builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1461420513.99 results: success (0) buildid: 20160423043013 builduid: f8a0afd1c98349028a08ee51e019e2b0 revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:33.991745) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:33.992394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:33.992668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:34.023571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:34.023839) ========= 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=fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 07:08:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-23 07:08:35 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:34.231018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:34.231297) ========= 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=fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016561 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:34.280118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 07:08:34.281495) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --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 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --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=fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 07:08:35,175 truncating revision to first 12 chars 2016-04-23 07:08:35,175 Setting DEBUG logging. 2016-04-23 07:08:35,175 attempt 1/10 2016-04-23 07:08:35,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37f04460ddb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 07:08:36,255 unpacking tar archive at: mozilla-central-37f04460ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391470 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 07:08:35.685756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:35.686046) ========= script_repo_revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:35.686436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:35.686751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 07:08:35.695115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-23 07:08:35.695383) ========= /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=fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:36 INFO - MultiFileLogger online at 20160423 07:08:36 in /builds/slave/test 07:08:36 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 07:08:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:36 INFO - {'append_to_log': False, 07:08:36 INFO - 'base_work_dir': '/builds/slave/test', 07:08:36 INFO - 'blob_upload_branch': 'Firefox', 07:08:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:36 INFO - 'branch': 'Firefox', 07:08:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:36 INFO - 'config_files': ('talos/linux_config.py',), 07:08:36 INFO - 'default_actions': ('clobber', 07:08:36 INFO - 'read-buildbot-config', 07:08:36 INFO - 'download-and-extract', 07:08:36 INFO - 'populate-webroot', 07:08:36 INFO - 'create-virtualenv', 07:08:36 INFO - 'install', 07:08:36 INFO - 'run-tests'), 07:08:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:36 INFO - 'download_minidump_stackwalk': True, 07:08:36 INFO - 'download_symbols': 'ondemand', 07:08:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:36 INFO - 'installer_path': 'installer.exe', 07:08:36 INFO - 'log_level': 'info', 07:08:36 INFO - 'log_name': 'talos', 07:08:36 INFO - 'log_to_console': True, 07:08:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:36 INFO - 'opt_config_files': (), 07:08:36 INFO - 'pip_index': False, 07:08:36 INFO - 'sps_profile': False, 07:08:36 INFO - 'sps_profile_interval': 0, 07:08:36 INFO - 'suite': 'dromaeojs-e10s', 07:08:36 INFO - 'system_bits': '32', 07:08:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:36 INFO - 'title': 'talos-linux64-ix-048', 07:08:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:36 INFO - 'use_talos_json': True, 07:08:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:36 INFO - 'work_dir': 'build'} 07:08:36 INFO - ##### 07:08:36 INFO - ##### Running clobber step. 07:08:36 INFO - ##### 07:08:36 INFO - Running pre-action listener: _resource_record_pre_action 07:08:36 INFO - Running main action method: clobber 07:08:36 INFO - rmtree: /builds/slave/test/build 07:08:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:37 INFO - Running post-action listener: _resource_record_post_action 07:08:37 INFO - ##### 07:08:37 INFO - ##### Running read-buildbot-config step. 07:08:37 INFO - ##### 07:08:37 INFO - Running pre-action listener: _resource_record_pre_action 07:08:37 INFO - Running main action method: read_buildbot_config 07:08:37 INFO - Using buildbot properties: 07:08:37 INFO - { 07:08:37 INFO - "project": "", 07:08:37 INFO - "product": "firefox", 07:08:37 INFO - "script_repo_revision": "production", 07:08:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:08:37 INFO - "repository": "", 07:08:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:08:37 INFO - "buildid": "20160423043013", 07:08:37 INFO - "pgo_build": "True", 07:08:37 INFO - "basedir": "/builds/slave/test", 07:08:37 INFO - "buildnumber": 716, 07:08:37 INFO - "slavename": "talos-linux64-ix-048", 07:08:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:08:37 INFO - "platform": "ubuntu64_hw", 07:08:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:37 INFO - "branch": "mozilla-central", 07:08:37 INFO - "repo_path": "mozilla-central", 07:08:37 INFO - "revision": "37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776", 07:08:37 INFO - "stage_platform": "linux64-pgo", 07:08:37 INFO - "builduid": "f8a0afd1c98349028a08ee51e019e2b0", 07:08:37 INFO - "slavebuilddir": "test" 07:08:37 INFO - } 07:08:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:08:37 INFO - Running post-action listener: _resource_record_post_action 07:08:37 INFO - ##### 07:08:37 INFO - ##### Running download-and-extract step. 07:08:37 INFO - ##### 07:08:37 INFO - Running pre-action listener: _resource_record_pre_action 07:08:37 INFO - Running main action method: download_and_extract 07:08:37 INFO - mkdir: /builds/slave/test/build/tests 07:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:37 INFO - https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:08:39 INFO - Downloaded 1361 bytes. 07:08:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:39 INFO - Using the following test package requirements: 07:08:39 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'jsshell-linux-x86_64.zip'], 07:08:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:39 INFO - https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:41 INFO - Downloaded 23857960 bytes. 07:08:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:42 INFO - Return code: 0 07:08:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:42 INFO - https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:43 INFO - Downloaded 23857960 bytes. 07:08:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:45 INFO - Return code: 0 07:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:45 INFO - https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:08:46 INFO - Downloaded 10840145 bytes. 07:08:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:08:46 INFO - Return code: 0 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:08:48 INFO - Downloaded 58348267 bytes. 07:08:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:48 INFO - mkdir: /builds/slave/test/properties 07:08:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:08:48 INFO - Writing to file /builds/slave/test/properties/build_url 07:08:48 INFO - Contents: 07:08:48 INFO - build_url:https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:48 INFO - Running post-action listener: _resource_record_post_action 07:08:48 INFO - Running post-action listener: set_extra_try_arguments 07:08:48 INFO - ##### 07:08:48 INFO - ##### Running populate-webroot step. 07:08:48 INFO - ##### 07:08:48 INFO - Running pre-action listener: _resource_record_pre_action 07:08:48 INFO - Running main action method: populate_webroot 07:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:48 INFO - '--tppagecycles', 07:08:48 INFO - '7'], 07:08:48 INFO - 'tests': ['tsvgm']}}, 07:08:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:08:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:08:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:08:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['damp', 'tps']}, 07:08:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'tests': ['damp', 'tps']}, 07:08:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['dromaeo_dom']}, 07:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['a11yr', 07:08:48 INFO - 'ts_paint', 07:08:48 INFO - 'tpaint', 07:08:48 INFO - 'sessionrestore', 07:08:48 INFO - 'sessionrestore_no_auto_restore', 07:08:48 INFO - 'tabpaint']}, 07:08:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:08:48 INFO - 'ts_paint', 07:08:48 INFO - 'tpaint', 07:08:48 INFO - 'sessionrestore', 07:08:48 INFO - 'sessionrestore_no_auto_restore', 07:08:48 INFO - 'tabpaint']}, 07:08:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:08:48 INFO - 'ts_paint', 07:08:48 INFO - 'tpaint', 07:08:48 INFO - 'sessionrestore', 07:08:48 INFO - 'sessionrestore_no_auto_restore', 07:08:48 INFO - 'tabpaint']}, 07:08:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:08:48 INFO - 'ts_paint', 07:08:48 INFO - 'tpaint', 07:08:48 INFO - 'sessionrestore', 07:08:48 INFO - 'sessionrestore_no_auto_restore', 07:08:48 INFO - 'tabpaint']}, 07:08:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['a11yr', 07:08:48 INFO - 'ts_paint', 07:08:48 INFO - 'tpaint', 07:08:48 INFO - 'sessionrestore', 07:08:48 INFO - 'sessionrestore_no_auto_restore', 07:08:48 INFO - 'tabpaint']}, 07:08:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['a11yr', 07:08:48 INFO - 'ts_paint', 07:08:48 INFO - 'tpaint', 07:08:48 INFO - 'sessionrestore', 07:08:48 INFO - 'sessionrestore_no_auto_restore', 07:08:48 INFO - 'tabpaint']}, 07:08:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['tsvgx', 07:08:48 INFO - 'tsvgr_opacity', 07:08:48 INFO - 'tart', 07:08:48 INFO - 'tscrollx', 07:08:48 INFO - 'cart']}, 07:08:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:08:48 INFO - 'tsvgr_opacity', 07:08:48 INFO - 'tart', 07:08:48 INFO - 'tscrollx', 07:08:48 INFO - 'cart']}, 07:08:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'talos_options': ['--disable-e10s'], 07:08:48 INFO - 'tests': ['tp5o']}, 07:08:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'tests': ['tp5o']}, 07:08:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'talos_options': ['--disable-e10s', 07:08:48 INFO - '--xperf_path', 07:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:48 INFO - 'tests': ['tp5n']}, 07:08:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:48 INFO - 'talos_options': ['--xperf_path', 07:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:48 INFO - 'tests': ['tp5n']}}, 07:08:48 INFO - 'talos.zip': {'path': '', 07:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:48 INFO - Running post-action listener: _resource_record_post_action 07:08:48 INFO - ##### 07:08:48 INFO - ##### Running create-virtualenv step. 07:08:48 INFO - ##### 07:08:48 INFO - Running pre-action listener: _resource_record_pre_action 07:08:48 INFO - Running main action method: create_virtualenv 07:08:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:08: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 07:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:49 INFO - Using real prefix '/usr' 07:08:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:08:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:51 INFO - Installing pip.................done. 07:08:51 INFO - Return code: 0 07:08:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08: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', 'pip>=1.5'] in /builds/slave/test/build 07:08: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 pip>=1.5 07:08:51 INFO - Using env: {'DISPLAY': ':0', 07:08:51 INFO - 'HOME': '/home/cltbld', 07:08:51 INFO - 'LANG': 'en_US.UTF-8', 07:08:51 INFO - 'LANGUAGE': 'en_US:en', 07:08:51 INFO - 'LOGNAME': 'cltbld', 07:08:51 INFO - 'MAIL': '/var/mail/cltbld', 07:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:51 INFO - 'MOZ_NO_REMOTE': '1', 07:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:51 INFO - 'NO_EM_RESTART': '1', 07:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:51 INFO - 'PWD': '/builds/slave/test', 07:08:51 INFO - 'SHELL': '/bin/bash', 07:08:51 INFO - 'SHLVL': '1', 07:08:51 INFO - 'TERM': 'linux', 07:08:51 INFO - 'TMOUT': '86400', 07:08:51 INFO - 'USER': 'cltbld', 07:08:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:51 INFO - '_': '/tools/buildbot/bin/python'} 07:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08: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 07:08:51 INFO - Cleaning up... 07:08:51 INFO - Return code: 0 07:08:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08: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 07:08: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 07:08:51 INFO - Using env: {'DISPLAY': ':0', 07:08:51 INFO - 'HOME': '/home/cltbld', 07:08:51 INFO - 'LANG': 'en_US.UTF-8', 07:08:51 INFO - 'LANGUAGE': 'en_US:en', 07:08:51 INFO - 'LOGNAME': 'cltbld', 07:08:51 INFO - 'MAIL': '/var/mail/cltbld', 07:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:51 INFO - 'MOZ_NO_REMOTE': '1', 07:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:51 INFO - 'NO_EM_RESTART': '1', 07:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:51 INFO - 'PWD': '/builds/slave/test', 07:08:51 INFO - 'SHELL': '/bin/bash', 07:08:51 INFO - 'SHLVL': '1', 07:08:51 INFO - 'TERM': 'linux', 07:08:51 INFO - 'TMOUT': '86400', 07:08:51 INFO - 'USER': 'cltbld', 07:08:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:51 INFO - '_': '/tools/buildbot/bin/python'} 07:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:52 INFO - Downloading/unpacking psutil>=0.7.1 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:53 INFO - Installing collected packages: psutil 07:08:53 INFO - Running setup.py install for psutil 07:08:54 INFO - building 'psutil._psutil_linux' extension 07:08:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:08: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 07:08:54 INFO - building 'psutil._psutil_posix' extension 07:08: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 07:08: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 07:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:54 INFO - Successfully installed psutil 07:08:54 INFO - Cleaning up... 07:08:54 INFO - Return code: 0 07:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:54 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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:08:54 INFO - Using env: {'DISPLAY': ':0', 07:08:54 INFO - 'HOME': '/home/cltbld', 07:08:54 INFO - 'LANG': 'en_US.UTF-8', 07:08:54 INFO - 'LANGUAGE': 'en_US:en', 07:08:54 INFO - 'LOGNAME': 'cltbld', 07:08:54 INFO - 'MAIL': '/var/mail/cltbld', 07:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:54 INFO - 'MOZ_NO_REMOTE': '1', 07:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:54 INFO - 'NO_EM_RESTART': '1', 07:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:54 INFO - 'PWD': '/builds/slave/test', 07:08:54 INFO - 'SHELL': '/bin/bash', 07:08:54 INFO - 'SHLVL': '1', 07:08:54 INFO - 'TERM': 'linux', 07:08:54 INFO - 'TMOUT': '86400', 07:08:54 INFO - 'USER': 'cltbld', 07:08:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:54 INFO - '_': '/tools/buildbot/bin/python'} 07:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:08:56 INFO - Installing collected packages: mozsystemmonitor 07:08:56 INFO - Running setup.py install for mozsystemmonitor 07:08:56 INFO - Successfully installed mozsystemmonitor 07:08:56 INFO - Cleaning up... 07:08:56 INFO - Return code: 0 07:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:56 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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:08:56 INFO - Using env: {'DISPLAY': ':0', 07:08:56 INFO - 'HOME': '/home/cltbld', 07:08:56 INFO - 'LANG': 'en_US.UTF-8', 07:08:56 INFO - 'LANGUAGE': 'en_US:en', 07:08:56 INFO - 'LOGNAME': 'cltbld', 07:08:56 INFO - 'MAIL': '/var/mail/cltbld', 07:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:56 INFO - 'MOZ_NO_REMOTE': '1', 07:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:56 INFO - 'NO_EM_RESTART': '1', 07:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:56 INFO - 'PWD': '/builds/slave/test', 07:08:56 INFO - 'SHELL': '/bin/bash', 07:08:56 INFO - 'SHLVL': '1', 07:08:56 INFO - 'TERM': 'linux', 07:08:56 INFO - 'TMOUT': '86400', 07:08:56 INFO - 'USER': 'cltbld', 07:08:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:56 INFO - '_': '/tools/buildbot/bin/python'} 07:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08: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 07:08: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 07:08: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 07:08: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 07:08: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 07:08: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 07:08:59 INFO - Downloading docopt-0.6.1.tar.gz 07:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:59 INFO - Running setup.py install for blobuploader 07:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:59 INFO - Running setup.py install for requests 07:09:00 INFO - Running setup.py install for docopt 07:09:00 INFO - Successfully installed blobuploader requests docopt 07:09:00 INFO - Cleaning up... 07:09:00 INFO - Return code: 0 07:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09: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 07:09: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 07:09:00 INFO - Using env: {'DISPLAY': ':0', 07:09:00 INFO - 'HOME': '/home/cltbld', 07:09:00 INFO - 'LANG': 'en_US.UTF-8', 07:09:00 INFO - 'LANGUAGE': 'en_US:en', 07:09:00 INFO - 'LOGNAME': 'cltbld', 07:09:00 INFO - 'MAIL': '/var/mail/cltbld', 07:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:00 INFO - 'MOZ_NO_REMOTE': '1', 07:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:00 INFO - 'NO_EM_RESTART': '1', 07:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:00 INFO - 'PWD': '/builds/slave/test', 07:09:00 INFO - 'SHELL': '/bin/bash', 07:09:00 INFO - 'SHLVL': '1', 07:09:00 INFO - 'TERM': 'linux', 07:09:00 INFO - 'TMOUT': '86400', 07:09:00 INFO - 'USER': 'cltbld', 07:09:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:00 INFO - '_': '/tools/buildbot/bin/python'} 07:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:00 INFO - Running setup.py (path:/tmp/pip-mbFSwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:00 INFO - Running setup.py (path:/tmp/pip-BZlGe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:00 INFO - Running setup.py (path:/tmp/pip-RZ6B9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:00 INFO - Running setup.py (path:/tmp/pip-XrGLcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:00 INFO - Running setup.py (path:/tmp/pip-4NuKR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:00 INFO - Running setup.py (path:/tmp/pip-wCk8WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:00 INFO - Running setup.py (path:/tmp/pip-N8msh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:00 INFO - Running setup.py (path:/tmp/pip-FDIznM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:01 INFO - Running setup.py (path:/tmp/pip-7QeTLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:01 INFO - Running setup.py (path:/tmp/pip-sOC97k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:01 INFO - Running setup.py (path:/tmp/pip-BjU6m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:01 INFO - Running setup.py (path:/tmp/pip-EkMgzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:01 INFO - Running setup.py (path:/tmp/pip-3ykpvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:01 INFO - Running setup.py (path:/tmp/pip-BlQiu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:01 INFO - Running setup.py (path:/tmp/pip-QmSAnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:01 INFO - Running setup.py (path:/tmp/pip-xwPe6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:01 INFO - Running setup.py (path:/tmp/pip-Nvzwan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:01 INFO - Running setup.py install for manifestparser 07:09:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:01 INFO - Running setup.py install for mozcrash 07:09:01 INFO - Running setup.py install for mozdebug 07:09:01 INFO - Running setup.py install for mozdevice 07:09:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Running setup.py install for mozfile 07:09:02 INFO - Running setup.py install for mozhttpd 07:09:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Running setup.py install for mozinfo 07:09:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Running setup.py install for mozInstall 07:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Running setup.py install for mozleak 07:09:02 INFO - Running setup.py install for mozlog 07:09:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Running setup.py install for moznetwork 07:09:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:02 INFO - Running setup.py install for mozprocess 07:09:02 INFO - Running setup.py install for mozprofile 07:09:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:03 INFO - Running setup.py install for mozrunner 07:09:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:03 INFO - Running setup.py install for mozscreenshot 07:09:03 INFO - Running setup.py install for moztest 07:09:03 INFO - Running setup.py install for mozversion 07:09:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:03 INFO - Cleaning up... 07:09:03 INFO - Return code: 0 07:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:03 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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:03 INFO - Using env: {'DISPLAY': ':0', 07:09:03 INFO - 'HOME': '/home/cltbld', 07:09:03 INFO - 'LANG': 'en_US.UTF-8', 07:09:03 INFO - 'LANGUAGE': 'en_US:en', 07:09:03 INFO - 'LOGNAME': 'cltbld', 07:09:03 INFO - 'MAIL': '/var/mail/cltbld', 07:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:03 INFO - 'MOZ_NO_REMOTE': '1', 07:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:03 INFO - 'NO_EM_RESTART': '1', 07:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:03 INFO - 'PWD': '/builds/slave/test', 07:09:03 INFO - 'SHELL': '/bin/bash', 07:09:03 INFO - 'SHLVL': '1', 07:09:03 INFO - 'TERM': 'linux', 07:09:03 INFO - 'TMOUT': '86400', 07:09:03 INFO - 'USER': 'cltbld', 07:09:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:03 INFO - '_': '/tools/buildbot/bin/python'} 07:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:03 INFO - Running setup.py (path:/tmp/pip-bQZqmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:03 INFO - Running setup.py (path:/tmp/pip-ofS3vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:03 INFO - Running setup.py (path:/tmp/pip-ebGL3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:03 INFO - Running setup.py (path:/tmp/pip-Hd4T8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:03 INFO - Running setup.py (path:/tmp/pip-2AUpH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09: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)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:04 INFO - Running setup.py (path:/tmp/pip-0kj9HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09: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)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:04 INFO - Running setup.py (path:/tmp/pip-vQpgKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09: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)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:04 INFO - Running setup.py (path:/tmp/pip-SK55gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09: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)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:04 INFO - Running setup.py (path:/tmp/pip-ZxPc1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09: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)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:04 INFO - Running setup.py (path:/tmp/pip-zfxWNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09: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)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:04 INFO - Running setup.py (path:/tmp/pip-qUZKke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:04 INFO - Running setup.py (path:/tmp/pip-VyAuk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:04 INFO - Running setup.py (path:/tmp/pip-xs8g1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:04 INFO - Running setup.py (path:/tmp/pip-EsAbNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:04 INFO - Running setup.py (path:/tmp/pip-eFqIXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:04 INFO - Running setup.py (path:/tmp/pip-flpmC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:04 INFO - Running setup.py (path:/tmp/pip-nZibQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:06 INFO - Downloading blessings-1.6.tar.gz 07:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:06 INFO - Installing collected packages: blessings 07:09:06 INFO - Running setup.py install for blessings 07:09:07 INFO - Successfully installed blessings 07:09:07 INFO - Cleaning up... 07:09:07 INFO - Return code: 0 07:09:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:07 INFO - Reading from file tmpfile_stdout 07:09:07 INFO - Current package versions: 07:09:07 INFO - argparse == 1.2.1 07:09:07 INFO - blessings == 1.6 07:09:07 INFO - blobuploader == 1.2.4 07:09:07 INFO - docopt == 0.6.1 07:09:07 INFO - manifestparser == 1.1 07:09:07 INFO - mozInstall == 1.12 07:09:07 INFO - mozcrash == 0.17 07:09:07 INFO - mozdebug == 0.1 07:09:07 INFO - mozdevice == 0.48 07:09:07 INFO - mozfile == 1.2 07:09:07 INFO - mozhttpd == 0.7 07:09:07 INFO - mozinfo == 0.9 07:09:07 INFO - mozleak == 0.1 07:09:07 INFO - mozlog == 3.1 07:09:07 INFO - moznetwork == 0.27 07:09:07 INFO - mozprocess == 0.22 07:09:07 INFO - mozprofile == 0.28 07:09:07 INFO - mozrunner == 6.11 07:09:07 INFO - mozscreenshot == 0.1 07:09:07 INFO - mozsystemmonitor == 0.0 07:09:07 INFO - moztest == 0.7 07:09:07 INFO - mozversion == 1.4 07:09:07 INFO - psutil == 3.1.1 07:09:07 INFO - requests == 1.2.3 07:09:07 INFO - wsgiref == 0.1.2 07:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09: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 07:09: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 07:09:07 INFO - Using env: {'DISPLAY': ':0', 07:09:07 INFO - 'HOME': '/home/cltbld', 07:09:07 INFO - 'LANG': 'en_US.UTF-8', 07:09:07 INFO - 'LANGUAGE': 'en_US:en', 07:09:07 INFO - 'LOGNAME': 'cltbld', 07:09:07 INFO - 'MAIL': '/var/mail/cltbld', 07:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:07 INFO - 'MOZ_NO_REMOTE': '1', 07:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:07 INFO - 'NO_EM_RESTART': '1', 07:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:07 INFO - 'PWD': '/builds/slave/test', 07:09:07 INFO - 'SHELL': '/bin/bash', 07:09:07 INFO - 'SHLVL': '1', 07:09:07 INFO - 'TERM': 'linux', 07:09:07 INFO - 'TMOUT': '86400', 07:09:07 INFO - 'USER': 'cltbld', 07:09:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:07 INFO - '_': '/tools/buildbot/bin/python'} 07:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:09:07 INFO - Cleaning up... 07:09:07 INFO - Return code: 0 07:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:07 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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:09:07 INFO - Using env: {'DISPLAY': ':0', 07:09:07 INFO - 'HOME': '/home/cltbld', 07:09:07 INFO - 'LANG': 'en_US.UTF-8', 07:09:07 INFO - 'LANGUAGE': 'en_US:en', 07:09:07 INFO - 'LOGNAME': 'cltbld', 07:09:07 INFO - 'MAIL': '/var/mail/cltbld', 07:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:07 INFO - 'MOZ_NO_REMOTE': '1', 07:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:07 INFO - 'NO_EM_RESTART': '1', 07:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:07 INFO - 'PWD': '/builds/slave/test', 07:09:07 INFO - 'SHELL': '/bin/bash', 07:09:07 INFO - 'SHLVL': '1', 07:09:07 INFO - 'TERM': 'linux', 07:09:07 INFO - 'TMOUT': '86400', 07:09:07 INFO - 'USER': 'cltbld', 07:09:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:07 INFO - '_': '/tools/buildbot/bin/python'} 07:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:07 INFO - Downloading/unpacking jsonschema 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:09 INFO - Downloading/unpacking functools32 (from jsonschema) 07:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:09 INFO - warning: no files found matching '*.txt' 07:09:09 INFO - no previously-included directories found matching 'build' 07:09:09 INFO - no previously-included directories found matching 'dist' 07:09:09 INFO - no previously-included directories found matching '.git*' 07:09:09 INFO - Installing collected packages: jsonschema, functools32 07:09:09 INFO - Running setup.py install for functools32 07:09:09 INFO - warning: no files found matching '*.txt' 07:09:09 INFO - no previously-included directories found matching 'build' 07:09:09 INFO - no previously-included directories found matching 'dist' 07:09:09 INFO - no previously-included directories found matching '.git*' 07:09:09 INFO - Successfully installed jsonschema functools32 07:09:10 INFO - Cleaning up... 07:09:10 INFO - Return code: 0 07:09:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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 0x7ff1c1c6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e415a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, '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': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09: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 07:09: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 07:09:10 INFO - Using env: {'DISPLAY': ':0', 07:09:10 INFO - 'HOME': '/home/cltbld', 07:09:10 INFO - 'LANG': 'en_US.UTF-8', 07:09:10 INFO - 'LANGUAGE': 'en_US:en', 07:09:10 INFO - 'LOGNAME': 'cltbld', 07:09:10 INFO - 'MAIL': '/var/mail/cltbld', 07:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:10 INFO - 'MOZ_NO_REMOTE': '1', 07:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:10 INFO - 'NO_EM_RESTART': '1', 07:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:10 INFO - 'PWD': '/builds/slave/test', 07:09:10 INFO - 'SHELL': '/bin/bash', 07:09:10 INFO - 'SHLVL': '1', 07:09:10 INFO - 'TERM': 'linux', 07:09:10 INFO - 'TMOUT': '86400', 07:09:10 INFO - 'USER': 'cltbld', 07:09:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:10 INFO - '_': '/tools/buildbot/bin/python'} 07:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:10 INFO - Downloading/unpacking flake8 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:12 INFO - no previously-included directories found matching 'docs/_build' 07:09:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:12 INFO - Running setup.py install for pep8 07:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:12 INFO - no previously-included directories found matching 'docs/_build' 07:09:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:09:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:13 INFO - Cleaning up... 07:09:13 INFO - Return code: 0 07:09:13 INFO - Running post-action listener: _resource_record_post_action 07:09:13 INFO - Running post-action listener: _start_resource_monitoring 07:09:13 INFO - Starting resource monitoring. 07:09:13 INFO - ##### 07:09:13 INFO - ##### Running install step. 07:09:13 INFO - ##### 07:09:13 INFO - Running pre-action listener: _resource_record_pre_action 07:09:13 INFO - Running main action method: install 07:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:13 INFO - Reading from file tmpfile_stdout 07:09:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:13 INFO - Reading from file tmpfile_stdout 07:09:13 INFO - Output received: 07:09:13 INFO - Usage: mozinstall [options] installer 07:09:13 INFO - Options: 07:09:13 INFO - -h, --help show this help message and exit 07:09:13 INFO - -d DEST, --destination=DEST 07:09:13 INFO - Directory to install application into. [default: 07:09:13 INFO - "/builds/slave/test"] 07:09:13 INFO - --app=APP Application being installed. [default: firefox] 07:09:13 INFO - mkdir: /builds/slave/test/build/application 07:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:09:29 INFO - Reading from file tmpfile_stdout 07:09:29 INFO - Output received: 07:09:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:29 INFO - Running post-action listener: _resource_record_post_action 07:09:29 INFO - ##### 07:09:29 INFO - ##### Running run-tests step. 07:09:29 INFO - ##### 07:09:29 INFO - Running pre-action listener: _resource_record_pre_action 07:09:29 INFO - Running main action method: run_tests 07:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:29 INFO - Python 2.7.3 07:09:29 INFO - Return code: 0 07:09:29 INFO - grabbing minidump binary from tooltool 07:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:29 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 0x1ed0410>, '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 0x1ed1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:09:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:09:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:30 INFO - Return code: 0 07:09:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:30 INFO - Return code: 0 07:09:30 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/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:09:30 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/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:09:30 INFO - Using env: {'DISPLAY': ':0', 07:09:30 INFO - 'HOME': '/home/cltbld', 07:09:30 INFO - 'LANG': 'en_US.UTF-8', 07:09:30 INFO - 'LANGUAGE': 'en_US:en', 07:09:30 INFO - 'LOGNAME': 'cltbld', 07:09:30 INFO - 'MAIL': '/var/mail/cltbld', 07:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:30 INFO - 'MOZ_NO_REMOTE': '1', 07:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:30 INFO - 'NO_EM_RESTART': '1', 07:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:30 INFO - 'PWD': '/builds/slave/test', 07:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:30 INFO - 'SHELL': '/bin/bash', 07:09:30 INFO - 'SHLVL': '1', 07:09:30 INFO - 'TERM': 'linux', 07:09:30 INFO - 'TMOUT': '86400', 07:09:30 INFO - 'USER': 'cltbld', 07:09:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834', 07:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:30 INFO - '_': '/tools/buildbot/bin/python'} 07:09:30 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/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:09:31 INFO - mozversion application_buildid: 20160423043013 07:09:31 INFO - mozversion application_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 07:09:31 INFO - mozversion application_display_name: Nightly 07:09:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:31 INFO - mozversion application_name: Firefox 07:09:31 INFO - mozversion application_remotingname: firefox 07:09:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:31 INFO - mozversion application_vendor: Mozilla 07:09:31 INFO - mozversion application_version: 48.0a1 07:09:31 INFO - mozversion platform_buildid: 20160423043013 07:09:31 INFO - mozversion platform_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 07:09:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:31 INFO - mozversion platform_version: 48.0a1 07:09:31 INFO - using testdate: 1461420571 07:09:31 INFO - actual date: 1461420571 07:09:31 INFO - starting webserver on 'localhost:45451' 07:09:31 INFO - SUITE-START | Running 2 tests 07:09:31 INFO - TEST-START | dromaeo_css 07:09:31 INFO - operating with platform_type : linux_ 07:09:31 INFO - Initialising browser for dromaeo_css test... 07:09:31 INFO - TEST-INFO | started process 8765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppolVn4/profile http://localhost:45451/getInfo.html) 07:09:35 INFO - PROCESS | 8765 | 07:09:35 INFO - PROCESS | 8765 | (process:8838): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:09:35 INFO - PROCESS | 8765 | __metrics Screen width/height:1600/1200 07:09:35 INFO - PROCESS | 8765 | colorDepth:24 07:09:35 INFO - PROCESS | 8765 | Browser inner width/height: 1024/697 07:09:35 INFO - PROCESS | 8765 | __metrics 07:09:36 ERROR - PROCESS | 8765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:09:37 INFO - TEST-INFO | 8765: exit 0 07:09:37 INFO - Browser initialized. 07:09:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:37 INFO - TEST-INFO | started process 8889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppolVn4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:39 INFO - PROCESS | 8889 | 07:09:39 INFO - PROCESS | 8889 | (process:8949): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:09:49 INFO - PROCESS | 8889 | RSS: Main: 165031936 07:09:49 INFO - PROCESS | 8889 | 07:10:38 INFO - PROCESS | 8889 | 1461420638826 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:12:46 INFO - PROCESS | 8889 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45451/tests/dromaeo/cssquery-ext.html) 07:12:47 INFO - PROCESS | 8889 | RSS: Main: 169320448 07:12:47 INFO - PROCESS | 8889 | 07:15:49 INFO - PROCESS | 8889 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-ext.html (next: http://localhost:45451/tests/dromaeo/cssquery-jquery.html) 07:15:50 INFO - PROCESS | 8889 | RSS: Main: 166436864 07:15:50 INFO - PROCESS | 8889 | 07:18:51 INFO - PROCESS | 8889 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45451/tests/dromaeo/cssquery-mootools.html) 07:18:52 INFO - PROCESS | 8889 | RSS: Main: 167219200 07:18:52 INFO - PROCESS | 8889 | 07:21:54 INFO - PROCESS | 8889 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45451/tests/dromaeo/cssquery-prototype.html) 07:21:54 INFO - PROCESS | 8889 | RSS: Main: 164954112 07:21:54 INFO - PROCESS | 8889 | 07:24:57 INFO - PROCESS | 8889 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45451/tests/dromaeo/cssquery-yui.html) 07:24:57 INFO - PROCESS | 8889 | RSS: Main: 166166528 07:24:57 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | Cycle 1(1): loaded http://localhost:45451/tests/dromaeo/cssquery-yui.html (next: http://localhost:45451/tests/dromaeo/cssquery-dojo.html) 07:28:00 INFO - PROCESS | 8889 | RSS: Main: 168181760 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | __start_tp_report 07:28:00 INFO - PROCESS | 8889 | _x_x_mozilla_page_load 07:28:00 INFO - PROCESS | 8889 | _x_x_mozilla_page_load_details 07:28:00 INFO - PROCESS | 8889 | |i|pagename|runs| 07:28:00 INFO - PROCESS | 8889 | |0;dojo.html;3136.310011797405;3185.6655051219623;3194.488881778915;3217.5012873004694;3231.40219059474;5447.700376479297;5454.890902181954;5455.018096742585;5458.590605704578;5462.945370546293;5316.12283973144;5377.5966802489875;5413.079776438005;5479;5524.861878453041;4908.656394052417;4918.114739346916;4960.603151747851;5007.4992500749995;5058;850.4824367353389;4881.219004959207;4913.434954980169;4943.456219815817;4998.125328067592;4836.395450568679;4875.902481950359;4897.7795999180125;4897.9265311020545;4916.410030796309;4894.216925291937;4974.87562810929;4976.87557811054;4977.9751101244265;5020.673656212334;4827.131116399047;4867.805287788484;4874.780634871439;4895.143349913751;4942.950570494285;5401.162819762943;5434.8913021739345;5437.429069947638;5450.91823622646;5457.426970168154;5791.536677065825;5833.504152147073;5860.062390017577;5864.70676466175;5915.674637894914;5636;5665.065264231438;5666.660000399989;5674.460926212003;5724.77100915967;5296.92054619181;5302.522772950453;5324.7071411072375;5339.252504649352;5357.410684824627;5808.94191058084;5916.645001299936;5936.762529498858;6034.5172386209;6036.486898613579;5553.361363443175;5553.77784888608;5554.055810512223;5561.610687251854;5563.471470210324;5601.579881508903;5605.411431799603;5622.072358060874;5623.915641265385;5640.435956404327;5747.08046712524;5806.30324361071;5809.680467574324;5819.185314056035;5909.940900591025;5631;5730.627509211971;5793.507551858055;5843.737031833578;5890.410958904075;4306.332518459643;4345.608895199447;4346.6522678185665;4363.2364336241035;4394.934075988863;3759.7556158850134;3921.705872059607;3951.130751234724;3981.960180398217;3999.480067591253;5510.5316048135555;5538.944610553924;5563.860903477445;5565.638233514808;5566.415526369754;5697;5823.475887170175;5823.796167134215;5828.329742079715;5854.502367298827;5506.146547285177;5511.5039646432015;5524.8342549723575;5532.059549876531;5577.330720313588;4793.49668284832;4811.941372897957;4818.084563932912;4819.855404337875;4851.029794041206;5870.236869206976;5997.190379298826;6074.36219196978;6099;6104.755809767648;5808.738606762706;5823.18475413451;5825.475707186373;5858.062709966385;5866.911996319973;6048.425399587032;6059;6062.6665533394325;6074.848128796815;6089.665068421279;5622.437756224344;5653.943460565506;5767.5385969121535;5783.8554036149435;5809.709514524172;5717.142428635738;5768.971155144198;5769.509591684586;5797.9420205797405;5816.621919575214;5543;5553.555715542828;5554.08357620988;5561.555075593862;5613.101903695389;5540.63985840919;5565.30433695788;5587.776488940397;5617.831465056055;5639.830805075854;5414.242006119068;5498.532624726783;5527.944720552743;5531.446855314436;5579.637323573955;5712.34308054579;5731.828045158652;5733.598648094593;5742.937556552051;5764.279465066867;5546.861328466659;5632.746526406403;5639.718014099197;5647.463490968352;5660.37735849048 07:28:00 INFO - PROCESS | 8889 | |1;ext.html;587.538782056086;630.8990561510158;639.143547646154;646.6508085633758;665.0190968321729;32920.506192407134;34148.829255853714;37267.0683232919;38790;38887.02782430441;40341.39487907676;40374;40511;40656;40988.795056024675;8620.482771033727;8756.8686469703;8798.29613630908;8804.471731696087;8805.25155361795;8643.956780216122;8798.6920457784;8800.251978581797;8818.426802257865;8824.161704638082;8943.95528022359;9036.68371606994;9047.140521650434;9083.500407477586;9136.040715724854;8944.508052057134;9023.503707296097;9033.051529589397;9042.367034307536;9055.547222638908;8829.381943263974;8906.777330566723;8923.598438070303;8948.821023579492;8956.104389561056;41197;41759.582404175875;41797.582024179675;41878;42028.78985605053;3653.733593912778;3677.9264414711556;3711.536057992751;3916.5495967963766;4279.358096285551;30976.84511577428;31205.37589248225;31549;31550.842245788623;31895.840520797246;4075.673946084306;4180.498340199165;4191.224623444673;4221.894452638709;4298.376735373385;224667;228026;228374.99999999834;228488;230207;35399;36369.81815090908;36447.63552364495;36459;56266.71866640641;34463.65536344604;34487.82756086203;34523.482147767805;34738.82630586831;34755.47866782;14851.777223341658;14943.775843362359;15035.323410446555;15058.623534411727;15115.773263401057;11666.88333116675;11676.241044332091;11698.70753231176;11709.121815863844;12095.81856272139;8403.243708066304;8454.957725211334;8487.278581320534;8508.10664880191;8532;3271.2803183299634;3316.8341582920757;3324.335132973415;3333.2000319923045;3368.3768502827056;1014.2504180289089;1032.901296111665;1038.1331588124;1046.210111365914;1088.1566785740956;32659.836700816344;33688;33973.964637945726;36343.63656363403;36497.817510912275;1086.999960036768;1152.464104191555;1156.2946602572424;1171.8593768747805;1208.5528354508888;16206.75689864653;16809.91595042017;17005.829941700424;17066.525353823625;17195.570110747332;481393;493974;496962;498120;498599;58056.709716451995;58684.41315586875;58765;58951.41048589545;59364.1095383561;1384.536180379564;1408.9506867259802;1438.3383643523887;1443.5236371997005;1513.4173343262703;30241.848790755907;30889.69110308868;31273.687263127078;31354.372912541166;31758.364832702755;51894.74052629713;52627.47372526226;52661.21008184804;52781.7360913193;52895.47104528906;418069;419208;420475;420740;420761;42168.1566368677;42823;44030.35817850939;44178.116437671706;44447;48411.27383089327;48455.27317090176;48748.75625621849;48890;49106;40788.18423631451;40939.1812163761;41211.587884120774;41518;42202.577974219865;40561.1887762249;40572;40708.14152834135;41494.58505414907;42097.94755131146;35339;40908.795456022526;41554.79222603868;42693;44209.55790442183;33747.3250534983;34800.129996750285;35067.82466087653;35286;35294.47058294179;26727.86636066807;27076.593851092643;27146.592801108392;27171.456570868868;27733.30666733348 07:28:00 INFO - PROCESS | 8889 | |2;jquery.html;400.9498812648418;403.06287880677417;403.43921948491595;409.520860593106;412.77503760450554;13545.932270338635;17832.643347133067;18420.263189472404;18495.167717452714;19022.904885475553;16714;16716.916415417905;16968.575785605368;19399.515012124702;19467.31864384747;5566.526845218141;5594.216809646642;5764.971175144118;5778.739956701937;5788.42115788422;5680.289963754531;5753.453421924932;5775.3358363788075;5791.623544469617;5806.071028635419;5541.750621222055;5682.863427314533;5690;5744.79893203738;5746.856328591777;5586.832395028176;5625.803096891589;5627.240322556464;5627.380988091307;5688.800891968782;4855.660103792736;5054.519820617035;5137.075326441239;5150.845474635767;5153.2785410042625;21414.892925535274;22906.427339316484;23011.884940575357;23078.076876924904;23130.76869231303;746.5446077892482;1506.6158129676862;2346.7066616672914;2495.152744618184;2773.959765088092;14200;14573.781393279109;14680.55958321252;14755;14912.254387280702;1827.1138497828542;1918.2710569983317;1948.123344494983;2079.4177630263553;2086.175960495611;66495;77815.61092194503;77906.61046694787;78183;80302.19697803006;10512.579496820195;10679.519421626046;10900.50947707355;10907.236493445542;11085.722856928642;15091;15218;15305.846941530664;15318;15339.386424543116;8304.792380190424;8421.115782842835;8551.657933682583;8566.61450234741;8612.913870861337;8325.5004699717;8367.665293388196;8391.32909306951;8521.744347669579;8569.742907712778;6594.373534514213;6713.362230588086;6724.9327506725285;6790.015447760146;6838.863222735517;1892.6877065284075;1925.3838771593237;1966.272479182683;1976.4762337980446;1983.6032793441082;965.8406362950175;1085.5386460754148;1089.9509522071526;1116.9218154729253;1137.7155711072232;18886.527836803914;19223.423297301102;19376.2249510018;19403;19709.704354434696;974.6296407365297;1034.886162522122;1057.391999600233;1072.8337107748312;1109.801414472368;10256.641017564349;10472.16222702182;10627.415492148006;10733.677989660322;10778.245522813328;518190;522046;522477;527953;533044;92791.53604231936;93832;96165;96383;98423;1088.4122573810212;1095.0910744082391;1103.6578660615235;1114.4483480677118;1116.4250411038322;15730.606734831721;16387.34450621962;16475.917620411823;16652.916735416246;16831.91584042072;36651.266974659826;37160.256794864494;38677.2264554713;40273.99315017148;41374.79312603418;50532.747336263084;54145.72927135339;54598.727006364716;55237.7238113823;56539.434605655064;8164.550949697824;8361.95819020901;8445.746627601182;8565.95717021411;8657.82684346297;8192.590370481334;9182.862257066283;10495.947520262655;11244.9437752814;12244;11266.549338026387;11777.470013849226;11893.940530297294;11895.226810257305;12023.879761202275;11518.82721759191;11716.121290903046;11737.180348760128;11769.293842369485;12071.758564828478;6204.348543403058;9784.6301517789;11592.942035289769;11759.294442333487;11952.940235298767;8048.235417635316;8595.312375009858;8647.178518040777;8831.425957312755;8994.190522852712;8767.167119123673;10856.032868164917;11946.044316454489;11963.700907477034;11986.520539178335 07:28:00 INFO - PROCESS | 8889 | |3;mootools.html;1491.7836913647525;1530.5255370835039;1669.9081550514725;1807.9819201807977;1838.4392760208138;7549;8133.715319963802;8184.468009579373;8449.155084491547;8494.957525212372;8225.300849427806;8253.215944485279;8283.91716082839;8284.627191776384;8354.039285482171;2274.0221704666988;2290.3586995641163;2299.37916762474;2299.5285966376937;2302.4128847143957;2189.2447105748493;2229.442639340165;2268.2174649745893;2271.2164303315412;2272.9545409091807;2216.6231740604057;2224.655178447343;2246.6517689758034;2249.1116009176367;2266.3314322274887;2229.7101376820992;2232.3191426614876;2233.5421238646118;2238.3396897915154;2238.541099074686;2244.2369594338;2257.2776711452343;2260.0507786729613;2262.2534563593977;2264.0264686184933;8458.196471335214;8507.829843403159;8519.446235994703;8557.700480483154;8579.699710510165;5031.723255220962;5133.589312854962;5184.559312458446;5185.507376799235;5205.401378841444;3280.5243239730107;3282.4748040313434;3336.2993771308056;3348.263382055944;3398.4562470004926;1155.3356819828548;1174.201542950793;1190.5118901250532;1195.121585634558;1210.1287073307205;11543.480543375568;11606.24559403636;11649.708757281136;11727.7068073298;11734.354610496504;4354.455693038371;4451.554844515587;4615.053913947632;4629.305604159335;4629.560191781776;9062.410943288665;9082.727518174466;9100;9141.131592498701;9160.6793762218;5028.170351891897;5028.874278143076;5030.144875371196;5058.519440653132;5060.7722652480725;4343.782810859444;4705.6941298816155;4724.811007559728;4727.338172655831;4750.168720473903;3628.129248980226;3686.170611612366;3735.0662334416397;3785.072657199004;3812.046988252937;1126.0709914320719;1132.7111586545543;1132.8527291452224;1146.3523109443138;1146.9942650286696;915.2906497464518;972.9513524323755;984.3601658921615;985.7190700650281;1003.8694969653898;5582.134769110794;5647.265855438766;5676.120201368794;5762.827115186551;5846.684495988368;430.16118568790984;434.50032462667554;440.0516886110437;447.583747115186;447.8611630394523;3932.980335098306;3949.7235193536753;3962.7226094173707;3999.7600143991453;4023.6781057515327;10145.847812282822;10472.581096756197;10558.788824223473;10623.203259755395;10685.946570267099;10403.53184106717;10444.686659400078;10456;10456.26806123564;10457.9477102614;7529.096508419025;7798.961005194938;7820.608969551614;7900.841983160304;7901.683932642745;5908.675022873783;5919.85200369977;5964.493018093511;5979.252593425822;6121.602095863755;9544;9599.904000960181;9608.66369677058;9676.806463870542;9739.853902191331;9294.25645948309;9798.85301720489;9878.901210987799;9940.502974851084;9965.850512242467;6796.252412234551;7164.785056448315;7283.963580182065;7397.778066658009;7403.851922961403;8092.433529652868;8110.188981101843;8124.63439145228;8138.145494722969;8166.6733330668485;7177.677004534704;7347.742829000959;7373.705051797868;7496.887546686913;7502.624868756431;7173.42612590981;7248.492605517563;7252.347288743827;7262.491625586158;7307.378872795659;6796.558223715443;6810.62541560219;6842.486813488908;6852.280510546321;6864.313568643096;4847.854564363075;5034;5051.292819005415;5068.569171620454;5079.187330027178;5016.097102521581;5050.393952725696;5116;5120.820771272987;5138.871528211825 07:28:00 INFO - PROCESS | 8889 | |4;prototype.html;333.14880480372653;333.96326404095544;342.8851334802841;343.65977682094734;345.25080575151924;6063.363346848583;6088.421599948003;6101.145839582451;6105.084237364397;6128.969355153218;6061.909071363922;6073.301570319414;6078.209832721751;6085.726142323595;6096.908546371808;4383.268608899482;4463.419755431789;4576.610988066019;4579.564941330568;4602.470715867685;4569.314602809572;4579.610733087691;4581.908361832761;4587.105514424688;4594.3338215958665;4553.157665831815;4562.9771851140695;4576.908461830762;4591.334256532801;4603;4285.8071386787515;4546.613537849286;4548.931766023512;4551.385562949025;4566.150708962876;3947.2697550953167;3956.3274243378405;3966.107625784204;3968.285708572456;3969.861054863095;5866.853328666817;5873.647581145145;5874.002839034706;5893.469587737124;5929.288485381739;4998.950010499885;5249.160134378481;5254.581263058953;5262.973685131588;5281.313429254211;6259.593126446812;6282.654454005028;6290.779822706229;6298.118263443076;6323.20959880015;4293.3989241506215;4298.161858437606;4358.346248062784;4383.978080109611;4384.671149663756;6571.605703657796;6631.4363279121335;6649.634270115142;6687.699053542602;6689.431398331099;4405.559444055633;4406.317020861771;4432.822687092545;4439.711418757771;4446.5331140230455;4228;4441.977790111094;4505.887352816206;4513.616342610915;4533.818647254073;5183.766730497136;5219.947800522022;5245.082110630625;5248.317718696545;5257.8159764408065;6314.494840412756;6364.84087897797;6379.425851673279;6407.327230640809;6441.677916104176;1523.116592376419;1538.100211376335;1538.2310343105294;1548.6051056980398;1552.5031989763393;995.955182016811;1013.554036224059;1021.5556233038503;1028.4138041316528;1032.6179313653845;6070.3019152797115;6130.6628135452975;6135.570510064253;6145.385461453819;6149.631022138686;6392.4246817786625;6492.577982431127;6505.544611877123;6510;6536.7712130075215;6097.420745029215;6098.817035488943;6111.747091846161;6112.938870611237;6153.569250152446;3443.707284880763;3498.7026102781037;3502.178866989151;3504.8422820972605;3508.5438892943753;6548.443382312556;6675.899861502081;6728.125343705287;6771.762988295386;6778.18661760582;6650.401463868178;6667.366600172976;6720;6723.394894459522;6738.32616738332;6591.373819487141;6723.899141512881;6738.157730283617;6757.594544327356;6788.626625535544;6403.96798016007;6410.262819775599;6439.098526206241;6439.130717353098;6493.155889734304;6338.841528961629;6433.356664333529;6463.642635046693;6464.2889282177985;6466.773662921775;6727.8990815138795;6747.628880411428;6758.831029224309;6767.526273160832;6767.89848152288;4408.250597398514;4427.402300689366;4439.089986552814;4442.577955094261;4451.732896026248;6325.683715814099;6458.515611329075;6490.870182596416;6516.609003459807;6529.118568993125;6272.121902933502;6287.842803929939;6307.747690092345;6316.305206427198;6326.715297811702;6129.570930035033;6287.868183726973;6334.144890439732;6349.206349206349;6350.301466838551;6048.6975651218145;6111.266648002268;6236.75052997875;6256.562040657111;6304.747810087545;6382.425581697669;6397.26431460388;6431.839204019937;6451.3548645135115;6463.418292353711;6140.754369825157;6261.154744109487;6283.560150789401;6339.714712838026;6342.460890824332 07:28:00 INFO - PROCESS | 8889 | |5;yui.html;699.6326928362608;737.5132412607678;748.6930358552987;804.7313850189304;813.2680587471275;13759.724805503884;14488.855111448882;14605.123692578452;14687.632809179775;14747.410103595857;12769.553065642704;12777.936110319459;12803.743925121493;12833.550825721102;12881.098323117385;659.143113951863;772.058089131259;799.0770659887838;799.6441583495347;799.8960135182447;804.7545498622918;807.7415227127321;811.3792948394483;813.6135335715547;813.7070654564352;850.6044689219511;852.8209076094028;853.6116067189414;855.4867079752161;857.8798968144465;842.3513894301415;844.4257904624852;849.732334314692;850.6427300533791;851.7827953871785;617.0682269772631;618.6473709985311;624.1947887225474;624.3693869192103;624.9906251406233;14308.713825723531;14322.713545729028;14330.498432554914;14369.640758981004;14400.927995360062;13823.654408639764;13925.860741392558;13936.372863221079;14058.437662493488;14209.57371278853;10676.704508530704;11067.391293478855;11151.163662725246;11178.496967636476;11199.552017919274;3796.126890815128;3807.1053302473897;3869.303525365433;3874.089588946595;3962.484876966005;54468.727656361465;54569;54699;54940.72529637366;55480.44519554793;10504.159667226604;10750.838737418944;10938.343699378063;10971.725706857393;11051.889481105247;20316.79683203149;20320;20325.695114573293;20383.286584969454;20416.0812763426;8053.557054361949;8077.798055048554;8153.714619988272;8230.83538329242;8513.659453621785;4045.7370270932297;4154.231467178582;4216.262154123077;4305.935410968838;4403.603675669206;3195.1532843796413;3226.48376259802;3255.544223808669;3257.77195596306;3271.985684437832;559.5048382181717;588.7144734803617;594.0702800117801;594.5867622002753;600.861801785583;665.6804733727838;684.1414025398094;723.4610215389569;733.5488674465272;763.1185980192886;8946.239569636524;9431.90568094324;9443.76390590227;9460.504401618018;9483.099105584959;634.7746549974693;648.1638686094885;693.6011793218919;725.5574099799119;762.5158024654385;4432.512423633398;4458.242098843204;4480.39514665516;4486.304622783408;4538.228501154812;61896.381036189065;62816.685916570124;63338.683306583174;63356.68321658454;63666;54261.72869135629;55184.72407637936;56287;56425.43574564284;57018.42981570131;50272.74863625658;50741.49258507442;51008.48991510038;51551;51603.7419812906;8715.433496822687;8736.170063843925;8792.472451652666;8873.866891996755;8988.708177745504;33551.993440196835;33637;33846.3230735379;33978.15054623654;34642.307153857284;39960.80019599883;42650.360244596974;44029.119417612106;44571;45091.32363014492;11487.576637624841;11911.642650720492;11945.701357466132;12167.817482737943;12306.692332691755;13442.193468391537;13548.864511355154;13682.179069255877;13768.862311376757;14054.297285135906;12815.16701414405;13169.934150329187;13222.074454788073;13777.380017899019;13842.723145537235;11813.291202527877;11836.76326473483;12499.625011249676;13273.203607783564;13719.1082579636;12474.126811123135;12901;13265.204087754766;13314.267715275753;13527.120737152054;9895.950520247352;9940.701778946643;10091.596336146471;10436.791264174522;10474;11036.834447483134;11046.33721976684;11372.772544548898;11449.14131440162;11501.367424791717 07:28:00 INFO - PROCESS | 8889 | __end_tp_report 07:28:00 INFO - PROCESS | 8889 | __start_cc_report 07:28:00 INFO - PROCESS | 8889 | _x_x_mozilla_cycle_collect,341 07:28:00 INFO - PROCESS | 8889 | __end_cc_report 07:28:00 INFO - PROCESS | 8889 | __startTimestamp1461421680285__endTimestamp 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | ------- Summary: start ------- 07:28:00 INFO - PROCESS | 8889 | Number of tests: 6 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | [#0] dojo.html Cycles:165 Average:5343.65 Median:5561.56 stddev:706.59 (12.7%) stddev-sans-first:687.21 07:28:00 INFO - PROCESS | 8889 | Values: 3136.3 3185.7 3194.5 3217.5 3231.4 5447.7 5454.9 5455.0 5458.6 5462.9 5316.1 5377.6 5413.1 5479.0 5524.9 4908.7 4918.1 4960.6 5007.5 5058.0 850.5 4881.2 4913.4 4943.5 4998.1 4836.4 4875.9 4897.8 4897.9 4916.4 4894.2 4974.9 4976.9 4978.0 5020.7 4827.1 4867.8 4874.8 4895.1 4943.0 5401.2 5434.9 5437.4 5450.9 5457.4 5791.5 5833.5 5860.1 5864.7 5915.7 5636.0 5665.1 5666.7 5674.5 5724.8 5296.9 5302.5 5324.7 5339.3 5357.4 5808.9 5916.6 5936.8 6034.5 6036.5 5553.4 5553.8 5554.1 5561.6 5563.5 5601.6 5605.4 5622.1 5623.9 5640.4 5747.1 5806.3 5809.7 5819.2 5909.9 5631.0 5730.6 5793.5 5843.7 5890.4 4306.3 4345.6 4346.7 4363.2 4394.9 3759.8 3921.7 3951.1 3982.0 3999.5 5510.5 5538.9 5563.9 5565.6 5566.4 5697.0 5823.5 5823.8 5828.3 5854.5 5506.1 5511.5 5524.8 5532.1 5577.3 4793.5 4811.9 4818.1 4819.9 4851.0 5870.2 5997.2 6074.4 6099.0 6104.8 5808.7 5823.2 5825.5 5858.1 5866.9 6048.4 6059.0 6062.7 6074.8 6089.7 5622.4 5653.9 5767.5 5783.9 5809.7 5717.1 5769.0 5769.5 5797.9 5816.6 5543.0 5553.6 5554.1 5561.6 5613.1 5540.6 5565.3 5587.8 5617.8 5639.8 5414.2 5498.5 5527.9 5531.4 5579.6 5712.3 5731.8 5733.6 5742.9 5764.3 5546.9 5632.7 5639.7 5647.5 5660.4 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | [#1] ext.html Cycles:180 Average:53708.05 Median:22391.91 stddev:105402.41 (470.7%) stddev-sans-first:105622.63 07:28:00 INFO - PROCESS | 8889 | Values: 587.5 630.9 639.1 646.7 665.0 32920.5 34148.8 37267.1 38790.0 38887.0 40341.4 40374.0 40511.0 40656.0 40988.8 8620.5 8756.9 8798.3 8804.5 8805.3 8644.0 8798.7 8800.3 8818.4 8824.2 8944.0 9036.7 9047.1 9083.5 9136.0 8944.5 9023.5 9033.1 9042.4 9055.5 8829.4 8906.8 8923.6 8948.8 8956.1 41197.0 41759.6 41797.6 41878.0 42028.8 3653.7 3677.9 3711.5 3916.5 4279.4 30976.8 31205.4 31549.0 31550.8 31895.8 4075.7 4180.5 4191.2 4221.9 4298.4 224667.0 228026.0 228375.0 228488.0 230207.0 35399.0 36369.8 36447.6 36459.0 56266.7 34463.7 34487.8 34523.5 34738.8 34755.5 14851.8 14943.8 15035.3 15058.6 15115.8 11666.9 11676.2 11698.7 11709.1 12095.8 8403.2 8455.0 8487.3 8508.1 8532.0 3271.3 3316.8 3324.3 3333.2 3368.4 1014.3 1032.9 1038.1 1046.2 1088.2 32659.8 33688.0 33974.0 36343.6 36497.8 1087.0 1152.5 1156.3 1171.9 1208.6 16206.8 16809.9 17005.8 17066.5 17195.6 481393.0 493974.0 496962.0 498120.0 498599.0 58056.7 58684.4 58765.0 58951.4 59364.1 1384.5 1409.0 1438.3 1443.5 1513.4 30241.8 30889.7 31273.7 31354.4 31758.4 51894.7 52627.5 52661.2 52781.7 52895.5 418069.0 419208.0 420475.0 420740.0 420761.0 42168.2 42823.0 44030.4 44178.1 44447.0 48411.3 48455.3 48748.8 48890.0 49106.0 40788.2 40939.2 41211.6 41518.0 42202.6 40561.2 40572.0 40708.1 41494.6 42097.9 35339.0 40908.8 41554.8 42693.0 44209.6 33747.3 34800.1 35067.8 35286.0 35294.5 26727.9 27076.6 27146.6 27171.5 27733.3 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | [#2] jquery.html Cycles:180 Average:29659.33 Median:2634.56 stddev:86312.50 (3276.2%) stddev-sans-first:86526.67 07:28:00 INFO - PROCESS | 8889 | Values: 400.9 403.1 403.4 409.5 412.8 13545.9 17832.6 18420.3 18495.2 19022.9 16714.0 16716.9 16968.6 19399.5 19467.3 5566.5 5594.2 5765.0 5778.7 5788.4 5680.3 5753.5 5775.3 5791.6 5806.1 5541.8 5682.9 5690.0 5744.8 5746.9 5586.8 5625.8 5627.2 5627.4 5688.8 4855.7 5054.5 5137.1 5150.8 5153.3 21414.9 22906.4 23011.9 23078.1 23130.8 746.5 1506.6 2346.7 2495.2 2774.0 14200.0 14573.8 14680.6 14755.0 14912.3 1827.1 1918.3 1948.1 2079.4 2086.2 66495.0 77815.6 77906.6 78183.0 80302.2 10512.6 10679.5 10900.5 10907.2 11085.7 15091.0 15218.0 15305.8 15318.0 15339.4 8304.8 8421.1 8551.7 8566.6 8612.9 8325.5 8367.7 8391.3 8521.7 8569.7 6594.4 6713.4 6724.9 6790.0 6838.9 1892.7 1925.4 1966.3 1976.5 1983.6 965.8 1085.5 1090.0 1116.9 1137.7 18886.5 19223.4 19376.2 19403.0 19709.7 974.6 1034.9 1057.4 1072.8 1109.8 10256.6 10472.2 10627.4 10733.7 10778.2 518190.0 522046.0 522477.0 527953.0 533044.0 92791.5 93832.0 96165.0 96383.0 98423.0 1088.4 1095.1 1103.7 1114.4 1116.4 15730.6 16387.3 16475.9 16652.9 16831.9 36651.3 37160.3 38677.2 40274.0 41374.8 50532.7 54145.7 54598.7 55237.7 56539.4 8164.6 8362.0 8445.7 8566.0 8657.8 8192.6 9182.9 10495.9 11244.9 12244.0 11266.5 11777.5 11893.9 11895.2 12023.9 11518.8 11716.1 11737.2 11769.3 12071.8 6204.3 9784.6 11592.9 11759.3 11952.9 8048.2 8595.3 8647.2 8831.4 8994.2 8767.2 10856.0 11946.0 11963.7 11986.5 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | [#3] mootools.html Cycles:180 Average:5542.66 Median:5030.93 stddev:3114.90 (61.9%) stddev-sans-first:3108.76 07:28:00 INFO - PROCESS | 8889 | Values: 1491.8 1530.5 1669.9 1808.0 1838.4 7549.0 8133.7 8184.5 8449.2 8495.0 8225.3 8253.2 8283.9 8284.6 8354.0 2274.0 2290.4 2299.4 2299.5 2302.4 2189.2 2229.4 2268.2 2271.2 2273.0 2216.6 2224.7 2246.7 2249.1 2266.3 2229.7 2232.3 2233.5 2238.3 2238.5 2244.2 2257.3 2260.1 2262.3 2264.0 8458.2 8507.8 8519.4 8557.7 8579.7 5031.7 5133.6 5184.6 5185.5 5205.4 3280.5 3282.5 3336.3 3348.3 3398.5 1155.3 1174.2 1190.5 1195.1 1210.1 11543.5 11606.2 11649.7 11727.7 11734.4 4354.5 4451.6 4615.1 4629.3 4629.6 9062.4 9082.7 9100.0 9141.1 9160.7 5028.2 5028.9 5030.1 5058.5 5060.8 4343.8 4705.7 4724.8 4727.3 4750.2 3628.1 3686.2 3735.1 3785.1 3812.0 1126.1 1132.7 1132.9 1146.4 1147.0 915.3 973.0 984.4 985.7 1003.9 5582.1 5647.3 5676.1 5762.8 5846.7 430.2 434.5 440.1 447.6 447.9 3933.0 3949.7 3962.7 3999.8 4023.7 10145.8 10472.6 10558.8 10623.2 10685.9 10403.5 10444.7 10456.0 10456.3 10457.9 7529.1 7799.0 7820.6 7900.8 7901.7 5908.7 5919.9 5964.5 5979.3 6121.6 9544.0 9599.9 9608.7 9676.8 9739.9 9294.3 9798.9 9878.9 9940.5 9965.9 6796.3 7164.8 7284.0 7397.8 7403.9 8092.4 8110.2 8124.6 8138.1 8166.7 7177.7 7347.7 7373.7 7496.9 7502.6 7173.4 7248.5 7252.3 7262.5 7307.4 6796.6 6810.6 6842.5 6852.3 6864.3 4847.9 5034.0 5051.3 5068.6 5079.2 5016.1 5050.4 5116.0 5120.8 5138.9 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | [#4] prototype.html Cycles:180 Average:5289.55 Median:6103.12 stddev:1611.53 (26.4%) stddev-sans-first:1572.53 07:28:00 INFO - PROCESS | 8889 | Values: 333.1 334.0 342.9 343.7 345.3 6063.4 6088.4 6101.1 6105.1 6129.0 6061.9 6073.3 6078.2 6085.7 6096.9 4383.3 4463.4 4576.6 4579.6 4602.5 4569.3 4579.6 4581.9 4587.1 4594.3 4553.2 4563.0 4576.9 4591.3 4603.0 4285.8 4546.6 4548.9 4551.4 4566.2 3947.3 3956.3 3966.1 3968.3 3969.9 5866.9 5873.6 5874.0 5893.5 5929.3 4999.0 5249.2 5254.6 5263.0 5281.3 6259.6 6282.7 6290.8 6298.1 6323.2 4293.4 4298.2 4358.3 4384.0 4384.7 6571.6 6631.4 6649.6 6687.7 6689.4 4405.6 4406.3 4432.8 4439.7 4446.5 4228.0 4442.0 4505.9 4513.6 4533.8 5183.8 5219.9 5245.1 5248.3 5257.8 6314.5 6364.8 6379.4 6407.3 6441.7 1523.1 1538.1 1538.2 1548.6 1552.5 996.0 1013.6 1021.6 1028.4 1032.6 6070.3 6130.7 6135.6 6145.4 6149.6 6392.4 6492.6 6505.5 6510.0 6536.8 6097.4 6098.8 6111.7 6112.9 6153.6 3443.7 3498.7 3502.2 3504.8 3508.5 6548.4 6675.9 6728.1 6771.8 6778.2 6650.4 6667.4 6720.0 6723.4 6738.3 6591.4 6723.9 6738.2 6757.6 6788.6 6404.0 6410.3 6439.1 6439.1 6493.2 6338.8 6433.4 6463.6 6464.3 6466.8 6727.9 6747.6 6758.8 6767.5 6767.9 4408.3 4427.4 4439.1 4442.6 4451.7 6325.7 6458.5 6490.9 6516.6 6529.1 6272.1 6287.8 6307.7 6316.3 6326.7 6129.6 6287.9 6334.1 6349.2 6350.3 6048.7 6111.3 6236.8 6256.6 6304.7 6382.4 6397.3 6431.8 6451.4 6463.4 6140.8 6261.2 6283.6 6339.7 6342.5 07:28:00 INFO - PROCESS | 8889 | 07:28:00 INFO - PROCESS | 8889 | [#5] yui.html Cycles:180 Average:14855.92 Median:4418.06 stddev:17194.88 (389.2%) stddev-sans-first:17210.25 07:28:00 INFO - PROCESS | 8889 | Values: 699.6 737.5 748.7 804.7 813.3 13759.7 14488.9 14605.1 14687.6 14747.4 12769.6 12777.9 12803.7 12833.6 12881.1 659.1 772.1 799.1 799.6 799.9 804.8 807.7 811.4 813.6 813.7 850.6 852.8 853.6 855.5 857.9 842.4 844.4 849.7 850.6 851.8 617.1 618.6 624.2 624.4 625.0 14308.7 14322.7 14330.5 14369.6 14400.9 13823.7 13925.9 13936.4 14058.4 14209.6 10676.7 11067.4 11151.2 11178.5 11199.6 3796.1 3807.1 3869.3 3874.1 3962.5 54468.7 54569.0 54699.0 54940.7 55480.4 10504.2 10750.8 10938.3 10971.7 11051.9 20316.8 20320.0 20325.7 20383.3 20416.1 8053.6 8077.8 8153.7 8230.8 8513.7 4045.7 4154.2 4216.3 4305.9 4403.6 3195.2 3226.5 3255.5 3257.8 3272.0 559.5 588.7 594.1 594.6 600.9 665.7 684.1 723.5 733.5 763.1 8946.2 9431.9 9443.8 9460.5 9483.1 634.8 648.2 693.6 725.6 762.5 4432.5 4458.2 4480.4 4486.3 4538.2 61896.4 62816.7 63338.7 63356.7 63666.0 54261.7 55184.7 56287.0 56425.4 57018.4 50272.7 50741.5 51008.5 51551.0 51603.7 8715.4 8736.2 8792.5 8873.9 8988.7 33552.0 33637.0 33846.3 33978.2 34642.3 39960.8 42650.4 44029.1 44571.0 45091.3 11487.6 11911.6 11945.7 12167.8 12306.7 13442.2 13548.9 13682.2 13768.9 14054.3 12815.2 13169.9 13222.1 13777.4 13842.7 11813.3 11836.8 12499.6 13273.2 13719.1 12474.1 12901.0 13265.2 13314.3 13527.1 9896.0 9940.7 10091.6 10436.8 10474.0 11036.8 11046.3 11372.8 11449.1 11501.4 07:28:00 INFO - PROCESS | 8889 | -------- Summary: end -------- 07:28:00 INFO - PROCESS | 8889 | 07:28:01 INFO - TEST-INFO | 8889: exit 0 07:28:01 INFO - TEST-OK | dromaeo_css | took 1109876ms 07:28:01 INFO - TEST-START | kraken 07:28:01 INFO - operating with platform_type : linux_ 07:28:01 INFO - Initialising browser for kraken test... 07:28:01 INFO - TEST-INFO | started process 9132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9C64XG/profile http://localhost:45451/getInfo.html) 07:28:04 INFO - PROCESS | 9132 | 07:28:04 INFO - PROCESS | 9132 | (process:9204): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:05 INFO - PROCESS | 9132 | __metrics Screen width/height:1600/1200 07:28:05 INFO - PROCESS | 9132 | colorDepth:24 07:28:05 INFO - PROCESS | 9132 | Browser inner width/height: 1024/697 07:28:05 INFO - PROCESS | 9132 | __metrics 07:28:06 ERROR - PROCESS | 9132 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:28:07 INFO - TEST-INFO | 9132: exit 0 07:28:07 INFO - Browser initialized. 07:28:07 INFO - Running cycle 1/1 for kraken test... 07:28:07 INFO - TEST-INFO | started process 9255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9C64XG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:09 INFO - PROCESS | 9255 | 07:28:09 INFO - PROCESS | 9255 | (process:9314): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:19 INFO - PROCESS | 9255 | RSS: Main: 164909056 07:28:19 INFO - PROCESS | 9255 | 07:28:21 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:22 INFO - PROCESS | 9255 | RSS: Main: 169836544 07:28:22 INFO - PROCESS | 9255 | 07:28:25 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-dft) 07:28:25 INFO - PROCESS | 9255 | RSS: Main: 173125632 07:28:25 INFO - PROCESS | 9255 | 07:28:28 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-fft) 07:28:29 INFO - PROCESS | 9255 | RSS: Main: 164323328 07:28:29 INFO - PROCESS | 9255 | 07:28:31 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45451/tests/kraken/driver.html?testName=audio-oscillator) 07:28:32 INFO - PROCESS | 9255 | RSS: Main: 164720640 07:28:32 INFO - PROCESS | 9255 | 07:28:34 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:34 INFO - PROCESS | 9255 | RSS: Main: 165228544 07:28:34 INFO - PROCESS | 9255 | 07:28:37 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45451/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:38 INFO - PROCESS | 9255 | RSS: Main: 165117952 07:28:38 INFO - PROCESS | 9255 | 07:28:41 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45451/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:42 INFO - PROCESS | 9255 | RSS: Main: 167497728 07:28:42 INFO - PROCESS | 9255 | 07:28:45 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45451/tests/kraken/driver.html?testName=json-parse-financial) 07:28:46 INFO - PROCESS | 9255 | RSS: Main: 167825408 07:28:46 INFO - PROCESS | 9255 | 07:28:47 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:48 INFO - PROCESS | 9255 | RSS: Main: 168038400 07:28:48 INFO - PROCESS | 9255 | 07:28:49 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:50 INFO - PROCESS | 9255 | RSS: Main: 167686144 07:28:50 INFO - PROCESS | 9255 | 07:28:52 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:53 INFO - PROCESS | 9255 | RSS: Main: 167743488 07:28:53 INFO - PROCESS | 9255 | 07:28:55 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:56 INFO - PROCESS | 9255 | RSS: Main: 168443904 07:28:56 INFO - PROCESS | 9255 | 07:28:59 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:59 INFO - PROCESS | 9255 | RSS: Main: 168456192 07:28:59 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | Cycle 1(1): loaded http://localhost:45451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45451/tests/kraken/driver.html?testName=ai-astar) 07:29:01 INFO - PROCESS | 9255 | RSS: Main: 170053632 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | __start_tp_report 07:29:01 INFO - PROCESS | 9255 | _x_x_mozilla_page_load 07:29:01 INFO - PROCESS | 9255 | _x_x_mozilla_page_load_details 07:29:01 INFO - PROCESS | 9255 | |i|pagename|runs| 07:29:01 INFO - PROCESS | 9255 | |0;ai-astar;111;106;111;112;112;124;111;113;112;111 07:29:01 INFO - PROCESS | 9255 | |1;audio-beat-detection;159;135;163;180;132;152;157;128;176;135 07:29:01 INFO - PROCESS | 9255 | |2;audio-dft;162;163;163;162;162;168;176;164;165;163 07:29:01 INFO - PROCESS | 9255 | |3;audio-fft;77;78;73;157;78;77;76;78;175;77 07:29:01 INFO - PROCESS | 9255 | |4;audio-oscillator;93;93;158;93;93;92;139;94;94;150 07:29:01 INFO - PROCESS | 9255 | |5;imaging-gaussian-blur;117;118;118;118;117;118;117;117;118;117 07:29:01 INFO - PROCESS | 9255 | |6;imaging-darkroom;148;147;147;147;147;146;149;148;150;147 07:29:01 INFO - PROCESS | 9255 | |7;imaging-desaturate;95;96;95;98;95;95;100;95;95;95 07:29:01 INFO - PROCESS | 9255 | |8;json-parse-financial;57;59;60;59;58;57;62;78;56;55 07:29:01 INFO - PROCESS | 9255 | |9;json-stringify-tinderbox;61;61;62;61;62;61;61;61;61;61 07:29:01 INFO - PROCESS | 9255 | |10;stanford-crypto-aes;77;77;77;76;77;77;79;77;78;86 07:29:01 INFO - PROCESS | 9255 | |11;stanford-crypto-ccm;127;136;124;126;141;128;125;123;158;133 07:29:01 INFO - PROCESS | 9255 | |12;stanford-crypto-pbkdf2;168;167;167;169;171;163;168;163;165;172 07:29:01 INFO - PROCESS | 9255 | |13;stanford-crypto-sha256-iterative;68;80;69;69;73;68;68;69;67;71 07:29:01 INFO - PROCESS | 9255 | __end_tp_report 07:29:01 INFO - PROCESS | 9255 | __start_cc_report 07:29:01 INFO - PROCESS | 9255 | _x_x_mozilla_cycle_collect,832 07:29:01 INFO - PROCESS | 9255 | __end_cc_report 07:29:01 INFO - PROCESS | 9255 | __startTimestamp1461421741932__endTimestamp 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | ------- Summary: start ------- 07:29:01 INFO - PROCESS | 9255 | Number of tests: 14 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.52 (4.0%) stddev-sans-first:4.77 07:29:01 INFO - PROCESS | 9255 | Values: 111.0 106.0 111.0 112.0 112.0 124.0 111.0 113.0 112.0 111.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.00 stddev:18.58 (11.8%) stddev-sans-first:19.52 07:29:01 INFO - PROCESS | 9255 | Values: 159.0 135.0 163.0 180.0 132.0 152.0 157.0 128.0 176.0 135.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.34 (2.7%) stddev-sans-first:4.48 07:29:01 INFO - PROCESS | 9255 | Values: 162.0 163.0 163.0 162.0 162.0 168.0 176.0 164.0 165.0 163.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.00 stddev:37.90 (49.2%) stddev-sans-first:39.66 07:29:01 INFO - PROCESS | 9255 | Values: 77.0 78.0 73.0 157.0 78.0 77.0 76.0 78.0 175.0 77.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.36 (29.4%) stddev-sans-first:28.33 07:29:01 INFO - PROCESS | 9255 | Values: 93.0 93.0 158.0 93.0 93.0 92.0 139.0 94.0 94.0 150.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:29:01 INFO - PROCESS | 9255 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.24 07:29:01 INFO - PROCESS | 9255 | Values: 148.0 147.0 147.0 147.0 147.0 146.0 149.0 148.0 150.0 147.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.73 (1.8%) stddev-sans-first:1.80 07:29:01 INFO - PROCESS | 9255 | Values: 95.0 96.0 95.0 98.0 95.0 95.0 100.0 95.0 95.0 95.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:6.61 (11.2%) stddev-sans-first:6.91 07:29:01 INFO - PROCESS | 9255 | Values: 57.0 59.0 60.0 59.0 58.0 57.0 62.0 78.0 56.0 55.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 07:29:01 INFO - PROCESS | 9255 | Values: 61.0 61.0 62.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.00 stddev:2.88 (3.7%) stddev-sans-first:3.03 07:29:01 INFO - PROCESS | 9255 | Values: 77.0 77.0 77.0 76.0 77.0 77.0 79.0 77.0 78.0 86.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:130.50 stddev:10.77 (8.3%) stddev-sans-first:11.27 07:29:01 INFO - PROCESS | 9255 | Values: 127.0 136.0 124.0 126.0 141.0 128.0 125.0 123.0 158.0 133.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.00 stddev:3.02 (1.8%) stddev-sans-first:3.19 07:29:01 INFO - PROCESS | 9255 | Values: 168.0 167.0 167.0 169.0 171.0 163.0 168.0 163.0 165.0 172.0 07:29:01 INFO - PROCESS | 9255 | 07:29:01 INFO - PROCESS | 9255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.00 stddev:3.85 (5.6%) stddev-sans-first:4.00 07:29:01 INFO - PROCESS | 9255 | Values: 68.0 80.0 69.0 69.0 73.0 68.0 68.0 69.0 67.0 71.0 07:29:01 INFO - PROCESS | 9255 | -------- Summary: end -------- 07:29:01 INFO - PROCESS | 9255 | 07:29:02 INFO - TEST-INFO | 9255: exit 0 07:29:02 INFO - TEST-OK | kraken | took 61844ms 07:29:02 INFO - SUITE-END | took 1171s 07:29:03 INFO - Completed test suite (00:19:31) 07:29:03 INFO - javascript benchmark 07:29:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.310011797405, 3185.6655051219623, 3194.488881778915, 3217.5012873004694, 3231.40219059474, 5447.700376479297, 5454.890902181954, 5455.018096742585, 5458.590605704578, 5462.945370546293, 5316.12283973144, 5377.5966802489875, 5413.079776438005, 5479.0, 5524.861878453041, 4908.656394052417, 4918.114739346916, 4960.603151747851, 5007.4992500749995, 5058.0, 850.4824367353389, 4881.219004959207, 4913.434954980169, 4943.456219815817, 4998.125328067592, 4836.395450568679, 4875.902481950359, 4897.7795999180125, 4897.9265311020545, 4916.410030796309, 4894.216925291937, 4974.87562810929, 4976.87557811054, 4977.9751101244265, 5020.673656212334, 4827.131116399047, 4867.805287788484, 4874.780634871439, 4895.143349913751, 4942.950570494285, 5401.162819762943, 5434.8913021739345, 5437.429069947638, 5450.91823622646, 5457.426970168154, 5791.536677065825, 5833.504152147073, 5860.062390017577, 5864.70676466175, 5915.674637894914, 5636.0, 5665.065264231438, 5666.660000399989, 5674.460926212003, 5724.77100915967, 5296.92054619181, 5302.522772950453, 5324.7071411072375, 5339.252504649352, 5357.410684824627, 5808.94191058084, 5916.645001299936, 5936.762529498858, 6034.5172386209, 6036.486898613579, 5553.361363443175, 5553.77784888608, 5554.055810512223, 5561.610687251854, 5563.471470210324, 5601.579881508903, 5605.411431799603, 5622.072358060874, 5623.915641265385, 5640.435956404327, 5747.08046712524, 5806.30324361071, 5809.680467574324, 5819.185314056035, 5909.940900591025, 5631.0, 5730.627509211971, 5793.507551858055, 5843.737031833578, 5890.410958904075, 4306.332518459643, 4345.608895199447, 4346.6522678185665, 4363.2364336241035, 4394.934075988863, 3759.7556158850134, 3921.705872059607, 3951.130751234724, 3981.960180398217, 3999.480067591253, 5510.5316048135555, 5538.944610553924, 5563.860903477445, 5565.638233514808, 5566.415526369754, 5697.0, 5823.475887170175, 5823.796167134215, 5828.329742079715, 5854.502367298827, 5506.146547285177, 5511.5039646432015, 5524.8342549723575, 5532.059549876531, 5577.330720313588, 4793.49668284832, 4811.941372897957, 4818.084563932912, 4819.855404337875, 4851.029794041206, 5870.236869206976, 5997.190379298826, 6074.36219196978, 6099.0, 6104.755809767648, 5808.738606762706, 5823.18475413451, 5825.475707186373, 5858.062709966385, 5866.911996319973, 6048.425399587032, 6059.0, 6062.6665533394325, 6074.848128796815, 6089.665068421279, 5622.437756224344, 5653.943460565506, 5767.5385969121535, 5783.8554036149435, 5809.709514524172, 5717.142428635738, 5768.971155144198, 5769.509591684586, 5797.9420205797405, 5816.621919575214, 5543.0, 5553.555715542828, 5554.08357620988, 5561.555075593862, 5613.101903695389, 5540.63985840919, 5565.30433695788, 5587.776488940397, 5617.831465056055, 5639.830805075854, 5414.242006119068, 5498.532624726783, 5527.944720552743, 5531.446855314436, 5579.637323573955, 5712.34308054579, 5731.828045158652, 5733.598648094593, 5742.937556552051, 5764.279465066867, 5546.861328466659, 5632.746526406403, 5639.718014099197, 5647.463490968352, 5660.37735849048], "value": 5298.0441949515425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.538782056086, 630.8990561510158, 639.143547646154, 646.6508085633758, 665.0190968321729, 32920.506192407134, 34148.829255853714, 37267.0683232919, 38790.0, 38887.02782430441, 40341.39487907676, 40374.0, 40511.0, 40656.0, 40988.795056024675, 8620.482771033727, 8756.8686469703, 8798.29613630908, 8804.471731696087, 8805.25155361795, 8643.956780216122, 8798.6920457784, 8800.251978581797, 8818.426802257865, 8824.161704638082, 8943.95528022359, 9036.68371606994, 9047.140521650434, 9083.500407477586, 9136.040715724854, 8944.508052057134, 9023.503707296097, 9033.051529589397, 9042.367034307536, 9055.547222638908, 8829.381943263974, 8906.777330566723, 8923.598438070303, 8948.821023579492, 8956.104389561056, 41197.0, 41759.582404175875, 41797.582024179675, 41878.0, 42028.78985605053, 3653.733593912778, 3677.9264414711556, 3711.536057992751, 3916.5495967963766, 4279.358096285551, 30976.84511577428, 31205.37589248225, 31549.0, 31550.842245788623, 31895.840520797246, 4075.673946084306, 4180.498340199165, 4191.224623444673, 4221.894452638709, 4298.376735373385, 224667.0, 228026.0, 228374.99999999834, 228488.0, 230207.0, 35399.0, 36369.81815090908, 36447.63552364495, 36459.0, 56266.71866640641, 34463.65536344604, 34487.82756086203, 34523.482147767805, 34738.82630586831, 34755.47866782, 14851.777223341658, 14943.775843362359, 15035.323410446555, 15058.623534411727, 15115.773263401057, 11666.88333116675, 11676.241044332091, 11698.70753231176, 11709.121815863844, 12095.81856272139, 8403.243708066304, 8454.957725211334, 8487.278581320534, 8508.10664880191, 8532.0, 3271.2803183299634, 3316.8341582920757, 3324.335132973415, 3333.2000319923045, 3368.3768502827056, 1014.2504180289089, 1032.901296111665, 1038.1331588124, 1046.210111365914, 1088.1566785740956, 32659.836700816344, 33688.0, 33973.964637945726, 36343.63656363403, 36497.817510912275, 1086.999960036768, 1152.464104191555, 1156.2946602572424, 1171.8593768747805, 1208.5528354508888, 16206.75689864653, 16809.91595042017, 17005.829941700424, 17066.525353823625, 17195.570110747332, 481393.0, 493974.0, 496962.0, 498120.0, 498599.0, 58056.709716451995, 58684.41315586875, 58765.0, 58951.41048589545, 59364.1095383561, 1384.536180379564, 1408.9506867259802, 1438.3383643523887, 1443.5236371997005, 1513.4173343262703, 30241.848790755907, 30889.69110308868, 31273.687263127078, 31354.372912541166, 31758.364832702755, 51894.74052629713, 52627.47372526226, 52661.21008184804, 52781.7360913193, 52895.47104528906, 418069.0, 419208.0, 420475.0, 420740.0, 420761.0, 42168.1566368677, 42823.0, 44030.35817850939, 44178.116437671706, 44447.0, 48411.27383089327, 48455.27317090176, 48748.75625621849, 48890.0, 49106.0, 40788.18423631451, 40939.1812163761, 41211.587884120774, 41518.0, 42202.577974219865, 40561.1887762249, 40572.0, 40708.14152834135, 41494.58505414907, 42097.94755131146, 35339.0, 40908.795456022526, 41554.79222603868, 42693.0, 44209.55790442183, 33747.3250534983, 34800.129996750285, 35067.82466087653, 35286.0, 35294.47058294179, 26727.86636066807, 27076.593851092643, 27146.592801108392, 27171.456570868868, 27733.30666733348], "value": 18589.33912088084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.9498812648418, 403.06287880677417, 403.43921948491595, 409.520860593106, 412.77503760450554, 13545.932270338635, 17832.643347133067, 18420.263189472404, 18495.167717452714, 19022.904885475553, 16714.0, 16716.916415417905, 16968.575785605368, 19399.515012124702, 19467.31864384747, 5566.526845218141, 5594.216809646642, 5764.971175144118, 5778.739956701937, 5788.42115788422, 5680.289963754531, 5753.453421924932, 5775.3358363788075, 5791.623544469617, 5806.071028635419, 5541.750621222055, 5682.863427314533, 5690.0, 5744.79893203738, 5746.856328591777, 5586.832395028176, 5625.803096891589, 5627.240322556464, 5627.380988091307, 5688.800891968782, 4855.660103792736, 5054.519820617035, 5137.075326441239, 5150.845474635767, 5153.2785410042625, 21414.892925535274, 22906.427339316484, 23011.884940575357, 23078.076876924904, 23130.76869231303, 746.5446077892482, 1506.6158129676862, 2346.7066616672914, 2495.152744618184, 2773.959765088092, 14200.0, 14573.781393279109, 14680.55958321252, 14755.0, 14912.254387280702, 1827.1138497828542, 1918.2710569983317, 1948.123344494983, 2079.4177630263553, 2086.175960495611, 66495.0, 77815.61092194503, 77906.61046694787, 78183.0, 80302.19697803006, 10512.579496820195, 10679.519421626046, 10900.50947707355, 10907.236493445542, 11085.722856928642, 15091.0, 15218.0, 15305.846941530664, 15318.0, 15339.386424543116, 8304.792380190424, 8421.115782842835, 8551.657933682583, 8566.61450234741, 8612.913870861337, 8325.5004699717, 8367.665293388196, 8391.32909306951, 8521.744347669579, 8569.742907712778, 6594.373534514213, 6713.362230588086, 6724.9327506725285, 6790.015447760146, 6838.863222735517, 1892.6877065284075, 1925.3838771593237, 1966.272479182683, 1976.4762337980446, 1983.6032793441082, 965.8406362950175, 1085.5386460754148, 1089.9509522071526, 1116.9218154729253, 1137.7155711072232, 18886.527836803914, 19223.423297301102, 19376.2249510018, 19403.0, 19709.704354434696, 974.6296407365297, 1034.886162522122, 1057.391999600233, 1072.8337107748312, 1109.801414472368, 10256.641017564349, 10472.16222702182, 10627.415492148006, 10733.677989660322, 10778.245522813328, 518190.0, 522046.0, 522477.0, 527953.0, 533044.0, 92791.53604231936, 93832.0, 96165.0, 96383.0, 98423.0, 1088.4122573810212, 1095.0910744082391, 1103.6578660615235, 1114.4483480677118, 1116.4250411038322, 15730.606734831721, 16387.34450621962, 16475.917620411823, 16652.916735416246, 16831.91584042072, 36651.266974659826, 37160.256794864494, 38677.2264554713, 40273.99315017148, 41374.79312603418, 50532.747336263084, 54145.72927135339, 54598.727006364716, 55237.7238113823, 56539.434605655064, 8164.550949697824, 8361.95819020901, 8445.746627601182, 8565.95717021411, 8657.82684346297, 8192.590370481334, 9182.862257066283, 10495.947520262655, 11244.9437752814, 12244.0, 11266.549338026387, 11777.470013849226, 11893.940530297294, 11895.226810257305, 12023.879761202275, 11518.82721759191, 11716.121290903046, 11737.180348760128, 11769.293842369485, 12071.758564828478, 6204.348543403058, 9784.6301517789, 11592.942035289769, 11759.294442333487, 11952.940235298767, 8048.235417635316, 8595.312375009858, 8647.178518040777, 8831.425957312755, 8994.190522852712, 8767.167119123673, 10856.032868164917, 11946.044316454489, 11963.700907477034, 11986.520539178335], "value": 9220.999450282005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.7836913647525, 1530.5255370835039, 1669.9081550514725, 1807.9819201807977, 1838.4392760208138, 7549.0, 8133.715319963802, 8184.468009579373, 8449.155084491547, 8494.957525212372, 8225.300849427806, 8253.215944485279, 8283.91716082839, 8284.627191776384, 8354.039285482171, 2274.0221704666988, 2290.3586995641163, 2299.37916762474, 2299.5285966376937, 2302.4128847143957, 2189.2447105748493, 2229.442639340165, 2268.2174649745893, 2271.2164303315412, 2272.9545409091807, 2216.6231740604057, 2224.655178447343, 2246.6517689758034, 2249.1116009176367, 2266.3314322274887, 2229.7101376820992, 2232.3191426614876, 2233.5421238646118, 2238.3396897915154, 2238.541099074686, 2244.2369594338, 2257.2776711452343, 2260.0507786729613, 2262.2534563593977, 2264.0264686184933, 8458.196471335214, 8507.829843403159, 8519.446235994703, 8557.700480483154, 8579.699710510165, 5031.723255220962, 5133.589312854962, 5184.559312458446, 5185.507376799235, 5205.401378841444, 3280.5243239730107, 3282.4748040313434, 3336.2993771308056, 3348.263382055944, 3398.4562470004926, 1155.3356819828548, 1174.201542950793, 1190.5118901250532, 1195.121585634558, 1210.1287073307205, 11543.480543375568, 11606.24559403636, 11649.708757281136, 11727.7068073298, 11734.354610496504, 4354.455693038371, 4451.554844515587, 4615.053913947632, 4629.305604159335, 4629.560191781776, 9062.410943288665, 9082.727518174466, 9100.0, 9141.131592498701, 9160.6793762218, 5028.170351891897, 5028.874278143076, 5030.144875371196, 5058.519440653132, 5060.7722652480725, 4343.782810859444, 4705.6941298816155, 4724.811007559728, 4727.338172655831, 4750.168720473903, 3628.129248980226, 3686.170611612366, 3735.0662334416397, 3785.072657199004, 3812.046988252937, 1126.0709914320719, 1132.7111586545543, 1132.8527291452224, 1146.3523109443138, 1146.9942650286696, 915.2906497464518, 972.9513524323755, 984.3601658921615, 985.7190700650281, 1003.8694969653898, 5582.134769110794, 5647.265855438766, 5676.120201368794, 5762.827115186551, 5846.684495988368, 430.16118568790984, 434.50032462667554, 440.0516886110437, 447.583747115186, 447.8611630394523, 3932.980335098306, 3949.7235193536753, 3962.7226094173707, 3999.7600143991453, 4023.6781057515327, 10145.847812282822, 10472.581096756197, 10558.788824223473, 10623.203259755395, 10685.946570267099, 10403.53184106717, 10444.686659400078, 10456.0, 10456.26806123564, 10457.9477102614, 7529.096508419025, 7798.961005194938, 7820.608969551614, 7900.841983160304, 7901.683932642745, 5908.675022873783, 5919.85200369977, 5964.493018093511, 5979.252593425822, 6121.602095863755, 9544.0, 9599.904000960181, 9608.66369677058, 9676.806463870542, 9739.853902191331, 9294.25645948309, 9798.85301720489, 9878.901210987799, 9940.502974851084, 9965.850512242467, 6796.252412234551, 7164.785056448315, 7283.963580182065, 7397.778066658009, 7403.851922961403, 8092.433529652868, 8110.188981101843, 8124.63439145228, 8138.145494722969, 8166.6733330668485, 7177.677004534704, 7347.742829000959, 7373.705051797868, 7496.887546686913, 7502.624868756431, 7173.42612590981, 7248.492605517563, 7252.347288743827, 7262.491625586158, 7307.378872795659, 6796.558223715443, 6810.62541560219, 6842.486813488908, 6852.280510546321, 6864.313568643096, 4847.854564363075, 5034.0, 5051.292819005415, 5068.569171620454, 5079.187330027178, 5016.097102521581, 5050.393952725696, 5116.0, 5120.820771272987, 5138.871528211825], "value": 4394.144957994551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.14880480372653, 333.96326404095544, 342.8851334802841, 343.65977682094734, 345.25080575151924, 6063.363346848583, 6088.421599948003, 6101.145839582451, 6105.084237364397, 6128.969355153218, 6061.909071363922, 6073.301570319414, 6078.209832721751, 6085.726142323595, 6096.908546371808, 4383.268608899482, 4463.419755431789, 4576.610988066019, 4579.564941330568, 4602.470715867685, 4569.314602809572, 4579.610733087691, 4581.908361832761, 4587.105514424688, 4594.3338215958665, 4553.157665831815, 4562.9771851140695, 4576.908461830762, 4591.334256532801, 4603.0, 4285.8071386787515, 4546.613537849286, 4548.931766023512, 4551.385562949025, 4566.150708962876, 3947.2697550953167, 3956.3274243378405, 3966.107625784204, 3968.285708572456, 3969.861054863095, 5866.853328666817, 5873.647581145145, 5874.002839034706, 5893.469587737124, 5929.288485381739, 4998.950010499885, 5249.160134378481, 5254.581263058953, 5262.973685131588, 5281.313429254211, 6259.593126446812, 6282.654454005028, 6290.779822706229, 6298.118263443076, 6323.20959880015, 4293.3989241506215, 4298.161858437606, 4358.346248062784, 4383.978080109611, 4384.671149663756, 6571.605703657796, 6631.4363279121335, 6649.634270115142, 6687.699053542602, 6689.431398331099, 4405.559444055633, 4406.317020861771, 4432.822687092545, 4439.711418757771, 4446.5331140230455, 4228.0, 4441.977790111094, 4505.887352816206, 4513.616342610915, 4533.818647254073, 5183.766730497136, 5219.947800522022, 5245.082110630625, 5248.317718696545, 5257.8159764408065, 6314.494840412756, 6364.84087897797, 6379.425851673279, 6407.327230640809, 6441.677916104176, 1523.116592376419, 1538.100211376335, 1538.2310343105294, 1548.6051056980398, 1552.5031989763393, 995.955182016811, 1013.554036224059, 1021.5556233038503, 1028.4138041316528, 1032.6179313653845, 6070.3019152797115, 6130.6628135452975, 6135.570510064253, 6145.385461453819, 6149.631022138686, 6392.4246817786625, 6492.577982431127, 6505.544611877123, 6510.0, 6536.7712130075215, 6097.420745029215, 6098.817035488943, 6111.747091846161, 6112.938870611237, 6153.569250152446, 3443.707284880763, 3498.7026102781037, 3502.178866989151, 3504.8422820972605, 3508.5438892943753, 6548.443382312556, 6675.899861502081, 6728.125343705287, 6771.762988295386, 6778.18661760582, 6650.401463868178, 6667.366600172976, 6720.0, 6723.394894459522, 6738.32616738332, 6591.373819487141, 6723.899141512881, 6738.157730283617, 6757.594544327356, 6788.626625535544, 6403.96798016007, 6410.262819775599, 6439.098526206241, 6439.130717353098, 6493.155889734304, 6338.841528961629, 6433.356664333529, 6463.642635046693, 6464.2889282177985, 6466.773662921775, 6727.8990815138795, 6747.628880411428, 6758.831029224309, 6767.526273160832, 6767.89848152288, 4408.250597398514, 4427.402300689366, 4439.089986552814, 4442.577955094261, 4451.732896026248, 6325.683715814099, 6458.515611329075, 6490.870182596416, 6516.609003459807, 6529.118568993125, 6272.121902933502, 6287.842803929939, 6307.747690092345, 6316.305206427198, 6326.715297811702, 6129.570930035033, 6287.868183726973, 6334.144890439732, 6349.206349206349, 6350.301466838551, 6048.6975651218145, 6111.266648002268, 6236.75052997875, 6256.562040657111, 6304.747810087545, 6382.425581697669, 6397.26431460388, 6431.839204019937, 6451.3548645135115, 6463.418292353711, 6140.754369825157, 6261.154744109487, 6283.560150789401, 6339.714712838026, 6342.460890824332], "value": 4760.591018332269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6326928362608, 737.5132412607678, 748.6930358552987, 804.7313850189304, 813.2680587471275, 13759.724805503884, 14488.855111448882, 14605.123692578452, 14687.632809179775, 14747.410103595857, 12769.553065642704, 12777.936110319459, 12803.743925121493, 12833.550825721102, 12881.098323117385, 659.143113951863, 772.058089131259, 799.0770659887838, 799.6441583495347, 799.8960135182447, 804.7545498622918, 807.7415227127321, 811.3792948394483, 813.6135335715547, 813.7070654564352, 850.6044689219511, 852.8209076094028, 853.6116067189414, 855.4867079752161, 857.8798968144465, 842.3513894301415, 844.4257904624852, 849.732334314692, 850.6427300533791, 851.7827953871785, 617.0682269772631, 618.6473709985311, 624.1947887225474, 624.3693869192103, 624.9906251406233, 14308.713825723531, 14322.713545729028, 14330.498432554914, 14369.640758981004, 14400.927995360062, 13823.654408639764, 13925.860741392558, 13936.372863221079, 14058.437662493488, 14209.57371278853, 10676.704508530704, 11067.391293478855, 11151.163662725246, 11178.496967636476, 11199.552017919274, 3796.126890815128, 3807.1053302473897, 3869.303525365433, 3874.089588946595, 3962.484876966005, 54468.727656361465, 54569.0, 54699.0, 54940.72529637366, 55480.44519554793, 10504.159667226604, 10750.838737418944, 10938.343699378063, 10971.725706857393, 11051.889481105247, 20316.79683203149, 20320.0, 20325.695114573293, 20383.286584969454, 20416.0812763426, 8053.557054361949, 8077.798055048554, 8153.714619988272, 8230.83538329242, 8513.659453621785, 4045.7370270932297, 4154.231467178582, 4216.262154123077, 4305.935410968838, 4403.603675669206, 3195.1532843796413, 3226.48376259802, 3255.544223808669, 3257.77195596306, 3271.985684437832, 559.5048382181717, 588.7144734803617, 594.0702800117801, 594.5867622002753, 600.861801785583, 665.6804733727838, 684.1414025398094, 723.4610215389569, 733.5488674465272, 763.1185980192886, 8946.239569636524, 9431.90568094324, 9443.76390590227, 9460.504401618018, 9483.099105584959, 634.7746549974693, 648.1638686094885, 693.6011793218919, 725.5574099799119, 762.5158024654385, 4432.512423633398, 4458.242098843204, 4480.39514665516, 4486.304622783408, 4538.228501154812, 61896.381036189065, 62816.685916570124, 63338.683306583174, 63356.68321658454, 63666.0, 54261.72869135629, 55184.72407637936, 56287.0, 56425.43574564284, 57018.42981570131, 50272.74863625658, 50741.49258507442, 51008.48991510038, 51551.0, 51603.7419812906, 8715.433496822687, 8736.170063843925, 8792.472451652666, 8873.866891996755, 8988.708177745504, 33551.993440196835, 33637.0, 33846.3230735379, 33978.15054623654, 34642.307153857284, 39960.80019599883, 42650.360244596974, 44029.119417612106, 44571.0, 45091.32363014492, 11487.576637624841, 11911.642650720492, 11945.701357466132, 12167.817482737943, 12306.692332691755, 13442.193468391537, 13548.864511355154, 13682.179069255877, 13768.862311376757, 14054.297285135906, 12815.16701414405, 13169.934150329187, 13222.074454788073, 13777.380017899019, 13842.723145537235, 11813.291202527877, 11836.76326473483, 12499.625011249676, 13273.203607783564, 13719.1082579636, 12474.126811123135, 12901.0, 13265.204087754766, 13314.267715275753, 13527.120737152054, 9895.950520247352, 9940.701778946643, 10091.596336146471, 10436.791264174522, 10474.0, 11036.834447483134, 11046.33721976684, 11372.772544548898, 11449.14131440162, 11501.367424791717], "value": 6699.083440286892, "unit": "score"}], "name": "dromaeo_css", "value": 7092.369367383373, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 112.0, 112.0, 124.0, 111.0, 113.0, 112.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 163.0, 180.0, 132.0, 152.0, 157.0, 128.0, 176.0, 135.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 162.0, 168.0, 176.0, 164.0, 165.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 73.0, 157.0, 78.0, 77.0, 76.0, 78.0, 175.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 93.0, 93.0, 92.0, 139.0, 94.0, 94.0, 150.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 149.0, 148.0, 150.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 98.0, 95.0, 95.0, 100.0, 95.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 60.0, 59.0, 58.0, 57.0, 62.0, 78.0, 56.0, 55.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 76.0, 77.0, 77.0, 79.0, 77.0, 78.0, 86.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 136.0, 124.0, 126.0, 141.0, 128.0, 125.0, 123.0, 158.0, 133.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 167.0, 169.0, 171.0, 163.0, 168.0, 163.0, 165.0, 172.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 80.0, 69.0, 69.0, 73.0, 68.0, 68.0, 69.0, 67.0, 71.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1563.2999999999997, "alertThreshold": 2.0}]} 07:29:03 INFO - Return code: 0 07:29:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:29:03 ERROR - # TBPL SUCCESS # 07:29:03 INFO - Running post-action listener: _resource_record_post_action 07:29:03 INFO - Running post-run listener: _resource_record_post_run 07:29:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 545153024; Read time: 216; Write time: 600524 07:29:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254996480; Read time: 0; Write time: 296988 07:29:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 290156544; Read time: 216; Write time: 303536 07:29:04 INFO - Running post-run listener: _upload_blobber_files 07:29:04 INFO - Blob upload gear active. 07:29:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:29:04 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'] 07:29:04 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 07:29:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:05 INFO - (blobuploader) - INFO - Done attempting. 07:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:06 INFO - (blobuploader) - INFO - Done attempting. 07:29:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:06 INFO - Return code: 0 07:29:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75c2ae3f0827965f03728e3efc7458d9afd72d79db55476f15728dfb86702ecb3abc487cb2eb4aaab8d1473f4fdfced933ed08d81e7253b74d04a7c467ae0356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672e3928e362ea41b2646930b641c643fb1ae2fce0df47a7810d1b826c82e9d720673cac2b7b904d26c49972595d389be56e1f7167dde790aba2c88f4e22043e"} 07:29:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:06 INFO - Contents: 07:29:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75c2ae3f0827965f03728e3efc7458d9afd72d79db55476f15728dfb86702ecb3abc487cb2eb4aaab8d1473f4fdfced933ed08d81e7253b74d04a7c467ae0356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672e3928e362ea41b2646930b641c643fb1ae2fce0df47a7810d1b826c82e9d720673cac2b7b904d26c49972595d389be56e1f7167dde790aba2c88f4e22043e"} 07:29:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:06 INFO - Copying logs to upload dir... 07:29:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.735891 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-23 07:29:05.435868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:29:05.439092) ========= 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=fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834 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/75c2ae3f0827965f03728e3efc7458d9afd72d79db55476f15728dfb86702ecb3abc487cb2eb4aaab8d1473f4fdfced933ed08d81e7253b74d04a7c467ae0356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672e3928e362ea41b2646930b641c643fb1ae2fce0df47a7810d1b826c82e9d720673cac2b7b904d26c49972595d389be56e1f7167dde790aba2c88f4e22043e"} build_url:https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/fAH99D8ETjS39_YdCX1e5w/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/75c2ae3f0827965f03728e3efc7458d9afd72d79db55476f15728dfb86702ecb3abc487cb2eb4aaab8d1473f4fdfced933ed08d81e7253b74d04a7c467ae0356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672e3928e362ea41b2646930b641c643fb1ae2fce0df47a7810d1b826c82e9d720673cac2b7b904d26c49972595d389be56e1f7167dde790aba2c88f4e22043e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 07:29:05.463667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:29:05.463985) ========= 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=fa44defc139c4ba8574fe040000001db-1461417769.327231-1715001834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 07:29:05.546367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:29:05.546671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:29:05.546975) ========= ========= Total master_lag: 0.16 =========