builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1463720300.43 results: success (0) buildid: 20160519191805 builduid: 758043963a694a0b8e389b65cf50b56c revision: 9ba18aae69e626a3f83560df321d91e42316083a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.426071) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.426669) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.427196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.444160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.447374) ========= 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=0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 21:58:20-- 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% 20.8M=0.001s 2016-05-19 21:58:20 (20.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.577876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.578222) ========= 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=0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019485 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:20.629606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 21:58:20.630611) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ba18aae69e626a3f83560df321d91e42316083a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ba18aae69e626a3f83560df321d91e42316083a --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=0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 21:58:20,710 truncating revision to first 12 chars 2016-05-19 21:58:20,711 Setting DEBUG logging. 2016-05-19 21:58:20,711 attempt 1/10 2016-05-19 21:58:20,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9ba18aae69e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 21:58:21,721 unpacking tar archive at: mozilla-aurora-9ba18aae69e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 21:58:21.965578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:21.965954) ========= script_repo_revision: 9ba18aae69e626a3f83560df321d91e42316083a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:21.966434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:21.966772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 21:58:21.977279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-19 21:58:21.977616) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:58:22 INFO - MultiFileLogger online at 20160519 21:58:22 in /builds/slave/test 21:58:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:58:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:58:22 INFO - {'append_to_log': False, 21:58:22 INFO - 'base_work_dir': '/builds/slave/test', 21:58:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:58:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:58:22 INFO - 'branch': 'Mozilla-Aurora', 21:58:22 INFO - 'buildbot_json_path': 'buildprops.json', 21:58:22 INFO - 'config_files': ('talos/linux_config.py',), 21:58:22 INFO - 'default_actions': ('clobber', 21:58:22 INFO - 'read-buildbot-config', 21:58:22 INFO - 'download-and-extract', 21:58:22 INFO - 'populate-webroot', 21:58:22 INFO - 'create-virtualenv', 21:58:22 INFO - 'install', 21:58:22 INFO - 'run-tests'), 21:58:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:58:22 INFO - 'download_minidump_stackwalk': True, 21:58:22 INFO - 'download_symbols': 'ondemand', 21:58:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:58:22 INFO - 'tooltool.py': '/tools/tooltool.py', 21:58:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:58:22 INFO - '/tools/misc-python/virtualenv.py')}, 21:58:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:58:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:58:22 INFO - 'installer_path': 'installer.exe', 21:58:22 INFO - 'log_level': 'info', 21:58:22 INFO - 'log_name': 'talos', 21:58:22 INFO - 'log_to_console': True, 21:58:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:58:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:58:22 INFO - 'opt_config_files': (), 21:58:22 INFO - 'pip_index': False, 21:58:22 INFO - 'sps_profile': False, 21:58:22 INFO - 'sps_profile_interval': 0, 21:58:22 INFO - 'suite': 'dromaeojs-e10s', 21:58:22 INFO - 'system_bits': '32', 21:58:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:58:22 INFO - 'title': 'talos-linux64-ix-017', 21:58:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:58:22 INFO - 'use_talos_json': True, 21:58:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:58:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:58:22 INFO - 'work_dir': 'build'} 21:58:22 INFO - ##### 21:58:22 INFO - ##### Running clobber step. 21:58:22 INFO - ##### 21:58:22 INFO - Running pre-action listener: _resource_record_pre_action 21:58:22 INFO - Running main action method: clobber 21:58:22 INFO - rmtree: /builds/slave/test/build 21:58:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:58:22 INFO - Running post-action listener: _resource_record_post_action 21:58:22 INFO - ##### 21:58:22 INFO - ##### Running read-buildbot-config step. 21:58:22 INFO - ##### 21:58:22 INFO - Running pre-action listener: _resource_record_pre_action 21:58:22 INFO - Running main action method: read_buildbot_config 21:58:22 INFO - Using buildbot properties: 21:58:22 INFO - { 21:58:22 INFO - "project": "", 21:58:22 INFO - "product": "firefox", 21:58:22 INFO - "script_repo_revision": "production", 21:58:22 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 21:58:22 INFO - "repository": "", 21:58:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 21:58:22 INFO - "buildid": "20160519191805", 21:58:22 INFO - "pgo_build": "True", 21:58:22 INFO - "basedir": "/builds/slave/test", 21:58:22 INFO - "buildnumber": 277, 21:58:22 INFO - "slavename": "talos-linux64-ix-017", 21:58:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:58:22 INFO - "platform": "ubuntu64_hw", 21:58:22 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:58:22 INFO - "branch": "mozilla-aurora", 21:58:22 INFO - "repo_path": "releases/mozilla-aurora", 21:58:22 INFO - "revision": "9ba18aae69e626a3f83560df321d91e42316083a", 21:58:22 INFO - "stage_platform": "linux64-pgo", 21:58:22 INFO - "builduid": "758043963a694a0b8e389b65cf50b56c", 21:58:22 INFO - "slavebuilddir": "test" 21:58:22 INFO - } 21:58:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 21:58:22 INFO - Running post-action listener: _resource_record_post_action 21:58:22 INFO - ##### 21:58:22 INFO - ##### Running download-and-extract step. 21:58:22 INFO - ##### 21:58:22 INFO - Running pre-action listener: _resource_record_pre_action 21:58:22 INFO - Running main action method: download_and_extract 21:58:22 INFO - mkdir: /builds/slave/test/build/tests 21:58: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')]} 21:58:22 INFO - https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:58:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:58:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:58:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:58:25 INFO - Downloaded 1361 bytes. 21:58:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:58:25 INFO - Using the following test package requirements: 21:58:25 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:58:25 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:58:25 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:58:25 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'jsshell-linux-x86_64.zip'], 21:58:25 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:58:25 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:58:25 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:58:25 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:58:25 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:58:25 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:58:25 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:58:25 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:25 INFO - https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:58:43 INFO - Downloaded 23813213 bytes. 21:58:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:58:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:58:44 INFO - Return code: 0 21:58:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:58:44 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')]} 21:58:44 INFO - https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:58:46 INFO - Downloaded 23813213 bytes. 21:58:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:58:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:58:47 INFO - Return code: 0 21:58:47 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')]} 21:58:47 INFO - https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:58:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:58:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:58:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:58:49 INFO - Downloaded 10840145 bytes. 21:58:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:58:49 INFO - Return code: 0 21:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:49 INFO - https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:58:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:58:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:58:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:58:53 INFO - Downloaded 62712901 bytes. 21:58:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:58:53 INFO - mkdir: /builds/slave/test/properties 21:58:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:58:53 INFO - Writing to file /builds/slave/test/properties/build_url 21:58:53 INFO - Contents: 21:58:53 INFO - build_url:https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:58:53 INFO - Running post-action listener: _resource_record_post_action 21:58:53 INFO - Running post-action listener: set_extra_try_arguments 21:58:53 INFO - ##### 21:58:53 INFO - ##### Running populate-webroot step. 21:58:53 INFO - ##### 21:58:53 INFO - Running pre-action listener: _resource_record_pre_action 21:58:53 INFO - Running main action method: populate_webroot 21:58:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:58:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:58:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:58:53 INFO - '--tppagecycles', 21:58:53 INFO - '7'], 21:58:53 INFO - 'tests': ['tsvgm']}}, 21:58:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:58:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:58:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:58:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:58:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:58:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:58:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['damp', 'tps']}, 21:58:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'tests': ['damp', 'tps']}, 21:58:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['dromaeo_dom']}, 21:58:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:58:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['a11yr', 21:58:53 INFO - 'ts_paint', 21:58:53 INFO - 'tpaint', 21:58:53 INFO - 'sessionrestore', 21:58:53 INFO - 'sessionrestore_no_auto_restore', 21:58:53 INFO - 'tabpaint']}, 21:58:53 INFO - 'other-e10s': {'tests': ['a11yr', 21:58:53 INFO - 'ts_paint', 21:58:53 INFO - 'tpaint', 21:58:53 INFO - 'sessionrestore', 21:58:53 INFO - 'sessionrestore_no_auto_restore', 21:58:53 INFO - 'tabpaint']}, 21:58:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:58:53 INFO - 'ts_paint', 21:58:53 INFO - 'tpaint', 21:58:53 INFO - 'sessionrestore', 21:58:53 INFO - 'sessionrestore_no_auto_restore', 21:58:53 INFO - 'tabpaint']}, 21:58:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:58:53 INFO - 'ts_paint', 21:58:53 INFO - 'tpaint', 21:58:53 INFO - 'sessionrestore', 21:58:53 INFO - 'sessionrestore_no_auto_restore', 21:58:53 INFO - 'tabpaint']}, 21:58:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['a11yr', 21:58:53 INFO - 'ts_paint', 21:58:53 INFO - 'tpaint', 21:58:53 INFO - 'sessionrestore', 21:58:53 INFO - 'sessionrestore_no_auto_restore', 21:58:53 INFO - 'tabpaint']}, 21:58:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['a11yr', 21:58:53 INFO - 'ts_paint', 21:58:53 INFO - 'tpaint', 21:58:53 INFO - 'sessionrestore', 21:58:53 INFO - 'sessionrestore_no_auto_restore', 21:58:53 INFO - 'tabpaint']}, 21:58:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['tsvgx', 21:58:53 INFO - 'tsvgr_opacity', 21:58:53 INFO - 'tart', 21:58:53 INFO - 'tscrollx', 21:58:53 INFO - 'cart']}, 21:58:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:58:53 INFO - 'tsvgr_opacity', 21:58:53 INFO - 'tart', 21:58:53 INFO - 'tscrollx', 21:58:53 INFO - 'cart']}, 21:58:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'talos_options': ['--disable-e10s'], 21:58:53 INFO - 'tests': ['tp5o']}, 21:58:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'tests': ['tp5o']}, 21:58:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'talos_options': ['--disable-e10s', 21:58:53 INFO - '--xperf_path', 21:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:58:53 INFO - 'tests': ['tp5n']}, 21:58:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:58:53 INFO - 'talos_options': ['--xperf_path', 21:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:58:53 INFO - 'tests': ['tp5n']}}, 21:58:53 INFO - 'talos.zip': {'path': '', 21:58:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:58:53 INFO - Running post-action listener: _resource_record_post_action 21:58:53 INFO - ##### 21:58:53 INFO - ##### Running create-virtualenv step. 21:58:53 INFO - ##### 21:58:53 INFO - Running pre-action listener: _resource_record_pre_action 21:58:53 INFO - Running main action method: create_virtualenv 21:58:53 INFO - Creating virtualenv /builds/slave/test/build/venv 21:58:53 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 21:58:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:58:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:58:53 INFO - Using real prefix '/usr' 21:58:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 21:58:56 INFO - Installing pip.................done. 21:58:56 INFO - Return code: 0 21:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:58:56 INFO - Using env: {'DISPLAY': ':0', 21:58:56 INFO - 'HOME': '/home/cltbld', 21:58:56 INFO - 'LANG': 'en_US.UTF-8', 21:58:56 INFO - 'LANGUAGE': 'en_US:en', 21:58:56 INFO - 'LOGNAME': 'cltbld', 21:58:56 INFO - 'MAIL': '/var/mail/cltbld', 21:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:56 INFO - 'MOZ_NO_REMOTE': '1', 21:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:56 INFO - 'NO_EM_RESTART': '1', 21:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:58:56 INFO - 'PWD': '/builds/slave/test', 21:58:56 INFO - 'SHELL': '/bin/bash', 21:58:56 INFO - 'SHLVL': '1', 21:58:56 INFO - 'TERM': 'linux', 21:58:56 INFO - 'TMOUT': '86400', 21:58:56 INFO - 'USER': 'cltbld', 21:58:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:56 INFO - '_': '/tools/buildbot/bin/python'} 21:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:56 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 21:58:56 INFO - Cleaning up... 21:58:56 INFO - Return code: 0 21:58:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:58:56 INFO - Using env: {'DISPLAY': ':0', 21:58:56 INFO - 'HOME': '/home/cltbld', 21:58:56 INFO - 'LANG': 'en_US.UTF-8', 21:58:56 INFO - 'LANGUAGE': 'en_US:en', 21:58:56 INFO - 'LOGNAME': 'cltbld', 21:58:56 INFO - 'MAIL': '/var/mail/cltbld', 21:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:56 INFO - 'MOZ_NO_REMOTE': '1', 21:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:56 INFO - 'NO_EM_RESTART': '1', 21:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:58:56 INFO - 'PWD': '/builds/slave/test', 21:58:56 INFO - 'SHELL': '/bin/bash', 21:58:56 INFO - 'SHLVL': '1', 21:58:56 INFO - 'TERM': 'linux', 21:58:56 INFO - 'TMOUT': '86400', 21:58:56 INFO - 'USER': 'cltbld', 21:58:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:56 INFO - '_': '/tools/buildbot/bin/python'} 21:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:57 INFO - Downloading/unpacking psutil>=0.7.1 21:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:58:59 INFO - Installing collected packages: psutil 21:58:59 INFO - Running setup.py install for psutil 21:58:59 INFO - building 'psutil._psutil_linux' extension 21:58:59 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 21:58:59 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 21:58:59 INFO - building 'psutil._psutil_posix' extension 21:58:59 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 21:59:00 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 21:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:00 INFO - Successfully installed psutil 21:59:00 INFO - Cleaning up... 21:59:00 INFO - Return code: 0 21:59:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:00 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:00 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 21:59:00 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 21:59:00 INFO - Using env: {'DISPLAY': ':0', 21:59:00 INFO - 'HOME': '/home/cltbld', 21:59:00 INFO - 'LANG': 'en_US.UTF-8', 21:59:00 INFO - 'LANGUAGE': 'en_US:en', 21:59:00 INFO - 'LOGNAME': 'cltbld', 21:59:00 INFO - 'MAIL': '/var/mail/cltbld', 21:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:00 INFO - 'MOZ_NO_REMOTE': '1', 21:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:00 INFO - 'NO_EM_RESTART': '1', 21:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:00 INFO - 'PWD': '/builds/slave/test', 21:59:00 INFO - 'SHELL': '/bin/bash', 21:59:00 INFO - 'SHLVL': '1', 21:59:00 INFO - 'TERM': 'linux', 21:59:00 INFO - 'TMOUT': '86400', 21:59:00 INFO - 'USER': 'cltbld', 21:59:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:00 INFO - '_': '/tools/buildbot/bin/python'} 21:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:02 INFO - Installing collected packages: mozsystemmonitor 21:59:02 INFO - Running setup.py install for mozsystemmonitor 21:59:02 INFO - Successfully installed mozsystemmonitor 21:59:02 INFO - Cleaning up... 21:59:02 INFO - Return code: 0 21:59:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:02 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')]} 21:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:02 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')]} 21:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:02 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:02 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 21:59:02 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 21:59:02 INFO - Using env: {'DISPLAY': ':0', 21:59:02 INFO - 'HOME': '/home/cltbld', 21:59:02 INFO - 'LANG': 'en_US.UTF-8', 21:59:02 INFO - 'LANGUAGE': 'en_US:en', 21:59:02 INFO - 'LOGNAME': 'cltbld', 21:59:02 INFO - 'MAIL': '/var/mail/cltbld', 21:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:02 INFO - 'MOZ_NO_REMOTE': '1', 21:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:02 INFO - 'NO_EM_RESTART': '1', 21:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:02 INFO - 'PWD': '/builds/slave/test', 21:59:02 INFO - 'SHELL': '/bin/bash', 21:59:02 INFO - 'SHLVL': '1', 21:59:02 INFO - 'TERM': 'linux', 21:59:02 INFO - 'TMOUT': '86400', 21:59:02 INFO - 'USER': 'cltbld', 21:59:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:02 INFO - '_': '/tools/buildbot/bin/python'} 21:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:02 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:02 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 21:59:02 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 21:59:02 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 21:59:02 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 21:59:02 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 21:59:02 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 21:59:04 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:05 INFO - Downloading docopt-0.6.1.tar.gz 21:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:05 INFO - Running setup.py install for blobuploader 21:59:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:05 INFO - Running setup.py install for requests 21:59:05 INFO - Running setup.py install for docopt 21:59:05 INFO - Successfully installed blobuploader requests docopt 21:59:05 INFO - Cleaning up... 21:59:06 INFO - Return code: 0 21:59:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:06 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')]} 21:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:06 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')]} 21:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:06 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:06 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 21:59:06 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 21:59:06 INFO - Using env: {'DISPLAY': ':0', 21:59:06 INFO - 'HOME': '/home/cltbld', 21:59:06 INFO - 'LANG': 'en_US.UTF-8', 21:59:06 INFO - 'LANGUAGE': 'en_US:en', 21:59:06 INFO - 'LOGNAME': 'cltbld', 21:59:06 INFO - 'MAIL': '/var/mail/cltbld', 21:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:06 INFO - 'MOZ_NO_REMOTE': '1', 21:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:06 INFO - 'NO_EM_RESTART': '1', 21:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:06 INFO - 'PWD': '/builds/slave/test', 21:59:06 INFO - 'SHELL': '/bin/bash', 21:59:06 INFO - 'SHLVL': '1', 21:59:06 INFO - 'TERM': 'linux', 21:59:06 INFO - 'TMOUT': '86400', 21:59:06 INFO - 'USER': 'cltbld', 21:59:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:06 INFO - '_': '/tools/buildbot/bin/python'} 21:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:06 INFO - Running setup.py (path:/tmp/pip-_sxIbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:06 INFO - Running setup.py (path:/tmp/pip-PJ7mmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:06 INFO - Running setup.py (path:/tmp/pip-ICevQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:06 INFO - Running setup.py (path:/tmp/pip-CPSv75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:06 INFO - Running setup.py (path:/tmp/pip-UjCZ1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:06 INFO - Running setup.py (path:/tmp/pip-nMDy6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:06 INFO - Running setup.py (path:/tmp/pip-wUwUOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:06 INFO - Running setup.py (path:/tmp/pip-z8FQGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:06 INFO - Running setup.py (path:/tmp/pip-EWOU5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:06 INFO - Running setup.py (path:/tmp/pip-eK4ay5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:06 INFO - Running setup.py (path:/tmp/pip-dNroSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:07 INFO - Running setup.py (path:/tmp/pip-74IKLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:07 INFO - Running setup.py (path:/tmp/pip-OHnGZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:07 INFO - Running setup.py (path:/tmp/pip-9XImXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:07 INFO - Running setup.py (path:/tmp/pip-dG2upR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:07 INFO - Running setup.py (path:/tmp/pip-7zcLfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:07 INFO - Running setup.py (path:/tmp/pip-sJ5KWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:07 INFO - Running setup.py install for manifestparser 21:59:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:07 INFO - Running setup.py install for mozcrash 21:59:07 INFO - Running setup.py install for mozdebug 21:59:07 INFO - Running setup.py install for mozdevice 21:59:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:07 INFO - Running setup.py install for mozfile 21:59:07 INFO - Running setup.py install for mozhttpd 21:59:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for mozinfo 21:59:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for mozInstall 21:59:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for mozleak 21:59:08 INFO - Running setup.py install for mozlog 21:59:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for moznetwork 21:59:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for mozprocess 21:59:08 INFO - Running setup.py install for mozprofile 21:59:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for mozrunner 21:59:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:08 INFO - Running setup.py install for mozscreenshot 21:59:09 INFO - Running setup.py install for moztest 21:59:09 INFO - Running setup.py install for mozversion 21:59:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:09 INFO - Cleaning up... 21:59:09 INFO - Return code: 0 21:59:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:09 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')]} 21:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:09 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')]} 21:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:09 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:09 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 21:59:09 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 21:59:09 INFO - Using env: {'DISPLAY': ':0', 21:59:09 INFO - 'HOME': '/home/cltbld', 21:59:09 INFO - 'LANG': 'en_US.UTF-8', 21:59:09 INFO - 'LANGUAGE': 'en_US:en', 21:59:09 INFO - 'LOGNAME': 'cltbld', 21:59:09 INFO - 'MAIL': '/var/mail/cltbld', 21:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:09 INFO - 'MOZ_NO_REMOTE': '1', 21:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:09 INFO - 'NO_EM_RESTART': '1', 21:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:09 INFO - 'PWD': '/builds/slave/test', 21:59:09 INFO - 'SHELL': '/bin/bash', 21:59:09 INFO - 'SHLVL': '1', 21:59:09 INFO - 'TERM': 'linux', 21:59:09 INFO - 'TMOUT': '86400', 21:59:09 INFO - 'USER': 'cltbld', 21:59:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:09 INFO - '_': '/tools/buildbot/bin/python'} 21:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:09 INFO - Running setup.py (path:/tmp/pip-veMLVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:09 INFO - Running setup.py (path:/tmp/pip-DQwPgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:09 INFO - Running setup.py (path:/tmp/pip-IurYJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:09 INFO - Running setup.py (path:/tmp/pip-mN6e5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:09 INFO - Running setup.py (path:/tmp/pip-6gzvtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:09 INFO - Running setup.py (path:/tmp/pip-vA6EGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:09 INFO - Running setup.py (path:/tmp/pip-ygf2Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:09 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)) 21:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:09 INFO - Running setup.py (path:/tmp/pip-Thg1qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:10 INFO - Running setup.py (path:/tmp/pip-4YbyAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:10 INFO - Running setup.py (path:/tmp/pip-xY1Idr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:10 INFO - Running setup.py (path:/tmp/pip-EPibS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:10 INFO - Running setup.py (path:/tmp/pip-RY4FCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:10 INFO - Running setup.py (path:/tmp/pip-VLXOId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:10 INFO - Running setup.py (path:/tmp/pip-Li9Kck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:10 INFO - Running setup.py (path:/tmp/pip-88Yiff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:10 INFO - Running setup.py (path:/tmp/pip-zZSWqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:10 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)) 21:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:10 INFO - Running setup.py (path:/tmp/pip-_oLkqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:10 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)) 21:59:10 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)) 21:59:10 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)) 21:59:10 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)) 21:59:10 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)) 21:59:10 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)) 21:59:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:12 INFO - Downloading blessings-1.6.tar.gz 21:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:12 INFO - Installing collected packages: blessings 21:59:12 INFO - Running setup.py install for blessings 21:59:12 INFO - Successfully installed blessings 21:59:12 INFO - Cleaning up... 21:59:12 INFO - Return code: 0 21:59:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:12 INFO - Reading from file tmpfile_stdout 21:59:12 INFO - Current package versions: 21:59:12 INFO - argparse == 1.2.1 21:59:12 INFO - blessings == 1.6 21:59:12 INFO - blobuploader == 1.2.4 21:59:12 INFO - docopt == 0.6.1 21:59:12 INFO - manifestparser == 1.1 21:59:12 INFO - mozInstall == 1.12 21:59:12 INFO - mozcrash == 0.17 21:59:12 INFO - mozdebug == 0.1 21:59:12 INFO - mozdevice == 0.48 21:59:12 INFO - mozfile == 1.2 21:59:12 INFO - mozhttpd == 0.7 21:59:12 INFO - mozinfo == 0.9 21:59:12 INFO - mozleak == 0.1 21:59:12 INFO - mozlog == 3.1 21:59:12 INFO - moznetwork == 0.27 21:59:12 INFO - mozprocess == 0.22 21:59:12 INFO - mozprofile == 0.28 21:59:13 INFO - mozrunner == 6.11 21:59:13 INFO - mozscreenshot == 0.1 21:59:13 INFO - mozsystemmonitor == 0.0 21:59:13 INFO - moztest == 0.7 21:59:13 INFO - mozversion == 1.4 21:59:13 INFO - psutil == 3.1.1 21:59:13 INFO - requests == 1.2.3 21:59:13 INFO - wsgiref == 0.1.2 21:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:13 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')]} 21:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:13 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')]} 21:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:13 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:13 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 21:59:13 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 21:59:13 INFO - Using env: {'DISPLAY': ':0', 21:59:13 INFO - 'HOME': '/home/cltbld', 21:59:13 INFO - 'LANG': 'en_US.UTF-8', 21:59:13 INFO - 'LANGUAGE': 'en_US:en', 21:59:13 INFO - 'LOGNAME': 'cltbld', 21:59:13 INFO - 'MAIL': '/var/mail/cltbld', 21:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:13 INFO - 'MOZ_NO_REMOTE': '1', 21:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:13 INFO - 'NO_EM_RESTART': '1', 21:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:13 INFO - 'PWD': '/builds/slave/test', 21:59:13 INFO - 'SHELL': '/bin/bash', 21:59:13 INFO - 'SHLVL': '1', 21:59:13 INFO - 'TERM': 'linux', 21:59:13 INFO - 'TMOUT': '86400', 21:59:13 INFO - 'USER': 'cltbld', 21:59:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:13 INFO - '_': '/tools/buildbot/bin/python'} 21:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 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)) 21:59:13 INFO - Cleaning up... 21:59:13 INFO - Return code: 0 21:59:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:59:13 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')]} 21:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:13 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')]} 21:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:13 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:13 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 21:59:13 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 21:59:13 INFO - Using env: {'DISPLAY': ':0', 21:59:13 INFO - 'HOME': '/home/cltbld', 21:59:13 INFO - 'LANG': 'en_US.UTF-8', 21:59:13 INFO - 'LANGUAGE': 'en_US:en', 21:59:13 INFO - 'LOGNAME': 'cltbld', 21:59:13 INFO - 'MAIL': '/var/mail/cltbld', 21:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:13 INFO - 'MOZ_NO_REMOTE': '1', 21:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:13 INFO - 'NO_EM_RESTART': '1', 21:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:13 INFO - 'PWD': '/builds/slave/test', 21:59:13 INFO - 'SHELL': '/bin/bash', 21:59:13 INFO - 'SHLVL': '1', 21:59:13 INFO - 'TERM': 'linux', 21:59:13 INFO - 'TMOUT': '86400', 21:59:13 INFO - 'USER': 'cltbld', 21:59:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:13 INFO - '_': '/tools/buildbot/bin/python'} 21:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:13 INFO - Downloading/unpacking jsonschema 21:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:15 INFO - Downloading/unpacking functools32 (from jsonschema) 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:15 INFO - warning: no files found matching '*.txt' 21:59:15 INFO - no previously-included directories found matching 'build' 21:59:15 INFO - no previously-included directories found matching 'dist' 21:59:15 INFO - no previously-included directories found matching '.git*' 21:59:15 INFO - Installing collected packages: jsonschema, functools32 21:59:15 INFO - Running setup.py install for functools32 21:59:15 INFO - warning: no files found matching '*.txt' 21:59:15 INFO - no previously-included directories found matching 'build' 21:59:15 INFO - no previously-included directories found matching 'dist' 21:59:15 INFO - no previously-included directories found matching '.git*' 21:59:15 INFO - Successfully installed jsonschema functools32 21:59:15 INFO - Cleaning up... 21:59:15 INFO - Return code: 0 21:59:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:15 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 0x7f45f2cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf845a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, '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': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', '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 21:59:15 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 21:59:15 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 21:59:15 INFO - Using env: {'DISPLAY': ':0', 21:59:15 INFO - 'HOME': '/home/cltbld', 21:59:15 INFO - 'LANG': 'en_US.UTF-8', 21:59:15 INFO - 'LANGUAGE': 'en_US:en', 21:59:15 INFO - 'LOGNAME': 'cltbld', 21:59:15 INFO - 'MAIL': '/var/mail/cltbld', 21:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:15 INFO - 'MOZ_NO_REMOTE': '1', 21:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:15 INFO - 'NO_EM_RESTART': '1', 21:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:15 INFO - 'PWD': '/builds/slave/test', 21:59:15 INFO - 'SHELL': '/bin/bash', 21:59:15 INFO - 'SHLVL': '1', 21:59:15 INFO - 'TERM': 'linux', 21:59:15 INFO - 'TMOUT': '86400', 21:59:15 INFO - 'USER': 'cltbld', 21:59:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:15 INFO - '_': '/tools/buildbot/bin/python'} 21:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:15 INFO - Downloading/unpacking flake8 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 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 21:59:15 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 21:59:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:59:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:59:17 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 21:59:17 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 21:59:17 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 21:59:17 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 21:59:17 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 21:59:17 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 21:59:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:59:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:59:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:59:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:59:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:59:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:59:18 INFO - no previously-included directories found matching 'docs/_build' 21:59:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:59:18 INFO - Running setup.py install for pep8 21:59:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:59:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:59:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:59:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:59:18 INFO - no previously-included directories found matching 'docs/_build' 21:59:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:59:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:59:18 INFO - Cleaning up... 21:59:18 INFO - Return code: 0 21:59:18 INFO - Running post-action listener: _resource_record_post_action 21:59:18 INFO - Running post-action listener: _start_resource_monitoring 21:59:18 INFO - Starting resource monitoring. 21:59:18 INFO - ##### 21:59:18 INFO - ##### Running install step. 21:59:18 INFO - ##### 21:59:18 INFO - Running pre-action listener: _resource_record_pre_action 21:59:18 INFO - Running main action method: install 21:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:19 INFO - Reading from file tmpfile_stdout 21:59:19 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:59:19 INFO - Reading from file tmpfile_stdout 21:59:19 INFO - Output received: 21:59:19 INFO - Usage: mozinstall [options] installer 21:59:19 INFO - Options: 21:59:19 INFO - -h, --help show this help message and exit 21:59:19 INFO - -d DEST, --destination=DEST 21:59:19 INFO - Directory to install application into. [default: 21:59:19 INFO - "/builds/slave/test"] 21:59:19 INFO - --app=APP Application being installed. [default: firefox] 21:59:19 INFO - mkdir: /builds/slave/test/build/application 21:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:59:34 INFO - Reading from file tmpfile_stdout 21:59:34 INFO - Output received: 21:59:34 INFO - /builds/slave/test/build/application/firefox/firefox 21:59:34 INFO - Running post-action listener: _resource_record_post_action 21:59:34 INFO - ##### 21:59:34 INFO - ##### Running run-tests step. 21:59:34 INFO - ##### 21:59:34 INFO - Running pre-action listener: _resource_record_pre_action 21:59:34 INFO - Running main action method: run_tests 21:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:59:34 INFO - Python 2.7.3 21:59:34 INFO - Return code: 0 21:59:34 INFO - grabbing minidump binary from tooltool 21:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:34 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 0x1013410>, '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 0x1014310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10147a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:59:34 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 21:59:34 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 21:59:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:59:34 INFO - Return code: 0 21:59:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:59:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:59:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:59:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:59:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:59:35 INFO - Return code: 0 21:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 21:59:35 INFO - Using env: {'DISPLAY': ':0', 21:59:35 INFO - 'HOME': '/home/cltbld', 21:59:35 INFO - 'LANG': 'en_US.UTF-8', 21:59:35 INFO - 'LANGUAGE': 'en_US:en', 21:59:35 INFO - 'LOGNAME': 'cltbld', 21:59:35 INFO - 'MAIL': '/var/mail/cltbld', 21:59:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:59:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:35 INFO - 'MOZ_NO_REMOTE': '1', 21:59:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:35 INFO - 'NO_EM_RESTART': '1', 21:59:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:35 INFO - 'PWD': '/builds/slave/test', 21:59:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:59:35 INFO - 'SHELL': '/bin/bash', 21:59:35 INFO - 'SHLVL': '1', 21:59:35 INFO - 'TERM': 'linux', 21:59:35 INFO - 'TMOUT': '86400', 21:59:35 INFO - 'USER': 'cltbld', 21:59:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494', 21:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:35 INFO - '_': '/tools/buildbot/bin/python'} 21:59:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 21:59:35 INFO - mozversion application_buildid: 20160519191805 21:59:35 INFO - mozversion application_changeset: 9ba18aae69e626a3f83560df321d91e42316083a 21:59:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:59:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:59:35 INFO - mozversion application_name: Firefox 21:59:35 INFO - mozversion application_remotingname: firefox-dev 21:59:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:59:35 INFO - mozversion application_vendor: Mozilla 21:59:35 INFO - mozversion application_version: 48.0a2 21:59:35 INFO - mozversion platform_buildid: 20160519191805 21:59:35 INFO - mozversion platform_changeset: 9ba18aae69e626a3f83560df321d91e42316083a 21:59:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:59:35 INFO - mozversion platform_version: 48.0a2 21:59:35 INFO - using testdate: 1463720375 21:59:35 INFO - actual date: 1463720375 21:59:35 INFO - starting webserver on 'localhost:41781' 21:59:35 INFO - SUITE-START | Running 2 tests 21:59:35 INFO - TEST-START | dromaeo_css 21:59:35 INFO - operating with platform_type : linux_ 21:59:35 INFO - Initialising browser for dromaeo_css test... 21:59:35 INFO - TEST-INFO | started process 6279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qxDBu/profile http://localhost:41781/getInfo.html) 21:59:39 INFO - PROCESS | 6279 | 21:59:39 INFO - PROCESS | 6279 | (process:6358): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:59:40 INFO - PROCESS | 6279 | __metrics Screen width/height:1600/1200 21:59:40 INFO - PROCESS | 6279 | colorDepth:24 21:59:40 INFO - PROCESS | 6279 | Browser inner width/height: 1024/697 21:59:40 INFO - PROCESS | 6279 | __metrics 21:59:40 ERROR - PROCESS | 6279 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 21:59:41 INFO - TEST-INFO | 6279: exit 0 21:59:41 INFO - Browser initialized. 21:59:41 INFO - Running cycle 1/1 for dromaeo_css test... 21:59:41 INFO - TEST-INFO | started process 6409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qxDBu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:59:43 INFO - PROCESS | 6409 | 21:59:43 INFO - PROCESS | 6409 | (process:6480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:59:53 INFO - PROCESS | 6409 | RSS: Main: 152100864 21:59:53 INFO - PROCESS | 6409 | 22:00:42 INFO - PROCESS | 6409 | 1463720442795 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] 22:02:50 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:41781/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41781/tests/dromaeo/cssquery-ext.html) 22:02:51 INFO - PROCESS | 6409 | RSS: Main: 155951104 22:02:51 INFO - PROCESS | 6409 | 22:05:52 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:41781/tests/dromaeo/cssquery-ext.html (next: http://localhost:41781/tests/dromaeo/cssquery-jquery.html) 22:05:53 INFO - PROCESS | 6409 | RSS: Main: 154128384 22:05:53 INFO - PROCESS | 6409 | 22:08:55 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:41781/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41781/tests/dromaeo/cssquery-mootools.html) 22:08:55 INFO - PROCESS | 6409 | RSS: Main: 153567232 22:08:55 INFO - PROCESS | 6409 | 22:11:57 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:41781/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41781/tests/dromaeo/cssquery-prototype.html) 22:11:57 INFO - PROCESS | 6409 | RSS: Main: 153169920 22:11:57 INFO - PROCESS | 6409 | 22:15:00 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:41781/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41781/tests/dromaeo/cssquery-yui.html) 22:15:00 INFO - PROCESS | 6409 | RSS: Main: 155078656 22:15:00 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | Cycle 1(1): loaded http://localhost:41781/tests/dromaeo/cssquery-yui.html (next: http://localhost:41781/tests/dromaeo/cssquery-dojo.html) 22:18:03 INFO - PROCESS | 6409 | RSS: Main: 156319744 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | __start_tp_report 22:18:03 INFO - PROCESS | 6409 | _x_x_mozilla_page_load 22:18:03 INFO - PROCESS | 6409 | _x_x_mozilla_page_load_details 22:18:03 INFO - PROCESS | 6409 | |i|pagename|runs| 22:18:03 INFO - PROCESS | 6409 | |0;dojo.html;3299.901002969911;3303.223742420531;3332.6500717424683;3387.0008347537473;3395.7113645340146;5563.582731295154;5583.8604034899145;5602.495775380215;5620.213170156181;5636.549076073909;5546.195801608765;5613.607047506676;5614.66312021279;5621.606487545873;5622.156676498527;5052.949470505285;5097.388313402397;5115.846524604268;5141.717205553693;5148.304978827867;5028.195488721805;5053.949460505403;5203.4016088149965;5216.165413533835;5261.605379596526;4953.9504604953845;5005.899882002376;5011.924821127686;5082.4155222149375;5089.592832573385;5089.287499750019;5091.05815424144;5105.081085404644;5118.744062796845;5148.433672296044;4903.362562866804;4986.07757564848;5019.774110165052;5034;5070.898582028376;5432.565394768409;5442.564594832404;5449.128139497661;5514.724263786835;5539.418361072069;5971.253593300838;5983.6110652807865;6007;6007.399260074001;6012.038073908154;5725.799597014085;5906.055031195031;5993.550483713739;6045.848853778647;6058.1215723719815;5441.401445840955;5488.588355873326;5515.448455154493;5519.254900588449;5519.2824932758485;6027.126066720301;6032.215811944419;6037.607555508966;6043.637381757108;6052.636841789506;5810.360860305363;5822.184894114827;5866.560007999332;5874.265716785402;5919.023361145449;6017;6049.758009679564;6059.0608455689435;6065.5450841187085;6071.726772295257;5809.9832529307205;5960.821175364746;6007.459328660441;6035.215421995113;6036.547258955508;5820.330661973842;5900.1739756434135;5900.822975310747;5921.348651648315;5934.080217566284;4458.464984201916;4507.954920450819;4520.434945631796;4541.205289074464;4550.726956382628;3996.540397854226;4021.195760847842;4074.735142215806;4085.571015043437;4118.773467459258;5502.394736578973;5514.035043867307;5771.451712087345;5813.069908814569;5848.473637372657;5876.618019828783;5927.31835838884;5956.255468066492;5965.582409231399;5990.251218597676;5610.831675049755;5689.800856969986;5690.800821971211;5697.715114244271;5701.486866182064;4853.635977301717;4892.461829198785;4900.534449227318;4922.409310882717;4931.063098011438;6194.132821405007;6208.565400421927;6239.376062393724;6250.593711408744;6256.937430625727;5922.881542369215;6016.488598469179;6019.578629495981;6023.367546407564;6033.245844269466;6122.194700145116;6126.387361263838;6129.633877546871;6130.004390691762;6141.884937092248;5810.273715785527;5811.4479124483105;5823.82528524145;5825.563082768894;5837.124431335334;5767.3367562729145;5945.494632956247;5961.165436838933;5989.940100598938;6000.159977603052;5663.490285874291;5672.12082127271;5698.914516282342;5703.08750599902;5703.20155178267;5676.801311954062;5686.061799802987;5726.169705392612;5730.111832665943;5743.59794814359;5594.188842617879;5595.580331475075;5660.603757736919;5707.971460142673;5758.1362795581;5886.146508756121;5895.882082358243;5915.763369465173;5926.081457374114;5946.286445626552;5755.3381361144;5809.651420914759;5814.215080964185;5817.592768506164;5818.534517238526 22:18:03 INFO - PROCESS | 6409 | |1;ext.html;659.656978371247;670.570834665814;670.9432643586352;716.9818857222747;730.3755289227709;40012.19975600486;40028.59971400285;40416.19167616646;40467.988300292505;40730.38904416436;43266.567334326646;43501.34747978775;43715.78142109293;43785.56214437855;43792.24831006764;8704.216620504138;8857.95571022144;8875.556222188898;8878.422902511316;8884.777880553005;8675.08911564286;8729.869051964226;8732.956335218347;8761.080086590911;8766.6931657392;8931.151540603665;8949.910500895005;8953.910460895373;8983.505907175135;8986.326025548111;8880.73357799267;8953.6866209683;8971;8975.506347150904;8981.236594889377;8998.370114092017;9036.593353299117;9059.50172740499;9071.501067441288;9126.406783559047;43731.562684373064;43841.78079109584;43853.780731096456;44055.33916991248;44082.33876491855;3925.3130702127014;4006.4791577095084;4151.418801367811;4447.3773671685985;4577.015941572545;33112.50331245033;33151.502727459105;33187.50218746721;33383.49924751131;34603.826980864935;4535.692980711858;4551.476580193287;4620.722756634613;4626.514216007338;4699.412573428322;306795;307311;307745;310876;310929;62294.377056228856;62690.37309626846;62797;62904.685476572326;63221.367786322466;72163.6391818048;73438.63280683562;73535.63232183912;73858.6307068472;74043.25956740472;17369.65260694779;17384.217710203073;17427.912860435616;17453.38913138034;17486.562835929202;14206.573802785933;14268.714625707427;14394.496192633207;14394.856051439352;14425.927870360581;19985.400437986882;20306.593868122556;20427;20490.077946492445;21230.150793968376;7572.697092116364;7711.460197786213;7913.762587122395;8034.870759248804;8046.436749427484;1113.2207454781685;1146.1289420040662;1183.207251141737;1209.5947857467847;1239.2906953576373;32790.344193116005;33315;33836.49245261323;33875.15312117217;33958.49062264068;1198.1553005131361;1227.4967263421954;1261.5962891874697;1262.4634530324574;1310.8099325597734;17538.912305438647;17678.46964591064;17824.46526604204;17945.910270448563;18109.63780724378;494590;508784;559550;572710;924332;63953.68023159855;64992.67503662546;65000.674996624715;65126;65151.348486515475;1479.6153000219806;1555.3234343060806;1563.8123425188824;1574.5906064423104;1578.337098418667;34219.4867076989;34696.82651586726;34803.477947830295;34912.825435873674;35053.47419788756;56531.43468565262;56815;57234;57276.42723572878;57384.71307643435;461184;468954;469007;469255;469546;31646.208844779063;31843;31889.521657175625;32025;32165;51231;51293;51804;52159;52261.216081758044;43501.12734780764;44348.11303773971;44581;44903;45656;42711;42887.571124288355;42978.35532466953;43787.56212437962;44291.77854110709;43816.561834381246;44403.77798110989;44578.55421445744;45335.54664453445;45888.77055614701;37668.62331376651;38105.80947095247;38126.42810357791;38143;38628.6137138625;30180.396392072475;30284.69715302907;30802.845985769927;30879.845600771852;30966.380672385974 22:18:03 INFO - PROCESS | 6409 | |2;jquery.html;437.3046855499755;438.08338518979457;438.89247134452063;448.6410871302957;451.65222778460566;18748.812511874876;18750.53123671909;19335.709964350528;19650.312239071634;19783.208671653152;19228.42314730557;19468.318608848695;19623;20081.59836803263;20085.899570502163;5733.684647344395;5789.884202315951;5898.941010589882;5921.644701317935;5955.731992060346;5851.444112809277;5890.734916928727;5934.643921364732;5936.703164841762;5971.10433434986;5729.484346408823;5808.303003639569;5815.47660710536;5914.970425147868;5922.141289513018;5807.796727114552;5821.155932389822;5858.443447872488;5864.179014937912;5864.472197502245;5223.843284701465;5233.215017747369;5306.204069389584;5319.601029922771;5324.760385782649;23538.76461235383;23700.288991330286;23781.16765913202;24136.75863241363;24310.270691879272;2534.4677617700304;2557.0794513974956;2661.4011847334386;2853.743163115309;2991.5213565829363;14547.3453694584;15074.773878391832;15228.923855380763;15279.312430940634;15442.768358474632;2023.1098316740588;2031.492126968258;2051.7025031370367;2057.9382618521468;2102.9369118926456;74319;74642;79491;80482;82098;11123.555057797597;11364.261323013978;11655.650330490098;11776.764464710657;11841.171118021655;16399.91800041016;16462.259198336105;16483;16588.50234492967;16618.086005269826;9146.542672866462;9151.405158664666;9188.173064424234;9242.630294788267;9267.304952128618;8923.107689231025;8936.32977526688;8952.597133129026;9022.691709702056;9022.729318120468;6962.094927659372;7085.05664448843;7137.607431591208;7145.642717864086;7247.20280769115;2068.855180137406;2090;2121.628714974873;2121.7241758571286;2200.8129309008914;1060.6923992042375;1061.9575216991389;1094.3543309447464;1182.3201659046083;1204.349651188366;17511.299548018193;19259.711104333448;19656.410307690792;20013.799862001484;20074.698879516818;1099.923005389631;1128.1933417606288;1156.410230782307;1171.5723760827407;1180.451090243041;11333.26333788301;11582.131340149353;11600.6519804406;11670.824937625943;11730.472128754227;461000;505348.29089606256;509770;521626;525390;61525;70090.64954675194;72870.44953426605;79861.20138798654;84991;1121.2935850414349;1125.5779082843933;1131.7340425000118;1140.8060629692807;1148.3741360958297;17771.555711107325;17920.91039544846;18001.729974050137;18210.998395088398;18537.53656158607;35931.64068359283;36372.27255454929;36929.212957897646;37326.25347493089;38652;49294.50705493043;53981.730091349295;56644;56990.71504642616;57211.713941430025;9108.089191080839;9135.497547634945;9144.725658230263;9341.392809467363;9346.11211934865;13261.454990899518;14262.643433914234;14276.214808185234;14301;14505.637359066108;12316.630501084981;12376;12431.564895228623;12672.87327126717;12915.206517506995;11858.644240672793;12433.93783031079;12453.564125255572;12514.624561263177;12744.553940612033;12774.105812593401;12843.486260549473;12913.612591622266;12978.675533111747;13074.477020919438;8859.158379953895;9028.322875784212;9062.728118156467;9083.318751093826;9130.634774608941;9264.351495395258;12178.695532611755;12436.937815311227;12456;12618.369081545703 22:18:03 INFO - PROCESS | 6409 | |3;mootools.html;1493.7385957457445;1543.7993060902077;1756.5081777102416;1885.9339923102686;1926.479850440382;8406.705765298208;8462.830743385144;8561.272291855192;8607.69873054444;8647.870281945776;8544.829103417944;8615.267702245317;8622.051574326819;8659.350548708857;8680.522571258578;2394.5450364430703;2395.8562486250794;2395.8562486250794;2403;2415.7221919479307;2353.9411514712097;2399.2082612737754;2424.599941009731;2429.6234083716963;2437.512497500507;2329.5457385809773;2364.8226383021342;2382.4401265702545;2416.0698131219433;2421.8667973261463;2362.681038059866;2367.3844800351862;2373.905043798246;2380.10745970262;2381.368937231635;2311.248844125649;2312.2716344351643;2330.603797354454;2353.882305884699;2356.5051339218785;8641.913580864237;8642;8692.739217823475;8709.695160669346;8770.561471926441;5387.24578559002;5503.834884953458;5510.91733623996;5514.531264842493;5519.558435325164;3456.5160877477174;3483.425234836249;3512.1921957949558;3541.6812486876306;3550.0592343029116;1118.6140781430393;1167.2762887010024;1172.7361343697685;1192.0999645267768;1197.556903945537;12083.154179207459;12084.214526055779;12103.757924841453;12177.878221217763;12192.57325993586;4448.377227188196;4584.656150788637;4596.172688916027;4623.214053610895;4681.391419115494;9774.657886973922;9856.556454959544;9861.506924653739;9866.703998880044;9870.950645246729;5257.263983042377;5261.5264626183825;5270.841874743764;5285.709285989307;5293.735313234323;4271.807768650418;4794.400699912511;4826.348442960156;4834.95165048345;4906.90186196274;3880.8447662093763;3906.628870257378;3949.54580223278;3951.565327813938;4007.6793856491413;1176.329492189461;1212.0969877441187;1230.9507619695291;1236.505397840871;1256.7172386213028;1009.8081364540714;1011.1051719228388;1014.1177175856905;1021.3922715983978;1053.2732414633879;5979.760809567656;6038.698065096728;6050.818475445743;6057.787977420858;6064.75740970365;461.87529367070704;467.4460763994677;469.4319872953696;471.32835709114374;475.1352538380184;4220.831166753357;4229.281022226229;4232.851850185229;4240.851570195028;4280.636145927569;10221.386716797017;10675.145988320915;10681.145508359312;10691;10727.624533141303;10431.113355364727;10472.528736206888;10474.738131546772;10555.313904596176;10592.682219533426;7791.181925897926;8107.148749381348;8260.29787468072;8280.171982801672;8285.088640249567;5868.589198756046;5881.500072493886;5897.852553686193;5975.731092100779;6000.189974353581;9282.396644218104;9296.07039296065;9367.063293670852;9380.108889655472;9390.765230869283;9067.591958362022;9542.666006689733;9624.181944534794;9657.758556036155;9738.902610974083;7047.682854271673;7417.109946806202;7500.887486687813;7546.2831031051965;7654.464187507044;8244.093149753402;8246.3815213858;8250.46371985819;8250.46371985819;8251.2986396157;7290.453216008715;7385.261473852572;7451.813704657427;7514.8497030058;7623.847523049619;7239.239879812754;7278.563286202845;7360.595167265852;7388.778336649909;7415.8887616684715;7017.578945263301;7084.149902011792;7113.679884405111;7130.714771409085;7137.216485570528;5059.19052951526;5062.924056139087;5187.948120518747;5202.479752024768;5222.764975576184;5245.973770131125;5286.762095705625;5311.150215965427;5357.491038351351;5456.317960254968 22:18:03 INFO - PROCESS | 6409 | |4;prototype.html;354.66129845997074;358.60195183346497;366.0665303476136;368.7197729725408;372.78751111866234;6532.248791388992;6574.967125164373;6609.438197753191;6616.239132499764;6652.50106242032;6633.2703402625675;6677;6701.262861085277;6704.765333213339;6750.62871542065;5021.17150670139;5024.849254522352;5030.220315851049;5033.169527028036;5034.446210916796;5023.648344615878;5028.974855125719;5036.420811606676;5037.798488060474;5042.924356134661;4993.425756038066;4998.950010499903;5002.199648056312;5004.274380214867;5005.624578156635;4800.855974320776;4988.451270360258;5003.949960500385;5005.974970125162;5016.673916195454;4315.244832154392;4327.242732521796;4345.369921361416;4345.956540434619;4348.412964249817;6312.274088479838;6349.238091429012;6359.904601430982;6368.012957991518;6385.074164246204;5555.694436805974;5639.238702775114;5639.68981706006;5647.068233741427;5647.971760141214;6881.690323935435;6932.48006399517;6953.826154346182;6966.651667416609;6970.233274339818;4679.766011699401;4697.436307643071;4701.717896926195;4706.411698537683;4711.411073615798;7269.527480713737;7322.377597904185;7332.266773322678;7339.119305683299;7343.522671026366;4850.8787280317565;4912.877178070506;4921.704697718148;4935.407751069894;4941.431735350408;4973.278874563168;5005.974970125126;5009.148444764399;5011.824586139468;5014.047331007097;5796.1595568642315;5806.390329015477;5807.82576522705;5814.447627475383;5816.127580862904;6947.4789390795895;6965.82585435358;6985.441164706811;7006.089208402875;7040.92959070413;1744.1628018550912;1770.504258807536;1771.4331413947414;1774.6539424812295;1775.4673597920573;1076.6231818863334;1119.6864877834219;1149.270213414471;1152.2798251093068;1164.2839653613137;6748.122744043243;6898.793036208922;6931.861362772716;6943.132108486439;6948.131483564554;7281.526700764539;7288.416926645961;7353;7357;7369.6315184240575;6834.794956151323;6890.173179218526;6907.378335949688;6912.619805910623;6921.619310937846;3886.6502014818802;3891.7275790694944;3975.602439756059;3979.323515002399;3982.3230050891416;7635.618219089023;7682.078150621849;7693.346065584376;7699.307062364414;7716.807079823049;7410.703571857065;7460.328570428687;7466.775996720107;7486.95182674426;7492.288232617892;7615.124260709978;7623.580703061274;7678.462507624413;7682.347000505019;7690.00029996097;7064.894026589503;7285.162206346126;7304.96347518259;7325.890111648223;7364.742234021784;7157.57054576727;7157.928420715726;7229.240929702516;7233.132024157135;7243.058402407653;7686.538807671557;7689.3464055555905;7702.499337543042;7707.576083315472;7713.2286771322415;4837.516248375135;4888.657793954531;4889.144399730104;4893.926591101065;4899.755012249445;7097.25478824716;7352.11774587053;7363.116426028911;7364.631768411665;7391.40868730511;7104.715811367488;7136.286371362822;7161.176464706626;7162.964185179041;7177.425805935408;7074.009638650696;7086.50394472382;7091.751788687371;7100.218975912749;7107.82230444243;6846.281140480377;6872.037914691847;6903.620300883299;6905.309469053255;6917.515773895779;7000.404965577983;7160.498765086394;7174.1032370953635;7174.354308112295;7192.136943566806;6842.692078856364;7011.929880701127;7037.472189585904;7045.929540704527;7054.435645148478 22:18:03 INFO - PROCESS | 6409 | |5;yui.html;786.7797016835289;887.1261807119987;906.2478143141193;935.0415823780625;966.6036924860808;15029.098254104747;15216.39134434624;15280.312385942632;15291.388344466222;15316.004459710124;12138.332391718452;14292.714145717106;14340.282985850718;14357.784633230483;14427;892.4734406700062;915.702396721065;916.0335845682802;918.8392031394512;920.0293690156882;910.968116115936;918.1323649151554;918.3846822628855;918.4626993208981;920.8618707193907;934.4113208678523;941.472775245861;942.3591957468918;944.5371767833747;949.7388218240005;934.8036912248436;937.329809186435;938.6573900526326;941.8916824565194;944.1361154543619;696.495041095207;697.8325201951545;698.0715648187897;698.6681326369984;699.3391245273219;14988.400463981428;15028.474003409938;15046.774298385533;15068.698626027528;15100.640942315134;14869.553913382615;14884.10695358282;14893.851061489355;14974.326155322928;15010.924945375313;11361.375124368156;11582.942085289604;11629.534818607246;11659.125565582615;11782.764344713143;3988.3618621020787;4044.211378781139;4122.732022418533;4122.814473348706;4185.518665353493;53132.20301695478;53510.46489535094;53764.19353709697;53886.46113538893;54131.72934135304;11387.886121138683;11566.074714023027;11646.70883227926;11750.118741094451;11837.467313970892;19405.0297485128;19426.22295108208;19435.222591096197;19464.805351946583;19473.707894381594;8353.66585336592;8430.409871309072;8811.691590794291;8921.286297096216;9040.502772347583;4922.630802689812;5016.799328026838;5184.533391994739;5206.349206349207;5247.422783493813;3519.9824000880344;3550.875719349862;3557.5197348358156;3563.322968635951;3573.160307327776;667.1727058447588;667.3793372163934;673.7204060315013;675.6081472745796;682.3483573187693;786.1627366854282;795.208767276552;813.7965508622844;840.2899549880341;846.0650980666398;9690;9911.55398007077;10063.949680251551;10126.746831329276;10438.217133715001;679.2290749998787;778.6573907480804;807.1940799132003;841.3185319890786;848.84296405164;4646.883827904329;4718.622510199176;4748.216544270226;4751.168545504592;4762.738049407247;61098.694506528074;61129.38870611326;61457.692711536154;64381.356186438476;64634.35365646283;50078.749606252466;50508.49491505112;50771.74614126905;50930.23604645933;54962;50139.24791128136;50507.24239136416;50647.746761266695;51082.489175107774;51670.74164629228;10060.0945914868;10306.742331441774;10306.845397318897;10451.268411211142;10558.947205263925;35482.29035419329;36460.088497787765;36633.63366366409;36825;37454.81272593619;42969.785151074044;43759;46405.07189856117;46630.53369466262;46792;12465.626031219077;12512.937435312766;12537.185082969578;12735.617931462071;12753.872461275269;13557.25435101079;13950;14149.929250353682;14262.57212283633;14419.567412977627;13211.669708256986;13421.328933553088;13485.460581576626;13597.52408665692;13617.86382136166;13015.219086854819;13063.934680326538;13434.798478023033;13609.727805444034;14201.573952781433;12257.325847078497;12531.248125112523;12687.804708003163;12750.42623081945;12835.229886206858;11267.830982535104;11469.942650287028;11593.6521904343;11658.300501969909;11757.588484403004;10806.35161890289;11423.771524569629;11638.41807909618;11745.706357341134;11814 22:18:03 INFO - PROCESS | 6409 | __end_tp_report 22:18:03 INFO - PROCESS | 6409 | __start_cc_report 22:18:03 INFO - PROCESS | 6409 | _x_x_mozilla_cycle_collect,337 22:18:03 INFO - PROCESS | 6409 | __end_cc_report 22:18:03 INFO - PROCESS | 6409 | __startTimestamp1463721483439__endTimestamp 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | ------- Summary: start ------- 22:18:03 INFO - PROCESS | 6409 | Number of tests: 6 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | [#0] dojo.html Cycles:165 Average:5526.34 Median:5707.97 stddev:622.07 (10.9%) stddev-sans-first:598.96 22:18:03 INFO - PROCESS | 6409 | Values: 3299.9 3303.2 3332.7 3387.0 3395.7 5563.6 5583.9 5602.5 5620.2 5636.5 5546.2 5613.6 5614.7 5621.6 5622.2 5052.9 5097.4 5115.8 5141.7 5148.3 5028.2 5053.9 5203.4 5216.2 5261.6 4954.0 5005.9 5011.9 5082.4 5089.6 5089.3 5091.1 5105.1 5118.7 5148.4 4903.4 4986.1 5019.8 5034.0 5070.9 5432.6 5442.6 5449.1 5514.7 5539.4 5971.3 5983.6 6007.0 6007.4 6012.0 5725.8 5906.1 5993.6 6045.8 6058.1 5441.4 5488.6 5515.4 5519.3 5519.3 6027.1 6032.2 6037.6 6043.6 6052.6 5810.4 5822.2 5866.6 5874.3 5919.0 6017.0 6049.8 6059.1 6065.5 6071.7 5810.0 5960.8 6007.5 6035.2 6036.5 5820.3 5900.2 5900.8 5921.3 5934.1 4458.5 4508.0 4520.4 4541.2 4550.7 3996.5 4021.2 4074.7 4085.6 4118.8 5502.4 5514.0 5771.5 5813.1 5848.5 5876.6 5927.3 5956.3 5965.6 5990.3 5610.8 5689.8 5690.8 5697.7 5701.5 4853.6 4892.5 4900.5 4922.4 4931.1 6194.1 6208.6 6239.4 6250.6 6256.9 5922.9 6016.5 6019.6 6023.4 6033.2 6122.2 6126.4 6129.6 6130.0 6141.9 5810.3 5811.4 5823.8 5825.6 5837.1 5767.3 5945.5 5961.2 5989.9 6000.2 5663.5 5672.1 5698.9 5703.1 5703.2 5676.8 5686.1 5726.2 5730.1 5743.6 5594.2 5595.6 5660.6 5708.0 5758.1 5886.1 5895.9 5915.8 5926.1 5946.3 5755.3 5809.7 5814.2 5817.6 5818.5 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | [#1] ext.html Cycles:180 Average:63809.91 Median:43847.78 stddev:130169.23 (296.9%) stddev-sans-first:130448.04 22:18:03 INFO - PROCESS | 6409 | Values: 659.7 670.6 670.9 717.0 730.4 40012.2 40028.6 40416.2 40468.0 40730.4 43266.6 43501.3 43715.8 43785.6 43792.2 8704.2 8858.0 8875.6 8878.4 8884.8 8675.1 8729.9 8733.0 8761.1 8766.7 8931.2 8949.9 8953.9 8983.5 8986.3 8880.7 8953.7 8971.0 8975.5 8981.2 8998.4 9036.6 9059.5 9071.5 9126.4 43731.6 43841.8 43853.8 44055.3 44082.3 3925.3 4006.5 4151.4 4447.4 4577.0 33112.5 33151.5 33187.5 33383.5 34603.8 4535.7 4551.5 4620.7 4626.5 4699.4 306795.0 307311.0 307745.0 310876.0 310929.0 62294.4 62690.4 62797.0 62904.7 63221.4 72163.6 73438.6 73535.6 73858.6 74043.3 17369.7 17384.2 17427.9 17453.4 17486.6 14206.6 14268.7 14394.5 14394.9 14425.9 19985.4 20306.6 20427.0 20490.1 21230.2 7572.7 7711.5 7913.8 8034.9 8046.4 1113.2 1146.1 1183.2 1209.6 1239.3 32790.3 33315.0 33836.5 33875.2 33958.5 1198.2 1227.5 1261.6 1262.5 1310.8 17538.9 17678.5 17824.5 17945.9 18109.6 494590.0 508784.0 559550.0 572710.0 924332.0 63953.7 64992.7 65000.7 65126.0 65151.3 1479.6 1555.3 1563.8 1574.6 1578.3 34219.5 34696.8 34803.5 34912.8 35053.5 56531.4 56815.0 57234.0 57276.4 57384.7 461184.0 468954.0 469007.0 469255.0 469546.0 31646.2 31843.0 31889.5 32025.0 32165.0 51231.0 51293.0 51804.0 52159.0 52261.2 43501.1 44348.1 44581.0 44903.0 45656.0 42711.0 42887.6 42978.4 43787.6 44291.8 43816.6 44403.8 44578.6 45335.5 45888.8 37668.6 38105.8 38126.4 38143.0 38628.6 30180.4 30284.7 30802.8 30879.8 30966.4 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | [#2] jquery.html Cycles:180 Average:29176.38 Median:23740.73 stddev:82684.48 (348.3%) stddev-sans-first:82888.27 22:18:03 INFO - PROCESS | 6409 | Values: 437.3 438.1 438.9 448.6 451.7 18748.8 18750.5 19335.7 19650.3 19783.2 19228.4 19468.3 19623.0 20081.6 20085.9 5733.7 5789.9 5898.9 5921.6 5955.7 5851.4 5890.7 5934.6 5936.7 5971.1 5729.5 5808.3 5815.5 5915.0 5922.1 5807.8 5821.2 5858.4 5864.2 5864.5 5223.8 5233.2 5306.2 5319.6 5324.8 23538.8 23700.3 23781.2 24136.8 24310.3 2534.5 2557.1 2661.4 2853.7 2991.5 14547.3 15074.8 15228.9 15279.3 15442.8 2023.1 2031.5 2051.7 2057.9 2102.9 74319.0 74642.0 79491.0 80482.0 82098.0 11123.6 11364.3 11655.7 11776.8 11841.2 16399.9 16462.3 16483.0 16588.5 16618.1 9146.5 9151.4 9188.2 9242.6 9267.3 8923.1 8936.3 8952.6 9022.7 9022.7 6962.1 7085.1 7137.6 7145.6 7247.2 2068.9 2090.0 2121.6 2121.7 2200.8 1060.7 1062.0 1094.4 1182.3 1204.3 17511.3 19259.7 19656.4 20013.8 20074.7 1099.9 1128.2 1156.4 1171.6 1180.5 11333.3 11582.1 11600.7 11670.8 11730.5 461000.0 505348.3 509770.0 521626.0 525390.0 61525.0 70090.6 72870.4 79861.2 84991.0 1121.3 1125.6 1131.7 1140.8 1148.4 17771.6 17920.9 18001.7 18211.0 18537.5 35931.6 36372.3 36929.2 37326.3 38652.0 49294.5 53981.7 56644.0 56990.7 57211.7 9108.1 9135.5 9144.7 9341.4 9346.1 13261.5 14262.6 14276.2 14301.0 14505.6 12316.6 12376.0 12431.6 12672.9 12915.2 11858.6 12433.9 12453.6 12514.6 12744.6 12774.1 12843.5 12913.6 12978.7 13074.5 8859.2 9028.3 9062.7 9083.3 9130.6 9264.4 12178.7 12436.9 12456.0 12618.4 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | [#3] mootools.html Cycles:180 Average:5700.65 Median:5061.06 stddev:3155.20 (62.3%) stddev-sans-first:3148.21 22:18:03 INFO - PROCESS | 6409 | Values: 1493.7 1543.8 1756.5 1885.9 1926.5 8406.7 8462.8 8561.3 8607.7 8647.9 8544.8 8615.3 8622.1 8659.4 8680.5 2394.5 2395.9 2395.9 2403.0 2415.7 2353.9 2399.2 2424.6 2429.6 2437.5 2329.5 2364.8 2382.4 2416.1 2421.9 2362.7 2367.4 2373.9 2380.1 2381.4 2311.2 2312.3 2330.6 2353.9 2356.5 8641.9 8642.0 8692.7 8709.7 8770.6 5387.2 5503.8 5510.9 5514.5 5519.6 3456.5 3483.4 3512.2 3541.7 3550.1 1118.6 1167.3 1172.7 1192.1 1197.6 12083.2 12084.2 12103.8 12177.9 12192.6 4448.4 4584.7 4596.2 4623.2 4681.4 9774.7 9856.6 9861.5 9866.7 9871.0 5257.3 5261.5 5270.8 5285.7 5293.7 4271.8 4794.4 4826.3 4835.0 4906.9 3880.8 3906.6 3949.5 3951.6 4007.7 1176.3 1212.1 1231.0 1236.5 1256.7 1009.8 1011.1 1014.1 1021.4 1053.3 5979.8 6038.7 6050.8 6057.8 6064.8 461.9 467.4 469.4 471.3 475.1 4220.8 4229.3 4232.9 4240.9 4280.6 10221.4 10675.1 10681.1 10691.0 10727.6 10431.1 10472.5 10474.7 10555.3 10592.7 7791.2 8107.1 8260.3 8280.2 8285.1 5868.6 5881.5 5897.9 5975.7 6000.2 9282.4 9296.1 9367.1 9380.1 9390.8 9067.6 9542.7 9624.2 9657.8 9738.9 7047.7 7417.1 7500.9 7546.3 7654.5 8244.1 8246.4 8250.5 8250.5 8251.3 7290.5 7385.3 7451.8 7514.8 7623.8 7239.2 7278.6 7360.6 7388.8 7415.9 7017.6 7084.1 7113.7 7130.7 7137.2 5059.2 5062.9 5187.9 5202.5 5222.8 5246.0 5286.8 5311.2 5357.5 5456.3 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | [#4] prototype.html Cycles:180 Average:5891.02 Median:6792.71 stddev:1817.06 (26.8%) stddev-sans-first:1774.00 22:18:03 INFO - PROCESS | 6409 | Values: 354.7 358.6 366.1 368.7 372.8 6532.2 6575.0 6609.4 6616.2 6652.5 6633.3 6677.0 6701.3 6704.8 6750.6 5021.2 5024.8 5030.2 5033.2 5034.4 5023.6 5029.0 5036.4 5037.8 5042.9 4993.4 4999.0 5002.2 5004.3 5005.6 4800.9 4988.5 5003.9 5006.0 5016.7 4315.2 4327.2 4345.4 4346.0 4348.4 6312.3 6349.2 6359.9 6368.0 6385.1 5555.7 5639.2 5639.7 5647.1 5648.0 6881.7 6932.5 6953.8 6966.7 6970.2 4679.8 4697.4 4701.7 4706.4 4711.4 7269.5 7322.4 7332.3 7339.1 7343.5 4850.9 4912.9 4921.7 4935.4 4941.4 4973.3 5006.0 5009.1 5011.8 5014.0 5796.2 5806.4 5807.8 5814.4 5816.1 6947.5 6965.8 6985.4 7006.1 7040.9 1744.2 1770.5 1771.4 1774.7 1775.5 1076.6 1119.7 1149.3 1152.3 1164.3 6748.1 6898.8 6931.9 6943.1 6948.1 7281.5 7288.4 7353.0 7357.0 7369.6 6834.8 6890.2 6907.4 6912.6 6921.6 3886.7 3891.7 3975.6 3979.3 3982.3 7635.6 7682.1 7693.3 7699.3 7716.8 7410.7 7460.3 7466.8 7487.0 7492.3 7615.1 7623.6 7678.5 7682.3 7690.0 7064.9 7285.2 7305.0 7325.9 7364.7 7157.6 7157.9 7229.2 7233.1 7243.1 7686.5 7689.3 7702.5 7707.6 7713.2 4837.5 4888.7 4889.1 4893.9 4899.8 7097.3 7352.1 7363.1 7364.6 7391.4 7104.7 7136.3 7161.2 7163.0 7177.4 7074.0 7086.5 7091.8 7100.2 7107.8 6846.3 6872.0 6903.6 6905.3 6917.5 7000.4 7160.5 7174.1 7174.4 7192.1 6842.7 7011.9 7037.5 7045.9 7054.4 22:18:03 INFO - PROCESS | 6409 | 22:18:03 INFO - PROCESS | 6409 | [#5] yui.html Cycles:180 Average:15154.91 Median:4122.77 stddev:16870.84 (409.2%) stddev-sans-first:16883.66 22:18:03 INFO - PROCESS | 6409 | Values: 786.8 887.1 906.2 935.0 966.6 15029.1 15216.4 15280.3 15291.4 15316.0 12138.3 14292.7 14340.3 14357.8 14427.0 892.5 915.7 916.0 918.8 920.0 911.0 918.1 918.4 918.5 920.9 934.4 941.5 942.4 944.5 949.7 934.8 937.3 938.7 941.9 944.1 696.5 697.8 698.1 698.7 699.3 14988.4 15028.5 15046.8 15068.7 15100.6 14869.6 14884.1 14893.9 14974.3 15010.9 11361.4 11582.9 11629.5 11659.1 11782.8 3988.4 4044.2 4122.7 4122.8 4185.5 53132.2 53510.5 53764.2 53886.5 54131.7 11387.9 11566.1 11646.7 11750.1 11837.5 19405.0 19426.2 19435.2 19464.8 19473.7 8353.7 8430.4 8811.7 8921.3 9040.5 4922.6 5016.8 5184.5 5206.3 5247.4 3520.0 3550.9 3557.5 3563.3 3573.2 667.2 667.4 673.7 675.6 682.3 786.2 795.2 813.8 840.3 846.1 9690.0 9911.6 10063.9 10126.7 10438.2 679.2 778.7 807.2 841.3 848.8 4646.9 4718.6 4748.2 4751.2 4762.7 61098.7 61129.4 61457.7 64381.4 64634.4 50078.7 50508.5 50771.7 50930.2 54962.0 50139.2 50507.2 50647.7 51082.5 51670.7 10060.1 10306.7 10306.8 10451.3 10558.9 35482.3 36460.1 36633.6 36825.0 37454.8 42969.8 43759.0 46405.1 46630.5 46792.0 12465.6 12512.9 12537.2 12735.6 12753.9 13557.3 13950.0 14149.9 14262.6 14419.6 13211.7 13421.3 13485.5 13597.5 13617.9 13015.2 13063.9 13434.8 13609.7 14201.6 12257.3 12531.2 12687.8 12750.4 12835.2 11267.8 11469.9 11593.7 11658.3 11757.6 10806.4 11423.8 11638.4 11745.7 11814.0 22:18:03 INFO - PROCESS | 6409 | -------- Summary: end -------- 22:18:03 INFO - PROCESS | 6409 | 22:18:04 INFO - TEST-INFO | 6409: exit 0 22:18:04 INFO - TEST-OK | dromaeo_css | took 1108198ms 22:18:04 INFO - TEST-START | kraken 22:18:04 INFO - operating with platform_type : linux_ 22:18:04 INFO - Initialising browser for kraken test... 22:18:04 INFO - TEST-INFO | started process 6659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQkLvM/profile http://localhost:41781/getInfo.html) 22:18:07 INFO - PROCESS | 6659 | 22:18:07 INFO - PROCESS | 6659 | (process:6737): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:18:08 INFO - PROCESS | 6659 | __metrics Screen width/height:1600/1200 22:18:08 INFO - PROCESS | 6659 | colorDepth:24 22:18:08 INFO - PROCESS | 6659 | Browser inner width/height: 1024/697 22:18:08 INFO - PROCESS | 6659 | __metrics 22:18:08 ERROR - PROCESS | 6659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 22:18:09 INFO - TEST-INFO | 6659: exit 0 22:18:09 INFO - Browser initialized. 22:18:09 INFO - Running cycle 1/1 for kraken test... 22:18:09 INFO - TEST-INFO | started process 6788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQkLvM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:11 INFO - PROCESS | 6788 | 22:18:11 INFO - PROCESS | 6788 | (process:6857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:18:21 INFO - PROCESS | 6788 | RSS: Main: 152129536 22:18:21 INFO - PROCESS | 6788 | 22:18:23 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41781/tests/kraken/driver.html?testName=audio-beat-detection) 22:18:24 INFO - PROCESS | 6788 | RSS: Main: 157024256 22:18:24 INFO - PROCESS | 6788 | 22:18:27 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41781/tests/kraken/driver.html?testName=audio-dft) 22:18:27 INFO - PROCESS | 6788 | RSS: Main: 157073408 22:18:27 INFO - PROCESS | 6788 | 22:18:30 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41781/tests/kraken/driver.html?testName=audio-fft) 22:18:31 INFO - PROCESS | 6788 | RSS: Main: 157245440 22:18:31 INFO - PROCESS | 6788 | 22:18:33 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41781/tests/kraken/driver.html?testName=audio-oscillator) 22:18:34 INFO - PROCESS | 6788 | RSS: Main: 157229056 22:18:34 INFO - PROCESS | 6788 | 22:18:36 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41781/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:18:36 INFO - PROCESS | 6788 | RSS: Main: 157130752 22:18:36 INFO - PROCESS | 6788 | 22:18:39 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41781/tests/kraken/driver.html?testName=imaging-darkroom) 22:18:40 INFO - PROCESS | 6788 | RSS: Main: 157147136 22:18:40 INFO - PROCESS | 6788 | 22:18:43 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41781/tests/kraken/driver.html?testName=imaging-desaturate) 22:18:44 INFO - PROCESS | 6788 | RSS: Main: 157253632 22:18:44 INFO - PROCESS | 6788 | 22:18:47 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41781/tests/kraken/driver.html?testName=json-parse-financial) 22:18:47 INFO - PROCESS | 6788 | RSS: Main: 157323264 22:18:47 INFO - PROCESS | 6788 | 22:18:49 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41781/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:18:50 INFO - PROCESS | 6788 | RSS: Main: 157339648 22:18:50 INFO - PROCESS | 6788 | 22:18:51 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:18:52 INFO - PROCESS | 6788 | RSS: Main: 157405184 22:18:52 INFO - PROCESS | 6788 | 22:18:54 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:18:55 INFO - PROCESS | 6788 | RSS: Main: 158150656 22:18:55 INFO - PROCESS | 6788 | 22:18:57 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:18:58 INFO - PROCESS | 6788 | RSS: Main: 158117888 22:18:58 INFO - PROCESS | 6788 | 22:19:00 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:01 INFO - PROCESS | 6788 | RSS: Main: 157921280 22:19:01 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | Cycle 1(1): loaded http://localhost:41781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41781/tests/kraken/driver.html?testName=ai-astar) 22:19:03 INFO - PROCESS | 6788 | RSS: Main: 159354880 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | __start_tp_report 22:19:03 INFO - PROCESS | 6788 | _x_x_mozilla_page_load 22:19:03 INFO - PROCESS | 6788 | _x_x_mozilla_page_load_details 22:19:03 INFO - PROCESS | 6788 | |i|pagename|runs| 22:19:03 INFO - PROCESS | 6788 | |0;ai-astar;110;113;103;111;112;111;104;113;112;111 22:19:03 INFO - PROCESS | 6788 | |1;audio-beat-detection;149;135;153;180;128;154;154;127;205;129 22:19:03 INFO - PROCESS | 6788 | |2;audio-dft;163;164;162;161;161;162;161;161;160;160 22:19:03 INFO - PROCESS | 6788 | |3;audio-fft;75;76;73;179;76;75;75;75;171;76 22:19:03 INFO - PROCESS | 6788 | |4;audio-oscillator;92;92;160;93;93;92;151;93;92;147 22:19:03 INFO - PROCESS | 6788 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 22:19:03 INFO - PROCESS | 6788 | |6;imaging-darkroom;147;147;146;147;145;147;146;147;146;146 22:19:03 INFO - PROCESS | 6788 | |7;imaging-desaturate;95;95;95;96;99;95;100;95;95;95 22:19:03 INFO - PROCESS | 6788 | |8;json-parse-financial;56;58;57;56;56;57;57;80;56;58 22:19:03 INFO - PROCESS | 6788 | |9;json-stringify-tinderbox;60;60;60;60;60;60;61;60;59;59 22:19:03 INFO - PROCESS | 6788 | |10;stanford-crypto-aes;81;74;75;73;81;74;76;76;74;75 22:19:03 INFO - PROCESS | 6788 | |11;stanford-crypto-ccm;114;116;115;112;115;114;115;114;127;129 22:19:03 INFO - PROCESS | 6788 | |12;stanford-crypto-pbkdf2;162;163;169;168;162;163;171;161;160;158 22:19:03 INFO - PROCESS | 6788 | |13;stanford-crypto-sha256-iterative;69;68;72;69;68;67;69;71;69;69 22:19:03 INFO - PROCESS | 6788 | __end_tp_report 22:19:03 INFO - PROCESS | 6788 | __start_cc_report 22:19:03 INFO - PROCESS | 6788 | _x_x_mozilla_cycle_collect,824 22:19:03 INFO - PROCESS | 6788 | __end_cc_report 22:19:03 INFO - PROCESS | 6788 | __startTimestamp1463721543432__endTimestamp 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | ------- Summary: start ------- 22:19:03 INFO - PROCESS | 6788 | Number of tests: 14 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.56 (3.2%) stddev-sans-first:3.77 22:19:03 INFO - PROCESS | 6788 | Values: 110.0 113.0 103.0 111.0 112.0 111.0 104.0 113.0 112.0 111.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:153.50 stddev:25.00 (16.3%) stddev-sans-first:26.50 22:19:03 INFO - PROCESS | 6788 | Values: 149.0 135.0 153.0 180.0 128.0 154.0 154.0 127.0 205.0 129.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.22 22:19:03 INFO - PROCESS | 6788 | Values: 163.0 164.0 162.0 161.0 161.0 162.0 161.0 161.0 160.0 160.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:42.16 (56.2%) stddev-sans-first:44.09 22:19:03 INFO - PROCESS | 6788 | Values: 75.0 76.0 73.0 179.0 76.0 75.0 75.0 75.0 171.0 76.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:29.27 (31.8%) stddev-sans-first:30.27 22:19:03 INFO - PROCESS | 6788 | Values: 92.0 92.0 160.0 93.0 93.0 92.0 151.0 93.0 92.0 147.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 22:19:03 INFO - PROCESS | 6788 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 22:19:03 INFO - PROCESS | 6788 | Values: 147.0 147.0 146.0 147.0 145.0 147.0 146.0 147.0 146.0 146.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:1.89 (2.0%) stddev-sans-first:1.96 22:19:03 INFO - PROCESS | 6788 | Values: 95.0 95.0 95.0 96.0 99.0 95.0 100.0 95.0 95.0 95.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:57.00 stddev:7.39 (13.0%) stddev-sans-first:7.75 22:19:03 INFO - PROCESS | 6788 | Values: 56.0 58.0 57.0 56.0 56.0 57.0 57.0 80.0 56.0 58.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:19:03 INFO - PROCESS | 6788 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 59.0 59.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.85 (3.8%) stddev-sans-first:2.35 22:19:03 INFO - PROCESS | 6788 | Values: 81.0 74.0 75.0 73.0 81.0 74.0 76.0 76.0 74.0 75.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:115.00 stddev:5.86 (5.1%) stddev-sans-first:6.11 22:19:03 INFO - PROCESS | 6788 | Values: 114.0 116.0 115.0 112.0 115.0 114.0 115.0 114.0 127.0 129.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.00 stddev:4.22 (2.6%) stddev-sans-first:4.43 22:19:03 INFO - PROCESS | 6788 | Values: 162.0 163.0 169.0 168.0 162.0 163.0 171.0 161.0 160.0 158.0 22:19:03 INFO - PROCESS | 6788 | 22:19:03 INFO - PROCESS | 6788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.54 22:19:03 INFO - PROCESS | 6788 | Values: 69.0 68.0 72.0 69.0 68.0 67.0 69.0 71.0 69.0 69.0 22:19:03 INFO - PROCESS | 6788 | -------- Summary: end -------- 22:19:03 INFO - PROCESS | 6788 | 22:19:04 INFO - TEST-INFO | 6788: exit 0 22:19:04 INFO - TEST-OK | kraken | took 60214ms 22:19:04 INFO - SUITE-END | took 1168s 22:19:04 INFO - Completed test suite (00:19:28) 22:19:04 INFO - javascript benchmark 22:19:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.901002969911, 3303.223742420531, 3332.6500717424683, 3387.0008347537473, 3395.7113645340146, 5563.582731295154, 5583.8604034899145, 5602.495775380215, 5620.213170156181, 5636.549076073909, 5546.195801608765, 5613.607047506676, 5614.66312021279, 5621.606487545873, 5622.156676498527, 5052.949470505285, 5097.388313402397, 5115.846524604268, 5141.717205553693, 5148.304978827867, 5028.195488721805, 5053.949460505403, 5203.4016088149965, 5216.165413533835, 5261.605379596526, 4953.9504604953845, 5005.899882002376, 5011.924821127686, 5082.4155222149375, 5089.592832573385, 5089.287499750019, 5091.05815424144, 5105.081085404644, 5118.744062796845, 5148.433672296044, 4903.362562866804, 4986.07757564848, 5019.774110165052, 5034.0, 5070.898582028376, 5432.565394768409, 5442.564594832404, 5449.128139497661, 5514.724263786835, 5539.418361072069, 5971.253593300838, 5983.6110652807865, 6007.0, 6007.399260074001, 6012.038073908154, 5725.799597014085, 5906.055031195031, 5993.550483713739, 6045.848853778647, 6058.1215723719815, 5441.401445840955, 5488.588355873326, 5515.448455154493, 5519.254900588449, 5519.2824932758485, 6027.126066720301, 6032.215811944419, 6037.607555508966, 6043.637381757108, 6052.636841789506, 5810.360860305363, 5822.184894114827, 5866.560007999332, 5874.265716785402, 5919.023361145449, 6017.0, 6049.758009679564, 6059.0608455689435, 6065.5450841187085, 6071.726772295257, 5809.9832529307205, 5960.821175364746, 6007.459328660441, 6035.215421995113, 6036.547258955508, 5820.330661973842, 5900.1739756434135, 5900.822975310747, 5921.348651648315, 5934.080217566284, 4458.464984201916, 4507.954920450819, 4520.434945631796, 4541.205289074464, 4550.726956382628, 3996.540397854226, 4021.195760847842, 4074.735142215806, 4085.571015043437, 4118.773467459258, 5502.394736578973, 5514.035043867307, 5771.451712087345, 5813.069908814569, 5848.473637372657, 5876.618019828783, 5927.31835838884, 5956.255468066492, 5965.582409231399, 5990.251218597676, 5610.831675049755, 5689.800856969986, 5690.800821971211, 5697.715114244271, 5701.486866182064, 4853.635977301717, 4892.461829198785, 4900.534449227318, 4922.409310882717, 4931.063098011438, 6194.132821405007, 6208.565400421927, 6239.376062393724, 6250.593711408744, 6256.937430625727, 5922.881542369215, 6016.488598469179, 6019.578629495981, 6023.367546407564, 6033.245844269466, 6122.194700145116, 6126.387361263838, 6129.633877546871, 6130.004390691762, 6141.884937092248, 5810.273715785527, 5811.4479124483105, 5823.82528524145, 5825.563082768894, 5837.124431335334, 5767.3367562729145, 5945.494632956247, 5961.165436838933, 5989.940100598938, 6000.159977603052, 5663.490285874291, 5672.12082127271, 5698.914516282342, 5703.08750599902, 5703.20155178267, 5676.801311954062, 5686.061799802987, 5726.169705392612, 5730.111832665943, 5743.59794814359, 5594.188842617879, 5595.580331475075, 5660.603757736919, 5707.971460142673, 5758.1362795581, 5886.146508756121, 5895.882082358243, 5915.763369465173, 5926.081457374114, 5946.286445626552, 5755.3381361144, 5809.651420914759, 5814.215080964185, 5817.592768506164, 5818.534517238526], "value": 5485.549334624713, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.656978371247, 670.570834665814, 670.9432643586352, 716.9818857222747, 730.3755289227709, 40012.19975600486, 40028.59971400285, 40416.19167616646, 40467.988300292505, 40730.38904416436, 43266.567334326646, 43501.34747978775, 43715.78142109293, 43785.56214437855, 43792.24831006764, 8704.216620504138, 8857.95571022144, 8875.556222188898, 8878.422902511316, 8884.777880553005, 8675.08911564286, 8729.869051964226, 8732.956335218347, 8761.080086590911, 8766.6931657392, 8931.151540603665, 8949.910500895005, 8953.910460895373, 8983.505907175135, 8986.326025548111, 8880.73357799267, 8953.6866209683, 8971.0, 8975.506347150904, 8981.236594889377, 8998.370114092017, 9036.593353299117, 9059.50172740499, 9071.501067441288, 9126.406783559047, 43731.562684373064, 43841.78079109584, 43853.780731096456, 44055.33916991248, 44082.33876491855, 3925.3130702127014, 4006.4791577095084, 4151.418801367811, 4447.3773671685985, 4577.015941572545, 33112.50331245033, 33151.502727459105, 33187.50218746721, 33383.49924751131, 34603.826980864935, 4535.692980711858, 4551.476580193287, 4620.722756634613, 4626.514216007338, 4699.412573428322, 306795.0, 307311.0, 307745.0, 310876.0, 310929.0, 62294.377056228856, 62690.37309626846, 62797.0, 62904.685476572326, 63221.367786322466, 72163.6391818048, 73438.63280683562, 73535.63232183912, 73858.6307068472, 74043.25956740472, 17369.65260694779, 17384.217710203073, 17427.912860435616, 17453.38913138034, 17486.562835929202, 14206.573802785933, 14268.714625707427, 14394.496192633207, 14394.856051439352, 14425.927870360581, 19985.400437986882, 20306.593868122556, 20427.0, 20490.077946492445, 21230.150793968376, 7572.697092116364, 7711.460197786213, 7913.762587122395, 8034.870759248804, 8046.436749427484, 1113.2207454781685, 1146.1289420040662, 1183.207251141737, 1209.5947857467847, 1239.2906953576373, 32790.344193116005, 33315.0, 33836.49245261323, 33875.15312117217, 33958.49062264068, 1198.1553005131361, 1227.4967263421954, 1261.5962891874697, 1262.4634530324574, 1310.8099325597734, 17538.912305438647, 17678.46964591064, 17824.46526604204, 17945.910270448563, 18109.63780724378, 494590.0, 508784.0, 559550.0, 572710.0, 924332.0, 63953.68023159855, 64992.67503662546, 65000.674996624715, 65126.0, 65151.348486515475, 1479.6153000219806, 1555.3234343060806, 1563.8123425188824, 1574.5906064423104, 1578.337098418667, 34219.4867076989, 34696.82651586726, 34803.477947830295, 34912.825435873674, 35053.47419788756, 56531.43468565262, 56815.0, 57234.0, 57276.42723572878, 57384.71307643435, 461184.0, 468954.0, 469007.0, 469255.0, 469546.0, 31646.208844779063, 31843.0, 31889.521657175625, 32025.0, 32165.0, 51231.0, 51293.0, 51804.0, 52159.0, 52261.216081758044, 43501.12734780764, 44348.11303773971, 44581.0, 44903.0, 45656.0, 42711.0, 42887.571124288355, 42978.35532466953, 43787.56212437962, 44291.77854110709, 43816.561834381246, 44403.77798110989, 44578.55421445744, 45335.54664453445, 45888.77055614701, 37668.62331376651, 38105.80947095247, 38126.42810357791, 38143.0, 38628.6137138625, 30180.396392072475, 30284.69715302907, 30802.845985769927, 30879.845600771852, 30966.380672385974], "value": 21506.60324786879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.3046855499755, 438.08338518979457, 438.89247134452063, 448.6410871302957, 451.65222778460566, 18748.812511874876, 18750.53123671909, 19335.709964350528, 19650.312239071634, 19783.208671653152, 19228.42314730557, 19468.318608848695, 19623.0, 20081.59836803263, 20085.899570502163, 5733.684647344395, 5789.884202315951, 5898.941010589882, 5921.644701317935, 5955.731992060346, 5851.444112809277, 5890.734916928727, 5934.643921364732, 5936.703164841762, 5971.10433434986, 5729.484346408823, 5808.303003639569, 5815.47660710536, 5914.970425147868, 5922.141289513018, 5807.796727114552, 5821.155932389822, 5858.443447872488, 5864.179014937912, 5864.472197502245, 5223.843284701465, 5233.215017747369, 5306.204069389584, 5319.601029922771, 5324.760385782649, 23538.76461235383, 23700.288991330286, 23781.16765913202, 24136.75863241363, 24310.270691879272, 2534.4677617700304, 2557.0794513974956, 2661.4011847334386, 2853.743163115309, 2991.5213565829363, 14547.3453694584, 15074.773878391832, 15228.923855380763, 15279.312430940634, 15442.768358474632, 2023.1098316740588, 2031.492126968258, 2051.7025031370367, 2057.9382618521468, 2102.9369118926456, 74319.0, 74642.0, 79491.0, 80482.0, 82098.0, 11123.555057797597, 11364.261323013978, 11655.650330490098, 11776.764464710657, 11841.171118021655, 16399.91800041016, 16462.259198336105, 16483.0, 16588.50234492967, 16618.086005269826, 9146.542672866462, 9151.405158664666, 9188.173064424234, 9242.630294788267, 9267.304952128618, 8923.107689231025, 8936.32977526688, 8952.597133129026, 9022.691709702056, 9022.729318120468, 6962.094927659372, 7085.05664448843, 7137.607431591208, 7145.642717864086, 7247.20280769115, 2068.855180137406, 2090.0, 2121.628714974873, 2121.7241758571286, 2200.8129309008914, 1060.6923992042375, 1061.9575216991389, 1094.3543309447464, 1182.3201659046083, 1204.349651188366, 17511.299548018193, 19259.711104333448, 19656.410307690792, 20013.799862001484, 20074.698879516818, 1099.923005389631, 1128.1933417606288, 1156.410230782307, 1171.5723760827407, 1180.451090243041, 11333.26333788301, 11582.131340149353, 11600.6519804406, 11670.824937625943, 11730.472128754227, 461000.0, 505348.29089606256, 509770.0, 521626.0, 525390.0, 61525.0, 70090.64954675194, 72870.44953426605, 79861.20138798654, 84991.0, 1121.2935850414349, 1125.5779082843933, 1131.7340425000118, 1140.8060629692807, 1148.3741360958297, 17771.555711107325, 17920.91039544846, 18001.729974050137, 18210.998395088398, 18537.53656158607, 35931.64068359283, 36372.27255454929, 36929.212957897646, 37326.25347493089, 38652.0, 49294.50705493043, 53981.730091349295, 56644.0, 56990.71504642616, 57211.713941430025, 9108.089191080839, 9135.497547634945, 9144.725658230263, 9341.392809467363, 9346.11211934865, 13261.454990899518, 14262.643433914234, 14276.214808185234, 14301.0, 14505.637359066108, 12316.630501084981, 12376.0, 12431.564895228623, 12672.87327126717, 12915.206517506995, 11858.644240672793, 12433.93783031079, 12453.564125255572, 12514.624561263177, 12744.553940612033, 12774.105812593401, 12843.486260549473, 12913.612591622266, 12978.675533111747, 13074.477020919438, 8859.158379953895, 9028.322875784212, 9062.728118156467, 9083.318751093826, 9130.634774608941, 9264.351495395258, 12178.695532611755, 12436.937815311227, 12456.0, 12618.369081545703], "value": 9804.339939842002, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.7385957457445, 1543.7993060902077, 1756.5081777102416, 1885.9339923102686, 1926.479850440382, 8406.705765298208, 8462.830743385144, 8561.272291855192, 8607.69873054444, 8647.870281945776, 8544.829103417944, 8615.267702245317, 8622.051574326819, 8659.350548708857, 8680.522571258578, 2394.5450364430703, 2395.8562486250794, 2395.8562486250794, 2403.0, 2415.7221919479307, 2353.9411514712097, 2399.2082612737754, 2424.599941009731, 2429.6234083716963, 2437.512497500507, 2329.5457385809773, 2364.8226383021342, 2382.4401265702545, 2416.0698131219433, 2421.8667973261463, 2362.681038059866, 2367.3844800351862, 2373.905043798246, 2380.10745970262, 2381.368937231635, 2311.248844125649, 2312.2716344351643, 2330.603797354454, 2353.882305884699, 2356.5051339218785, 8641.913580864237, 8642.0, 8692.739217823475, 8709.695160669346, 8770.561471926441, 5387.24578559002, 5503.834884953458, 5510.91733623996, 5514.531264842493, 5519.558435325164, 3456.5160877477174, 3483.425234836249, 3512.1921957949558, 3541.6812486876306, 3550.0592343029116, 1118.6140781430393, 1167.2762887010024, 1172.7361343697685, 1192.0999645267768, 1197.556903945537, 12083.154179207459, 12084.214526055779, 12103.757924841453, 12177.878221217763, 12192.57325993586, 4448.377227188196, 4584.656150788637, 4596.172688916027, 4623.214053610895, 4681.391419115494, 9774.657886973922, 9856.556454959544, 9861.506924653739, 9866.703998880044, 9870.950645246729, 5257.263983042377, 5261.5264626183825, 5270.841874743764, 5285.709285989307, 5293.735313234323, 4271.807768650418, 4794.400699912511, 4826.348442960156, 4834.95165048345, 4906.90186196274, 3880.8447662093763, 3906.628870257378, 3949.54580223278, 3951.565327813938, 4007.6793856491413, 1176.329492189461, 1212.0969877441187, 1230.9507619695291, 1236.505397840871, 1256.7172386213028, 1009.8081364540714, 1011.1051719228388, 1014.1177175856905, 1021.3922715983978, 1053.2732414633879, 5979.760809567656, 6038.698065096728, 6050.818475445743, 6057.787977420858, 6064.75740970365, 461.87529367070704, 467.4460763994677, 469.4319872953696, 471.32835709114374, 475.1352538380184, 4220.831166753357, 4229.281022226229, 4232.851850185229, 4240.851570195028, 4280.636145927569, 10221.386716797017, 10675.145988320915, 10681.145508359312, 10691.0, 10727.624533141303, 10431.113355364727, 10472.528736206888, 10474.738131546772, 10555.313904596176, 10592.682219533426, 7791.181925897926, 8107.148749381348, 8260.29787468072, 8280.171982801672, 8285.088640249567, 5868.589198756046, 5881.500072493886, 5897.852553686193, 5975.731092100779, 6000.189974353581, 9282.396644218104, 9296.07039296065, 9367.063293670852, 9380.108889655472, 9390.765230869283, 9067.591958362022, 9542.666006689733, 9624.181944534794, 9657.758556036155, 9738.902610974083, 7047.682854271673, 7417.109946806202, 7500.887486687813, 7546.2831031051965, 7654.464187507044, 8244.093149753402, 8246.3815213858, 8250.46371985819, 8250.46371985819, 8251.2986396157, 7290.453216008715, 7385.261473852572, 7451.813704657427, 7514.8497030058, 7623.847523049619, 7239.239879812754, 7278.563286202845, 7360.595167265852, 7388.778336649909, 7415.8887616684715, 7017.578945263301, 7084.149902011792, 7113.679884405111, 7130.714771409085, 7137.216485570528, 5059.19052951526, 5062.924056139087, 5187.948120518747, 5202.479752024768, 5222.764975576184, 5245.973770131125, 5286.762095705625, 5311.150215965427, 5357.491038351351, 5456.317960254968], "value": 4547.590161539029, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.66129845997074, 358.60195183346497, 366.0665303476136, 368.7197729725408, 372.78751111866234, 6532.248791388992, 6574.967125164373, 6609.438197753191, 6616.239132499764, 6652.50106242032, 6633.2703402625675, 6677.0, 6701.262861085277, 6704.765333213339, 6750.62871542065, 5021.17150670139, 5024.849254522352, 5030.220315851049, 5033.169527028036, 5034.446210916796, 5023.648344615878, 5028.974855125719, 5036.420811606676, 5037.798488060474, 5042.924356134661, 4993.425756038066, 4998.950010499903, 5002.199648056312, 5004.274380214867, 5005.624578156635, 4800.855974320776, 4988.451270360258, 5003.949960500385, 5005.974970125162, 5016.673916195454, 4315.244832154392, 4327.242732521796, 4345.369921361416, 4345.956540434619, 4348.412964249817, 6312.274088479838, 6349.238091429012, 6359.904601430982, 6368.012957991518, 6385.074164246204, 5555.694436805974, 5639.238702775114, 5639.68981706006, 5647.068233741427, 5647.971760141214, 6881.690323935435, 6932.48006399517, 6953.826154346182, 6966.651667416609, 6970.233274339818, 4679.766011699401, 4697.436307643071, 4701.717896926195, 4706.411698537683, 4711.411073615798, 7269.527480713737, 7322.377597904185, 7332.266773322678, 7339.119305683299, 7343.522671026366, 4850.8787280317565, 4912.877178070506, 4921.704697718148, 4935.407751069894, 4941.431735350408, 4973.278874563168, 5005.974970125126, 5009.148444764399, 5011.824586139468, 5014.047331007097, 5796.1595568642315, 5806.390329015477, 5807.82576522705, 5814.447627475383, 5816.127580862904, 6947.4789390795895, 6965.82585435358, 6985.441164706811, 7006.089208402875, 7040.92959070413, 1744.1628018550912, 1770.504258807536, 1771.4331413947414, 1774.6539424812295, 1775.4673597920573, 1076.6231818863334, 1119.6864877834219, 1149.270213414471, 1152.2798251093068, 1164.2839653613137, 6748.122744043243, 6898.793036208922, 6931.861362772716, 6943.132108486439, 6948.131483564554, 7281.526700764539, 7288.416926645961, 7353.0, 7357.0, 7369.6315184240575, 6834.794956151323, 6890.173179218526, 6907.378335949688, 6912.619805910623, 6921.619310937846, 3886.6502014818802, 3891.7275790694944, 3975.602439756059, 3979.323515002399, 3982.3230050891416, 7635.618219089023, 7682.078150621849, 7693.346065584376, 7699.307062364414, 7716.807079823049, 7410.703571857065, 7460.328570428687, 7466.775996720107, 7486.95182674426, 7492.288232617892, 7615.124260709978, 7623.580703061274, 7678.462507624413, 7682.347000505019, 7690.00029996097, 7064.894026589503, 7285.162206346126, 7304.96347518259, 7325.890111648223, 7364.742234021784, 7157.57054576727, 7157.928420715726, 7229.240929702516, 7233.132024157135, 7243.058402407653, 7686.538807671557, 7689.3464055555905, 7702.499337543042, 7707.576083315472, 7713.2286771322415, 4837.516248375135, 4888.657793954531, 4889.144399730104, 4893.926591101065, 4899.755012249445, 7097.25478824716, 7352.11774587053, 7363.116426028911, 7364.631768411665, 7391.40868730511, 7104.715811367488, 7136.286371362822, 7161.176464706626, 7162.964185179041, 7177.425805935408, 7074.009638650696, 7086.50394472382, 7091.751788687371, 7100.218975912749, 7107.82230444243, 6846.281140480377, 6872.037914691847, 6903.620300883299, 6905.309469053255, 6917.515773895779, 7000.404965577983, 7160.498765086394, 7174.1032370953635, 7174.354308112295, 7192.136943566806, 6842.692078856364, 7011.929880701127, 7037.472189585904, 7045.929540704527, 7054.435645148478], "value": 5293.638549855215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.7797016835289, 887.1261807119987, 906.2478143141193, 935.0415823780625, 966.6036924860808, 15029.098254104747, 15216.39134434624, 15280.312385942632, 15291.388344466222, 15316.004459710124, 12138.332391718452, 14292.714145717106, 14340.282985850718, 14357.784633230483, 14427.0, 892.4734406700062, 915.702396721065, 916.0335845682802, 918.8392031394512, 920.0293690156882, 910.968116115936, 918.1323649151554, 918.3846822628855, 918.4626993208981, 920.8618707193907, 934.4113208678523, 941.472775245861, 942.3591957468918, 944.5371767833747, 949.7388218240005, 934.8036912248436, 937.329809186435, 938.6573900526326, 941.8916824565194, 944.1361154543619, 696.495041095207, 697.8325201951545, 698.0715648187897, 698.6681326369984, 699.3391245273219, 14988.400463981428, 15028.474003409938, 15046.774298385533, 15068.698626027528, 15100.640942315134, 14869.553913382615, 14884.10695358282, 14893.851061489355, 14974.326155322928, 15010.924945375313, 11361.375124368156, 11582.942085289604, 11629.534818607246, 11659.125565582615, 11782.764344713143, 3988.3618621020787, 4044.211378781139, 4122.732022418533, 4122.814473348706, 4185.518665353493, 53132.20301695478, 53510.46489535094, 53764.19353709697, 53886.46113538893, 54131.72934135304, 11387.886121138683, 11566.074714023027, 11646.70883227926, 11750.118741094451, 11837.467313970892, 19405.0297485128, 19426.22295108208, 19435.222591096197, 19464.805351946583, 19473.707894381594, 8353.66585336592, 8430.409871309072, 8811.691590794291, 8921.286297096216, 9040.502772347583, 4922.630802689812, 5016.799328026838, 5184.533391994739, 5206.349206349207, 5247.422783493813, 3519.9824000880344, 3550.875719349862, 3557.5197348358156, 3563.322968635951, 3573.160307327776, 667.1727058447588, 667.3793372163934, 673.7204060315013, 675.6081472745796, 682.3483573187693, 786.1627366854282, 795.208767276552, 813.7965508622844, 840.2899549880341, 846.0650980666398, 9690.0, 9911.55398007077, 10063.949680251551, 10126.746831329276, 10438.217133715001, 679.2290749998787, 778.6573907480804, 807.1940799132003, 841.3185319890786, 848.84296405164, 4646.883827904329, 4718.622510199176, 4748.216544270226, 4751.168545504592, 4762.738049407247, 61098.694506528074, 61129.38870611326, 61457.692711536154, 64381.356186438476, 64634.35365646283, 50078.749606252466, 50508.49491505112, 50771.74614126905, 50930.23604645933, 54962.0, 50139.24791128136, 50507.24239136416, 50647.746761266695, 51082.489175107774, 51670.74164629228, 10060.0945914868, 10306.742331441774, 10306.845397318897, 10451.268411211142, 10558.947205263925, 35482.29035419329, 36460.088497787765, 36633.63366366409, 36825.0, 37454.81272593619, 42969.785151074044, 43759.0, 46405.07189856117, 46630.53369466262, 46792.0, 12465.626031219077, 12512.937435312766, 12537.185082969578, 12735.617931462071, 12753.872461275269, 13557.25435101079, 13950.0, 14149.929250353682, 14262.57212283633, 14419.567412977627, 13211.669708256986, 13421.328933553088, 13485.460581576626, 13597.52408665692, 13617.86382136166, 13015.219086854819, 13063.934680326538, 13434.798478023033, 13609.727805444034, 14201.573952781433, 12257.325847078497, 12531.248125112523, 12687.804708003163, 12750.42623081945, 12835.229886206858, 11267.830982535104, 11469.942650287028, 11593.6521904343, 11658.300501969909, 11757.588484403004, 10806.35161890289, 11423.771524569629, 11638.41807909618, 11745.706357341134, 11814.0], "value": 7170.78207914406, "unit": "score"}], "name": "dromaeo_css", "value": 7645.259415052782, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 103.0, 111.0, 112.0, 111.0, 104.0, 113.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 135.0, 153.0, 180.0, 128.0, 154.0, 154.0, 127.0, 205.0, 129.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 179.0, 76.0, 75.0, 75.0, 75.0, 171.0, 76.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 160.0, 93.0, 93.0, 92.0, 151.0, 93.0, 92.0, 147.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 99.0, 95.0, 100.0, 95.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 80.0, 56.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 75.0, 73.0, 81.0, 74.0, 76.0, 76.0, 74.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 112.0, 115.0, 114.0, 115.0, 114.0, 127.0, 129.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 169.0, 168.0, 162.0, 163.0, 171.0, 161.0, 160.0, 158.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 72.0, 69.0, 68.0, 67.0, 69.0, 71.0, 69.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1532.7, "alertThreshold": 2.0}]} 22:19:04 INFO - Return code: 0 22:19:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:19:04 ERROR - # TBPL SUCCESS # 22:19:04 INFO - Running post-action listener: _resource_record_post_action 22:19:04 INFO - Running post-run listener: _resource_record_post_run 22:19:05 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 757760; Write bytes: 264355840; Read time: 56; Write time: 164360 22:19:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13344768; Read time: 0; Write time: 2136 22:19:05 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 757760; Write bytes: 247160832; Read time: 56; Write time: 157336 22:19:05 INFO - Running post-run listener: _upload_blobber_files 22:19:05 INFO - Blob upload gear active. 22:19:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:19:05 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 22:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:19:06 INFO - (blobuploader) - INFO - Open directory for files ... 22:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:07 INFO - (blobuploader) - INFO - Done attempting. 22:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:07 INFO - (blobuploader) - INFO - Done attempting. 22:19:07 INFO - (blobuploader) - INFO - Iteration through files over. 22:19:07 INFO - Return code: 0 22:19:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:19:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:19:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6bcd44b9b9a067100b2cfca95c42c44ee4f07ad4572493cdd3d6f4bc9cbaa74f26c6a996bb8d59c0033bb2c0d62c5b53d86b448cb0572adfa8ad8c9e0c0cbd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf4de5cb52bf7dc625822056a7bef307c8be0a4405d0bf9d79d614a99d0a520e54e669e0fcb929e9014b5797872a4b9d40f31d240f7cf8d5a3d7addfb1e17999"} 22:19:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:19:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:19:07 INFO - Contents: 22:19:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6bcd44b9b9a067100b2cfca95c42c44ee4f07ad4572493cdd3d6f4bc9cbaa74f26c6a996bb8d59c0033bb2c0d62c5b53d86b448cb0572adfa8ad8c9e0c0cbd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf4de5cb52bf7dc625822056a7bef307c8be0a4405d0bf9d79d614a99d0a520e54e669e0fcb929e9014b5797872a4b9d40f31d240f7cf8d5a3d7addfb1e17999"} 22:19:07 INFO - Running post-run listener: copy_logs_to_upload_dir 22:19:07 INFO - Copying logs to upload dir... 22:19:07 INFO - mkdir: /builds/slave/test/build/upload/logs 22:19:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.777674 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-19 22:19:07.770457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 22:19:07.773939) ========= 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=0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6bcd44b9b9a067100b2cfca95c42c44ee4f07ad4572493cdd3d6f4bc9cbaa74f26c6a996bb8d59c0033bb2c0d62c5b53d86b448cb0572adfa8ad8c9e0c0cbd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf4de5cb52bf7dc625822056a7bef307c8be0a4405d0bf9d79d614a99d0a520e54e669e0fcb929e9014b5797872a4b9d40f31d240f7cf8d5a3d7addfb1e17999"} build_url:https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/ET9vsQTYStKD2FBW0HPSNQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6bcd44b9b9a067100b2cfca95c42c44ee4f07ad4572493cdd3d6f4bc9cbaa74f26c6a996bb8d59c0033bb2c0d62c5b53d86b448cb0572adfa8ad8c9e0c0cbd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf4de5cb52bf7dc625822056a7bef307c8be0a4405d0bf9d79d614a99d0a520e54e669e0fcb929e9014b5797872a4b9d40f31d240f7cf8d5a3d7addfb1e17999"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 22:19:07.798778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 22:19:07.799084) ========= 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=0333a256a5e4f052382dd180000001b1-1463718627.978473-373384494 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 22:19:07.881356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 22:19:07.881687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 22:19:07.881962) ========= ========= Total master_lag: 0.17 =========