builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1460808016.39 results: success (0) buildid: 20160416023005 builduid: e3a68a70ea434390820da54117f01941 revision: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.391275) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.391786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.392277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.435102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.435379) ========= 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=d2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 05:00:16-- 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% 81.6M=0s 2016-04-16 05:00:16 (81.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148055 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.632160) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.632450) ========= 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=d2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.124303 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.768095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:16.768414) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19d56ca9e3f5078dba44230ac3ec0718cc029b70 --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 19d56ca9e3f5078dba44230ac3ec0718cc029b70 --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=d2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 05:00:16,885 truncating revision to first 12 chars 2016-04-16 05:00:16,885 Setting DEBUG logging. 2016-04-16 05:00:16,885 attempt 1/10 2016-04-16 05:00:16,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/19d56ca9e3f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 05:00:17,223 unpacking tar archive at: fx-team-19d56ca9e3f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:17.405492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:17.405828) ========= script_repo_revision: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:17.406280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:17.406554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 05:00:17.415653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-16 05:00:17.415922) ========= /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=d2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:17 INFO - MultiFileLogger online at 20160416 05:00:17 in /builds/slave/test 05:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:00:17 INFO - {'append_to_log': False, 05:00:17 INFO - 'base_work_dir': '/builds/slave/test', 05:00:17 INFO - 'blob_upload_branch': 'Fx-Team', 05:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:00:17 INFO - 'branch': 'Fx-Team', 05:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:17 INFO - 'config_files': ('talos/linux_config.py',), 05:00:17 INFO - 'default_actions': ('clobber', 05:00:17 INFO - 'read-buildbot-config', 05:00:17 INFO - 'download-and-extract', 05:00:17 INFO - 'populate-webroot', 05:00:17 INFO - 'create-virtualenv', 05:00:17 INFO - 'install', 05:00:17 INFO - 'run-tests'), 05:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:17 INFO - 'download_minidump_stackwalk': True, 05:00:17 INFO - 'download_symbols': 'ondemand', 05:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:17 INFO - 'installer_path': 'installer.exe', 05:00:17 INFO - 'log_level': 'info', 05:00:17 INFO - 'log_name': 'talos', 05:00:17 INFO - 'log_to_console': True, 05:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:17 INFO - 'opt_config_files': (), 05:00:17 INFO - 'pip_index': False, 05:00:17 INFO - 'sps_profile': False, 05:00:17 INFO - 'sps_profile_interval': 0, 05:00:17 INFO - 'suite': 'dromaeojs-e10s', 05:00:17 INFO - 'system_bits': '32', 05:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:17 INFO - 'title': 'talos-linux64-ix-043', 05:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:17 INFO - 'use_talos_json': True, 05:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:17 INFO - 'work_dir': 'build'} 05:00:17 INFO - ##### 05:00:17 INFO - ##### Running clobber step. 05:00:17 INFO - ##### 05:00:17 INFO - Running pre-action listener: _resource_record_pre_action 05:00:17 INFO - Running main action method: clobber 05:00:17 INFO - rmtree: /builds/slave/test/build 05:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:00:18 INFO - Running post-action listener: _resource_record_post_action 05:00:18 INFO - ##### 05:00:18 INFO - ##### Running read-buildbot-config step. 05:00:18 INFO - ##### 05:00:18 INFO - Running pre-action listener: _resource_record_pre_action 05:00:18 INFO - Running main action method: read_buildbot_config 05:00:18 INFO - Using buildbot properties: 05:00:18 INFO - { 05:00:18 INFO - "project": "", 05:00:18 INFO - "product": "firefox", 05:00:18 INFO - "script_repo_revision": "production", 05:00:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:00:18 INFO - "repository": "", 05:00:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:00:18 INFO - "buildid": "20160416023005", 05:00:18 INFO - "pgo_build": "True", 05:00:18 INFO - "basedir": "/builds/slave/test", 05:00:18 INFO - "buildnumber": 392, 05:00:18 INFO - "slavename": "talos-linux64-ix-043", 05:00:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:00:18 INFO - "platform": "ubuntu64_hw", 05:00:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:00:18 INFO - "branch": "fx-team", 05:00:18 INFO - "repo_path": "integration/fx-team", 05:00:18 INFO - "revision": "19d56ca9e3f5078dba44230ac3ec0718cc029b70", 05:00:18 INFO - "stage_platform": "linux64-pgo", 05:00:18 INFO - "builduid": "e3a68a70ea434390820da54117f01941", 05:00:18 INFO - "slavebuilddir": "test" 05:00:18 INFO - } 05:00:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:00:18 INFO - Running post-action listener: _resource_record_post_action 05:00:18 INFO - ##### 05:00:18 INFO - ##### Running download-and-extract step. 05:00:18 INFO - ##### 05:00:18 INFO - Running pre-action listener: _resource_record_pre_action 05:00:18 INFO - Running main action method: download_and_extract 05:00:18 INFO - mkdir: /builds/slave/test/build/tests 05:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:18 INFO - https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:00:25 INFO - Downloaded 1361 bytes. 05:00:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:00:25 INFO - Using the following test package requirements: 05:00:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:00:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:00:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'jsshell-linux-x86_64.zip'], 05:00:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:00:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:00:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:00:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:00:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:00:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:25 INFO - https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:00:38 INFO - Downloaded 23775019 bytes. 05:00:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:00:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:00:40 INFO - Return code: 0 05:00:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:40 INFO - https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:00:41 INFO - Downloaded 23775019 bytes. 05:00:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:00:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:00:43 INFO - Return code: 0 05:00: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')]} 05:00:43 INFO - https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:00:44 INFO - Downloaded 10841076 bytes. 05:00:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:00:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:00:44 INFO - Return code: 0 05:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:44 INFO - https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:00:48 INFO - Downloaded 58229558 bytes. 05:00:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:00:48 INFO - mkdir: /builds/slave/test/properties 05:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:00:48 INFO - Writing to file /builds/slave/test/properties/build_url 05:00:48 INFO - Contents: 05:00:48 INFO - build_url:https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:00:49 INFO - Running post-action listener: _resource_record_post_action 05:00:49 INFO - Running post-action listener: set_extra_try_arguments 05:00:49 INFO - ##### 05:00:49 INFO - ##### Running populate-webroot step. 05:00:49 INFO - ##### 05:00:49 INFO - Running pre-action listener: _resource_record_pre_action 05:00:49 INFO - Running main action method: populate_webroot 05:00:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:49 INFO - '--tppagecycles', 05:00:49 INFO - '7'], 05:00:49 INFO - 'tests': ['tsvgm']}}, 05:00:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:00:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:00:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['damp', 'tps']}, 05:00:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'tests': ['damp', 'tps']}, 05:00:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['dromaeo_dom']}, 05:00:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['tsvgx', 05:00:49 INFO - 'tsvgr_opacity', 05:00:49 INFO - 'tart', 05:00:49 INFO - 'tscrollx', 05:00:49 INFO - 'cart']}, 05:00:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:00:49 INFO - 'tsvgr_opacity', 05:00:49 INFO - 'tart', 05:00:49 INFO - 'tscrollx', 05:00:49 INFO - 'cart']}, 05:00:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--disable-e10s'], 05:00:49 INFO - 'tests': ['tp5o']}, 05:00:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'tests': ['tp5o']}, 05:00:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--disable-e10s', 05:00:49 INFO - '--xperf_path', 05:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:49 INFO - 'tests': ['tp5n']}, 05:00:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--xperf_path', 05:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:49 INFO - 'tests': ['tp5n']}}, 05:00:49 INFO - 'talos.zip': {'path': '', 05:00:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:49 INFO - Running post-action listener: _resource_record_post_action 05:00:49 INFO - ##### 05:00:49 INFO - ##### Running create-virtualenv step. 05:00:49 INFO - ##### 05:00:49 INFO - Running pre-action listener: _resource_record_pre_action 05:00:49 INFO - Running main action method: create_virtualenv 05:00:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:00:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:00:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:00:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:50 INFO - Using real prefix '/usr' 05:00:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:00:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:52 INFO - Installing pip.................done. 05:00:52 INFO - Return code: 0 05:00:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:00:52 INFO - Using env: {'DISPLAY': ':0', 05:00:52 INFO - 'HOME': '/home/cltbld', 05:00:52 INFO - 'LANG': 'en_US.UTF-8', 05:00:52 INFO - 'LANGUAGE': 'en_US:en', 05:00:52 INFO - 'LOGNAME': 'cltbld', 05:00:52 INFO - 'MAIL': '/var/mail/cltbld', 05:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:52 INFO - 'MOZ_NO_REMOTE': '1', 05:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:52 INFO - 'NO_EM_RESTART': '1', 05:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:52 INFO - 'PWD': '/builds/slave/test', 05:00:52 INFO - 'SHELL': '/bin/bash', 05:00:52 INFO - 'SHLVL': '1', 05:00:52 INFO - 'TERM': 'linux', 05:00:52 INFO - 'TMOUT': '86400', 05:00:52 INFO - 'USER': 'cltbld', 05:00:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:52 INFO - '_': '/tools/buildbot/bin/python'} 05:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:00:52 INFO - Cleaning up... 05:00:52 INFO - Return code: 0 05:00:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:00:52 INFO - Using env: {'DISPLAY': ':0', 05:00:52 INFO - 'HOME': '/home/cltbld', 05:00:52 INFO - 'LANG': 'en_US.UTF-8', 05:00:52 INFO - 'LANGUAGE': 'en_US:en', 05:00:52 INFO - 'LOGNAME': 'cltbld', 05:00:52 INFO - 'MAIL': '/var/mail/cltbld', 05:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:52 INFO - 'MOZ_NO_REMOTE': '1', 05:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:52 INFO - 'NO_EM_RESTART': '1', 05:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:52 INFO - 'PWD': '/builds/slave/test', 05:00:52 INFO - 'SHELL': '/bin/bash', 05:00:52 INFO - 'SHLVL': '1', 05:00:52 INFO - 'TERM': 'linux', 05:00:52 INFO - 'TMOUT': '86400', 05:00:52 INFO - 'USER': 'cltbld', 05:00:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:52 INFO - '_': '/tools/buildbot/bin/python'} 05:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 INFO - Downloading/unpacking psutil>=0.7.1 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:55 INFO - Installing collected packages: psutil 05:00:55 INFO - Running setup.py install for psutil 05:00:55 INFO - building 'psutil._psutil_linux' extension 05:00:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:00:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:00:56 INFO - building 'psutil._psutil_posix' extension 05:00:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:00:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:56 INFO - Successfully installed psutil 05:00:56 INFO - Cleaning up... 05:00:56 INFO - Return code: 0 05:00:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:00:56 INFO - Using env: {'DISPLAY': ':0', 05:00:56 INFO - 'HOME': '/home/cltbld', 05:00:56 INFO - 'LANG': 'en_US.UTF-8', 05:00:56 INFO - 'LANGUAGE': 'en_US:en', 05:00:56 INFO - 'LOGNAME': 'cltbld', 05:00:56 INFO - 'MAIL': '/var/mail/cltbld', 05:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:56 INFO - 'MOZ_NO_REMOTE': '1', 05:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:56 INFO - 'NO_EM_RESTART': '1', 05:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:56 INFO - 'PWD': '/builds/slave/test', 05:00:56 INFO - 'SHELL': '/bin/bash', 05:00:56 INFO - 'SHLVL': '1', 05:00:56 INFO - 'TERM': 'linux', 05:00:56 INFO - 'TMOUT': '86400', 05:00:56 INFO - 'USER': 'cltbld', 05:00:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:56 INFO - '_': '/tools/buildbot/bin/python'} 05:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:00:58 INFO - Installing collected packages: mozsystemmonitor 05:00:58 INFO - Running setup.py install for mozsystemmonitor 05:00:58 INFO - Successfully installed mozsystemmonitor 05:00:58 INFO - Cleaning up... 05:00:58 INFO - Return code: 0 05:00:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:58 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:00:58 INFO - Using env: {'DISPLAY': ':0', 05:00:58 INFO - 'HOME': '/home/cltbld', 05:00:58 INFO - 'LANG': 'en_US.UTF-8', 05:00:58 INFO - 'LANGUAGE': 'en_US:en', 05:00:58 INFO - 'LOGNAME': 'cltbld', 05:00:58 INFO - 'MAIL': '/var/mail/cltbld', 05:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:58 INFO - 'MOZ_NO_REMOTE': '1', 05:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:58 INFO - 'NO_EM_RESTART': '1', 05:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:58 INFO - 'PWD': '/builds/slave/test', 05:00:58 INFO - 'SHELL': '/bin/bash', 05:00:58 INFO - 'SHLVL': '1', 05:00:58 INFO - 'TERM': 'linux', 05:00:58 INFO - 'TMOUT': '86400', 05:00:58 INFO - 'USER': 'cltbld', 05:00:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:58 INFO - '_': '/tools/buildbot/bin/python'} 05:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:01 INFO - Downloading docopt-0.6.1.tar.gz 05:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:01 INFO - Running setup.py install for blobuploader 05:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:01:01 INFO - Running setup.py install for requests 05:01:02 INFO - Running setup.py install for docopt 05:01:02 INFO - Successfully installed blobuploader requests docopt 05:01:02 INFO - Cleaning up... 05:01:02 INFO - Return code: 0 05:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:02 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:02 INFO - Using env: {'DISPLAY': ':0', 05:01:02 INFO - 'HOME': '/home/cltbld', 05:01:02 INFO - 'LANG': 'en_US.UTF-8', 05:01:02 INFO - 'LANGUAGE': 'en_US:en', 05:01:02 INFO - 'LOGNAME': 'cltbld', 05:01:02 INFO - 'MAIL': '/var/mail/cltbld', 05:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:02 INFO - 'MOZ_NO_REMOTE': '1', 05:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:02 INFO - 'NO_EM_RESTART': '1', 05:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:02 INFO - 'PWD': '/builds/slave/test', 05:01:02 INFO - 'SHELL': '/bin/bash', 05:01:02 INFO - 'SHLVL': '1', 05:01:02 INFO - 'TERM': 'linux', 05:01:02 INFO - 'TMOUT': '86400', 05:01:02 INFO - 'USER': 'cltbld', 05:01:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:02 INFO - '_': '/tools/buildbot/bin/python'} 05:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:02 INFO - Running setup.py (path:/tmp/pip-Lli3xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:02 INFO - Running setup.py (path:/tmp/pip-7hOea4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:02 INFO - Running setup.py (path:/tmp/pip-TowlA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:02 INFO - Running setup.py (path:/tmp/pip-LRbsSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:02 INFO - Running setup.py (path:/tmp/pip-DB1Nlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:02 INFO - Running setup.py (path:/tmp/pip-eXjmss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:02 INFO - Running setup.py (path:/tmp/pip-_QAiJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:03 INFO - Running setup.py (path:/tmp/pip-Xi3HEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:03 INFO - Running setup.py (path:/tmp/pip-QYyvMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:03 INFO - Running setup.py (path:/tmp/pip-qefBOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:03 INFO - Running setup.py (path:/tmp/pip-ZlqkyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:03 INFO - Running setup.py (path:/tmp/pip-YJMnE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:03 INFO - Running setup.py (path:/tmp/pip-qCQKKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:03 INFO - Running setup.py (path:/tmp/pip-J7BFPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:03 INFO - Running setup.py (path:/tmp/pip-TGwFuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:03 INFO - Running setup.py (path:/tmp/pip-s6g_Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:03 INFO - Running setup.py (path:/tmp/pip-kyb1th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:03 INFO - Running setup.py install for manifestparser 05:01:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:01:03 INFO - Running setup.py install for mozcrash 05:01:03 INFO - Running setup.py install for mozdebug 05:01:04 INFO - Running setup.py install for mozdevice 05:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for mozfile 05:01:04 INFO - Running setup.py install for mozhttpd 05:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for mozinfo 05:01:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for mozInstall 05:01:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for mozleak 05:01:04 INFO - Running setup.py install for mozlog 05:01:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for moznetwork 05:01:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for mozprocess 05:01:04 INFO - Running setup.py install for mozprofile 05:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for mozrunner 05:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for mozscreenshot 05:01:05 INFO - Running setup.py install for moztest 05:01:05 INFO - Running setup.py install for mozversion 05:01:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:05 INFO - Cleaning up... 05:01:05 INFO - Return code: 0 05:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:05 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:05 INFO - Using env: {'DISPLAY': ':0', 05:01:05 INFO - 'HOME': '/home/cltbld', 05:01:05 INFO - 'LANG': 'en_US.UTF-8', 05:01:05 INFO - 'LANGUAGE': 'en_US:en', 05:01:05 INFO - 'LOGNAME': 'cltbld', 05:01:05 INFO - 'MAIL': '/var/mail/cltbld', 05:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:05 INFO - 'MOZ_NO_REMOTE': '1', 05:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:05 INFO - 'NO_EM_RESTART': '1', 05:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:05 INFO - 'PWD': '/builds/slave/test', 05:01:05 INFO - 'SHELL': '/bin/bash', 05:01:05 INFO - 'SHLVL': '1', 05:01:05 INFO - 'TERM': 'linux', 05:01:05 INFO - 'TMOUT': '86400', 05:01:05 INFO - 'USER': 'cltbld', 05:01:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:05 INFO - '_': '/tools/buildbot/bin/python'} 05:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:05 INFO - Running setup.py (path:/tmp/pip-YLdFxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:05 INFO - Running setup.py (path:/tmp/pip-M4bQF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:05 INFO - Running setup.py (path:/tmp/pip-QkssPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:05 INFO - Running setup.py (path:/tmp/pip-6zKD1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:06 INFO - Running setup.py (path:/tmp/pip-2c7A2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:06 INFO - Running setup.py (path:/tmp/pip-Qd43Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:06 INFO - Running setup.py (path:/tmp/pip-ojiVM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:06 INFO - Running setup.py (path:/tmp/pip-ER1jMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:06 INFO - Running setup.py (path:/tmp/pip-7BeSEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:06 INFO - Running setup.py (path:/tmp/pip-xvuG6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:06 INFO - Running setup.py (path:/tmp/pip-qH9_vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:06 INFO - Running setup.py (path:/tmp/pip-kNDvG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:06 INFO - Running setup.py (path:/tmp/pip-dbdtI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:06 INFO - Running setup.py (path:/tmp/pip-KgBvAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:06 INFO - Running setup.py (path:/tmp/pip-nOhNha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:06 INFO - Running setup.py (path:/tmp/pip-xAFt67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:06 INFO - Running setup.py (path:/tmp/pip-qPSl5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:08 INFO - Downloading blessings-1.6.tar.gz 05:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:08 INFO - Installing collected packages: blessings 05:01:08 INFO - Running setup.py install for blessings 05:01:09 INFO - Successfully installed blessings 05:01:09 INFO - Cleaning up... 05:01:09 INFO - Return code: 0 05:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:09 INFO - Reading from file tmpfile_stdout 05:01:09 INFO - Current package versions: 05:01:09 INFO - argparse == 1.2.1 05:01:09 INFO - blessings == 1.6 05:01:09 INFO - blobuploader == 1.2.4 05:01:09 INFO - docopt == 0.6.1 05:01:09 INFO - manifestparser == 1.1 05:01:09 INFO - mozInstall == 1.12 05:01:09 INFO - mozcrash == 0.17 05:01:09 INFO - mozdebug == 0.1 05:01:09 INFO - mozdevice == 0.48 05:01:09 INFO - mozfile == 1.2 05:01:09 INFO - mozhttpd == 0.7 05:01:09 INFO - mozinfo == 0.9 05:01:09 INFO - mozleak == 0.1 05:01:09 INFO - mozlog == 3.1 05:01:09 INFO - moznetwork == 0.27 05:01:09 INFO - mozprocess == 0.22 05:01:09 INFO - mozprofile == 0.28 05:01:09 INFO - mozrunner == 6.11 05:01:09 INFO - mozscreenshot == 0.1 05:01:09 INFO - mozsystemmonitor == 0.0 05:01:09 INFO - moztest == 0.7 05:01:09 INFO - mozversion == 1.4 05:01:09 INFO - psutil == 3.1.1 05:01:09 INFO - requests == 1.2.3 05:01:09 INFO - wsgiref == 0.1.2 05:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:09 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:09 INFO - Using env: {'DISPLAY': ':0', 05:01:09 INFO - 'HOME': '/home/cltbld', 05:01:09 INFO - 'LANG': 'en_US.UTF-8', 05:01:09 INFO - 'LANGUAGE': 'en_US:en', 05:01:09 INFO - 'LOGNAME': 'cltbld', 05:01:09 INFO - 'MAIL': '/var/mail/cltbld', 05:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:09 INFO - 'MOZ_NO_REMOTE': '1', 05:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:09 INFO - 'NO_EM_RESTART': '1', 05:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:09 INFO - 'PWD': '/builds/slave/test', 05:01:09 INFO - 'SHELL': '/bin/bash', 05:01:09 INFO - 'SHLVL': '1', 05:01:09 INFO - 'TERM': 'linux', 05:01:09 INFO - 'TMOUT': '86400', 05:01:09 INFO - 'USER': 'cltbld', 05:01:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:09 INFO - '_': '/tools/buildbot/bin/python'} 05:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:01:09 INFO - Cleaning up... 05:01:09 INFO - Return code: 0 05:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:09 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:01:09 INFO - Using env: {'DISPLAY': ':0', 05:01:09 INFO - 'HOME': '/home/cltbld', 05:01:09 INFO - 'LANG': 'en_US.UTF-8', 05:01:09 INFO - 'LANGUAGE': 'en_US:en', 05:01:09 INFO - 'LOGNAME': 'cltbld', 05:01:09 INFO - 'MAIL': '/var/mail/cltbld', 05:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:09 INFO - 'MOZ_NO_REMOTE': '1', 05:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:09 INFO - 'NO_EM_RESTART': '1', 05:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:09 INFO - 'PWD': '/builds/slave/test', 05:01:09 INFO - 'SHELL': '/bin/bash', 05:01:09 INFO - 'SHLVL': '1', 05:01:09 INFO - 'TERM': 'linux', 05:01:09 INFO - 'TMOUT': '86400', 05:01:09 INFO - 'USER': 'cltbld', 05:01:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:09 INFO - '_': '/tools/buildbot/bin/python'} 05:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:09 INFO - Downloading/unpacking jsonschema 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:11 INFO - Downloading/unpacking functools32 (from jsonschema) 05:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:11 INFO - warning: no files found matching '*.txt' 05:01:11 INFO - no previously-included directories found matching 'build' 05:01:11 INFO - no previously-included directories found matching 'dist' 05:01:11 INFO - no previously-included directories found matching '.git*' 05:01:11 INFO - Installing collected packages: jsonschema, functools32 05:01:11 INFO - Running setup.py install for functools32 05:01:12 INFO - warning: no files found matching '*.txt' 05:01:12 INFO - no previously-included directories found matching 'build' 05:01:12 INFO - no previously-included directories found matching 'dist' 05:01:12 INFO - no previously-included directories found matching '.git*' 05:01:12 INFO - Successfully installed jsonschema functools32 05:01:12 INFO - Cleaning up... 05:01:12 INFO - Return code: 0 05:01:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:12 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 0x7f7be1952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, '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': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:01:12 INFO - Using env: {'DISPLAY': ':0', 05:01:12 INFO - 'HOME': '/home/cltbld', 05:01:12 INFO - 'LANG': 'en_US.UTF-8', 05:01:12 INFO - 'LANGUAGE': 'en_US:en', 05:01:12 INFO - 'LOGNAME': 'cltbld', 05:01:12 INFO - 'MAIL': '/var/mail/cltbld', 05:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:12 INFO - 'MOZ_NO_REMOTE': '1', 05:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:12 INFO - 'NO_EM_RESTART': '1', 05:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:12 INFO - 'PWD': '/builds/slave/test', 05:01:12 INFO - 'SHELL': '/bin/bash', 05:01:12 INFO - 'SHLVL': '1', 05:01:12 INFO - 'TERM': 'linux', 05:01:12 INFO - 'TMOUT': '86400', 05:01:12 INFO - 'USER': 'cltbld', 05:01:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:12 INFO - '_': '/tools/buildbot/bin/python'} 05:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:12 INFO - Downloading/unpacking flake8 05:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:01:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:01:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:14 INFO - no previously-included directories found matching 'docs/_build' 05:01:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:01:14 INFO - Running setup.py install for pep8 05:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:15 INFO - no previously-included directories found matching 'docs/_build' 05:01:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:01:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:01:15 INFO - Cleaning up... 05:01:15 INFO - Return code: 0 05:01:15 INFO - Running post-action listener: _resource_record_post_action 05:01:15 INFO - Running post-action listener: _start_resource_monitoring 05:01:15 INFO - Starting resource monitoring. 05:01:15 INFO - ##### 05:01:15 INFO - ##### Running install step. 05:01:15 INFO - ##### 05:01:15 INFO - Running pre-action listener: _resource_record_pre_action 05:01:15 INFO - Running main action method: install 05:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:15 INFO - Reading from file tmpfile_stdout 05:01:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:01:15 INFO - Reading from file tmpfile_stdout 05:01:15 INFO - Output received: 05:01:15 INFO - Usage: mozinstall [options] installer 05:01:15 INFO - Options: 05:01:15 INFO - -h, --help show this help message and exit 05:01:15 INFO - -d DEST, --destination=DEST 05:01:15 INFO - Directory to install application into. [default: 05:01:15 INFO - "/builds/slave/test"] 05:01:15 INFO - --app=APP Application being installed. [default: firefox] 05:01:15 INFO - mkdir: /builds/slave/test/build/application 05:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:01:31 INFO - Reading from file tmpfile_stdout 05:01:31 INFO - Output received: 05:01:31 INFO - /builds/slave/test/build/application/firefox/firefox 05:01:31 INFO - Running post-action listener: _resource_record_post_action 05:01:31 INFO - ##### 05:01:31 INFO - ##### Running run-tests step. 05:01:31 INFO - ##### 05:01:31 INFO - Running pre-action listener: _resource_record_pre_action 05:01:31 INFO - Running main action method: run_tests 05:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:01:31 INFO - Python 2.7.3 05:01:31 INFO - Return code: 0 05:01:31 INFO - grabbing minidump binary from tooltool 05:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:31 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 0x11cd410>, '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 0x11ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ce7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:01:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:01:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:01:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:32 INFO - Return code: 0 05:01:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:01:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:01:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:01:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:01:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:01:33 INFO - Return code: 0 05:01:33 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/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:01:33 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/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:01:33 INFO - Using env: {'DISPLAY': ':0', 05:01:33 INFO - 'HOME': '/home/cltbld', 05:01:33 INFO - 'LANG': 'en_US.UTF-8', 05:01:33 INFO - 'LANGUAGE': 'en_US:en', 05:01:33 INFO - 'LOGNAME': 'cltbld', 05:01:33 INFO - 'MAIL': '/var/mail/cltbld', 05:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:33 INFO - 'MOZ_NO_REMOTE': '1', 05:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:33 INFO - 'NO_EM_RESTART': '1', 05:01:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:33 INFO - 'PWD': '/builds/slave/test', 05:01:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:01:33 INFO - 'SHELL': '/bin/bash', 05:01:33 INFO - 'SHLVL': '1', 05:01:33 INFO - 'TERM': 'linux', 05:01:33 INFO - 'TMOUT': '86400', 05:01:33 INFO - 'USER': 'cltbld', 05:01:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843', 05:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:33 INFO - '_': '/tools/buildbot/bin/python'} 05:01:33 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/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:01:33 INFO - mozversion application_buildid: 20160416023005 05:01:33 INFO - mozversion application_changeset: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 05:01:33 INFO - mozversion application_display_name: Nightly 05:01:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:33 INFO - mozversion application_name: Firefox 05:01:33 INFO - mozversion application_remotingname: firefox 05:01:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:01:33 INFO - mozversion application_vendor: Mozilla 05:01:33 INFO - mozversion application_version: 48.0a1 05:01:33 INFO - mozversion platform_buildid: 20160416023005 05:01:33 INFO - mozversion platform_changeset: 19d56ca9e3f5078dba44230ac3ec0718cc029b70 05:01:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:01:33 INFO - mozversion platform_version: 48.0a1 05:01:33 INFO - using testdate: 1460808093 05:01:33 INFO - actual date: 1460808093 05:01:33 INFO - starting webserver on 'localhost:49142' 05:01:33 INFO - SUITE-START | Running 2 tests 05:01:33 INFO - TEST-START | dromaeo_css 05:01:33 INFO - operating with platform_type : linux_ 05:01:33 INFO - Initialising browser for dromaeo_css test... 05:01:33 INFO - TEST-INFO | started process 3344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbieDmI/profile http://localhost:49142/getInfo.html) 05:01:38 INFO - PROCESS | 3344 | 05:01:38 INFO - PROCESS | 3344 | (process:3414): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:01:38 INFO - PROCESS | 3344 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:01:40 INFO - PROCESS | 3344 | __metrics Screen width/height:1600/1200 05:01:40 INFO - PROCESS | 3344 | colorDepth:24 05:01:40 INFO - PROCESS | 3344 | Browser inner width/height: 1024/697 05:01:40 INFO - PROCESS | 3344 | __metrics 05:01:40 ERROR - PROCESS | 3344 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:01:41 INFO - TEST-INFO | 3344: exit 0 05:01:41 INFO - Browser initialized. 05:01:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:41 INFO - TEST-INFO | started process 3465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbieDmI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:43 INFO - PROCESS | 3465 | 05:01:43 INFO - PROCESS | 3465 | (process:3526): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:01:53 INFO - PROCESS | 3465 | RSS: Main: 163356672 05:01:53 INFO - PROCESS | 3465 | 05:02:42 INFO - PROCESS | 3465 | 1460808162986 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:04:50 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:49142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49142/tests/dromaeo/cssquery-ext.html) 05:04:51 INFO - PROCESS | 3465 | RSS: Main: 168071168 05:04:51 INFO - PROCESS | 3465 | 05:07:53 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:49142/tests/dromaeo/cssquery-ext.html (next: http://localhost:49142/tests/dromaeo/cssquery-jquery.html) 05:07:53 INFO - PROCESS | 3465 | RSS: Main: 165814272 05:07:53 INFO - PROCESS | 3465 | 05:10:55 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:49142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49142/tests/dromaeo/cssquery-mootools.html) 05:10:56 INFO - PROCESS | 3465 | RSS: Main: 166641664 05:10:56 INFO - PROCESS | 3465 | 05:13:57 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:49142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49142/tests/dromaeo/cssquery-prototype.html) 05:13:58 INFO - PROCESS | 3465 | RSS: Main: 164245504 05:13:58 INFO - PROCESS | 3465 | 05:17:00 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:49142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49142/tests/dromaeo/cssquery-yui.html) 05:17:01 INFO - PROCESS | 3465 | RSS: Main: 165806080 05:17:01 INFO - PROCESS | 3465 | 05:20:03 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:49142/tests/dromaeo/cssquery-yui.html (next: http://localhost:49142/tests/dromaeo/cssquery-dojo.html) 05:20:04 INFO - PROCESS | 3465 | RSS: Main: 167370752 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | __start_tp_report 05:20:04 INFO - PROCESS | 3465 | _x_x_mozilla_page_load 05:20:04 INFO - PROCESS | 3465 | _x_x_mozilla_page_load_details 05:20:04 INFO - PROCESS | 3465 | |i|pagename|runs| 05:20:04 INFO - PROCESS | 3465 | |0;dojo.html;3080.1991482214626;3153.4796758534844;3160.352127813797;3187.7290430313424;3202.183443221978;5434.782608695652;5462.371827239858;5473.835784926454;5501.202325662776;5504.4495550444935;5386.622936394454;5499;5520.641158324706;5555.527780138683;5604.299462567179;4982.327385802915;5028.220625803006;5092.083424983502;5101.183810590306;5147.510986456281;366.3405088062622;4836.984233311009;4949.034938187055;5049.3435853339015;5097.974510127444;4946.035523073002;4969.478204788481;4995.35060442142;4995.975824955894;4998.875028124289;4988.127077761377;5000.1249781288125;5004.099262132815;5010.323606313137;5023.120953833065;4939;4976.2286845539;4980.676256043345;4982.526659967298;5032.295478632995;5376.11294136467;5403.162509810946;5413.404525502192;5435.972820135914;5437.782488700487;5638.859028524279;5777.59556831022;5843.824685259449;5865.472107510344;5879.0593505039415;5844;5844.357120716718;5865.178874957509;5879.3826648202175;6007.3992600739575;5443.237946687467;5448.863778405532;5449.809256675997;5452.972735136299;5452.972735136339;5945.227120474397;5970.671613061323;6005.768817392424;6054.909176362358;6100.176476175659;5768.3654797972185;5772.682502462321;5782.132680097935;5788.681622510802;5810.099434587646;5875.353711091777;5894.263217097863;5896.1450589664255;5898.262717160355;5903.911441328383;5803.564732645069;5831.708414579254;5883.0293001654245;5884.617499862496;5935.376785437553;5721.456461636138;5737.540996720252;5782.566307526952;5797.4782269595935;5807.564432667482;4332.090261045216;4391.494978077498;4400.559944005574;4401.537838526972;4447.822087116479;3876.6704830089193;3909.139989202371;3952.4071389291835;3979.462772525672;4013.779242141652;5511.090670039479;5535.8339249821765;5591.273134492571;5648.265725455664;5661.065924122474;5952.583319167703;6012.368701286389;6017.338092809788;6019.729112189962;6020.217371741734;5471.206675032098;5579.497845193952;5624.100143976944;5626.465485778845;5680.40355762639;5002.774875130628;5036.11867923112;5049.722265275445;5052.115879721034;5066.417362003343;5879.059350503899;6080.14877917092;6091.878162436727;6092.482139018233;6100.267967843798;5927.673977931255;6015.428534289235;6023.066424704178;6029.78895738647;6039.245094363205;5950.9404905952115;5964.582479226586;5983.611065280743;6021.909671355021;6113.786017489544;5620.4660557247;5758.107493338372;5815.447532484407;5815.79644712433;5826.650400975955;5886.705664716661;5897.5576831736935;5909.940900590939;5910.674912879833;5953.196318497121;5667.801626943037;5677.460641239241;5681.573881958787;5719.799807006735;5760.0783874579865;5569.19246709233;5676.858078548069;5709.343425505954;5716.5426765859465;5723.399043100415;5538.667679939216;5548.805791797267;5560.2493663356545;5589.217509548747;5620.241267428844;5704.600677952503;5731.742071606871;5767.192593037062;5768.884622307614;5782.971085144715;5456.072467680583;5527.861803454945;5579.804706835242;5654.378018417889;5668.943310566841 05:20:04 INFO - PROCESS | 3465 | |1;ext.html;585.0872638683651;650.9056186852906;653.7777155767038;657.9539432239744;673.8349104469406;35105;35977;36176;36200;36430.453543196876;37095.81452092736;37203.81398093013;37628.05929851755;37661.24677506448;37715.057123571925;8432.325413966882;8491.15088491149;8506.276966457859;8569.143085691412;8587.313014958789;8292.875606865902;8594.484330940164;8599.742007739778;8602.053774084878;8661.783455413602;8631.870521942175;8670.653173873037;8671.739847804576;8706.129387061275;8709.60806763694;8547.10255423181;8550.230479256834;8593.26957208638;8606.31149508038;8640.697575584856;8530.914690853075;8648.870266946002;8691.521966291852;8733.694320698809;8793.428427152214;32777;37791.811040944616;38054.61945380566;38122.23755524902;38132;3313.6686331366914;3348.933234737984;3555.7510974231814;3617.0776452004834;3665.2119794244363;29816.254593635116;30314.54528182079;30328.019879389067;30336.69663303383;30455.23861903448;4044.6562042226446;4074.225897079575;4093.8771836844944;4106.07613287011;4130.401091841696;234540;238932;241172;241812;304473;63072.36927630757;63239.36760632427;63726.681366593795;63727.85768925005;63737.36262637407;68348.6582567084;70279.64860175768;70495.64752176206;70519;70524.64737676381;15550.688986220212;15664.843351566338;15699.68600627981;15710.9214453927;15822.208889555477;11949.820752688716;12059.397030148457;12083.154179207371;12172.2696638202;12218.022558195324;19795.60408791816;20144.49638759043;20403;21004.369868903956;21034.47413814667;7906.920930790733;7944.721934732373;7989.360851132012;8020.796880467977;8073.6366863491285;1034.3535290443472;1122.2480937771713;1131.7906187355366;1158.3050169897995;1244.6950497128262;31569.684303157133;31700.9657306966;31835.681643183736;31876;31922;1146.9025132863633;1185.9644210673694;1191.976160476803;1298.558490113366;1299.330844615024;17059.658806823794;17074.317027318768;17163.313467461412;17241;17396.21717022737;431591;438126;441625;442370;443103;57265.713671431375;58267.70866145727;58445.70777146172;58568;58640.12039819406;1322.081153598259;1323.5499930023645;1358.864113588653;1389.485890220625;1423.3310344138238;29921.551176732803;30628.540571891885;30660.233494162825;31968.840155799073;32495.35009299848;51088.489115109856;51917.96164076622;52122.47877521176;52310.47689523056;52328.215076773115;402500;405550;410258;412763;414187;42645.42071480282;43676.34485482784;45013;45121.54878451305;45243.32135017912;48053;48429.273560897316;48766;49070.26394604155;49652.50347496623;40862.79568602138;41948.79025604852;42046.15907681768;42127.57872421236;42976.57023429726;40722.389164163156;41265;41330.380044298756;42207;42393;42460.363094554225;42578;42820.14359712726;43061;43170;34718.82640586781;36637.26725465422;36899.376696340565;37080.25839483249;37128.81435592805;28226.71773282241;28414.57378139371;28478.145655630364;28616.713832861406;29159.562606560496 05:20:04 INFO - PROCESS | 3465 | |2;jquery.html;394.6053946053947;394.7868151198353;398.4004073868827;405.1532297498229;407.49674152421755;14123.505677301297;17916.731249031258;18358.632827343445;18420.355287564922;18561.907190464062;17933.282668693235;17937.282508699638;17948.64102717948;18347.633047339044;18744.906275468602;5053.191489361703;5466.9179962300595;5683.204351390808;5704.087346024637;5756.338021127561;5648.378678345379;5663.886722265553;5666.405027472118;5676.148577713356;5703.857403564903;5448.182772584105;5595.300587426572;5653.321601407837;5705.2012718219485;5711.71441427929;5645.943540564583;5663.745131469093;5671.035923892928;5671.092625179972;5689.658620482764;4790.42514898211;5066.442691303953;5068.087744206042;5072.416672082684;5074.59403247743;21708.240211592678;22636.434089147904;22740;22986.655200171845;23036.308910732703;2382.892769825362;2421.2131057406414;2444.095684596693;2444.6333050042635;2548.286479785663;13524.391402386917;14231.644208894757;14377.56867293983;14383.78424323636;14646.780298295535;1931.198552600669;1988.2345297060592;2004.8295894848955;2008.8895110768901;2054.445299769069;79557.60221198914;80220.99999999942;80365.19634803636;80814;81690.59154704188;10001.949990250003;10288;10334.379937203792;10507.737306567244;10537.63118290856;14530.491432799801;14563.563093107012;14581.781273280909;14618.488352907598;14642.487512936996;7890.053193616688;7897.289243967955;7950.681972721027;7963.800904977422;8055.073666528307;7697.8845317319165;7727.343175830005;7744.0707115145415;7773.92226077732;7795.766127016199;6258.405451482102;6436.452901503425;6474.546781725328;6530;6591;1850.4818650777804;1850.8704390692521;1860.135037207705;1901.077977181066;1926.9325573605138;973.5229737428609;1067.32225037102;1101.262154356583;1102.0487184960548;1138.7608602193466;18656.81343186578;18761;19356.516087097934;19472.318468853522;19614.509637258896;1050.2490719135856;1088.4938503595865;1092.7377429416883;1111.4165063341811;1124.44901998022;10840.891591083988;11183.273087249465;11185.94407027976;11202.831957520644;11225.214235003634;474646;477732;483387;485388;485487;62320;77318;78489.60755196188;80041.19958800338;81812.18187818164;1075.8762742284737;1077.4020418667558;1097.0948967102013;1111.2388014210292;1113.9387333696725;17680.115994200496;17789.822101778816;17794.91102544479;17800.55498612545;18035.549111272325;36334.454983175805;36461.817690911375;36931.63068369282;36996.26007479889;37329.44005839969;48630.513694862595;48873;49639;49750.25374619456;50740;8048;8447.493150410995;8458.450200736932;8493.938257717786;8528.488290702579;12760.48958041705;12859.742805144031;12894.548690795777;13034.608961731163;13268.80096798568;11395.715107122056;11475.770484590428;11485.655430337103;11652.30086194831;11733.413329333669;11295.943520282346;11513.712157196138;11622;11740.58907938218;11811.350375729417;11772.293662380285;11816.113791465847;12082.09384296199;12091.274523528617;12133.878661213275;8110.959445202736;8137.471064380797;8164.142765009588;8227.382946279173;8250.958745206235;11290.43547822622;11314.321140731583;11356.488957996744;11476.598319058792;11665 05:20:04 INFO - PROCESS | 3465 | |3;mootools.html;1537.5156825599931;1557.6105973506624;1738.6783445062665;1799.973000404995;1864.2170288478837;7598.582077985709;8104.675812967482;8305.086440491541;8309.50142991421;8357.331413486922;8300.584970751454;8333.708320208794;8339.54132522711;8408.957955210231;8429.199226073528;2308.6306191009444;2316.664083707861;2319.1071437496516;2330.627099664054;2333.5332933413383;2304.331743794306;2311.9884400577976;2352.5765362234793;2355.0462062864567;2355.3875992242056;2305.9192928247517;2307.3539408965516;2314.3057082875152;2317.629179331307;2321.2339927823778;2271.034810205664;2273.318004598622;2274.1130958925864;2277.840551161419;2284.520250747345;2243.5064285857084;2256.2103263857684;2261.1520679745095;2263.7736226377397;2272.988635056814;8395.874061889077;8504.362172837062;8514.787130321729;8541.82916341676;8544.914550854473;5029.622778291643;5206.895862082737;5216.139337009389;5219.895602087975;5230;3253.544503769474;3285.655006224336;3352.916177095568;3362.6469220731715;3396.3037577296595;1078.563181911327;1084.4089970965763;1094.895984881435;1108.905743011845;1118.72031992002;11667.766644667145;11747.765044699057;11761.176717629769;11786.646400607995;11796;4440.644748420119;4573.885652858705;4586.1057093866375;4672.135654903854;4693.48371679115;9855.31012829095;9986.101250887456;10022.498875056219;10057.14514266281;10084.798304033879;5152.896942061137;5193.350831146106;5225.608079394061;5243.344581927259;5258.894822103536;4140.482439695038;4711.128441238382;4811.4707382187935;4830.347903033045;4835.58897493717;3874.244522318177;3893.377059670439;3977.5823538528616;3991.44119823225;4018.216447792711;1282.6857419932176;1299.8375203099613;1302.4920281090383;1302.5050480817229;1304.6803533134444;931.4783721116197;989.559645957542;1006.33079002464;1021.6322124035341;1034.5809946971488;5787.942120578825;5883.264591926009;5966.343702192756;6019.789307374309;6061.363556826558;436.03853503025755;439.936209249657;458.8002373792575;468.89918667486654;469.40854523300885;4089.6728261739586;4260.8495706159165;4261.126469073833;4276.2089013532595;4279.850205242801;9762.560684769202;10234.48827558619;10285.640002600023;10290.845637315446;10296.742581435525;9360.765980850534;9760.804783904283;9862.358946668444;9982.850257246148;10105.696829095139;7423.591702456417;7524.322810947041;7548.207438219018;7553.773386798514;7593.810154746065;5713.514351280188;5762.596618236851;5768.94231057684;5869.765209391577;6010.669413182317;9271.814563708553;9384.296177786557;9428.292878034037;9503.192228660364;9517.428954262767;9370.156685898302;9410.38832475887;9606;9654.27592930519;9745.074217949283;6941.409980151744;6970.302969702989;7123.608201548965;7266.382357499671;7417.592032438268;7801.570913599807;7803.804904877424;7843.137254901842;7851.803704907423;7883.487573307717;6859.9314006859295;7086.645667716697;7102.112235970504;7159;7205.171405288249;7063.293670633101;7101.183363913216;7144.4641651877355;7174.569525828467;7175.282471752992;6256.343083976117;6402;6573.605583664996;6585.934140658724;6591.307912669101;4869.366982292279;4877.5366340197625;4908.263760435963;4952.851414457572;4957.107720610325;4913.582345500672;4921.237208232729;4936.481669424802;4940.2342636891335;4946.530079642428 05:20:04 INFO - PROCESS | 3465 | |4;prototype.html;326.6423266523156;332.1198823118735;336.59104188411084;338.8525991193831;340.5674793012875;5763.5389168866495;5913;5915.822525324236;6054.727537260817;6083.300420451649;5893.616914900528;6014.188084608577;6015.939840601593;6037.486813620848;6058.485028772559;4579.885502862438;4589.724616523019;4596.149712303226;4642.373279607261;4647.047355292174;4363.214621368168;4561.954380456203;4566.49768525462;4597.08058388322;4654;4481.686281960264;4538.773061346919;4544.272916333387;4544.363789069533;4551.931721024171;4555.407796986387;4556.931646025312;4561.247394179956;4570.245909424924;4581.79381927814;3871.825767840454;3912.960870391288;3935.5080614923136;3965.801709914522;3972.980135099335;5728.627639203439;5744.167095771131;5756.971215143939;5762.654240745569;5791.305043394777;5237.921431178535;5239.947600523984;5243.9213411798855;5252.57979361654;5267.683938963674;6009.789657361971;6197.419657987184;6261.21196676009;6294.559380843343;6331.303556608769;4273.145370925796;4277.080427708027;4280.079782846703;4287.48550173978;4299.828006879752;6275.7489700411925;6498.772542961021;6584.913489274264;6595.736170553172;6634.668266586651;4495.325701144854;4524.434445694288;4529.479109902403;4536.319552067216;4546.636269098464;4624.676272660881;4625.398698169217;4626.259798432302;4633.72197668141;4636.374089497942;5073.543381095646;5315.282436870973;5337.572994160458;5346.9038847037045;5355.7054362009685;6068.362821903725;6198.597091189058;6216.564840461125;6377.139086223393;6382.457491113215;1595.4176725495342;1609.8953568018042;1623.3750006247444;1626.7966504186977;1639.2049855819919;1083.34999000599;1084.2735367303926;1099.4228030284005;1101.1411099342527;1109.9056580190775;6111.297200821873;6111.327753947062;6135.913789311656;6137.9079313810325;6193.287771906198;6489.286178520359;6491.902621460682;6495.4803615710625;6506.837329066811;6535.836604084936;5900.937831190341;6118;6178.969105154535;6179.16581261533;6203.844903877349;3481.4429691249784;3484.686378225972;3487.982560087234;3498.3877821381157;3512.5609298837644;6561.212654481493;6688.3646053624825;6749.3250674932115;6782.593044417351;6816.897746533806;6579.078928949951;6637.369449902251;6647.66761661915;6675.831729447327;6706.22878368984;6576.80269591913;6587.835304117435;6645.269020407752;6691.966540167366;6720.428763555153;6418.19772528434;6512.381323774234;6517.934820651923;6522.902156467562;6525.673716314261;6262.780802671885;6301.779437719658;6328.303886572566;6344.30212676596;6460.289368169404;6678.699458524281;6684.231313399021;6739.528233023641;6743.2582415935185;6759.628220447923;4592.540745925381;4594.632429405707;4601.838935637236;4624.3294722265755;4628.791704373379;6266.154069200599;6324.2410910691015;6414.5189110815945;6471.482281417381;6539.574927629689;6314.684265786784;6336.968315158395;6416.262129855127;6417.711202995783;6436.066770318184;6186.412290832363;6355.841103972438;6363.936360636334;6368.42684158428;6374.458171055512;6177.62934223948;6184.721687523982;6187.319394866651;6189.535784816067;6190.133381326528;6415.230172379344;6422.582532135396;6431.710573024132;6452.257990331172;6459.773907913201;5965.522758179422;6221.813345599639;6281.96859015702;6290.622562646073;6308.905366419415 05:20:04 INFO - PROCESS | 3465 | |5;yui.html;814.853326401248;820.2207902492634;862.5126803356103;876.73259655805;883.885094937658;13629.182249065063;14405.63985900353;14621.561353159408;14622.48821291255;14689.559313220621;12178.147529672926;13367.866321336784;13499.190048597091;13500.932495337534;13502.527411540597;804.3203493048379;831.8876951611516;832.7376876283951;835.5947365527715;837.9916200838005;824.085265355455;831.6382373667444;834.5535138700797;837.0750320895414;842.3640151685469;865.5888452984844;866.4844417571567;874.8119154381807;875.4047247871445;879.9296056315511;855.7261676263598;858.2533196119385;859.1923591823665;866.8613021916526;868.0971789339111;627.2253766598247;630.9432151106377;633.2084893882646;633.8763941031501;633.9144215530937;14440.927795361062;14453.71092578153;14469.348879300456;14498.492552760708;14561.271936403138;13171.538996135185;13244.337783110806;13337.466501339935;13509.932450337783;13539.458421663121;11133.944330278297;11219.326840389604;11253.324800511995;11404.771904561861;11440.19918605698;3861.2856621524825;3887.9611203888167;3897.5907529709257;3937.212557488485;3959.762414255154;54381.728091359684;56063.71968140174;56371.71814140944;56392;59006.70496647489;11000.284981476338;11313.490892909838;11353.545858165746;11423.428828558539;11545.769084618261;19466.124024418936;19808.108635111454;19920;19934.50163745918;19937.401877943685;8198;8262.504249745034;8278.130796266305;8381.874271885927;8549.102344253764;4497.730136191839;4660.39414876064;4664.906701865943;4764.237721964469;4773.069251495925;3203.2152122729613;3271.9509207361907;3273.3126043530647;3284.244623736506;3292.9506057409158;636.3604577399684;662.3806740697368;674.1842370731372;676.0839063069568;692.715986445565;763.7441457111819;764.3044829205396;788.2078511096312;798.9680412783424;817.2807929022422;9270.675526356545;9698.175655069399;9737.659181928599;9746.61013559464;9758.804823903482;688.5524409134102;722.1550785580883;748.296601194875;761.8704820180583;781.0822283816493;4470.687051906335;4601.585857272861;4636.976815115903;4748.810047598057;4778.4982576829625;65241.673791631685;65820.34179658142;68190.3180968184;68365.3163468359;68536;56446.717766410904;57169;58407;58483.122753158736;60011;52629;53791.731041344545;54336.45663543393;54471.45528544743;54763.72618136884;8758.343124265579;8790.34072444582;8827.029026806918;8866.20204181601;8880.600372983361;34857;35445.82277088598;35933.28133437369;36072;36266.63733362633;44760;45845.77077114593;46420;46912.53087469218;47540.28689569728;11308.264962777394;11974.101942354184;12077.818832717692;12245.081618878798;12458.377081146087;13290.401931912893;13295.933520332337;13330.866691332962;13839.30803459843;14206.360713768112;13076.738465230452;13430.664233394244;13480.93259533696;13858.16850988944;13862.306884655929;12653.810192847299;12699.746005079662;12960;13398.799018014543;13886.583402497941;13195.60413187606;13215.405306761411;13531.391087400894;13917.72164556683;13986.930065349608;10922.508487118257;11012.293879904713;11012.339259644446;11134.164937629548;11396.430178491208;10517.421541814967;10880.238383313408;10977.3962432067;11306.265092768943;11356.148288878201 05:20:04 INFO - PROCESS | 3465 | __end_tp_report 05:20:04 INFO - PROCESS | 3465 | __start_cc_report 05:20:04 INFO - PROCESS | 3465 | _x_x_mozilla_cycle_collect,337 05:20:04 INFO - PROCESS | 3465 | __end_cc_report 05:20:04 INFO - PROCESS | 3465 | __startTimestamp1460809204204__endTimestamp 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | ------- Summary: start ------- 05:20:04 INFO - PROCESS | 3465 | Number of tests: 6 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | [#0] dojo.html Cycles:165 Average:5415.79 Median:5638.86 stddev:742.31 (13.2%) stddev-sans-first:721.62 05:20:04 INFO - PROCESS | 3465 | Values: 3080.2 3153.5 3160.4 3187.7 3202.2 5434.8 5462.4 5473.8 5501.2 5504.4 5386.6 5499.0 5520.6 5555.5 5604.3 4982.3 5028.2 5092.1 5101.2 5147.5 366.3 4837.0 4949.0 5049.3 5098.0 4946.0 4969.5 4995.4 4996.0 4998.9 4988.1 5000.1 5004.1 5010.3 5023.1 4939.0 4976.2 4980.7 4982.5 5032.3 5376.1 5403.2 5413.4 5436.0 5437.8 5638.9 5777.6 5843.8 5865.5 5879.1 5844.0 5844.4 5865.2 5879.4 6007.4 5443.2 5448.9 5449.8 5453.0 5453.0 5945.2 5970.7 6005.8 6054.9 6100.2 5768.4 5772.7 5782.1 5788.7 5810.1 5875.4 5894.3 5896.1 5898.3 5903.9 5803.6 5831.7 5883.0 5884.6 5935.4 5721.5 5737.5 5782.6 5797.5 5807.6 4332.1 4391.5 4400.6 4401.5 4447.8 3876.7 3909.1 3952.4 3979.5 4013.8 5511.1 5535.8 5591.3 5648.3 5661.1 5952.6 6012.4 6017.3 6019.7 6020.2 5471.2 5579.5 5624.1 5626.5 5680.4 5002.8 5036.1 5049.7 5052.1 5066.4 5879.1 6080.1 6091.9 6092.5 6100.3 5927.7 6015.4 6023.1 6029.8 6039.2 5950.9 5964.6 5983.6 6021.9 6113.8 5620.5 5758.1 5815.4 5815.8 5826.7 5886.7 5897.6 5909.9 5910.7 5953.2 5667.8 5677.5 5681.6 5719.8 5760.1 5569.2 5676.9 5709.3 5716.5 5723.4 5538.7 5548.8 5560.2 5589.2 5620.2 5704.6 5731.7 5767.2 5768.9 5783.0 5456.1 5527.9 5579.8 5654.4 5668.9 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | [#1] ext.html Cycles:180 Average:54469.87 Median:22478.34 stddev:99337.37 (441.9%) stddev-sans-first:99533.65 05:20:04 INFO - PROCESS | 3465 | Values: 585.1 650.9 653.8 658.0 673.8 35105.0 35977.0 36176.0 36200.0 36430.5 37095.8 37203.8 37628.1 37661.2 37715.1 8432.3 8491.2 8506.3 8569.1 8587.3 8292.9 8594.5 8599.7 8602.1 8661.8 8631.9 8670.7 8671.7 8706.1 8709.6 8547.1 8550.2 8593.3 8606.3 8640.7 8530.9 8648.9 8691.5 8733.7 8793.4 32777.0 37791.8 38054.6 38122.2 38132.0 3313.7 3348.9 3555.8 3617.1 3665.2 29816.3 30314.5 30328.0 30336.7 30455.2 4044.7 4074.2 4093.9 4106.1 4130.4 234540.0 238932.0 241172.0 241812.0 304473.0 63072.4 63239.4 63726.7 63727.9 63737.4 68348.7 70279.6 70495.6 70519.0 70524.6 15550.7 15664.8 15699.7 15710.9 15822.2 11949.8 12059.4 12083.2 12172.3 12218.0 19795.6 20144.5 20403.0 21004.4 21034.5 7906.9 7944.7 7989.4 8020.8 8073.6 1034.4 1122.2 1131.8 1158.3 1244.7 31569.7 31701.0 31835.7 31876.0 31922.0 1146.9 1186.0 1192.0 1298.6 1299.3 17059.7 17074.3 17163.3 17241.0 17396.2 431591.0 438126.0 441625.0 442370.0 443103.0 57265.7 58267.7 58445.7 58568.0 58640.1 1322.1 1323.5 1358.9 1389.5 1423.3 29921.6 30628.5 30660.2 31968.8 32495.4 51088.5 51918.0 52122.5 52310.5 52328.2 402500.0 405550.0 410258.0 412763.0 414187.0 42645.4 43676.3 45013.0 45121.5 45243.3 48053.0 48429.3 48766.0 49070.3 49652.5 40862.8 41948.8 42046.2 42127.6 42976.6 40722.4 41265.0 41330.4 42207.0 42393.0 42460.4 42578.0 42820.1 43061.0 43170.0 34718.8 36637.3 36899.4 37080.3 37128.8 28226.7 28414.6 28478.1 28616.7 29159.6 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | [#2] jquery.html Cycles:180 Average:27930.10 Median:22688.22 stddev:78994.17 (348.2%) stddev-sans-first:79188.71 05:20:04 INFO - PROCESS | 3465 | Values: 394.6 394.8 398.4 405.2 407.5 14123.5 17916.7 18358.6 18420.4 18561.9 17933.3 17937.3 17948.6 18347.6 18744.9 5053.2 5466.9 5683.2 5704.1 5756.3 5648.4 5663.9 5666.4 5676.1 5703.9 5448.2 5595.3 5653.3 5705.2 5711.7 5645.9 5663.7 5671.0 5671.1 5689.7 4790.4 5066.4 5068.1 5072.4 5074.6 21708.2 22636.4 22740.0 22986.7 23036.3 2382.9 2421.2 2444.1 2444.6 2548.3 13524.4 14231.6 14377.6 14383.8 14646.8 1931.2 1988.2 2004.8 2008.9 2054.4 79557.6 80221.0 80365.2 80814.0 81690.6 10001.9 10288.0 10334.4 10507.7 10537.6 14530.5 14563.6 14581.8 14618.5 14642.5 7890.1 7897.3 7950.7 7963.8 8055.1 7697.9 7727.3 7744.1 7773.9 7795.8 6258.4 6436.5 6474.5 6530.0 6591.0 1850.5 1850.9 1860.1 1901.1 1926.9 973.5 1067.3 1101.3 1102.0 1138.8 18656.8 18761.0 19356.5 19472.3 19614.5 1050.2 1088.5 1092.7 1111.4 1124.4 10840.9 11183.3 11185.9 11202.8 11225.2 474646.0 477732.0 483387.0 485388.0 485487.0 62320.0 77318.0 78489.6 80041.2 81812.2 1075.9 1077.4 1097.1 1111.2 1113.9 17680.1 17789.8 17794.9 17800.6 18035.5 36334.5 36461.8 36931.6 36996.3 37329.4 48630.5 48873.0 49639.0 49750.3 50740.0 8048.0 8447.5 8458.5 8493.9 8528.5 12760.5 12859.7 12894.5 13034.6 13268.8 11395.7 11475.8 11485.7 11652.3 11733.4 11295.9 11513.7 11622.0 11740.6 11811.4 11772.3 11816.1 12082.1 12091.3 12133.9 8111.0 8137.5 8164.1 8227.4 8251.0 11290.4 11314.3 11356.5 11476.6 11665.0 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | [#3] mootools.html Cycles:180 Average:5521.08 Median:4928.86 stddev:3056.17 (62.0%) stddev-sans-first:3050.08 05:20:04 INFO - PROCESS | 3465 | Values: 1537.5 1557.6 1738.7 1800.0 1864.2 7598.6 8104.7 8305.1 8309.5 8357.3 8300.6 8333.7 8339.5 8409.0 8429.2 2308.6 2316.7 2319.1 2330.6 2333.5 2304.3 2312.0 2352.6 2355.0 2355.4 2305.9 2307.4 2314.3 2317.6 2321.2 2271.0 2273.3 2274.1 2277.8 2284.5 2243.5 2256.2 2261.2 2263.8 2273.0 8395.9 8504.4 8514.8 8541.8 8544.9 5029.6 5206.9 5216.1 5219.9 5230.0 3253.5 3285.7 3352.9 3362.6 3396.3 1078.6 1084.4 1094.9 1108.9 1118.7 11667.8 11747.8 11761.2 11786.6 11796.0 4440.6 4573.9 4586.1 4672.1 4693.5 9855.3 9986.1 10022.5 10057.1 10084.8 5152.9 5193.4 5225.6 5243.3 5258.9 4140.5 4711.1 4811.5 4830.3 4835.6 3874.2 3893.4 3977.6 3991.4 4018.2 1282.7 1299.8 1302.5 1302.5 1304.7 931.5 989.6 1006.3 1021.6 1034.6 5787.9 5883.3 5966.3 6019.8 6061.4 436.0 439.9 458.8 468.9 469.4 4089.7 4260.8 4261.1 4276.2 4279.9 9762.6 10234.5 10285.6 10290.8 10296.7 9360.8 9760.8 9862.4 9982.9 10105.7 7423.6 7524.3 7548.2 7553.8 7593.8 5713.5 5762.6 5768.9 5869.8 6010.7 9271.8 9384.3 9428.3 9503.2 9517.4 9370.2 9410.4 9606.0 9654.3 9745.1 6941.4 6970.3 7123.6 7266.4 7417.6 7801.6 7803.8 7843.1 7851.8 7883.5 6859.9 7086.6 7102.1 7159.0 7205.2 7063.3 7101.2 7144.5 7174.6 7175.3 6256.3 6402.0 6573.6 6585.9 6591.3 4869.4 4877.5 4908.3 4952.9 4957.1 4913.6 4921.2 4936.5 4940.2 4946.5 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | [#4] prototype.html Cycles:180 Average:5285.83 Median:6056.61 stddev:1582.08 (26.1%) stddev-sans-first:1542.11 05:20:04 INFO - PROCESS | 3465 | Values: 326.6 332.1 336.6 338.9 340.6 5763.5 5913.0 5915.8 6054.7 6083.3 5893.6 6014.2 6015.9 6037.5 6058.5 4579.9 4589.7 4596.1 4642.4 4647.0 4363.2 4562.0 4566.5 4597.1 4654.0 4481.7 4538.8 4544.3 4544.4 4551.9 4555.4 4556.9 4561.2 4570.2 4581.8 3871.8 3913.0 3935.5 3965.8 3973.0 5728.6 5744.2 5757.0 5762.7 5791.3 5237.9 5239.9 5243.9 5252.6 5267.7 6009.8 6197.4 6261.2 6294.6 6331.3 4273.1 4277.1 4280.1 4287.5 4299.8 6275.7 6498.8 6584.9 6595.7 6634.7 4495.3 4524.4 4529.5 4536.3 4546.6 4624.7 4625.4 4626.3 4633.7 4636.4 5073.5 5315.3 5337.6 5346.9 5355.7 6068.4 6198.6 6216.6 6377.1 6382.5 1595.4 1609.9 1623.4 1626.8 1639.2 1083.3 1084.3 1099.4 1101.1 1109.9 6111.3 6111.3 6135.9 6137.9 6193.3 6489.3 6491.9 6495.5 6506.8 6535.8 5900.9 6118.0 6179.0 6179.2 6203.8 3481.4 3484.7 3488.0 3498.4 3512.6 6561.2 6688.4 6749.3 6782.6 6816.9 6579.1 6637.4 6647.7 6675.8 6706.2 6576.8 6587.8 6645.3 6692.0 6720.4 6418.2 6512.4 6517.9 6522.9 6525.7 6262.8 6301.8 6328.3 6344.3 6460.3 6678.7 6684.2 6739.5 6743.3 6759.6 4592.5 4594.6 4601.8 4624.3 4628.8 6266.2 6324.2 6414.5 6471.5 6539.6 6314.7 6337.0 6416.3 6417.7 6436.1 6186.4 6355.8 6363.9 6368.4 6374.5 6177.6 6184.7 6187.3 6189.5 6190.1 6415.2 6422.6 6431.7 6452.3 6459.8 5965.5 6221.8 6282.0 6290.6 6308.9 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - PROCESS | 3465 | [#5] yui.html Cycles:180 Average:15388.18 Median:25528.49 stddev:18114.51 (71.0%) stddev-sans-first:18132.26 05:20:04 INFO - PROCESS | 3465 | Values: 814.9 820.2 862.5 876.7 883.9 13629.2 14405.6 14621.6 14622.5 14689.6 12178.1 13367.9 13499.2 13500.9 13502.5 804.3 831.9 832.7 835.6 838.0 824.1 831.6 834.6 837.1 842.4 865.6 866.5 874.8 875.4 879.9 855.7 858.3 859.2 866.9 868.1 627.2 630.9 633.2 633.9 633.9 14440.9 14453.7 14469.3 14498.5 14561.3 13171.5 13244.3 13337.5 13509.9 13539.5 11133.9 11219.3 11253.3 11404.8 11440.2 3861.3 3888.0 3897.6 3937.2 3959.8 54381.7 56063.7 56371.7 56392.0 59006.7 11000.3 11313.5 11353.5 11423.4 11545.8 19466.1 19808.1 19920.0 19934.5 19937.4 8198.0 8262.5 8278.1 8381.9 8549.1 4497.7 4660.4 4664.9 4764.2 4773.1 3203.2 3272.0 3273.3 3284.2 3293.0 636.4 662.4 674.2 676.1 692.7 763.7 764.3 788.2 799.0 817.3 9270.7 9698.2 9737.7 9746.6 9758.8 688.6 722.2 748.3 761.9 781.1 4470.7 4601.6 4637.0 4748.8 4778.5 65241.7 65820.3 68190.3 68365.3 68536.0 56446.7 57169.0 58407.0 58483.1 60011.0 52629.0 53791.7 54336.5 54471.5 54763.7 8758.3 8790.3 8827.0 8866.2 8880.6 34857.0 35445.8 35933.3 36072.0 36266.6 44760.0 45845.8 46420.0 46912.5 47540.3 11308.3 11974.1 12077.8 12245.1 12458.4 13290.4 13295.9 13330.9 13839.3 14206.4 13076.7 13430.7 13480.9 13858.2 13862.3 12653.8 12699.7 12960.0 13398.8 13886.6 13195.6 13215.4 13531.4 13917.7 13986.9 10922.5 11012.3 11012.3 11134.2 11396.4 10517.4 10880.2 10977.4 11306.3 11356.1 05:20:04 INFO - PROCESS | 3465 | -------- Summary: end -------- 05:20:04 INFO - PROCESS | 3465 | 05:20:04 INFO - TEST-INFO | 3465: exit 0 05:20:04 INFO - TEST-OK | dromaeo_css | took 1111324ms 05:20:04 INFO - TEST-START | kraken 05:20:04 INFO - operating with platform_type : linux_ 05:20:04 INFO - Initialising browser for kraken test... 05:20:04 INFO - TEST-INFO | started process 3700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV3senG/profile http://localhost:49142/getInfo.html) 05:20:08 INFO - PROCESS | 3700 | 05:20:08 INFO - PROCESS | 3700 | (process:3769): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:20:08 INFO - PROCESS | 3700 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:20:09 INFO - PROCESS | 3700 | __metrics Screen width/height:1600/1200 05:20:09 INFO - PROCESS | 3700 | colorDepth:24 05:20:09 INFO - PROCESS | 3700 | Browser inner width/height: 1024/697 05:20:09 INFO - PROCESS | 3700 | __metrics 05:20:10 ERROR - PROCESS | 3700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:20:11 INFO - TEST-INFO | 3700: exit 0 05:20:11 INFO - Browser initialized. 05:20:11 INFO - Running cycle 1/1 for kraken test... 05:20:11 INFO - TEST-INFO | started process 3820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV3senG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:12 INFO - PROCESS | 3820 | 05:20:12 INFO - PROCESS | 3820 | (process:3878): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:20:22 INFO - PROCESS | 3820 | RSS: Main: 163655680 05:20:22 INFO - PROCESS | 3820 | 05:20:25 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49142/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:26 INFO - PROCESS | 3820 | RSS: Main: 168148992 05:20:26 INFO - PROCESS | 3820 | 05:20:29 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49142/tests/kraken/driver.html?testName=audio-dft) 05:20:29 INFO - PROCESS | 3820 | RSS: Main: 171266048 05:20:29 INFO - PROCESS | 3820 | 05:20:32 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49142/tests/kraken/driver.html?testName=audio-fft) 05:20:33 INFO - PROCESS | 3820 | RSS: Main: 162054144 05:20:33 INFO - PROCESS | 3820 | 05:20:35 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49142/tests/kraken/driver.html?testName=audio-oscillator) 05:20:35 INFO - PROCESS | 3820 | RSS: Main: 162463744 05:20:35 INFO - PROCESS | 3820 | 05:20:38 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:38 INFO - PROCESS | 3820 | RSS: Main: 162816000 05:20:38 INFO - PROCESS | 3820 | 05:20:41 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49142/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:42 INFO - PROCESS | 3820 | RSS: Main: 163459072 05:20:42 INFO - PROCESS | 3820 | 05:20:45 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49142/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:46 INFO - PROCESS | 3820 | RSS: Main: 163618816 05:20:46 INFO - PROCESS | 3820 | 05:20:49 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49142/tests/kraken/driver.html?testName=json-parse-financial) 05:20:49 INFO - PROCESS | 3820 | RSS: Main: 166219776 05:20:49 INFO - PROCESS | 3820 | 05:20:51 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:52 INFO - PROCESS | 3820 | RSS: Main: 166113280 05:20:52 INFO - PROCESS | 3820 | 05:20:53 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:54 INFO - PROCESS | 3820 | RSS: Main: 165793792 05:20:54 INFO - PROCESS | 3820 | 05:20:56 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:57 INFO - PROCESS | 3820 | RSS: Main: 165994496 05:20:57 INFO - PROCESS | 3820 | 05:20:59 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:00 INFO - PROCESS | 3820 | RSS: Main: 166572032 05:21:00 INFO - PROCESS | 3820 | 05:21:03 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:21:03 INFO - PROCESS | 3820 | RSS: Main: 167145472 05:21:03 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:49142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49142/tests/kraken/driver.html?testName=ai-astar) 05:21:05 INFO - PROCESS | 3820 | RSS: Main: 168476672 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | __start_tp_report 05:21:05 INFO - PROCESS | 3820 | _x_x_mozilla_page_load 05:21:05 INFO - PROCESS | 3820 | _x_x_mozilla_page_load_details 05:21:05 INFO - PROCESS | 3820 | |i|pagename|runs| 05:21:05 INFO - PROCESS | 3820 | |0;ai-astar;113;105;113;110;110;122;110;109;112;110 05:21:05 INFO - PROCESS | 3820 | |1;audio-beat-detection;154;131;154;191;138;155;162;128;182;129 05:21:05 INFO - PROCESS | 3820 | |2;audio-dft;161;162;162;162;163;168;166;161;165;162 05:21:05 INFO - PROCESS | 3820 | |3;audio-fft;73;73;74;165;80;75;72;73;161;73 05:21:05 INFO - PROCESS | 3820 | |4;audio-oscillator;92;93;157;92;93;92;138;93;93;147 05:21:05 INFO - PROCESS | 3820 | |5;imaging-gaussian-blur;118;119;118;117;117;117;117;118;117;118 05:21:05 INFO - PROCESS | 3820 | |6;imaging-darkroom;147;147;146;147;146;147;148;146;147;146 05:21:05 INFO - PROCESS | 3820 | |7;imaging-desaturate;94;98;95;95;95;96;95;95;96;96 05:21:05 INFO - PROCESS | 3820 | |8;json-parse-financial;57;61;57;57;58;57;56;86;56;54 05:21:05 INFO - PROCESS | 3820 | |9;json-stringify-tinderbox;60;61;61;60;60;60;60;62;61;61 05:21:05 INFO - PROCESS | 3820 | |10;stanford-crypto-aes;76;77;76;77;84;78;78;80;87;79 05:21:05 INFO - PROCESS | 3820 | |11;stanford-crypto-ccm;127;137;133;126;127;125;126;125;159;129 05:21:05 INFO - PROCESS | 3820 | |12;stanford-crypto-pbkdf2;171;167;171;171;175;171;167;168;175;163 05:21:05 INFO - PROCESS | 3820 | |13;stanford-crypto-sha256-iterative;70;68;69;69;76;71;69;68;69;68 05:21:05 INFO - PROCESS | 3820 | __end_tp_report 05:21:05 INFO - PROCESS | 3820 | __start_cc_report 05:21:05 INFO - PROCESS | 3820 | _x_x_mozilla_cycle_collect,850 05:21:05 INFO - PROCESS | 3820 | __end_cc_report 05:21:05 INFO - PROCESS | 3820 | __startTimestamp1460809265772__endTimestamp 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | ------- Summary: start ------- 05:21:05 INFO - PROCESS | 3820 | Number of tests: 14 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.38 (3.9%) stddev-sans-first:4.60 05:21:05 INFO - PROCESS | 3820 | Values: 113.0 105.0 113.0 110.0 110.0 122.0 110.0 109.0 112.0 110.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:154.50 stddev:21.80 (14.1%) stddev-sans-first:23.12 05:21:05 INFO - PROCESS | 3820 | Values: 154.0 131.0 154.0 191.0 138.0 155.0 162.0 128.0 182.0 129.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.35 (1.4%) stddev-sans-first:2.35 05:21:05 INFO - PROCESS | 3820 | Values: 161.0 162.0 162.0 162.0 163.0 168.0 166.0 161.0 165.0 162.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#3] audio-fft Cycles:10 Average:91.90 Median:73.00 stddev:37.55 (51.4%) stddev-sans-first:39.20 05:21:05 INFO - PROCESS | 3820 | Values: 73.0 73.0 74.0 165.0 80.0 75.0 72.0 73.0 161.0 73.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.50 stddev:26.83 (29.0%) stddev-sans-first:27.75 05:21:05 INFO - PROCESS | 3820 | Values: 92.0 93.0 157.0 92.0 93.0 92.0 138.0 93.0 93.0 147.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:21:05 INFO - PROCESS | 3820 | Values: 118.0 119.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:21:05 INFO - PROCESS | 3820 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 148.0 146.0 147.0 146.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:1.08 (1.1%) stddev-sans-first:1.00 05:21:05 INFO - PROCESS | 3820 | Values: 94.0 98.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:57.00 stddev:9.34 (16.4%) stddev-sans-first:9.85 05:21:05 INFO - PROCESS | 3820 | Values: 57.0 61.0 57.0 57.0 58.0 57.0 56.0 86.0 56.0 54.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 05:21:05 INFO - PROCESS | 3820 | Values: 60.0 61.0 61.0 60.0 60.0 60.0 60.0 62.0 61.0 61.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.50 stddev:3.61 (4.6%) stddev-sans-first:3.64 05:21:05 INFO - PROCESS | 3820 | Values: 76.0 77.0 76.0 77.0 84.0 78.0 78.0 80.0 87.0 79.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:128.00 stddev:10.44 (8.2%) stddev-sans-first:10.95 05:21:05 INFO - PROCESS | 3820 | Values: 127.0 137.0 133.0 126.0 127.0 125.0 126.0 125.0 159.0 129.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:171.00 stddev:3.73 (2.2%) stddev-sans-first:3.93 05:21:05 INFO - PROCESS | 3820 | Values: 171.0 167.0 171.0 171.0 175.0 171.0 167.0 168.0 175.0 163.0 05:21:05 INFO - PROCESS | 3820 | 05:21:05 INFO - PROCESS | 3820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:2.41 (3.5%) stddev-sans-first:2.55 05:21:05 INFO - PROCESS | 3820 | Values: 70.0 68.0 69.0 69.0 76.0 71.0 69.0 68.0 69.0 68.0 05:21:05 INFO - PROCESS | 3820 | -------- Summary: end -------- 05:21:05 INFO - PROCESS | 3820 | 05:21:06 INFO - TEST-INFO | 3820: exit 0 05:21:06 INFO - TEST-OK | kraken | took 61784ms 05:21:06 INFO - SUITE-END | took 1173s 05:21:06 INFO - Completed test suite (00:19:33) 05:21:06 INFO - javascript benchmark 05:21:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.1991482214626, 3153.4796758534844, 3160.352127813797, 3187.7290430313424, 3202.183443221978, 5434.782608695652, 5462.371827239858, 5473.835784926454, 5501.202325662776, 5504.4495550444935, 5386.622936394454, 5499.0, 5520.641158324706, 5555.527780138683, 5604.299462567179, 4982.327385802915, 5028.220625803006, 5092.083424983502, 5101.183810590306, 5147.510986456281, 366.3405088062622, 4836.984233311009, 4949.034938187055, 5049.3435853339015, 5097.974510127444, 4946.035523073002, 4969.478204788481, 4995.35060442142, 4995.975824955894, 4998.875028124289, 4988.127077761377, 5000.1249781288125, 5004.099262132815, 5010.323606313137, 5023.120953833065, 4939.0, 4976.2286845539, 4980.676256043345, 4982.526659967298, 5032.295478632995, 5376.11294136467, 5403.162509810946, 5413.404525502192, 5435.972820135914, 5437.782488700487, 5638.859028524279, 5777.59556831022, 5843.824685259449, 5865.472107510344, 5879.0593505039415, 5844.0, 5844.357120716718, 5865.178874957509, 5879.3826648202175, 6007.3992600739575, 5443.237946687467, 5448.863778405532, 5449.809256675997, 5452.972735136299, 5452.972735136339, 5945.227120474397, 5970.671613061323, 6005.768817392424, 6054.909176362358, 6100.176476175659, 5768.3654797972185, 5772.682502462321, 5782.132680097935, 5788.681622510802, 5810.099434587646, 5875.353711091777, 5894.263217097863, 5896.1450589664255, 5898.262717160355, 5903.911441328383, 5803.564732645069, 5831.708414579254, 5883.0293001654245, 5884.617499862496, 5935.376785437553, 5721.456461636138, 5737.540996720252, 5782.566307526952, 5797.4782269595935, 5807.564432667482, 4332.090261045216, 4391.494978077498, 4400.559944005574, 4401.537838526972, 4447.822087116479, 3876.6704830089193, 3909.139989202371, 3952.4071389291835, 3979.462772525672, 4013.779242141652, 5511.090670039479, 5535.8339249821765, 5591.273134492571, 5648.265725455664, 5661.065924122474, 5952.583319167703, 6012.368701286389, 6017.338092809788, 6019.729112189962, 6020.217371741734, 5471.206675032098, 5579.497845193952, 5624.100143976944, 5626.465485778845, 5680.40355762639, 5002.774875130628, 5036.11867923112, 5049.722265275445, 5052.115879721034, 5066.417362003343, 5879.059350503899, 6080.14877917092, 6091.878162436727, 6092.482139018233, 6100.267967843798, 5927.673977931255, 6015.428534289235, 6023.066424704178, 6029.78895738647, 6039.245094363205, 5950.9404905952115, 5964.582479226586, 5983.611065280743, 6021.909671355021, 6113.786017489544, 5620.4660557247, 5758.107493338372, 5815.447532484407, 5815.79644712433, 5826.650400975955, 5886.705664716661, 5897.5576831736935, 5909.940900590939, 5910.674912879833, 5953.196318497121, 5667.801626943037, 5677.460641239241, 5681.573881958787, 5719.799807006735, 5760.0783874579865, 5569.19246709233, 5676.858078548069, 5709.343425505954, 5716.5426765859465, 5723.399043100415, 5538.667679939216, 5548.805791797267, 5560.2493663356545, 5589.217509548747, 5620.241267428844, 5704.600677952503, 5731.742071606871, 5767.192593037062, 5768.884622307614, 5782.971085144715, 5456.072467680583, 5527.861803454945, 5579.804706835242, 5654.378018417889, 5668.943310566841], "value": 5366.9743529589605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.0872638683651, 650.9056186852906, 653.7777155767038, 657.9539432239744, 673.8349104469406, 35105.0, 35977.0, 36176.0, 36200.0, 36430.453543196876, 37095.81452092736, 37203.81398093013, 37628.05929851755, 37661.24677506448, 37715.057123571925, 8432.325413966882, 8491.15088491149, 8506.276966457859, 8569.143085691412, 8587.313014958789, 8292.875606865902, 8594.484330940164, 8599.742007739778, 8602.053774084878, 8661.783455413602, 8631.870521942175, 8670.653173873037, 8671.739847804576, 8706.129387061275, 8709.60806763694, 8547.10255423181, 8550.230479256834, 8593.26957208638, 8606.31149508038, 8640.697575584856, 8530.914690853075, 8648.870266946002, 8691.521966291852, 8733.694320698809, 8793.428427152214, 32777.0, 37791.811040944616, 38054.61945380566, 38122.23755524902, 38132.0, 3313.6686331366914, 3348.933234737984, 3555.7510974231814, 3617.0776452004834, 3665.2119794244363, 29816.254593635116, 30314.54528182079, 30328.019879389067, 30336.69663303383, 30455.23861903448, 4044.6562042226446, 4074.225897079575, 4093.8771836844944, 4106.07613287011, 4130.401091841696, 234540.0, 238932.0, 241172.0, 241812.0, 304473.0, 63072.36927630757, 63239.36760632427, 63726.681366593795, 63727.85768925005, 63737.36262637407, 68348.6582567084, 70279.64860175768, 70495.64752176206, 70519.0, 70524.64737676381, 15550.688986220212, 15664.843351566338, 15699.68600627981, 15710.9214453927, 15822.208889555477, 11949.820752688716, 12059.397030148457, 12083.154179207371, 12172.2696638202, 12218.022558195324, 19795.60408791816, 20144.49638759043, 20403.0, 21004.369868903956, 21034.47413814667, 7906.920930790733, 7944.721934732373, 7989.360851132012, 8020.796880467977, 8073.6366863491285, 1034.3535290443472, 1122.2480937771713, 1131.7906187355366, 1158.3050169897995, 1244.6950497128262, 31569.684303157133, 31700.9657306966, 31835.681643183736, 31876.0, 31922.0, 1146.9025132863633, 1185.9644210673694, 1191.976160476803, 1298.558490113366, 1299.330844615024, 17059.658806823794, 17074.317027318768, 17163.313467461412, 17241.0, 17396.21717022737, 431591.0, 438126.0, 441625.0, 442370.0, 443103.0, 57265.713671431375, 58267.70866145727, 58445.70777146172, 58568.0, 58640.12039819406, 1322.081153598259, 1323.5499930023645, 1358.864113588653, 1389.485890220625, 1423.3310344138238, 29921.551176732803, 30628.540571891885, 30660.233494162825, 31968.840155799073, 32495.35009299848, 51088.489115109856, 51917.96164076622, 52122.47877521176, 52310.47689523056, 52328.215076773115, 402500.0, 405550.0, 410258.0, 412763.0, 414187.0, 42645.42071480282, 43676.34485482784, 45013.0, 45121.54878451305, 45243.32135017912, 48053.0, 48429.273560897316, 48766.0, 49070.26394604155, 49652.50347496623, 40862.79568602138, 41948.79025604852, 42046.15907681768, 42127.57872421236, 42976.57023429726, 40722.389164163156, 41265.0, 41330.380044298756, 42207.0, 42393.0, 42460.363094554225, 42578.0, 42820.14359712726, 43061.0, 43170.0, 34718.82640586781, 36637.26725465422, 36899.376696340565, 37080.25839483249, 37128.81435592805, 28226.71773282241, 28414.57378139371, 28478.145655630364, 28616.713832861406, 29159.562606560496], "value": 19993.173319515263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.6053946053947, 394.7868151198353, 398.4004073868827, 405.1532297498229, 407.49674152421755, 14123.505677301297, 17916.731249031258, 18358.632827343445, 18420.355287564922, 18561.907190464062, 17933.282668693235, 17937.282508699638, 17948.64102717948, 18347.633047339044, 18744.906275468602, 5053.191489361703, 5466.9179962300595, 5683.204351390808, 5704.087346024637, 5756.338021127561, 5648.378678345379, 5663.886722265553, 5666.405027472118, 5676.148577713356, 5703.857403564903, 5448.182772584105, 5595.300587426572, 5653.321601407837, 5705.2012718219485, 5711.71441427929, 5645.943540564583, 5663.745131469093, 5671.035923892928, 5671.092625179972, 5689.658620482764, 4790.42514898211, 5066.442691303953, 5068.087744206042, 5072.416672082684, 5074.59403247743, 21708.240211592678, 22636.434089147904, 22740.0, 22986.655200171845, 23036.308910732703, 2382.892769825362, 2421.2131057406414, 2444.095684596693, 2444.6333050042635, 2548.286479785663, 13524.391402386917, 14231.644208894757, 14377.56867293983, 14383.78424323636, 14646.780298295535, 1931.198552600669, 1988.2345297060592, 2004.8295894848955, 2008.8895110768901, 2054.445299769069, 79557.60221198914, 80220.99999999942, 80365.19634803636, 80814.0, 81690.59154704188, 10001.949990250003, 10288.0, 10334.379937203792, 10507.737306567244, 10537.63118290856, 14530.491432799801, 14563.563093107012, 14581.781273280909, 14618.488352907598, 14642.487512936996, 7890.053193616688, 7897.289243967955, 7950.681972721027, 7963.800904977422, 8055.073666528307, 7697.8845317319165, 7727.343175830005, 7744.0707115145415, 7773.92226077732, 7795.766127016199, 6258.405451482102, 6436.452901503425, 6474.546781725328, 6530.0, 6591.0, 1850.4818650777804, 1850.8704390692521, 1860.135037207705, 1901.077977181066, 1926.9325573605138, 973.5229737428609, 1067.32225037102, 1101.262154356583, 1102.0487184960548, 1138.7608602193466, 18656.81343186578, 18761.0, 19356.516087097934, 19472.318468853522, 19614.509637258896, 1050.2490719135856, 1088.4938503595865, 1092.7377429416883, 1111.4165063341811, 1124.44901998022, 10840.891591083988, 11183.273087249465, 11185.94407027976, 11202.831957520644, 11225.214235003634, 474646.0, 477732.0, 483387.0, 485388.0, 485487.0, 62320.0, 77318.0, 78489.60755196188, 80041.19958800338, 81812.18187818164, 1075.8762742284737, 1077.4020418667558, 1097.0948967102013, 1111.2388014210292, 1113.9387333696725, 17680.115994200496, 17789.822101778816, 17794.91102544479, 17800.55498612545, 18035.549111272325, 36334.454983175805, 36461.817690911375, 36931.63068369282, 36996.26007479889, 37329.44005839969, 48630.513694862595, 48873.0, 49639.0, 49750.25374619456, 50740.0, 8048.0, 8447.493150410995, 8458.450200736932, 8493.938257717786, 8528.488290702579, 12760.48958041705, 12859.742805144031, 12894.548690795777, 13034.608961731163, 13268.80096798568, 11395.715107122056, 11475.770484590428, 11485.655430337103, 11652.30086194831, 11733.413329333669, 11295.943520282346, 11513.712157196138, 11622.0, 11740.58907938218, 11811.350375729417, 11772.293662380285, 11816.113791465847, 12082.09384296199, 12091.274523528617, 12133.878661213275, 8110.959445202736, 8137.471064380797, 8164.142765009588, 8227.382946279173, 8250.958745206235, 11290.43547822622, 11314.321140731583, 11356.488957996744, 11476.598319058792, 11665.0], "value": 9195.30274120139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.5156825599931, 1557.6105973506624, 1738.6783445062665, 1799.973000404995, 1864.2170288478837, 7598.582077985709, 8104.675812967482, 8305.086440491541, 8309.50142991421, 8357.331413486922, 8300.584970751454, 8333.708320208794, 8339.54132522711, 8408.957955210231, 8429.199226073528, 2308.6306191009444, 2316.664083707861, 2319.1071437496516, 2330.627099664054, 2333.5332933413383, 2304.331743794306, 2311.9884400577976, 2352.5765362234793, 2355.0462062864567, 2355.3875992242056, 2305.9192928247517, 2307.3539408965516, 2314.3057082875152, 2317.629179331307, 2321.2339927823778, 2271.034810205664, 2273.318004598622, 2274.1130958925864, 2277.840551161419, 2284.520250747345, 2243.5064285857084, 2256.2103263857684, 2261.1520679745095, 2263.7736226377397, 2272.988635056814, 8395.874061889077, 8504.362172837062, 8514.787130321729, 8541.82916341676, 8544.914550854473, 5029.622778291643, 5206.895862082737, 5216.139337009389, 5219.895602087975, 5230.0, 3253.544503769474, 3285.655006224336, 3352.916177095568, 3362.6469220731715, 3396.3037577296595, 1078.563181911327, 1084.4089970965763, 1094.895984881435, 1108.905743011845, 1118.72031992002, 11667.766644667145, 11747.765044699057, 11761.176717629769, 11786.646400607995, 11796.0, 4440.644748420119, 4573.885652858705, 4586.1057093866375, 4672.135654903854, 4693.48371679115, 9855.31012829095, 9986.101250887456, 10022.498875056219, 10057.14514266281, 10084.798304033879, 5152.896942061137, 5193.350831146106, 5225.608079394061, 5243.344581927259, 5258.894822103536, 4140.482439695038, 4711.128441238382, 4811.4707382187935, 4830.347903033045, 4835.58897493717, 3874.244522318177, 3893.377059670439, 3977.5823538528616, 3991.44119823225, 4018.216447792711, 1282.6857419932176, 1299.8375203099613, 1302.4920281090383, 1302.5050480817229, 1304.6803533134444, 931.4783721116197, 989.559645957542, 1006.33079002464, 1021.6322124035341, 1034.5809946971488, 5787.942120578825, 5883.264591926009, 5966.343702192756, 6019.789307374309, 6061.363556826558, 436.03853503025755, 439.936209249657, 458.8002373792575, 468.89918667486654, 469.40854523300885, 4089.6728261739586, 4260.8495706159165, 4261.126469073833, 4276.2089013532595, 4279.850205242801, 9762.560684769202, 10234.48827558619, 10285.640002600023, 10290.845637315446, 10296.742581435525, 9360.765980850534, 9760.804783904283, 9862.358946668444, 9982.850257246148, 10105.696829095139, 7423.591702456417, 7524.322810947041, 7548.207438219018, 7553.773386798514, 7593.810154746065, 5713.514351280188, 5762.596618236851, 5768.94231057684, 5869.765209391577, 6010.669413182317, 9271.814563708553, 9384.296177786557, 9428.292878034037, 9503.192228660364, 9517.428954262767, 9370.156685898302, 9410.38832475887, 9606.0, 9654.27592930519, 9745.074217949283, 6941.409980151744, 6970.302969702989, 7123.608201548965, 7266.382357499671, 7417.592032438268, 7801.570913599807, 7803.804904877424, 7843.137254901842, 7851.803704907423, 7883.487573307717, 6859.9314006859295, 7086.645667716697, 7102.112235970504, 7159.0, 7205.171405288249, 7063.293670633101, 7101.183363913216, 7144.4641651877355, 7174.569525828467, 7175.282471752992, 6256.343083976117, 6402.0, 6573.605583664996, 6585.934140658724, 6591.307912669101, 4869.366982292279, 4877.5366340197625, 4908.263760435963, 4952.851414457572, 4957.107720610325, 4913.582345500672, 4921.237208232729, 4936.481669424802, 4940.2342636891335, 4946.530079642428], "value": 4412.797983531696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6423266523156, 332.1198823118735, 336.59104188411084, 338.8525991193831, 340.5674793012875, 5763.5389168866495, 5913.0, 5915.822525324236, 6054.727537260817, 6083.300420451649, 5893.616914900528, 6014.188084608577, 6015.939840601593, 6037.486813620848, 6058.485028772559, 4579.885502862438, 4589.724616523019, 4596.149712303226, 4642.373279607261, 4647.047355292174, 4363.214621368168, 4561.954380456203, 4566.49768525462, 4597.08058388322, 4654.0, 4481.686281960264, 4538.773061346919, 4544.272916333387, 4544.363789069533, 4551.931721024171, 4555.407796986387, 4556.931646025312, 4561.247394179956, 4570.245909424924, 4581.79381927814, 3871.825767840454, 3912.960870391288, 3935.5080614923136, 3965.801709914522, 3972.980135099335, 5728.627639203439, 5744.167095771131, 5756.971215143939, 5762.654240745569, 5791.305043394777, 5237.921431178535, 5239.947600523984, 5243.9213411798855, 5252.57979361654, 5267.683938963674, 6009.789657361971, 6197.419657987184, 6261.21196676009, 6294.559380843343, 6331.303556608769, 4273.145370925796, 4277.080427708027, 4280.079782846703, 4287.48550173978, 4299.828006879752, 6275.7489700411925, 6498.772542961021, 6584.913489274264, 6595.736170553172, 6634.668266586651, 4495.325701144854, 4524.434445694288, 4529.479109902403, 4536.319552067216, 4546.636269098464, 4624.676272660881, 4625.398698169217, 4626.259798432302, 4633.72197668141, 4636.374089497942, 5073.543381095646, 5315.282436870973, 5337.572994160458, 5346.9038847037045, 5355.7054362009685, 6068.362821903725, 6198.597091189058, 6216.564840461125, 6377.139086223393, 6382.457491113215, 1595.4176725495342, 1609.8953568018042, 1623.3750006247444, 1626.7966504186977, 1639.2049855819919, 1083.34999000599, 1084.2735367303926, 1099.4228030284005, 1101.1411099342527, 1109.9056580190775, 6111.297200821873, 6111.327753947062, 6135.913789311656, 6137.9079313810325, 6193.287771906198, 6489.286178520359, 6491.902621460682, 6495.4803615710625, 6506.837329066811, 6535.836604084936, 5900.937831190341, 6118.0, 6178.969105154535, 6179.16581261533, 6203.844903877349, 3481.4429691249784, 3484.686378225972, 3487.982560087234, 3498.3877821381157, 3512.5609298837644, 6561.212654481493, 6688.3646053624825, 6749.3250674932115, 6782.593044417351, 6816.897746533806, 6579.078928949951, 6637.369449902251, 6647.66761661915, 6675.831729447327, 6706.22878368984, 6576.80269591913, 6587.835304117435, 6645.269020407752, 6691.966540167366, 6720.428763555153, 6418.19772528434, 6512.381323774234, 6517.934820651923, 6522.902156467562, 6525.673716314261, 6262.780802671885, 6301.779437719658, 6328.303886572566, 6344.30212676596, 6460.289368169404, 6678.699458524281, 6684.231313399021, 6739.528233023641, 6743.2582415935185, 6759.628220447923, 4592.540745925381, 4594.632429405707, 4601.838935637236, 4624.3294722265755, 4628.791704373379, 6266.154069200599, 6324.2410910691015, 6414.5189110815945, 6471.482281417381, 6539.574927629689, 6314.684265786784, 6336.968315158395, 6416.262129855127, 6417.711202995783, 6436.066770318184, 6186.412290832363, 6355.841103972438, 6363.936360636334, 6368.42684158428, 6374.458171055512, 6177.62934223948, 6184.721687523982, 6187.319394866651, 6189.535784816067, 6190.133381326528, 6415.230172379344, 6422.582532135396, 6431.710573024132, 6452.257990331172, 6459.773907913201, 5965.522758179422, 6221.813345599639, 6281.96859015702, 6290.622562646073, 6308.905366419415], "value": 4772.705686756262, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.853326401248, 820.2207902492634, 862.5126803356103, 876.73259655805, 883.885094937658, 13629.182249065063, 14405.63985900353, 14621.561353159408, 14622.48821291255, 14689.559313220621, 12178.147529672926, 13367.866321336784, 13499.190048597091, 13500.932495337534, 13502.527411540597, 804.3203493048379, 831.8876951611516, 832.7376876283951, 835.5947365527715, 837.9916200838005, 824.085265355455, 831.6382373667444, 834.5535138700797, 837.0750320895414, 842.3640151685469, 865.5888452984844, 866.4844417571567, 874.8119154381807, 875.4047247871445, 879.9296056315511, 855.7261676263598, 858.2533196119385, 859.1923591823665, 866.8613021916526, 868.0971789339111, 627.2253766598247, 630.9432151106377, 633.2084893882646, 633.8763941031501, 633.9144215530937, 14440.927795361062, 14453.71092578153, 14469.348879300456, 14498.492552760708, 14561.271936403138, 13171.538996135185, 13244.337783110806, 13337.466501339935, 13509.932450337783, 13539.458421663121, 11133.944330278297, 11219.326840389604, 11253.324800511995, 11404.771904561861, 11440.19918605698, 3861.2856621524825, 3887.9611203888167, 3897.5907529709257, 3937.212557488485, 3959.762414255154, 54381.728091359684, 56063.71968140174, 56371.71814140944, 56392.0, 59006.70496647489, 11000.284981476338, 11313.490892909838, 11353.545858165746, 11423.428828558539, 11545.769084618261, 19466.124024418936, 19808.108635111454, 19920.0, 19934.50163745918, 19937.401877943685, 8198.0, 8262.504249745034, 8278.130796266305, 8381.874271885927, 8549.102344253764, 4497.730136191839, 4660.39414876064, 4664.906701865943, 4764.237721964469, 4773.069251495925, 3203.2152122729613, 3271.9509207361907, 3273.3126043530647, 3284.244623736506, 3292.9506057409158, 636.3604577399684, 662.3806740697368, 674.1842370731372, 676.0839063069568, 692.715986445565, 763.7441457111819, 764.3044829205396, 788.2078511096312, 798.9680412783424, 817.2807929022422, 9270.675526356545, 9698.175655069399, 9737.659181928599, 9746.61013559464, 9758.804823903482, 688.5524409134102, 722.1550785580883, 748.296601194875, 761.8704820180583, 781.0822283816493, 4470.687051906335, 4601.585857272861, 4636.976815115903, 4748.810047598057, 4778.4982576829625, 65241.673791631685, 65820.34179658142, 68190.3180968184, 68365.3163468359, 68536.0, 56446.717766410904, 57169.0, 58407.0, 58483.122753158736, 60011.0, 52629.0, 53791.731041344545, 54336.45663543393, 54471.45528544743, 54763.72618136884, 8758.343124265579, 8790.34072444582, 8827.029026806918, 8866.20204181601, 8880.600372983361, 34857.0, 35445.82277088598, 35933.28133437369, 36072.0, 36266.63733362633, 44760.0, 45845.77077114593, 46420.0, 46912.53087469218, 47540.28689569728, 11308.264962777394, 11974.101942354184, 12077.818832717692, 12245.081618878798, 12458.377081146087, 13290.401931912893, 13295.933520332337, 13330.866691332962, 13839.30803459843, 14206.360713768112, 13076.738465230452, 13430.664233394244, 13480.93259533696, 13858.16850988944, 13862.306884655929, 12653.810192847299, 12699.746005079662, 12960.0, 13398.799018014543, 13886.583402497941, 13195.60413187606, 13215.405306761411, 13531.391087400894, 13917.72164556683, 13986.930065349608, 10922.508487118257, 11012.293879904713, 11012.339259644446, 11134.164937629548, 11396.430178491208, 10517.421541814967, 10880.238383313408, 10977.3962432067, 11306.265092768943, 11356.148288878201], "value": 6935.78474863888, "unit": "score"}], "name": "dromaeo_css", "value": 7241.006480511114, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 113.0, 110.0, 110.0, 122.0, 110.0, 109.0, 112.0, 110.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 154.0, 191.0, 138.0, 155.0, 162.0, 128.0, 182.0, 129.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 163.0, 168.0, 166.0, 161.0, 165.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 165.0, 80.0, 75.0, 72.0, 73.0, 161.0, 73.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 157.0, 92.0, 93.0, 92.0, 138.0, 93.0, 93.0, 147.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 57.0, 57.0, 58.0, 57.0, 56.0, 86.0, 56.0, 54.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 77.0, 84.0, 78.0, 78.0, 80.0, 87.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 137.0, 133.0, 126.0, 127.0, 125.0, 126.0, 125.0, 159.0, 129.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 171.0, 171.0, 175.0, 171.0, 167.0, 168.0, 175.0, 163.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 76.0, 71.0, 69.0, 68.0, 69.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1558.4000000000003, "alertThreshold": 2.0}]} 05:21:07 INFO - Return code: 0 05:21:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:21:07 ERROR - # TBPL SUCCESS # 05:21:07 INFO - Running post-action listener: _resource_record_post_action 05:21:07 INFO - Running post-run listener: _resource_record_post_run 05:21:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7790592; Write bytes: 466694144; Read time: 1464; Write time: 388752 05:21:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20410368; Read time: 0; Write time: 6168 05:21:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6029312; Write bytes: 446283776; Read time: 1388; Write time: 382584 05:21:08 INFO - Running post-run listener: _upload_blobber_files 05:21:08 INFO - Blob upload gear active. 05:21:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:21:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:21:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:09 INFO - (blobuploader) - INFO - Done attempting. 05:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:10 INFO - (blobuploader) - INFO - Done attempting. 05:21:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:10 INFO - Return code: 0 05:21:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:21:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c2c3346bfee9fdf7f592f952dffcabd6ec114421ca22d04070d3d1a7884965c26eb9d742ab504a1155f3b40ab0a6999769157b027339a7f2f5400a8e46ee3d28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4606d01b0b34030bccf14579a9e8dbceff85c03a59829e73fc9d5d451dac88f519a712b73be4ade1a9e32476affcc5c98cb3d1340c7720179f5c58b2af42f17f"} 05:21:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:21:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:21:10 INFO - Contents: 05:21:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c2c3346bfee9fdf7f592f952dffcabd6ec114421ca22d04070d3d1a7884965c26eb9d742ab504a1155f3b40ab0a6999769157b027339a7f2f5400a8e46ee3d28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4606d01b0b34030bccf14579a9e8dbceff85c03a59829e73fc9d5d451dac88f519a712b73be4ade1a9e32476affcc5c98cb3d1340c7720179f5c58b2af42f17f"} 05:21:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:21:10 INFO - Copying logs to upload dir... 05:21:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:21:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.710951 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-16 05:21:10.140150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 05:21:10.143578) ========= 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=d2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843 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/c2c3346bfee9fdf7f592f952dffcabd6ec114421ca22d04070d3d1a7884965c26eb9d742ab504a1155f3b40ab0a6999769157b027339a7f2f5400a8e46ee3d28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4606d01b0b34030bccf14579a9e8dbceff85c03a59829e73fc9d5d451dac88f519a712b73be4ade1a9e32476affcc5c98cb3d1340c7720179f5c58b2af42f17f"} build_url:https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/RQLc1CwqTXqqWNGJnezeBA/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/c2c3346bfee9fdf7f592f952dffcabd6ec114421ca22d04070d3d1a7884965c26eb9d742ab504a1155f3b40ab0a6999769157b027339a7f2f5400a8e46ee3d28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4606d01b0b34030bccf14579a9e8dbceff85c03a59829e73fc9d5d451dac88f519a712b73be4ade1a9e32476affcc5c98cb3d1340c7720179f5c58b2af42f17f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 05:21:10.168105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:21:10.168416) ========= 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=d2a8c569965ab8367867b893000001a1-1460803175.510253-1922445843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:21:10.251820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 05:21:10.252153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 05:21:10.252448) ========= ========= Total master_lag: 0.18 =========