builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1460644451.16 results: success (0) buildid: 20160414043009 builduid: 5932c9d202b54d4bb055a02eae7a328e revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.162363) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.162854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.163134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.180468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.180851) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 07:34:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.4M=0s 2016-04-14 07:34:12 (82.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094575 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.480101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.480491) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015784 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.508280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:11.508678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 91115264629dfaacf2d60d52a3eff89c18c5af0d --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 91115264629dfaacf2d60d52a3eff89c18c5af0d --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=516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 07:34:12,416 truncating revision to first 12 chars 2016-04-14 07:34:12,416 Setting DEBUG logging. 2016-04-14 07:34:12,416 attempt 1/10 2016-04-14 07:34:12,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/91115264629d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 07:34:12,867 unpacking tar archive at: mozilla-central-91115264629d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748516 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:12.270278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:12.270619) ========= script_repo_revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:12.271032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:12.271324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 07:34:12.323284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-14 07:34:12.323677) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:34:13 INFO - MultiFileLogger online at 20160414 07:34:13 in /builds/slave/test 07:34:13 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:34:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:13 INFO - {'append_to_log': False, 07:34:13 INFO - 'base_work_dir': '/builds/slave/test', 07:34:13 INFO - 'blob_upload_branch': 'Firefox', 07:34:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:13 INFO - 'branch': 'Firefox', 07:34:13 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:13 INFO - 'config_files': ('talos/linux_config.py',), 07:34:13 INFO - 'default_actions': ('clobber', 07:34:13 INFO - 'read-buildbot-config', 07:34:13 INFO - 'download-and-extract', 07:34:13 INFO - 'populate-webroot', 07:34:13 INFO - 'create-virtualenv', 07:34:13 INFO - 'install', 07:34:13 INFO - 'run-tests'), 07:34:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:13 INFO - 'download_minidump_stackwalk': True, 07:34:13 INFO - 'download_symbols': 'ondemand', 07:34:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:13 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:13 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:13 INFO - 'installer_path': 'installer.exe', 07:34:13 INFO - 'log_level': 'info', 07:34:13 INFO - 'log_name': 'talos', 07:34:13 INFO - 'log_to_console': True, 07:34:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:34:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:34:13 INFO - 'opt_config_files': (), 07:34:13 INFO - 'pip_index': False, 07:34:13 INFO - 'sps_profile': False, 07:34:13 INFO - 'sps_profile_interval': 0, 07:34:13 INFO - 'suite': 'dromaeojs-e10s', 07:34:13 INFO - 'system_bits': '32', 07:34:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:13 INFO - 'title': 'talos-linux64-ix-061', 07:34:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:13 INFO - 'use_talos_json': True, 07:34:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:13 INFO - 'work_dir': 'build'} 07:34:13 INFO - ##### 07:34:13 INFO - ##### Running clobber step. 07:34:13 INFO - ##### 07:34:13 INFO - Running pre-action listener: _resource_record_pre_action 07:34:13 INFO - Running main action method: clobber 07:34:13 INFO - rmtree: /builds/slave/test/build 07:34:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:14 INFO - Running post-action listener: _resource_record_post_action 07:34:14 INFO - ##### 07:34:14 INFO - ##### Running read-buildbot-config step. 07:34:14 INFO - ##### 07:34:14 INFO - Running pre-action listener: _resource_record_pre_action 07:34:14 INFO - Running main action method: read_buildbot_config 07:34:14 INFO - Using buildbot properties: 07:34:14 INFO - { 07:34:14 INFO - "project": "", 07:34:14 INFO - "product": "firefox", 07:34:14 INFO - "script_repo_revision": "production", 07:34:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:34:14 INFO - "repository": "", 07:34:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:34:14 INFO - "buildid": "20160414043009", 07:34:14 INFO - "pgo_build": "True", 07:34:14 INFO - "basedir": "/builds/slave/test", 07:34:14 INFO - "buildnumber": 178, 07:34:14 INFO - "slavename": "talos-linux64-ix-061", 07:34:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:34:14 INFO - "platform": "ubuntu64_hw", 07:34:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:34:14 INFO - "branch": "mozilla-central", 07:34:14 INFO - "repo_path": "mozilla-central", 07:34:14 INFO - "revision": "91115264629dfaacf2d60d52a3eff89c18c5af0d", 07:34:14 INFO - "stage_platform": "linux64-pgo", 07:34:14 INFO - "builduid": "5932c9d202b54d4bb055a02eae7a328e", 07:34:14 INFO - "slavebuilddir": "test" 07:34:14 INFO - } 07:34:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:34:14 INFO - Running post-action listener: _resource_record_post_action 07:34:14 INFO - ##### 07:34:14 INFO - ##### Running download-and-extract step. 07:34:14 INFO - ##### 07:34:14 INFO - Running pre-action listener: _resource_record_pre_action 07:34:14 INFO - Running main action method: download_and_extract 07:34:14 INFO - mkdir: /builds/slave/test/build/tests 07:34:14 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:34:14 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:34:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:34:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:34:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:15 INFO - Downloaded 1361 bytes. 07:34:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:34:15 INFO - Using the following test package requirements: 07:34:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:34:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:34:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'jsshell-linux-x86_64.zip'], 07:34:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:34:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:34:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:34:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:34:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:34:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:34:15 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:34:15 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:34:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:34:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:34:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:17 INFO - Downloaded 23774359 bytes. 07:34:17 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:34:17 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:34:18 INFO - Return code: 0 07:34:18 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:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:18 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:19 INFO - Downloaded 23774359 bytes. 07:34:19 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:34:19 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:34:21 INFO - Return code: 0 07:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:21 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:34:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:22 INFO - Downloaded 10841076 bytes. 07:34:22 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:34:22 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:34:22 INFO - Return code: 0 07:34:22 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:34:22 INFO - https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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:34:24 INFO - Downloaded 58137284 bytes. 07:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:34:24 INFO - mkdir: /builds/slave/test/properties 07:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:24 INFO - Contents: 07:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:34:25 INFO - Running post-action listener: _resource_record_post_action 07:34:25 INFO - Running post-action listener: set_extra_try_arguments 07:34:25 INFO - ##### 07:34:25 INFO - ##### Running populate-webroot step. 07:34:25 INFO - ##### 07:34:25 INFO - Running pre-action listener: _resource_record_pre_action 07:34:25 INFO - Running main action method: populate_webroot 07:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:25 INFO - '--tppagecycles', 07:34:25 INFO - '7'], 07:34:25 INFO - 'tests': ['tsvgm']}}, 07:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['damp', 'tps']}, 07:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'tests': ['damp', 'tps']}, 07:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['dromaeo_dom']}, 07:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tsvgx', 07:34:25 INFO - 'tsvgr_opacity', 07:34:25 INFO - 'tart', 07:34:25 INFO - 'tscrollx', 07:34:25 INFO - 'cart']}, 07:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:25 INFO - 'tsvgr_opacity', 07:34:25 INFO - 'tart', 07:34:25 INFO - 'tscrollx', 07:34:25 INFO - 'cart']}, 07:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tp5o']}, 07:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'tests': ['tp5o']}, 07:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s', 07:34:25 INFO - '--xperf_path', 07:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:25 INFO - 'tests': ['tp5n']}, 07:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:34:25 INFO - 'talos_options': ['--xperf_path', 07:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:25 INFO - 'tests': ['tp5n']}}, 07:34:25 INFO - 'talos.zip': {'path': '', 07:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:25 INFO - Running post-action listener: _resource_record_post_action 07:34:25 INFO - ##### 07:34:25 INFO - ##### Running create-virtualenv step. 07:34:25 INFO - ##### 07:34:25 INFO - Running pre-action listener: _resource_record_pre_action 07:34:25 INFO - Running main action method: create_virtualenv 07:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:25 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:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:25 INFO - Using real prefix '/usr' 07:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:27 INFO - Installing pip.................done. 07:34:27 INFO - Return code: 0 07:34:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:27 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:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:27 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:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:27 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:27 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:34:27 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:34:27 INFO - Using env: {'DISPLAY': ':0', 07:34:27 INFO - 'HOME': '/home/cltbld', 07:34:27 INFO - 'LANG': 'en_US.UTF-8', 07:34:27 INFO - 'LANGUAGE': 'en_US:en', 07:34:27 INFO - 'LOGNAME': 'cltbld', 07:34:27 INFO - 'MAIL': '/var/mail/cltbld', 07:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:27 INFO - 'MOZ_NO_REMOTE': '1', 07:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:27 INFO - 'NO_EM_RESTART': '1', 07:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:27 INFO - 'PWD': '/builds/slave/test', 07:34:27 INFO - 'SHELL': '/bin/bash', 07:34:27 INFO - 'SHLVL': '1', 07:34:27 INFO - 'TERM': 'linux', 07:34:27 INFO - 'TMOUT': '86400', 07:34:27 INFO - 'USER': 'cltbld', 07:34:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:27 INFO - '_': '/tools/buildbot/bin/python'} 07:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:27 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:34:27 INFO - Cleaning up... 07:34:27 INFO - Return code: 0 07:34:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:34:27 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:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:27 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:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:27 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:27 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:34:27 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:34:27 INFO - Using env: {'DISPLAY': ':0', 07:34:27 INFO - 'HOME': '/home/cltbld', 07:34:27 INFO - 'LANG': 'en_US.UTF-8', 07:34:27 INFO - 'LANGUAGE': 'en_US:en', 07:34:27 INFO - 'LOGNAME': 'cltbld', 07:34:27 INFO - 'MAIL': '/var/mail/cltbld', 07:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:27 INFO - 'MOZ_NO_REMOTE': '1', 07:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:27 INFO - 'NO_EM_RESTART': '1', 07:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:27 INFO - 'PWD': '/builds/slave/test', 07:34:27 INFO - 'SHELL': '/bin/bash', 07:34:27 INFO - 'SHLVL': '1', 07:34:27 INFO - 'TERM': 'linux', 07:34:27 INFO - 'TMOUT': '86400', 07:34:27 INFO - 'USER': 'cltbld', 07:34:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:27 INFO - '_': '/tools/buildbot/bin/python'} 07:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:28 INFO - Downloading/unpacking psutil>=0.7.1 07:34:28 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:34:28 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:34:28 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:34:28 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:34:28 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:34:28 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:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:30 INFO - Installing collected packages: psutil 07:34:30 INFO - Running setup.py install for psutil 07:34:30 INFO - building 'psutil._psutil_linux' extension 07:34:30 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:34:30 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:34:30 INFO - building 'psutil._psutil_posix' extension 07:34:30 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:34:30 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:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:30 INFO - Successfully installed psutil 07:34:30 INFO - Cleaning up... 07:34:30 INFO - Return code: 0 07:34:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:30 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:30 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:34:30 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:34:30 INFO - Using env: {'DISPLAY': ':0', 07:34:30 INFO - 'HOME': '/home/cltbld', 07:34:30 INFO - 'LANG': 'en_US.UTF-8', 07:34:30 INFO - 'LANGUAGE': 'en_US:en', 07:34:30 INFO - 'LOGNAME': 'cltbld', 07:34:30 INFO - 'MAIL': '/var/mail/cltbld', 07:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:30 INFO - 'MOZ_NO_REMOTE': '1', 07:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:30 INFO - 'NO_EM_RESTART': '1', 07:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:30 INFO - 'PWD': '/builds/slave/test', 07:34:30 INFO - 'SHELL': '/bin/bash', 07:34:30 INFO - 'SHLVL': '1', 07:34:30 INFO - 'TERM': 'linux', 07:34:30 INFO - 'TMOUT': '86400', 07:34:30 INFO - 'USER': 'cltbld', 07:34:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:30 INFO - '_': '/tools/buildbot/bin/python'} 07:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:34:30 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:34:30 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:34:30 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:34:30 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:34:30 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:34:30 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:34:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:32 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:34:32 INFO - Installing collected packages: mozsystemmonitor 07:34:32 INFO - Running setup.py install for mozsystemmonitor 07:34:32 INFO - Successfully installed mozsystemmonitor 07:34:32 INFO - Cleaning up... 07:34:32 INFO - Return code: 0 07:34:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:32 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:32 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:34:32 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:34:32 INFO - Using env: {'DISPLAY': ':0', 07:34:32 INFO - 'HOME': '/home/cltbld', 07:34:32 INFO - 'LANG': 'en_US.UTF-8', 07:34:32 INFO - 'LANGUAGE': 'en_US:en', 07:34:32 INFO - 'LOGNAME': 'cltbld', 07:34:32 INFO - 'MAIL': '/var/mail/cltbld', 07:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:32 INFO - 'MOZ_NO_REMOTE': '1', 07:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:32 INFO - 'NO_EM_RESTART': '1', 07:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:32 INFO - 'PWD': '/builds/slave/test', 07:34:32 INFO - 'SHELL': '/bin/bash', 07:34:32 INFO - 'SHLVL': '1', 07:34:32 INFO - 'TERM': 'linux', 07:34:32 INFO - 'TMOUT': '86400', 07:34:32 INFO - 'USER': 'cltbld', 07:34:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:32 INFO - '_': '/tools/buildbot/bin/python'} 07:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:33 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:34:33 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:34:33 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:34:33 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:34:33 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:34:33 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:34:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:35 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:34:35 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:34:35 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:34:35 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:34:35 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:34:35 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:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:35 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:34:35 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:34:35 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:34:35 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:34:35 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:34:35 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:34:35 INFO - Downloading docopt-0.6.1.tar.gz 07:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:35 INFO - Running setup.py install for blobuploader 07:34:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:35 INFO - Running setup.py install for requests 07:34:36 INFO - Running setup.py install for docopt 07:34:36 INFO - Successfully installed blobuploader requests docopt 07:34:36 INFO - Cleaning up... 07:34:36 INFO - Return code: 0 07:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:36 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:36 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:34:36 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:34:36 INFO - Using env: {'DISPLAY': ':0', 07:34:36 INFO - 'HOME': '/home/cltbld', 07:34:36 INFO - 'LANG': 'en_US.UTF-8', 07:34:36 INFO - 'LANGUAGE': 'en_US:en', 07:34:36 INFO - 'LOGNAME': 'cltbld', 07:34:36 INFO - 'MAIL': '/var/mail/cltbld', 07:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:36 INFO - 'MOZ_NO_REMOTE': '1', 07:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:36 INFO - 'NO_EM_RESTART': '1', 07:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:36 INFO - 'PWD': '/builds/slave/test', 07:34:36 INFO - 'SHELL': '/bin/bash', 07:34:36 INFO - 'SHLVL': '1', 07:34:36 INFO - 'TERM': 'linux', 07:34:36 INFO - 'TMOUT': '86400', 07:34:36 INFO - 'USER': 'cltbld', 07:34:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:36 INFO - '_': '/tools/buildbot/bin/python'} 07:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:36 INFO - Running setup.py (path:/tmp/pip-vRnjNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:36 INFO - Running setup.py (path:/tmp/pip-NVv6E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:36 INFO - Running setup.py (path:/tmp/pip-qlzEwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:36 INFO - Running setup.py (path:/tmp/pip-G96Imf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:36 INFO - Running setup.py (path:/tmp/pip-u7wFbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:36 INFO - Running setup.py (path:/tmp/pip-ANe4DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:36 INFO - Running setup.py (path:/tmp/pip-7w_J69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:37 INFO - Running setup.py (path:/tmp/pip-BLlnMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:37 INFO - Running setup.py (path:/tmp/pip-yeMIEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:37 INFO - Running setup.py (path:/tmp/pip-J9sd4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:37 INFO - Running setup.py (path:/tmp/pip-2tebId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:37 INFO - Running setup.py (path:/tmp/pip-tc1yIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:37 INFO - Running setup.py (path:/tmp/pip-kFYzGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:37 INFO - Running setup.py (path:/tmp/pip-E5bmUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:37 INFO - Running setup.py (path:/tmp/pip-wfkl0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:37 INFO - Running setup.py (path:/tmp/pip-gsc8vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:37 INFO - Running setup.py (path:/tmp/pip-n8OuRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:37 INFO - Running setup.py install for manifestparser 07:34:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:37 INFO - Running setup.py install for mozcrash 07:34:37 INFO - Running setup.py install for mozdebug 07:34:38 INFO - Running setup.py install for mozdevice 07:34:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Running setup.py install for mozfile 07:34:38 INFO - Running setup.py install for mozhttpd 07:34:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Running setup.py install for mozinfo 07:34:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Running setup.py install for mozInstall 07:34:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Running setup.py install for mozleak 07:34:38 INFO - Running setup.py install for mozlog 07:34:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Running setup.py install for moznetwork 07:34:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:38 INFO - Running setup.py install for mozprocess 07:34:38 INFO - Running setup.py install for mozprofile 07:34:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:39 INFO - Running setup.py install for mozrunner 07:34:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:39 INFO - Running setup.py install for mozscreenshot 07:34:39 INFO - Running setup.py install for moztest 07:34:39 INFO - Running setup.py install for mozversion 07:34:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:39 INFO - Cleaning up... 07:34:39 INFO - Return code: 0 07:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34: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:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:39 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:39 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:34:39 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:34:39 INFO - Using env: {'DISPLAY': ':0', 07:34:39 INFO - 'HOME': '/home/cltbld', 07:34:39 INFO - 'LANG': 'en_US.UTF-8', 07:34:39 INFO - 'LANGUAGE': 'en_US:en', 07:34:39 INFO - 'LOGNAME': 'cltbld', 07:34:39 INFO - 'MAIL': '/var/mail/cltbld', 07:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:39 INFO - 'MOZ_NO_REMOTE': '1', 07:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:39 INFO - 'NO_EM_RESTART': '1', 07:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:39 INFO - 'PWD': '/builds/slave/test', 07:34:39 INFO - 'SHELL': '/bin/bash', 07:34:39 INFO - 'SHLVL': '1', 07:34:39 INFO - 'TERM': 'linux', 07:34:39 INFO - 'TMOUT': '86400', 07:34:39 INFO - 'USER': 'cltbld', 07:34:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:39 INFO - '_': '/tools/buildbot/bin/python'} 07:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:39 INFO - Running setup.py (path:/tmp/pip-3A9Ebb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:39 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:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:39 INFO - Running setup.py (path:/tmp/pip-su8Kw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:39 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:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:39 INFO - Running setup.py (path:/tmp/pip-0vHmno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:39 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:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:39 INFO - Running setup.py (path:/tmp/pip-uzNjNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:40 INFO - Running setup.py (path:/tmp/pip-dGrJcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:40 INFO - Running setup.py (path:/tmp/pip-AoxbeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:40 INFO - Running setup.py (path:/tmp/pip-gcurCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:40 INFO - Running setup.py (path:/tmp/pip-40hYAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:40 INFO - Running setup.py (path:/tmp/pip-MQhf_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:40 INFO - Running setup.py (path:/tmp/pip-4Vj2ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:40 INFO - Running setup.py (path:/tmp/pip-N6_bhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:40 INFO - Running setup.py (path:/tmp/pip-z5e_5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:40 INFO - Running setup.py (path:/tmp/pip-K_Oxtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:40 INFO - Running setup.py (path:/tmp/pip-_wgvcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:40 INFO - Running setup.py (path:/tmp/pip-U2KmjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:40 INFO - Running setup.py (path:/tmp/pip-dasUjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:40 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:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:40 INFO - Running setup.py (path:/tmp/pip-fxlSDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:42 INFO - Downloading blessings-1.6.tar.gz 07:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:42 INFO - Installing collected packages: blessings 07:34:42 INFO - Running setup.py install for blessings 07:34:43 INFO - Successfully installed blessings 07:34:43 INFO - Cleaning up... 07:34:43 INFO - Return code: 0 07:34:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:43 INFO - Reading from file tmpfile_stdout 07:34:43 INFO - Current package versions: 07:34:43 INFO - argparse == 1.2.1 07:34:43 INFO - blessings == 1.6 07:34:43 INFO - blobuploader == 1.2.4 07:34:43 INFO - docopt == 0.6.1 07:34:43 INFO - manifestparser == 1.1 07:34:43 INFO - mozInstall == 1.12 07:34:43 INFO - mozcrash == 0.17 07:34:43 INFO - mozdebug == 0.1 07:34:43 INFO - mozdevice == 0.48 07:34:43 INFO - mozfile == 1.2 07:34:43 INFO - mozhttpd == 0.7 07:34:43 INFO - mozinfo == 0.9 07:34:43 INFO - mozleak == 0.1 07:34:43 INFO - mozlog == 3.1 07:34:43 INFO - moznetwork == 0.27 07:34:43 INFO - mozprocess == 0.22 07:34:43 INFO - mozprofile == 0.28 07:34:43 INFO - mozrunner == 6.11 07:34:43 INFO - mozscreenshot == 0.1 07:34:43 INFO - mozsystemmonitor == 0.0 07:34:43 INFO - moztest == 0.7 07:34:43 INFO - mozversion == 1.4 07:34:43 INFO - psutil == 3.1.1 07:34:43 INFO - requests == 1.2.3 07:34:43 INFO - wsgiref == 0.1.2 07:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:43 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:43 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:34:43 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:34:43 INFO - Using env: {'DISPLAY': ':0', 07:34:43 INFO - 'HOME': '/home/cltbld', 07:34:43 INFO - 'LANG': 'en_US.UTF-8', 07:34:43 INFO - 'LANGUAGE': 'en_US:en', 07:34:43 INFO - 'LOGNAME': 'cltbld', 07:34:43 INFO - 'MAIL': '/var/mail/cltbld', 07:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:43 INFO - 'MOZ_NO_REMOTE': '1', 07:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:43 INFO - 'NO_EM_RESTART': '1', 07:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:43 INFO - 'PWD': '/builds/slave/test', 07:34:43 INFO - 'SHELL': '/bin/bash', 07:34:43 INFO - 'SHLVL': '1', 07:34:43 INFO - 'TERM': 'linux', 07:34:43 INFO - 'TMOUT': '86400', 07:34:43 INFO - 'USER': 'cltbld', 07:34:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:43 INFO - '_': '/tools/buildbot/bin/python'} 07:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 INFO - Cleaning up... 07:34:43 INFO - Return code: 0 07:34:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:43 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:43 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:34:43 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:34:43 INFO - Using env: {'DISPLAY': ':0', 07:34:43 INFO - 'HOME': '/home/cltbld', 07:34:43 INFO - 'LANG': 'en_US.UTF-8', 07:34:43 INFO - 'LANGUAGE': 'en_US:en', 07:34:43 INFO - 'LOGNAME': 'cltbld', 07:34:43 INFO - 'MAIL': '/var/mail/cltbld', 07:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:43 INFO - 'MOZ_NO_REMOTE': '1', 07:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:43 INFO - 'NO_EM_RESTART': '1', 07:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:43 INFO - 'PWD': '/builds/slave/test', 07:34:43 INFO - 'SHELL': '/bin/bash', 07:34:43 INFO - 'SHLVL': '1', 07:34:43 INFO - 'TERM': 'linux', 07:34:43 INFO - 'TMOUT': '86400', 07:34:43 INFO - 'USER': 'cltbld', 07:34:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:43 INFO - '_': '/tools/buildbot/bin/python'} 07:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:43 INFO - Downloading/unpacking jsonschema 07:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:43 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:34:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:34:45 INFO - Downloading/unpacking functools32 (from jsonschema) 07:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:34:45 INFO - warning: no files found matching '*.txt' 07:34:45 INFO - no previously-included directories found matching 'build' 07:34:45 INFO - no previously-included directories found matching 'dist' 07:34:45 INFO - no previously-included directories found matching '.git*' 07:34:45 INFO - Installing collected packages: jsonschema, functools32 07:34:45 INFO - Running setup.py install for functools32 07:34:45 INFO - warning: no files found matching '*.txt' 07:34:45 INFO - no previously-included directories found matching 'build' 07:34:45 INFO - no previously-included directories found matching 'dist' 07:34:45 INFO - no previously-included directories found matching '.git*' 07:34:46 INFO - Successfully installed jsonschema functools32 07:34:46 INFO - Cleaning up... 07:34:46 INFO - Return code: 0 07:34:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:34: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:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:46 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 0x7feb39a40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', '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:34:46 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:34:46 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:34:46 INFO - Using env: {'DISPLAY': ':0', 07:34:46 INFO - 'HOME': '/home/cltbld', 07:34:46 INFO - 'LANG': 'en_US.UTF-8', 07:34:46 INFO - 'LANGUAGE': 'en_US:en', 07:34:46 INFO - 'LOGNAME': 'cltbld', 07:34:46 INFO - 'MAIL': '/var/mail/cltbld', 07:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:46 INFO - 'MOZ_NO_REMOTE': '1', 07:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:46 INFO - 'NO_EM_RESTART': '1', 07:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:46 INFO - 'PWD': '/builds/slave/test', 07:34:46 INFO - 'SHELL': '/bin/bash', 07:34:46 INFO - 'SHLVL': '1', 07:34:46 INFO - 'TERM': 'linux', 07:34:46 INFO - 'TMOUT': '86400', 07:34:46 INFO - 'USER': 'cltbld', 07:34:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:46 INFO - '_': '/tools/buildbot/bin/python'} 07:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:46 INFO - Downloading/unpacking flake8 07:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:34:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:34:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:34:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:34:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:34:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:34:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:34:48 INFO - no previously-included directories found matching 'docs/_build' 07:34:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:34:48 INFO - Running setup.py install for pep8 07:34:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:34:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:34:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:34:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:34:49 INFO - no previously-included directories found matching 'docs/_build' 07:34:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:34:49 INFO - Cleaning up... 07:34:49 INFO - Return code: 0 07:34:49 INFO - Running post-action listener: _resource_record_post_action 07:34:49 INFO - Running post-action listener: _start_resource_monitoring 07:34:49 INFO - Starting resource monitoring. 07:34:49 INFO - ##### 07:34:49 INFO - ##### Running install step. 07:34:49 INFO - ##### 07:34:49 INFO - Running pre-action listener: _resource_record_pre_action 07:34:49 INFO - Running main action method: install 07:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:49 INFO - Reading from file tmpfile_stdout 07:34:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:49 INFO - Reading from file tmpfile_stdout 07:34:49 INFO - Output received: 07:34:49 INFO - Usage: mozinstall [options] installer 07:34:49 INFO - Options: 07:34:49 INFO - -h, --help show this help message and exit 07:34:49 INFO - -d DEST, --destination=DEST 07:34:49 INFO - Directory to install application into. [default: 07:34:49 INFO - "/builds/slave/test"] 07:34:49 INFO - --app=APP Application being installed. [default: firefox] 07:34:49 INFO - mkdir: /builds/slave/test/build/application 07:34:49 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:34:49 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:35:05 INFO - Reading from file tmpfile_stdout 07:35:05 INFO - Output received: 07:35:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:35:05 INFO - Running post-action listener: _resource_record_post_action 07:35:05 INFO - ##### 07:35:05 INFO - ##### Running run-tests step. 07:35:05 INFO - ##### 07:35:05 INFO - Running pre-action listener: _resource_record_pre_action 07:35:05 INFO - Running main action method: run_tests 07:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:05 INFO - Python 2.7.3 07:35:05 INFO - Return code: 0 07:35:05 INFO - grabbing minidump binary from tooltool 07:35:05 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:35:05 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 0x2d13410>, '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 0x2d14310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d147a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:05 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:35:05 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:35:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:06 INFO - Return code: 0 07:35:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:35:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:35:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:35:07 INFO - Return code: 0 07:35:07 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/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:35:07 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/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:35:07 INFO - Using env: {'DISPLAY': ':0', 07:35:07 INFO - 'HOME': '/home/cltbld', 07:35:07 INFO - 'LANG': 'en_US.UTF-8', 07:35:07 INFO - 'LANGUAGE': 'en_US:en', 07:35:07 INFO - 'LOGNAME': 'cltbld', 07:35:07 INFO - 'MAIL': '/var/mail/cltbld', 07:35:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:07 INFO - 'MOZ_NO_REMOTE': '1', 07:35:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:07 INFO - 'NO_EM_RESTART': '1', 07:35:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:07 INFO - 'PWD': '/builds/slave/test', 07:35:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:07 INFO - 'SHELL': '/bin/bash', 07:35:07 INFO - 'SHLVL': '1', 07:35:07 INFO - 'TERM': 'linux', 07:35:07 INFO - 'TMOUT': '86400', 07:35:07 INFO - 'USER': 'cltbld', 07:35:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718', 07:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:07 INFO - '_': '/tools/buildbot/bin/python'} 07:35:07 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/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:35:07 INFO - mozversion application_buildid: 20160414043009 07:35:07 INFO - mozversion application_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 07:35:07 INFO - mozversion application_display_name: Nightly 07:35:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:07 INFO - mozversion application_name: Firefox 07:35:07 INFO - mozversion application_remotingname: firefox 07:35:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:35:07 INFO - mozversion application_vendor: Mozilla 07:35:07 INFO - mozversion application_version: 48.0a1 07:35:07 INFO - mozversion platform_buildid: 20160414043009 07:35:07 INFO - mozversion platform_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 07:35:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:35:07 INFO - mozversion platform_version: 48.0a1 07:35:07 INFO - using testdate: 1460644507 07:35:07 INFO - actual date: 1460644507 07:35:07 INFO - starting webserver on 'localhost:35330' 07:35:07 INFO - SUITE-START | Running 2 tests 07:35:07 INFO - TEST-START | dromaeo_css 07:35:07 INFO - operating with platform_type : linux_ 07:35:07 INFO - Initialising browser for dromaeo_css test... 07:35:07 INFO - TEST-INFO | started process 8880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnclcGN/profile http://localhost:35330/getInfo.html) 07:35:11 INFO - PROCESS | 8880 | 07:35:11 INFO - PROCESS | 8880 | (process:8947): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:35:11 INFO - PROCESS | 8880 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:35:11 INFO - PROCESS | 8880 | __metrics Screen width/height:1600/1200 07:35:11 INFO - PROCESS | 8880 | colorDepth:24 07:35:11 INFO - PROCESS | 8880 | Browser inner width/height: 1024/697 07:35:11 INFO - PROCESS | 8880 | __metrics 07:35:12 ERROR - PROCESS | 8880 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:35:13 INFO - TEST-INFO | 8880: exit 0 07:35:13 INFO - Browser initialized. 07:35:13 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:13 INFO - TEST-INFO | started process 8998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnclcGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:15 INFO - PROCESS | 8998 | 07:35:15 INFO - PROCESS | 8998 | (process:9059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:35:25 INFO - PROCESS | 8998 | RSS: Main: 163110912 07:35:25 INFO - PROCESS | 8998 | 07:36:14 INFO - PROCESS | 8998 | 1460644574950 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:38:22 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:35330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35330/tests/dromaeo/cssquery-ext.html) 07:38:23 INFO - PROCESS | 8998 | RSS: Main: 168648704 07:38:23 INFO - PROCESS | 8998 | 07:41:25 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:35330/tests/dromaeo/cssquery-ext.html (next: http://localhost:35330/tests/dromaeo/cssquery-jquery.html) 07:41:25 INFO - PROCESS | 8998 | RSS: Main: 165654528 07:41:25 INFO - PROCESS | 8998 | 07:44:27 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:35330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35330/tests/dromaeo/cssquery-mootools.html) 07:44:28 INFO - PROCESS | 8998 | RSS: Main: 166182912 07:44:28 INFO - PROCESS | 8998 | 07:47:29 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:35330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35330/tests/dromaeo/cssquery-prototype.html) 07:47:30 INFO - PROCESS | 8998 | RSS: Main: 163696640 07:47:30 INFO - PROCESS | 8998 | 07:50:32 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:35330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35330/tests/dromaeo/cssquery-yui.html) 07:50:33 INFO - PROCESS | 8998 | RSS: Main: 165281792 07:50:33 INFO - PROCESS | 8998 | 07:53:35 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:35330/tests/dromaeo/cssquery-yui.html (next: http://localhost:35330/tests/dromaeo/cssquery-dojo.html) 07:53:36 INFO - PROCESS | 8998 | RSS: Main: 167387136 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | __start_tp_report 07:53:36 INFO - PROCESS | 8998 | _x_x_mozilla_page_load 07:53:36 INFO - PROCESS | 8998 | _x_x_mozilla_page_load_details 07:53:36 INFO - PROCESS | 8998 | |i|pagename|runs| 07:53:36 INFO - PROCESS | 8998 | |0;dojo.html;3082.614673165854;3134.623845138584;3160.683931606839;3190.872365105396;3191.1702957231114;5445.673259604427;5456.099743542316;5457.972710136453;5467;5490.945090549093;5235.083860324447;5333.893322133555;5433.891322173554;5446.972765136169;5454.34547854257;4787.6169906407495;4866.245731911559;4939.58013568847;4944.233643785219;4987.700737955716;916.4559502542014;4774.355462012636;4883.365162528867;4894.5594896459315;4932.062908047477;4922;4950.529699678525;4968.677035992649;4970.055689419017;4999.075171093359;4944.703317800908;4954.975225123887;4975.477574854661;4995.275685025651;5016.372953380827;4774.665773395864;4856.975715121437;4918.8278410255825;4925.729084900365;4933.136701077297;5300.939812037569;5313.1764576490705;5314.601404894648;5327.573794096502;5364.222187782789;5750.424957504258;5768.625039372428;5771.88456230873;5781.913271300934;5827.446392592739;5617.522510586605;5670.149477578355;5703.828885133453;5714.228579141804;5779.9422005779825;5440.591955603346;5450.890982180374;5465.398806131322;5466.398696143381;5477;5644.57665675076;5908.350081491032;5932.881342373128;5945.732442040118;5955.821325360246;5501.394846566875;5576.275084239023;5579.804706835242;5583.106702927512;5614.9157762633595;5721.170430287668;5733.569982251348;5737.225474560964;5743.770249190069;5756.453136951983;5548.86127846799;5651.773929042874;5725.885482290331;5733.082706766897;5736.368999410061;5791.652500849962;5805.274340707411;5812.3025236971835;5832.300123985149;5865.35481097079;4380.518143004267;4389.626881715026;4405.625521830616;4410.757408342572;4419.845305414295;3849.8845034649007;3917.745346552465;3950.5654378018394;3971.5035620547433;4002.939955900664;5235.712035838065;5439.075357189287;5532.30846144232;5550.361708403585;5574.721263936787;5808.651480911159;5864.237649105589;5867.501262392744;5867.589268751147;5880.529557635379;5206.895862082737;5453.400125986138;5519.944800551943;5564.8052318169475;5570.5265052470995;4891.682040667345;4902;4929.87675308113;4937.136001199848;4966.6771659842;5908.438698323653;5911.290645122527;5912.408759124053;5922.052471604608;5988.101784732325;5624.690642014565;5768.538516918637;5791.971040144772;5866.67733274674;5872.941270587239;5952.642841429528;5982.790602328898;5983.491403230774;5987.131865879336;5988.790392336247;5704.714764261687;5709.200711900255;5710;5712;5723.5707321950185;5662.122371032497;5725.914111288417;5734.799282025276;5754.53963682896;5809.24479817621;5474.835754927359;5565.38780734127;5566.276384070045;5567.972160139173;5590.608657394106;5441.809536666197;5499.9175012375645;5566.165075238747;5567.832965011056;5570.888582228414;5583.972080139736;5618.157276408571;5629.7748090077575;5635.915461268166;5671.773129074791;5609.80365687199;5653.236813030188;5655.321361436654;5683.71581420919;5704.885902282014;5420.918686219631;5495.505404513613;5560.026995275892;5572.0527510324155;5590.580706446952 07:53:36 INFO - PROCESS | 8998 | |1;ext.html;601.3775742106917;648.500654496038;649.0685865782599;657.8717150155719;671.2079745899839;29145.708542914563;38875.80562097189;39653;39797.8010109949;40000.79999599998;41941.16117677645;42308.57691423092;42694.35958460625;42788.78605606975;42839.143217135635;8579.914200857975;8845.115488451167;8848;8854.513001784899;8859.557022148867;8741.956290218572;8836.513991730451;8863.645454181857;8867.955660221722;8881.600327985256;8866.512341821197;8928.330375221853;8940.374173807835;8957.283417326631;9135.086491350845;9025.368224224274;9025.413348132382;9042.954785226064;9047.502387368691;9082.591283392198;8948.776280592972;8962.82074358509;9015.729528114167;9021.278297736231;9022.14289642483;42475.36286955698;42910.785446072885;43013.56986430127;43347.56652433467;43358.349624755654;3413.2149605590603;3427.5544179256785;3470.132466883279;3641.7814931103953;4373.147236288925;31494.842525787226;32034.839825800722;32153.51769723456;32653.18367040843;33013.50479742806;4065.056795615209;4081.2041651877894;4137.089840235143;4137.931034482759;4148.419221309019;280278;284484;285377;285694;286048;35828.46257306143;36795.81602091972;59212.11181832276;60263;60274.09588856171;34852;35046.64953350434;35221;35236.82381588127;35259.4711079334;15031.473898413504;15048.247587620575;15136.54590362291;15265.465708700141;15276.15981121049;12487.31319777421;12491.87508124907;12590.181638193488;12596.496140154475;12679.175853569488;8482.406231563731;8541.188587084218;8575;8582.313414926915;8595;3357.093584732109;3376.7636265461183;3376.7973921564785;3391.9491207631904;3407.1311815486893;1057.957681692739;1066.6373433032652;1148.6898537394857;1169.7075731067234;1239.6714870559308;32111.197220069684;32299.838500807346;32309.67690323114;32431.189220269684;32681.18297042593;1097.1113398147527;1152.6081132414852;1245.8380410546752;1249.056961993689;1305.8041293806004;15065.924670376578;15314.310856011507;15553.533393998197;15847.841521584867;16059.437919672755;341193;345790;346881;347619;347621;53530;54501.45498545043;54709.45290547043;54792.72603636956;59115.70442147762;1313.2317594207304;1361.162884825825;1380.2201756007823;1389.8471168171493;1455.9490417835325;29924.401511970074;30114.88196139442;30236.546451802802;30731.692683072884;31124.22189445282;47910;48351;48378;48567.514324856296;48583.05667773391;388921;390069;391421;392249;394195;28849.278768030967;29331;44159;45498;45961.540384595726;43062.35406468968;43111;43886.56113438825;43960.780196098814;44318.55681443273;38347.2330553393;39503.407448887716;40349.596504035755;40977.1804563913;42175.7891210542;38816.417753734284;40017;40046.8792858385;40881.38677919774;41076.383854242806;41051;41496.17007659769;43010.56989430066;44260.55739442565;44604.77697611491;32786;33772.831135844164;33927.491087633214;35815.46276805902;36602.26795464129;28303.29241768972;28789.56815647725;28825;28865.85567072151;28877.855610721814 07:53:36 INFO - PROCESS | 8998 | |2;jquery.html;394.32570304778847;400.3414383339406;400.9518857737068;405.50933370621544;408.19992814084395;13414.932925335384;17973.910130449363;18502.629947401045;19458.1243844027;19504.9024754876;17617.207225674843;18099.819001809978;18466.353677621286;18528.351507697233;18551.721724174113;5210.869728256805;5522.944770552303;5584.497395234418;5829.038208695561;5863.941360586382;5354.196870469441;5416.079266524681;5423.403425623178;5426.701531415771;5429.619926605139;5248.973755131219;5610.495055445009;5618.297712785902;5626.156076588524;5634.464725851038;5430.3755068167075;5479.671219726829;6148.077788331741;6323.6521991290465;6334.651594162319;5518.172274158868;5544.473275038865;5575;5587.8882422351735;5613.691246981414;17590.82409175905;21082.156713731434;21759.129634814588;22004.77995220043;22113.447163821034;2154.709114269569;2198.043850924853;2286.119843860126;2407.6749638798715;2416.846373239794;10028.548715307828;10976.286541374786;12945.54690585825;14149.787753183711;14300.213488258141;1905.3236101184157;1910.4650697804636;1980.9009549522466;1991.6912878503856;1995.4213278149318;70588.2941170592;71948.2805171952;72652;72944;74131.62934185294;9976.902540720515;10244.59021639141;10493.790124197474;10618.885017073251;10732.497450356956;14725.926370368294;14774.778378324334;14784.408623654934;14834.703305933821;14860.92569537167;7815.218478152253;7858.528488290721;7957.204279572113;7982.002249718786;8029.317508011768;7547.28300811422;7651.120121186135;7704.422168337285;7726.7681969541;7760.107587627383;4466.3747075409465;4617.538246175355;4640.484466976738;4666.976665116721;4729.527047295243;1905.8380037696952;1921.953119927273;1972.6547854125758;1985.1563085688524;1989.7413336266193;903.4895284164558;978.1490103609905;1014.5789497358661;1063.4576366053368;1106.5794997900746;17576;17685.094248381043;17778.911105444648;18372.265109395474;18523.44429667112;992.6079198716467;1046.2728403759313;1054.235679132638;1073.0771536478621;1089.6730980705756;10142.949285253526;10388.948055259676;10430.791384172426;10462;10526.210534209966;341772;347931;348675;489491;494345;84757.57621211854;90282.54858725665;91546;91962.54018729864;92788;1069.8609180806445;1071.3946620159586;1075.070064394309;1109.162582250412;1115.2082021764477;16304.592385190464;16683;16747.665046699243;16912.915435422743;17080.402185923434;33954.3209135811;35779;36931.6306836939;38394.616053839105;39266.41100383439;43555.782221088695;46382.304265436724;50872.236916445545;52167.21749173841;52282.21576676429;7332.816679583053;8351.624176911931;8534.274586659954;8723.78190545216;8741.519216443157;7562.168161502121;11068.896909587153;12069.698257543632;13220.008499362393;13632.727345453233;11699.473523691284;11909.40452977365;11956.222845515014;11958.940205298917;12028.09789265791;11549;11594.826077609012;11693.824592631288;11778.76442471163;11867.58463453775;11899.405029748652;11964.521419143484;12044.457999389873;12094.758104837678;12104.51581936748;7848.568328741974;7916.722914697958;7984.121746607752;8061.717839875576;8135.186481352054;11355.716107097058;11493.770124597628;11513.712157196138;11773.17587768848;11827.881721182677 07:53:36 INFO - PROCESS | 8998 | |3;mootools.html;1300.765862144814;1412.3291436567629;1450.8404075551693;1799.118431968336;1848.5840685845678;7374.668139933702;8018.879716804246;8290.958545207266;8322.209390107937;8363.874541881876;8359.707410240642;8360.163983601637;8375.455595386296;8437.240648341663;8440.788980275496;2308.9769102309015;2316.3514216019544;2337.030132495021;2346.85918844869;2352.4001379648166;2284.7029886114783;2295.6441751528455;2315.571619250444;2325.476767727265;2330.347502699247;2310.560993411255;2319.7100362454694;2326.360250930991;2347.272345572878;2349.565330413879;2251.324602619208;2271.5229801741652;2275;2278.1456953642382;2292.4039749665126;2191.671249312616;2194.7366316042016;2197.033305345659;2198.7251593550805;2202.196198387593;8430.578471076422;8458.830823383498;8470.915290847135;8478.152184781535;8494.575271236414;5031.924521132186;5189.844304670828;5190.2993095932325;5194.298769666085;5205.427402985669;3253.4957081652383;3342.131045928076;3427.234973988398;3448.7241020718534;3468.4103702370658;1085.0614218700766;1095.6220104064084;1099.648112603967;1113.5323164270944;1116.8998536441597;11522.539098436053;11579.189456738031;11637.010854077414;11682.065434765198;11711.414429278502;4516.548345165523;4530.478994915627;4673.929891051637;4688.226442636995;4689.320048592935;9943.105120539187;9967.302288839712;10049.949750251202;10051.145652619463;10077.546510406903;5232.581393488512;5238.135707608202;5252.2384254282915;5257.553107985864;5261.3686357637325;4027.838886444509;4684.5549672781035;4782.713037217778;4822.228443449031;4824.035192961422;3932.292187406237;3944.36890097583;3987.202559488056;4056.513218413809;4062.451569038142;1278.7186818899827;1294.8834604885606;1305.0538359689149;1309.1490531154636;1330.5609148980814;984.3503287829998;988.8417853143462;998.006983051868;1001.6043662753171;1002.3735165521549;5632.04255276604;5726.570507211975;5763.942360576424;5786.421357864264;5978.342382337939;887.0597167002998;892.5403417239996;928.3687092776977;965.1844191658038;975.4391225045628;3753.793541355252;3887.941680874789;3986;3993.9201215975518;4217.578242175758;10169.491525423698;10431;10471.68584942453;10481.685549433529;10489.895101049044;10273.332233404804;10277.229207809443;10381.429021403896;10411.687649370531;10438.739031524121;7555.320021198008;7565.508241964255;7808.141104478616;7826.217378262242;7848.450608457353;5618.971905140448;5638.85902852432;5689.914651280317;5723.427657234243;5733.684647344436;9292.860607090764;9348.719538413858;9353.11145441182;9537.713868583953;9539.236861051239;9283.62865485373;9371.906280937375;9509.524523773922;9510.429374237568;9735.70792876215;6698.665066746546;7232.566046037255;7483.962580187064;7526.09686837583;7633.923660763321;8181.550014749246;8217.58912054383;8217.876731848908;8249.216324449168;8271.586420679063;7103.857922841617;7222.674979625825;7240.674169662483;7279.1265048194555;7339.70641174347;7216.314450127229;7237.397356845657;7275.272472752894;7424.70301187968;7506.662200200894;6879.380855723009;6910.619915904674;6920.204176519564;6947.513674042769;6987.6855541499735;4913.631477639263;4949.950500494949;5015.523525265094;5022.824201152942;5193.350831146106;4864.537868902448;4931.97534012342;4950.331705219894;5008.724520151281;5067.87330316745 07:53:36 INFO - PROCESS | 8998 | |4;prototype.html;328.55316769193894;330.17291684330746;335.4532112656369;340.87387666563376;343.02067597010534;6019.969900150499;6131.8773624527485;6152;6153.415425534578;6176.258848938128;6025.216721826157;6032.0951857221435;6039.4262545058145;6078.234403346478;6103.572749907508;4155.711729363907;4379.167958087961;4560.8403705870305;4609.861704148864;4631.93052104217;4622.1217968586025;4627.745473998929;4647.419072615923;4649.767511624422;4660.953390466086;4587.472440669332;4598.218302888517;4614;4618.452818305872;4630.536946305359;4528.320751887227;4606;4606.170889239936;4611.884702882421;4633.582977532004;4032.1129351542613;4033;4041.090754580225;4058.7361821481804;4068.247374235746;5783.479486846204;5820.476157145878;5822.737976791054;5845.298564172284;5860.7948721794955;5188.429272779991;5336.546393556552;5349.3045904032615;5362.651427657229;5364.91952620711;6307.873842523124;6363.490920726331;6365.649889256089;6376.234851817811;6401;4460.710053846489;4460.8884777880485;4468.352088947117;4478.39541661878;4481.865544033684;6226.816904788076;6273.6235825850135;6454.290028096859;6611.6033038017395;6620.470362370998;4451.643868490513;4452.421185245962;4460.687751857339;4461.665375096881;4486.654003798847;4504.572065653758;4521.186186486399;4523.231050721385;4531.456225252925;4538.29656403258;4981.078500477423;5241.528262456397;5259.684418934876;5278.498542638443;5283.233931079972;6368.808935731936;6372.8847451695765;6374.9800031994655;6375.776847810304;6387.201599800025;1540.537838648401;1570.434643528329;1572.771948067524;1575.94484193055;1576.9986058852712;983.1839573154408;1033.2095946600857;1033.8397548380012;1040.3029969920171;1051.148569658579;6082.118092876508;6116.938830611637;6130.1724267224245;6131.436483696718;6144.692765361714;6460.935390646034;6481.449076828522;6507.3167317431935;6521.413072823469;6541.084248205255;5926.436988486087;6219.315875253718;6230.470410015199;6270.561060725706;6282.842928926722;3556.893293201208;3574.91062723434;3575.4279315309427;3586.372384832644;3593.9460908085875;6726.159230096238;6787.287334829871;6818.590884546943;6830.658467076626;6884.139482564679;6692.765753198712;6770.255271920085;6783.59298442095;6789.388954994074;6796.626185559841;6738.528303018742;6818.011388348662;6871;6893.103896493424;6906.447484201251;6580.144581204413;6605.108310378229;6617.172853393326;6645.235797883305;6698.799036028927;6206.565540412128;6346.809595711951;6535.607863528204;6561.639109849004;6605.933940660532;6521.315261897433;6743.224529179207;6746.224184218878;6871.5189936703955;6926.238113807578;4415.227335216388;4450;4466.531014243457;4472.530384309731;4473.418455600751;6420.26166990802;6537.248216455168;6539.673016349258;6591.373819487141;6693.665316734241;6338.683065846782;6392.20097487814;6405.647689376942;6410.775622853178;6441.13044738973;6313.179286692701;6407.571949007259;6414.967925160345;6451.3226111257645;6463.965765477501;6252.562320637512;6295.905561416674;6344.195061518659;6344.238691357066;6364.809055728336;6202.937970620416;6383.234011918599;6413.518986076157;6469.5794773339585;6486.416222539994;6248.968755156195;6283.968580157253;6290.716917738804;6296.2759282681245;6340.112384266298 07:53:36 INFO - PROCESS | 8998 | |5;yui.html;755.9470837041406;857.7212405968062;866.69665617034;876.045110829196;880.3925291548835;14281.928590357047;14423.639409014766;14670.926645366771;14875.92562037191;14963.476278330261;11927.403629818518;13867.514636987707;14382.712345753078;14424.567262982127;14483.13101213928;795.1571334385541;848.9787755306136;849.3247867944967;851.4763420496381;851.9701810436636;823.8187598728271;833.6457005772522;834.7370578267856;837.1712005114923;838.0822998816317;871.7776966873438;873.5151990645189;877.5173654490037;879.6613303877989;880.4761167105562;874.6195404998814;874.654511467973;876.0407353947418;876.1720174435161;877.241186373782;627.0468887291291;636.045931103345;636.4144986612328;636.4844475974476;639.6865535887429;14639.487617933428;14699.265036748227;14724;14772.335244914004;14781.630459238497;14086;14195.85804141966;14240.145591264558;14377.353019114165;14431;11218.551257949672;11258.831117533244;11404;11491.827622585668;11523.827142592867;3859.8649047283493;3868.651821336065;3871.4386413970096;3880.3597406427907;3972.2651309507833;53719.73140134313;53863.192052119644;54136.729316353165;54542;54594;11160.832587511193;11384.772304553862;11431.314121152758;11450.198486105892;11640.126990475748;18246.45260642183;18280.725789113174;18318.908405458154;18335.449936501926;18372.724409133873;8527.957360213159;8602.913970860336;8685.131486851391;8750.212480876751;8852.513111778913;4797.64017698674;4810.2063159578975;4833.468318484964;4885.218365061573;4888.340074089952;3375.645557216457;3480.7215422766117;3482.7910325380053;3488.0407887830543;3488.6162522122545;639.2169592249458;642.5662677692538;651.0332156747227;651.5992664511291;655.4494224851148;659.0838734159522;704.2781149321986;776.5185584937262;779.5504890857931;812.455654711333;9836.458994755214;10238.283320167666;10441.895581044093;10544.367337959748;10617.575296988189;740.3226048165975;756.6973210715757;764.2319468933797;775.158952536493;786.9488483248571;4452.443444569429;4525.864224073283;4549.499555048942;4615.769211539409;4624.398828152319;61076.389236107956;61744;62113.68943155346;62616.37383626196;63087.684561577815;53366.7331663347;53712;54018.459815401344;54588.72705636526;55454.16818747722;47483.05033899302;48298.27552586714;49165;49284.75357623189;50721.49278507241;9186.356955013085;9337.346385752931;9390.906090939276;9543.76140596463;9577.616895324109;30216.69783302139;30491.695083048886;30858.228544286572;31022;31562.842185788923;34608.30783384368;34694.479582805776;34874;37023.629763703095;40208.798956005034;11315.547378105113;11545.942270288595;12174.817377739164;12282.692932676397;12549.247045177319;12668.493260269855;13026.218426894417;13256.07207495466;13635.250061246727;14019.158850469004;13065.673358166121;13084.542041028519;13111.672208194872;13564.660883477993;13574.457021719021;13015.674608134872;13015.739685206432;13075.41160647754;13203.471861125447;13317;12771;12810.67973300675;12984.610461686165;13065.608031759062;13531.188128712309;11108.166887483632;11375.089992800722;11464.31214127155;11506.94246528762;11705.88294117082;10701.732456688645;10764.677059688222;10773.676789696321;10803.945980270362;10844.783104337712 07:53:36 INFO - PROCESS | 8998 | __end_tp_report 07:53:36 INFO - PROCESS | 8998 | __start_cc_report 07:53:36 INFO - PROCESS | 8998 | _x_x_mozilla_cycle_collect,352 07:53:36 INFO - PROCESS | 8998 | __end_cc_report 07:53:36 INFO - PROCESS | 8998 | __startTimestamp1460645616079__endTimestamp 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | ------- Summary: start ------- 07:53:36 INFO - PROCESS | 8998 | Number of tests: 6 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | [#0] dojo.html Cycles:165 Average:5328.65 Median:5566.28 stddev:692.31 (12.4%) stddev-sans-first:671.63 07:53:36 INFO - PROCESS | 8998 | Values: 3082.6 3134.6 3160.7 3190.9 3191.2 5445.7 5456.1 5458.0 5467.0 5490.9 5235.1 5333.9 5433.9 5447.0 5454.3 4787.6 4866.2 4939.6 4944.2 4987.7 916.5 4774.4 4883.4 4894.6 4932.1 4922.0 4950.5 4968.7 4970.1 4999.1 4944.7 4955.0 4975.5 4995.3 5016.4 4774.7 4857.0 4918.8 4925.7 4933.1 5300.9 5313.2 5314.6 5327.6 5364.2 5750.4 5768.6 5771.9 5781.9 5827.4 5617.5 5670.1 5703.8 5714.2 5779.9 5440.6 5450.9 5465.4 5466.4 5477.0 5644.6 5908.4 5932.9 5945.7 5955.8 5501.4 5576.3 5579.8 5583.1 5614.9 5721.2 5733.6 5737.2 5743.8 5756.5 5548.9 5651.8 5725.9 5733.1 5736.4 5791.7 5805.3 5812.3 5832.3 5865.4 4380.5 4389.6 4405.6 4410.8 4419.8 3849.9 3917.7 3950.6 3971.5 4002.9 5235.7 5439.1 5532.3 5550.4 5574.7 5808.7 5864.2 5867.5 5867.6 5880.5 5206.9 5453.4 5519.9 5564.8 5570.5 4891.7 4902.0 4929.9 4937.1 4966.7 5908.4 5911.3 5912.4 5922.1 5988.1 5624.7 5768.5 5792.0 5866.7 5872.9 5952.6 5982.8 5983.5 5987.1 5988.8 5704.7 5709.2 5710.0 5712.0 5723.6 5662.1 5725.9 5734.8 5754.5 5809.2 5474.8 5565.4 5566.3 5568.0 5590.6 5441.8 5499.9 5566.2 5567.8 5570.9 5584.0 5618.2 5629.8 5635.9 5671.8 5609.8 5653.2 5655.3 5683.7 5704.9 5420.9 5495.5 5560.0 5572.1 5590.6 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | [#1] ext.html Cycles:180 Average:50278.55 Median:393222.00 stddev:90278.95 (23.0%) stddev-sans-first:90455.16 07:53:36 INFO - PROCESS | 8998 | Values: 601.4 648.5 649.1 657.9 671.2 29145.7 38875.8 39653.0 39797.8 40000.8 41941.2 42308.6 42694.4 42788.8 42839.1 8579.9 8845.1 8848.0 8854.5 8859.6 8742.0 8836.5 8863.6 8868.0 8881.6 8866.5 8928.3 8940.4 8957.3 9135.1 9025.4 9025.4 9043.0 9047.5 9082.6 8948.8 8962.8 9015.7 9021.3 9022.1 42475.4 42910.8 43013.6 43347.6 43358.3 3413.2 3427.6 3470.1 3641.8 4373.1 31494.8 32034.8 32153.5 32653.2 33013.5 4065.1 4081.2 4137.1 4137.9 4148.4 280278.0 284484.0 285377.0 285694.0 286048.0 35828.5 36795.8 59212.1 60263.0 60274.1 34852.0 35046.6 35221.0 35236.8 35259.5 15031.5 15048.2 15136.5 15265.5 15276.2 12487.3 12491.9 12590.2 12596.5 12679.2 8482.4 8541.2 8575.0 8582.3 8595.0 3357.1 3376.8 3376.8 3391.9 3407.1 1058.0 1066.6 1148.7 1169.7 1239.7 32111.2 32299.8 32309.7 32431.2 32681.2 1097.1 1152.6 1245.8 1249.1 1305.8 15065.9 15314.3 15553.5 15847.8 16059.4 341193.0 345790.0 346881.0 347619.0 347621.0 53530.0 54501.5 54709.5 54792.7 59115.7 1313.2 1361.2 1380.2 1389.8 1455.9 29924.4 30114.9 30236.5 30731.7 31124.2 47910.0 48351.0 48378.0 48567.5 48583.1 388921.0 390069.0 391421.0 392249.0 394195.0 28849.3 29331.0 44159.0 45498.0 45961.5 43062.4 43111.0 43886.6 43960.8 44318.6 38347.2 39503.4 40349.6 40977.2 42175.8 38816.4 40017.0 40046.9 40881.4 41076.4 41051.0 41496.2 43010.6 44260.6 44604.8 32786.0 33772.8 33927.5 35815.5 36602.3 28303.3 28789.6 28825.0 28865.9 28877.9 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | [#2] jquery.html Cycles:180 Average:25720.70 Median:22059.11 stddev:67990.73 (308.2%) stddev-sans-first:68154.87 07:53:36 INFO - PROCESS | 8998 | Values: 394.3 400.3 401.0 405.5 408.2 13414.9 17973.9 18502.6 19458.1 19504.9 17617.2 18099.8 18466.4 18528.4 18551.7 5210.9 5522.9 5584.5 5829.0 5863.9 5354.2 5416.1 5423.4 5426.7 5429.6 5249.0 5610.5 5618.3 5626.2 5634.5 5430.4 5479.7 6148.1 6323.7 6334.7 5518.2 5544.5 5575.0 5587.9 5613.7 17590.8 21082.2 21759.1 22004.8 22113.4 2154.7 2198.0 2286.1 2407.7 2416.8 10028.5 10976.3 12945.5 14149.8 14300.2 1905.3 1910.5 1980.9 1991.7 1995.4 70588.3 71948.3 72652.0 72944.0 74131.6 9976.9 10244.6 10493.8 10618.9 10732.5 14725.9 14774.8 14784.4 14834.7 14860.9 7815.2 7858.5 7957.2 7982.0 8029.3 7547.3 7651.1 7704.4 7726.8 7760.1 4466.4 4617.5 4640.5 4667.0 4729.5 1905.8 1922.0 1972.7 1985.2 1989.7 903.5 978.1 1014.6 1063.5 1106.6 17576.0 17685.1 17778.9 18372.3 18523.4 992.6 1046.3 1054.2 1073.1 1089.7 10142.9 10388.9 10430.8 10462.0 10526.2 341772.0 347931.0 348675.0 489491.0 494345.0 84757.6 90282.5 91546.0 91962.5 92788.0 1069.9 1071.4 1075.1 1109.2 1115.2 16304.6 16683.0 16747.7 16912.9 17080.4 33954.3 35779.0 36931.6 38394.6 39266.4 43555.8 46382.3 50872.2 52167.2 52282.2 7332.8 8351.6 8534.3 8723.8 8741.5 7562.2 11068.9 12069.7 13220.0 13632.7 11699.5 11909.4 11956.2 11958.9 12028.1 11549.0 11594.8 11693.8 11778.8 11867.6 11899.4 11964.5 12044.5 12094.8 12104.5 7848.6 7916.7 7984.1 8061.7 8135.2 11355.7 11493.8 11513.7 11773.2 11827.9 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | [#3] mootools.html Cycles:180 Average:5577.59 Median:5012.12 stddev:3089.27 (61.6%) stddev-sans-first:3081.22 07:53:36 INFO - PROCESS | 8998 | Values: 1300.8 1412.3 1450.8 1799.1 1848.6 7374.7 8018.9 8291.0 8322.2 8363.9 8359.7 8360.2 8375.5 8437.2 8440.8 2309.0 2316.4 2337.0 2346.9 2352.4 2284.7 2295.6 2315.6 2325.5 2330.3 2310.6 2319.7 2326.4 2347.3 2349.6 2251.3 2271.5 2275.0 2278.1 2292.4 2191.7 2194.7 2197.0 2198.7 2202.2 8430.6 8458.8 8470.9 8478.2 8494.6 5031.9 5189.8 5190.3 5194.3 5205.4 3253.5 3342.1 3427.2 3448.7 3468.4 1085.1 1095.6 1099.6 1113.5 1116.9 11522.5 11579.2 11637.0 11682.1 11711.4 4516.5 4530.5 4673.9 4688.2 4689.3 9943.1 9967.3 10049.9 10051.1 10077.5 5232.6 5238.1 5252.2 5257.6 5261.4 4027.8 4684.6 4782.7 4822.2 4824.0 3932.3 3944.4 3987.2 4056.5 4062.5 1278.7 1294.9 1305.1 1309.1 1330.6 984.4 988.8 998.0 1001.6 1002.4 5632.0 5726.6 5763.9 5786.4 5978.3 887.1 892.5 928.4 965.2 975.4 3753.8 3887.9 3986.0 3993.9 4217.6 10169.5 10431.0 10471.7 10481.7 10489.9 10273.3 10277.2 10381.4 10411.7 10438.7 7555.3 7565.5 7808.1 7826.2 7848.5 5619.0 5638.9 5689.9 5723.4 5733.7 9292.9 9348.7 9353.1 9537.7 9539.2 9283.6 9371.9 9509.5 9510.4 9735.7 6698.7 7232.6 7484.0 7526.1 7633.9 8181.6 8217.6 8217.9 8249.2 8271.6 7103.9 7222.7 7240.7 7279.1 7339.7 7216.3 7237.4 7275.3 7424.7 7506.7 6879.4 6910.6 6920.2 6947.5 6987.7 4913.6 4950.0 5015.5 5022.8 5193.4 4864.5 4932.0 4950.3 5008.7 5067.9 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | [#4] prototype.html Cycles:180 Average:5331.63 Median:6138.29 stddev:1617.08 (26.3%) stddev-sans-first:1577.41 07:53:36 INFO - PROCESS | 8998 | Values: 328.6 330.2 335.5 340.9 343.0 6020.0 6131.9 6152.0 6153.4 6176.3 6025.2 6032.1 6039.4 6078.2 6103.6 4155.7 4379.2 4560.8 4609.9 4631.9 4622.1 4627.7 4647.4 4649.8 4661.0 4587.5 4598.2 4614.0 4618.5 4630.5 4528.3 4606.0 4606.2 4611.9 4633.6 4032.1 4033.0 4041.1 4058.7 4068.2 5783.5 5820.5 5822.7 5845.3 5860.8 5188.4 5336.5 5349.3 5362.7 5364.9 6307.9 6363.5 6365.6 6376.2 6401.0 4460.7 4460.9 4468.4 4478.4 4481.9 6226.8 6273.6 6454.3 6611.6 6620.5 4451.6 4452.4 4460.7 4461.7 4486.7 4504.6 4521.2 4523.2 4531.5 4538.3 4981.1 5241.5 5259.7 5278.5 5283.2 6368.8 6372.9 6375.0 6375.8 6387.2 1540.5 1570.4 1572.8 1575.9 1577.0 983.2 1033.2 1033.8 1040.3 1051.1 6082.1 6116.9 6130.2 6131.4 6144.7 6460.9 6481.4 6507.3 6521.4 6541.1 5926.4 6219.3 6230.5 6270.6 6282.8 3556.9 3574.9 3575.4 3586.4 3593.9 6726.2 6787.3 6818.6 6830.7 6884.1 6692.8 6770.3 6783.6 6789.4 6796.6 6738.5 6818.0 6871.0 6893.1 6906.4 6580.1 6605.1 6617.2 6645.2 6698.8 6206.6 6346.8 6535.6 6561.6 6605.9 6521.3 6743.2 6746.2 6871.5 6926.2 4415.2 4450.0 4466.5 4472.5 4473.4 6420.3 6537.2 6539.7 6591.4 6693.7 6338.7 6392.2 6405.6 6410.8 6441.1 6313.2 6407.6 6415.0 6451.3 6464.0 6252.6 6295.9 6344.2 6344.2 6364.8 6202.9 6383.2 6413.5 6469.6 6486.4 6249.0 6284.0 6290.7 6296.3 6340.1 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - PROCESS | 8998 | [#5] yui.html Cycles:180 Average:14565.81 Median:3875.90 stddev:16399.02 (423.1%) stddev-sans-first:16412.23 07:53:36 INFO - PROCESS | 8998 | Values: 755.9 857.7 866.7 876.0 880.4 14281.9 14423.6 14670.9 14875.9 14963.5 11927.4 13867.5 14382.7 14424.6 14483.1 795.2 849.0 849.3 851.5 852.0 823.8 833.6 834.7 837.2 838.1 871.8 873.5 877.5 879.7 880.5 874.6 874.7 876.0 876.2 877.2 627.0 636.0 636.4 636.5 639.7 14639.5 14699.3 14724.0 14772.3 14781.6 14086.0 14195.9 14240.1 14377.4 14431.0 11218.6 11258.8 11404.0 11491.8 11523.8 3859.9 3868.7 3871.4 3880.4 3972.3 53719.7 53863.2 54136.7 54542.0 54594.0 11160.8 11384.8 11431.3 11450.2 11640.1 18246.5 18280.7 18318.9 18335.4 18372.7 8528.0 8602.9 8685.1 8750.2 8852.5 4797.6 4810.2 4833.5 4885.2 4888.3 3375.6 3480.7 3482.8 3488.0 3488.6 639.2 642.6 651.0 651.6 655.4 659.1 704.3 776.5 779.6 812.5 9836.5 10238.3 10441.9 10544.4 10617.6 740.3 756.7 764.2 775.2 786.9 4452.4 4525.9 4549.5 4615.8 4624.4 61076.4 61744.0 62113.7 62616.4 63087.7 53366.7 53712.0 54018.5 54588.7 55454.2 47483.1 48298.3 49165.0 49284.8 50721.5 9186.4 9337.3 9390.9 9543.8 9577.6 30216.7 30491.7 30858.2 31022.0 31562.8 34608.3 34694.5 34874.0 37023.6 40208.8 11315.5 11545.9 12174.8 12282.7 12549.2 12668.5 13026.2 13256.1 13635.3 14019.2 13065.7 13084.5 13111.7 13564.7 13574.5 13015.7 13015.7 13075.4 13203.5 13317.0 12771.0 12810.7 12984.6 13065.6 13531.2 11108.2 11375.1 11464.3 11506.9 11705.9 10701.7 10764.7 10773.7 10803.9 10844.8 07:53:36 INFO - PROCESS | 8998 | -------- Summary: end -------- 07:53:36 INFO - PROCESS | 8998 | 07:53:36 INFO - TEST-INFO | 8998: exit 0 07:53:36 INFO - TEST-OK | dromaeo_css | took 1109514ms 07:53:36 INFO - TEST-START | kraken 07:53:36 INFO - operating with platform_type : linux_ 07:53:36 INFO - Initialising browser for kraken test... 07:53:36 INFO - TEST-INFO | started process 9232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfLc1mi/profile http://localhost:35330/getInfo.html) 07:53:40 INFO - PROCESS | 9232 | 07:53:40 INFO - PROCESS | 9232 | (process:9303): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:53:40 INFO - PROCESS | 9232 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:53:41 INFO - PROCESS | 9232 | __metrics Screen width/height:1600/1200 07:53:41 INFO - PROCESS | 9232 | colorDepth:24 07:53:41 INFO - PROCESS | 9232 | Browser inner width/height: 1024/697 07:53:41 INFO - PROCESS | 9232 | __metrics 07:53:42 ERROR - PROCESS | 9232 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:53:42 INFO - TEST-INFO | 9232: exit 0 07:53:42 INFO - Browser initialized. 07:53:42 INFO - Running cycle 1/1 for kraken test... 07:53:42 INFO - TEST-INFO | started process 9356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfLc1mi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:44 INFO - PROCESS | 9356 | 07:53:44 INFO - PROCESS | 9356 | (process:9416): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:53:54 INFO - PROCESS | 9356 | RSS: Main: 163442688 07:53:54 INFO - PROCESS | 9356 | 07:53:57 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35330/tests/kraken/driver.html?testName=audio-beat-detection) 07:53:58 INFO - PROCESS | 9356 | RSS: Main: 167477248 07:53:58 INFO - PROCESS | 9356 | 07:54:00 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35330/tests/kraken/driver.html?testName=audio-dft) 07:54:01 INFO - PROCESS | 9356 | RSS: Main: 170893312 07:54:01 INFO - PROCESS | 9356 | 07:54:04 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35330/tests/kraken/driver.html?testName=audio-fft) 07:54:04 INFO - PROCESS | 9356 | RSS: Main: 162881536 07:54:04 INFO - PROCESS | 9356 | 07:54:07 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35330/tests/kraken/driver.html?testName=audio-oscillator) 07:54:07 INFO - PROCESS | 9356 | RSS: Main: 163524608 07:54:07 INFO - PROCESS | 9356 | 07:54:09 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:10 INFO - PROCESS | 9356 | RSS: Main: 164020224 07:54:10 INFO - PROCESS | 9356 | 07:54:13 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35330/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:14 INFO - PROCESS | 9356 | RSS: Main: 164831232 07:54:14 INFO - PROCESS | 9356 | 07:54:17 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35330/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:18 INFO - PROCESS | 9356 | RSS: Main: 163975168 07:54:18 INFO - PROCESS | 9356 | 07:54:21 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35330/tests/kraken/driver.html?testName=json-parse-financial) 07:54:21 INFO - PROCESS | 9356 | RSS: Main: 164945920 07:54:21 INFO - PROCESS | 9356 | 07:54:23 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:23 INFO - PROCESS | 9356 | RSS: Main: 164958208 07:54:23 INFO - PROCESS | 9356 | 07:54:25 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:26 INFO - PROCESS | 9356 | RSS: Main: 164777984 07:54:26 INFO - PROCESS | 9356 | 07:54:28 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:29 INFO - PROCESS | 9356 | RSS: Main: 165093376 07:54:29 INFO - PROCESS | 9356 | 07:54:31 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:32 INFO - PROCESS | 9356 | RSS: Main: 165617664 07:54:32 INFO - PROCESS | 9356 | 07:54:35 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:35 INFO - PROCESS | 9356 | RSS: Main: 165588992 07:54:35 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | Cycle 1(1): loaded http://localhost:35330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35330/tests/kraken/driver.html?testName=ai-astar) 07:54:37 INFO - PROCESS | 9356 | RSS: Main: 167141376 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | __start_tp_report 07:54:37 INFO - PROCESS | 9356 | _x_x_mozilla_page_load 07:54:37 INFO - PROCESS | 9356 | _x_x_mozilla_page_load_details 07:54:37 INFO - PROCESS | 9356 | |i|pagename|runs| 07:54:37 INFO - PROCESS | 9356 | |0;ai-astar;111;106;112;111;114;122;111;114;112;112 07:54:37 INFO - PROCESS | 9356 | |1;audio-beat-detection;162;128;157;179;130;156;154;132;182;130 07:54:37 INFO - PROCESS | 9356 | |2;audio-dft;164;165;162;163;162;164;175;163;166;166 07:54:37 INFO - PROCESS | 9356 | |3;audio-fft;77;77;75;163;73;74;73;78;158;77 07:54:37 INFO - PROCESS | 9356 | |4;audio-oscillator;94;93;152;94;93;93;143;95;94;155 07:54:37 INFO - PROCESS | 9356 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 07:54:37 INFO - PROCESS | 9356 | |6;imaging-darkroom;147;146;146;146;146;148;147;147;147;147 07:54:37 INFO - PROCESS | 9356 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 07:54:37 INFO - PROCESS | 9356 | |8;json-parse-financial;61;59;70;60;69;65;63;75;62;57 07:54:37 INFO - PROCESS | 9356 | |9;json-stringify-tinderbox;61;61;62;62;61;62;62;62;61;63 07:54:37 INFO - PROCESS | 9356 | |10;stanford-crypto-aes;81;80;81;83;89;83;80;84;82;83 07:54:37 INFO - PROCESS | 9356 | |11;stanford-crypto-ccm;136;131;133;130;136;132;131;135;179;143 07:54:37 INFO - PROCESS | 9356 | |12;stanford-crypto-pbkdf2;164;166;164;168;173;167;173;171;164;163 07:54:37 INFO - PROCESS | 9356 | |13;stanford-crypto-sha256-iterative;72;70;69;69;68;69;69;72;70;71 07:54:37 INFO - PROCESS | 9356 | __end_tp_report 07:54:37 INFO - PROCESS | 9356 | __start_cc_report 07:54:37 INFO - PROCESS | 9356 | _x_x_mozilla_cycle_collect,835 07:54:37 INFO - PROCESS | 9356 | __end_cc_report 07:54:37 INFO - PROCESS | 9356 | __startTimestamp1460645677764__endTimestamp 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | ------- Summary: start ------- 07:54:37 INFO - PROCESS | 9356 | Number of tests: 14 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.01 (3.6%) stddev-sans-first:4.21 07:54:37 INFO - PROCESS | 9356 | Values: 111.0 106.0 112.0 111.0 114.0 122.0 111.0 114.0 112.0 112.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:156.50 stddev:20.30 (13.0%) stddev-sans-first:21.14 07:54:37 INFO - PROCESS | 9356 | Values: 162.0 128.0 157.0 179.0 130.0 156.0 154.0 132.0 182.0 130.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.80 (2.3%) stddev-sans-first:4.01 07:54:37 INFO - PROCESS | 9356 | Values: 164.0 165.0 162.0 163.0 162.0 164.0 175.0 163.0 166.0 166.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:35.90 (47.2%) stddev-sans-first:37.64 07:54:37 INFO - PROCESS | 9356 | Values: 77.0 77.0 75.0 163.0 73.0 74.0 73.0 78.0 158.0 77.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:93.50 stddev:27.35 (29.3%) stddev-sans-first:28.35 07:54:37 INFO - PROCESS | 9356 | Values: 94.0 93.0 152.0 94.0 93.0 93.0 143.0 95.0 94.0 155.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:54:37 INFO - PROCESS | 9356 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:54:37 INFO - PROCESS | 9356 | Values: 147.0 146.0 146.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:54:37 INFO - PROCESS | 9356 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:5.65 (8.8%) stddev-sans-first:5.88 07:54:37 INFO - PROCESS | 9356 | Values: 61.0 59.0 70.0 60.0 69.0 65.0 63.0 75.0 62.0 57.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 07:54:37 INFO - PROCESS | 9356 | Values: 61.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 61.0 63.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:2.63 (3.2%) stddev-sans-first:2.73 07:54:37 INFO - PROCESS | 9356 | Values: 81.0 80.0 81.0 83.0 89.0 83.0 80.0 84.0 82.0 83.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:135.50 stddev:14.69 (10.8%) stddev-sans-first:15.55 07:54:37 INFO - PROCESS | 9356 | Values: 136.0 131.0 133.0 130.0 136.0 132.0 131.0 135.0 179.0 143.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.50 stddev:3.83 (2.3%) stddev-sans-first:3.87 07:54:37 INFO - PROCESS | 9356 | Values: 164.0 166.0 164.0 168.0 173.0 167.0 173.0 171.0 164.0 163.0 07:54:37 INFO - PROCESS | 9356 | 07:54:37 INFO - PROCESS | 9356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.22 07:54:37 INFO - PROCESS | 9356 | Values: 72.0 70.0 69.0 69.0 68.0 69.0 69.0 72.0 70.0 71.0 07:54:37 INFO - PROCESS | 9356 | -------- Summary: end -------- 07:54:37 INFO - PROCESS | 9356 | 07:54:38 INFO - TEST-INFO | 9356: exit 0 07:54:38 INFO - TEST-OK | kraken | took 61950ms 07:54:38 INFO - SUITE-END | took 1171s 07:54:38 INFO - Completed test suite (00:19:31) 07:54:38 INFO - javascript benchmark 07:54:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.614673165854, 3134.623845138584, 3160.683931606839, 3190.872365105396, 3191.1702957231114, 5445.673259604427, 5456.099743542316, 5457.972710136453, 5467.0, 5490.945090549093, 5235.083860324447, 5333.893322133555, 5433.891322173554, 5446.972765136169, 5454.34547854257, 4787.6169906407495, 4866.245731911559, 4939.58013568847, 4944.233643785219, 4987.700737955716, 916.4559502542014, 4774.355462012636, 4883.365162528867, 4894.5594896459315, 4932.062908047477, 4922.0, 4950.529699678525, 4968.677035992649, 4970.055689419017, 4999.075171093359, 4944.703317800908, 4954.975225123887, 4975.477574854661, 4995.275685025651, 5016.372953380827, 4774.665773395864, 4856.975715121437, 4918.8278410255825, 4925.729084900365, 4933.136701077297, 5300.939812037569, 5313.1764576490705, 5314.601404894648, 5327.573794096502, 5364.222187782789, 5750.424957504258, 5768.625039372428, 5771.88456230873, 5781.913271300934, 5827.446392592739, 5617.522510586605, 5670.149477578355, 5703.828885133453, 5714.228579141804, 5779.9422005779825, 5440.591955603346, 5450.890982180374, 5465.398806131322, 5466.398696143381, 5477.0, 5644.57665675076, 5908.350081491032, 5932.881342373128, 5945.732442040118, 5955.821325360246, 5501.394846566875, 5576.275084239023, 5579.804706835242, 5583.106702927512, 5614.9157762633595, 5721.170430287668, 5733.569982251348, 5737.225474560964, 5743.770249190069, 5756.453136951983, 5548.86127846799, 5651.773929042874, 5725.885482290331, 5733.082706766897, 5736.368999410061, 5791.652500849962, 5805.274340707411, 5812.3025236971835, 5832.300123985149, 5865.35481097079, 4380.518143004267, 4389.626881715026, 4405.625521830616, 4410.757408342572, 4419.845305414295, 3849.8845034649007, 3917.745346552465, 3950.5654378018394, 3971.5035620547433, 4002.939955900664, 5235.712035838065, 5439.075357189287, 5532.30846144232, 5550.361708403585, 5574.721263936787, 5808.651480911159, 5864.237649105589, 5867.501262392744, 5867.589268751147, 5880.529557635379, 5206.895862082737, 5453.400125986138, 5519.944800551943, 5564.8052318169475, 5570.5265052470995, 4891.682040667345, 4902.0, 4929.87675308113, 4937.136001199848, 4966.6771659842, 5908.438698323653, 5911.290645122527, 5912.408759124053, 5922.052471604608, 5988.101784732325, 5624.690642014565, 5768.538516918637, 5791.971040144772, 5866.67733274674, 5872.941270587239, 5952.642841429528, 5982.790602328898, 5983.491403230774, 5987.131865879336, 5988.790392336247, 5704.714764261687, 5709.200711900255, 5710.0, 5712.0, 5723.5707321950185, 5662.122371032497, 5725.914111288417, 5734.799282025276, 5754.53963682896, 5809.24479817621, 5474.835754927359, 5565.38780734127, 5566.276384070045, 5567.972160139173, 5590.608657394106, 5441.809536666197, 5499.9175012375645, 5566.165075238747, 5567.832965011056, 5570.888582228414, 5583.972080139736, 5618.157276408571, 5629.7748090077575, 5635.915461268166, 5671.773129074791, 5609.80365687199, 5653.236813030188, 5655.321361436654, 5683.71581420919, 5704.885902282014, 5420.918686219631, 5495.505404513613, 5560.026995275892, 5572.0527510324155, 5590.580706446952], "value": 5284.22896286868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.3775742106917, 648.500654496038, 649.0685865782599, 657.8717150155719, 671.2079745899839, 29145.708542914563, 38875.80562097189, 39653.0, 39797.8010109949, 40000.79999599998, 41941.16117677645, 42308.57691423092, 42694.35958460625, 42788.78605606975, 42839.143217135635, 8579.914200857975, 8845.115488451167, 8848.0, 8854.513001784899, 8859.557022148867, 8741.956290218572, 8836.513991730451, 8863.645454181857, 8867.955660221722, 8881.600327985256, 8866.512341821197, 8928.330375221853, 8940.374173807835, 8957.283417326631, 9135.086491350845, 9025.368224224274, 9025.413348132382, 9042.954785226064, 9047.502387368691, 9082.591283392198, 8948.776280592972, 8962.82074358509, 9015.729528114167, 9021.278297736231, 9022.14289642483, 42475.36286955698, 42910.785446072885, 43013.56986430127, 43347.56652433467, 43358.349624755654, 3413.2149605590603, 3427.5544179256785, 3470.132466883279, 3641.7814931103953, 4373.147236288925, 31494.842525787226, 32034.839825800722, 32153.51769723456, 32653.18367040843, 33013.50479742806, 4065.056795615209, 4081.2041651877894, 4137.089840235143, 4137.931034482759, 4148.419221309019, 280278.0, 284484.0, 285377.0, 285694.0, 286048.0, 35828.46257306143, 36795.81602091972, 59212.11181832276, 60263.0, 60274.09588856171, 34852.0, 35046.64953350434, 35221.0, 35236.82381588127, 35259.4711079334, 15031.473898413504, 15048.247587620575, 15136.54590362291, 15265.465708700141, 15276.15981121049, 12487.31319777421, 12491.87508124907, 12590.181638193488, 12596.496140154475, 12679.175853569488, 8482.406231563731, 8541.188587084218, 8575.0, 8582.313414926915, 8595.0, 3357.093584732109, 3376.7636265461183, 3376.7973921564785, 3391.9491207631904, 3407.1311815486893, 1057.957681692739, 1066.6373433032652, 1148.6898537394857, 1169.7075731067234, 1239.6714870559308, 32111.197220069684, 32299.838500807346, 32309.67690323114, 32431.189220269684, 32681.18297042593, 1097.1113398147527, 1152.6081132414852, 1245.8380410546752, 1249.056961993689, 1305.8041293806004, 15065.924670376578, 15314.310856011507, 15553.533393998197, 15847.841521584867, 16059.437919672755, 341193.0, 345790.0, 346881.0, 347619.0, 347621.0, 53530.0, 54501.45498545043, 54709.45290547043, 54792.72603636956, 59115.70442147762, 1313.2317594207304, 1361.162884825825, 1380.2201756007823, 1389.8471168171493, 1455.9490417835325, 29924.401511970074, 30114.88196139442, 30236.546451802802, 30731.692683072884, 31124.22189445282, 47910.0, 48351.0, 48378.0, 48567.514324856296, 48583.05667773391, 388921.0, 390069.0, 391421.0, 392249.0, 394195.0, 28849.278768030967, 29331.0, 44159.0, 45498.0, 45961.540384595726, 43062.35406468968, 43111.0, 43886.56113438825, 43960.780196098814, 44318.55681443273, 38347.2330553393, 39503.407448887716, 40349.596504035755, 40977.1804563913, 42175.7891210542, 38816.417753734284, 40017.0, 40046.8792858385, 40881.38677919774, 41076.383854242806, 41051.0, 41496.17007659769, 43010.56989430066, 44260.55739442565, 44604.77697611491, 32786.0, 33772.831135844164, 33927.491087633214, 35815.46276805902, 36602.26795464129, 28303.29241768972, 28789.56815647725, 28825.0, 28865.85567072151, 28877.855610721814], "value": 18504.712071135546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.32570304778847, 400.3414383339406, 400.9518857737068, 405.50933370621544, 408.19992814084395, 13414.932925335384, 17973.910130449363, 18502.629947401045, 19458.1243844027, 19504.9024754876, 17617.207225674843, 18099.819001809978, 18466.353677621286, 18528.351507697233, 18551.721724174113, 5210.869728256805, 5522.944770552303, 5584.497395234418, 5829.038208695561, 5863.941360586382, 5354.196870469441, 5416.079266524681, 5423.403425623178, 5426.701531415771, 5429.619926605139, 5248.973755131219, 5610.495055445009, 5618.297712785902, 5626.156076588524, 5634.464725851038, 5430.3755068167075, 5479.671219726829, 6148.077788331741, 6323.6521991290465, 6334.651594162319, 5518.172274158868, 5544.473275038865, 5575.0, 5587.8882422351735, 5613.691246981414, 17590.82409175905, 21082.156713731434, 21759.129634814588, 22004.77995220043, 22113.447163821034, 2154.709114269569, 2198.043850924853, 2286.119843860126, 2407.6749638798715, 2416.846373239794, 10028.548715307828, 10976.286541374786, 12945.54690585825, 14149.787753183711, 14300.213488258141, 1905.3236101184157, 1910.4650697804636, 1980.9009549522466, 1991.6912878503856, 1995.4213278149318, 70588.2941170592, 71948.2805171952, 72652.0, 72944.0, 74131.62934185294, 9976.902540720515, 10244.59021639141, 10493.790124197474, 10618.885017073251, 10732.497450356956, 14725.926370368294, 14774.778378324334, 14784.408623654934, 14834.703305933821, 14860.92569537167, 7815.218478152253, 7858.528488290721, 7957.204279572113, 7982.002249718786, 8029.317508011768, 7547.28300811422, 7651.120121186135, 7704.422168337285, 7726.7681969541, 7760.107587627383, 4466.3747075409465, 4617.538246175355, 4640.484466976738, 4666.976665116721, 4729.527047295243, 1905.8380037696952, 1921.953119927273, 1972.6547854125758, 1985.1563085688524, 1989.7413336266193, 903.4895284164558, 978.1490103609905, 1014.5789497358661, 1063.4576366053368, 1106.5794997900746, 17576.0, 17685.094248381043, 17778.911105444648, 18372.265109395474, 18523.44429667112, 992.6079198716467, 1046.2728403759313, 1054.235679132638, 1073.0771536478621, 1089.6730980705756, 10142.949285253526, 10388.948055259676, 10430.791384172426, 10462.0, 10526.210534209966, 341772.0, 347931.0, 348675.0, 489491.0, 494345.0, 84757.57621211854, 90282.54858725665, 91546.0, 91962.54018729864, 92788.0, 1069.8609180806445, 1071.3946620159586, 1075.070064394309, 1109.162582250412, 1115.2082021764477, 16304.592385190464, 16683.0, 16747.665046699243, 16912.915435422743, 17080.402185923434, 33954.3209135811, 35779.0, 36931.6306836939, 38394.616053839105, 39266.41100383439, 43555.782221088695, 46382.304265436724, 50872.236916445545, 52167.21749173841, 52282.21576676429, 7332.816679583053, 8351.624176911931, 8534.274586659954, 8723.78190545216, 8741.519216443157, 7562.168161502121, 11068.896909587153, 12069.698257543632, 13220.008499362393, 13632.727345453233, 11699.473523691284, 11909.40452977365, 11956.222845515014, 11958.940205298917, 12028.09789265791, 11549.0, 11594.826077609012, 11693.824592631288, 11778.76442471163, 11867.58463453775, 11899.405029748652, 11964.521419143484, 12044.457999389873, 12094.758104837678, 12104.51581936748, 7848.568328741974, 7916.722914697958, 7984.121746607752, 8061.717839875576, 8135.186481352054, 11355.716107097058, 11493.770124597628, 11513.712157196138, 11773.17587768848, 11827.881721182677], "value": 8953.503182861126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.765862144814, 1412.3291436567629, 1450.8404075551693, 1799.118431968336, 1848.5840685845678, 7374.668139933702, 8018.879716804246, 8290.958545207266, 8322.209390107937, 8363.874541881876, 8359.707410240642, 8360.163983601637, 8375.455595386296, 8437.240648341663, 8440.788980275496, 2308.9769102309015, 2316.3514216019544, 2337.030132495021, 2346.85918844869, 2352.4001379648166, 2284.7029886114783, 2295.6441751528455, 2315.571619250444, 2325.476767727265, 2330.347502699247, 2310.560993411255, 2319.7100362454694, 2326.360250930991, 2347.272345572878, 2349.565330413879, 2251.324602619208, 2271.5229801741652, 2275.0, 2278.1456953642382, 2292.4039749665126, 2191.671249312616, 2194.7366316042016, 2197.033305345659, 2198.7251593550805, 2202.196198387593, 8430.578471076422, 8458.830823383498, 8470.915290847135, 8478.152184781535, 8494.575271236414, 5031.924521132186, 5189.844304670828, 5190.2993095932325, 5194.298769666085, 5205.427402985669, 3253.4957081652383, 3342.131045928076, 3427.234973988398, 3448.7241020718534, 3468.4103702370658, 1085.0614218700766, 1095.6220104064084, 1099.648112603967, 1113.5323164270944, 1116.8998536441597, 11522.539098436053, 11579.189456738031, 11637.010854077414, 11682.065434765198, 11711.414429278502, 4516.548345165523, 4530.478994915627, 4673.929891051637, 4688.226442636995, 4689.320048592935, 9943.105120539187, 9967.302288839712, 10049.949750251202, 10051.145652619463, 10077.546510406903, 5232.581393488512, 5238.135707608202, 5252.2384254282915, 5257.553107985864, 5261.3686357637325, 4027.838886444509, 4684.5549672781035, 4782.713037217778, 4822.228443449031, 4824.035192961422, 3932.292187406237, 3944.36890097583, 3987.202559488056, 4056.513218413809, 4062.451569038142, 1278.7186818899827, 1294.8834604885606, 1305.0538359689149, 1309.1490531154636, 1330.5609148980814, 984.3503287829998, 988.8417853143462, 998.006983051868, 1001.6043662753171, 1002.3735165521549, 5632.04255276604, 5726.570507211975, 5763.942360576424, 5786.421357864264, 5978.342382337939, 887.0597167002998, 892.5403417239996, 928.3687092776977, 965.1844191658038, 975.4391225045628, 3753.793541355252, 3887.941680874789, 3986.0, 3993.9201215975518, 4217.578242175758, 10169.491525423698, 10431.0, 10471.68584942453, 10481.685549433529, 10489.895101049044, 10273.332233404804, 10277.229207809443, 10381.429021403896, 10411.687649370531, 10438.739031524121, 7555.320021198008, 7565.508241964255, 7808.141104478616, 7826.217378262242, 7848.450608457353, 5618.971905140448, 5638.85902852432, 5689.914651280317, 5723.427657234243, 5733.684647344436, 9292.860607090764, 9348.719538413858, 9353.11145441182, 9537.713868583953, 9539.236861051239, 9283.62865485373, 9371.906280937375, 9509.524523773922, 9510.429374237568, 9735.70792876215, 6698.665066746546, 7232.566046037255, 7483.962580187064, 7526.09686837583, 7633.923660763321, 8181.550014749246, 8217.58912054383, 8217.876731848908, 8249.216324449168, 8271.586420679063, 7103.857922841617, 7222.674979625825, 7240.674169662483, 7279.1265048194555, 7339.70641174347, 7216.314450127229, 7237.397356845657, 7275.272472752894, 7424.70301187968, 7506.662200200894, 6879.380855723009, 6910.619915904674, 6920.204176519564, 6947.513674042769, 6987.6855541499735, 4913.631477639263, 4949.950500494949, 5015.523525265094, 5022.824201152942, 5193.350831146106, 4864.537868902448, 4931.97534012342, 4950.331705219894, 5008.724520151281, 5067.87330316745], "value": 4513.581238153582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.55316769193894, 330.17291684330746, 335.4532112656369, 340.87387666563376, 343.02067597010534, 6019.969900150499, 6131.8773624527485, 6152.0, 6153.415425534578, 6176.258848938128, 6025.216721826157, 6032.0951857221435, 6039.4262545058145, 6078.234403346478, 6103.572749907508, 4155.711729363907, 4379.167958087961, 4560.8403705870305, 4609.861704148864, 4631.93052104217, 4622.1217968586025, 4627.745473998929, 4647.419072615923, 4649.767511624422, 4660.953390466086, 4587.472440669332, 4598.218302888517, 4614.0, 4618.452818305872, 4630.536946305359, 4528.320751887227, 4606.0, 4606.170889239936, 4611.884702882421, 4633.582977532004, 4032.1129351542613, 4033.0, 4041.090754580225, 4058.7361821481804, 4068.247374235746, 5783.479486846204, 5820.476157145878, 5822.737976791054, 5845.298564172284, 5860.7948721794955, 5188.429272779991, 5336.546393556552, 5349.3045904032615, 5362.651427657229, 5364.91952620711, 6307.873842523124, 6363.490920726331, 6365.649889256089, 6376.234851817811, 6401.0, 4460.710053846489, 4460.8884777880485, 4468.352088947117, 4478.39541661878, 4481.865544033684, 6226.816904788076, 6273.6235825850135, 6454.290028096859, 6611.6033038017395, 6620.470362370998, 4451.643868490513, 4452.421185245962, 4460.687751857339, 4461.665375096881, 4486.654003798847, 4504.572065653758, 4521.186186486399, 4523.231050721385, 4531.456225252925, 4538.29656403258, 4981.078500477423, 5241.528262456397, 5259.684418934876, 5278.498542638443, 5283.233931079972, 6368.808935731936, 6372.8847451695765, 6374.9800031994655, 6375.776847810304, 6387.201599800025, 1540.537838648401, 1570.434643528329, 1572.771948067524, 1575.94484193055, 1576.9986058852712, 983.1839573154408, 1033.2095946600857, 1033.8397548380012, 1040.3029969920171, 1051.148569658579, 6082.118092876508, 6116.938830611637, 6130.1724267224245, 6131.436483696718, 6144.692765361714, 6460.935390646034, 6481.449076828522, 6507.3167317431935, 6521.413072823469, 6541.084248205255, 5926.436988486087, 6219.315875253718, 6230.470410015199, 6270.561060725706, 6282.842928926722, 3556.893293201208, 3574.91062723434, 3575.4279315309427, 3586.372384832644, 3593.9460908085875, 6726.159230096238, 6787.287334829871, 6818.590884546943, 6830.658467076626, 6884.139482564679, 6692.765753198712, 6770.255271920085, 6783.59298442095, 6789.388954994074, 6796.626185559841, 6738.528303018742, 6818.011388348662, 6871.0, 6893.103896493424, 6906.447484201251, 6580.144581204413, 6605.108310378229, 6617.172853393326, 6645.235797883305, 6698.799036028927, 6206.565540412128, 6346.809595711951, 6535.607863528204, 6561.639109849004, 6605.933940660532, 6521.315261897433, 6743.224529179207, 6746.224184218878, 6871.5189936703955, 6926.238113807578, 4415.227335216388, 4450.0, 4466.531014243457, 4472.530384309731, 4473.418455600751, 6420.26166990802, 6537.248216455168, 6539.673016349258, 6591.373819487141, 6693.665316734241, 6338.683065846782, 6392.20097487814, 6405.647689376942, 6410.775622853178, 6441.13044738973, 6313.179286692701, 6407.571949007259, 6414.967925160345, 6451.3226111257645, 6463.965765477501, 6252.562320637512, 6295.905561416674, 6344.195061518659, 6344.238691357066, 6364.809055728336, 6202.937970620416, 6383.234011918599, 6413.518986076157, 6469.5794773339585, 6486.416222539994, 6248.968755156195, 6283.968580157253, 6290.716917738804, 6296.2759282681245, 6340.112384266298], "value": 4799.404784424278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.9470837041406, 857.7212405968062, 866.69665617034, 876.045110829196, 880.3925291548835, 14281.928590357047, 14423.639409014766, 14670.926645366771, 14875.92562037191, 14963.476278330261, 11927.403629818518, 13867.514636987707, 14382.712345753078, 14424.567262982127, 14483.13101213928, 795.1571334385541, 848.9787755306136, 849.3247867944967, 851.4763420496381, 851.9701810436636, 823.8187598728271, 833.6457005772522, 834.7370578267856, 837.1712005114923, 838.0822998816317, 871.7776966873438, 873.5151990645189, 877.5173654490037, 879.6613303877989, 880.4761167105562, 874.6195404998814, 874.654511467973, 876.0407353947418, 876.1720174435161, 877.241186373782, 627.0468887291291, 636.045931103345, 636.4144986612328, 636.4844475974476, 639.6865535887429, 14639.487617933428, 14699.265036748227, 14724.0, 14772.335244914004, 14781.630459238497, 14086.0, 14195.85804141966, 14240.145591264558, 14377.353019114165, 14431.0, 11218.551257949672, 11258.831117533244, 11404.0, 11491.827622585668, 11523.827142592867, 3859.8649047283493, 3868.651821336065, 3871.4386413970096, 3880.3597406427907, 3972.2651309507833, 53719.73140134313, 53863.192052119644, 54136.729316353165, 54542.0, 54594.0, 11160.832587511193, 11384.772304553862, 11431.314121152758, 11450.198486105892, 11640.126990475748, 18246.45260642183, 18280.725789113174, 18318.908405458154, 18335.449936501926, 18372.724409133873, 8527.957360213159, 8602.913970860336, 8685.131486851391, 8750.212480876751, 8852.513111778913, 4797.64017698674, 4810.2063159578975, 4833.468318484964, 4885.218365061573, 4888.340074089952, 3375.645557216457, 3480.7215422766117, 3482.7910325380053, 3488.0407887830543, 3488.6162522122545, 639.2169592249458, 642.5662677692538, 651.0332156747227, 651.5992664511291, 655.4494224851148, 659.0838734159522, 704.2781149321986, 776.5185584937262, 779.5504890857931, 812.455654711333, 9836.458994755214, 10238.283320167666, 10441.895581044093, 10544.367337959748, 10617.575296988189, 740.3226048165975, 756.6973210715757, 764.2319468933797, 775.158952536493, 786.9488483248571, 4452.443444569429, 4525.864224073283, 4549.499555048942, 4615.769211539409, 4624.398828152319, 61076.389236107956, 61744.0, 62113.68943155346, 62616.37383626196, 63087.684561577815, 53366.7331663347, 53712.0, 54018.459815401344, 54588.72705636526, 55454.16818747722, 47483.05033899302, 48298.27552586714, 49165.0, 49284.75357623189, 50721.49278507241, 9186.356955013085, 9337.346385752931, 9390.906090939276, 9543.76140596463, 9577.616895324109, 30216.69783302139, 30491.695083048886, 30858.228544286572, 31022.0, 31562.842185788923, 34608.30783384368, 34694.479582805776, 34874.0, 37023.629763703095, 40208.798956005034, 11315.547378105113, 11545.942270288595, 12174.817377739164, 12282.692932676397, 12549.247045177319, 12668.493260269855, 13026.218426894417, 13256.07207495466, 13635.250061246727, 14019.158850469004, 13065.673358166121, 13084.542041028519, 13111.672208194872, 13564.660883477993, 13574.457021719021, 13015.674608134872, 13015.739685206432, 13075.41160647754, 13203.471861125447, 13317.0, 12771.0, 12810.67973300675, 12984.610461686165, 13065.608031759062, 13531.188128712309, 11108.166887483632, 11375.089992800722, 11464.31214127155, 11506.94246528762, 11705.88294117082, 10701.732456688645, 10764.677059688222, 10773.676789696321, 10803.945980270362, 10844.783104337712], "value": 6850.802681304003, "unit": "score"}], "name": "dromaeo_css", "value": 7116.899968492081, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 111.0, 114.0, 122.0, 111.0, 114.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 128.0, 157.0, 179.0, 130.0, 156.0, 154.0, 132.0, 182.0, 130.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 163.0, 162.0, 164.0, 175.0, 163.0, 166.0, 166.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 163.0, 73.0, 74.0, 73.0, 78.0, 158.0, 77.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 152.0, 94.0, 93.0, 93.0, 143.0, 95.0, 94.0, 155.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 70.0, 60.0, 69.0, 65.0, 63.0, 75.0, 62.0, 57.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 83.0, 89.0, 83.0, 80.0, 84.0, 82.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 133.0, 130.0, 136.0, 132.0, 131.0, 135.0, 179.0, 143.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 168.0, 173.0, 167.0, 173.0, 171.0, 164.0, 163.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 72.0, 70.0, 71.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1575.6, "alertThreshold": 2.0}]} 07:54:38 INFO - Return code: 0 07:54:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:54:39 ERROR - # TBPL SUCCESS # 07:54:39 INFO - Running post-action listener: _resource_record_post_action 07:54:39 INFO - Running post-run listener: _resource_record_post_run 07:54:40 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2527232; Write bytes: 552222720; Read time: 1276; Write time: 768300 07:54:40 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 2523136; Write bytes: 262234112; Read time: 1264; Write time: 452784 07:54:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289988608; Read time: 12; Write time: 315516 07:54:40 INFO - Running post-run listener: _upload_blobber_files 07:54:40 INFO - Blob upload gear active. 07:54:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:54:40 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:54:40 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:54:40 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:54:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:54:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:54:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:54:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:41 INFO - (blobuploader) - INFO - Done attempting. 07:54:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:54:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:42 INFO - (blobuploader) - INFO - Done attempting. 07:54:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:54:42 INFO - Return code: 0 07:54:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:54:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:54:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6eea8bc80763b518448e1179bebdc7d405908a748caafac333ad60ff65eebf164e156a322974f348126148b8ac9c67b144f1d266a06441b4099d1ebaf364f248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c5f2c7aac70cfea9781baa64a8015f2962b6f0d37a7e871b2024f42f688f32e4bc6b8ce1d1dec9e58900322bb4c36794f8f973c8ba3125cd3d4a7cfd50b3008"} 07:54:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:54:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:54:42 INFO - Contents: 07:54:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6eea8bc80763b518448e1179bebdc7d405908a748caafac333ad60ff65eebf164e156a322974f348126148b8ac9c67b144f1d266a06441b4099d1ebaf364f248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c5f2c7aac70cfea9781baa64a8015f2962b6f0d37a7e871b2024f42f688f32e4bc6b8ce1d1dec9e58900322bb4c36794f8f973c8ba3125cd3d4a7cfd50b3008"} 07:54:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:54:42 INFO - Copying logs to upload dir... 07:54:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:54:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.023946 ========= master_lag: -0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-14 07:54:41.150903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:54:41.154722) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718 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/6eea8bc80763b518448e1179bebdc7d405908a748caafac333ad60ff65eebf164e156a322974f348126148b8ac9c67b144f1d266a06441b4099d1ebaf364f248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c5f2c7aac70cfea9781baa64a8015f2962b6f0d37a7e871b2024f42f688f32e4bc6b8ce1d1dec9e58900322bb4c36794f8f973c8ba3125cd3d4a7cfd50b3008"} build_url:https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/YQKAvJTLSIyrYGPJcHCn5g/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/6eea8bc80763b518448e1179bebdc7d405908a748caafac333ad60ff65eebf164e156a322974f348126148b8ac9c67b144f1d266a06441b4099d1ebaf364f248", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c5f2c7aac70cfea9781baa64a8015f2962b6f0d37a7e871b2024f42f688f32e4bc6b8ce1d1dec9e58900322bb4c36794f8f973c8ba3125cd3d4a7cfd50b3008"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:54:41.180666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:54:41.181048) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460643274.619274-2025415718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:54:41.267043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:54:41.267427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:54:41.267790) ========= ========= Total master_lag: 0.13 =========