builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1461146762.79 results: success (0) buildid: 20160419222324 builduid: 5a68dfb2918b44a8b4e6ebada04a0dd4 revision: bf3a35b355f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:02.793439) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:02.794049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:02.794346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:03.762920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:03.763468) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 03:06:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-04-20 03:06:04 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:03.933693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:03.934018) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016874 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:03.984691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:03.985089) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0 --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 bf3a35b355f0 --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=fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 03:06:04,582 Setting DEBUG logging. 2016-04-20 03:06:04,582 attempt 1/10 2016-04-20 03:06:04,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 03:06:04,926 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:04.646260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:04.646670) ========= script_repo_revision: bf3a35b355f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:04.647135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:04.647410) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 03:06:04.657984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-20 03:06:04.658297) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:05 INFO - MultiFileLogger online at 20160420 03:06:05 in /builds/slave/test 03:06:05 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 03:06:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:06:05 INFO - {'append_to_log': False, 03:06:05 INFO - 'base_work_dir': '/builds/slave/test', 03:06:05 INFO - 'blob_upload_branch': 'Fx-Team', 03:06:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:06:05 INFO - 'branch': 'Fx-Team', 03:06:05 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:05 INFO - 'config_files': ('talos/linux_config.py',), 03:06:05 INFO - 'default_actions': ('clobber', 03:06:05 INFO - 'read-buildbot-config', 03:06:05 INFO - 'download-and-extract', 03:06:05 INFO - 'populate-webroot', 03:06:05 INFO - 'create-virtualenv', 03:06:05 INFO - 'install', 03:06:05 INFO - 'run-tests'), 03:06:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:05 INFO - 'download_minidump_stackwalk': True, 03:06:05 INFO - 'download_symbols': 'ondemand', 03:06:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:05 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:05 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:05 INFO - 'installer_path': 'installer.exe', 03:06:05 INFO - 'log_level': 'info', 03:06:05 INFO - 'log_name': 'talos', 03:06:05 INFO - 'log_to_console': True, 03:06:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:05 INFO - 'opt_config_files': (), 03:06:05 INFO - 'pip_index': False, 03:06:05 INFO - 'sps_profile': False, 03:06:05 INFO - 'sps_profile_interval': 0, 03:06:05 INFO - 'suite': 'dromaeojs-e10s', 03:06:05 INFO - 'system_bits': '32', 03:06:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:05 INFO - 'title': 'talos-linux64-ix-014', 03:06:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:05 INFO - 'use_talos_json': True, 03:06:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:06:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:05 INFO - 'work_dir': 'build'} 03:06:05 INFO - ##### 03:06:05 INFO - ##### Running clobber step. 03:06:05 INFO - ##### 03:06:05 INFO - Running pre-action listener: _resource_record_pre_action 03:06:05 INFO - Running main action method: clobber 03:06:05 INFO - rmtree: /builds/slave/test/build 03:06:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:05 INFO - Running post-action listener: _resource_record_post_action 03:06:05 INFO - ##### 03:06:05 INFO - ##### Running read-buildbot-config step. 03:06:05 INFO - ##### 03:06:05 INFO - Running pre-action listener: _resource_record_pre_action 03:06:05 INFO - Running main action method: read_buildbot_config 03:06:05 INFO - Using buildbot properties: 03:06:05 INFO - { 03:06:05 INFO - "project": "", 03:06:05 INFO - "product": "firefox", 03:06:05 INFO - "script_repo_revision": "production", 03:06:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:06:05 INFO - "repository": "", 03:06:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 03:06:05 INFO - "buildid": "20160419222324", 03:06:05 INFO - "pgo_build": "True", 03:06:05 INFO - "basedir": "/builds/slave/test", 03:06:05 INFO - "buildnumber": 292, 03:06:05 INFO - "slavename": "talos-linux64-ix-014", 03:06:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:06:05 INFO - "platform": "ubuntu64_hw", 03:06:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:06:05 INFO - "branch": "fx-team", 03:06:05 INFO - "repo_path": "integration/fx-team", 03:06:05 INFO - "revision": "bf3a35b355f0", 03:06:05 INFO - "stage_platform": "linux64-pgo", 03:06:05 INFO - "builduid": "5a68dfb2918b44a8b4e6ebada04a0dd4", 03:06:05 INFO - "slavebuilddir": "test" 03:06:05 INFO - } 03:06:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:06:05 INFO - Running post-action listener: _resource_record_post_action 03:06:05 INFO - ##### 03:06:05 INFO - ##### Running download-and-extract step. 03:06:05 INFO - ##### 03:06:05 INFO - Running pre-action listener: _resource_record_pre_action 03:06:05 INFO - Running main action method: download_and_extract 03:06:05 INFO - mkdir: /builds/slave/test/build/tests 03:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:05 INFO - https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:10 INFO - Downloaded 1361 bytes. 03:06:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:06:10 INFO - Using the following test package requirements: 03:06:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:06:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:06:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:06:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'jsshell-linux-x86_64.zip'], 03:06:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:06:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:06:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:06:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:06:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:06:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:06:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:10 INFO - https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:11 INFO - Downloaded 23838355 bytes. 03:06:11 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'] 03:06:11 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 03:06:12 INFO - Return code: 0 03:06:12 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 03:06:12 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')]} 03:06:12 INFO - https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:18 INFO - Downloaded 23838355 bytes. 03:06:18 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'] 03:06:18 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 03:06:19 INFO - Return code: 0 03:06:19 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')]} 03:06:19 INFO - https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:20 INFO - Downloaded 10845952 bytes. 03:06:20 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'] 03:06:20 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 03:06:20 INFO - Return code: 0 03:06:20 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')]} 03:06:20 INFO - https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eZfSDps3QLaSJYGO8Bcbug/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 03:06:23 INFO - Downloaded 58266387 bytes. 03:06:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:06:23 INFO - mkdir: /builds/slave/test/properties 03:06:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:23 INFO - Contents: 03:06:23 INFO - build_url:https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:06:24 INFO - Running post-action listener: _resource_record_post_action 03:06:24 INFO - Running post-action listener: set_extra_try_arguments 03:06:24 INFO - ##### 03:06:24 INFO - ##### Running populate-webroot step. 03:06:24 INFO - ##### 03:06:24 INFO - Running pre-action listener: _resource_record_pre_action 03:06:24 INFO - Running main action method: populate_webroot 03:06:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:06:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:06:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:06:24 INFO - '--tppagecycles', 03:06:24 INFO - '7'], 03:06:24 INFO - 'tests': ['tsvgm']}}, 03:06:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:06:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:06:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['damp', 'tps']}, 03:06:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'tests': ['damp', 'tps']}, 03:06:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['dromaeo_dom']}, 03:06:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['a11yr', 03:06:24 INFO - 'ts_paint', 03:06:24 INFO - 'tpaint', 03:06:24 INFO - 'sessionrestore', 03:06:24 INFO - 'sessionrestore_no_auto_restore', 03:06:24 INFO - 'tabpaint']}, 03:06:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:24 INFO - 'ts_paint', 03:06:24 INFO - 'tpaint', 03:06:24 INFO - 'sessionrestore', 03:06:24 INFO - 'sessionrestore_no_auto_restore', 03:06:24 INFO - 'tabpaint']}, 03:06:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:06:24 INFO - 'ts_paint', 03:06:24 INFO - 'tpaint', 03:06:24 INFO - 'sessionrestore', 03:06:24 INFO - 'sessionrestore_no_auto_restore', 03:06:24 INFO - 'tabpaint']}, 03:06:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:06:24 INFO - 'ts_paint', 03:06:24 INFO - 'tpaint', 03:06:24 INFO - 'sessionrestore', 03:06:24 INFO - 'sessionrestore_no_auto_restore', 03:06:24 INFO - 'tabpaint']}, 03:06:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['a11yr', 03:06:24 INFO - 'ts_paint', 03:06:24 INFO - 'tpaint', 03:06:24 INFO - 'sessionrestore', 03:06:24 INFO - 'sessionrestore_no_auto_restore', 03:06:24 INFO - 'tabpaint']}, 03:06:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['a11yr', 03:06:24 INFO - 'ts_paint', 03:06:24 INFO - 'tpaint', 03:06:24 INFO - 'sessionrestore', 03:06:24 INFO - 'sessionrestore_no_auto_restore', 03:06:24 INFO - 'tabpaint']}, 03:06:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['tsvgx', 03:06:24 INFO - 'tsvgr_opacity', 03:06:24 INFO - 'tart', 03:06:24 INFO - 'tscrollx', 03:06:24 INFO - 'cart']}, 03:06:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:24 INFO - 'tsvgr_opacity', 03:06:24 INFO - 'tart', 03:06:24 INFO - 'tscrollx', 03:06:24 INFO - 'cart']}, 03:06:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'talos_options': ['--disable-e10s'], 03:06:24 INFO - 'tests': ['tp5o']}, 03:06:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'tests': ['tp5o']}, 03:06:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'talos_options': ['--disable-e10s', 03:06:24 INFO - '--xperf_path', 03:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:24 INFO - 'tests': ['tp5n']}, 03:06:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:24 INFO - 'talos_options': ['--xperf_path', 03:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:24 INFO - 'tests': ['tp5n']}}, 03:06:24 INFO - 'talos.zip': {'path': '', 03:06:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:06:24 INFO - Running post-action listener: _resource_record_post_action 03:06:24 INFO - ##### 03:06:24 INFO - ##### Running create-virtualenv step. 03:06:24 INFO - ##### 03:06:24 INFO - Running pre-action listener: _resource_record_pre_action 03:06:24 INFO - Running main action method: create_virtualenv 03:06:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06:24 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 03:06:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:06:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:24 INFO - Using real prefix '/usr' 03:06:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:27 INFO - Installing pip.................done. 03:06:27 INFO - Return code: 0 03:06:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:06:27 INFO - Using env: {'DISPLAY': ':0', 03:06:27 INFO - 'HOME': '/home/cltbld', 03:06:27 INFO - 'LANG': 'en_US.UTF-8', 03:06:27 INFO - 'LANGUAGE': 'en_US:en', 03:06:27 INFO - 'LOGNAME': 'cltbld', 03:06:27 INFO - 'MAIL': '/var/mail/cltbld', 03:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:27 INFO - 'MOZ_NO_REMOTE': '1', 03:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:27 INFO - 'NO_EM_RESTART': '1', 03:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:27 INFO - 'PWD': '/builds/slave/test', 03:06:27 INFO - 'SHELL': '/bin/bash', 03:06:27 INFO - 'SHLVL': '1', 03:06:27 INFO - 'TERM': 'linux', 03:06:27 INFO - 'TMOUT': '86400', 03:06:27 INFO - 'USER': 'cltbld', 03:06:27 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:27 INFO - '_': '/tools/buildbot/bin/python'} 03:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:06:27 INFO - Cleaning up... 03:06:27 INFO - Return code: 0 03:06:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:06:27 INFO - Using env: {'DISPLAY': ':0', 03:06:27 INFO - 'HOME': '/home/cltbld', 03:06:27 INFO - 'LANG': 'en_US.UTF-8', 03:06:27 INFO - 'LANGUAGE': 'en_US:en', 03:06:27 INFO - 'LOGNAME': 'cltbld', 03:06:27 INFO - 'MAIL': '/var/mail/cltbld', 03:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:27 INFO - 'MOZ_NO_REMOTE': '1', 03:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:27 INFO - 'NO_EM_RESTART': '1', 03:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:27 INFO - 'PWD': '/builds/slave/test', 03:06:27 INFO - 'SHELL': '/bin/bash', 03:06:27 INFO - 'SHLVL': '1', 03:06:27 INFO - 'TERM': 'linux', 03:06:27 INFO - 'TMOUT': '86400', 03:06:27 INFO - 'USER': 'cltbld', 03:06:27 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:27 INFO - '_': '/tools/buildbot/bin/python'} 03:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:27 INFO - Downloading/unpacking psutil>=0.7.1 03:06:27 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 03:06:27 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 03:06:27 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 03:06:27 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 03:06:27 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 03:06:27 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 03:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:29 INFO - Installing collected packages: psutil 03:06:29 INFO - Running setup.py install for psutil 03:06:29 INFO - building 'psutil._psutil_linux' extension 03:06:29 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 03:06:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:06:30 INFO - building 'psutil._psutil_posix' extension 03:06:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:06:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:30 INFO - Successfully installed psutil 03:06:30 INFO - Cleaning up... 03:06:30 INFO - Return code: 0 03:06:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:06:30 INFO - Using env: {'DISPLAY': ':0', 03:06:30 INFO - 'HOME': '/home/cltbld', 03:06:30 INFO - 'LANG': 'en_US.UTF-8', 03:06:30 INFO - 'LANGUAGE': 'en_US:en', 03:06:30 INFO - 'LOGNAME': 'cltbld', 03:06:30 INFO - 'MAIL': '/var/mail/cltbld', 03:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:30 INFO - 'MOZ_NO_REMOTE': '1', 03:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:30 INFO - 'NO_EM_RESTART': '1', 03:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:30 INFO - 'PWD': '/builds/slave/test', 03:06:30 INFO - 'SHELL': '/bin/bash', 03:06:30 INFO - 'SHLVL': '1', 03:06:30 INFO - 'TERM': 'linux', 03:06:30 INFO - 'TMOUT': '86400', 03:06:30 INFO - 'USER': 'cltbld', 03:06:30 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:30 INFO - '_': '/tools/buildbot/bin/python'} 03:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:06:32 INFO - Installing collected packages: mozsystemmonitor 03:06:32 INFO - Running setup.py install for mozsystemmonitor 03:06:32 INFO - Successfully installed mozsystemmonitor 03:06:32 INFO - Cleaning up... 03:06:32 INFO - Return code: 0 03:06:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:06:32 INFO - Using env: {'DISPLAY': ':0', 03:06:32 INFO - 'HOME': '/home/cltbld', 03:06:32 INFO - 'LANG': 'en_US.UTF-8', 03:06:32 INFO - 'LANGUAGE': 'en_US:en', 03:06:32 INFO - 'LOGNAME': 'cltbld', 03:06:32 INFO - 'MAIL': '/var/mail/cltbld', 03:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:32 INFO - 'MOZ_NO_REMOTE': '1', 03:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:32 INFO - 'NO_EM_RESTART': '1', 03:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:32 INFO - 'PWD': '/builds/slave/test', 03:06:32 INFO - 'SHELL': '/bin/bash', 03:06:32 INFO - 'SHLVL': '1', 03:06:32 INFO - 'TERM': 'linux', 03:06:32 INFO - 'TMOUT': '86400', 03:06:32 INFO - 'USER': 'cltbld', 03:06:32 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:32 INFO - '_': '/tools/buildbot/bin/python'} 03:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:06:32 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 03:06:32 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 03:06:32 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 03:06:32 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 03:06:32 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 03:06:32 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 03:06:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06:34 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 03:06:34 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 03:06:34 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 03:06:34 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 03:06:34 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 03:06:34 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 03:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:06:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:35 INFO - Downloading docopt-0.6.1.tar.gz 03:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:35 INFO - Running setup.py install for blobuploader 03:06:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:06:35 INFO - Running setup.py install for requests 03:06:36 INFO - Running setup.py install for docopt 03:06:36 INFO - Successfully installed blobuploader requests docopt 03:06:36 INFO - Cleaning up... 03:06:36 INFO - Return code: 0 03:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:06:36 INFO - Using env: {'DISPLAY': ':0', 03:06:36 INFO - 'HOME': '/home/cltbld', 03:06:36 INFO - 'LANG': 'en_US.UTF-8', 03:06:36 INFO - 'LANGUAGE': 'en_US:en', 03:06:36 INFO - 'LOGNAME': 'cltbld', 03:06:36 INFO - 'MAIL': '/var/mail/cltbld', 03:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:36 INFO - 'MOZ_NO_REMOTE': '1', 03:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:36 INFO - 'NO_EM_RESTART': '1', 03:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:36 INFO - 'PWD': '/builds/slave/test', 03:06:36 INFO - 'SHELL': '/bin/bash', 03:06:36 INFO - 'SHLVL': '1', 03:06:36 INFO - 'TERM': 'linux', 03:06:36 INFO - 'TMOUT': '86400', 03:06:36 INFO - 'USER': 'cltbld', 03:06:36 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:36 INFO - '_': '/tools/buildbot/bin/python'} 03:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:36 INFO - Running setup.py (path:/tmp/pip-uibMu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:36 INFO - Running setup.py (path:/tmp/pip-KsGuCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:36 INFO - Running setup.py (path:/tmp/pip-SOF8Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:36 INFO - Running setup.py (path:/tmp/pip-SPWEaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:36 INFO - Running setup.py (path:/tmp/pip-faimaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:36 INFO - Running setup.py (path:/tmp/pip-hXrXSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:36 INFO - Running setup.py (path:/tmp/pip-7S39Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:36 INFO - Running setup.py (path:/tmp/pip-GgL_hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:36 INFO - Running setup.py (path:/tmp/pip-9Kdj4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:37 INFO - Running setup.py (path:/tmp/pip-Yxm6x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:37 INFO - Running setup.py (path:/tmp/pip-_Zict0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:37 INFO - Running setup.py (path:/tmp/pip-4MGVzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:37 INFO - Running setup.py (path:/tmp/pip-BJ7lDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:37 INFO - Running setup.py (path:/tmp/pip-ogv7_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:37 INFO - Running setup.py (path:/tmp/pip-oWSgiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:37 INFO - Running setup.py (path:/tmp/pip-M9huye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:37 INFO - Running setup.py (path:/tmp/pip-HsYcuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:37 INFO - Running setup.py install for manifestparser 03:06:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:06:37 INFO - Running setup.py install for mozcrash 03:06:37 INFO - Running setup.py install for mozdebug 03:06:37 INFO - Running setup.py install for mozdevice 03:06:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for mozfile 03:06:38 INFO - Running setup.py install for mozhttpd 03:06:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for mozinfo 03:06:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for mozInstall 03:06:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for mozleak 03:06:38 INFO - Running setup.py install for mozlog 03:06:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for moznetwork 03:06:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for mozprocess 03:06:38 INFO - Running setup.py install for mozprofile 03:06:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:06:38 INFO - Running setup.py install for mozrunner 03:06:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:06:39 INFO - Running setup.py install for mozscreenshot 03:06:39 INFO - Running setup.py install for moztest 03:06:39 INFO - Running setup.py install for mozversion 03:06:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:06:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:39 INFO - Cleaning up... 03:06:39 INFO - Return code: 0 03:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03: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')]} 03:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:06:39 INFO - Using env: {'DISPLAY': ':0', 03:06:39 INFO - 'HOME': '/home/cltbld', 03:06:39 INFO - 'LANG': 'en_US.UTF-8', 03:06:39 INFO - 'LANGUAGE': 'en_US:en', 03:06:39 INFO - 'LOGNAME': 'cltbld', 03:06:39 INFO - 'MAIL': '/var/mail/cltbld', 03:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:39 INFO - 'MOZ_NO_REMOTE': '1', 03:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:39 INFO - 'NO_EM_RESTART': '1', 03:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:39 INFO - 'PWD': '/builds/slave/test', 03:06:39 INFO - 'SHELL': '/bin/bash', 03:06:39 INFO - 'SHLVL': '1', 03:06:39 INFO - 'TERM': 'linux', 03:06:39 INFO - 'TMOUT': '86400', 03:06:39 INFO - 'USER': 'cltbld', 03:06:39 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:39 INFO - '_': '/tools/buildbot/bin/python'} 03:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:39 INFO - Running setup.py (path:/tmp/pip-CI1JIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:39 INFO - Running setup.py (path:/tmp/pip-uVZiaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:39 INFO - Running setup.py (path:/tmp/pip-wRd_8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:39 INFO - Running setup.py (path:/tmp/pip-oUs0zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:39 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)) 03:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:39 INFO - Running setup.py (path:/tmp/pip-yIoX_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:39 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)) 03:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:39 INFO - Running setup.py (path:/tmp/pip-nHHtmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:40 INFO - Running setup.py (path:/tmp/pip-XW_C1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:40 INFO - Running setup.py (path:/tmp/pip-H_WHLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:40 INFO - Running setup.py (path:/tmp/pip-uMvFe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:40 INFO - Running setup.py (path:/tmp/pip-s9GNk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:40 INFO - Running setup.py (path:/tmp/pip-qkn9WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:40 INFO - Running setup.py (path:/tmp/pip-KnXWTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:40 INFO - Running setup.py (path:/tmp/pip-3v3zv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:40 INFO - Running setup.py (path:/tmp/pip-Ipi2ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:40 INFO - Running setup.py (path:/tmp/pip-_WXRAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:40 INFO - Running setup.py (path:/tmp/pip-_QRDQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:40 INFO - Running setup.py (path:/tmp/pip-3jQdi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:42 INFO - Downloading blessings-1.6.tar.gz 03:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:42 INFO - Installing collected packages: blessings 03:06:42 INFO - Running setup.py install for blessings 03:06:42 INFO - Successfully installed blessings 03:06:42 INFO - Cleaning up... 03:06:42 INFO - Return code: 0 03:06:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:43 INFO - Reading from file tmpfile_stdout 03:06:43 INFO - Current package versions: 03:06:43 INFO - argparse == 1.2.1 03:06:43 INFO - blessings == 1.6 03:06:43 INFO - blobuploader == 1.2.4 03:06:43 INFO - docopt == 0.6.1 03:06:43 INFO - manifestparser == 1.1 03:06:43 INFO - mozInstall == 1.12 03:06:43 INFO - mozcrash == 0.17 03:06:43 INFO - mozdebug == 0.1 03:06:43 INFO - mozdevice == 0.48 03:06:43 INFO - mozfile == 1.2 03:06:43 INFO - mozhttpd == 0.7 03:06:43 INFO - mozinfo == 0.9 03:06:43 INFO - mozleak == 0.1 03:06:43 INFO - mozlog == 3.1 03:06:43 INFO - moznetwork == 0.27 03:06:43 INFO - mozprocess == 0.22 03:06:43 INFO - mozprofile == 0.28 03:06:43 INFO - mozrunner == 6.11 03:06:43 INFO - mozscreenshot == 0.1 03:06:43 INFO - mozsystemmonitor == 0.0 03:06:43 INFO - moztest == 0.7 03:06:43 INFO - mozversion == 1.4 03:06:43 INFO - psutil == 3.1.1 03:06:43 INFO - requests == 1.2.3 03:06:43 INFO - wsgiref == 0.1.2 03:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:06:43 INFO - Using env: {'DISPLAY': ':0', 03:06:43 INFO - 'HOME': '/home/cltbld', 03:06:43 INFO - 'LANG': 'en_US.UTF-8', 03:06:43 INFO - 'LANGUAGE': 'en_US:en', 03:06:43 INFO - 'LOGNAME': 'cltbld', 03:06:43 INFO - 'MAIL': '/var/mail/cltbld', 03:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:43 INFO - 'MOZ_NO_REMOTE': '1', 03:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:43 INFO - 'NO_EM_RESTART': '1', 03:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:43 INFO - 'PWD': '/builds/slave/test', 03:06:43 INFO - 'SHELL': '/bin/bash', 03:06:43 INFO - 'SHLVL': '1', 03:06:43 INFO - 'TERM': 'linux', 03:06:43 INFO - 'TMOUT': '86400', 03:06:43 INFO - 'USER': 'cltbld', 03:06:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:43 INFO - '_': '/tools/buildbot/bin/python'} 03:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:06:43 INFO - Cleaning up... 03:06:43 INFO - Return code: 0 03:06:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:06:43 INFO - Using env: {'DISPLAY': ':0', 03:06:43 INFO - 'HOME': '/home/cltbld', 03:06:43 INFO - 'LANG': 'en_US.UTF-8', 03:06:43 INFO - 'LANGUAGE': 'en_US:en', 03:06:43 INFO - 'LOGNAME': 'cltbld', 03:06:43 INFO - 'MAIL': '/var/mail/cltbld', 03:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:43 INFO - 'MOZ_NO_REMOTE': '1', 03:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:43 INFO - 'NO_EM_RESTART': '1', 03:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:43 INFO - 'PWD': '/builds/slave/test', 03:06:43 INFO - 'SHELL': '/bin/bash', 03:06:43 INFO - 'SHLVL': '1', 03:06:43 INFO - 'TERM': 'linux', 03:06:43 INFO - 'TMOUT': '86400', 03:06:43 INFO - 'USER': 'cltbld', 03:06:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:43 INFO - '_': '/tools/buildbot/bin/python'} 03:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:43 INFO - Downloading/unpacking jsonschema 03:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:45 INFO - Downloading/unpacking functools32 (from jsonschema) 03:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:45 INFO - warning: no files found matching '*.txt' 03:06:45 INFO - no previously-included directories found matching 'build' 03:06:45 INFO - no previously-included directories found matching 'dist' 03:06:45 INFO - no previously-included directories found matching '.git*' 03:06:45 INFO - Installing collected packages: jsonschema, functools32 03:06:45 INFO - Running setup.py install for functools32 03:06:45 INFO - warning: no files found matching '*.txt' 03:06:45 INFO - no previously-included directories found matching 'build' 03:06:45 INFO - no previously-included directories found matching 'dist' 03:06:45 INFO - no previously-included directories found matching '.git*' 03:06:45 INFO - Successfully installed jsonschema functools32 03:06:45 INFO - Cleaning up... 03:06:45 INFO - Return code: 0 03:06:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65dbdaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16165a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', '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 03: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', 'flake8'] in /builds/slave/test/build 03: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 flake8 03:06:46 INFO - Using env: {'DISPLAY': ':0', 03:06:46 INFO - 'HOME': '/home/cltbld', 03:06:46 INFO - 'LANG': 'en_US.UTF-8', 03:06:46 INFO - 'LANGUAGE': 'en_US:en', 03:06:46 INFO - 'LOGNAME': 'cltbld', 03:06:46 INFO - 'MAIL': '/var/mail/cltbld', 03:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:46 INFO - 'MOZ_NO_REMOTE': '1', 03:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:46 INFO - 'NO_EM_RESTART': '1', 03:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:46 INFO - 'PWD': '/builds/slave/test', 03:06:46 INFO - 'SHELL': '/bin/bash', 03:06:46 INFO - 'SHLVL': '1', 03:06:46 INFO - 'TERM': 'linux', 03:06:46 INFO - 'TMOUT': '86400', 03:06:46 INFO - 'USER': 'cltbld', 03:06:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:46 INFO - '_': '/tools/buildbot/bin/python'} 03:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:46 INFO - Downloading/unpacking flake8 03: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 03: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 03: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 03: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 03: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 03: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 03:06:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:06:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:06:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:06:48 INFO - no previously-included directories found matching 'docs/_build' 03:06:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:06:48 INFO - Running setup.py install for pep8 03:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:06:48 INFO - no previously-included directories found matching 'docs/_build' 03:06:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:06:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:06:48 INFO - Cleaning up... 03:06:49 INFO - Return code: 0 03:06:49 INFO - Running post-action listener: _resource_record_post_action 03:06:49 INFO - Running post-action listener: _start_resource_monitoring 03:06:49 INFO - Starting resource monitoring. 03:06:49 INFO - ##### 03:06:49 INFO - ##### Running install step. 03:06:49 INFO - ##### 03:06:49 INFO - Running pre-action listener: _resource_record_pre_action 03:06:49 INFO - Running main action method: install 03:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:49 INFO - Reading from file tmpfile_stdout 03:06:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:06:49 INFO - Reading from file tmpfile_stdout 03:06:49 INFO - Output received: 03:06:49 INFO - Usage: mozinstall [options] installer 03:06:49 INFO - Options: 03:06:49 INFO - -h, --help show this help message and exit 03:06:49 INFO - -d DEST, --destination=DEST 03:06:49 INFO - Directory to install application into. [default: 03:06:49 INFO - "/builds/slave/test"] 03:06:49 INFO - --app=APP Application being installed. [default: firefox] 03:06:49 INFO - mkdir: /builds/slave/test/build/application 03:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:07:05 INFO - Reading from file tmpfile_stdout 03:07:05 INFO - Output received: 03:07:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:07:05 INFO - Running post-action listener: _resource_record_post_action 03:07:05 INFO - ##### 03:07:05 INFO - ##### Running run-tests step. 03:07:05 INFO - ##### 03:07:05 INFO - Running pre-action listener: _resource_record_pre_action 03:07:05 INFO - Running main action method: run_tests 03:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:07:05 INFO - Python 2.7.3 03:07:05 INFO - Return code: 0 03:07:05 INFO - grabbing minidump binary from tooltool 03:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5410>, '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 0x16a6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:07:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:07:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:07:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:07:05 INFO - Return code: 0 03:07:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:07:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:07:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:07:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:07:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:07:06 INFO - Return code: 0 03:07:06 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/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:07:06 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/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 03:07:06 INFO - Using env: {'DISPLAY': ':0', 03:07:06 INFO - 'HOME': '/home/cltbld', 03:07:06 INFO - 'LANG': 'en_US.UTF-8', 03:07:06 INFO - 'LANGUAGE': 'en_US:en', 03:07:06 INFO - 'LOGNAME': 'cltbld', 03:07:06 INFO - 'MAIL': '/var/mail/cltbld', 03:07:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:07:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:06 INFO - 'MOZ_NO_REMOTE': '1', 03:07:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:06 INFO - 'NO_EM_RESTART': '1', 03:07:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:06 INFO - 'PWD': '/builds/slave/test', 03:07:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:07:06 INFO - 'SHELL': '/bin/bash', 03:07:06 INFO - 'SHLVL': '1', 03:07:06 INFO - 'TERM': 'linux', 03:07:06 INFO - 'TMOUT': '86400', 03:07:06 INFO - 'USER': 'cltbld', 03:07:06 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081', 03:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:06 INFO - '_': '/tools/buildbot/bin/python'} 03:07:06 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/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:07:07 INFO - mozversion application_buildid: 20160419222324 03:07:07 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 03:07:07 INFO - mozversion application_display_name: Nightly 03:07:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:07:07 INFO - mozversion application_name: Firefox 03:07:07 INFO - mozversion application_remotingname: firefox 03:07:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:07:07 INFO - mozversion application_vendor: Mozilla 03:07:07 INFO - mozversion application_version: 48.0a1 03:07:07 INFO - mozversion platform_buildid: 20160419222324 03:07:07 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 03:07:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:07:07 INFO - mozversion platform_version: 48.0a1 03:07:07 INFO - using testdate: 1461146827 03:07:07 INFO - actual date: 1461146827 03:07:07 INFO - starting webserver on 'localhost:41145' 03:07:07 INFO - SUITE-START | Running 2 tests 03:07:07 INFO - TEST-START | dromaeo_css 03:07:07 INFO - operating with platform_type : linux_ 03:07:07 INFO - Initialising browser for dromaeo_css test... 03:07:07 INFO - TEST-INFO | started process 6595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hfOhj/profile http://localhost:41145/getInfo.html) 03:07:10 INFO - PROCESS | 6595 | 03:07:10 INFO - PROCESS | 6595 | (process:6663): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:07:11 INFO - PROCESS | 6595 | __metrics Screen width/height:1600/1200 03:07:11 INFO - PROCESS | 6595 | colorDepth:24 03:07:11 INFO - PROCESS | 6595 | Browser inner width/height: 1024/697 03:07:11 INFO - PROCESS | 6595 | __metrics 03:07:12 ERROR - PROCESS | 6595 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:07:13 INFO - TEST-INFO | 6595: exit 0 03:07:13 INFO - Browser initialized. 03:07:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:13 INFO - TEST-INFO | started process 6714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hfOhj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:15 INFO - PROCESS | 6714 | 03:07:15 INFO - PROCESS | 6714 | (process:6775): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:07:25 INFO - PROCESS | 6714 | RSS: Main: 163528704 03:07:25 INFO - PROCESS | 6714 | 03:08:14 INFO - PROCESS | 6714 | 1461146894700 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] 03:10:23 INFO - PROCESS | 6714 | Cycle 1(1): loaded http://localhost:41145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41145/tests/dromaeo/cssquery-ext.html) 03:10:24 INFO - PROCESS | 6714 | RSS: Main: 168644608 03:10:24 INFO - PROCESS | 6714 | 03:13:26 INFO - PROCESS | 6714 | Cycle 1(1): loaded http://localhost:41145/tests/dromaeo/cssquery-ext.html (next: http://localhost:41145/tests/dromaeo/cssquery-jquery.html) 03:13:26 INFO - PROCESS | 6714 | RSS: Main: 165126144 03:13:26 INFO - PROCESS | 6714 | 03:16:28 INFO - PROCESS | 6714 | Cycle 1(1): loaded http://localhost:41145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41145/tests/dromaeo/cssquery-mootools.html) 03:16:29 INFO - PROCESS | 6714 | RSS: Main: 166260736 03:16:29 INFO - PROCESS | 6714 | 03:19:30 INFO - PROCESS | 6714 | Cycle 1(1): loaded http://localhost:41145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41145/tests/dromaeo/cssquery-prototype.html) 03:19:31 INFO - PROCESS | 6714 | RSS: Main: 163962880 03:19:31 INFO - PROCESS | 6714 | 03:22:33 INFO - PROCESS | 6714 | Cycle 1(1): loaded http://localhost:41145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41145/tests/dromaeo/cssquery-yui.html) 03:22:34 INFO - PROCESS | 6714 | RSS: Main: 164659200 03:22:34 INFO - PROCESS | 6714 | 03:25:36 INFO - PROCESS | 6714 | Cycle 1(1): loaded http://localhost:41145/tests/dromaeo/cssquery-yui.html (next: http://localhost:41145/tests/dromaeo/cssquery-dojo.html) 03:25:37 INFO - PROCESS | 6714 | RSS: Main: 167292928 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | __start_tp_report 03:25:37 INFO - PROCESS | 6714 | _x_x_mozilla_page_load 03:25:37 INFO - PROCESS | 6714 | _x_x_mozilla_page_load_details 03:25:37 INFO - PROCESS | 6714 | |i|pagename|runs| 03:25:37 INFO - PROCESS | 6714 | |0;dojo.html;3162.4149532336514;3206.519022146678;3269.182704323919;3308.421026320393;3308.470644696849;5623.381428042917;5626.493615574597;5630.690312032836;5678.943210567893;5682.545396368291;5583.134614134806;5642.830715078544;5677.886442271162;5746.9712651436685;5767.711614419283;5052.469490703478;5084.618653600976;5099.235114732801;5140.922886156692;5146.228065790124;5094.312267843849;5203.375594928614;5232.2674825524455;5244.265802787613;5252.8686782830355;4961.355023846895;5017;5083.034223497523;5123.077845987721;5146.408163061258;4938.407391113054;4959.404871415417;4959.752012399365;4974.577160941324;5022.723750193738;4949.826756063557;4956.008798240367;4958.504149585013;4979.10376132296;4982.6013918886765;5437.293151890269;5465.398806131322;5465.398806131322;5467.507924286833;5516.724163791834;5992.011318132503;6012.218411606507;6022.096685497167;6026.939730602681;6037.366076561942;5970.940290597126;6023.668698221596;6044.184035155242;6048.364921683204;6051.1830902828;5621.4659607337235;5638.154276858422;5640.32316122068;5677.347105082927;5683.403242659502;6051.636901785907;6085.300190478063;6086.6348019119;6088.238970128734;6102.908456373158;5784.363719990798;5817;5859.384764599741;5879.676617786063;5897.49871260939;6000.129981152709;6000.879982400327;6009.939900601025;6032.095185722089;6077.453029227391;5858.355580886099;5910.320313163955;5943.762249509971;6015.218021657157;6103.816885493442;5813.6221145625395;5865.765369385262;5884.08796636522;5940.851478713067;5951.642901425928;4431.313146462304;4431.8448854289945;4537.750423726727;4557.043020965634;4591.9081618367445;3950;3979.4030895365927;3983.601639836051;3996.1208534122447;4004.379321205218;5607.579431542651;5626.099824028136;5657;5669.06460434032;5676.2337084493065;5930.28836539618;5953.136795164677;5982.611130276518;5999.520038396918;6014.969925150346;5629.408912064257;5640.294963129609;5661.801836935688;5666.518345940559;5696.430356964271;5083.313752643419;5092.745362731923;5092.821751238763;5099.898002039939;5135.794568217304;6103.337669688931;6250;6263.4362907337645;6270.905936410957;6293.930031894497;6011.0382338825575;6027.427394397525;6036.124761909587;6036.305824830025;6091.4822240108315;5914.083317085859;6079.361667025076;6137.14643565387;6186.938130618636;6188.690565471798;5930.110483427347;5998.070299103646;6002.039673652194;6005.549583781321;6019.909701354571;6050.21347224858;6088.086786981989;6089.360617135314;6090.878182436415;6103.664298463449;5856.531477481876;5923.170756094064;5949.1076338549565;5961.463468287875;6013.398660133952;5837.94162058374;5850.297964244318;5871.060630299132;5928.436798504135;5974.522038237017;5682.886342273214;5711.628744131618;5726;5731.7420716067045;5736.42635736423;5646.096624540054;5842.678652674143;5868.911966320423;5891.1752354671235;5936.436038576328;5719.084946408721;5728.570357223141;5745.827625171084;5746.13807928814;5800.1299805029585 03:25:37 INFO - PROCESS | 6714 | |1;ext.html;596.9940300596993;648.7372614091295;652.305294860973;664.9667516624168;681.9522633415656;34108.31783364334;35659;35730.46404303938;35782.82108589457;35900.10249743755;39512.22195001232;39878.202435951265;40059.39910901331;40338.39492407609;40388;8596.785080372994;8769.473831570094;8769.912300877006;8771.210591046805;8775.473471591693;8619.138086191393;8722.476651400937;8757.080506546816;8763.868541971875;8772.780680482974;8735.737927862174;8814.515201663906;8823.867641985375;8847.646094156225;8853.42452740573;8677.43596666221;8730.301575873946;8746.169113934166;8775.25410340122;8781.38530302879;8495.957520212422;8580;8596.699115530926;8598.269147122503;8617.69838055665;31889.362212755615;37734.245315093816;38181.23637527234;38196.42705359394;38398.23203535942;3450.3271861986923;3459.7924124552605;3493.5283736695474;3525.189206482498;3621.311950729353;27046.1886143416;28044.298892527648;28279.575806362922;28449.715502844912;29011.274718132005;3210.4542227821325;3230.2893363460234;3264.689854463822;3315.7347412207205;3321.8671253149846;195280;195497;195742;197232;244515;34425.483617745755;35303;37511.62488375081;38668.80665596654;38672.41991370132;36529.81735091307;36783.81608091996;36832.07919802026;36847.631523684955;36932;15707.607309817346;15929.920350398173;15942.362305507882;15956.2819673115;15963.361465541248;13194.406251718696;13227.404766785517;13258.00564957632;13263.602091937257;13280.734385312433;8565.700200492953;8578.09929957358;8665.483540380408;8717.95384553845;8727.389082764146;3285.868565257363;3305.933881322408;3315.1712071982006;3331.4336562784383;3361;1074.4573990134932;1079.3254216114929;1098.9230753847314;1107.7950579142885;1190.4345435918042;31784.20539486485;32163;32261.838690806864;32666;32920.83539582287;1097.3799803111217;1165.6619580321612;1167.0780083733925;1173.202222488716;1234.512367614787;17145.571360716083;17248.137593120293;17330.39343622967;17334.133293335282;17375.131243437776;462045;466557;469523;470272;473555.3222338869;57898.42101579015;58689;58707.70646146742;58729.70635146797;58767.706161469774;1372.848986611472;1406.2476575032308;1429.3139293139143;1429.6926160875253;1435.9066660667024;30729.539056913716;30943.690563094082;31589.65402610758;31796.5230521547;32422.35155296928;51113.744431277606;51424.74287628687;51577.742111289204;51692.74153629208;51921.740391297804;404848;409900;412576;414177;415021;28119.156425307272;28677;28695.713042869305;28696.85651571729;28786.7121328784;47551.5244847561;48425.27362089642;48511.5148848507;48710;49260.50739492702;40286.39570406505;40834;41260.38109428301;41337.1732565353;41654.79172604118;38930.85880276612;39527.80236098801;39936;40271.597284026786;40986.1802763949;36639;40766.59233407747;41910.37134443047;41922.58077419309;42835.7858210707;31290.687093128778;32465;32623.836880815445;32797.672023280415;33046.33907321792;25400.237992860242;25468.23595292144;25849.612255815802;25859.612105818804;26185.60721589216 03:25:37 INFO - PROCESS | 6714 | |2;jquery.html;391.2878561018946;394.5265681182582;402.08525604250326;403.6952101163621;404.2279246638918;17637.29450821967;18459.907700461496;18484.353047643333;18563.443096707088;20070.698939515918;18680.626387472243;19240.42278731637;19566.902165489188;19579;19613.50966225845;5638.238837756912;5728.255326807509;5856.56075794315;5874.73563689635;5882.6764527950945;5801.6519008859395;5815.505682017034;5818.0981947798155;5832.795852145176;5837;5521.806736764194;5712.685802280873;5757.856053598652;5792.913106303409;5822.854428639275;5712;5713.028785106542;5713.714314284269;5761.625494342854;5767.826965191009;4951.925721114186;5100.872478188038;5108.821191258288;5110.565601923841;5113.846584602468;21827.23604673829;21970.89014554933;22397.848494846115;22669.77330226693;22825.31524054281;2476.6532685424054;2512.5854234051358;2769.3492029373283;2773.959765088092;2776.805623606328;13404.329783510786;13975.371108300049;14427.422903083969;14574.854251457456;14759.18824464654;1913.6077104193607;1968.1536939116174;1973.4572992427054;1976.8418526517844;2008.829249513793;73126.63436682835;75307;75522.99999999945;77186;79511;10282.537285822156;10300.175985921109;10350.223733220038;10758.462076896123;10849.566017359217;15365.923170384076;15428.38286468551;15458.149801761012;15555.14446705442;15562.66560015984;8128.431009829374;8297.294729947902;8381.916180838236;8424.241818236265;8579.613917373734;8051.396145289127;8086.433949623588;8158.428909976364;8198.303144232807;8231.382646301552;4642.094791515622;4686.3204835299375;4709.175894218498;4713.622910167179;4777.426708794897;1908.351160605373;1978.6537355962648;1989.5424052468013;1992.900354982245;1993.8305244054127;938.9061093890693;1069.8395240713955;1070.9892901071046;1080.233034545466;1122.2985633978763;18002.189901454465;18113.547161321072;19043.238270469024;19131.61736765257;19161;1019.5972590826582;1023.5036007536339;1042.155853758458;1048.1352883870836;1114.6878873915316;10373.740656483498;10588.841167382496;10748.516316765765;10749.355038697704;10846.945765271123;464555;469265;474412;478584;478975;90913;93121.53439232896;96023;96932.51533742287;96978;1023.6570748799087;1043.0351924469835;1044.7335929337971;1055.8680164979378;1062.5749700120014;16202.513924582281;16410;16620;16839.747403788708;16983.7452438216;38048;39569.60430395774;39594.2081158381;39871.40192897051;40320.596794032856;53936.460635393145;55939.72030139823;56514.71742641425;56866;57448.71275643595;8155;8411.747647570583;8446.535440550582;8464.44981076228;8862.379633425599;9566.56950437218;12573.622791316275;13136.40886160106;13473.528426505025;13492.257925814174;11683.240589361665;11939.104567157325;11955.880441195477;11966;12003.339816309837;11347.716307092389;11556.828558739673;11673.591424300448;11688.532458701557;11895.940520297689;11924.582639607572;11932.821007684717;12077.51689932393;12273.386330683608;12334.50661973511;8459.746207613782;8758.430702004349;8816.647334106821;8955.194032537103;9054.456732596065;9124.133207345292;12233.571824986082;12279.263244205376;12370.381480926098;12585.181963172365 03:25:37 INFO - PROCESS | 6714 | |3;mootools.html;1508.1328236264148;1533.4326299269271;1716.613761903571;1828.5520047588343;1871.6256748650273;7596.696132154707;8216.95891520543;8275.08974012858;8499.362547808916;8521.190486903743;8270.586470676471;8288.088310285864;8323.91676083239;8401.789955251123;8407.70573029944;2295.6326987681973;2332.183735692511;2338.543983923136;2338.6375111857687;2342.8360014798886;2233.932982010542;2269.2511471214543;2269.7389800173028;2274.920377786778;2280.1677387753516;2258.141906075697;2275.3174047785683;2277.3168049585142;2295.5523672883796;2297.1959814065112;2243.102758896438;2261.174671244992;2266.8073213776847;2269.841111122222;2274.2494976657827;2224.9876306280603;2226.4322597737473;2230.2417178159503;2234.932952011426;2237.295251995616;8458.492490450593;8485.0242222144;8558.400911936167;8573.271271941892;8601.741947741577;5065.696058236517;5219.112750832368;5242.318498595197;5244.056069907415;5251.36983561975;3325.6840600142946;3335.849886755102;3402.6767457091537;3423.554937858087;3494.4408894577;1072.6835583502886;1076.7631121153333;1091.110744743032;1093.868735751715;1096.8519249901242;11767.529298828036;11839.763204735857;11912.106592005548;11927.284362938164;11938.28370297785;4500.864974050718;4506.81972721094;4680.157571637138;4703.318018887242;4741.596964258008;9792.265580081379;9842.360246583949;9852.852207216898;9889;9936.80126397468;5332.493413125747;5345.70598617072;5376.973115134399;5383.865403364947;5394.811181608625;4383.846565370197;4833.830815921426;4936.3829521309835;4941.03649788295;4956.281339205867;3954.347532657137;3974.28462876685;4040.1717647882115;4064.3700226464944;4108.77401742901;1263.1473755215193;1273.4530938123753;1283.4930202569933;1291.9806202906964;1304.7260075384277;982.7297493189287;997;1016.3901659004538;1018.0379541333369;1021.8722659667542;5952.791652292149;5959.851003724942;5972.790952316648;5983.581149319506;6125.081237814275;446.04546270980126;449.5347315528478;451.17209919796886;454.4773510462994;458.7981288233167;4172.5410204877435;4231.259529582372;4234.6188843003665;4242.427272318259;4284.443022407129;10051.195904327637;10501.894981050245;10569.682909512727;10577.9471102644;10594.947025264824;10274.178065754722;10439.164866810637;10470.895291047143;10476.68569942903;10486.37081775096;7824.413169012233;8026.277635012877;8154.633041513146;8155.5514446706;8162.30620397261;5840.269966254218;5932.4957378621575;6023.939760602513;6045.1234570987845;6055.818325450244;9595.088466595662;9655.468949207861;9663.323567350219;9676.419414835133;9779.26655500826;9522.857157142787;9703.417794932328;9740.318177727491;9937.900620993698;9990.550425230736;6654.301298363602;7347.942576078706;7358.264173582599;7500.549967001997;7585.127710313164;8036.9953755780525;8069.5965201740855;8073.596320184085;8115.513069215866;8136.511809291462;7058.11773528309;7282.635868206675;7320.633968301457;7422.443316751157;7455.92544074574;7157.427405807419;7216.9278307216255;7239.782806515813;7312.085989251344;7527.397808175223;6675.465962723068;6686.364795344434;6760.22257440381;6769.796906092825;6785.796426107225;4933.679310844784;5116.488351165002;5133.307003554472;5219.217117432264;5236.9738151309;5124.154514505065;5132.409772876167;5205.245239440184;5241.868953276198;5402.243685884058 03:25:37 INFO - PROCESS | 6714 | |4;prototype.html;333.2345611844886;334.5700774504761;342.5632318793536;345.13887849814716;346.69144461429346;5996.88006239876;6029.246344206974;6080.604760690552;6096.750166215927;6104.847378815526;6093.695315234231;6093.847653808657;6111.174991376163;6131.202943617323;6132.2028136342215;4587.449506059261;4595.448546174463;4598.080383923212;4612.146752850734;4617.2381557043045;4317.784110794463;4531.592156705896;4567.931481027787;4584.3352713856475;4594.58648721615;4520.50274469808;4521.253993091136;4525.570070843281;4543.954560454403;4553.043860789238;4526.592606665399;4545.977270113662;4565;4567.33773602829;4582.221022426195;3885.7668539887413;3947.5577028964153;3948.881533553998;3963.6432721054957;3964.444977703124;5788.768449262025;5791.536677065825;5824.737886795105;5832.708364581754;5845.736941837585;5274.789008439658;5295.391030031518;5312.273511108905;5320.467953204648;5338;6009.733089506456;6365.586236894587;6369.420384744186;6383.936160638381;6395.5842870213755;4268.9573104268875;4315.956840431587;4315.978420107879;4323.891902702426;4340.457442819647;6314.5895516791725;6648.734050637969;6682.599044057372;6707.128073350482;6711.597304161766;4496.527864574238;4502.729836209838;4504.414426124583;4508.18852606534;4519.728816270968;4522.932156017662;4549.181147393501;4556.931646025312;4563.885902852455;4579.908401832011;5012.423571289275;5256.737163141827;5306.8407947761625;5318.750093727971;5326.174442961347;6210.230084426007;6372.311337495567;6415.358464153641;6419.646919419477;6428.774992875227;1537.6540278437262;1543.9536813895602;1547.5047984644805;1556.6108472881779;1557.6339560203344;1032.2670903658336;1041.3023274406166;1055.2033214922837;1066.3388699006666;1066.4401189375485;6145.231846019247;6146.877062458726;6166.321704612489;6169.2288463942;6175.814725558241;6533.379328963741;6591.835204119935;6605.801825945229;6610.0745895574655;6639;5962.4633782959745;6101.877962440726;6186.907196392058;6203.379662033851;6225.190725205694;3498.9475157872653;3501.5272938153535;3504.4392897136336;3505.631908649606;3510;6527.445167160749;6710.396064354231;6779.322067793181;6794.660266986631;6829;6736.5284430090405;6745.831354216086;6756.83107922296;6767.187937447439;6789.966050169816;6581;6761.121054262914;6773.559718618274;6798.436359637311;6805.251422343637;6461.483081353575;6530.934690653223;6538.692261547614;6575.375339342755;6585.374389432996;6384.521160913043;6468.935310646833;6481.287058423475;6496.285408604956;6503.6097834130105;6750.324967503407;6784.457243420416;6786.558873673195;6787.864242715217;6799.5920244785475;4455.75493347869;4465.910681786411;4475.485319188335;4500.2124628189285;4504.301833215857;6363.61818290904;6471.902921456088;6478.190226221723;6534.353586797355;6596.109525214035;6396.29640739509;6411.967940160456;6448.1295025171;6465.838354041187;6489.610623362424;6288.717007734572;6425.164728585254;6431.935680643133;6432;6436.935630643634;6264.49884009269;6282.2147231596055;6298.496120310456;6367.204099487564;6371.331010243857;6367.235931688227;6388.1376014237485;6409.9679501602195;6438.935610644021;6505.804825855232;6162.722677479434;6186.4142461793635;6278.529110316653;6310.337414571588;6323.494120470259 03:25:37 INFO - PROCESS | 6714 | |5;yui.html;682.5290549520834;725.0031207090251;738.4240292571794;750.4034292737275;758.0827199089106;14391.352389142488;14595.416183352652;14599.70800583989;14661.70676586469;14814.925925370359;13059.673508162301;13077.67305817355;13096;13100.803487947689;13105.148165369268;689.1626673591585;823.518241828531;824.5959479854873;840.9537475438848;842.0064324097593;825.014108140772;825.7357645553425;827.3215962910385;827.5779352530193;828.5484410996022;874.6894852327396;875.7504111328273;880.7093659092516;880.8194320164351;880.9515476648781;873.6898401067625;874.3005595523556;874.5802015032788;876.0669886570845;878.3324673248313;634.0077778277027;634.8539835837784;635.5265327331122;638.6998110887876;640.0910706796313;14305.785413218706;14306.427742890271;14377.856221437756;14418.13491190532;14451.349689264009;13512.662183445493;13948;14146.929265353607;14216.218108004055;14267.643308917257;11023.779524409547;11173.078268517698;11206.607768728056;11285.548578056867;11532.654020379403;3822.847086116552;3825.6556909878245;3897.279003384355;3916.373380259145;3943.605639436062;53804.461955380335;54182;55147;55336.44663553393;55388.44611553873;10458.058774710313;10470.947645261725;10514.421706806199;10666.306690065121;10695.197860160519;20408.591828163353;20448.284310049075;20488;20496;20549.48626284325;8264.256216940505;8334.749957501284;8451.830963380698;8583.699570515128;8690.000649925212;4624.583787459078;4640.862988567823;4684.882877928079;4687.601553867891;4837.080954618611;3418.572678415198;3527.8059706715862;3537.823108844599;3565.073080998959;3579.552555930509;600.8527910661916;612.6783438694721;650.612885333226;679.4055201698513;680.8195828105556;769.7113582406597;774.8566515194707;775.9650815713306;790.4782843323379;823.2056065896319;8229.341652667772;8848.646054157762;9040.8643870342;9505.382150160218;9511;699.8040548646285;765.9885101723479;772.7681695491331;796.1759578835877;805.5609692717483;4481.126180394792;4530.365748795171;4617.699849509771;4628.190066738307;4630.83792067276;65491;65681.34318656848;66051.66974165099;67259.99110013354;67319.66340168267;56062.15906761402;57303.71348143316;58542.707286464145;59226;59667.403325967054;48419.5158048415;50327.74836125796;51552;52463.73768131135;52641.94716105657;8821.60302786389;8859.335549833659;8881.200691937498;8954.776130596527;9027.187553120251;33078.66921330852;33473.83263083766;33556;33667;33715.325693486484;42040.579594203664;43899.78050109729;44198.55801441945;44474.77762611166;47204.291935620306;11966.58116965902;11984.820227696417;12052.276863388224;12124.454399551865;12392.132550721362;13139;13156.40796164194;13293.335333233494;13463.528776492776;14118.2940852959;12256.816147757969;12791.104622676696;13040.608781736562;13075.411606477921;13169.934150329187;12218.144729868824;12571.93714031424;12603.432845521791;12605.621831345074;12999.805002924775;12331.445084971378;12514.561990330294;12703.174293670882;12794.552190673281;12795;9682.128608425275;9967.800643986935;10271.383716977005;10449.84325235107;10636.468176590985;9826.312158148861;9861.852072219066;10323.277370584288;10349.74125646865;10405.323653962469 03:25:37 INFO - PROCESS | 6714 | __end_tp_report 03:25:37 INFO - PROCESS | 6714 | __start_cc_report 03:25:37 INFO - PROCESS | 6714 | _x_x_mozilla_cycle_collect,350 03:25:37 INFO - PROCESS | 6714 | __end_cc_report 03:25:37 INFO - PROCESS | 6714 | __startTimestamp1461147937081__endTimestamp 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | ------- Summary: start ------- 03:25:37 INFO - PROCESS | 6714 | Number of tests: 6 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | [#0] dojo.html Cycles:165 Average:5555.80 Median:5746.14 stddev:649.21 (11.3%) stddev-sans-first:623.45 03:25:37 INFO - PROCESS | 6714 | Values: 3162.4 3206.5 3269.2 3308.4 3308.5 5623.4 5626.5 5630.7 5678.9 5682.5 5583.1 5642.8 5677.9 5747.0 5767.7 5052.5 5084.6 5099.2 5140.9 5146.2 5094.3 5203.4 5232.3 5244.3 5252.9 4961.4 5017.0 5083.0 5123.1 5146.4 4938.4 4959.4 4959.8 4974.6 5022.7 4949.8 4956.0 4958.5 4979.1 4982.6 5437.3 5465.4 5465.4 5467.5 5516.7 5992.0 6012.2 6022.1 6026.9 6037.4 5970.9 6023.7 6044.2 6048.4 6051.2 5621.5 5638.2 5640.3 5677.3 5683.4 6051.6 6085.3 6086.6 6088.2 6102.9 5784.4 5817.0 5859.4 5879.7 5897.5 6000.1 6000.9 6009.9 6032.1 6077.5 5858.4 5910.3 5943.8 6015.2 6103.8 5813.6 5865.8 5884.1 5940.9 5951.6 4431.3 4431.8 4537.8 4557.0 4591.9 3950.0 3979.4 3983.6 3996.1 4004.4 5607.6 5626.1 5657.0 5669.1 5676.2 5930.3 5953.1 5982.6 5999.5 6015.0 5629.4 5640.3 5661.8 5666.5 5696.4 5083.3 5092.7 5092.8 5099.9 5135.8 6103.3 6250.0 6263.4 6270.9 6293.9 6011.0 6027.4 6036.1 6036.3 6091.5 5914.1 6079.4 6137.1 6186.9 6188.7 5930.1 5998.1 6002.0 6005.5 6019.9 6050.2 6088.1 6089.4 6090.9 6103.7 5856.5 5923.2 5949.1 5961.5 6013.4 5837.9 5850.3 5871.1 5928.4 5974.5 5682.9 5711.6 5726.0 5731.7 5736.4 5646.1 5842.7 5868.9 5891.2 5936.4 5719.1 5728.6 5745.8 5746.1 5800.1 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | [#1] ext.html Cycles:180 Average:51215.34 Median:36807.95 stddev:100800.77 (273.9%) stddev-sans-first:101011.89 03:25:37 INFO - PROCESS | 6714 | Values: 597.0 648.7 652.3 665.0 682.0 34108.3 35659.0 35730.5 35782.8 35900.1 39512.2 39878.2 40059.4 40338.4 40388.0 8596.8 8769.5 8769.9 8771.2 8775.5 8619.1 8722.5 8757.1 8763.9 8772.8 8735.7 8814.5 8823.9 8847.6 8853.4 8677.4 8730.3 8746.2 8775.3 8781.4 8496.0 8580.0 8596.7 8598.3 8617.7 31889.4 37734.2 38181.2 38196.4 38398.2 3450.3 3459.8 3493.5 3525.2 3621.3 27046.2 28044.3 28279.6 28449.7 29011.3 3210.5 3230.3 3264.7 3315.7 3321.9 195280.0 195497.0 195742.0 197232.0 244515.0 34425.5 35303.0 37511.6 38668.8 38672.4 36529.8 36783.8 36832.1 36847.6 36932.0 15707.6 15929.9 15942.4 15956.3 15963.4 13194.4 13227.4 13258.0 13263.6 13280.7 8565.7 8578.1 8665.5 8718.0 8727.4 3285.9 3305.9 3315.2 3331.4 3361.0 1074.5 1079.3 1098.9 1107.8 1190.4 31784.2 32163.0 32261.8 32666.0 32920.8 1097.4 1165.7 1167.1 1173.2 1234.5 17145.6 17248.1 17330.4 17334.1 17375.1 462045.0 466557.0 469523.0 470272.0 473555.3 57898.4 58689.0 58707.7 58729.7 58767.7 1372.8 1406.2 1429.3 1429.7 1435.9 30729.5 30943.7 31589.7 31796.5 32422.4 51113.7 51424.7 51577.7 51692.7 51921.7 404848.0 409900.0 412576.0 414177.0 415021.0 28119.2 28677.0 28695.7 28696.9 28786.7 47551.5 48425.3 48511.5 48710.0 49260.5 40286.4 40834.0 41260.4 41337.2 41654.8 38930.9 39527.8 39936.0 40271.6 40986.2 36639.0 40766.6 41910.4 41922.6 42835.8 31290.7 32465.0 32623.8 32797.7 33046.3 25400.2 25468.2 25849.6 25859.6 26185.6 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | [#2] jquery.html Cycles:180 Average:28411.29 Median:22747.54 stddev:78047.61 (343.1%) stddev-sans-first:78238.20 03:25:37 INFO - PROCESS | 6714 | Values: 391.3 394.5 402.1 403.7 404.2 17637.3 18459.9 18484.4 18563.4 20070.7 18680.6 19240.4 19566.9 19579.0 19613.5 5638.2 5728.3 5856.6 5874.7 5882.7 5801.7 5815.5 5818.1 5832.8 5837.0 5521.8 5712.7 5757.9 5792.9 5822.9 5712.0 5713.0 5713.7 5761.6 5767.8 4951.9 5100.9 5108.8 5110.6 5113.8 21827.2 21970.9 22397.8 22669.8 22825.3 2476.7 2512.6 2769.3 2774.0 2776.8 13404.3 13975.4 14427.4 14574.9 14759.2 1913.6 1968.2 1973.5 1976.8 2008.8 73126.6 75307.0 75523.0 77186.0 79511.0 10282.5 10300.2 10350.2 10758.5 10849.6 15365.9 15428.4 15458.1 15555.1 15562.7 8128.4 8297.3 8381.9 8424.2 8579.6 8051.4 8086.4 8158.4 8198.3 8231.4 4642.1 4686.3 4709.2 4713.6 4777.4 1908.4 1978.7 1989.5 1992.9 1993.8 938.9 1069.8 1071.0 1080.2 1122.3 18002.2 18113.5 19043.2 19131.6 19161.0 1019.6 1023.5 1042.2 1048.1 1114.7 10373.7 10588.8 10748.5 10749.4 10846.9 464555.0 469265.0 474412.0 478584.0 478975.0 90913.0 93121.5 96023.0 96932.5 96978.0 1023.7 1043.0 1044.7 1055.9 1062.6 16202.5 16410.0 16620.0 16839.7 16983.7 38048.0 39569.6 39594.2 39871.4 40320.6 53936.5 55939.7 56514.7 56866.0 57448.7 8155.0 8411.7 8446.5 8464.4 8862.4 9566.6 12573.6 13136.4 13473.5 13492.3 11683.2 11939.1 11955.9 11966.0 12003.3 11347.7 11556.8 11673.6 11688.5 11895.9 11924.6 11932.8 12077.5 12273.4 12334.5 8459.7 8758.4 8816.6 8955.2 9054.5 9124.1 12233.6 12279.3 12370.4 12585.2 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | [#3] mootools.html Cycles:180 Average:5634.31 Median:5120.32 stddev:3140.25 (61.3%) stddev-sans-first:3133.75 03:25:37 INFO - PROCESS | 6714 | Values: 1508.1 1533.4 1716.6 1828.6 1871.6 7596.7 8217.0 8275.1 8499.4 8521.2 8270.6 8288.1 8323.9 8401.8 8407.7 2295.6 2332.2 2338.5 2338.6 2342.8 2233.9 2269.3 2269.7 2274.9 2280.2 2258.1 2275.3 2277.3 2295.6 2297.2 2243.1 2261.2 2266.8 2269.8 2274.2 2225.0 2226.4 2230.2 2234.9 2237.3 8458.5 8485.0 8558.4 8573.3 8601.7 5065.7 5219.1 5242.3 5244.1 5251.4 3325.7 3335.8 3402.7 3423.6 3494.4 1072.7 1076.8 1091.1 1093.9 1096.9 11767.5 11839.8 11912.1 11927.3 11938.3 4500.9 4506.8 4680.2 4703.3 4741.6 9792.3 9842.4 9852.9 9889.0 9936.8 5332.5 5345.7 5377.0 5383.9 5394.8 4383.8 4833.8 4936.4 4941.0 4956.3 3954.3 3974.3 4040.2 4064.4 4108.8 1263.1 1273.5 1283.5 1292.0 1304.7 982.7 997.0 1016.4 1018.0 1021.9 5952.8 5959.9 5972.8 5983.6 6125.1 446.0 449.5 451.2 454.5 458.8 4172.5 4231.3 4234.6 4242.4 4284.4 10051.2 10501.9 10569.7 10577.9 10594.9 10274.2 10439.2 10470.9 10476.7 10486.4 7824.4 8026.3 8154.6 8155.6 8162.3 5840.3 5932.5 6023.9 6045.1 6055.8 9595.1 9655.5 9663.3 9676.4 9779.3 9522.9 9703.4 9740.3 9937.9 9990.6 6654.3 7347.9 7358.3 7500.5 7585.1 8037.0 8069.6 8073.6 8115.5 8136.5 7058.1 7282.6 7320.6 7422.4 7455.9 7157.4 7216.9 7239.8 7312.1 7527.4 6675.5 6686.4 6760.2 6769.8 6785.8 4933.7 5116.5 5133.3 5219.2 5237.0 5124.2 5132.4 5205.2 5241.9 5402.2 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | [#4] prototype.html Cycles:180 Average:5320.00 Median:6121.19 stddev:1620.02 (26.5%) stddev-sans-first:1580.73 03:25:37 INFO - PROCESS | 6714 | Values: 333.2 334.6 342.6 345.1 346.7 5996.9 6029.2 6080.6 6096.8 6104.8 6093.7 6093.8 6111.2 6131.2 6132.2 4587.4 4595.4 4598.1 4612.1 4617.2 4317.8 4531.6 4567.9 4584.3 4594.6 4520.5 4521.3 4525.6 4544.0 4553.0 4526.6 4546.0 4565.0 4567.3 4582.2 3885.8 3947.6 3948.9 3963.6 3964.4 5788.8 5791.5 5824.7 5832.7 5845.7 5274.8 5295.4 5312.3 5320.5 5338.0 6009.7 6365.6 6369.4 6383.9 6395.6 4269.0 4316.0 4316.0 4323.9 4340.5 6314.6 6648.7 6682.6 6707.1 6711.6 4496.5 4502.7 4504.4 4508.2 4519.7 4522.9 4549.2 4556.9 4563.9 4579.9 5012.4 5256.7 5306.8 5318.8 5326.2 6210.2 6372.3 6415.4 6419.6 6428.8 1537.7 1544.0 1547.5 1556.6 1557.6 1032.3 1041.3 1055.2 1066.3 1066.4 6145.2 6146.9 6166.3 6169.2 6175.8 6533.4 6591.8 6605.8 6610.1 6639.0 5962.5 6101.9 6186.9 6203.4 6225.2 3498.9 3501.5 3504.4 3505.6 3510.0 6527.4 6710.4 6779.3 6794.7 6829.0 6736.5 6745.8 6756.8 6767.2 6790.0 6581.0 6761.1 6773.6 6798.4 6805.3 6461.5 6530.9 6538.7 6575.4 6585.4 6384.5 6468.9 6481.3 6496.3 6503.6 6750.3 6784.5 6786.6 6787.9 6799.6 4455.8 4465.9 4475.5 4500.2 4504.3 6363.6 6471.9 6478.2 6534.4 6596.1 6396.3 6412.0 6448.1 6465.8 6489.6 6288.7 6425.2 6431.9 6432.0 6436.9 6264.5 6282.2 6298.5 6367.2 6371.3 6367.2 6388.1 6410.0 6438.9 6505.8 6162.7 6186.4 6278.5 6310.3 6323.5 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - PROCESS | 6714 | [#5] yui.html Cycles:180 Average:15017.48 Median:4635.85 stddev:17646.01 (380.6%) stddev-sans-first:17662.67 03:25:37 INFO - PROCESS | 6714 | Values: 682.5 725.0 738.4 750.4 758.1 14391.4 14595.4 14599.7 14661.7 14814.9 13059.7 13077.7 13096.0 13100.8 13105.1 689.2 823.5 824.6 841.0 842.0 825.0 825.7 827.3 827.6 828.5 874.7 875.8 880.7 880.8 881.0 873.7 874.3 874.6 876.1 878.3 634.0 634.9 635.5 638.7 640.1 14305.8 14306.4 14377.9 14418.1 14451.3 13512.7 13948.0 14146.9 14216.2 14267.6 11023.8 11173.1 11206.6 11285.5 11532.7 3822.8 3825.7 3897.3 3916.4 3943.6 53804.5 54182.0 55147.0 55336.4 55388.4 10458.1 10470.9 10514.4 10666.3 10695.2 20408.6 20448.3 20488.0 20496.0 20549.5 8264.3 8334.7 8451.8 8583.7 8690.0 4624.6 4640.9 4684.9 4687.6 4837.1 3418.6 3527.8 3537.8 3565.1 3579.6 600.9 612.7 650.6 679.4 680.8 769.7 774.9 776.0 790.5 823.2 8229.3 8848.6 9040.9 9505.4 9511.0 699.8 766.0 772.8 796.2 805.6 4481.1 4530.4 4617.7 4628.2 4630.8 65491.0 65681.3 66051.7 67260.0 67319.7 56062.2 57303.7 58542.7 59226.0 59667.4 48419.5 50327.7 51552.0 52463.7 52641.9 8821.6 8859.3 8881.2 8954.8 9027.2 33078.7 33473.8 33556.0 33667.0 33715.3 42040.6 43899.8 44198.6 44474.8 47204.3 11966.6 11984.8 12052.3 12124.5 12392.1 13139.0 13156.4 13293.3 13463.5 14118.3 12256.8 12791.1 13040.6 13075.4 13169.9 12218.1 12571.9 12603.4 12605.6 12999.8 12331.4 12514.6 12703.2 12794.6 12795.0 9682.1 9967.8 10271.4 10449.8 10636.5 9826.3 9861.9 10323.3 10349.7 10405.3 03:25:37 INFO - PROCESS | 6714 | -------- Summary: end -------- 03:25:37 INFO - PROCESS | 6714 | 03:25:37 INFO - TEST-INFO | 6714: exit 0 03:25:37 INFO - TEST-OK | dromaeo_css | took 1110645ms 03:25:37 INFO - TEST-START | kraken 03:25:37 INFO - operating with platform_type : linux_ 03:25:37 INFO - Initialising browser for kraken test... 03:25:37 INFO - TEST-INFO | started process 6951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgCEIB/profile http://localhost:41145/getInfo.html) 03:25:41 INFO - PROCESS | 6951 | 03:25:41 INFO - PROCESS | 6951 | (process:7020): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:25:42 INFO - PROCESS | 6951 | __metrics Screen width/height:1600/1200 03:25:42 INFO - PROCESS | 6951 | colorDepth:24 03:25:42 INFO - PROCESS | 6951 | Browser inner width/height: 1024/697 03:25:42 INFO - PROCESS | 6951 | __metrics 03:25:42 ERROR - PROCESS | 6951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:25:43 INFO - TEST-INFO | 6951: exit 0 03:25:43 INFO - Browser initialized. 03:25:43 INFO - Running cycle 1/1 for kraken test... 03:25:43 INFO - TEST-INFO | started process 7071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgCEIB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:45 INFO - PROCESS | 7071 | 03:25:45 INFO - PROCESS | 7071 | (process:7130): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:25:55 INFO - PROCESS | 7071 | RSS: Main: 163676160 03:25:55 INFO - PROCESS | 7071 | 03:25:58 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41145/tests/kraken/driver.html?testName=audio-beat-detection) 03:25:58 INFO - PROCESS | 7071 | RSS: Main: 168022016 03:25:58 INFO - PROCESS | 7071 | 03:26:01 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41145/tests/kraken/driver.html?testName=audio-dft) 03:26:02 INFO - PROCESS | 7071 | RSS: Main: 171601920 03:26:02 INFO - PROCESS | 7071 | 03:26:05 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41145/tests/kraken/driver.html?testName=audio-fft) 03:26:05 INFO - PROCESS | 7071 | RSS: Main: 163061760 03:26:05 INFO - PROCESS | 7071 | 03:26:07 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41145/tests/kraken/driver.html?testName=audio-oscillator) 03:26:08 INFO - PROCESS | 7071 | RSS: Main: 163151872 03:26:08 INFO - PROCESS | 7071 | 03:26:10 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:11 INFO - PROCESS | 7071 | RSS: Main: 163803136 03:26:11 INFO - PROCESS | 7071 | 03:26:14 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41145/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:15 INFO - PROCESS | 7071 | RSS: Main: 163770368 03:26:15 INFO - PROCESS | 7071 | 03:26:18 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41145/tests/kraken/driver.html?testName=imaging-desaturate) 03:26:19 INFO - PROCESS | 7071 | RSS: Main: 164139008 03:26:19 INFO - PROCESS | 7071 | 03:26:22 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41145/tests/kraken/driver.html?testName=json-parse-financial) 03:26:22 INFO - PROCESS | 7071 | RSS: Main: 165167104 03:26:22 INFO - PROCESS | 7071 | 03:26:24 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:26:24 INFO - PROCESS | 7071 | RSS: Main: 164765696 03:26:24 INFO - PROCESS | 7071 | 03:26:26 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:26:27 INFO - PROCESS | 7071 | RSS: Main: 164872192 03:26:27 INFO - PROCESS | 7071 | 03:26:29 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:29 INFO - PROCESS | 7071 | RSS: Main: 165163008 03:26:29 INFO - PROCESS | 7071 | 03:26:32 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:26:33 INFO - PROCESS | 7071 | RSS: Main: 165691392 03:26:33 INFO - PROCESS | 7071 | 03:26:36 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:26:36 INFO - PROCESS | 7071 | RSS: Main: 165679104 03:26:36 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | Cycle 1(1): loaded http://localhost:41145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41145/tests/kraken/driver.html?testName=ai-astar) 03:26:38 INFO - PROCESS | 7071 | RSS: Main: 167153664 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | __start_tp_report 03:26:38 INFO - PROCESS | 7071 | _x_x_mozilla_page_load 03:26:38 INFO - PROCESS | 7071 | _x_x_mozilla_page_load_details 03:26:38 INFO - PROCESS | 7071 | |i|pagename|runs| 03:26:38 INFO - PROCESS | 7071 | |0;ai-astar;112;109;111;114;113;123;112;112;112;110 03:26:38 INFO - PROCESS | 7071 | |1;audio-beat-detection;163;130;166;190;137;160;156;133;190;129 03:26:38 INFO - PROCESS | 7071 | |2;audio-dft;164;163;165;162;164;166;176;164;166;163 03:26:38 INFO - PROCESS | 7071 | |3;audio-fft;76;73;76;162;77;74;75;74;105;77 03:26:38 INFO - PROCESS | 7071 | |4;audio-oscillator;94;94;145;94;102;99;139;94;94;150 03:26:38 INFO - PROCESS | 7071 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;117;118;118 03:26:38 INFO - PROCESS | 7071 | |6;imaging-darkroom;148;147;146;146;147;147;146;146;147;146 03:26:38 INFO - PROCESS | 7071 | |7;imaging-desaturate;96;95;95;95;95;95;95;94;96;95 03:26:38 INFO - PROCESS | 7071 | |8;json-parse-financial;58;61;62;61;59;59;59;78;58;60 03:26:38 INFO - PROCESS | 7071 | |9;json-stringify-tinderbox;60;61;60;61;61;60;60;61;61;61 03:26:38 INFO - PROCESS | 7071 | |10;stanford-crypto-aes;85;79;84;76;77;78;78;77;78;78 03:26:38 INFO - PROCESS | 7071 | |11;stanford-crypto-ccm;128;138;124;124;127;124;134;131;162;126 03:26:38 INFO - PROCESS | 7071 | |12;stanford-crypto-pbkdf2;171;174;171;173;175;186;182;167;172;174 03:26:38 INFO - PROCESS | 7071 | |13;stanford-crypto-sha256-iterative;71;69;70;70;70;69;72;69;68;73 03:26:38 INFO - PROCESS | 7071 | __end_tp_report 03:26:38 INFO - PROCESS | 7071 | __start_cc_report 03:26:38 INFO - PROCESS | 7071 | _x_x_mozilla_cycle_collect,858 03:26:38 INFO - PROCESS | 7071 | __end_cc_report 03:26:38 INFO - PROCESS | 7071 | __startTimestamp1461147998658__endTimestamp 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | ------- Summary: start ------- 03:26:38 INFO - PROCESS | 7071 | Number of tests: 14 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:3.85 (3.4%) stddev-sans-first:4.08 03:26:38 INFO - PROCESS | 7071 | Values: 112.0 109.0 111.0 114.0 113.0 123.0 112.0 112.0 112.0 110.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:161.50 stddev:23.02 (14.3%) stddev-sans-first:24.25 03:26:38 INFO - PROCESS | 7071 | Values: 163.0 130.0 166.0 190.0 137.0 160.0 156.0 133.0 190.0 129.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:3.97 (2.4%) stddev-sans-first:4.19 03:26:38 INFO - PROCESS | 7071 | Values: 164.0 163.0 165.0 162.0 164.0 166.0 176.0 164.0 166.0 163.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#3] audio-fft Cycles:10 Average:86.90 Median:75.50 stddev:28.03 (37.1%) stddev-sans-first:29.45 03:26:38 INFO - PROCESS | 7071 | Values: 76.0 73.0 76.0 162.0 77.0 74.0 75.0 74.0 105.0 77.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.00 stddev:23.87 (25.4%) stddev-sans-first:24.56 03:26:38 INFO - PROCESS | 7071 | Values: 94.0 94.0 145.0 94.0 102.0 99.0 139.0 94.0 94.0 150.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:26:38 INFO - PROCESS | 7071 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 03:26:38 INFO - PROCESS | 7071 | Values: 148.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 03:26:38 INFO - PROCESS | 7071 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.50 stddev:5.95 (9.8%) stddev-sans-first:6.17 03:26:38 INFO - PROCESS | 7071 | Values: 58.0 61.0 62.0 61.0 59.0 59.0 59.0 78.0 58.0 60.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 03:26:38 INFO - PROCESS | 7071 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.00 stddev:3.02 (3.9%) stddev-sans-first:2.29 03:26:38 INFO - PROCESS | 7071 | Values: 85.0 79.0 84.0 76.0 77.0 78.0 78.0 77.0 78.0 78.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:129.50 stddev:11.59 (9.0%) stddev-sans-first:12.21 03:26:38 INFO - PROCESS | 7071 | Values: 128.0 138.0 124.0 124.0 127.0 124.0 134.0 131.0 162.0 126.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:174.00 stddev:5.56 (3.2%) stddev-sans-first:5.75 03:26:38 INFO - PROCESS | 7071 | Values: 171.0 174.0 171.0 173.0 175.0 186.0 182.0 167.0 172.0 174.0 03:26:38 INFO - PROCESS | 7071 | 03:26:38 INFO - PROCESS | 7071 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.52 (2.2%) stddev-sans-first:1.58 03:26:38 INFO - PROCESS | 7071 | Values: 71.0 69.0 70.0 70.0 70.0 69.0 72.0 69.0 68.0 73.0 03:26:38 INFO - PROCESS | 7071 | -------- Summary: end -------- 03:26:38 INFO - PROCESS | 7071 | 03:26:39 INFO - TEST-INFO | 7071: exit 0 03:26:39 INFO - TEST-OK | kraken | took 61839ms 03:26:39 INFO - SUITE-END | took 1172s 03:26:39 INFO - Completed test suite (00:19:32) 03:26:39 INFO - javascript benchmark 03:26:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.4149532336514, 3206.519022146678, 3269.182704323919, 3308.421026320393, 3308.470644696849, 5623.381428042917, 5626.493615574597, 5630.690312032836, 5678.943210567893, 5682.545396368291, 5583.134614134806, 5642.830715078544, 5677.886442271162, 5746.9712651436685, 5767.711614419283, 5052.469490703478, 5084.618653600976, 5099.235114732801, 5140.922886156692, 5146.228065790124, 5094.312267843849, 5203.375594928614, 5232.2674825524455, 5244.265802787613, 5252.8686782830355, 4961.355023846895, 5017.0, 5083.034223497523, 5123.077845987721, 5146.408163061258, 4938.407391113054, 4959.404871415417, 4959.752012399365, 4974.577160941324, 5022.723750193738, 4949.826756063557, 4956.008798240367, 4958.504149585013, 4979.10376132296, 4982.6013918886765, 5437.293151890269, 5465.398806131322, 5465.398806131322, 5467.507924286833, 5516.724163791834, 5992.011318132503, 6012.218411606507, 6022.096685497167, 6026.939730602681, 6037.366076561942, 5970.940290597126, 6023.668698221596, 6044.184035155242, 6048.364921683204, 6051.1830902828, 5621.4659607337235, 5638.154276858422, 5640.32316122068, 5677.347105082927, 5683.403242659502, 6051.636901785907, 6085.300190478063, 6086.6348019119, 6088.238970128734, 6102.908456373158, 5784.363719990798, 5817.0, 5859.384764599741, 5879.676617786063, 5897.49871260939, 6000.129981152709, 6000.879982400327, 6009.939900601025, 6032.095185722089, 6077.453029227391, 5858.355580886099, 5910.320313163955, 5943.762249509971, 6015.218021657157, 6103.816885493442, 5813.6221145625395, 5865.765369385262, 5884.08796636522, 5940.851478713067, 5951.642901425928, 4431.313146462304, 4431.8448854289945, 4537.750423726727, 4557.043020965634, 4591.9081618367445, 3950.0, 3979.4030895365927, 3983.601639836051, 3996.1208534122447, 4004.379321205218, 5607.579431542651, 5626.099824028136, 5657.0, 5669.06460434032, 5676.2337084493065, 5930.28836539618, 5953.136795164677, 5982.611130276518, 5999.520038396918, 6014.969925150346, 5629.408912064257, 5640.294963129609, 5661.801836935688, 5666.518345940559, 5696.430356964271, 5083.313752643419, 5092.745362731923, 5092.821751238763, 5099.898002039939, 5135.794568217304, 6103.337669688931, 6250.0, 6263.4362907337645, 6270.905936410957, 6293.930031894497, 6011.0382338825575, 6027.427394397525, 6036.124761909587, 6036.305824830025, 6091.4822240108315, 5914.083317085859, 6079.361667025076, 6137.14643565387, 6186.938130618636, 6188.690565471798, 5930.110483427347, 5998.070299103646, 6002.039673652194, 6005.549583781321, 6019.909701354571, 6050.21347224858, 6088.086786981989, 6089.360617135314, 6090.878182436415, 6103.664298463449, 5856.531477481876, 5923.170756094064, 5949.1076338549565, 5961.463468287875, 6013.398660133952, 5837.94162058374, 5850.297964244318, 5871.060630299132, 5928.436798504135, 5974.522038237017, 5682.886342273214, 5711.628744131618, 5726.0, 5731.7420716067045, 5736.42635736423, 5646.096624540054, 5842.678652674143, 5868.911966320423, 5891.1752354671235, 5936.436038576328, 5719.084946408721, 5728.570357223141, 5745.827625171084, 5746.13807928814, 5800.1299805029585], "value": 5510.776092897253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9940300596993, 648.7372614091295, 652.305294860973, 664.9667516624168, 681.9522633415656, 34108.31783364334, 35659.0, 35730.46404303938, 35782.82108589457, 35900.10249743755, 39512.22195001232, 39878.202435951265, 40059.39910901331, 40338.39492407609, 40388.0, 8596.785080372994, 8769.473831570094, 8769.912300877006, 8771.210591046805, 8775.473471591693, 8619.138086191393, 8722.476651400937, 8757.080506546816, 8763.868541971875, 8772.780680482974, 8735.737927862174, 8814.515201663906, 8823.867641985375, 8847.646094156225, 8853.42452740573, 8677.43596666221, 8730.301575873946, 8746.169113934166, 8775.25410340122, 8781.38530302879, 8495.957520212422, 8580.0, 8596.699115530926, 8598.269147122503, 8617.69838055665, 31889.362212755615, 37734.245315093816, 38181.23637527234, 38196.42705359394, 38398.23203535942, 3450.3271861986923, 3459.7924124552605, 3493.5283736695474, 3525.189206482498, 3621.311950729353, 27046.1886143416, 28044.298892527648, 28279.575806362922, 28449.715502844912, 29011.274718132005, 3210.4542227821325, 3230.2893363460234, 3264.689854463822, 3315.7347412207205, 3321.8671253149846, 195280.0, 195497.0, 195742.0, 197232.0, 244515.0, 34425.483617745755, 35303.0, 37511.62488375081, 38668.80665596654, 38672.41991370132, 36529.81735091307, 36783.81608091996, 36832.07919802026, 36847.631523684955, 36932.0, 15707.607309817346, 15929.920350398173, 15942.362305507882, 15956.2819673115, 15963.361465541248, 13194.406251718696, 13227.404766785517, 13258.00564957632, 13263.602091937257, 13280.734385312433, 8565.700200492953, 8578.09929957358, 8665.483540380408, 8717.95384553845, 8727.389082764146, 3285.868565257363, 3305.933881322408, 3315.1712071982006, 3331.4336562784383, 3361.0, 1074.4573990134932, 1079.3254216114929, 1098.9230753847314, 1107.7950579142885, 1190.4345435918042, 31784.20539486485, 32163.0, 32261.838690806864, 32666.0, 32920.83539582287, 1097.3799803111217, 1165.6619580321612, 1167.0780083733925, 1173.202222488716, 1234.512367614787, 17145.571360716083, 17248.137593120293, 17330.39343622967, 17334.133293335282, 17375.131243437776, 462045.0, 466557.0, 469523.0, 470272.0, 473555.3222338869, 57898.42101579015, 58689.0, 58707.70646146742, 58729.70635146797, 58767.706161469774, 1372.848986611472, 1406.2476575032308, 1429.3139293139143, 1429.6926160875253, 1435.9066660667024, 30729.539056913716, 30943.690563094082, 31589.65402610758, 31796.5230521547, 32422.35155296928, 51113.744431277606, 51424.74287628687, 51577.742111289204, 51692.74153629208, 51921.740391297804, 404848.0, 409900.0, 412576.0, 414177.0, 415021.0, 28119.156425307272, 28677.0, 28695.713042869305, 28696.85651571729, 28786.7121328784, 47551.5244847561, 48425.27362089642, 48511.5148848507, 48710.0, 49260.50739492702, 40286.39570406505, 40834.0, 41260.38109428301, 41337.1732565353, 41654.79172604118, 38930.85880276612, 39527.80236098801, 39936.0, 40271.597284026786, 40986.1802763949, 36639.0, 40766.59233407747, 41910.37134443047, 41922.58077419309, 42835.7858210707, 31290.687093128778, 32465.0, 32623.836880815445, 32797.672023280415, 33046.33907321792, 25400.237992860242, 25468.23595292144, 25849.612255815802, 25859.612105818804, 26185.60721589216], "value": 17937.87964549606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.2878561018946, 394.5265681182582, 402.08525604250326, 403.6952101163621, 404.2279246638918, 17637.29450821967, 18459.907700461496, 18484.353047643333, 18563.443096707088, 20070.698939515918, 18680.626387472243, 19240.42278731637, 19566.902165489188, 19579.0, 19613.50966225845, 5638.238837756912, 5728.255326807509, 5856.56075794315, 5874.73563689635, 5882.6764527950945, 5801.6519008859395, 5815.505682017034, 5818.0981947798155, 5832.795852145176, 5837.0, 5521.806736764194, 5712.685802280873, 5757.856053598652, 5792.913106303409, 5822.854428639275, 5712.0, 5713.028785106542, 5713.714314284269, 5761.625494342854, 5767.826965191009, 4951.925721114186, 5100.872478188038, 5108.821191258288, 5110.565601923841, 5113.846584602468, 21827.23604673829, 21970.89014554933, 22397.848494846115, 22669.77330226693, 22825.31524054281, 2476.6532685424054, 2512.5854234051358, 2769.3492029373283, 2773.959765088092, 2776.805623606328, 13404.329783510786, 13975.371108300049, 14427.422903083969, 14574.854251457456, 14759.18824464654, 1913.6077104193607, 1968.1536939116174, 1973.4572992427054, 1976.8418526517844, 2008.829249513793, 73126.63436682835, 75307.0, 75522.99999999945, 77186.0, 79511.0, 10282.537285822156, 10300.175985921109, 10350.223733220038, 10758.462076896123, 10849.566017359217, 15365.923170384076, 15428.38286468551, 15458.149801761012, 15555.14446705442, 15562.66560015984, 8128.431009829374, 8297.294729947902, 8381.916180838236, 8424.241818236265, 8579.613917373734, 8051.396145289127, 8086.433949623588, 8158.428909976364, 8198.303144232807, 8231.382646301552, 4642.094791515622, 4686.3204835299375, 4709.175894218498, 4713.622910167179, 4777.426708794897, 1908.351160605373, 1978.6537355962648, 1989.5424052468013, 1992.900354982245, 1993.8305244054127, 938.9061093890693, 1069.8395240713955, 1070.9892901071046, 1080.233034545466, 1122.2985633978763, 18002.189901454465, 18113.547161321072, 19043.238270469024, 19131.61736765257, 19161.0, 1019.5972590826582, 1023.5036007536339, 1042.155853758458, 1048.1352883870836, 1114.6878873915316, 10373.740656483498, 10588.841167382496, 10748.516316765765, 10749.355038697704, 10846.945765271123, 464555.0, 469265.0, 474412.0, 478584.0, 478975.0, 90913.0, 93121.53439232896, 96023.0, 96932.51533742287, 96978.0, 1023.6570748799087, 1043.0351924469835, 1044.7335929337971, 1055.8680164979378, 1062.5749700120014, 16202.513924582281, 16410.0, 16620.0, 16839.747403788708, 16983.7452438216, 38048.0, 39569.60430395774, 39594.2081158381, 39871.40192897051, 40320.596794032856, 53936.460635393145, 55939.72030139823, 56514.71742641425, 56866.0, 57448.71275643595, 8155.0, 8411.747647570583, 8446.535440550582, 8464.44981076228, 8862.379633425599, 9566.56950437218, 12573.622791316275, 13136.40886160106, 13473.528426505025, 13492.257925814174, 11683.240589361665, 11939.104567157325, 11955.880441195477, 11966.0, 12003.339816309837, 11347.716307092389, 11556.828558739673, 11673.591424300448, 11688.532458701557, 11895.940520297689, 11924.582639607572, 11932.821007684717, 12077.51689932393, 12273.386330683608, 12334.50661973511, 8459.746207613782, 8758.430702004349, 8816.647334106821, 8955.194032537103, 9054.456732596065, 9124.133207345292, 12233.571824986082, 12279.263244205376, 12370.381480926098, 12585.181963172365], "value": 9301.69636332648, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.1328236264148, 1533.4326299269271, 1716.613761903571, 1828.5520047588343, 1871.6256748650273, 7596.696132154707, 8216.95891520543, 8275.08974012858, 8499.362547808916, 8521.190486903743, 8270.586470676471, 8288.088310285864, 8323.91676083239, 8401.789955251123, 8407.70573029944, 2295.6326987681973, 2332.183735692511, 2338.543983923136, 2338.6375111857687, 2342.8360014798886, 2233.932982010542, 2269.2511471214543, 2269.7389800173028, 2274.920377786778, 2280.1677387753516, 2258.141906075697, 2275.3174047785683, 2277.3168049585142, 2295.5523672883796, 2297.1959814065112, 2243.102758896438, 2261.174671244992, 2266.8073213776847, 2269.841111122222, 2274.2494976657827, 2224.9876306280603, 2226.4322597737473, 2230.2417178159503, 2234.932952011426, 2237.295251995616, 8458.492490450593, 8485.0242222144, 8558.400911936167, 8573.271271941892, 8601.741947741577, 5065.696058236517, 5219.112750832368, 5242.318498595197, 5244.056069907415, 5251.36983561975, 3325.6840600142946, 3335.849886755102, 3402.6767457091537, 3423.554937858087, 3494.4408894577, 1072.6835583502886, 1076.7631121153333, 1091.110744743032, 1093.868735751715, 1096.8519249901242, 11767.529298828036, 11839.763204735857, 11912.106592005548, 11927.284362938164, 11938.28370297785, 4500.864974050718, 4506.81972721094, 4680.157571637138, 4703.318018887242, 4741.596964258008, 9792.265580081379, 9842.360246583949, 9852.852207216898, 9889.0, 9936.80126397468, 5332.493413125747, 5345.70598617072, 5376.973115134399, 5383.865403364947, 5394.811181608625, 4383.846565370197, 4833.830815921426, 4936.3829521309835, 4941.03649788295, 4956.281339205867, 3954.347532657137, 3974.28462876685, 4040.1717647882115, 4064.3700226464944, 4108.77401742901, 1263.1473755215193, 1273.4530938123753, 1283.4930202569933, 1291.9806202906964, 1304.7260075384277, 982.7297493189287, 997.0, 1016.3901659004538, 1018.0379541333369, 1021.8722659667542, 5952.791652292149, 5959.851003724942, 5972.790952316648, 5983.581149319506, 6125.081237814275, 446.04546270980126, 449.5347315528478, 451.17209919796886, 454.4773510462994, 458.7981288233167, 4172.5410204877435, 4231.259529582372, 4234.6188843003665, 4242.427272318259, 4284.443022407129, 10051.195904327637, 10501.894981050245, 10569.682909512727, 10577.9471102644, 10594.947025264824, 10274.178065754722, 10439.164866810637, 10470.895291047143, 10476.68569942903, 10486.37081775096, 7824.413169012233, 8026.277635012877, 8154.633041513146, 8155.5514446706, 8162.30620397261, 5840.269966254218, 5932.4957378621575, 6023.939760602513, 6045.1234570987845, 6055.818325450244, 9595.088466595662, 9655.468949207861, 9663.323567350219, 9676.419414835133, 9779.26655500826, 9522.857157142787, 9703.417794932328, 9740.318177727491, 9937.900620993698, 9990.550425230736, 6654.301298363602, 7347.942576078706, 7358.264173582599, 7500.549967001997, 7585.127710313164, 8036.9953755780525, 8069.5965201740855, 8073.596320184085, 8115.513069215866, 8136.511809291462, 7058.11773528309, 7282.635868206675, 7320.633968301457, 7422.443316751157, 7455.92544074574, 7157.427405807419, 7216.9278307216255, 7239.782806515813, 7312.085989251344, 7527.397808175223, 6675.465962723068, 6686.364795344434, 6760.22257440381, 6769.796906092825, 6785.796426107225, 4933.679310844784, 5116.488351165002, 5133.307003554472, 5219.217117432264, 5236.9738151309, 5124.154514505065, 5132.409772876167, 5205.245239440184, 5241.868953276198, 5402.243685884058], "value": 4477.279143386172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.2345611844886, 334.5700774504761, 342.5632318793536, 345.13887849814716, 346.69144461429346, 5996.88006239876, 6029.246344206974, 6080.604760690552, 6096.750166215927, 6104.847378815526, 6093.695315234231, 6093.847653808657, 6111.174991376163, 6131.202943617323, 6132.2028136342215, 4587.449506059261, 4595.448546174463, 4598.080383923212, 4612.146752850734, 4617.2381557043045, 4317.784110794463, 4531.592156705896, 4567.931481027787, 4584.3352713856475, 4594.58648721615, 4520.50274469808, 4521.253993091136, 4525.570070843281, 4543.954560454403, 4553.043860789238, 4526.592606665399, 4545.977270113662, 4565.0, 4567.33773602829, 4582.221022426195, 3885.7668539887413, 3947.5577028964153, 3948.881533553998, 3963.6432721054957, 3964.444977703124, 5788.768449262025, 5791.536677065825, 5824.737886795105, 5832.708364581754, 5845.736941837585, 5274.789008439658, 5295.391030031518, 5312.273511108905, 5320.467953204648, 5338.0, 6009.733089506456, 6365.586236894587, 6369.420384744186, 6383.936160638381, 6395.5842870213755, 4268.9573104268875, 4315.956840431587, 4315.978420107879, 4323.891902702426, 4340.457442819647, 6314.5895516791725, 6648.734050637969, 6682.599044057372, 6707.128073350482, 6711.597304161766, 4496.527864574238, 4502.729836209838, 4504.414426124583, 4508.18852606534, 4519.728816270968, 4522.932156017662, 4549.181147393501, 4556.931646025312, 4563.885902852455, 4579.908401832011, 5012.423571289275, 5256.737163141827, 5306.8407947761625, 5318.750093727971, 5326.174442961347, 6210.230084426007, 6372.311337495567, 6415.358464153641, 6419.646919419477, 6428.774992875227, 1537.6540278437262, 1543.9536813895602, 1547.5047984644805, 1556.6108472881779, 1557.6339560203344, 1032.2670903658336, 1041.3023274406166, 1055.2033214922837, 1066.3388699006666, 1066.4401189375485, 6145.231846019247, 6146.877062458726, 6166.321704612489, 6169.2288463942, 6175.814725558241, 6533.379328963741, 6591.835204119935, 6605.801825945229, 6610.0745895574655, 6639.0, 5962.4633782959745, 6101.877962440726, 6186.907196392058, 6203.379662033851, 6225.190725205694, 3498.9475157872653, 3501.5272938153535, 3504.4392897136336, 3505.631908649606, 3510.0, 6527.445167160749, 6710.396064354231, 6779.322067793181, 6794.660266986631, 6829.0, 6736.5284430090405, 6745.831354216086, 6756.83107922296, 6767.187937447439, 6789.966050169816, 6581.0, 6761.121054262914, 6773.559718618274, 6798.436359637311, 6805.251422343637, 6461.483081353575, 6530.934690653223, 6538.692261547614, 6575.375339342755, 6585.374389432996, 6384.521160913043, 6468.935310646833, 6481.287058423475, 6496.285408604956, 6503.6097834130105, 6750.324967503407, 6784.457243420416, 6786.558873673195, 6787.864242715217, 6799.5920244785475, 4455.75493347869, 4465.910681786411, 4475.485319188335, 4500.2124628189285, 4504.301833215857, 6363.61818290904, 6471.902921456088, 6478.190226221723, 6534.353586797355, 6596.109525214035, 6396.29640739509, 6411.967940160456, 6448.1295025171, 6465.838354041187, 6489.610623362424, 6288.717007734572, 6425.164728585254, 6431.935680643133, 6432.0, 6436.935630643634, 6264.49884009269, 6282.2147231596055, 6298.496120310456, 6367.204099487564, 6371.331010243857, 6367.235931688227, 6388.1376014237485, 6409.9679501602195, 6438.935610644021, 6505.804825855232, 6162.722677479434, 6186.4142461793635, 6278.529110316653, 6310.337414571588, 6323.494120470259], "value": 4790.064623426172, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.5290549520834, 725.0031207090251, 738.4240292571794, 750.4034292737275, 758.0827199089106, 14391.352389142488, 14595.416183352652, 14599.70800583989, 14661.70676586469, 14814.925925370359, 13059.673508162301, 13077.67305817355, 13096.0, 13100.803487947689, 13105.148165369268, 689.1626673591585, 823.518241828531, 824.5959479854873, 840.9537475438848, 842.0064324097593, 825.014108140772, 825.7357645553425, 827.3215962910385, 827.5779352530193, 828.5484410996022, 874.6894852327396, 875.7504111328273, 880.7093659092516, 880.8194320164351, 880.9515476648781, 873.6898401067625, 874.3005595523556, 874.5802015032788, 876.0669886570845, 878.3324673248313, 634.0077778277027, 634.8539835837784, 635.5265327331122, 638.6998110887876, 640.0910706796313, 14305.785413218706, 14306.427742890271, 14377.856221437756, 14418.13491190532, 14451.349689264009, 13512.662183445493, 13948.0, 14146.929265353607, 14216.218108004055, 14267.643308917257, 11023.779524409547, 11173.078268517698, 11206.607768728056, 11285.548578056867, 11532.654020379403, 3822.847086116552, 3825.6556909878245, 3897.279003384355, 3916.373380259145, 3943.605639436062, 53804.461955380335, 54182.0, 55147.0, 55336.44663553393, 55388.44611553873, 10458.058774710313, 10470.947645261725, 10514.421706806199, 10666.306690065121, 10695.197860160519, 20408.591828163353, 20448.284310049075, 20488.0, 20496.0, 20549.48626284325, 8264.256216940505, 8334.749957501284, 8451.830963380698, 8583.699570515128, 8690.000649925212, 4624.583787459078, 4640.862988567823, 4684.882877928079, 4687.601553867891, 4837.080954618611, 3418.572678415198, 3527.8059706715862, 3537.823108844599, 3565.073080998959, 3579.552555930509, 600.8527910661916, 612.6783438694721, 650.612885333226, 679.4055201698513, 680.8195828105556, 769.7113582406597, 774.8566515194707, 775.9650815713306, 790.4782843323379, 823.2056065896319, 8229.341652667772, 8848.646054157762, 9040.8643870342, 9505.382150160218, 9511.0, 699.8040548646285, 765.9885101723479, 772.7681695491331, 796.1759578835877, 805.5609692717483, 4481.126180394792, 4530.365748795171, 4617.699849509771, 4628.190066738307, 4630.83792067276, 65491.0, 65681.34318656848, 66051.66974165099, 67259.99110013354, 67319.66340168267, 56062.15906761402, 57303.71348143316, 58542.707286464145, 59226.0, 59667.403325967054, 48419.5158048415, 50327.74836125796, 51552.0, 52463.73768131135, 52641.94716105657, 8821.60302786389, 8859.335549833659, 8881.200691937498, 8954.776130596527, 9027.187553120251, 33078.66921330852, 33473.83263083766, 33556.0, 33667.0, 33715.325693486484, 42040.579594203664, 43899.78050109729, 44198.55801441945, 44474.77762611166, 47204.291935620306, 11966.58116965902, 11984.820227696417, 12052.276863388224, 12124.454399551865, 12392.132550721362, 13139.0, 13156.40796164194, 13293.335333233494, 13463.528776492776, 14118.2940852959, 12256.816147757969, 12791.104622676696, 13040.608781736562, 13075.411606477921, 13169.934150329187, 12218.144729868824, 12571.93714031424, 12603.432845521791, 12605.621831345074, 12999.805002924775, 12331.445084971378, 12514.561990330294, 12703.174293670882, 12794.552190673281, 12795.0, 9682.128608425275, 9967.800643986935, 10271.383716977005, 10449.84325235107, 10636.468176590985, 9826.312158148861, 9861.852072219066, 10323.277370584288, 10349.74125646865, 10405.323653962469], "value": 6807.3906525302455, "unit": "score"}], "name": "dromaeo_css", "value": 7155.717880266493, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 114.0, 113.0, 123.0, 112.0, 112.0, 112.0, 110.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 166.0, 190.0, 137.0, 160.0, 156.0, 133.0, 190.0, 129.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 162.0, 164.0, 166.0, 176.0, 164.0, 166.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 76.0, 162.0, 77.0, 74.0, 75.0, 74.0, 105.0, 77.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 145.0, 94.0, 102.0, 99.0, 139.0, 94.0, 94.0, 150.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 62.0, 61.0, 59.0, 59.0, 59.0, 78.0, 58.0, 60.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 84.0, 76.0, 77.0, 78.0, 78.0, 77.0, 78.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 138.0, 124.0, 124.0, 127.0, 124.0, 134.0, 131.0, 162.0, 126.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 171.0, 173.0, 175.0, 186.0, 182.0, 167.0, 172.0, 174.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 70.0, 70.0, 69.0, 72.0, 69.0, 68.0, 73.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1567.5999999999997, "alertThreshold": 2.0}]} 03:26:39 INFO - Return code: 0 03:26:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:26:39 ERROR - # TBPL SUCCESS # 03:26:39 INFO - Running post-action listener: _resource_record_post_action 03:26:39 INFO - Running post-run listener: _resource_record_post_run 03:26:41 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 526295040; Read time: 276; Write time: 682532 03:26:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 179310592; Read time: 0; Write time: 276956 03:26:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290680832; Read time: 276; Write time: 289320 03:26:41 INFO - Running post-run listener: _upload_blobber_files 03:26:41 INFO - Blob upload gear active. 03:26:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:26:41 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 03:26:41 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'] 03:26:41 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 03:26:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:42 INFO - (blobuploader) - INFO - Done attempting. 03:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:42 INFO - (blobuploader) - INFO - Done attempting. 03:26:42 INFO - (blobuploader) - INFO - Iteration through files over. 03:26:42 INFO - Return code: 0 03:26:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:26:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:26:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/198455c90b2e5f1710e8a48ab0943b470c78e62aa4f059c78dd2a34869e5973cb21711b179cf4ea398598ee45d937ce5958395396cc6ed12401d84fb7373750c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad12f5bc62dc7df60699d22b1a239ccbc5fde233a16fc19720fe405386472829602a4db4a996e6ec37e4633feab301a2d1dd07bf5fabcb786fe4d854dcffec80"} 03:26:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:26:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:26:42 INFO - Contents: 03:26:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/198455c90b2e5f1710e8a48ab0943b470c78e62aa4f059c78dd2a34869e5973cb21711b179cf4ea398598ee45d937ce5958395396cc6ed12401d84fb7373750c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad12f5bc62dc7df60699d22b1a239ccbc5fde233a16fc19720fe405386472829602a4db4a996e6ec37e4633feab301a2d1dd07bf5fabcb786fe4d854dcffec80"} 03:26:42 INFO - Running post-run listener: copy_logs_to_upload_dir 03:26:42 INFO - Copying logs to upload dir... 03:26:42 INFO - mkdir: /builds/slave/test/build/upload/logs 03:26:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.809916 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-20 03:26:42.485621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 03:26:42.489546) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081 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/198455c90b2e5f1710e8a48ab0943b470c78e62aa4f059c78dd2a34869e5973cb21711b179cf4ea398598ee45d937ce5958395396cc6ed12401d84fb7373750c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad12f5bc62dc7df60699d22b1a239ccbc5fde233a16fc19720fe405386472829602a4db4a996e6ec37e4633feab301a2d1dd07bf5fabcb786fe4d854dcffec80"} build_url:https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/eZfSDps3QLaSJYGO8Bcbug/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/198455c90b2e5f1710e8a48ab0943b470c78e62aa4f059c78dd2a34869e5973cb21711b179cf4ea398598ee45d937ce5958395396cc6ed12401d84fb7373750c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad12f5bc62dc7df60699d22b1a239ccbc5fde233a16fc19720fe405386472829602a4db4a996e6ec37e4633feab301a2d1dd07bf5fabcb786fe4d854dcffec80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 03:26:42.514987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:26:42.515333) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461146700.14348-1138886081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:26:42.599045) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 03:26:42.599375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 03:26:42.599678) ========= ========= Total master_lag: 0.18 =========