builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1461845186.29 results: success (0) buildid: 20160428023625 builduid: 559b161a53a1490295bd43a36f8f4423 revision: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.285615) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.286102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.286394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.347786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.348151) ========= 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=db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 05:06:26-- 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% 225M=0s 2016-04-28 05:06:27 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195724 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.587625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.588303) ========= 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=db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016481 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.637126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:26.640826) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 352d365eb4eda3aab7c3680b0e80ce17e178b5ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 352d365eb4eda3aab7c3680b0e80ce17e178b5ee --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=db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 05:06:27,176 truncating revision to first 12 chars 2016-04-28 05:06:27,176 Setting DEBUG logging. 2016-04-28 05:06:27,176 attempt 1/10 2016-04-28 05:06:27,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/352d365eb4ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 05:06:27,415 unpacking tar archive at: fx-team-352d365eb4ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.482304 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:27.138007) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:27.138358) ========= script_repo_revision: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:27.138826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:27.139108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:06:27.149105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-28 05:06:27.149435) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:27 INFO - MultiFileLogger online at 20160428 05:06:27 in /builds/slave/test 05:06:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:27 INFO - {'append_to_log': False, 05:06:27 INFO - 'base_work_dir': '/builds/slave/test', 05:06:27 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:27 INFO - 'branch': 'Fx-Team', 05:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:27 INFO - 'config_files': ('talos/linux_config.py',), 05:06:27 INFO - 'default_actions': ('clobber', 05:06:27 INFO - 'read-buildbot-config', 05:06:27 INFO - 'download-and-extract', 05:06:27 INFO - 'populate-webroot', 05:06:27 INFO - 'create-virtualenv', 05:06:27 INFO - 'install', 05:06:27 INFO - 'run-tests'), 05:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:27 INFO - 'download_minidump_stackwalk': True, 05:06:27 INFO - 'download_symbols': 'ondemand', 05:06:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:27 INFO - 'installer_path': 'installer.exe', 05:06:27 INFO - 'log_level': 'info', 05:06:27 INFO - 'log_name': 'talos', 05:06:27 INFO - 'log_to_console': True, 05:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:27 INFO - 'opt_config_files': (), 05:06:27 INFO - 'pip_index': False, 05:06:27 INFO - 'sps_profile': False, 05:06:27 INFO - 'sps_profile_interval': 0, 05:06:27 INFO - 'suite': 'dromaeojs-e10s', 05:06:27 INFO - 'system_bits': '32', 05:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:27 INFO - 'title': 'talos-linux64-ix-031', 05:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:27 INFO - 'use_talos_json': True, 05:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:27 INFO - 'work_dir': 'build'} 05:06:27 INFO - ##### 05:06:27 INFO - ##### Running clobber step. 05:06:27 INFO - ##### 05:06:27 INFO - Running pre-action listener: _resource_record_pre_action 05:06:27 INFO - Running main action method: clobber 05:06:27 INFO - rmtree: /builds/slave/test/build 05:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:28 INFO - Running post-action listener: _resource_record_post_action 05:06:28 INFO - ##### 05:06:28 INFO - ##### Running read-buildbot-config step. 05:06:28 INFO - ##### 05:06:28 INFO - Running pre-action listener: _resource_record_pre_action 05:06:28 INFO - Running main action method: read_buildbot_config 05:06:28 INFO - Using buildbot properties: 05:06:28 INFO - { 05:06:28 INFO - "project": "", 05:06:28 INFO - "product": "firefox", 05:06:28 INFO - "script_repo_revision": "production", 05:06:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:06:28 INFO - "repository": "", 05:06:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:06:28 INFO - "buildid": "20160428023625", 05:06:28 INFO - "pgo_build": "True", 05:06:28 INFO - "basedir": "/builds/slave/test", 05:06:28 INFO - "buildnumber": 698, 05:06:28 INFO - "slavename": "talos-linux64-ix-031", 05:06:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:06:28 INFO - "platform": "ubuntu64_hw", 05:06:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:06:28 INFO - "branch": "fx-team", 05:06:28 INFO - "repo_path": "integration/fx-team", 05:06:28 INFO - "revision": "352d365eb4eda3aab7c3680b0e80ce17e178b5ee", 05:06:28 INFO - "stage_platform": "linux64-pgo", 05:06:28 INFO - "builduid": "559b161a53a1490295bd43a36f8f4423", 05:06:28 INFO - "slavebuilddir": "test" 05:06:28 INFO - } 05:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:06:28 INFO - Running post-action listener: _resource_record_post_action 05:06:28 INFO - ##### 05:06:28 INFO - ##### Running download-and-extract step. 05:06:28 INFO - ##### 05:06:28 INFO - Running pre-action listener: _resource_record_pre_action 05:06:28 INFO - Running main action method: download_and_extract 05:06:28 INFO - mkdir: /builds/slave/test/build/tests 05:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:28 INFO - https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:06:29 INFO - Downloaded 1361 bytes. 05:06:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:29 INFO - Using the following test package requirements: 05:06:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'jsshell-linux-x86_64.zip'], 05:06:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:29 INFO - https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:30 INFO - Downloaded 23860314 bytes. 05:06:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:31 INFO - Return code: 0 05:06:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:06:31 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')]} 05:06:31 INFO - https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:38 INFO - Downloaded 23860314 bytes. 05:06:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:39 INFO - Return code: 0 05:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:39 INFO - https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:06:41 INFO - Downloaded 10840145 bytes. 05:06:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:06:41 INFO - Return code: 0 05:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:41 INFO - https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:06:43 INFO - Downloaded 58355870 bytes. 05:06:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:43 INFO - mkdir: /builds/slave/test/properties 05:06:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:43 INFO - Contents: 05:06:43 INFO - build_url:https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:43 INFO - Running post-action listener: _resource_record_post_action 05:06:43 INFO - Running post-action listener: set_extra_try_arguments 05:06:43 INFO - ##### 05:06:43 INFO - ##### Running populate-webroot step. 05:06:43 INFO - ##### 05:06:43 INFO - Running pre-action listener: _resource_record_pre_action 05:06:43 INFO - Running main action method: populate_webroot 05:06:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:43 INFO - '--tppagecycles', 05:06:43 INFO - '7'], 05:06:43 INFO - 'tests': ['tsvgm']}}, 05:06:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['damp', 'tps']}, 05:06:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'tests': ['damp', 'tps']}, 05:06:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['dromaeo_dom']}, 05:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['a11yr', 05:06:43 INFO - 'ts_paint', 05:06:43 INFO - 'tpaint', 05:06:43 INFO - 'sessionrestore', 05:06:43 INFO - 'sessionrestore_no_auto_restore', 05:06:43 INFO - 'tabpaint']}, 05:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:43 INFO - 'ts_paint', 05:06:43 INFO - 'tpaint', 05:06:43 INFO - 'sessionrestore', 05:06:43 INFO - 'sessionrestore_no_auto_restore', 05:06:43 INFO - 'tabpaint']}, 05:06:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:43 INFO - 'ts_paint', 05:06:43 INFO - 'tpaint', 05:06:43 INFO - 'sessionrestore', 05:06:43 INFO - 'sessionrestore_no_auto_restore', 05:06:43 INFO - 'tabpaint']}, 05:06:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:43 INFO - 'ts_paint', 05:06:43 INFO - 'tpaint', 05:06:43 INFO - 'sessionrestore', 05:06:43 INFO - 'sessionrestore_no_auto_restore', 05:06:43 INFO - 'tabpaint']}, 05:06:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['a11yr', 05:06:43 INFO - 'ts_paint', 05:06:43 INFO - 'tpaint', 05:06:43 INFO - 'sessionrestore', 05:06:43 INFO - 'sessionrestore_no_auto_restore', 05:06:43 INFO - 'tabpaint']}, 05:06:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['a11yr', 05:06:43 INFO - 'ts_paint', 05:06:43 INFO - 'tpaint', 05:06:43 INFO - 'sessionrestore', 05:06:43 INFO - 'sessionrestore_no_auto_restore', 05:06:43 INFO - 'tabpaint']}, 05:06:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['tsvgx', 05:06:43 INFO - 'tsvgr_opacity', 05:06:43 INFO - 'tart', 05:06:43 INFO - 'tscrollx', 05:06:43 INFO - 'cart']}, 05:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:43 INFO - 'tsvgr_opacity', 05:06:43 INFO - 'tart', 05:06:43 INFO - 'tscrollx', 05:06:43 INFO - 'cart']}, 05:06:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'talos_options': ['--disable-e10s'], 05:06:43 INFO - 'tests': ['tp5o']}, 05:06:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'tests': ['tp5o']}, 05:06:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'talos_options': ['--disable-e10s', 05:06:43 INFO - '--xperf_path', 05:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:43 INFO - 'tests': ['tp5n']}, 05:06:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:43 INFO - 'talos_options': ['--xperf_path', 05:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:43 INFO - 'tests': ['tp5n']}}, 05:06:43 INFO - 'talos.zip': {'path': '', 05:06:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:43 INFO - Running post-action listener: _resource_record_post_action 05:06:43 INFO - ##### 05:06:43 INFO - ##### Running create-virtualenv step. 05:06:43 INFO - ##### 05:06:43 INFO - Running pre-action listener: _resource_record_pre_action 05:06:43 INFO - Running main action method: create_virtualenv 05:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:43 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 05:06:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:44 INFO - Using real prefix '/usr' 05:06:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:46 INFO - Installing pip.................done. 05:06:46 INFO - Return code: 0 05:06:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:06:46 INFO - Using env: {'DISPLAY': ':0', 05:06:46 INFO - 'HOME': '/home/cltbld', 05:06:46 INFO - 'LANG': 'en_US.UTF-8', 05:06:46 INFO - 'LANGUAGE': 'en_US:en', 05:06:46 INFO - 'LOGNAME': 'cltbld', 05:06:46 INFO - 'MAIL': '/var/mail/cltbld', 05:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:46 INFO - 'MOZ_NO_REMOTE': '1', 05:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:46 INFO - 'NO_EM_RESTART': '1', 05:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:46 INFO - 'PWD': '/builds/slave/test', 05:06:46 INFO - 'SHELL': '/bin/bash', 05:06:46 INFO - 'SHLVL': '1', 05:06:46 INFO - 'TERM': 'linux', 05:06:46 INFO - 'TMOUT': '86400', 05:06:46 INFO - 'USER': 'cltbld', 05:06:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:46 INFO - '_': '/tools/buildbot/bin/python'} 05:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:46 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 05:06:46 INFO - Cleaning up... 05:06:46 INFO - Return code: 0 05:06:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:06:46 INFO - Using env: {'DISPLAY': ':0', 05:06:46 INFO - 'HOME': '/home/cltbld', 05:06:46 INFO - 'LANG': 'en_US.UTF-8', 05:06:46 INFO - 'LANGUAGE': 'en_US:en', 05:06:46 INFO - 'LOGNAME': 'cltbld', 05:06:46 INFO - 'MAIL': '/var/mail/cltbld', 05:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:46 INFO - 'MOZ_NO_REMOTE': '1', 05:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:46 INFO - 'NO_EM_RESTART': '1', 05:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:46 INFO - 'PWD': '/builds/slave/test', 05:06:46 INFO - 'SHELL': '/bin/bash', 05:06:46 INFO - 'SHLVL': '1', 05:06:46 INFO - 'TERM': 'linux', 05:06:46 INFO - 'TMOUT': '86400', 05:06:46 INFO - 'USER': 'cltbld', 05:06:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:46 INFO - '_': '/tools/buildbot/bin/python'} 05:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:46 INFO - Downloading/unpacking psutil>=0.7.1 05:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:48 INFO - Installing collected packages: psutil 05:06:48 INFO - Running setup.py install for psutil 05:06:48 INFO - building 'psutil._psutil_linux' extension 05:06:48 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 05:06:49 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 05:06:49 INFO - building 'psutil._psutil_posix' extension 05:06:49 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 05:06:49 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 05:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:49 INFO - Successfully installed psutil 05:06:49 INFO - Cleaning up... 05:06:49 INFO - Return code: 0 05:06:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:49 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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:06:49 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 05:06:49 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 05:06:49 INFO - Using env: {'DISPLAY': ':0', 05:06:49 INFO - 'HOME': '/home/cltbld', 05:06:49 INFO - 'LANG': 'en_US.UTF-8', 05:06:49 INFO - 'LANGUAGE': 'en_US:en', 05:06:49 INFO - 'LOGNAME': 'cltbld', 05:06:49 INFO - 'MAIL': '/var/mail/cltbld', 05:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:49 INFO - 'MOZ_NO_REMOTE': '1', 05:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:49 INFO - 'NO_EM_RESTART': '1', 05:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:49 INFO - 'PWD': '/builds/slave/test', 05:06:49 INFO - 'SHELL': '/bin/bash', 05:06:49 INFO - 'SHLVL': '1', 05:06:49 INFO - 'TERM': 'linux', 05:06:49 INFO - 'TMOUT': '86400', 05:06:49 INFO - 'USER': 'cltbld', 05:06:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:49 INFO - '_': '/tools/buildbot/bin/python'} 05:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06:49 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 05:06:49 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 05:06:49 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 05:06:49 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 05:06:49 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 05:06:49 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 05:06:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:06:51 INFO - Installing collected packages: mozsystemmonitor 05:06:51 INFO - Running setup.py install for mozsystemmonitor 05:06:51 INFO - Successfully installed mozsystemmonitor 05:06:51 INFO - Cleaning up... 05:06:51 INFO - Return code: 0 05:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:51 INFO - Using env: {'DISPLAY': ':0', 05:06:51 INFO - 'HOME': '/home/cltbld', 05:06:51 INFO - 'LANG': 'en_US.UTF-8', 05:06:51 INFO - 'LANGUAGE': 'en_US:en', 05:06:51 INFO - 'LOGNAME': 'cltbld', 05:06:51 INFO - 'MAIL': '/var/mail/cltbld', 05:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:51 INFO - 'MOZ_NO_REMOTE': '1', 05:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:51 INFO - 'NO_EM_RESTART': '1', 05:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:51 INFO - 'PWD': '/builds/slave/test', 05:06:51 INFO - 'SHELL': '/bin/bash', 05:06:51 INFO - 'SHLVL': '1', 05:06:51 INFO - 'TERM': 'linux', 05:06:51 INFO - 'TMOUT': '86400', 05:06:51 INFO - 'USER': 'cltbld', 05:06:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:51 INFO - '_': '/tools/buildbot/bin/python'} 05:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:54 INFO - Downloading docopt-0.6.1.tar.gz 05:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:54 INFO - Running setup.py install for blobuploader 05:06:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:54 INFO - Running setup.py install for requests 05:06:55 INFO - Running setup.py install for docopt 05:06:55 INFO - Successfully installed blobuploader requests docopt 05:06:55 INFO - Cleaning up... 05:06:55 INFO - Return code: 0 05:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:55 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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:06:55 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 05:06:55 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 05:06:55 INFO - Using env: {'DISPLAY': ':0', 05:06:55 INFO - 'HOME': '/home/cltbld', 05:06:55 INFO - 'LANG': 'en_US.UTF-8', 05:06:55 INFO - 'LANGUAGE': 'en_US:en', 05:06:55 INFO - 'LOGNAME': 'cltbld', 05:06:55 INFO - 'MAIL': '/var/mail/cltbld', 05:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:55 INFO - 'MOZ_NO_REMOTE': '1', 05:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:55 INFO - 'NO_EM_RESTART': '1', 05:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:55 INFO - 'PWD': '/builds/slave/test', 05:06:55 INFO - 'SHELL': '/bin/bash', 05:06:55 INFO - 'SHLVL': '1', 05:06:55 INFO - 'TERM': 'linux', 05:06:55 INFO - 'TMOUT': '86400', 05:06:55 INFO - 'USER': 'cltbld', 05:06:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:55 INFO - '_': '/tools/buildbot/bin/python'} 05:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:55 INFO - Running setup.py (path:/tmp/pip-3049am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:55 INFO - Running setup.py (path:/tmp/pip-x2tHBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:55 INFO - Running setup.py (path:/tmp/pip-JMLm_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:55 INFO - Running setup.py (path:/tmp/pip-OCThJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:55 INFO - Running setup.py (path:/tmp/pip-EFWq2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:55 INFO - Running setup.py (path:/tmp/pip-0jgMFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:55 INFO - Running setup.py (path:/tmp/pip-Px31dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:55 INFO - Running setup.py (path:/tmp/pip-2YXSkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:55 INFO - Running setup.py (path:/tmp/pip-QDbcAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:56 INFO - Running setup.py (path:/tmp/pip-X_etaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:56 INFO - Running setup.py (path:/tmp/pip-FXS4Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:56 INFO - Running setup.py (path:/tmp/pip-pEgDkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:56 INFO - Running setup.py (path:/tmp/pip-FcsChL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:56 INFO - Running setup.py (path:/tmp/pip-oIoifp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:56 INFO - Running setup.py (path:/tmp/pip-Hx2iUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:56 INFO - Running setup.py (path:/tmp/pip-DDfjjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:56 INFO - Running setup.py (path:/tmp/pip-_ZQMlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:56 INFO - Running setup.py install for manifestparser 05:06:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:56 INFO - Running setup.py install for mozcrash 05:06:56 INFO - Running setup.py install for mozdebug 05:06:56 INFO - Running setup.py install for mozdevice 05:06:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for mozfile 05:06:57 INFO - Running setup.py install for mozhttpd 05:06:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for mozinfo 05:06:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for mozInstall 05:06:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for mozleak 05:06:57 INFO - Running setup.py install for mozlog 05:06:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for moznetwork 05:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for mozprocess 05:06:57 INFO - Running setup.py install for mozprofile 05:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:57 INFO - Running setup.py install for mozrunner 05:06:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Running setup.py install for mozscreenshot 05:06:58 INFO - Running setup.py install for moztest 05:06:58 INFO - Running setup.py install for mozversion 05:06:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:58 INFO - Cleaning up... 05:06:58 INFO - Return code: 0 05:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:06:58 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 05:06:58 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 05:06:58 INFO - Using env: {'DISPLAY': ':0', 05:06:58 INFO - 'HOME': '/home/cltbld', 05:06:58 INFO - 'LANG': 'en_US.UTF-8', 05:06:58 INFO - 'LANGUAGE': 'en_US:en', 05:06:58 INFO - 'LOGNAME': 'cltbld', 05:06:58 INFO - 'MAIL': '/var/mail/cltbld', 05:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:58 INFO - 'MOZ_NO_REMOTE': '1', 05:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:58 INFO - 'NO_EM_RESTART': '1', 05:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:58 INFO - 'PWD': '/builds/slave/test', 05:06:58 INFO - 'SHELL': '/bin/bash', 05:06:58 INFO - 'SHLVL': '1', 05:06:58 INFO - 'TERM': 'linux', 05:06:58 INFO - 'TMOUT': '86400', 05:06:58 INFO - 'USER': 'cltbld', 05:06:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:58 INFO - '_': '/tools/buildbot/bin/python'} 05:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:58 INFO - Running setup.py (path:/tmp/pip-1lTeOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:58 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)) 05:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:58 INFO - Running setup.py (path:/tmp/pip-iq3EFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:58 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)) 05:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:58 INFO - Running setup.py (path:/tmp/pip-ab6hGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:58 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)) 05:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:58 INFO - Running setup.py (path:/tmp/pip-qLoTLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:58 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)) 05:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:58 INFO - Running setup.py (path:/tmp/pip-cQun40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:58 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)) 05:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:58 INFO - Running setup.py (path:/tmp/pip-IAIsTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:59 INFO - Running setup.py (path:/tmp/pip-eGzanj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:59 INFO - Running setup.py (path:/tmp/pip-urvlxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:59 INFO - Running setup.py (path:/tmp/pip-RfCzz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:59 INFO - Running setup.py (path:/tmp/pip-iamZb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:59 INFO - Running setup.py (path:/tmp/pip-hmsV6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:59 INFO - Running setup.py (path:/tmp/pip-uSiMvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:59 INFO - Running setup.py (path:/tmp/pip-M5AQf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:59 INFO - Running setup.py (path:/tmp/pip-e9PNJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:59 INFO - Running setup.py (path:/tmp/pip-FfW6XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:59 INFO - Running setup.py (path:/tmp/pip-ZnLBzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:59 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)) 05:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:59 INFO - Running setup.py (path:/tmp/pip-J8BXmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:59 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)) 05:06:59 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)) 05:06:59 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)) 05:06:59 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)) 05:06:59 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)) 05:06:59 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)) 05:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:01 INFO - Downloading blessings-1.6.tar.gz 05:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:01 INFO - Installing collected packages: blessings 05:07:01 INFO - Running setup.py install for blessings 05:07:01 INFO - Successfully installed blessings 05:07:01 INFO - Cleaning up... 05:07:01 INFO - Return code: 0 05:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:02 INFO - Reading from file tmpfile_stdout 05:07:02 INFO - Current package versions: 05:07:02 INFO - argparse == 1.2.1 05:07:02 INFO - blessings == 1.6 05:07:02 INFO - blobuploader == 1.2.4 05:07:02 INFO - docopt == 0.6.1 05:07:02 INFO - manifestparser == 1.1 05:07:02 INFO - mozInstall == 1.12 05:07:02 INFO - mozcrash == 0.17 05:07:02 INFO - mozdebug == 0.1 05:07:02 INFO - mozdevice == 0.48 05:07:02 INFO - mozfile == 1.2 05:07:02 INFO - mozhttpd == 0.7 05:07:02 INFO - mozinfo == 0.9 05:07:02 INFO - mozleak == 0.1 05:07:02 INFO - mozlog == 3.1 05:07:02 INFO - moznetwork == 0.27 05:07:02 INFO - mozprocess == 0.22 05:07:02 INFO - mozprofile == 0.28 05:07:02 INFO - mozrunner == 6.11 05:07:02 INFO - mozscreenshot == 0.1 05:07:02 INFO - mozsystemmonitor == 0.0 05:07:02 INFO - moztest == 0.7 05:07:02 INFO - mozversion == 1.4 05:07:02 INFO - psutil == 3.1.1 05:07:02 INFO - requests == 1.2.3 05:07:02 INFO - wsgiref == 0.1.2 05:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:02 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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:07:02 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 05:07:02 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 05:07:02 INFO - Using env: {'DISPLAY': ':0', 05:07:02 INFO - 'HOME': '/home/cltbld', 05:07:02 INFO - 'LANG': 'en_US.UTF-8', 05:07:02 INFO - 'LANGUAGE': 'en_US:en', 05:07:02 INFO - 'LOGNAME': 'cltbld', 05:07:02 INFO - 'MAIL': '/var/mail/cltbld', 05:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:02 INFO - 'MOZ_NO_REMOTE': '1', 05:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:02 INFO - 'NO_EM_RESTART': '1', 05:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:02 INFO - 'PWD': '/builds/slave/test', 05:07:02 INFO - 'SHELL': '/bin/bash', 05:07:02 INFO - 'SHLVL': '1', 05:07:02 INFO - 'TERM': 'linux', 05:07:02 INFO - 'TMOUT': '86400', 05:07:02 INFO - 'USER': 'cltbld', 05:07:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:02 INFO - '_': '/tools/buildbot/bin/python'} 05:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 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)) 05:07:02 INFO - Cleaning up... 05:07:02 INFO - Return code: 0 05:07:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:07: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', 'jsonschema'] in /builds/slave/test/build 05:07: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 jsonschema 05:07:02 INFO - Using env: {'DISPLAY': ':0', 05:07:02 INFO - 'HOME': '/home/cltbld', 05:07:02 INFO - 'LANG': 'en_US.UTF-8', 05:07:02 INFO - 'LANGUAGE': 'en_US:en', 05:07:02 INFO - 'LOGNAME': 'cltbld', 05:07:02 INFO - 'MAIL': '/var/mail/cltbld', 05:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:02 INFO - 'MOZ_NO_REMOTE': '1', 05:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:02 INFO - 'NO_EM_RESTART': '1', 05:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:02 INFO - 'PWD': '/builds/slave/test', 05:07:02 INFO - 'SHELL': '/bin/bash', 05:07:02 INFO - 'SHLVL': '1', 05:07:02 INFO - 'TERM': 'linux', 05:07:02 INFO - 'TMOUT': '86400', 05:07:02 INFO - 'USER': 'cltbld', 05:07:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:02 INFO - '_': '/tools/buildbot/bin/python'} 05:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:02 INFO - Downloading/unpacking jsonschema 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:04 INFO - Downloading/unpacking functools32 (from jsonschema) 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:04 INFO - warning: no files found matching '*.txt' 05:07:04 INFO - no previously-included directories found matching 'build' 05:07:04 INFO - no previously-included directories found matching 'dist' 05:07:04 INFO - no previously-included directories found matching '.git*' 05:07:04 INFO - Installing collected packages: jsonschema, functools32 05:07:04 INFO - Running setup.py install for functools32 05:07:04 INFO - warning: no files found matching '*.txt' 05:07:04 INFO - no previously-included directories found matching 'build' 05:07:04 INFO - no previously-included directories found matching 'dist' 05:07:04 INFO - no previously-included directories found matching '.git*' 05:07:04 INFO - Successfully installed jsonschema functools32 05:07:04 INFO - Cleaning up... 05:07:04 INFO - Return code: 0 05:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:04 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 0x7f1f86848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', '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 05:07:04 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 05:07:04 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 05:07:04 INFO - Using env: {'DISPLAY': ':0', 05:07:04 INFO - 'HOME': '/home/cltbld', 05:07:04 INFO - 'LANG': 'en_US.UTF-8', 05:07:04 INFO - 'LANGUAGE': 'en_US:en', 05:07:04 INFO - 'LOGNAME': 'cltbld', 05:07:04 INFO - 'MAIL': '/var/mail/cltbld', 05:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:04 INFO - 'MOZ_NO_REMOTE': '1', 05:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:04 INFO - 'NO_EM_RESTART': '1', 05:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:04 INFO - 'PWD': '/builds/slave/test', 05:07:04 INFO - 'SHELL': '/bin/bash', 05:07:04 INFO - 'SHLVL': '1', 05:07:04 INFO - 'TERM': 'linux', 05:07:04 INFO - 'TMOUT': '86400', 05:07:04 INFO - 'USER': 'cltbld', 05:07:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:04 INFO - '_': '/tools/buildbot/bin/python'} 05:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:05 INFO - Downloading/unpacking flake8 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:07:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:07:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:07 INFO - no previously-included directories found matching 'docs/_build' 05:07:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:07:07 INFO - Running setup.py install for pep8 05:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:07 INFO - no previously-included directories found matching 'docs/_build' 05:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:07:07 INFO - Cleaning up... 05:07:07 INFO - Return code: 0 05:07:07 INFO - Running post-action listener: _resource_record_post_action 05:07:07 INFO - Running post-action listener: _start_resource_monitoring 05:07:08 INFO - Starting resource monitoring. 05:07:08 INFO - ##### 05:07:08 INFO - ##### Running install step. 05:07:08 INFO - ##### 05:07:08 INFO - Running pre-action listener: _resource_record_pre_action 05:07:08 INFO - Running main action method: install 05:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:08 INFO - Reading from file tmpfile_stdout 05:07:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:08 INFO - Reading from file tmpfile_stdout 05:07:08 INFO - Output received: 05:07:08 INFO - Usage: mozinstall [options] installer 05:07:08 INFO - Options: 05:07:08 INFO - -h, --help show this help message and exit 05:07:08 INFO - -d DEST, --destination=DEST 05:07:08 INFO - Directory to install application into. [default: 05:07:08 INFO - "/builds/slave/test"] 05:07:08 INFO - --app=APP Application being installed. [default: firefox] 05:07:08 INFO - mkdir: /builds/slave/test/build/application 05:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:07:24 INFO - Reading from file tmpfile_stdout 05:07:24 INFO - Output received: 05:07:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:24 INFO - Running post-action listener: _resource_record_post_action 05:07:24 INFO - ##### 05:07:24 INFO - ##### Running run-tests step. 05:07:24 INFO - ##### 05:07:24 INFO - Running pre-action listener: _resource_record_pre_action 05:07:24 INFO - Running main action method: run_tests 05:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:24 INFO - Python 2.7.3 05:07:24 INFO - Return code: 0 05:07:24 INFO - grabbing minidump binary from tooltool 05:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:24 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 0x188c410>, '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 0x188d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:24 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 05:07:24 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 05:07:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:24 INFO - Return code: 0 05:07:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:25 INFO - Return code: 0 05:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 05:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 05:07:25 INFO - Using env: {'DISPLAY': ':0', 05:07:25 INFO - 'HOME': '/home/cltbld', 05:07:25 INFO - 'LANG': 'en_US.UTF-8', 05:07:25 INFO - 'LANGUAGE': 'en_US:en', 05:07:25 INFO - 'LOGNAME': 'cltbld', 05:07:25 INFO - 'MAIL': '/var/mail/cltbld', 05:07:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:25 INFO - 'MOZ_NO_REMOTE': '1', 05:07:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:25 INFO - 'NO_EM_RESTART': '1', 05:07:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:25 INFO - 'PWD': '/builds/slave/test', 05:07:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:25 INFO - 'SHELL': '/bin/bash', 05:07:25 INFO - 'SHLVL': '1', 05:07:25 INFO - 'TERM': 'linux', 05:07:25 INFO - 'TMOUT': '86400', 05:07:25 INFO - 'USER': 'cltbld', 05:07:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577', 05:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:25 INFO - '_': '/tools/buildbot/bin/python'} 05:07:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 05:07:26 INFO - mozversion application_buildid: 20160428023625 05:07:26 INFO - mozversion application_changeset: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee 05:07:26 INFO - mozversion application_display_name: Nightly 05:07:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:26 INFO - mozversion application_name: Firefox 05:07:26 INFO - mozversion application_remotingname: firefox 05:07:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:26 INFO - mozversion application_vendor: Mozilla 05:07:26 INFO - mozversion application_version: 48.0a1 05:07:26 INFO - mozversion platform_buildid: 20160428023625 05:07:26 INFO - mozversion platform_changeset: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee 05:07:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:26 INFO - mozversion platform_version: 48.0a1 05:07:26 INFO - using testdate: 1461845246 05:07:26 INFO - actual date: 1461845246 05:07:26 INFO - starting webserver on 'localhost:58306' 05:07:26 INFO - SUITE-START | Running 2 tests 05:07:26 INFO - TEST-START | dromaeo_css 05:07:26 INFO - operating with platform_type : linux_ 05:07:26 INFO - Initialising browser for dromaeo_css test... 05:07:26 INFO - TEST-INFO | started process 29039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp59SZB7/profile http://localhost:58306/getInfo.html) 05:07:29 INFO - PROCESS | 29039 | 05:07:29 INFO - PROCESS | 29039 | (process:29109): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:30 INFO - PROCESS | 29039 | __metrics Screen width/height:1600/1200 05:07:30 INFO - PROCESS | 29039 | colorDepth:24 05:07:30 INFO - PROCESS | 29039 | Browser inner width/height: 1024/697 05:07:30 INFO - PROCESS | 29039 | __metrics 05:07:31 ERROR - PROCESS | 29039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:07:32 INFO - TEST-INFO | 29039: exit 0 05:07:32 INFO - Browser initialized. 05:07:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:32 INFO - TEST-INFO | started process 29160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp59SZB7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:34 INFO - PROCESS | 29160 | 05:07:34 INFO - PROCESS | 29160 | (process:29222): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:44 INFO - PROCESS | 29160 | RSS: Main: 164626432 05:07:44 INFO - PROCESS | 29160 | 05:08:33 INFO - PROCESS | 29160 | 1461845313622 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] 05:10:41 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58306/tests/dromaeo/cssquery-ext.html) 05:10:42 INFO - PROCESS | 29160 | RSS: Main: 170430464 05:10:42 INFO - PROCESS | 29160 | 05:13:44 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-ext.html (next: http://localhost:58306/tests/dromaeo/cssquery-jquery.html) 05:13:45 INFO - PROCESS | 29160 | RSS: Main: 167280640 05:13:45 INFO - PROCESS | 29160 | 05:16:47 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58306/tests/dromaeo/cssquery-mootools.html) 05:16:47 INFO - PROCESS | 29160 | RSS: Main: 168280064 05:16:47 INFO - PROCESS | 29160 | 05:19:49 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58306/tests/dromaeo/cssquery-prototype.html) 05:19:49 INFO - PROCESS | 29160 | RSS: Main: 166039552 05:19:49 INFO - PROCESS | 29160 | 05:22:52 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58306/tests/dromaeo/cssquery-yui.html) 05:22:52 INFO - PROCESS | 29160 | RSS: Main: 166719488 05:22:52 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | Cycle 1(1): loaded http://localhost:58306/tests/dromaeo/cssquery-yui.html (next: http://localhost:58306/tests/dromaeo/cssquery-dojo.html) 05:25:55 INFO - PROCESS | 29160 | RSS: Main: 169041920 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | __start_tp_report 05:25:55 INFO - PROCESS | 29160 | _x_x_mozilla_page_load 05:25:55 INFO - PROCESS | 29160 | _x_x_mozilla_page_load_details 05:25:55 INFO - PROCESS | 29160 | |i|pagename|runs| 05:25:55 INFO - PROCESS | 29160 | |0;dojo.html;3138.0428969164404;3177.094528059503;3177.2215807127227;3221.710046095851;3222.6777322267762;5486.615936884415;5498.697571633558;5503.11950087986;5510.862228444291;5528.5024347808685;5348.732563371826;5481.780728770855;5531.032069387861;5613.550915926727;5624.775008999645;4923.040007198607;4947.134251505972;4989.550940415362;5019.723915184663;5044.596432285427;4902.754862256891;5058.392992840864;5077.162268225757;5079.212722028092;5106.846794596149;4988.301637770697;4996.300517927475;5005.6496045276845;5039.798408063673;5081.669691470042;4933.062718083553;4934.432540257881;4943.456219815817;4969.155243608595;4985.302057711923;4932.383452068491;4934.284528743348;4934.358533390637;4935.963447675957;4968.22992436173;5201.1678131498775;5381.192821076831;5392.4337944515655;5398.676079435247;5460.6177567570285;5836.88326233473;5849.268841394825;5858.794942177046;5869.85325366865;5874.060150375919;5874.882502349972;5915.1718759373725;5922.674252916088;5925.7333419995775;5935.1987481690285;5487.670739755627;5503.6147469677135;5520.972395138079;5552.250446189793;5554.833354999357;5889.028310328834;5895.115732640138;5895.35151133375;5906.350301466835;5922.230110085661;5654.37801841797;5665.2635157430095;5671.007573674673;5689.288838895138;5721.5708821838525;5872.882542349214;5873.765049398062;5881.764729410861;5894.056950887837;5916.881662366729;5644.294463192101;5806.593538452352;5857.121431785266;5875.764969401176;5899.882002359929;5653.123765816223;5744.908467391182;5770.019096753562;5837.91998480274;5846.649201047951;4385.232584297799;4404.8458303959205;4409.4488188976375;4415.558444155558;4451.287793952952;3891.64975152232;3899.3566061600086;3903.8048097595006;3938.6061393860386;3943.960560394359;5491.148871924778;5491.643043202179;5592.384837667853;5602.663840169603;5652.547796176296;5929.614575052694;5943.465088142001;5944.732487038007;5944.762209511658;5959.672218027963;5677.659340439587;5685.317761868602;5698.17376480408;5714.171445140514;5717.342505611825;4959.801607935714;5003.674761140514;5041.546260836542;5061.215511595635;5065.062963351718;5993.250843644544;5993.790217342372;6000.129981152709;6007.609505382136;6051.062085376773;5796.971015145066;5802.82591522255;5819.301683797971;5819.970900145472;5828.737706803119;5989.460948514655;6002.579819412599;6010.669413182317;6053;6135.662538560422;5816.912746308724;5823.388544202798;5834.38738932406;5836.708164591839;5848.941510584839;5851.473367396955;5948.048312270016;5959.7020148991505;5972.581919265784;5978.521718262442;5635.436456354331;5674.375818660027;5735.627184233012;5786.9131963019745;5801.129830525455;5729.169270455677;5737.282839645044;5759;5771.3651498335985;5817.156512305776;5526.198701188386;5553.8333849984565;5561.777528898799;5562.749676264659;5565.415631358649;5653.773849045992;5700.828975130753;5780.479756821906;5906.70466476683;5915.053591425351;5651.576131790214;5688.3742788294085;5694.06048002075;5701.572382071278;5710.771569137188 05:25:55 INFO - PROCESS | 29160 | |1;ext.html;609.2658346692234;618.8143556932922;645.4642646603319;654.3227759269156;675.820907459523;36511.4523282151;37716.81141594292;37777.43333849991;37941.81029094851;38025.80987095061;35751.4637280441;35918.46122308167;36236;37203.25593488129;37426;8403.747887563382;8550.187732165434;8564.48613083214;8566.61450234741;8580.828383432328;8396.244338009577;8696.869546956801;8743.344249181306;8744.081871403507;8775.736727898173;8703.825923481527;8730.126987301252;8762.167594078552;8819.206271435569;8830.823383532326;8697.869531957025;8747.956260218658;8764.8685269721;8773.736787896374;8783;8668.306535477146;8725.694600688945;8744.8688269676;8793.7801554961;8809.515476648781;29212;38609;39332.80333598314;39364.80317598422;39383.606163938566;3379.8986030418882;3398.677125673057;3527.94708079379;3571.964280357189;3580.820958952042;28526.572101418496;28748.281292967633;29281;29355.55966660502;29420.264493387836;3700.611435799229;3724.646158614927;3741.1395379062697;3760.1539653578;3803.5435747710176;222547;224314.87842560845;224630;225008;226202;31926.361472770415;32951.3409731804;34513.827430862686;34755.82622086874;34759.4786078209;33834.15414614605;33844.49233261503;33882.491762623584;34037.82981085128;34054;14820.814334853187;14977.625559360886;14999.17504537239;15015.549533514011;15046.097234165985;11343.829842552368;11476.139289553317;11478.598249061242;11487.885121148849;11517.136214783925;8422.24199822019;8473.195046470575;8519.446235994641;8574.657013719507;8579.099194584604;3209.727173190305;3247.269364392993;3254.1051210917185;3273.7217336526187;3281.934361312808;1071.2073065931154;1083.8103331916882;1087.9292845964987;1096.270979798425;1108.296231892754;29502.409951800844;29997.25006874802;30074.097777066723;30209.395812083636;33153.66846331506;1103.442761405485;1124.9100071994221;1164.5283660117666;1182.5920057580292;1196.491491116272;15072.623184420258;16242.837571624368;16370.590735231715;16384.426545070866;16469.58826029359;520485;521407;527559;530000;530883;56497.91518763331;57216.141757873665;57343;57361.71319143461;57389;1250.4310538704867;1268.7145392286661;1289.548657969703;1357.755603991291;1520.5818399940106;31130.53304200484;31253;31568.842155789993;31800.36399272048;32069.35861282808;50234.24648630347;50985.23522147097;51151;51308.74345628248;51336.71658208575;425231;430571;431804;432501;432675;27722.02972895939;27971.300717482227;27990.160295191177;28029.719702803526;28053.579196311664;45718.542814571425;47182.528174719184;47431;47668;47723.761381192875;38993;39031.804840975616;39037;39937.40093898536;40274.395884062345;39393.40909886297;39460;39473.60526394699;40380.1923961525;40481.59518404778;39142.804285979524;40012.39981400223;40799.59200407958;40912.59087409088;41027;33751.32497350089;35230.64769352274;35349;35595;36273.455898161024;27620;28009.439811203254;28094.71905280921;28266.85866570654;28324.433511329247 05:25:55 INFO - PROCESS | 29160 | |2;jquery.html;390.3773481297333;393.56314490915076;394.8894309593314;398.68703068091554;411.78998710657555;17572;17619.55951101223;18202.5449363766;18216.90891545542;18220;16383.91808040961;16747.83252167478;16946.661066778688;17034;17457.73813392797;5700.401457846929;5748.856278593037;5917.378675239102;5921.319048309457;5927.081302398114;5815.767369305223;5831.825045248649;5834.445727655887;5858.41415858415;5870.11948207768;5728.914066289009;5753.942460575383;5789.102689083199;5802.767889284423;5816.1275808628625;5787.652740835563;5789;5844.26946631671;5848.385919478457;5851.122331650244;5116.386033675945;5140.511651393112;5192.92210616841;5386.542143917733;5397.514223719884;12051.457684404222;12183.573574924834;12225.755484890342;17566.560835979075;23360.883195584083;2245.0682966568857;2331.825113116506;2340.099061861196;2405.5910495215853;2442.560339138954;9637.518124093767;9766.218702503782;9814.803703925882;9850.21198304134;12825.35873206336;1829.5791967847338;1934.477691023416;1953.5897461533095;1957.8335841453493;1982.8215460608615;73247;75682.24317756807;76680.61659691666;83324.16675833224;83680.16319836785;10063.094321511098;10396.376217426978;10596.15230781551;10829.783404331869;10917;14892.925535372255;14904.776428353583;14915.403383864741;14927.104373737393;15027.774583381259;7906.525608463396;7948.523088614586;8053.758387248392;8160.30637395828;8366.163383661586;7837.09873364559;7898.091719452222;7956.562389068657;8029.7189598363775;8159.836803263902;4456.6211871991245;4502.122086193161;4525.818967241339;4625.3755742974945;4655.4878963314;1840.162725959685;1857.0993068361834;1865.0488250992091;1865.1140708163514;1998.8700734452214;882.3955590420583;979.1285755677453;997.3367710472454;1006.2050979726081;1077.095239998405;17350;18269.81730182708;19040.809591903904;19067.61864762697;19372;1036.7874585710063;1039.2517387481003;1047.8323468245044;1058.767071244325;1064.3986147826608;10235.692929212135;10593;10635.94682026585;10751.301165424222;10753.462326883624;474129;479310;496027;499401;501158;54423.18365224525;71501.6424917872;82184;95617;96570.51714741382;1017.7099526634873;1018.6282007067515;1053.7997780421695;1064.5209655654987;1072.6192201768415;15849.286782095063;15953.521394358188;15987.760183597487;16364.590885227488;16367.59081022984;34902.30195396129;35941.460878087375;36088.45867312045;36622;36790;48778.512214877395;49627;57671;57810.42189578219;57869.710651446476;8061.113277539349;8329.916700832913;8333.791655208668;8386.203310685476;8483.787905302417;12756.425960831599;13017.349132543524;13023.739525209254;13095.41070651804;13205.735885282049;10870.61952831647;11354.772904542027;11403.201775875941;11495.54017839277;11619.593314233962;11371.374574398156;11373;11526.423678816192;11694.649160525198;11787.233829801036;10787.680648660576;10901.890981090404;11129.833052504056;11136.55453781872;11576.94211528937;7885.605719713876;8225.341972642054;8293.95853020731;8408.789780255542;8577.95711021441;9964.302498825013;10625.628103016357;10986.066184374098;11160.49777760019;11332.92337227962 05:25:55 INFO - PROCESS | 29160 | |3;mootools.html;1426.26547328126;1504.9021813582117;1518.9240537973099;1564.4289834210517;1622.3510595761702;7514.211007844179;8112.351011919047;8179.100298967109;8468.576571171448;8470.19533144351;8218.547979861105;8245.958770206156;8253.91746082539;8311.958440207805;8324.75025749227;2281.258590957941;2331.300609817048;2335.6613291072786;2339.146211632759;2342.7774361435636;2141;2155.7736437674052;2189.901454434554;2201.515666553356;2204.8456608037445;2253.0537174386714;2259.45773014477;2272.715910511186;2297.4945511987335;2306.3542208181734;2260.954780904373;2272.306946381353;2274.169927976285;2274.2040285899884;2276.886155692217;2247.359502541784;2249.7750224977535;2278.9658155127686;2282.132789539981;2285.5543169082034;8436.873446898302;8467.872981905277;8509.957450212709;8514.82970340596;8527.872081918715;4834.468208497063;5048.29323894655;5056.772445239973;5057.418396884369;5065.898682026375;3123.437781199383;3219.3561287742546;3306.322203948185;3310.933781324384;3320.053784671357;1038.1176000399676;1046.487221261584;1079.703081652544;1082.2045796339685;1097.5280629329386;11428.942855285753;11531.94234028833;11551.711207219803;11568.884311156864;11614.825777613343;4541.568550987651;4574.473935497461;4654.441467023911;4658.790354434059;4668.3697700810635;9881.061299176567;9883.11052005323;9903.059209375098;9917.504124793732;9936.304458687822;5128.743562821844;5137.640365174477;5160.071187186342;5165.457626949192;5180.766865491062;4200.537940826506;4541.591256786905;4544.727316361029;4604.1712491751805;4631.3516107744945;3795.1271207622403;3803.6006219347123;3869.400242962345;3887.1059656279213;3902.6292502212245;1254.7239607286565;1266.6200139957975;1270.885620294178;1283.159530507519;1285.9035572332114;996.4220751963844;1032.1587905856702;1033.121846430528;1039.599754094679;1046.4663021858908;5801.245838041112;5827.067669172912;5845.707714614252;5893.5874488785375;5921.96365636012;941.7692665297046;956.6221342569785;970.4856426094041;999.8550210219478;1040.2718097331897;3791.9810400947817;3874.3026255273758;3881.8059097045034;4037.515498140242;4066.1257829566784;9943.701688949199;10231.897681023243;10330.380177189392;10375.118114960162;10431.478426078666;9950.154236889946;10229;10291.53688084038;10319.948400258101;10412.375257484575;7282.453815963824;7293.9635301823155;7334.339909408179;7514.736984205527;7638.732644357421;5710.857228569319;5747.5401967841635;5792.94207057924;5803.3616302207565;5857.7949771757785;9152.542372881197;9357.344985850925;9581.712548623553;9636.71089867305;9732;9372.109649583279;9541.284403669613;9592.66425675098;9749.610015599581;9755.073268039525;7008.5094043416475;7553.924460755322;7749.3413059890545;7773.144954055162;8038.397120216124;7826.686932522635;7899.921000789918;7904.802379940547;7921.485103468487;7969.721059763112;6920.723171073302;7230;7239.312265334785;7285.526440781332;7331.486795924234;7208;7301.561906285639;7328.047353844179;7337.657185925551;7400.59296738663;6427.935720642734;6617.106690596708;6622.337766223339;6627.966860165861;6632.071509988702;4885.389326334208;5005.074061298671;5063.265826455217;5068.037072956126;5174.223866419917;4934.777934993006;5019.62352823547;5024.547790698854;5045.823396181116;5077.619178561697 05:25:55 INFO - PROCESS | 29160 | |4;prototype.html;301.60640364324547;313.3685623468711;318.3124451185439;321.0352889566853;322.94994275887245;5402.270693456382;5497.972510137443;5539.723013849307;5624.578156638248;5685.4030326815655;5526.889462210764;5577.69322687252;5577.8047768328115;5579.972100139494;5592.328920529542;4302.655787537005;4315.093830295642;4316.575530075075;4319.935200971988;4324.740515569076;4173.142951386634;4316.892077698067;4317.676174286926;4332.591907630032;4333.393324934512;4222.134462435193;4222.704410691253;4231.70378073535;4246.596573325544;4255.2978758504805;4238.957610423887;4255.5744425557505;4259.595338442874;4276.893077673052;4302.075053863435;3475.5481787367735;3727.291814555253;3736.6263373662687;3745.3632882410056;3747.362948298796;5264.263003179558;5284.788608455658;5326.387465441485;5354.678719276856;5373.704446255454;4833.589144922686;4850.151223535867;4858.587020103296;4863.19757240055;4904.288878112654;5606.159076138571;5779.393163717791;5789.305283365981;5828.766849326022;5843.883122337529;4020.2160578687167;4021.8190181441905;4043.353063509824;4046.4941882264716;4085.468889044435;6026.397360263983;6059;6065.363136870653;6110.541709371815;6138.877222455526;3994.8801535953967;4099.364598487239;4104.220198162399;4108.301588729923;4122.443470131554;4168.333066709312;4173.144505376391;4182.9790851046155;4192.161567686475;4193.769342686121;4793.1372352976105;4828.203346447867;4853.369062021915;4854.417469903634;4864.246041863516;5472.753726082336;5525.254090697785;5805.303363596396;5843.3864444233595;5859.853503662443;1485.7994170786806;1494.8430414806505;1504.3230546254229;1507.3970411835135;1509.1096253210658;986.1075726467558;988.5600907596195;993.1806259835664;1004.4977511244377;1005.9346142500714;6005.3694362091355;6021.3677563856045;6033.758649653964;6047.15339852421;6061.151438798572;6410.391012853772;6441.420272175526;6451.548391612542;6467.641795223056;6507.804765857032;5897.970510147422;5898.528117750569;6028.276606807123;6057.151998720183;6066.211392519032;3419.9145021374666;3449.2411669433186;3454.240067185215;3465.636108208602;3473.8362648512525;6017.909731354033;6270.811875643738;6304.968475157595;6694.397504224643;6717.764878229238;6182.795698924684;6213.37866213375;6223.919160015821;6235.469985051322;6253;6101.420365065312;6214.316425193135;6241.656708881055;6249.937510623205;6270.122182894398;6007.30915944672;6010.87978240424;6027.156198132353;6027.367126451835;6084.6349219047;5929.822105336847;5965.791197308074;5976.312724036791;6010.338862725184;6020.187274717857;6093.75624974996;6121.65323628801;6255.843603909939;6280.152179455715;6304.779332723516;4036.2936486114227;4095.6313931746286;4109.260333140063;4112.691548133842;4135.77253251062;5756.251687280626;5767.798127065533;6038.577299589162;6084.787032453843;6126.417990290915;5847.918135145012;5874.735636896265;5876.823695289148;5908.822735317947;5921.940780592139;5848.181254624271;5860.355360910211;5865.149553314831;5884.6469211847425;5912.793052243323;5539.41836107219;5727.914081288701;5747.942520574908;5762.193292939076;5762.2221000164445;5839.649621022582;5890.440408161217;5906.320773110975;5908.409159084229;5946.197263369563;5538.224648549126;5810.680412577349;5816.243888294494;5817.709114544171;5821.476067153807 05:25:55 INFO - PROCESS | 29160 | |5;yui.html;655.8721049395367;681.2131987554376;694.4791406445166;717.8707832590135;719.5394947233768;11326.660200193997;12030.639080827566;12144.514219431223;12227.205231659937;13018.674533136653;12596;12632.557860474884;12668.113232073758;12673.239605623668;12687.238765674043;772.8995230620012;808.0545761459092;812.3866480806983;813.5850716134755;815.4373482297226;775.4533054196778;775.5308038636629;778.7352300217925;784.301971245589;789.8420315936806;816.1919699497514;816.1919699497514;817.5340056167987;818.2553875972866;818.5825229133126;810.2748040503775;811.5698679699768;812.9146439623843;813.0730966697969;817.3624572833199;597.1788790413182;597.2265915639258;597.4175179200288;601.0203368509345;603.3905755187249;11976.820347694791;12043.879561204363;12058.939705301418;12080.516779328816;12091.576794812227;11196.216264861463;11560.479778409992;11660.650180494598;11878.584249551224;12037.458314375786;10150.086492215662;10202.686638135972;10347.793044139074;10414.27100102993;10515.842262365994;3585.748997570171;3585.964140358615;3614.222942067468;3678.9448158277646;3681.1901381695984;60652.696736516475;60847.39152608462;61083.08375374373;61182.69408652973;61301.08048379322;9541.809163816684;9652.75868103303;9679.370840895319;9862;9970.700878973643;17641.94148351103;17662.470125896245;17750;18025.909870450825;18119.45641630753;7229;7240.275972402717;7266;7301.817454563678;7369.6315184240575;4119.855805046809;4129.380592911088;4145.709800313949;4211.684123690736;4230.027093768389;2887.7112288771373;2995.3859458810894;2995.5207166853197;2995.550667399864;3002.1143762590086;547.2912578211226;561.4553882733742;569.0354848531699;569.2485918587424;575.04255414734;711.7544447165719;714.7891372045259;719.5502810743285;725.804032911111;732.9926700733031;8387.245147936716;8428.32573394127;8594.527300998505;8743.56282185888;8778.692745753868;544.6187668631974;591.6006695480534;635.5519358851998;661.1075048684238;725.2421219825295;4095.713300069026;4112.547619761824;4126.834926602963;4162.708610397303;4227.32362821947;56921.715391423604;57488;58855;58884.11673824896;59077.11384329238;53949;54138.45861541334;54620;55100.17349739757;56266.71866640641;48240.27639585409;49269;49507;49938.001239975;50244.74877625588;7768.61156942162;8081.63632636521;8118.472299300526;8134.593270336578;8205.876911846208;33657.15857103592;33874.66125338715;34239.14402139966;34508.13729656678;34976.30047399089;40875.38686919758;43298;43915.34126988162;44714;44747.88130296769;9582.712518624452;9809.068138527115;9840.458774767456;9974.251931105342;10249.38503689781;9978.650747223812;10475.580976760844;10617.681469555926;10838;11028.503717332578;10014.298999069995;10208.846867296848;10409.47952602382;10457.111145552713;10559.472026398804;10143.34068285559;10335.844962325722;10491.842622360824;10516;10619.94690026545;9973.700788976343;10025.398476091457;10070;10082.747931301776;10130.341527800669;8561.657533698832;8647.135286471303;8647.437916535406;8791.296696264155;8923.196912277926;8689.478631282143;8888.066752990842;8940.284777217677;9046.954765226132;9047.864282035905 05:25:55 INFO - PROCESS | 29160 | __end_tp_report 05:25:55 INFO - PROCESS | 29160 | __start_cc_report 05:25:55 INFO - PROCESS | 29160 | _x_x_mozilla_cycle_collect,355 05:25:55 INFO - PROCESS | 29160 | __end_cc_report 05:25:55 INFO - PROCESS | 29160 | __startTimestamp1461846355340__endTimestamp 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | ------- Summary: start ------- 05:25:55 INFO - PROCESS | 29160 | Number of tests: 6 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | [#0] dojo.html Cycles:165 Average:5442.50 Median:5671.01 stddev:625.08 (11.0%) stddev-sans-first:600.28 05:25:55 INFO - PROCESS | 29160 | Values: 3138.0 3177.1 3177.2 3221.7 3222.7 5486.6 5498.7 5503.1 5510.9 5528.5 5348.7 5481.8 5531.0 5613.6 5624.8 4923.0 4947.1 4989.6 5019.7 5044.6 4902.8 5058.4 5077.2 5079.2 5106.8 4988.3 4996.3 5005.6 5039.8 5081.7 4933.1 4934.4 4943.5 4969.2 4985.3 4932.4 4934.3 4934.4 4936.0 4968.2 5201.2 5381.2 5392.4 5398.7 5460.6 5836.9 5849.3 5858.8 5869.9 5874.1 5874.9 5915.2 5922.7 5925.7 5935.2 5487.7 5503.6 5521.0 5552.3 5554.8 5889.0 5895.1 5895.4 5906.4 5922.2 5654.4 5665.3 5671.0 5689.3 5721.6 5872.9 5873.8 5881.8 5894.1 5916.9 5644.3 5806.6 5857.1 5875.8 5899.9 5653.1 5744.9 5770.0 5837.9 5846.6 4385.2 4404.8 4409.4 4415.6 4451.3 3891.6 3899.4 3903.8 3938.6 3944.0 5491.1 5491.6 5592.4 5602.7 5652.5 5929.6 5943.5 5944.7 5944.8 5959.7 5677.7 5685.3 5698.2 5714.2 5717.3 4959.8 5003.7 5041.5 5061.2 5065.1 5993.3 5993.8 6000.1 6007.6 6051.1 5797.0 5802.8 5819.3 5820.0 5828.7 5989.5 6002.6 6010.7 6053.0 6135.7 5816.9 5823.4 5834.4 5836.7 5848.9 5851.5 5948.0 5959.7 5972.6 5978.5 5635.4 5674.4 5735.6 5786.9 5801.1 5729.2 5737.3 5759.0 5771.4 5817.2 5526.2 5553.8 5561.8 5562.7 5565.4 5653.8 5700.8 5780.5 5906.7 5915.1 5651.6 5688.4 5694.1 5701.6 5710.8 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | [#1] ext.html Cycles:180 Average:53523.78 Median:20451.93 stddev:110286.92 (539.2%) stddev-sans-first:110524.74 05:25:55 INFO - PROCESS | 29160 | Values: 609.3 618.8 645.5 654.3 675.8 36511.5 37716.8 37777.4 37941.8 38025.8 35751.5 35918.5 36236.0 37203.3 37426.0 8403.7 8550.2 8564.5 8566.6 8580.8 8396.2 8696.9 8743.3 8744.1 8775.7 8703.8 8730.1 8762.2 8819.2 8830.8 8697.9 8748.0 8764.9 8773.7 8783.0 8668.3 8725.7 8744.9 8793.8 8809.5 29212.0 38609.0 39332.8 39364.8 39383.6 3379.9 3398.7 3527.9 3572.0 3580.8 28526.6 28748.3 29281.0 29355.6 29420.3 3700.6 3724.6 3741.1 3760.2 3803.5 222547.0 224314.9 224630.0 225008.0 226202.0 31926.4 32951.3 34513.8 34755.8 34759.5 33834.2 33844.5 33882.5 34037.8 34054.0 14820.8 14977.6 14999.2 15015.5 15046.1 11343.8 11476.1 11478.6 11487.9 11517.1 8422.2 8473.2 8519.4 8574.7 8579.1 3209.7 3247.3 3254.1 3273.7 3281.9 1071.2 1083.8 1087.9 1096.3 1108.3 29502.4 29997.3 30074.1 30209.4 33153.7 1103.4 1124.9 1164.5 1182.6 1196.5 15072.6 16242.8 16370.6 16384.4 16469.6 520485.0 521407.0 527559.0 530000.0 530883.0 56497.9 57216.1 57343.0 57361.7 57389.0 1250.4 1268.7 1289.5 1357.8 1520.6 31130.5 31253.0 31568.8 31800.4 32069.4 50234.2 50985.2 51151.0 51308.7 51336.7 425231.0 430571.0 431804.0 432501.0 432675.0 27722.0 27971.3 27990.2 28029.7 28053.6 45718.5 47182.5 47431.0 47668.0 47723.8 38993.0 39031.8 39037.0 39937.4 40274.4 39393.4 39460.0 39473.6 40380.2 40481.6 39142.8 40012.4 40799.6 40912.6 41027.0 33751.3 35230.6 35349.0 35595.0 36273.5 27620.0 28009.4 28094.7 28266.9 28324.4 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | [#2] jquery.html Cycles:180 Average:27883.19 Median:2424.08 stddev:80592.41 (3324.7%) stddev-sans-first:80792.06 05:25:55 INFO - PROCESS | 29160 | Values: 390.4 393.6 394.9 398.7 411.8 17572.0 17619.6 18202.5 18216.9 18220.0 16383.9 16747.8 16946.7 17034.0 17457.7 5700.4 5748.9 5917.4 5921.3 5927.1 5815.8 5831.8 5834.4 5858.4 5870.1 5728.9 5753.9 5789.1 5802.8 5816.1 5787.7 5789.0 5844.3 5848.4 5851.1 5116.4 5140.5 5192.9 5386.5 5397.5 12051.5 12183.6 12225.8 17566.6 23360.9 2245.1 2331.8 2340.1 2405.6 2442.6 9637.5 9766.2 9814.8 9850.2 12825.4 1829.6 1934.5 1953.6 1957.8 1982.8 73247.0 75682.2 76680.6 83324.2 83680.2 10063.1 10396.4 10596.2 10829.8 10917.0 14892.9 14904.8 14915.4 14927.1 15027.8 7906.5 7948.5 8053.8 8160.3 8366.2 7837.1 7898.1 7956.6 8029.7 8159.8 4456.6 4502.1 4525.8 4625.4 4655.5 1840.2 1857.1 1865.0 1865.1 1998.9 882.4 979.1 997.3 1006.2 1077.1 17350.0 18269.8 19040.8 19067.6 19372.0 1036.8 1039.3 1047.8 1058.8 1064.4 10235.7 10593.0 10635.9 10751.3 10753.5 474129.0 479310.0 496027.0 499401.0 501158.0 54423.2 71501.6 82184.0 95617.0 96570.5 1017.7 1018.6 1053.8 1064.5 1072.6 15849.3 15953.5 15987.8 16364.6 16367.6 34902.3 35941.5 36088.5 36622.0 36790.0 48778.5 49627.0 57671.0 57810.4 57869.7 8061.1 8329.9 8333.8 8386.2 8483.8 12756.4 13017.3 13023.7 13095.4 13205.7 10870.6 11354.8 11403.2 11495.5 11619.6 11371.4 11373.0 11526.4 11694.6 11787.2 10787.7 10901.9 11129.8 11136.6 11576.9 7885.6 8225.3 8294.0 8408.8 8578.0 9964.3 10625.6 10986.1 11160.5 11332.9 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | [#3] mootools.html Cycles:180 Average:5534.11 Median:5052.53 stddev:3073.78 (60.8%) stddev-sans-first:3066.90 05:25:55 INFO - PROCESS | 29160 | Values: 1426.3 1504.9 1518.9 1564.4 1622.4 7514.2 8112.4 8179.1 8468.6 8470.2 8218.5 8246.0 8253.9 8312.0 8324.8 2281.3 2331.3 2335.7 2339.1 2342.8 2141.0 2155.8 2189.9 2201.5 2204.8 2253.1 2259.5 2272.7 2297.5 2306.4 2261.0 2272.3 2274.2 2274.2 2276.9 2247.4 2249.8 2279.0 2282.1 2285.6 8436.9 8467.9 8510.0 8514.8 8527.9 4834.5 5048.3 5056.8 5057.4 5065.9 3123.4 3219.4 3306.3 3310.9 3320.1 1038.1 1046.5 1079.7 1082.2 1097.5 11428.9 11531.9 11551.7 11568.9 11614.8 4541.6 4574.5 4654.4 4658.8 4668.4 9881.1 9883.1 9903.1 9917.5 9936.3 5128.7 5137.6 5160.1 5165.5 5180.8 4200.5 4541.6 4544.7 4604.2 4631.4 3795.1 3803.6 3869.4 3887.1 3902.6 1254.7 1266.6 1270.9 1283.2 1285.9 996.4 1032.2 1033.1 1039.6 1046.5 5801.2 5827.1 5845.7 5893.6 5922.0 941.8 956.6 970.5 999.9 1040.3 3792.0 3874.3 3881.8 4037.5 4066.1 9943.7 10231.9 10330.4 10375.1 10431.5 9950.2 10229.0 10291.5 10319.9 10412.4 7282.5 7294.0 7334.3 7514.7 7638.7 5710.9 5747.5 5792.9 5803.4 5857.8 9152.5 9357.3 9581.7 9636.7 9732.0 9372.1 9541.3 9592.7 9749.6 9755.1 7008.5 7553.9 7749.3 7773.1 8038.4 7826.7 7899.9 7904.8 7921.5 7969.7 6920.7 7230.0 7239.3 7285.5 7331.5 7208.0 7301.6 7328.0 7337.7 7400.6 6427.9 6617.1 6622.3 6628.0 6632.1 4885.4 5005.1 5063.3 5068.0 5174.2 4934.8 5019.6 5024.5 5045.8 5077.6 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | [#4] prototype.html Cycles:180 Average:4938.57 Median:5654.99 stddev:1492.16 (26.4%) stddev-sans-first:1455.19 05:25:55 INFO - PROCESS | 29160 | Values: 301.6 313.4 318.3 321.0 322.9 5402.3 5498.0 5539.7 5624.6 5685.4 5526.9 5577.7 5577.8 5580.0 5592.3 4302.7 4315.1 4316.6 4319.9 4324.7 4173.1 4316.9 4317.7 4332.6 4333.4 4222.1 4222.7 4231.7 4246.6 4255.3 4239.0 4255.6 4259.6 4276.9 4302.1 3475.5 3727.3 3736.6 3745.4 3747.4 5264.3 5284.8 5326.4 5354.7 5373.7 4833.6 4850.2 4858.6 4863.2 4904.3 5606.2 5779.4 5789.3 5828.8 5843.9 4020.2 4021.8 4043.4 4046.5 4085.5 6026.4 6059.0 6065.4 6110.5 6138.9 3994.9 4099.4 4104.2 4108.3 4122.4 4168.3 4173.1 4183.0 4192.2 4193.8 4793.1 4828.2 4853.4 4854.4 4864.2 5472.8 5525.3 5805.3 5843.4 5859.9 1485.8 1494.8 1504.3 1507.4 1509.1 986.1 988.6 993.2 1004.5 1005.9 6005.4 6021.4 6033.8 6047.2 6061.2 6410.4 6441.4 6451.5 6467.6 6507.8 5898.0 5898.5 6028.3 6057.2 6066.2 3419.9 3449.2 3454.2 3465.6 3473.8 6017.9 6270.8 6305.0 6694.4 6717.8 6182.8 6213.4 6223.9 6235.5 6253.0 6101.4 6214.3 6241.7 6249.9 6270.1 6007.3 6010.9 6027.2 6027.4 6084.6 5929.8 5965.8 5976.3 6010.3 6020.2 6093.8 6121.7 6255.8 6280.2 6304.8 4036.3 4095.6 4109.3 4112.7 4135.8 5756.3 5767.8 6038.6 6084.8 6126.4 5847.9 5874.7 5876.8 5908.8 5921.9 5848.2 5860.4 5865.1 5884.6 5912.8 5539.4 5727.9 5747.9 5762.2 5762.2 5839.6 5890.4 5906.3 5908.4 5946.2 5538.2 5810.7 5816.2 5817.7 5821.5 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - PROCESS | 29160 | [#5] yui.html Cycles:180 Average:13941.53 Median:28414.09 stddev:17273.57 (60.8%) stddev-sans-first:17293.22 05:25:55 INFO - PROCESS | 29160 | Values: 655.9 681.2 694.5 717.9 719.5 11326.7 12030.6 12144.5 12227.2 13018.7 12596.0 12632.6 12668.1 12673.2 12687.2 772.9 808.1 812.4 813.6 815.4 775.5 775.5 778.7 784.3 789.8 816.2 816.2 817.5 818.3 818.6 810.3 811.6 812.9 813.1 817.4 597.2 597.2 597.4 601.0 603.4 11976.8 12043.9 12058.9 12080.5 12091.6 11196.2 11560.5 11660.7 11878.6 12037.5 10150.1 10202.7 10347.8 10414.3 10515.8 3585.7 3586.0 3614.2 3678.9 3681.2 60652.7 60847.4 61083.1 61182.7 61301.1 9541.8 9652.8 9679.4 9862.0 9970.7 17641.9 17662.5 17750.0 18025.9 18119.5 7229.0 7240.3 7266.0 7301.8 7369.6 4119.9 4129.4 4145.7 4211.7 4230.0 2887.7 2995.4 2995.5 2995.6 3002.1 547.3 561.5 569.0 569.2 575.0 711.8 714.8 719.6 725.8 733.0 8387.2 8428.3 8594.5 8743.6 8778.7 544.6 591.6 635.6 661.1 725.2 4095.7 4112.5 4126.8 4162.7 4227.3 56921.7 57488.0 58855.0 58884.1 59077.1 53949.0 54138.5 54620.0 55100.2 56266.7 48240.3 49269.0 49507.0 49938.0 50244.7 7768.6 8081.6 8118.5 8134.6 8205.9 33657.2 33874.7 34239.1 34508.1 34976.3 40875.4 43298.0 43915.3 44714.0 44747.9 9582.7 9809.1 9840.5 9974.3 10249.4 9978.7 10475.6 10617.7 10838.0 11028.5 10014.3 10208.8 10409.5 10457.1 10559.5 10143.3 10335.8 10491.8 10516.0 10619.9 9973.7 10025.4 10070.0 10082.7 10130.3 8561.7 8647.1 8647.4 8791.3 8923.2 8689.5 8888.1 8940.3 9047.0 9047.9 05:25:55 INFO - PROCESS | 29160 | -------- Summary: end -------- 05:25:55 INFO - PROCESS | 29160 | 05:25:55 INFO - TEST-INFO | 29160: exit 0 05:25:56 INFO - TEST-OK | dromaeo_css | took 1109946ms 05:25:56 INFO - TEST-START | kraken 05:25:56 INFO - operating with platform_type : linux_ 05:25:56 INFO - Initialising browser for kraken test... 05:25:56 INFO - TEST-INFO | started process 29400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQykZ6H/profile http://localhost:58306/getInfo.html) 05:25:59 INFO - PROCESS | 29400 | 05:25:59 INFO - PROCESS | 29400 | (process:29469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:26:00 INFO - PROCESS | 29400 | __metrics Screen width/height:1600/1200 05:26:00 INFO - PROCESS | 29400 | colorDepth:24 05:26:00 INFO - PROCESS | 29400 | Browser inner width/height: 1024/697 05:26:00 INFO - PROCESS | 29400 | __metrics 05:26:01 ERROR - PROCESS | 29400 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:26:01 INFO - TEST-INFO | 29400: exit 0 05:26:01 INFO - Browser initialized. 05:26:01 INFO - Running cycle 1/1 for kraken test... 05:26:01 INFO - TEST-INFO | started process 29520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQykZ6H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:03 INFO - PROCESS | 29520 | 05:26:03 INFO - PROCESS | 29520 | (process:29584): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:26:13 INFO - PROCESS | 29520 | RSS: Main: 164614144 05:26:13 INFO - PROCESS | 29520 | 05:26:16 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:17 INFO - PROCESS | 29520 | RSS: Main: 169340928 05:26:17 INFO - PROCESS | 29520 | 05:26:19 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-dft) 05:26:20 INFO - PROCESS | 29520 | RSS: Main: 173199360 05:26:20 INFO - PROCESS | 29520 | 05:26:23 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-fft) 05:26:23 INFO - PROCESS | 29520 | RSS: Main: 163438592 05:26:23 INFO - PROCESS | 29520 | 05:26:26 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58306/tests/kraken/driver.html?testName=audio-oscillator) 05:26:26 INFO - PROCESS | 29520 | RSS: Main: 163643392 05:26:26 INFO - PROCESS | 29520 | 05:26:29 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:29 INFO - PROCESS | 29520 | RSS: Main: 165171200 05:26:29 INFO - PROCESS | 29520 | 05:26:32 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58306/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:33 INFO - PROCESS | 29520 | RSS: Main: 165421056 05:26:33 INFO - PROCESS | 29520 | 05:26:36 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58306/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:37 INFO - PROCESS | 29520 | RSS: Main: 167604224 05:26:37 INFO - PROCESS | 29520 | 05:26:40 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58306/tests/kraken/driver.html?testName=json-parse-financial) 05:26:40 INFO - PROCESS | 29520 | RSS: Main: 168448000 05:26:40 INFO - PROCESS | 29520 | 05:26:42 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:43 INFO - PROCESS | 29520 | RSS: Main: 168153088 05:26:43 INFO - PROCESS | 29520 | 05:26:44 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:45 INFO - PROCESS | 29520 | RSS: Main: 168165376 05:26:45 INFO - PROCESS | 29520 | 05:26:47 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:48 INFO - PROCESS | 29520 | RSS: Main: 168173568 05:26:48 INFO - PROCESS | 29520 | 05:26:50 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:51 INFO - PROCESS | 29520 | RSS: Main: 168529920 05:26:51 INFO - PROCESS | 29520 | 05:26:54 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:54 INFO - PROCESS | 29520 | RSS: Main: 168345600 05:26:54 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | Cycle 1(1): loaded http://localhost:58306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58306/tests/kraken/driver.html?testName=ai-astar) 05:26:56 INFO - PROCESS | 29520 | RSS: Main: 169672704 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | __start_tp_report 05:26:56 INFO - PROCESS | 29520 | _x_x_mozilla_page_load 05:26:56 INFO - PROCESS | 29520 | _x_x_mozilla_page_load_details 05:26:56 INFO - PROCESS | 29520 | |i|pagename|runs| 05:26:56 INFO - PROCESS | 29520 | |0;ai-astar;113;111;116;115;112;124;113;113;114;112 05:26:56 INFO - PROCESS | 29520 | |1;audio-beat-detection;154;141;155;183;130;163;156;131;192;128 05:26:56 INFO - PROCESS | 29520 | |2;audio-dft;162;163;161;163;163;168;166;162;167;164 05:26:56 INFO - PROCESS | 29520 | |3;audio-fft;77;78;73;167;81;77;76;77;162;73 05:26:56 INFO - PROCESS | 29520 | |4;audio-oscillator;92;93;156;92;92;93;153;94;92;148 05:26:56 INFO - PROCESS | 29520 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;118;117;117 05:26:56 INFO - PROCESS | 29520 | |6;imaging-darkroom;146;147;147;150;146;148;147;146;147;146 05:26:56 INFO - PROCESS | 29520 | |7;imaging-desaturate;97;97;95;96;95;95;95;95;95;95 05:26:56 INFO - PROCESS | 29520 | |8;json-parse-financial;58;58;59;58;64;60;57;76;56;56 05:26:56 INFO - PROCESS | 29520 | |9;json-stringify-tinderbox;61;62;62;62;62;63;62;62;64;62 05:26:56 INFO - PROCESS | 29520 | |10;stanford-crypto-aes;78;79;76;85;85;77;79;79;79;85 05:26:56 INFO - PROCESS | 29520 | |11;stanford-crypto-ccm;128;129;126;125;122;126;127;125;161;129 05:26:56 INFO - PROCESS | 29520 | |12;stanford-crypto-pbkdf2;178;166;172;170;171;167;180;170;169;177 05:26:56 INFO - PROCESS | 29520 | |13;stanford-crypto-sha256-iterative;73;71;70;74;71;69;67;70;75;70 05:26:56 INFO - PROCESS | 29520 | __end_tp_report 05:26:56 INFO - PROCESS | 29520 | __start_cc_report 05:26:56 INFO - PROCESS | 29520 | _x_x_mozilla_cycle_collect,860 05:26:56 INFO - PROCESS | 29520 | __end_cc_report 05:26:56 INFO - PROCESS | 29520 | __startTimestamp1461846416922__endTimestamp 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | ------- Summary: start ------- 05:26:56 INFO - PROCESS | 29520 | Number of tests: 14 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#0] ai-astar Cycles:10 Average:114.30 Median:113.50 stddev:3.71 (3.3%) stddev-sans-first:3.91 05:26:56 INFO - PROCESS | 29520 | Values: 113.0 111.0 116.0 115.0 112.0 124.0 113.0 113.0 114.0 112.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:155.50 stddev:21.90 (14.1%) stddev-sans-first:23.23 05:26:56 INFO - PROCESS | 29520 | Values: 154.0 141.0 155.0 183.0 130.0 163.0 156.0 131.0 192.0 128.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.33 (1.4%) stddev-sans-first:2.37 05:26:56 INFO - PROCESS | 29520 | Values: 162.0 163.0 161.0 163.0 163.0 168.0 166.0 162.0 167.0 164.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#3] audio-fft Cycles:10 Average:94.10 Median:77.00 stddev:37.19 (48.3%) stddev-sans-first:38.93 05:26:56 INFO - PROCESS | 29520 | Values: 77.0 78.0 73.0 167.0 81.0 77.0 76.0 77.0 162.0 73.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:28.94 (31.5%) stddev-sans-first:29.91 05:26:56 INFO - PROCESS | 29520 | Values: 92.0 93.0 156.0 92.0 92.0 93.0 153.0 94.0 92.0 148.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:26:56 INFO - PROCESS | 29520 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 05:26:56 INFO - PROCESS | 29520 | Values: 146.0 147.0 147.0 150.0 146.0 148.0 147.0 146.0 147.0 146.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 05:26:56 INFO - PROCESS | 29520 | Values: 97.0 97.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.50 stddev:6.01 (10.3%) stddev-sans-first:6.33 05:26:56 INFO - PROCESS | 29520 | Values: 58.0 58.0 59.0 58.0 64.0 60.0 57.0 76.0 56.0 56.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 05:26:56 INFO - PROCESS | 29520 | Values: 61.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 64.0 62.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:3.46 (4.4%) stddev-sans-first:3.57 05:26:56 INFO - PROCESS | 29520 | Values: 78.0 79.0 76.0 85.0 85.0 77.0 79.0 79.0 79.0 85.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:127.50 stddev:11.16 (8.8%) stddev-sans-first:11.82 05:26:56 INFO - PROCESS | 29520 | Values: 128.0 129.0 126.0 125.0 122.0 126.0 127.0 125.0 161.0 129.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:171.50 stddev:4.76 (2.8%) stddev-sans-first:4.53 05:26:56 INFO - PROCESS | 29520 | Values: 178.0 166.0 172.0 170.0 171.0 167.0 180.0 170.0 169.0 177.0 05:26:56 INFO - PROCESS | 29520 | 05:26:56 INFO - PROCESS | 29520 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:2.40 (3.4%) stddev-sans-first:2.44 05:26:56 INFO - PROCESS | 29520 | Values: 73.0 71.0 70.0 74.0 71.0 69.0 67.0 70.0 75.0 70.0 05:26:56 INFO - PROCESS | 29520 | -------- Summary: end -------- 05:26:56 INFO - PROCESS | 29520 | 05:26:57 INFO - TEST-INFO | 29520: exit 0 05:26:57 INFO - TEST-OK | kraken | took 61838ms 05:26:57 INFO - SUITE-END | took 1171s 05:26:58 INFO - Completed test suite (00:19:32) 05:26:58 INFO - javascript benchmark 05:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.0428969164404, 3177.094528059503, 3177.2215807127227, 3221.710046095851, 3222.6777322267762, 5486.615936884415, 5498.697571633558, 5503.11950087986, 5510.862228444291, 5528.5024347808685, 5348.732563371826, 5481.780728770855, 5531.032069387861, 5613.550915926727, 5624.775008999645, 4923.040007198607, 4947.134251505972, 4989.550940415362, 5019.723915184663, 5044.596432285427, 4902.754862256891, 5058.392992840864, 5077.162268225757, 5079.212722028092, 5106.846794596149, 4988.301637770697, 4996.300517927475, 5005.6496045276845, 5039.798408063673, 5081.669691470042, 4933.062718083553, 4934.432540257881, 4943.456219815817, 4969.155243608595, 4985.302057711923, 4932.383452068491, 4934.284528743348, 4934.358533390637, 4935.963447675957, 4968.22992436173, 5201.1678131498775, 5381.192821076831, 5392.4337944515655, 5398.676079435247, 5460.6177567570285, 5836.88326233473, 5849.268841394825, 5858.794942177046, 5869.85325366865, 5874.060150375919, 5874.882502349972, 5915.1718759373725, 5922.674252916088, 5925.7333419995775, 5935.1987481690285, 5487.670739755627, 5503.6147469677135, 5520.972395138079, 5552.250446189793, 5554.833354999357, 5889.028310328834, 5895.115732640138, 5895.35151133375, 5906.350301466835, 5922.230110085661, 5654.37801841797, 5665.2635157430095, 5671.007573674673, 5689.288838895138, 5721.5708821838525, 5872.882542349214, 5873.765049398062, 5881.764729410861, 5894.056950887837, 5916.881662366729, 5644.294463192101, 5806.593538452352, 5857.121431785266, 5875.764969401176, 5899.882002359929, 5653.123765816223, 5744.908467391182, 5770.019096753562, 5837.91998480274, 5846.649201047951, 4385.232584297799, 4404.8458303959205, 4409.4488188976375, 4415.558444155558, 4451.287793952952, 3891.64975152232, 3899.3566061600086, 3903.8048097595006, 3938.6061393860386, 3943.960560394359, 5491.148871924778, 5491.643043202179, 5592.384837667853, 5602.663840169603, 5652.547796176296, 5929.614575052694, 5943.465088142001, 5944.732487038007, 5944.762209511658, 5959.672218027963, 5677.659340439587, 5685.317761868602, 5698.17376480408, 5714.171445140514, 5717.342505611825, 4959.801607935714, 5003.674761140514, 5041.546260836542, 5061.215511595635, 5065.062963351718, 5993.250843644544, 5993.790217342372, 6000.129981152709, 6007.609505382136, 6051.062085376773, 5796.971015145066, 5802.82591522255, 5819.301683797971, 5819.970900145472, 5828.737706803119, 5989.460948514655, 6002.579819412599, 6010.669413182317, 6053.0, 6135.662538560422, 5816.912746308724, 5823.388544202798, 5834.38738932406, 5836.708164591839, 5848.941510584839, 5851.473367396955, 5948.048312270016, 5959.7020148991505, 5972.581919265784, 5978.521718262442, 5635.436456354331, 5674.375818660027, 5735.627184233012, 5786.9131963019745, 5801.129830525455, 5729.169270455677, 5737.282839645044, 5759.0, 5771.3651498335985, 5817.156512305776, 5526.198701188386, 5553.8333849984565, 5561.777528898799, 5562.749676264659, 5565.415631358649, 5653.773849045992, 5700.828975130753, 5780.479756821906, 5906.70466476683, 5915.053591425351, 5651.576131790214, 5688.3742788294085, 5694.06048002075, 5701.572382071278, 5710.771569137188], "value": 5399.716119493743, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.2658346692234, 618.8143556932922, 645.4642646603319, 654.3227759269156, 675.820907459523, 36511.4523282151, 37716.81141594292, 37777.43333849991, 37941.81029094851, 38025.80987095061, 35751.4637280441, 35918.46122308167, 36236.0, 37203.25593488129, 37426.0, 8403.747887563382, 8550.187732165434, 8564.48613083214, 8566.61450234741, 8580.828383432328, 8396.244338009577, 8696.869546956801, 8743.344249181306, 8744.081871403507, 8775.736727898173, 8703.825923481527, 8730.126987301252, 8762.167594078552, 8819.206271435569, 8830.823383532326, 8697.869531957025, 8747.956260218658, 8764.8685269721, 8773.736787896374, 8783.0, 8668.306535477146, 8725.694600688945, 8744.8688269676, 8793.7801554961, 8809.515476648781, 29212.0, 38609.0, 39332.80333598314, 39364.80317598422, 39383.606163938566, 3379.8986030418882, 3398.677125673057, 3527.94708079379, 3571.964280357189, 3580.820958952042, 28526.572101418496, 28748.281292967633, 29281.0, 29355.55966660502, 29420.264493387836, 3700.611435799229, 3724.646158614927, 3741.1395379062697, 3760.1539653578, 3803.5435747710176, 222547.0, 224314.87842560845, 224630.0, 225008.0, 226202.0, 31926.361472770415, 32951.3409731804, 34513.827430862686, 34755.82622086874, 34759.4786078209, 33834.15414614605, 33844.49233261503, 33882.491762623584, 34037.82981085128, 34054.0, 14820.814334853187, 14977.625559360886, 14999.17504537239, 15015.549533514011, 15046.097234165985, 11343.829842552368, 11476.139289553317, 11478.598249061242, 11487.885121148849, 11517.136214783925, 8422.24199822019, 8473.195046470575, 8519.446235994641, 8574.657013719507, 8579.099194584604, 3209.727173190305, 3247.269364392993, 3254.1051210917185, 3273.7217336526187, 3281.934361312808, 1071.2073065931154, 1083.8103331916882, 1087.9292845964987, 1096.270979798425, 1108.296231892754, 29502.409951800844, 29997.25006874802, 30074.097777066723, 30209.395812083636, 33153.66846331506, 1103.442761405485, 1124.9100071994221, 1164.5283660117666, 1182.5920057580292, 1196.491491116272, 15072.623184420258, 16242.837571624368, 16370.590735231715, 16384.426545070866, 16469.58826029359, 520485.0, 521407.0, 527559.0, 530000.0, 530883.0, 56497.91518763331, 57216.141757873665, 57343.0, 57361.71319143461, 57389.0, 1250.4310538704867, 1268.7145392286661, 1289.548657969703, 1357.755603991291, 1520.5818399940106, 31130.53304200484, 31253.0, 31568.842155789993, 31800.36399272048, 32069.35861282808, 50234.24648630347, 50985.23522147097, 51151.0, 51308.74345628248, 51336.71658208575, 425231.0, 430571.0, 431804.0, 432501.0, 432675.0, 27722.02972895939, 27971.300717482227, 27990.160295191177, 28029.719702803526, 28053.579196311664, 45718.542814571425, 47182.528174719184, 47431.0, 47668.0, 47723.761381192875, 38993.0, 39031.804840975616, 39037.0, 39937.40093898536, 40274.395884062345, 39393.40909886297, 39460.0, 39473.60526394699, 40380.1923961525, 40481.59518404778, 39142.804285979524, 40012.39981400223, 40799.59200407958, 40912.59087409088, 41027.0, 33751.32497350089, 35230.64769352274, 35349.0, 35595.0, 36273.455898161024, 27620.0, 28009.439811203254, 28094.71905280921, 28266.85866570654, 28324.433511329247], "value": 17822.81047422014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3773481297333, 393.56314490915076, 394.8894309593314, 398.68703068091554, 411.78998710657555, 17572.0, 17619.55951101223, 18202.5449363766, 18216.90891545542, 18220.0, 16383.91808040961, 16747.83252167478, 16946.661066778688, 17034.0, 17457.73813392797, 5700.401457846929, 5748.856278593037, 5917.378675239102, 5921.319048309457, 5927.081302398114, 5815.767369305223, 5831.825045248649, 5834.445727655887, 5858.41415858415, 5870.11948207768, 5728.914066289009, 5753.942460575383, 5789.102689083199, 5802.767889284423, 5816.1275808628625, 5787.652740835563, 5789.0, 5844.26946631671, 5848.385919478457, 5851.122331650244, 5116.386033675945, 5140.511651393112, 5192.92210616841, 5386.542143917733, 5397.514223719884, 12051.457684404222, 12183.573574924834, 12225.755484890342, 17566.560835979075, 23360.883195584083, 2245.0682966568857, 2331.825113116506, 2340.099061861196, 2405.5910495215853, 2442.560339138954, 9637.518124093767, 9766.218702503782, 9814.803703925882, 9850.21198304134, 12825.35873206336, 1829.5791967847338, 1934.477691023416, 1953.5897461533095, 1957.8335841453493, 1982.8215460608615, 73247.0, 75682.24317756807, 76680.61659691666, 83324.16675833224, 83680.16319836785, 10063.094321511098, 10396.376217426978, 10596.15230781551, 10829.783404331869, 10917.0, 14892.925535372255, 14904.776428353583, 14915.403383864741, 14927.104373737393, 15027.774583381259, 7906.525608463396, 7948.523088614586, 8053.758387248392, 8160.30637395828, 8366.163383661586, 7837.09873364559, 7898.091719452222, 7956.562389068657, 8029.7189598363775, 8159.836803263902, 4456.6211871991245, 4502.122086193161, 4525.818967241339, 4625.3755742974945, 4655.4878963314, 1840.162725959685, 1857.0993068361834, 1865.0488250992091, 1865.1140708163514, 1998.8700734452214, 882.3955590420583, 979.1285755677453, 997.3367710472454, 1006.2050979726081, 1077.095239998405, 17350.0, 18269.81730182708, 19040.809591903904, 19067.61864762697, 19372.0, 1036.7874585710063, 1039.2517387481003, 1047.8323468245044, 1058.767071244325, 1064.3986147826608, 10235.692929212135, 10593.0, 10635.94682026585, 10751.301165424222, 10753.462326883624, 474129.0, 479310.0, 496027.0, 499401.0, 501158.0, 54423.18365224525, 71501.6424917872, 82184.0, 95617.0, 96570.51714741382, 1017.7099526634873, 1018.6282007067515, 1053.7997780421695, 1064.5209655654987, 1072.6192201768415, 15849.286782095063, 15953.521394358188, 15987.760183597487, 16364.590885227488, 16367.59081022984, 34902.30195396129, 35941.460878087375, 36088.45867312045, 36622.0, 36790.0, 48778.512214877395, 49627.0, 57671.0, 57810.42189578219, 57869.710651446476, 8061.113277539349, 8329.916700832913, 8333.791655208668, 8386.203310685476, 8483.787905302417, 12756.425960831599, 13017.349132543524, 13023.739525209254, 13095.41070651804, 13205.735885282049, 10870.61952831647, 11354.772904542027, 11403.201775875941, 11495.54017839277, 11619.593314233962, 11371.374574398156, 11373.0, 11526.423678816192, 11694.649160525198, 11787.233829801036, 10787.680648660576, 10901.890981090404, 11129.833052504056, 11136.55453781872, 11576.94211528937, 7885.605719713876, 8225.341972642054, 8293.95853020731, 8408.789780255542, 8577.95711021441, 9964.302498825013, 10625.628103016357, 10986.066184374098, 11160.49777760019, 11332.92337227962], "value": 8876.874731792303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.26547328126, 1504.9021813582117, 1518.9240537973099, 1564.4289834210517, 1622.3510595761702, 7514.211007844179, 8112.351011919047, 8179.100298967109, 8468.576571171448, 8470.19533144351, 8218.547979861105, 8245.958770206156, 8253.91746082539, 8311.958440207805, 8324.75025749227, 2281.258590957941, 2331.300609817048, 2335.6613291072786, 2339.146211632759, 2342.7774361435636, 2141.0, 2155.7736437674052, 2189.901454434554, 2201.515666553356, 2204.8456608037445, 2253.0537174386714, 2259.45773014477, 2272.715910511186, 2297.4945511987335, 2306.3542208181734, 2260.954780904373, 2272.306946381353, 2274.169927976285, 2274.2040285899884, 2276.886155692217, 2247.359502541784, 2249.7750224977535, 2278.9658155127686, 2282.132789539981, 2285.5543169082034, 8436.873446898302, 8467.872981905277, 8509.957450212709, 8514.82970340596, 8527.872081918715, 4834.468208497063, 5048.29323894655, 5056.772445239973, 5057.418396884369, 5065.898682026375, 3123.437781199383, 3219.3561287742546, 3306.322203948185, 3310.933781324384, 3320.053784671357, 1038.1176000399676, 1046.487221261584, 1079.703081652544, 1082.2045796339685, 1097.5280629329386, 11428.942855285753, 11531.94234028833, 11551.711207219803, 11568.884311156864, 11614.825777613343, 4541.568550987651, 4574.473935497461, 4654.441467023911, 4658.790354434059, 4668.3697700810635, 9881.061299176567, 9883.11052005323, 9903.059209375098, 9917.504124793732, 9936.304458687822, 5128.743562821844, 5137.640365174477, 5160.071187186342, 5165.457626949192, 5180.766865491062, 4200.537940826506, 4541.591256786905, 4544.727316361029, 4604.1712491751805, 4631.3516107744945, 3795.1271207622403, 3803.6006219347123, 3869.400242962345, 3887.1059656279213, 3902.6292502212245, 1254.7239607286565, 1266.6200139957975, 1270.885620294178, 1283.159530507519, 1285.9035572332114, 996.4220751963844, 1032.1587905856702, 1033.121846430528, 1039.599754094679, 1046.4663021858908, 5801.245838041112, 5827.067669172912, 5845.707714614252, 5893.5874488785375, 5921.96365636012, 941.7692665297046, 956.6221342569785, 970.4856426094041, 999.8550210219478, 1040.2718097331897, 3791.9810400947817, 3874.3026255273758, 3881.8059097045034, 4037.515498140242, 4066.1257829566784, 9943.701688949199, 10231.897681023243, 10330.380177189392, 10375.118114960162, 10431.478426078666, 9950.154236889946, 10229.0, 10291.53688084038, 10319.948400258101, 10412.375257484575, 7282.453815963824, 7293.9635301823155, 7334.339909408179, 7514.736984205527, 7638.732644357421, 5710.857228569319, 5747.5401967841635, 5792.94207057924, 5803.3616302207565, 5857.7949771757785, 9152.542372881197, 9357.344985850925, 9581.712548623553, 9636.71089867305, 9732.0, 9372.109649583279, 9541.284403669613, 9592.66425675098, 9749.610015599581, 9755.073268039525, 7008.5094043416475, 7553.924460755322, 7749.3413059890545, 7773.144954055162, 8038.397120216124, 7826.686932522635, 7899.921000789918, 7904.802379940547, 7921.485103468487, 7969.721059763112, 6920.723171073302, 7230.0, 7239.312265334785, 7285.526440781332, 7331.486795924234, 7208.0, 7301.561906285639, 7328.047353844179, 7337.657185925551, 7400.59296738663, 6427.935720642734, 6617.106690596708, 6622.337766223339, 6627.966860165861, 6632.071509988702, 4885.389326334208, 5005.074061298671, 5063.265826455217, 5068.037072956126, 5174.223866419917, 4934.777934993006, 5019.62352823547, 5024.547790698854, 5045.823396181116, 5077.619178561697], "value": 4478.619722365702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.60640364324547, 313.3685623468711, 318.3124451185439, 321.0352889566853, 322.94994275887245, 5402.270693456382, 5497.972510137443, 5539.723013849307, 5624.578156638248, 5685.4030326815655, 5526.889462210764, 5577.69322687252, 5577.8047768328115, 5579.972100139494, 5592.328920529542, 4302.655787537005, 4315.093830295642, 4316.575530075075, 4319.935200971988, 4324.740515569076, 4173.142951386634, 4316.892077698067, 4317.676174286926, 4332.591907630032, 4333.393324934512, 4222.134462435193, 4222.704410691253, 4231.70378073535, 4246.596573325544, 4255.2978758504805, 4238.957610423887, 4255.5744425557505, 4259.595338442874, 4276.893077673052, 4302.075053863435, 3475.5481787367735, 3727.291814555253, 3736.6263373662687, 3745.3632882410056, 3747.362948298796, 5264.263003179558, 5284.788608455658, 5326.387465441485, 5354.678719276856, 5373.704446255454, 4833.589144922686, 4850.151223535867, 4858.587020103296, 4863.19757240055, 4904.288878112654, 5606.159076138571, 5779.393163717791, 5789.305283365981, 5828.766849326022, 5843.883122337529, 4020.2160578687167, 4021.8190181441905, 4043.353063509824, 4046.4941882264716, 4085.468889044435, 6026.397360263983, 6059.0, 6065.363136870653, 6110.541709371815, 6138.877222455526, 3994.8801535953967, 4099.364598487239, 4104.220198162399, 4108.301588729923, 4122.443470131554, 4168.333066709312, 4173.144505376391, 4182.9790851046155, 4192.161567686475, 4193.769342686121, 4793.1372352976105, 4828.203346447867, 4853.369062021915, 4854.417469903634, 4864.246041863516, 5472.753726082336, 5525.254090697785, 5805.303363596396, 5843.3864444233595, 5859.853503662443, 1485.7994170786806, 1494.8430414806505, 1504.3230546254229, 1507.3970411835135, 1509.1096253210658, 986.1075726467558, 988.5600907596195, 993.1806259835664, 1004.4977511244377, 1005.9346142500714, 6005.3694362091355, 6021.3677563856045, 6033.758649653964, 6047.15339852421, 6061.151438798572, 6410.391012853772, 6441.420272175526, 6451.548391612542, 6467.641795223056, 6507.804765857032, 5897.970510147422, 5898.528117750569, 6028.276606807123, 6057.151998720183, 6066.211392519032, 3419.9145021374666, 3449.2411669433186, 3454.240067185215, 3465.636108208602, 3473.8362648512525, 6017.909731354033, 6270.811875643738, 6304.968475157595, 6694.397504224643, 6717.764878229238, 6182.795698924684, 6213.37866213375, 6223.919160015821, 6235.469985051322, 6253.0, 6101.420365065312, 6214.316425193135, 6241.656708881055, 6249.937510623205, 6270.122182894398, 6007.30915944672, 6010.87978240424, 6027.156198132353, 6027.367126451835, 6084.6349219047, 5929.822105336847, 5965.791197308074, 5976.312724036791, 6010.338862725184, 6020.187274717857, 6093.75624974996, 6121.65323628801, 6255.843603909939, 6280.152179455715, 6304.779332723516, 4036.2936486114227, 4095.6313931746286, 4109.260333140063, 4112.691548133842, 4135.77253251062, 5756.251687280626, 5767.798127065533, 6038.577299589162, 6084.787032453843, 6126.417990290915, 5847.918135145012, 5874.735636896265, 5876.823695289148, 5908.822735317947, 5921.940780592139, 5848.181254624271, 5860.355360910211, 5865.149553314831, 5884.6469211847425, 5912.793052243323, 5539.41836107219, 5727.914081288701, 5747.942520574908, 5762.193292939076, 5762.2221000164445, 5839.649621022582, 5890.440408161217, 5906.320773110975, 5908.409159084229, 5946.197263369563, 5538.224648549126, 5810.680412577349, 5816.243888294494, 5817.709114544171, 5821.476067153807], "value": 4454.952197415374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.8721049395367, 681.2131987554376, 694.4791406445166, 717.8707832590135, 719.5394947233768, 11326.660200193997, 12030.639080827566, 12144.514219431223, 12227.205231659937, 13018.674533136653, 12596.0, 12632.557860474884, 12668.113232073758, 12673.239605623668, 12687.238765674043, 772.8995230620012, 808.0545761459092, 812.3866480806983, 813.5850716134755, 815.4373482297226, 775.4533054196778, 775.5308038636629, 778.7352300217925, 784.301971245589, 789.8420315936806, 816.1919699497514, 816.1919699497514, 817.5340056167987, 818.2553875972866, 818.5825229133126, 810.2748040503775, 811.5698679699768, 812.9146439623843, 813.0730966697969, 817.3624572833199, 597.1788790413182, 597.2265915639258, 597.4175179200288, 601.0203368509345, 603.3905755187249, 11976.820347694791, 12043.879561204363, 12058.939705301418, 12080.516779328816, 12091.576794812227, 11196.216264861463, 11560.479778409992, 11660.650180494598, 11878.584249551224, 12037.458314375786, 10150.086492215662, 10202.686638135972, 10347.793044139074, 10414.27100102993, 10515.842262365994, 3585.748997570171, 3585.964140358615, 3614.222942067468, 3678.9448158277646, 3681.1901381695984, 60652.696736516475, 60847.39152608462, 61083.08375374373, 61182.69408652973, 61301.08048379322, 9541.809163816684, 9652.75868103303, 9679.370840895319, 9862.0, 9970.700878973643, 17641.94148351103, 17662.470125896245, 17750.0, 18025.909870450825, 18119.45641630753, 7229.0, 7240.275972402717, 7266.0, 7301.817454563678, 7369.6315184240575, 4119.855805046809, 4129.380592911088, 4145.709800313949, 4211.684123690736, 4230.027093768389, 2887.7112288771373, 2995.3859458810894, 2995.5207166853197, 2995.550667399864, 3002.1143762590086, 547.2912578211226, 561.4553882733742, 569.0354848531699, 569.2485918587424, 575.04255414734, 711.7544447165719, 714.7891372045259, 719.5502810743285, 725.804032911111, 732.9926700733031, 8387.245147936716, 8428.32573394127, 8594.527300998505, 8743.56282185888, 8778.692745753868, 544.6187668631974, 591.6006695480534, 635.5519358851998, 661.1075048684238, 725.2421219825295, 4095.713300069026, 4112.547619761824, 4126.834926602963, 4162.708610397303, 4227.32362821947, 56921.715391423604, 57488.0, 58855.0, 58884.11673824896, 59077.11384329238, 53949.0, 54138.45861541334, 54620.0, 55100.17349739757, 56266.71866640641, 48240.27639585409, 49269.0, 49507.0, 49938.001239975, 50244.74877625588, 7768.61156942162, 8081.63632636521, 8118.472299300526, 8134.593270336578, 8205.876911846208, 33657.15857103592, 33874.66125338715, 34239.14402139966, 34508.13729656678, 34976.30047399089, 40875.38686919758, 43298.0, 43915.34126988162, 44714.0, 44747.88130296769, 9582.712518624452, 9809.068138527115, 9840.458774767456, 9974.251931105342, 10249.38503689781, 9978.650747223812, 10475.580976760844, 10617.681469555926, 10838.0, 11028.503717332578, 10014.298999069995, 10208.846867296848, 10409.47952602382, 10457.111145552713, 10559.472026398804, 10143.34068285559, 10335.844962325722, 10491.842622360824, 10516.0, 10619.94690026545, 9973.700788976343, 10025.398476091457, 10070.0, 10082.747931301776, 10130.341527800669, 8561.657533698832, 8647.135286471303, 8647.437916535406, 8791.296696264155, 8923.196912277926, 8689.478631282143, 8888.066752990842, 8940.284777217677, 9046.954765226132, 9047.864282035905], "value": 6117.854916509491, "unit": "score"}], "name": "dromaeo_css", "value": 6860.758951230303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 116.0, 115.0, 112.0, 124.0, 113.0, 113.0, 114.0, 112.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 141.0, 155.0, 183.0, 130.0, 163.0, 156.0, 131.0, 192.0, 128.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 163.0, 168.0, 166.0, 162.0, 167.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 73.0, 167.0, 81.0, 77.0, 76.0, 77.0, 162.0, 73.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 156.0, 92.0, 92.0, 93.0, 153.0, 94.0, 92.0, 148.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 150.0, 146.0, 148.0, 147.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 58.0, 64.0, 60.0, 57.0, 76.0, 56.0, 56.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 64.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 76.0, 85.0, 85.0, 77.0, 79.0, 79.0, 79.0, 85.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 126.0, 125.0, 122.0, 126.0, 127.0, 125.0, 161.0, 129.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 166.0, 172.0, 170.0, 171.0, 167.0, 180.0, 170.0, 169.0, 177.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 70.0, 74.0, 71.0, 69.0, 67.0, 70.0, 75.0, 70.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1571.4, "alertThreshold": 2.0}]} 05:26:58 INFO - Return code: 0 05:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:58 ERROR - # TBPL SUCCESS # 05:26:58 INFO - Running post-action listener: _resource_record_post_action 05:26:58 INFO - Running post-run listener: _resource_record_post_run 05:26:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 535965696; Read time: 0; Write time: 451696 05:26:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244645888; Read time: 0; Write time: 269280 05:26:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 291319808; Read time: 0; Write time: 182416 05:26:59 INFO - Running post-run listener: _upload_blobber_files 05:26:59 INFO - Blob upload gear active. 05:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:59 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 05:26:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:00 INFO - (blobuploader) - INFO - Done attempting. 05:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:01 INFO - (blobuploader) - INFO - Done attempting. 05:27:01 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:01 INFO - Return code: 0 05:27:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad240bcbccf6e37e337463381bd22627db18a28e7323a980c24cdeebc67cce0148233826e7aa13e2b68431b37f3a6fc9f25b98d8ccdda39c600fbe62ff7e15c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee5a7bc831f96ea190b230b1444674b63bc78bbaa9c408f6ee2e8b51b713d26d4914f13cfe9280da84e2467d36629c7786e78499286528ac5702bc2f0f1ea970"} 05:27:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:01 INFO - Contents: 05:27:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad240bcbccf6e37e337463381bd22627db18a28e7323a980c24cdeebc67cce0148233826e7aa13e2b68431b37f3a6fc9f25b98d8ccdda39c600fbe62ff7e15c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee5a7bc831f96ea190b230b1444674b63bc78bbaa9c408f6ee2e8b51b713d26d4914f13cfe9280da84e2467d36629c7786e78499286528ac5702bc2f0f1ea970"} 05:27:01 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:01 INFO - Copying logs to upload dir... 05:27:01 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.650661 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-28 05:27:00.828967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:27:00.832455) ========= 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=db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577 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/Fx-Team/sha512/ad240bcbccf6e37e337463381bd22627db18a28e7323a980c24cdeebc67cce0148233826e7aa13e2b68431b37f3a6fc9f25b98d8ccdda39c600fbe62ff7e15c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee5a7bc831f96ea190b230b1444674b63bc78bbaa9c408f6ee2e8b51b713d26d4914f13cfe9280da84e2467d36629c7786e78499286528ac5702bc2f0f1ea970"} build_url:https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/MECs3yMiT56WBoZ_JJTR0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad240bcbccf6e37e337463381bd22627db18a28e7323a980c24cdeebc67cce0148233826e7aa13e2b68431b37f3a6fc9f25b98d8ccdda39c600fbe62ff7e15c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee5a7bc831f96ea190b230b1444674b63bc78bbaa9c408f6ee2e8b51b713d26d4914f13cfe9280da84e2467d36629c7786e78499286528ac5702bc2f0f1ea970"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:27:00.861961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:27:00.862316) ========= 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=db0483c52d987ecb441a263b000001ad-1461845150.851903-1051894577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:27:00.951133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:27:00.951537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:27:00.951940) ========= ========= Total master_lag: 0.22 =========