builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1467103890.21 results: success (0) buildid: 20160627144420 builduid: 4360f4d245a549be90444bafc60905d0 revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.207779) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.208321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.208638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.281750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.282207) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 01:51:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-06-28 01:51:30 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.420308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.420706) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022952 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:30.474942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:51:30.477380) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --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=20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:51:30,647 truncating revision to first 12 chars 2016-06-28 01:51:30,647 Setting DEBUG logging. 2016-06-28 01:51:30,647 attempt 1/10 2016-06-28 01:51:30,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/676a32cdd41f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:51:31,414 unpacking tar archive at: mozilla-beta-676a32cdd41f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 01:51:31.576289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.576645) ========= script_repo_revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.577113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.577619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:51:31.590846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-28 01:51:31.591178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:51:31 INFO - MultiFileLogger online at 20160628 01:51:31 in /builds/slave/test 01:51:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:51:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:51:31 INFO - {'append_to_log': False, 01:51:31 INFO - 'base_work_dir': '/builds/slave/test', 01:51:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:51:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:51:31 INFO - 'branch': 'Mozilla-Beta', 01:51:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:51:31 INFO - 'config_files': ('talos/linux_config.py',), 01:51:31 INFO - 'default_actions': ('clobber', 01:51:31 INFO - 'read-buildbot-config', 01:51:31 INFO - 'download-and-extract', 01:51:31 INFO - 'populate-webroot', 01:51:31 INFO - 'create-virtualenv', 01:51:31 INFO - 'install', 01:51:31 INFO - 'run-tests'), 01:51:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:51:31 INFO - 'download_minidump_stackwalk': True, 01:51:31 INFO - 'download_symbols': 'ondemand', 01:51:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:51:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:51:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:51:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:51:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:51:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:51:31 INFO - 'installer_path': 'installer.exe', 01:51:31 INFO - 'log_level': 'info', 01:51:31 INFO - 'log_name': 'talos', 01:51:31 INFO - 'log_to_console': True, 01:51:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:51:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:51:31 INFO - 'opt_config_files': (), 01:51:31 INFO - 'pip_index': False, 01:51:31 INFO - 'sps_profile': False, 01:51:31 INFO - 'sps_profile_interval': 0, 01:51:31 INFO - 'suite': 'dromaeojs-e10s', 01:51:31 INFO - 'system_bits': '32', 01:51:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:51:31 INFO - 'title': 'talos-linux64-ix-015', 01:51:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:51:31 INFO - 'use_talos_json': True, 01:51:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:51:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:51:31 INFO - 'work_dir': 'build'} 01:51:31 INFO - ##### 01:51:31 INFO - ##### Running clobber step. 01:51:31 INFO - ##### 01:51:31 INFO - Running pre-action listener: _resource_record_pre_action 01:51:31 INFO - Running main action method: clobber 01:51:31 INFO - rmtree: /builds/slave/test/build 01:51:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:51:32 INFO - Running post-action listener: _resource_record_post_action 01:51:32 INFO - ##### 01:51:32 INFO - ##### Running read-buildbot-config step. 01:51:32 INFO - ##### 01:51:32 INFO - Running pre-action listener: _resource_record_pre_action 01:51:32 INFO - Running main action method: read_buildbot_config 01:51:32 INFO - Using buildbot properties: 01:51:32 INFO - { 01:51:32 INFO - "project": "", 01:51:32 INFO - "product": "firefox", 01:51:32 INFO - "script_repo_revision": "production", 01:51:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 01:51:32 INFO - "repository": "", 01:51:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 01:51:32 INFO - "buildid": "20160627144420", 01:51:32 INFO - "pgo_build": "True", 01:51:32 INFO - "basedir": "/builds/slave/test", 01:51:32 INFO - "buildnumber": 153, 01:51:32 INFO - "slavename": "talos-linux64-ix-015", 01:51:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:51:32 INFO - "platform": "ubuntu64_hw", 01:51:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:51:32 INFO - "branch": "mozilla-beta", 01:51:32 INFO - "repo_path": "releases/mozilla-beta", 01:51:32 INFO - "revision": "676a32cdd41fd372f4c6df3a4954939f73a6ef02", 01:51:32 INFO - "stage_platform": "linux64-pgo", 01:51:32 INFO - "builduid": "4360f4d245a549be90444bafc60905d0", 01:51:32 INFO - "slavebuilddir": "test" 01:51:32 INFO - } 01:51:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 01:51:32 INFO - Running post-action listener: _resource_record_post_action 01:51:32 INFO - ##### 01:51:32 INFO - ##### Running download-and-extract step. 01:51:32 INFO - ##### 01:51:32 INFO - Running pre-action listener: _resource_record_pre_action 01:51:32 INFO - Running main action method: download_and_extract 01:51:32 INFO - mkdir: /builds/slave/test/build/tests 01:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:32 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:51:35 INFO - Downloaded 1327 bytes. 01:51:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 01:51:35 INFO - Using the following test package requirements: 01:51:35 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:51:35 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:51:35 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 01:51:35 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'jsshell-linux-x86_64.zip'], 01:51:35 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:51:35 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 01:51:35 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 01:51:35 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 01:51:35 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:51:35 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 01:51:35 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:51:35 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:51:35 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')]} 01:51:35 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:51:37 INFO - Downloaded 24236181 bytes. 01:51:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:51:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:51:38 INFO - Return code: 0 01:51:38 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:51:38 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')]} 01:51:38 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 01:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:51:39 INFO - Downloaded 24236181 bytes. 01:51:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:51:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:51:40 INFO - Return code: 0 01:51: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')]} 01:51:40 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 01:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:51:41 INFO - Downloaded 10840145 bytes. 01:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:51:42 INFO - Return code: 0 01:51:42 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')]} 01:51:42 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:51:43 INFO - Downloaded 56013298 bytes. 01:51:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:43 INFO - mkdir: /builds/slave/test/properties 01:51:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:51:43 INFO - Writing to file /builds/slave/test/properties/build_url 01:51:43 INFO - Contents: 01:51:43 INFO - build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 01:51:44 INFO - Running post-action listener: _resource_record_post_action 01:51:44 INFO - Running post-action listener: set_extra_try_arguments 01:51:44 INFO - ##### 01:51:44 INFO - ##### Running populate-webroot step. 01:51:44 INFO - ##### 01:51:44 INFO - Running pre-action listener: _resource_record_pre_action 01:51:44 INFO - Running main action method: populate_webroot 01:51:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:51:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:51:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:51:44 INFO - '--tppagecycles', 01:51:44 INFO - '7'], 01:51:44 INFO - 'tests': ['tsvgm']}}, 01:51:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:51:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:51:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:51:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:51:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:51:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['damp', 'tps']}, 01:51:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'tests': ['damp', 'tps']}, 01:51:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['dromaeo_dom']}, 01:51:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:51:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['a11yr', 01:51:44 INFO - 'ts_paint', 01:51:44 INFO - 'tpaint', 01:51:44 INFO - 'sessionrestore', 01:51:44 INFO - 'sessionrestore_no_auto_restore', 01:51:44 INFO - 'tabpaint']}, 01:51:44 INFO - 'other-e10s': {'tests': ['a11yr', 01:51:44 INFO - 'ts_paint', 01:51:44 INFO - 'tpaint', 01:51:44 INFO - 'sessionrestore', 01:51:44 INFO - 'sessionrestore_no_auto_restore', 01:51:44 INFO - 'tabpaint']}, 01:51:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:51:44 INFO - 'ts_paint', 01:51:44 INFO - 'tpaint', 01:51:44 INFO - 'sessionrestore', 01:51:44 INFO - 'sessionrestore_no_auto_restore', 01:51:44 INFO - 'tabpaint']}, 01:51:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:51:44 INFO - 'ts_paint', 01:51:44 INFO - 'tpaint', 01:51:44 INFO - 'sessionrestore', 01:51:44 INFO - 'sessionrestore_no_auto_restore', 01:51:44 INFO - 'tabpaint']}, 01:51:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['a11yr', 01:51:44 INFO - 'ts_paint', 01:51:44 INFO - 'tpaint', 01:51:44 INFO - 'sessionrestore', 01:51:44 INFO - 'sessionrestore_no_auto_restore', 01:51:44 INFO - 'tabpaint']}, 01:51:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['a11yr', 01:51:44 INFO - 'ts_paint', 01:51:44 INFO - 'tpaint', 01:51:44 INFO - 'sessionrestore', 01:51:44 INFO - 'sessionrestore_no_auto_restore', 01:51:44 INFO - 'tabpaint']}, 01:51:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['tsvgx', 01:51:44 INFO - 'tsvgr_opacity', 01:51:44 INFO - 'tart', 01:51:44 INFO - 'tscrollx', 01:51:44 INFO - 'cart']}, 01:51:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:51:44 INFO - 'tsvgr_opacity', 01:51:44 INFO - 'tart', 01:51:44 INFO - 'tscrollx', 01:51:44 INFO - 'cart']}, 01:51:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'talos_options': ['--disable-e10s'], 01:51:44 INFO - 'tests': ['tp5o']}, 01:51:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'tests': ['tp5o']}, 01:51:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'talos_options': ['--disable-e10s', 01:51:44 INFO - '--xperf_path', 01:51:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:44 INFO - 'tests': ['tp5n']}, 01:51:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:51:44 INFO - 'talos_options': ['--xperf_path', 01:51:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:51:44 INFO - 'tests': ['tp5n']}}, 01:51:44 INFO - 'talos.zip': {'path': '', 01:51:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:51:44 INFO - Running post-action listener: _resource_record_post_action 01:51:44 INFO - ##### 01:51:44 INFO - ##### Running create-virtualenv step. 01:51:44 INFO - ##### 01:51:44 INFO - Running pre-action listener: _resource_record_pre_action 01:51:44 INFO - Running main action method: create_virtualenv 01:51:44 INFO - Creating virtualenv /builds/slave/test/build/venv 01:51:44 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 01:51:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:51:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:51:44 INFO - Using real prefix '/usr' 01:51:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:51:44 INFO - Installing distribute.............................................................................................................................................................................................done. 01:51:46 INFO - Installing pip.................done. 01:51:46 INFO - Return code: 0 01:51:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:51:46 INFO - Using env: {'DISPLAY': ':0', 01:51:46 INFO - 'HOME': '/home/cltbld', 01:51:46 INFO - 'LANG': 'en_US.UTF-8', 01:51:46 INFO - 'LANGUAGE': 'en_US:en', 01:51:46 INFO - 'LOGNAME': 'cltbld', 01:51:46 INFO - 'MAIL': '/var/mail/cltbld', 01:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:46 INFO - 'MOZ_NO_REMOTE': '1', 01:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:46 INFO - 'NO_EM_RESTART': '1', 01:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:46 INFO - 'PWD': '/builds/slave/test', 01:51:46 INFO - 'SHELL': '/bin/bash', 01:51:46 INFO - 'SHLVL': '1', 01:51:46 INFO - 'TERM': 'linux', 01:51:46 INFO - 'TMOUT': '86400', 01:51:46 INFO - 'USER': 'cltbld', 01:51:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:46 INFO - '_': '/tools/buildbot/bin/python'} 01:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:51:46 INFO - Cleaning up... 01:51:46 INFO - Return code: 0 01:51:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:51:46 INFO - Using env: {'DISPLAY': ':0', 01:51:46 INFO - 'HOME': '/home/cltbld', 01:51:46 INFO - 'LANG': 'en_US.UTF-8', 01:51:46 INFO - 'LANGUAGE': 'en_US:en', 01:51:46 INFO - 'LOGNAME': 'cltbld', 01:51:46 INFO - 'MAIL': '/var/mail/cltbld', 01:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:46 INFO - 'MOZ_NO_REMOTE': '1', 01:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:46 INFO - 'NO_EM_RESTART': '1', 01:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:46 INFO - 'PWD': '/builds/slave/test', 01:51:46 INFO - 'SHELL': '/bin/bash', 01:51:46 INFO - 'SHLVL': '1', 01:51:46 INFO - 'TERM': 'linux', 01:51:46 INFO - 'TMOUT': '86400', 01:51:46 INFO - 'USER': 'cltbld', 01:51:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:46 INFO - '_': '/tools/buildbot/bin/python'} 01:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:47 INFO - Downloading/unpacking psutil>=0.7.1 01:51:47 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 01:51:47 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 01:51:47 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 01:51:47 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 01:51:47 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 01:51:47 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 01:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:51:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:49 INFO - Installing collected packages: psutil 01:51:49 INFO - Running setup.py install for psutil 01:51:49 INFO - building 'psutil._psutil_linux' extension 01:51:49 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 01:51:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:51:49 INFO - building 'psutil._psutil_posix' extension 01:51:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:51:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:51:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:51:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:51:49 INFO - Successfully installed psutil 01:51:49 INFO - Cleaning up... 01:51:49 INFO - Return code: 0 01:51:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:51:49 INFO - Using env: {'DISPLAY': ':0', 01:51:49 INFO - 'HOME': '/home/cltbld', 01:51:49 INFO - 'LANG': 'en_US.UTF-8', 01:51:49 INFO - 'LANGUAGE': 'en_US:en', 01:51:49 INFO - 'LOGNAME': 'cltbld', 01:51:49 INFO - 'MAIL': '/var/mail/cltbld', 01:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:49 INFO - 'MOZ_NO_REMOTE': '1', 01:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:49 INFO - 'NO_EM_RESTART': '1', 01:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:49 INFO - 'PWD': '/builds/slave/test', 01:51:49 INFO - 'SHELL': '/bin/bash', 01:51:49 INFO - 'SHLVL': '1', 01:51:49 INFO - 'TERM': 'linux', 01:51:49 INFO - 'TMOUT': '86400', 01:51:49 INFO - 'USER': 'cltbld', 01:51:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:49 INFO - '_': '/tools/buildbot/bin/python'} 01:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:51:51 INFO - Installing collected packages: mozsystemmonitor 01:51:51 INFO - Running setup.py install for mozsystemmonitor 01:51:51 INFO - Successfully installed mozsystemmonitor 01:51:51 INFO - Cleaning up... 01:51:51 INFO - Return code: 0 01:51:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:51:51 INFO - Using env: {'DISPLAY': ':0', 01:51:51 INFO - 'HOME': '/home/cltbld', 01:51:51 INFO - 'LANG': 'en_US.UTF-8', 01:51:51 INFO - 'LANGUAGE': 'en_US:en', 01:51:51 INFO - 'LOGNAME': 'cltbld', 01:51:51 INFO - 'MAIL': '/var/mail/cltbld', 01:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:51 INFO - 'MOZ_NO_REMOTE': '1', 01:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:51 INFO - 'NO_EM_RESTART': '1', 01:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:51 INFO - 'PWD': '/builds/slave/test', 01:51:51 INFO - 'SHELL': '/bin/bash', 01:51:51 INFO - 'SHLVL': '1', 01:51:51 INFO - 'TERM': 'linux', 01:51:51 INFO - 'TMOUT': '86400', 01:51:51 INFO - 'USER': 'cltbld', 01:51:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:51 INFO - '_': '/tools/buildbot/bin/python'} 01:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:52 INFO - Downloading/unpacking blobuploader==1.2.4 01:51:52 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 01:51:52 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 01:51:52 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 01:51:52 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 01:51:52 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 01:51:52 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 01:51:54 INFO - Downloading blobuploader-1.2.4.tar.gz 01:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:51:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:51:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:51:54 INFO - Downloading docopt-0.6.1.tar.gz 01:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:51:54 INFO - Installing collected packages: blobuploader, requests, docopt 01:51:54 INFO - Running setup.py install for blobuploader 01:51:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:51:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:51:54 INFO - Running setup.py install for requests 01:51:55 INFO - Running setup.py install for docopt 01:51:55 INFO - Successfully installed blobuploader requests docopt 01:51:55 INFO - Cleaning up... 01:51:55 INFO - Return code: 0 01:51:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:51:55 INFO - Using env: {'DISPLAY': ':0', 01:51:55 INFO - 'HOME': '/home/cltbld', 01:51:55 INFO - 'LANG': 'en_US.UTF-8', 01:51:55 INFO - 'LANGUAGE': 'en_US:en', 01:51:55 INFO - 'LOGNAME': 'cltbld', 01:51:55 INFO - 'MAIL': '/var/mail/cltbld', 01:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:55 INFO - 'MOZ_NO_REMOTE': '1', 01:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:55 INFO - 'NO_EM_RESTART': '1', 01:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:55 INFO - 'PWD': '/builds/slave/test', 01:51:55 INFO - 'SHELL': '/bin/bash', 01:51:55 INFO - 'SHLVL': '1', 01:51:55 INFO - 'TERM': 'linux', 01:51:55 INFO - 'TMOUT': '86400', 01:51:55 INFO - 'USER': 'cltbld', 01:51:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:55 INFO - '_': '/tools/buildbot/bin/python'} 01:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:55 INFO - Running setup.py (path:/tmp/pip-XqwFzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:55 INFO - Running setup.py (path:/tmp/pip-Dhxom4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:55 INFO - Running setup.py (path:/tmp/pip-LB5FAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:55 INFO - Running setup.py (path:/tmp/pip-AA9tNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:55 INFO - Running setup.py (path:/tmp/pip-3hdUaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:56 INFO - Running setup.py (path:/tmp/pip-br5JKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:51:56 INFO - Running setup.py (path:/tmp/pip-SqSiCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:56 INFO - Running setup.py (path:/tmp/pip-QHpSBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:56 INFO - Running setup.py (path:/tmp/pip-ifeJFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:51:56 INFO - Running setup.py (path:/tmp/pip-2JBfXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:51:56 INFO - Running setup.py (path:/tmp/pip-z4Qb0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:56 INFO - Running setup.py (path:/tmp/pip-yhPL31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:56 INFO - Running setup.py (path:/tmp/pip-dH2mWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:56 INFO - Running setup.py (path:/tmp/pip-Lv0LoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:56 INFO - Running setup.py (path:/tmp/pip-dvULaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:51:56 INFO - Running setup.py (path:/tmp/pip-OgP4wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:51:56 INFO - Running setup.py (path:/tmp/pip-f5B67O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:51:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:51:56 INFO - Running setup.py install for manifestparser 01:51:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for mozcrash 01:51:57 INFO - Running setup.py install for mozdebug 01:51:57 INFO - Running setup.py install for mozdevice 01:51:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for mozfile 01:51:57 INFO - Running setup.py install for mozhttpd 01:51:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for mozinfo 01:51:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for mozInstall 01:51:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for mozleak 01:51:57 INFO - Running setup.py install for mozlog 01:51:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:51:57 INFO - Running setup.py install for moznetwork 01:51:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozprocess 01:51:58 INFO - Running setup.py install for mozprofile 01:51:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozrunner 01:51:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Running setup.py install for mozscreenshot 01:51:58 INFO - Running setup.py install for moztest 01:51:58 INFO - Running setup.py install for mozversion 01:51:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:51:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:51:58 INFO - Cleaning up... 01:51:58 INFO - Return code: 0 01:51:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:51: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')]} 01:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51: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')]} 01:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:51:58 INFO - Using env: {'DISPLAY': ':0', 01:51:58 INFO - 'HOME': '/home/cltbld', 01:51:58 INFO - 'LANG': 'en_US.UTF-8', 01:51:58 INFO - 'LANGUAGE': 'en_US:en', 01:51:58 INFO - 'LOGNAME': 'cltbld', 01:51:58 INFO - 'MAIL': '/var/mail/cltbld', 01:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:58 INFO - 'MOZ_NO_REMOTE': '1', 01:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:58 INFO - 'NO_EM_RESTART': '1', 01:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:58 INFO - 'PWD': '/builds/slave/test', 01:51:58 INFO - 'SHELL': '/bin/bash', 01:51:58 INFO - 'SHLVL': '1', 01:51:58 INFO - 'TERM': 'linux', 01:51:58 INFO - 'TMOUT': '86400', 01:51:58 INFO - 'USER': 'cltbld', 01:51:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:58 INFO - '_': '/tools/buildbot/bin/python'} 01:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:51:58 INFO - Running setup.py (path:/tmp/pip-6KC5WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:51:58 INFO - Running setup.py (path:/tmp/pip-AeGIx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:51:59 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)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:51:59 INFO - Running setup.py (path:/tmp/pip-ux1idN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:51:59 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)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:51:59 INFO - Running setup.py (path:/tmp/pip-zfQjAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:51:59 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)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:51:59 INFO - Running setup.py (path:/tmp/pip-zNtcoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:51:59 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)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:51:59 INFO - Running setup.py (path:/tmp/pip-BlEgAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:51:59 INFO - Running setup.py (path:/tmp/pip-x3O_oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:51:59 INFO - Running setup.py (path:/tmp/pip-p6OG8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:51:59 INFO - Running setup.py (path:/tmp/pip-XXoDl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:51:59 INFO - Running setup.py (path:/tmp/pip-XnjgXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:51:59 INFO - Running setup.py (path:/tmp/pip-KFXXdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:51:59 INFO - Running setup.py (path:/tmp/pip-HWg2CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:51:59 INFO - Running setup.py (path:/tmp/pip-dNTDtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:51:59 INFO - Running setup.py (path:/tmp/pip-AlBnyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:51:59 INFO - Running setup.py (path:/tmp/pip-shgpzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:00 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)) 01:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:00 INFO - Running setup.py (path:/tmp/pip-0joBfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:00 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)) 01:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:00 INFO - Running setup.py (path:/tmp/pip-o6JGu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 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)) 01:52:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:02 INFO - Downloading blessings-1.6.tar.gz 01:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:02 INFO - Installing collected packages: blessings 01:52:02 INFO - Running setup.py install for blessings 01:52:02 INFO - Successfully installed blessings 01:52:02 INFO - Cleaning up... 01:52:02 INFO - Return code: 0 01:52:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:02 INFO - Reading from file tmpfile_stdout 01:52:02 INFO - Current package versions: 01:52:02 INFO - argparse == 1.2.1 01:52:02 INFO - blessings == 1.6 01:52:02 INFO - blobuploader == 1.2.4 01:52:02 INFO - docopt == 0.6.1 01:52:02 INFO - manifestparser == 1.1 01:52:02 INFO - mozInstall == 1.12 01:52:02 INFO - mozcrash == 0.17 01:52:02 INFO - mozdebug == 0.1 01:52:02 INFO - mozdevice == 0.48 01:52:02 INFO - mozfile == 1.2 01:52:02 INFO - mozhttpd == 0.7 01:52:02 INFO - mozinfo == 0.9 01:52:02 INFO - mozleak == 0.1 01:52:02 INFO - mozlog == 3.1 01:52:02 INFO - moznetwork == 0.27 01:52:02 INFO - mozprocess == 0.22 01:52:02 INFO - mozprofile == 0.28 01:52:02 INFO - mozrunner == 6.11 01:52:02 INFO - mozscreenshot == 0.1 01:52:02 INFO - mozsystemmonitor == 0.0 01:52:02 INFO - moztest == 0.7 01:52:02 INFO - mozversion == 1.4 01:52:02 INFO - psutil == 3.1.1 01:52:02 INFO - requests == 1.2.3 01:52:02 INFO - wsgiref == 0.1.2 01:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:52:02 INFO - Using env: {'DISPLAY': ':0', 01:52:02 INFO - 'HOME': '/home/cltbld', 01:52:02 INFO - 'LANG': 'en_US.UTF-8', 01:52:02 INFO - 'LANGUAGE': 'en_US:en', 01:52:02 INFO - 'LOGNAME': 'cltbld', 01:52:02 INFO - 'MAIL': '/var/mail/cltbld', 01:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:02 INFO - 'MOZ_NO_REMOTE': '1', 01:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:02 INFO - 'NO_EM_RESTART': '1', 01:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:02 INFO - 'PWD': '/builds/slave/test', 01:52:02 INFO - 'SHELL': '/bin/bash', 01:52:02 INFO - 'SHLVL': '1', 01:52:02 INFO - 'TERM': 'linux', 01:52:02 INFO - 'TMOUT': '86400', 01:52:02 INFO - 'USER': 'cltbld', 01:52:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:02 INFO - '_': '/tools/buildbot/bin/python'} 01:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:52:02 INFO - Cleaning up... 01:52:02 INFO - Return code: 0 01:52:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:52:02 INFO - Using env: {'DISPLAY': ':0', 01:52:02 INFO - 'HOME': '/home/cltbld', 01:52:02 INFO - 'LANG': 'en_US.UTF-8', 01:52:02 INFO - 'LANGUAGE': 'en_US:en', 01:52:02 INFO - 'LOGNAME': 'cltbld', 01:52:02 INFO - 'MAIL': '/var/mail/cltbld', 01:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:02 INFO - 'MOZ_NO_REMOTE': '1', 01:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:02 INFO - 'NO_EM_RESTART': '1', 01:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:02 INFO - 'PWD': '/builds/slave/test', 01:52:02 INFO - 'SHELL': '/bin/bash', 01:52:02 INFO - 'SHLVL': '1', 01:52:02 INFO - 'TERM': 'linux', 01:52:02 INFO - 'TMOUT': '86400', 01:52:02 INFO - 'USER': 'cltbld', 01:52:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:02 INFO - '_': '/tools/buildbot/bin/python'} 01:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:02 INFO - Downloading/unpacking jsonschema 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:04 INFO - Downloading/unpacking functools32 (from jsonschema) 01:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:05 INFO - warning: no files found matching '*.txt' 01:52:05 INFO - no previously-included directories found matching 'build' 01:52:05 INFO - no previously-included directories found matching 'dist' 01:52:05 INFO - no previously-included directories found matching '.git*' 01:52:05 INFO - Installing collected packages: jsonschema, functools32 01:52:05 INFO - Running setup.py install for functools32 01:52:05 INFO - warning: no files found matching '*.txt' 01:52:05 INFO - no previously-included directories found matching 'build' 01:52:05 INFO - no previously-included directories found matching 'dist' 01:52:05 INFO - no previously-included directories found matching '.git*' 01:52:05 INFO - Successfully installed jsonschema functools32 01:52:05 INFO - Cleaning up... 01:52:05 INFO - Return code: 0 01:52:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:05 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 0x7fe563accf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', '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 01:52:05 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 01:52:05 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 01:52:05 INFO - Using env: {'DISPLAY': ':0', 01:52:05 INFO - 'HOME': '/home/cltbld', 01:52:05 INFO - 'LANG': 'en_US.UTF-8', 01:52:05 INFO - 'LANGUAGE': 'en_US:en', 01:52:05 INFO - 'LOGNAME': 'cltbld', 01:52:05 INFO - 'MAIL': '/var/mail/cltbld', 01:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:05 INFO - 'MOZ_NO_REMOTE': '1', 01:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:05 INFO - 'NO_EM_RESTART': '1', 01:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:05 INFO - 'PWD': '/builds/slave/test', 01:52:05 INFO - 'SHELL': '/bin/bash', 01:52:05 INFO - 'SHLVL': '1', 01:52:05 INFO - 'TERM': 'linux', 01:52:05 INFO - 'TMOUT': '86400', 01:52:05 INFO - 'USER': 'cltbld', 01:52:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:05 INFO - '_': '/tools/buildbot/bin/python'} 01:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:05 INFO - Downloading/unpacking flake8 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:52:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:52:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:52:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:08 INFO - no previously-included directories found matching 'docs/_build' 01:52:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:52:08 INFO - Running setup.py install for pep8 01:52:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:08 INFO - no previously-included directories found matching 'docs/_build' 01:52:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:52:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:52:08 INFO - Cleaning up... 01:52:08 INFO - Return code: 0 01:52:08 INFO - Running post-action listener: _resource_record_post_action 01:52:08 INFO - Running post-action listener: _start_resource_monitoring 01:52:08 INFO - Starting resource monitoring. 01:52:08 INFO - ##### 01:52:08 INFO - ##### Running install step. 01:52:08 INFO - ##### 01:52:08 INFO - Running pre-action listener: _resource_record_pre_action 01:52:08 INFO - Running main action method: install 01:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:08 INFO - Reading from file tmpfile_stdout 01:52:08 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:08 INFO - Reading from file tmpfile_stdout 01:52:08 INFO - Output received: 01:52:08 INFO - Usage: mozinstall [options] installer 01:52:08 INFO - Options: 01:52:08 INFO - -h, --help show this help message and exit 01:52:08 INFO - -d DEST, --destination=DEST 01:52:08 INFO - Directory to install application into. [default: 01:52:08 INFO - "/builds/slave/test"] 01:52:08 INFO - --app=APP Application being installed. [default: firefox] 01:52:08 INFO - mkdir: /builds/slave/test/build/application 01:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:52:21 INFO - Reading from file tmpfile_stdout 01:52:21 INFO - Output received: 01:52:21 INFO - /builds/slave/test/build/application/firefox/firefox 01:52:21 INFO - Running post-action listener: _resource_record_post_action 01:52:21 INFO - ##### 01:52:21 INFO - ##### Running run-tests step. 01:52:21 INFO - ##### 01:52:21 INFO - Running pre-action listener: _resource_record_pre_action 01:52:21 INFO - Running main action method: run_tests 01:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:52:21 INFO - Python 2.7.3 01:52:21 INFO - Return code: 0 01:52:21 INFO - grabbing minidump binary from tooltool 01:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:21 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 0x283c410>, '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 0x283d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:52:21 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 01:52:21 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 01:52:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:52:22 INFO - Return code: 0 01:52:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:52:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:52:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:52:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:52:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:52:22 INFO - Return code: 0 01:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 01:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 01:52:22 INFO - Using env: {'DISPLAY': ':0', 01:52:22 INFO - 'HOME': '/home/cltbld', 01:52:22 INFO - 'LANG': 'en_US.UTF-8', 01:52:22 INFO - 'LANGUAGE': 'en_US:en', 01:52:22 INFO - 'LOGNAME': 'cltbld', 01:52:22 INFO - 'MAIL': '/var/mail/cltbld', 01:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:22 INFO - 'MOZ_NO_REMOTE': '1', 01:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:22 INFO - 'NO_EM_RESTART': '1', 01:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:22 INFO - 'PWD': '/builds/slave/test', 01:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:52:22 INFO - 'SHELL': '/bin/bash', 01:52:22 INFO - 'SHLVL': '1', 01:52:22 INFO - 'TERM': 'linux', 01:52:22 INFO - 'TMOUT': '86400', 01:52:22 INFO - 'USER': 'cltbld', 01:52:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594', 01:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:22 INFO - '_': '/tools/buildbot/bin/python'} 01:52:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 01:52:23 INFO - mozversion application_buildid: 20160627144420 01:52:23 INFO - mozversion application_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 01:52:23 INFO - mozversion application_display_name: Firefox 01:52:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:52:23 INFO - mozversion application_name: Firefox 01:52:23 INFO - mozversion application_remotingname: firefox 01:52:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:52:23 INFO - mozversion application_vendor: Mozilla 01:52:23 INFO - mozversion application_version: 48.0 01:52:23 INFO - mozversion platform_buildid: 20160627144420 01:52:23 INFO - mozversion platform_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 01:52:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:52:23 INFO - mozversion platform_version: 48.0 01:52:23 INFO - using testdate: 1467103943 01:52:23 INFO - actual date: 1467103943 01:52:23 INFO - starting webserver on 'localhost:58560' 01:52:23 INFO - SUITE-START | Running 2 tests 01:52:23 INFO - TEST-START | dromaeo_css 01:52:23 INFO - operating with platform_type : linux_ 01:52:23 INFO - Initialising browser for dromaeo_css test... 01:52:23 INFO - TEST-INFO | started process 26611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyWyas6/profile http://localhost:58560/getInfo.html) 01:52:26 INFO - PROCESS | 26611 | 01:52:26 INFO - PROCESS | 26611 | (process:26692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:52:27 INFO - PROCESS | 26611 | __metrics Screen width/height:1600/1200 01:52:27 INFO - PROCESS | 26611 | colorDepth:24 01:52:27 INFO - PROCESS | 26611 | Browser inner width/height: 1024/697 01:52:27 INFO - PROCESS | 26611 | __metrics 01:52:27 ERROR - PROCESS | 26611 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:52:28 INFO - TEST-INFO | 26611: exit 0 01:52:28 INFO - Browser initialized. 01:52:28 INFO - Running cycle 1/1 for dromaeo_css test... 01:52:28 INFO - TEST-INFO | started process 26741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyWyas6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:30 INFO - PROCESS | 26741 | 01:52:30 INFO - PROCESS | 26741 | (process:26811): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:52:40 INFO - PROCESS | 26741 | RSS: Main: 150663168 01:52:40 INFO - PROCESS | 26741 | 01:53:29 INFO - PROCESS | 26741 | 1467104009919 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] 01:55:37 INFO - PROCESS | 26741 | Cycle 1(1): loaded http://localhost:58560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58560/tests/dromaeo/cssquery-ext.html) 01:55:38 INFO - PROCESS | 26741 | RSS: Main: 155258880 01:55:38 INFO - PROCESS | 26741 | 01:58:40 INFO - PROCESS | 26741 | Cycle 1(1): loaded http://localhost:58560/tests/dromaeo/cssquery-ext.html (next: http://localhost:58560/tests/dromaeo/cssquery-jquery.html) 01:58:40 INFO - PROCESS | 26741 | RSS: Main: 152334336 01:58:40 INFO - PROCESS | 26741 | 02:01:42 INFO - PROCESS | 26741 | Cycle 1(1): loaded http://localhost:58560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58560/tests/dromaeo/cssquery-mootools.html) 02:01:43 INFO - PROCESS | 26741 | RSS: Main: 151744512 02:01:43 INFO - PROCESS | 26741 | 02:04:44 INFO - PROCESS | 26741 | Cycle 1(1): loaded http://localhost:58560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58560/tests/dromaeo/cssquery-prototype.html) 02:04:45 INFO - PROCESS | 26741 | RSS: Main: 152788992 02:04:45 INFO - PROCESS | 26741 | 02:07:47 INFO - PROCESS | 26741 | Cycle 1(1): loaded http://localhost:58560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58560/tests/dromaeo/cssquery-yui.html) 02:07:48 INFO - PROCESS | 26741 | RSS: Main: 152023040 02:07:48 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | Cycle 1(1): loaded http://localhost:58560/tests/dromaeo/cssquery-yui.html (next: http://localhost:58560/tests/dromaeo/cssquery-dojo.html) 02:10:50 INFO - PROCESS | 26741 | RSS: Main: 155979776 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | __start_tp_report 02:10:50 INFO - PROCESS | 26741 | _x_x_mozilla_page_load 02:10:50 INFO - PROCESS | 26741 | _x_x_mozilla_page_load_details 02:10:50 INFO - PROCESS | 26741 | |i|pagename|runs| 02:10:50 INFO - PROCESS | 26741 | |0;dojo.html;3301.504774283857;3398.7620866539323;3399.7790143640655;3432.5709286339206;3444.517767512547;5591.66450012999;5629.296337957755;5633.80281690141;5658.603897727161;5663.575231857607;5621.7751289948455;5665.8668266346795;5673.773049078042;5674.971625141879;5683.687397193163;5089.1602885523935;5156.58747300217;5175.637705360627;5197.428282888898;5210.843674689765;5066.569341605968;5128.282040514331;5287.973560132214;5306.7611957462;5312.362516498026;5061.139606266925;5158.509941555565;5170;5245.44922783108;5262.868428289305;5169.147090730025;5189.818356357509;5190.558802501791;5194.6883187008525;5208.76560554774;5063.797448102108;5103.260027296058;5183.533481986639;5184.9740751296;5205.583553315726;5396.947595218934;5452.836414907559;5490.313710786152;5501.724913754337;5527.778888844441;5889;5944.791932282349;5945.137954996501;5955.225820643332;5966.552508561832;5874.9118763218585;6006.819795406145;6010.398960103998;6014.338422773535;6021.09683547467;5596.1605759136455;5643.209950606918;5645.407232240596;5646.491815736604;5746.454086861741;6112.786052488231;6125.418085281891;6128.387161283925;6140.478059364915;6142.385761423911;5829.387914268941;5904.409559044061;5905.202797622352;5912.586118971717;5920.200772895604;5873.236479257755;5901.29184497863;5917.082852157922;5921.526277897758;5953.9878220702585;5884.793617308442;5887.676177810176;5889.352171261158;5902.704864756745;5917.053271476543;5861.5603829712945;5887.381824908409;5918.615290006136;5983.940160598426;5992.250968628921;4520.480144783326;4520.909581808345;4522.66080043998;4526.59260666535;4548.431446069241;4068.3083875741195;4072.9185416291507;4091.059056416981;4110.383442483591;4127.009517715726;5719.742611582489;5786.07422812348;5851;5857.121431785266;5888.263967004124;5861.003629383015;5917.911231331534;5932.110183472428;5971.820845374646;6023.608465449732;5687.488126068673;5719.857003574861;5721;5731;5734.627249228787;4963.404391473046;4996.800127994912;5082.923756143661;5098.362704661918;5111.616628752859;6303.716332765037;6346.27017892939;6363.363663633692;6399.8080057598345;6405.903911441332;5966.0454327307425;6094;6096.603720758137;6107.816765497042;6131.908021379772;6264.185655864709;6383.585066970632;6387;6391.840203994937;6415.775447859302;5888.793892213752;5892;5893.145493903446;5899.67551784656;5948.672822994777;5943.613665111927;5952.5237980960555;5965.015772397506;6033.78881739137;6034.909476357946;5758.366579676149;5810.1575271586225;5815.621984570989;5830.591858569859;5846.327672317738;5750.568707346882;5773.451522105393;5799.652020878761;5804.709764511673;5814.04068328721;5673.234113394639;5674.233978412862;5696.515796157373;5796.884062318814;5904.409559044061;5899;5928.67392293428;5945.64326140433;5952.702364881825;5958.34458209588;5792.3917988612275;5812;5816.069428891357;5816.5055970243;5817.0983497557945 02:10:50 INFO - PROCESS | 26741 | |1;ext.html;652.4845372155997;669.9732010719572;677.5392732941601;683.5044592670315;739.1019910808367;39389.212215755666;40732.592674073254;40749.79625101878;40828.38757418641;40896.79551602245;43475.13049739011;43588.564114358844;44065;44187.337189942176;44247;8745.125487451252;8905.154010369037;8916.866247006301;8943.239824614882;8959.507227102507;8689.913760779902;8820.647174113028;8821.911780882205;8825.249853762405;8846.823063538724;9089.909100909006;9165.31260155491;9165.633374665005;9181.770455738626;9200;9019.143181397756;9064.41081329718;9068.365214434993;9073.7277881663;9091.545422728903;8765.561721913942;8847.159519845605;8849.557522123869;8859.734207973772;8861.246794022516;44157.55842441566;44417;44448.3332750009;44622.10755784898;44703.32945005828;3729.310077635646;3820.331441997639;3826.598207188233;3945.0926286954164;4044.272031034442;33660;33777;33946.49080263798;34127.31745365079;34194.14514637129;4487.708298960557;4559.17934771741;4564.064366804797;4569.565891240327;4625.791839367203;323010;324644;325423;325475;326995.3650231757;39286;39694.80152599219;61158;61458.69270653708;61545.38454615486;37585.81207093947;37603;37730;37772.244555108744;37780.62219377826;16296.185190740416;16471.094089824936;16475.917620411823;16489.505314840575;16531.090790006423;14772.852271477363;14795.112293262438;14819.481318154028;14854;14854.108753474826;9433.716988490356;9489.715308540755;9492.857607135898;9534.618615255451;9553.235741140692;3620.1854582719207;3631.455281707765;3641.780003698738;3644.817759112034;3705.1478160022807;1159.1306520109918;1163.3310846263432;1226.8589112252205;1246.5948566715672;1251.2742609286593;33809.323813523595;33819.66180338165;33919.15202119967;34067.14832129217;34214.657853421144;1232.993835030837;1242.4151994429487;1262.211118051218;1315.329531494996;1318.8021796730375;17458.476245712394;17561.736573951403;17639.647207055787;17755.911220443813;17874.642507150045;472334;535220;546310;877101;896926;63028.684856575426;63754;64105;64258;64742.67628661827;1509.7584386498108;1542.9382824687111;1546.2809793446102;1561.8984765990174;1564.8982816116916;33455.83272083624;33947.83026084854;34002.65997339995;34456.310873781884;34859.302813943075;54128.458715412344;55231.44768552424;56516.43483565276;56628.15057774219;57065.71467142638;318749;321663;322038;322642;322972;44474.55525444704;45165.54834451614;45451.54548454473;45767.313490297005;50411.243831341824;53968.19047714366;54472.72763636157;55656.721716391155;55760;55878.72060639671;44966.77516612396;46037.53962460333;46415.53584464247;46748.7662561685;47547;45166;45184.14159853899;45819.31271031004;46014;46329;46189.76905115453;47045.294320585905;47243;47315.76342118405;47465.81335466641;39158.80420597879;39559.60440395674;39610.80194599008;40002.59997400105;40686;30310.545341820332;30609.54085688672;30980;31052.378952421277;31099.84450077735 02:10:50 INFO - PROCESS | 26741 | |2;jquery.html;422.79339299089355;432.40544251653967;442.3320785613722;443.96892217544786;448.7442157969957;18449.354272600445;18786;19459.902700486495;20129.396118116445;20160.89919550404;19165.712514312298;19559.70660440091;19656.11547480363;19800.10899509522;19823.10796014179;5723.141528770697;5761.539076873861;5952.58331916766;5953.493953013977;5974.4921681657115;5431.565474762029;5684.744186511617;5726.341470730857;5773.509251713609;5863.384344643815;5628.212050312939;5699.173619825123;5702.45826646468;5705.62913410627;5721.542276617861;5918.822435326947;5919.733611987471;5966.791162309299;5977.850553736148;5988.610740301889;5675.51758100562;5766.077427611562;5798.855028624276;5807.854803629901;5809.186713860063;13858;14183.149011059266;14351.354189061518;14385.136891786526;14412.927935360362;2364.101641376283;2425.0057476434577;2546.579814330652;2591.183777110204;3064.4024415239037;9807.950960245153;10053.547590358377;10277.948610256975;12559.058070644738;14423.206723630195;1957.8237958583654;1965.1549833571557;1965.8230759231737;1992.1832048860042;2113.1124927530473;74144.25855741427;75520.9791608335;76577.61711191465;77108.61445692736;78545.60727196328;11197.272177308449;11230.7192320191;11464.770704586028;11496.42517874103;11620.128490363257;15899;15956.680866382607;15987;16020.27908744086;16024.519264422086;8648.351373647001;8698.782530436789;8827.867581986275;8892.377533572717;8915.866262006075;8412.537310447984;8555.614997325136;8617.439866408664;8701.086385929386;8713.128687131362;4674.6026587740425;4788.736619485892;4836.443808961944;4873.610111191097;4885.998370334073;2028.7869773673847;2060.732104826363;2080.1887263967064;2083.4062292246635;2113.3131732187103;987.3236832769576;1051.0435503691756;1066.8506409102731;1099.780043991205;1155.064397837754;17930.372436964644;18330.81669183291;18586.535336616424;18613.627727445648;18879.150438230314;1080.6001779341536;1091.8853520380405;1104.0394856474918;1123.702218911989;1143.6854864912216;9971;10420.374777513221;10428.104819607519;10566.735831604272;10639.627613033506;489131;508721;509750;516600;517988;89134.55432722795;89696.551517242;89755.55122224348;90524;90805;1048.6801525534634;1058.9523471443804;1062.5324857062867;1071.314358810362;1106.9667909962875;16455;16543;16627.25177366997;16809.32762689479;17047.147642618067;36846.26307473889;37715;38254.23491530209;38754.80622596869;39117.80441097776;55843;56229.437705624056;56337.15494267507;56574.15138773004;56671.71664141818;8813.294936404944;8836.469811811312;10414.271001029856;12025.819612705642;12220.266783992989;12767.425465853874;13797.241151736349;14259.287035647969;14475.131492110508;14672.266386680836;12551.121421500407;12688.6827829305;12715.80926286125;12948.417321220379;13039.087263891437;12069.336186509827;12335.629931102081;12727.363631818558;12751.872481275068;12765.93617031909;7805.297523222937;8519.829603407774;12544.310062946626;12664.74670506603;12739.235645860907;9892.060254275832;10403;10420.583176673152;10647.361158330525;10650.360978341325;11682.88317116818;11897;11919.702007449536;12104.334261615695;12201.267923924594 02:10:50 INFO - PROCESS | 26741 | |3;mootools.html;1510.969780604388;1553.541705196967;1768.3899054826081;1896.2320260294578;1896.3931541906595;7242.420606351492;7928.563928983904;8016.559089250089;8211.343092552597;8246.62890169943;8068.314193293562;8106.148854370294;8137.267645911867;8321.33429325654;8326.66693332266;2348.788609025192;2374.347054560001;2381.0594815048044;2385.3440303916386;2391.928242152738;2374.608189648706;2387.761223877607;2410.9397265068337;2415.553122672311;2426.9271921842374;2356.281334193079;2358.551875143717;2370.3244575295957;2381.130887226159;2399.8920048597856;2372.3120295114395;2377.9643305350432;2382.404398900275;2403.8918248678765;2414.263649586875;2407.4222186675247;2418.8427752196053;2420.0319872051145;2429.635554666814;2439.9756002440104;8109.837803243961;8120.75637730869;8151.429399942006;8156.062052863878;8190.795230119235;5212.087884620214;5270.894582108336;5325.520703136736;5330.307060082203;5345.198220266952;3334.333133373311;3381.171612954817;3394.0835974286806;3505.3339865425487;3519.5248641433336;1025;1049.695588279398;1051.5110473629722;1064.978700425995;1075.763332066944;10966.177536684781;11121.499532520975;11149.554017839277;11177.21759476837;11234.101271898311;4413.426254586883;4454.4654641442585;4512.075024619945;4547.567981041796;4597.44830620321;9116.954415227881;9156.816863662689;9157.267418606496;9180.495072770927;9181.173694367539;5247.711375874287;5258.763355649005;5278.313819203479;5295.15277555597;5346.465353464622;4790.0180463005;4967.105920934267;5006.6495345325475;5036.471170527042;5040.067587496325;3742.1206016586625;3808;3832.3676593362343;3849.7690138591215;3941.960580394217;1116.5812820192427;1125.8536390269212;1150.3730466895563;1181.5923506390282;1195;1067.64767626683;1069.9625513107003;1088.3905013192636;1104.8342748587615;1110.1396417776127;5804.738786754606;5838.241028666331;5981.461668449861;5992.191054207626;6043.969780151159;475.5292260661989;480.8052738640856;485.7328469341848;487.8512053823618;490.70557665400474;4279.186954478639;4319.503257125408;4323.308270676676;4385.649148068147;4405;9901.059399357193;9980.451075190935;10164.542595583216;10172.542235599416;10184.694459166238;9854.901450985542;9892.55483503244;9993.200543956465;10004.849927251096;10037;7825;7990.840183196304;8017.078036025815;8136.430449868452;8155.062167850654;5439.891202175855;5498;5502.202180683858;5579.358373787067;5621.5221706155435;8772.342074344577;8831.602577883883;8845.69040083594;8956.417832840845;8988.999999999738;8833.29333653319;9013.414128081917;9097.13577210164;9122.270218382646;9133.132352426508;7746.57393843344;7839;7860.606969651609;7906.248906353887;7981.441299109007;7956.562389068657;8011.799705007422;8026.919730802851;8052.557109358807;8060.476069055727;7089.893651595334;7312.451566132455;7350.669219885011;7425.480216384801;7441.516301440389;7046.1192350956135;7418.888716669362;7529.924700752922;7534.962325188339;7657.540547567164;6835.14560679915;6858.41703455192;6874.793756187322;6928.44572434194;6930;4945.629077819106;5220.817271395483;5317.946820531745;5502.422245664307;5665.178549110438;5436.891262174813;5554.2779438672715;5561.610687251854;5562.527185189304;5595.5523558116065 02:10:50 INFO - PROCESS | 26741 | |4;prototype.html;356.0582259922505;364.31326948701707;367.36262584416016;371.1297008515033;375.24201113750223;6376.234851817777;6435.678216089189;6486.254080780705;6524.086627872101;6550.967245163767;6536.2156541215;6562.606243625386;6564.376384243489;6568.835779105513;6579;4962.206047032476;4964.826231081913;4970.776315065822;4981.875453113665;4988.625853061017;4976.576990955773;4977.751112444382;4977.925331120036;4981.875453113665;4999.500049994989;4933.136701077297;4939.827106051289;4940.357753492041;4952.33143525623;4953.182724850395;4721.480637129947;4867.953390021127;4921.483244259372;4938.037082768861;4942.777575009115;4202.474690663667;4234.5553716859595;4240.342746874208;4261.019965407973;4263.189993901149;6231.688415579203;6242.533004743882;6244.687765611701;6248.3751624837605;6255.343188965184;5559.861003474905;5672.461116193955;5682.914756278659;5727;5738.311402631669;6843.8973415398805;6854.554453960476;6865.725370985205;6877.3810357068105;6883.518153729241;4780.043991201774;4783.832565860178;4784.114938736345;4786;4790.592799612037;7075.080239568823;7115.5730656160795;7162.820929476753;7166.713331466787;7189.7483588074165;4900;4901.411830580353;4912.042151780369;4912.164931961575;4923.08922849274;4746.5490778376;4830.758462076882;4849.248366503127;4853.708777473293;4861.149298872683;5558.527525160326;5650.604457687922;5671.943280567141;5678.517326027334;5685.488306052475;6862.039314495874;6889.758858439931;6908.758193463204;6914.0666010089;6931.133608298963;1708.5899384147715;1709.8803083784017;1716.0990479997852;1716.2019660857761;1720.346268418018;1097.1880808202034;1124.1793490751797;1132.2357408749226;1133.7335726104359;1151.9827202591969;6680.899786503206;6689.6989635466525;6700.731970721116;6711.597304161766;6729.798106056826;7055.470839687044;7068.893966590505;7069.045678833395;7083.716651333992;7090.964545177344;6671.899921501182;6674.9666251669405;6681.665916704243;6695.062691223233;6703.29615390377;3787.715921305913;3806.4861243732294;3838.213166300902;3840.2127563849344;3841.9039524012123;7277.563346199245;7450.478466507292;7456.067991501062;7471.514351567131;7472.252774722593;7238.059052323164;7308.96345518269;7335.963320183365;7345.375643070292;7351.117865856025;7500.812479687942;7568.205338439385;7582.241775822374;7582.87679449755;7590.354819840375;6962.3733863950465;7194.496385253191;7227.096612923385;7233.746818861525;7238.131424229126;7090.255523170199;7122;7138.107736532934;7146.035285236427;7147.606881621353;7598.088229412506;7605.201453847267;7609.048868891388;7618.200088990798;7625.885611715939;4756.310335001336;4769.236922092448;4772.308015337826;4781.378420805273;4783.091212669582;7026.578405295699;7197.928020719935;7203.315685009916;7211.098612673416;7216.639168041682;6977.79066628002;6979.162500499972;6980.092587963532;6980.406665433292;6993.545419547713;6924.480663950325;6945.409640180641;6954.9304506956305;6962.965185174042;6974.407175389946;6848.897266541106;6849.589024658537;6851.657417129223;6857.074294970115;6867.793966181022;6791.89812152828;7002.299770022957;7011.193712723102;7014.579125252501;7037.859242815218;6656.933430665631;6809.285025072296;6827.214870289781;6837.564111536633;6843.726250950105 02:10:50 INFO - PROCESS | 26741 | |5;yui.html;851.2083762101246;890.7817584691755;891.915268049535;895.6506962284708;906.7415786500841;15279.388824447024;15588.454404095859;15635.921820390882;15639.921800390983;15648.374065037398;13608.387622556984;13684.384202710877;13697.178169309824;13705.3832577534;13706.862931370682;746.0748671647145;879.9384043116985;887.9778005549848;907.4645958884257;908.0556221529602;880.6785523284019;885.5527958381009;890.9376343655947;897.0760117079419;897.9146981036791;940.6143481172686;942.0626476655702;945.0879900895634;954.6181527389031;957.1098878043417;940.0881145289059;945.7682867697458;948.3219498058886;949.5726922884729;949.8622699708503;698.7554355975419;700.422151724824;701.6351497221467;701.824543864034;702.5538782872861;13780.793288100687;13785.655358616015;13895.444182232699;13902.513412030632;13938.651533711636;15151.469698560497;15261.313240904186;15486.148261845594;15497.302621382065;15517;12221.388930553438;12385.690357741129;12449.875501244962;12449.875501244962;12476.75046499065;4055.1889622075705;4099.159672267178;4114.835406583733;4122.90820836267;4173.874783756492;54711.45288547104;54897;55332.44667553313;55512.722436387965;57086.143707844;11735.354555499529;11795.174337796443;11980.820287695691;12073.15487915855;12139.635810925687;20853.061612227488;20878.478038048866;20924.686129708065;20930.47673808167;21051.473713157295;8689.869651955225;8742.169493898069;8845.734627961172;8937.955310223537;9001.324900632348;4868.342773725572;4880.707157570557;4989.226669866177;4998.2502624606595;4999.550130462125;3519.225770330523;3550.3076900004767;3567.1795487038125;3572.4284114541547;3578.087587665129;572.4561666416921;626.0421555020735;628.8019273928697;628.8207860759661;630.5523078614143;670.0652589637526;775.5700390261284;808.2483290539855;832.4422636833336;833.4915701422127;9176.770580735401;10153.4923253837;10250.179985601135;10368;10483.633072842415;779.2674885607511;826.8470332988417;827.9461834980827;829.0383155539545;846.3990566697713;4627.490975992638;4687.929681054787;4705.12955103307;4746.715197088186;4760.952390476051;61762.38237617656;66058;66496.66751666211;66510;66524.33475665278;54680.45319546833;54895.45104548983;55066.449335506935;55602.44397555973;56648;53562.19656705153;54039;54387.184192237146;54445.72777136089;55414;10193.082622564005;10234.539445724811;10393.58425662965;10399.688009359732;10407.843882341922;38002.239955201294;38234.61765382311;38555.42166867555;39685.60314396819;40722;48105.75947120382;49743.50256497389;50406.747966259936;51049;51330.97338053143;12181.756364872475;12871.22772633645;12992.155509891827;13195.274259915797;13246.735065298833;14516.564503064925;14556.41774329015;14916.328765205375;15108.39566417331;15494.845051549792;13525;13705.794413084011;13795.793063104262;13866.376013079234;14264.857351426353;13379.598612041655;13458.596242112751;13745.587632371045;13811.654708632364;14236.217008064656;13109.1479053865;13599.320033998458;13763.105398149088;13793.517226897011;13890.958178136478;11047.337159770119;11048.723781905517;11819.645410637351;11871.76256474883;11901;11740.823887641864;11770.411479426166;11860.76278474443;11970.640880773592;12081 02:10:50 INFO - PROCESS | 26741 | __end_tp_report 02:10:50 INFO - PROCESS | 26741 | __start_cc_report 02:10:50 INFO - PROCESS | 26741 | _x_x_mozilla_cycle_collect,319 02:10:50 INFO - PROCESS | 26741 | __end_cc_report 02:10:50 INFO - PROCESS | 26741 | __startTimestamp1467105050551__endTimestamp 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | ------- Summary: start ------- 02:10:50 INFO - PROCESS | 26741 | Number of tests: 6 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | [#0] dojo.html Cycles:165 Average:5586.96 Median:5810.16 stddev:618.78 (10.6%) stddev-sans-first:594.13 02:10:50 INFO - PROCESS | 26741 | Values: 3301.5 3398.8 3399.8 3432.6 3444.5 5591.7 5629.3 5633.8 5658.6 5663.6 5621.8 5665.9 5673.8 5675.0 5683.7 5089.2 5156.6 5175.6 5197.4 5210.8 5066.6 5128.3 5288.0 5306.8 5312.4 5061.1 5158.5 5170.0 5245.4 5262.9 5169.1 5189.8 5190.6 5194.7 5208.8 5063.8 5103.3 5183.5 5185.0 5205.6 5396.9 5452.8 5490.3 5501.7 5527.8 5889.0 5944.8 5945.1 5955.2 5966.6 5874.9 6006.8 6010.4 6014.3 6021.1 5596.2 5643.2 5645.4 5646.5 5746.5 6112.8 6125.4 6128.4 6140.5 6142.4 5829.4 5904.4 5905.2 5912.6 5920.2 5873.2 5901.3 5917.1 5921.5 5954.0 5884.8 5887.7 5889.4 5902.7 5917.1 5861.6 5887.4 5918.6 5983.9 5992.3 4520.5 4520.9 4522.7 4526.6 4548.4 4068.3 4072.9 4091.1 4110.4 4127.0 5719.7 5786.1 5851.0 5857.1 5888.3 5861.0 5917.9 5932.1 5971.8 6023.6 5687.5 5719.9 5721.0 5731.0 5734.6 4963.4 4996.8 5082.9 5098.4 5111.6 6303.7 6346.3 6363.4 6399.8 6405.9 5966.0 6094.0 6096.6 6107.8 6131.9 6264.2 6383.6 6387.0 6391.8 6415.8 5888.8 5892.0 5893.1 5899.7 5948.7 5943.6 5952.5 5965.0 6033.8 6034.9 5758.4 5810.2 5815.6 5830.6 5846.3 5750.6 5773.5 5799.7 5804.7 5814.0 5673.2 5674.2 5696.5 5796.9 5904.4 5899.0 5928.7 5945.6 5952.7 5958.3 5792.4 5812.0 5816.1 5816.5 5817.1 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | [#1] ext.html Cycles:180 Average:60682.33 Median:44172.45 stddev:128266.91 (290.4%) stddev-sans-first:128547.55 02:10:50 INFO - PROCESS | 26741 | Values: 652.5 670.0 677.5 683.5 739.1 39389.2 40732.6 40749.8 40828.4 40896.8 43475.1 43588.6 44065.0 44187.3 44247.0 8745.1 8905.2 8916.9 8943.2 8959.5 8689.9 8820.6 8821.9 8825.2 8846.8 9089.9 9165.3 9165.6 9181.8 9200.0 9019.1 9064.4 9068.4 9073.7 9091.5 8765.6 8847.2 8849.6 8859.7 8861.2 44157.6 44417.0 44448.3 44622.1 44703.3 3729.3 3820.3 3826.6 3945.1 4044.3 33660.0 33777.0 33946.5 34127.3 34194.1 4487.7 4559.2 4564.1 4569.6 4625.8 323010.0 324644.0 325423.0 325475.0 326995.4 39286.0 39694.8 61158.0 61458.7 61545.4 37585.8 37603.0 37730.0 37772.2 37780.6 16296.2 16471.1 16475.9 16489.5 16531.1 14772.9 14795.1 14819.5 14854.0 14854.1 9433.7 9489.7 9492.9 9534.6 9553.2 3620.2 3631.5 3641.8 3644.8 3705.1 1159.1 1163.3 1226.9 1246.6 1251.3 33809.3 33819.7 33919.2 34067.1 34214.7 1233.0 1242.4 1262.2 1315.3 1318.8 17458.5 17561.7 17639.6 17755.9 17874.6 472334.0 535220.0 546310.0 877101.0 896926.0 63028.7 63754.0 64105.0 64258.0 64742.7 1509.8 1542.9 1546.3 1561.9 1564.9 33455.8 33947.8 34002.7 34456.3 34859.3 54128.5 55231.4 56516.4 56628.2 57065.7 318749.0 321663.0 322038.0 322642.0 322972.0 44474.6 45165.5 45451.5 45767.3 50411.2 53968.2 54472.7 55656.7 55760.0 55878.7 44966.8 46037.5 46415.5 46748.8 47547.0 45166.0 45184.1 45819.3 46014.0 46329.0 46189.8 47045.3 47243.0 47315.8 47465.8 39158.8 39559.6 39610.8 40002.6 40686.0 30310.5 30609.5 30980.0 31052.4 31099.8 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | [#2] jquery.html Cycles:180 Average:29206.27 Median:11094.84 stddev:83573.22 (753.3%) stddev-sans-first:83779.72 02:10:50 INFO - PROCESS | 26741 | Values: 422.8 432.4 442.3 444.0 448.7 18449.4 18786.0 19459.9 20129.4 20160.9 19165.7 19559.7 19656.1 19800.1 19823.1 5723.1 5761.5 5952.6 5953.5 5974.5 5431.6 5684.7 5726.3 5773.5 5863.4 5628.2 5699.2 5702.5 5705.6 5721.5 5918.8 5919.7 5966.8 5977.9 5988.6 5675.5 5766.1 5798.9 5807.9 5809.2 13858.0 14183.1 14351.4 14385.1 14412.9 2364.1 2425.0 2546.6 2591.2 3064.4 9808.0 10053.5 10277.9 12559.1 14423.2 1957.8 1965.2 1965.8 1992.2 2113.1 74144.3 75521.0 76577.6 77108.6 78545.6 11197.3 11230.7 11464.8 11496.4 11620.1 15899.0 15956.7 15987.0 16020.3 16024.5 8648.4 8698.8 8827.9 8892.4 8915.9 8412.5 8555.6 8617.4 8701.1 8713.1 4674.6 4788.7 4836.4 4873.6 4886.0 2028.8 2060.7 2080.2 2083.4 2113.3 987.3 1051.0 1066.9 1099.8 1155.1 17930.4 18330.8 18586.5 18613.6 18879.2 1080.6 1091.9 1104.0 1123.7 1143.7 9971.0 10420.4 10428.1 10566.7 10639.6 489131.0 508721.0 509750.0 516600.0 517988.0 89134.6 89696.6 89755.6 90524.0 90805.0 1048.7 1059.0 1062.5 1071.3 1107.0 16455.0 16543.0 16627.3 16809.3 17047.1 36846.3 37715.0 38254.2 38754.8 39117.8 55843.0 56229.4 56337.2 56574.2 56671.7 8813.3 8836.5 10414.3 12025.8 12220.3 12767.4 13797.2 14259.3 14475.1 14672.3 12551.1 12688.7 12715.8 12948.4 13039.1 12069.3 12335.6 12727.4 12751.9 12765.9 7805.3 8519.8 12544.3 12664.7 12739.2 9892.1 10403.0 10420.6 10647.4 10650.4 11682.9 11897.0 11919.7 12104.3 12201.3 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | [#3] mootools.html Cycles:180 Average:5542.62 Median:5274.60 stddev:2959.13 (56.1%) stddev-sans-first:2951.92 02:10:50 INFO - PROCESS | 26741 | Values: 1511.0 1553.5 1768.4 1896.2 1896.4 7242.4 7928.6 8016.6 8211.3 8246.6 8068.3 8106.1 8137.3 8321.3 8326.7 2348.8 2374.3 2381.1 2385.3 2391.9 2374.6 2387.8 2410.9 2415.6 2426.9 2356.3 2358.6 2370.3 2381.1 2399.9 2372.3 2378.0 2382.4 2403.9 2414.3 2407.4 2418.8 2420.0 2429.6 2440.0 8109.8 8120.8 8151.4 8156.1 8190.8 5212.1 5270.9 5325.5 5330.3 5345.2 3334.3 3381.2 3394.1 3505.3 3519.5 1025.0 1049.7 1051.5 1065.0 1075.8 10966.2 11121.5 11149.6 11177.2 11234.1 4413.4 4454.5 4512.1 4547.6 4597.4 9117.0 9156.8 9157.3 9180.5 9181.2 5247.7 5258.8 5278.3 5295.2 5346.5 4790.0 4967.1 5006.6 5036.5 5040.1 3742.1 3808.0 3832.4 3849.8 3942.0 1116.6 1125.9 1150.4 1181.6 1195.0 1067.6 1070.0 1088.4 1104.8 1110.1 5804.7 5838.2 5981.5 5992.2 6044.0 475.5 480.8 485.7 487.9 490.7 4279.2 4319.5 4323.3 4385.6 4405.0 9901.1 9980.5 10164.5 10172.5 10184.7 9854.9 9892.6 9993.2 10004.8 10037.0 7825.0 7990.8 8017.1 8136.4 8155.1 5439.9 5498.0 5502.2 5579.4 5621.5 8772.3 8831.6 8845.7 8956.4 8989.0 8833.3 9013.4 9097.1 9122.3 9133.1 7746.6 7839.0 7860.6 7906.2 7981.4 7956.6 8011.8 8026.9 8052.6 8060.5 7089.9 7312.5 7350.7 7425.5 7441.5 7046.1 7418.9 7529.9 7535.0 7657.5 6835.1 6858.4 6874.8 6928.4 6930.0 4945.6 5220.8 5317.9 5502.4 5665.2 5436.9 5554.3 5561.6 5562.5 5595.6 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | [#4] prototype.html Cycles:180 Average:5785.20 Median:6664.42 stddev:1775.83 (26.6%) stddev-sans-first:1733.43 02:10:50 INFO - PROCESS | 26741 | Values: 356.1 364.3 367.4 371.1 375.2 6376.2 6435.7 6486.3 6524.1 6551.0 6536.2 6562.6 6564.4 6568.8 6579.0 4962.2 4964.8 4970.8 4981.9 4988.6 4976.6 4977.8 4977.9 4981.9 4999.5 4933.1 4939.8 4940.4 4952.3 4953.2 4721.5 4868.0 4921.5 4938.0 4942.8 4202.5 4234.6 4240.3 4261.0 4263.2 6231.7 6242.5 6244.7 6248.4 6255.3 5559.9 5672.5 5682.9 5727.0 5738.3 6843.9 6854.6 6865.7 6877.4 6883.5 4780.0 4783.8 4784.1 4786.0 4790.6 7075.1 7115.6 7162.8 7166.7 7189.7 4900.0 4901.4 4912.0 4912.2 4923.1 4746.5 4830.8 4849.2 4853.7 4861.1 5558.5 5650.6 5671.9 5678.5 5685.5 6862.0 6889.8 6908.8 6914.1 6931.1 1708.6 1709.9 1716.1 1716.2 1720.3 1097.2 1124.2 1132.2 1133.7 1152.0 6680.9 6689.7 6700.7 6711.6 6729.8 7055.5 7068.9 7069.0 7083.7 7091.0 6671.9 6675.0 6681.7 6695.1 6703.3 3787.7 3806.5 3838.2 3840.2 3841.9 7277.6 7450.5 7456.1 7471.5 7472.3 7238.1 7309.0 7336.0 7345.4 7351.1 7500.8 7568.2 7582.2 7582.9 7590.4 6962.4 7194.5 7227.1 7233.7 7238.1 7090.3 7122.0 7138.1 7146.0 7147.6 7598.1 7605.2 7609.0 7618.2 7625.9 4756.3 4769.2 4772.3 4781.4 4783.1 7026.6 7197.9 7203.3 7211.1 7216.6 6977.8 6979.2 6980.1 6980.4 6993.5 6924.5 6945.4 6954.9 6963.0 6974.4 6848.9 6849.6 6851.7 6857.1 6867.8 6791.9 7002.3 7011.2 7014.6 7037.9 6656.9 6809.3 6827.2 6837.6 6843.7 02:10:50 INFO - PROCESS | 26741 | 02:10:50 INFO - PROCESS | 26741 | [#5] yui.html Cycles:180 Average:15836.50 Median:4107.00 stddev:17998.40 (438.2%) stddev-sans-first:18013.71 02:10:50 INFO - PROCESS | 26741 | Values: 851.2 890.8 891.9 895.7 906.7 15279.4 15588.5 15635.9 15639.9 15648.4 13608.4 13684.4 13697.2 13705.4 13706.9 746.1 879.9 888.0 907.5 908.1 880.7 885.6 890.9 897.1 897.9 940.6 942.1 945.1 954.6 957.1 940.1 945.8 948.3 949.6 949.9 698.8 700.4 701.6 701.8 702.6 13780.8 13785.7 13895.4 13902.5 13938.7 15151.5 15261.3 15486.1 15497.3 15517.0 12221.4 12385.7 12449.9 12449.9 12476.8 4055.2 4099.2 4114.8 4122.9 4173.9 54711.5 54897.0 55332.4 55512.7 57086.1 11735.4 11795.2 11980.8 12073.2 12139.6 20853.1 20878.5 20924.7 20930.5 21051.5 8689.9 8742.2 8845.7 8938.0 9001.3 4868.3 4880.7 4989.2 4998.3 4999.6 3519.2 3550.3 3567.2 3572.4 3578.1 572.5 626.0 628.8 628.8 630.6 670.1 775.6 808.2 832.4 833.5 9176.8 10153.5 10250.2 10368.0 10483.6 779.3 826.8 827.9 829.0 846.4 4627.5 4687.9 4705.1 4746.7 4761.0 61762.4 66058.0 66496.7 66510.0 66524.3 54680.5 54895.5 55066.4 55602.4 56648.0 53562.2 54039.0 54387.2 54445.7 55414.0 10193.1 10234.5 10393.6 10399.7 10407.8 38002.2 38234.6 38555.4 39685.6 40722.0 48105.8 49743.5 50406.7 51049.0 51331.0 12181.8 12871.2 12992.2 13195.3 13246.7 14516.6 14556.4 14916.3 15108.4 15494.8 13525.0 13705.8 13795.8 13866.4 14264.9 13379.6 13458.6 13745.6 13811.7 14236.2 13109.1 13599.3 13763.1 13793.5 13891.0 11047.3 11048.7 11819.6 11871.8 11901.0 11740.8 11770.4 11860.8 11970.6 12081.0 02:10:50 INFO - PROCESS | 26741 | -------- Summary: end -------- 02:10:50 INFO - PROCESS | 26741 | 02:10:51 INFO - TEST-INFO | 26741: exit 0 02:10:51 INFO - TEST-OK | dromaeo_css | took 1108025ms 02:10:51 INFO - TEST-START | kraken 02:10:51 INFO - operating with platform_type : linux_ 02:10:51 INFO - Initialising browser for kraken test... 02:10:51 INFO - TEST-INFO | started process 26982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdwCDVe/profile http://localhost:58560/getInfo.html) 02:10:54 INFO - PROCESS | 26982 | 02:10:54 INFO - PROCESS | 26982 | (process:27065): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:10:55 INFO - PROCESS | 26982 | __metrics Screen width/height:1600/1200 02:10:55 INFO - PROCESS | 26982 | colorDepth:24 02:10:55 INFO - PROCESS | 26982 | Browser inner width/height: 1024/697 02:10:55 INFO - PROCESS | 26982 | __metrics 02:10:55 ERROR - PROCESS | 26982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:10:56 INFO - TEST-INFO | 26982: exit 0 02:10:56 INFO - Browser initialized. 02:10:56 INFO - Running cycle 1/1 for kraken test... 02:10:56 INFO - TEST-INFO | started process 27116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdwCDVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:58 INFO - PROCESS | 27116 | 02:10:58 INFO - PROCESS | 27116 | (process:27184): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:11:08 INFO - PROCESS | 27116 | RSS: Main: 151019520 02:11:08 INFO - PROCESS | 27116 | 02:11:10 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58560/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:11 INFO - PROCESS | 27116 | RSS: Main: 156467200 02:11:11 INFO - PROCESS | 27116 | 02:11:14 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58560/tests/kraken/driver.html?testName=audio-dft) 02:11:14 INFO - PROCESS | 27116 | RSS: Main: 156078080 02:11:14 INFO - PROCESS | 27116 | 02:11:17 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58560/tests/kraken/driver.html?testName=audio-fft) 02:11:18 INFO - PROCESS | 27116 | RSS: Main: 156278784 02:11:18 INFO - PROCESS | 27116 | 02:11:20 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58560/tests/kraken/driver.html?testName=audio-oscillator) 02:11:21 INFO - PROCESS | 27116 | RSS: Main: 156372992 02:11:21 INFO - PROCESS | 27116 | 02:11:23 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:23 INFO - PROCESS | 27116 | RSS: Main: 156250112 02:11:23 INFO - PROCESS | 27116 | 02:11:26 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58560/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:27 INFO - PROCESS | 27116 | RSS: Main: 156372992 02:11:27 INFO - PROCESS | 27116 | 02:11:30 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58560/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:31 INFO - PROCESS | 27116 | RSS: Main: 156753920 02:11:31 INFO - PROCESS | 27116 | 02:11:34 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58560/tests/kraken/driver.html?testName=json-parse-financial) 02:11:34 INFO - PROCESS | 27116 | RSS: Main: 156372992 02:11:34 INFO - PROCESS | 27116 | 02:11:36 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:36 INFO - PROCESS | 27116 | RSS: Main: 156205056 02:11:36 INFO - PROCESS | 27116 | 02:11:38 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:11:39 INFO - PROCESS | 27116 | RSS: Main: 156442624 02:11:39 INFO - PROCESS | 27116 | 02:11:41 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:11:41 INFO - PROCESS | 27116 | RSS: Main: 156839936 02:11:41 INFO - PROCESS | 27116 | 02:11:44 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:11:44 INFO - PROCESS | 27116 | RSS: Main: 157011968 02:11:44 INFO - PROCESS | 27116 | 02:11:47 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:11:48 INFO - PROCESS | 27116 | RSS: Main: 156925952 02:11:48 INFO - PROCESS | 27116 | 02:11:49 INFO - PROCESS | 27116 | Cycle 1(1): loaded http://localhost:58560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58560/tests/kraken/driver.html?testName=ai-astar) 02:11:50 INFO - PROCESS | 27116 | RSS: Main: 158212096 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | __start_tp_report 02:11:50 INFO - PROCESS | 27116 | _x_x_mozilla_page_load 02:11:50 INFO - PROCESS | 27116 | _x_x_mozilla_page_load_details 02:11:50 INFO - PROCESS | 27116 | |i|pagename|runs| 02:11:50 INFO - PROCESS | 27116 | |0;ai-astar;107;113;103;110;111;112;101;113;112;113 02:11:50 INFO - PROCESS | 27116 | |1;audio-beat-detection;155;128;157;180;127;157;156;128;189;127 02:11:50 INFO - PROCESS | 27116 | |2;audio-dft;162;163;163;162;163;162;163;160;163;161 02:11:50 INFO - PROCESS | 27116 | |3;audio-fft;76;73;76;167;77;75;76;77;167;76 02:11:50 INFO - PROCESS | 27116 | |4;audio-oscillator;93;92;161;92;93;92;161;92;92;157 02:11:50 INFO - PROCESS | 27116 | |5;imaging-gaussian-blur;117;117;118;117;117;118;118;117;118;117 02:11:50 INFO - PROCESS | 27116 | |6;imaging-darkroom;146;145;146;147;146;146;147;146;146;146 02:11:50 INFO - PROCESS | 27116 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;95;95 02:11:50 INFO - PROCESS | 27116 | |8;json-parse-financial;56;55;55;55;55;57;60;74;54;54 02:11:50 INFO - PROCESS | 27116 | |9;json-stringify-tinderbox;57;58;56;58;57;56;59;57;56;57 02:11:50 INFO - PROCESS | 27116 | |10;stanford-crypto-aes;73;73;71;74;74;74;73;74;74;74 02:11:50 INFO - PROCESS | 27116 | |11;stanford-crypto-ccm;114;112;116;115;120;112;115;118;125;133 02:11:50 INFO - PROCESS | 27116 | |12;stanford-crypto-pbkdf2;159;156;157;167;164;157;161;156;161;162 02:11:50 INFO - PROCESS | 27116 | |13;stanford-crypto-sha256-iterative;67;69;65;69;66;66;71;68;66;66 02:11:50 INFO - PROCESS | 27116 | __end_tp_report 02:11:50 INFO - PROCESS | 27116 | __start_cc_report 02:11:50 INFO - PROCESS | 27116 | _x_x_mozilla_cycle_collect,825 02:11:50 INFO - PROCESS | 27116 | __end_cc_report 02:11:50 INFO - PROCESS | 27116 | __startTimestamp1467105110140__endTimestamp 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | ------- Summary: start ------- 02:11:50 INFO - PROCESS | 27116 | Number of tests: 14 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:4.38 (3.9%) stddev-sans-first:4.55 02:11:50 INFO - PROCESS | 27116 | Values: 107.0 113.0 103.0 110.0 111.0 112.0 101.0 113.0 112.0 113.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.50 stddev:22.62 (14.5%) stddev-sans-first:23.93 02:11:50 INFO - PROCESS | 27116 | Values: 155.0 128.0 157.0 180.0 127.0 157.0 156.0 128.0 189.0 127.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 02:11:50 INFO - PROCESS | 27116 | Values: 162.0 163.0 163.0 162.0 163.0 162.0 163.0 160.0 163.0 161.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:38.49 (50.6%) stddev-sans-first:40.27 02:11:50 INFO - PROCESS | 27116 | Values: 76.0 73.0 76.0 167.0 77.0 75.0 76.0 77.0 167.0 76.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:92.00 stddev:32.57 (35.4%) stddev-sans-first:33.77 02:11:50 INFO - PROCESS | 27116 | Values: 93.0 92.0 161.0 92.0 93.0 92.0 161.0 92.0 92.0 157.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:11:50 INFO - PROCESS | 27116 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:11:50 INFO - PROCESS | 27116 | Values: 146.0 145.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:11:50 INFO - PROCESS | 27116 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:55.50 stddev:6.06 (10.9%) stddev-sans-first:6.40 02:11:50 INFO - PROCESS | 27116 | Values: 56.0 55.0 55.0 55.0 55.0 57.0 60.0 74.0 54.0 54.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 02:11:50 INFO - PROCESS | 27116 | Values: 57.0 58.0 56.0 58.0 57.0 56.0 59.0 57.0 56.0 57.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 02:11:50 INFO - PROCESS | 27116 | Values: 73.0 73.0 71.0 74.0 74.0 74.0 73.0 74.0 74.0 74.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:117.00 stddev:6.57 (5.6%) stddev-sans-first:6.80 02:11:50 INFO - PROCESS | 27116 | Values: 114.0 112.0 116.0 115.0 120.0 112.0 115.0 118.0 125.0 133.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:161.00 stddev:3.68 (2.3%) stddev-sans-first:3.89 02:11:50 INFO - PROCESS | 27116 | Values: 159.0 156.0 157.0 167.0 164.0 157.0 161.0 156.0 161.0 162.0 02:11:50 INFO - PROCESS | 27116 | 02:11:50 INFO - PROCESS | 27116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.89 (2.8%) stddev-sans-first:2.00 02:11:50 INFO - PROCESS | 27116 | Values: 67.0 69.0 65.0 69.0 66.0 66.0 71.0 68.0 66.0 66.0 02:11:50 INFO - PROCESS | 27116 | -------- Summary: end -------- 02:11:50 INFO - PROCESS | 27116 | 02:11:51 INFO - TEST-INFO | 27116: exit 0 02:11:51 INFO - TEST-OK | kraken | took 60031ms 02:11:51 INFO - SUITE-END | took 1168s 02:11:51 INFO - Completed test suite (00:19:28) 02:11:51 INFO - javascript benchmark 02:11:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.504774283857, 3398.7620866539323, 3399.7790143640655, 3432.5709286339206, 3444.517767512547, 5591.66450012999, 5629.296337957755, 5633.80281690141, 5658.603897727161, 5663.575231857607, 5621.7751289948455, 5665.8668266346795, 5673.773049078042, 5674.971625141879, 5683.687397193163, 5089.1602885523935, 5156.58747300217, 5175.637705360627, 5197.428282888898, 5210.843674689765, 5066.569341605968, 5128.282040514331, 5287.973560132214, 5306.7611957462, 5312.362516498026, 5061.139606266925, 5158.509941555565, 5170.0, 5245.44922783108, 5262.868428289305, 5169.147090730025, 5189.818356357509, 5190.558802501791, 5194.6883187008525, 5208.76560554774, 5063.797448102108, 5103.260027296058, 5183.533481986639, 5184.9740751296, 5205.583553315726, 5396.947595218934, 5452.836414907559, 5490.313710786152, 5501.724913754337, 5527.778888844441, 5889.0, 5944.791932282349, 5945.137954996501, 5955.225820643332, 5966.552508561832, 5874.9118763218585, 6006.819795406145, 6010.398960103998, 6014.338422773535, 6021.09683547467, 5596.1605759136455, 5643.209950606918, 5645.407232240596, 5646.491815736604, 5746.454086861741, 6112.786052488231, 6125.418085281891, 6128.387161283925, 6140.478059364915, 6142.385761423911, 5829.387914268941, 5904.409559044061, 5905.202797622352, 5912.586118971717, 5920.200772895604, 5873.236479257755, 5901.29184497863, 5917.082852157922, 5921.526277897758, 5953.9878220702585, 5884.793617308442, 5887.676177810176, 5889.352171261158, 5902.704864756745, 5917.053271476543, 5861.5603829712945, 5887.381824908409, 5918.615290006136, 5983.940160598426, 5992.250968628921, 4520.480144783326, 4520.909581808345, 4522.66080043998, 4526.59260666535, 4548.431446069241, 4068.3083875741195, 4072.9185416291507, 4091.059056416981, 4110.383442483591, 4127.009517715726, 5719.742611582489, 5786.07422812348, 5851.0, 5857.121431785266, 5888.263967004124, 5861.003629383015, 5917.911231331534, 5932.110183472428, 5971.820845374646, 6023.608465449732, 5687.488126068673, 5719.857003574861, 5721.0, 5731.0, 5734.627249228787, 4963.404391473046, 4996.800127994912, 5082.923756143661, 5098.362704661918, 5111.616628752859, 6303.716332765037, 6346.27017892939, 6363.363663633692, 6399.8080057598345, 6405.903911441332, 5966.0454327307425, 6094.0, 6096.603720758137, 6107.816765497042, 6131.908021379772, 6264.185655864709, 6383.585066970632, 6387.0, 6391.840203994937, 6415.775447859302, 5888.793892213752, 5892.0, 5893.145493903446, 5899.67551784656, 5948.672822994777, 5943.613665111927, 5952.5237980960555, 5965.015772397506, 6033.78881739137, 6034.909476357946, 5758.366579676149, 5810.1575271586225, 5815.621984570989, 5830.591858569859, 5846.327672317738, 5750.568707346882, 5773.451522105393, 5799.652020878761, 5804.709764511673, 5814.04068328721, 5673.234113394639, 5674.233978412862, 5696.515796157373, 5796.884062318814, 5904.409559044061, 5899.0, 5928.67392293428, 5945.64326140433, 5952.702364881825, 5958.34458209588, 5792.3917988612275, 5812.0, 5816.069428891357, 5816.5055970243, 5817.0983497557945], "value": 5546.90086700197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4845372155997, 669.9732010719572, 677.5392732941601, 683.5044592670315, 739.1019910808367, 39389.212215755666, 40732.592674073254, 40749.79625101878, 40828.38757418641, 40896.79551602245, 43475.13049739011, 43588.564114358844, 44065.0, 44187.337189942176, 44247.0, 8745.125487451252, 8905.154010369037, 8916.866247006301, 8943.239824614882, 8959.507227102507, 8689.913760779902, 8820.647174113028, 8821.911780882205, 8825.249853762405, 8846.823063538724, 9089.909100909006, 9165.31260155491, 9165.633374665005, 9181.770455738626, 9200.0, 9019.143181397756, 9064.41081329718, 9068.365214434993, 9073.7277881663, 9091.545422728903, 8765.561721913942, 8847.159519845605, 8849.557522123869, 8859.734207973772, 8861.246794022516, 44157.55842441566, 44417.0, 44448.3332750009, 44622.10755784898, 44703.32945005828, 3729.310077635646, 3820.331441997639, 3826.598207188233, 3945.0926286954164, 4044.272031034442, 33660.0, 33777.0, 33946.49080263798, 34127.31745365079, 34194.14514637129, 4487.708298960557, 4559.17934771741, 4564.064366804797, 4569.565891240327, 4625.791839367203, 323010.0, 324644.0, 325423.0, 325475.0, 326995.3650231757, 39286.0, 39694.80152599219, 61158.0, 61458.69270653708, 61545.38454615486, 37585.81207093947, 37603.0, 37730.0, 37772.244555108744, 37780.62219377826, 16296.185190740416, 16471.094089824936, 16475.917620411823, 16489.505314840575, 16531.090790006423, 14772.852271477363, 14795.112293262438, 14819.481318154028, 14854.0, 14854.108753474826, 9433.716988490356, 9489.715308540755, 9492.857607135898, 9534.618615255451, 9553.235741140692, 3620.1854582719207, 3631.455281707765, 3641.780003698738, 3644.817759112034, 3705.1478160022807, 1159.1306520109918, 1163.3310846263432, 1226.8589112252205, 1246.5948566715672, 1251.2742609286593, 33809.323813523595, 33819.66180338165, 33919.15202119967, 34067.14832129217, 34214.657853421144, 1232.993835030837, 1242.4151994429487, 1262.211118051218, 1315.329531494996, 1318.8021796730375, 17458.476245712394, 17561.736573951403, 17639.647207055787, 17755.911220443813, 17874.642507150045, 472334.0, 535220.0, 546310.0, 877101.0, 896926.0, 63028.684856575426, 63754.0, 64105.0, 64258.0, 64742.67628661827, 1509.7584386498108, 1542.9382824687111, 1546.2809793446102, 1561.8984765990174, 1564.8982816116916, 33455.83272083624, 33947.83026084854, 34002.65997339995, 34456.310873781884, 34859.302813943075, 54128.458715412344, 55231.44768552424, 56516.43483565276, 56628.15057774219, 57065.71467142638, 318749.0, 321663.0, 322038.0, 322642.0, 322972.0, 44474.55525444704, 45165.54834451614, 45451.54548454473, 45767.313490297005, 50411.243831341824, 53968.19047714366, 54472.72763636157, 55656.721716391155, 55760.0, 55878.72060639671, 44966.77516612396, 46037.53962460333, 46415.53584464247, 46748.7662561685, 47547.0, 45166.0, 45184.14159853899, 45819.31271031004, 46014.0, 46329.0, 46189.76905115453, 47045.294320585905, 47243.0, 47315.76342118405, 47465.81335466641, 39158.80420597879, 39559.60440395674, 39610.80194599008, 40002.59997400105, 40686.0, 30310.545341820332, 30609.54085688672, 30980.0, 31052.378952421277, 31099.84450077735], "value": 20306.58583507314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.79339299089355, 432.40544251653967, 442.3320785613722, 443.96892217544786, 448.7442157969957, 18449.354272600445, 18786.0, 19459.902700486495, 20129.396118116445, 20160.89919550404, 19165.712514312298, 19559.70660440091, 19656.11547480363, 19800.10899509522, 19823.10796014179, 5723.141528770697, 5761.539076873861, 5952.58331916766, 5953.493953013977, 5974.4921681657115, 5431.565474762029, 5684.744186511617, 5726.341470730857, 5773.509251713609, 5863.384344643815, 5628.212050312939, 5699.173619825123, 5702.45826646468, 5705.62913410627, 5721.542276617861, 5918.822435326947, 5919.733611987471, 5966.791162309299, 5977.850553736148, 5988.610740301889, 5675.51758100562, 5766.077427611562, 5798.855028624276, 5807.854803629901, 5809.186713860063, 13858.0, 14183.149011059266, 14351.354189061518, 14385.136891786526, 14412.927935360362, 2364.101641376283, 2425.0057476434577, 2546.579814330652, 2591.183777110204, 3064.4024415239037, 9807.950960245153, 10053.547590358377, 10277.948610256975, 12559.058070644738, 14423.206723630195, 1957.8237958583654, 1965.1549833571557, 1965.8230759231737, 1992.1832048860042, 2113.1124927530473, 74144.25855741427, 75520.9791608335, 76577.61711191465, 77108.61445692736, 78545.60727196328, 11197.272177308449, 11230.7192320191, 11464.770704586028, 11496.42517874103, 11620.128490363257, 15899.0, 15956.680866382607, 15987.0, 16020.27908744086, 16024.519264422086, 8648.351373647001, 8698.782530436789, 8827.867581986275, 8892.377533572717, 8915.866262006075, 8412.537310447984, 8555.614997325136, 8617.439866408664, 8701.086385929386, 8713.128687131362, 4674.6026587740425, 4788.736619485892, 4836.443808961944, 4873.610111191097, 4885.998370334073, 2028.7869773673847, 2060.732104826363, 2080.1887263967064, 2083.4062292246635, 2113.3131732187103, 987.3236832769576, 1051.0435503691756, 1066.8506409102731, 1099.780043991205, 1155.064397837754, 17930.372436964644, 18330.81669183291, 18586.535336616424, 18613.627727445648, 18879.150438230314, 1080.6001779341536, 1091.8853520380405, 1104.0394856474918, 1123.702218911989, 1143.6854864912216, 9971.0, 10420.374777513221, 10428.104819607519, 10566.735831604272, 10639.627613033506, 489131.0, 508721.0, 509750.0, 516600.0, 517988.0, 89134.55432722795, 89696.551517242, 89755.55122224348, 90524.0, 90805.0, 1048.6801525534634, 1058.9523471443804, 1062.5324857062867, 1071.314358810362, 1106.9667909962875, 16455.0, 16543.0, 16627.25177366997, 16809.32762689479, 17047.147642618067, 36846.26307473889, 37715.0, 38254.23491530209, 38754.80622596869, 39117.80441097776, 55843.0, 56229.437705624056, 56337.15494267507, 56574.15138773004, 56671.71664141818, 8813.294936404944, 8836.469811811312, 10414.271001029856, 12025.819612705642, 12220.266783992989, 12767.425465853874, 13797.241151736349, 14259.287035647969, 14475.131492110508, 14672.266386680836, 12551.121421500407, 12688.6827829305, 12715.80926286125, 12948.417321220379, 13039.087263891437, 12069.336186509827, 12335.629931102081, 12727.363631818558, 12751.872481275068, 12765.93617031909, 7805.297523222937, 8519.829603407774, 12544.310062946626, 12664.74670506603, 12739.235645860907, 9892.060254275832, 10403.0, 10420.583176673152, 10647.361158330525, 10650.360978341325, 11682.88317116818, 11897.0, 11919.702007449536, 12104.334261615695, 12201.267923924594], "value": 9435.488248285483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.969780604388, 1553.541705196967, 1768.3899054826081, 1896.2320260294578, 1896.3931541906595, 7242.420606351492, 7928.563928983904, 8016.559089250089, 8211.343092552597, 8246.62890169943, 8068.314193293562, 8106.148854370294, 8137.267645911867, 8321.33429325654, 8326.66693332266, 2348.788609025192, 2374.347054560001, 2381.0594815048044, 2385.3440303916386, 2391.928242152738, 2374.608189648706, 2387.761223877607, 2410.9397265068337, 2415.553122672311, 2426.9271921842374, 2356.281334193079, 2358.551875143717, 2370.3244575295957, 2381.130887226159, 2399.8920048597856, 2372.3120295114395, 2377.9643305350432, 2382.404398900275, 2403.8918248678765, 2414.263649586875, 2407.4222186675247, 2418.8427752196053, 2420.0319872051145, 2429.635554666814, 2439.9756002440104, 8109.837803243961, 8120.75637730869, 8151.429399942006, 8156.062052863878, 8190.795230119235, 5212.087884620214, 5270.894582108336, 5325.520703136736, 5330.307060082203, 5345.198220266952, 3334.333133373311, 3381.171612954817, 3394.0835974286806, 3505.3339865425487, 3519.5248641433336, 1025.0, 1049.695588279398, 1051.5110473629722, 1064.978700425995, 1075.763332066944, 10966.177536684781, 11121.499532520975, 11149.554017839277, 11177.21759476837, 11234.101271898311, 4413.426254586883, 4454.4654641442585, 4512.075024619945, 4547.567981041796, 4597.44830620321, 9116.954415227881, 9156.816863662689, 9157.267418606496, 9180.495072770927, 9181.173694367539, 5247.711375874287, 5258.763355649005, 5278.313819203479, 5295.15277555597, 5346.465353464622, 4790.0180463005, 4967.105920934267, 5006.6495345325475, 5036.471170527042, 5040.067587496325, 3742.1206016586625, 3808.0, 3832.3676593362343, 3849.7690138591215, 3941.960580394217, 1116.5812820192427, 1125.8536390269212, 1150.3730466895563, 1181.5923506390282, 1195.0, 1067.64767626683, 1069.9625513107003, 1088.3905013192636, 1104.8342748587615, 1110.1396417776127, 5804.738786754606, 5838.241028666331, 5981.461668449861, 5992.191054207626, 6043.969780151159, 475.5292260661989, 480.8052738640856, 485.7328469341848, 487.8512053823618, 490.70557665400474, 4279.186954478639, 4319.503257125408, 4323.308270676676, 4385.649148068147, 4405.0, 9901.059399357193, 9980.451075190935, 10164.542595583216, 10172.542235599416, 10184.694459166238, 9854.901450985542, 9892.55483503244, 9993.200543956465, 10004.849927251096, 10037.0, 7825.0, 7990.840183196304, 8017.078036025815, 8136.430449868452, 8155.062167850654, 5439.891202175855, 5498.0, 5502.202180683858, 5579.358373787067, 5621.5221706155435, 8772.342074344577, 8831.602577883883, 8845.69040083594, 8956.417832840845, 8988.999999999738, 8833.29333653319, 9013.414128081917, 9097.13577210164, 9122.270218382646, 9133.132352426508, 7746.57393843344, 7839.0, 7860.606969651609, 7906.248906353887, 7981.441299109007, 7956.562389068657, 8011.799705007422, 8026.919730802851, 8052.557109358807, 8060.476069055727, 7089.893651595334, 7312.451566132455, 7350.669219885011, 7425.480216384801, 7441.516301440389, 7046.1192350956135, 7418.888716669362, 7529.924700752922, 7534.962325188339, 7657.540547567164, 6835.14560679915, 6858.41703455192, 6874.793756187322, 6928.44572434194, 6930.0, 4945.629077819106, 5220.817271395483, 5317.946820531745, 5502.422245664307, 5665.178549110438, 5436.891262174813, 5554.2779438672715, 5561.610687251854, 5562.527185189304, 5595.5523558116065], "value": 4465.6208778455675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.0582259922505, 364.31326948701707, 367.36262584416016, 371.1297008515033, 375.24201113750223, 6376.234851817777, 6435.678216089189, 6486.254080780705, 6524.086627872101, 6550.967245163767, 6536.2156541215, 6562.606243625386, 6564.376384243489, 6568.835779105513, 6579.0, 4962.206047032476, 4964.826231081913, 4970.776315065822, 4981.875453113665, 4988.625853061017, 4976.576990955773, 4977.751112444382, 4977.925331120036, 4981.875453113665, 4999.500049994989, 4933.136701077297, 4939.827106051289, 4940.357753492041, 4952.33143525623, 4953.182724850395, 4721.480637129947, 4867.953390021127, 4921.483244259372, 4938.037082768861, 4942.777575009115, 4202.474690663667, 4234.5553716859595, 4240.342746874208, 4261.019965407973, 4263.189993901149, 6231.688415579203, 6242.533004743882, 6244.687765611701, 6248.3751624837605, 6255.343188965184, 5559.861003474905, 5672.461116193955, 5682.914756278659, 5727.0, 5738.311402631669, 6843.8973415398805, 6854.554453960476, 6865.725370985205, 6877.3810357068105, 6883.518153729241, 4780.043991201774, 4783.832565860178, 4784.114938736345, 4786.0, 4790.592799612037, 7075.080239568823, 7115.5730656160795, 7162.820929476753, 7166.713331466787, 7189.7483588074165, 4900.0, 4901.411830580353, 4912.042151780369, 4912.164931961575, 4923.08922849274, 4746.5490778376, 4830.758462076882, 4849.248366503127, 4853.708777473293, 4861.149298872683, 5558.527525160326, 5650.604457687922, 5671.943280567141, 5678.517326027334, 5685.488306052475, 6862.039314495874, 6889.758858439931, 6908.758193463204, 6914.0666010089, 6931.133608298963, 1708.5899384147715, 1709.8803083784017, 1716.0990479997852, 1716.2019660857761, 1720.346268418018, 1097.1880808202034, 1124.1793490751797, 1132.2357408749226, 1133.7335726104359, 1151.9827202591969, 6680.899786503206, 6689.6989635466525, 6700.731970721116, 6711.597304161766, 6729.798106056826, 7055.470839687044, 7068.893966590505, 7069.045678833395, 7083.716651333992, 7090.964545177344, 6671.899921501182, 6674.9666251669405, 6681.665916704243, 6695.062691223233, 6703.29615390377, 3787.715921305913, 3806.4861243732294, 3838.213166300902, 3840.2127563849344, 3841.9039524012123, 7277.563346199245, 7450.478466507292, 7456.067991501062, 7471.514351567131, 7472.252774722593, 7238.059052323164, 7308.96345518269, 7335.963320183365, 7345.375643070292, 7351.117865856025, 7500.812479687942, 7568.205338439385, 7582.241775822374, 7582.87679449755, 7590.354819840375, 6962.3733863950465, 7194.496385253191, 7227.096612923385, 7233.746818861525, 7238.131424229126, 7090.255523170199, 7122.0, 7138.107736532934, 7146.035285236427, 7147.606881621353, 7598.088229412506, 7605.201453847267, 7609.048868891388, 7618.200088990798, 7625.885611715939, 4756.310335001336, 4769.236922092448, 4772.308015337826, 4781.378420805273, 4783.091212669582, 7026.578405295699, 7197.928020719935, 7203.315685009916, 7211.098612673416, 7216.639168041682, 6977.79066628002, 6979.162500499972, 6980.092587963532, 6980.406665433292, 6993.545419547713, 6924.480663950325, 6945.409640180641, 6954.9304506956305, 6962.965185174042, 6974.407175389946, 6848.897266541106, 6849.589024658537, 6851.657417129223, 6857.074294970115, 6867.793966181022, 6791.89812152828, 7002.299770022957, 7011.193712723102, 7014.579125252501, 7037.859242815218, 6656.933430665631, 6809.285025072296, 6827.214870289781, 6837.564111536633, 6843.726250950105], "value": 5204.286480910801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.2083762101246, 890.7817584691755, 891.915268049535, 895.6506962284708, 906.7415786500841, 15279.388824447024, 15588.454404095859, 15635.921820390882, 15639.921800390983, 15648.374065037398, 13608.387622556984, 13684.384202710877, 13697.178169309824, 13705.3832577534, 13706.862931370682, 746.0748671647145, 879.9384043116985, 887.9778005549848, 907.4645958884257, 908.0556221529602, 880.6785523284019, 885.5527958381009, 890.9376343655947, 897.0760117079419, 897.9146981036791, 940.6143481172686, 942.0626476655702, 945.0879900895634, 954.6181527389031, 957.1098878043417, 940.0881145289059, 945.7682867697458, 948.3219498058886, 949.5726922884729, 949.8622699708503, 698.7554355975419, 700.422151724824, 701.6351497221467, 701.824543864034, 702.5538782872861, 13780.793288100687, 13785.655358616015, 13895.444182232699, 13902.513412030632, 13938.651533711636, 15151.469698560497, 15261.313240904186, 15486.148261845594, 15497.302621382065, 15517.0, 12221.388930553438, 12385.690357741129, 12449.875501244962, 12449.875501244962, 12476.75046499065, 4055.1889622075705, 4099.159672267178, 4114.835406583733, 4122.90820836267, 4173.874783756492, 54711.45288547104, 54897.0, 55332.44667553313, 55512.722436387965, 57086.143707844, 11735.354555499529, 11795.174337796443, 11980.820287695691, 12073.15487915855, 12139.635810925687, 20853.061612227488, 20878.478038048866, 20924.686129708065, 20930.47673808167, 21051.473713157295, 8689.869651955225, 8742.169493898069, 8845.734627961172, 8937.955310223537, 9001.324900632348, 4868.342773725572, 4880.707157570557, 4989.226669866177, 4998.2502624606595, 4999.550130462125, 3519.225770330523, 3550.3076900004767, 3567.1795487038125, 3572.4284114541547, 3578.087587665129, 572.4561666416921, 626.0421555020735, 628.8019273928697, 628.8207860759661, 630.5523078614143, 670.0652589637526, 775.5700390261284, 808.2483290539855, 832.4422636833336, 833.4915701422127, 9176.770580735401, 10153.4923253837, 10250.179985601135, 10368.0, 10483.633072842415, 779.2674885607511, 826.8470332988417, 827.9461834980827, 829.0383155539545, 846.3990566697713, 4627.490975992638, 4687.929681054787, 4705.12955103307, 4746.715197088186, 4760.952390476051, 61762.38237617656, 66058.0, 66496.66751666211, 66510.0, 66524.33475665278, 54680.45319546833, 54895.45104548983, 55066.449335506935, 55602.44397555973, 56648.0, 53562.19656705153, 54039.0, 54387.184192237146, 54445.72777136089, 55414.0, 10193.082622564005, 10234.539445724811, 10393.58425662965, 10399.688009359732, 10407.843882341922, 38002.239955201294, 38234.61765382311, 38555.42166867555, 39685.60314396819, 40722.0, 48105.75947120382, 49743.50256497389, 50406.747966259936, 51049.0, 51330.97338053143, 12181.756364872475, 12871.22772633645, 12992.155509891827, 13195.274259915797, 13246.735065298833, 14516.564503064925, 14556.41774329015, 14916.328765205375, 15108.39566417331, 15494.845051549792, 13525.0, 13705.794413084011, 13795.793063104262, 13866.376013079234, 14264.857351426353, 13379.598612041655, 13458.596242112751, 13745.587632371045, 13811.654708632364, 14236.217008064656, 13109.1479053865, 13599.320033998458, 13763.105398149088, 13793.517226897011, 13890.958178136478, 11047.337159770119, 11048.723781905517, 11819.645410637351, 11871.76256474883, 11901.0, 11740.823887641864, 11770.411479426166, 11860.76278474443, 11970.640880773592, 12081.0], "value": 7284.6940297963, "unit": "score"}], "name": "dromaeo_css", "value": 7513.763921778998, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 103.0, 110.0, 111.0, 112.0, 101.0, 113.0, 112.0, 113.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 157.0, 180.0, 127.0, 157.0, 156.0, 128.0, 189.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 163.0, 162.0, 163.0, 160.0, 163.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 76.0, 167.0, 77.0, 75.0, 76.0, 77.0, 167.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 161.0, 92.0, 93.0, 92.0, 161.0, 92.0, 92.0, 157.0], "value": 112.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 57.0, 60.0, 74.0, 54.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 58.0, 57.0, 56.0, 59.0, 57.0, 56.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 71.0, 74.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 116.0, 115.0, 120.0, 112.0, 115.0, 118.0, 125.0, 133.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 157.0, 167.0, 164.0, 157.0, 161.0, 156.0, 161.0, 162.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 69.0, 66.0, 66.0, 71.0, 68.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1520.6, "alertThreshold": 2.0}]} 02:11:51 INFO - Return code: 0 02:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:11:51 ERROR - # TBPL SUCCESS # 02:11:51 INFO - Running post-action listener: _resource_record_post_action 02:11:51 INFO - Running post-run listener: _resource_record_post_run 02:11:52 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 466411520; Read time: 0; Write time: 322452 02:11:52 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242614272; Read time: 0; Write time: 208836 02:11:52 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 223797248; Read time: 0; Write time: 113616 02:11:52 INFO - Running post-run listener: _upload_blobber_files 02:11:52 INFO - Blob upload gear active. 02:11:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:11:52 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 02:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:11:52 INFO - (blobuploader) - INFO - Open directory for files ... 02:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:53 INFO - (blobuploader) - INFO - Done attempting. 02:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:54 INFO - (blobuploader) - INFO - Done attempting. 02:11:54 INFO - (blobuploader) - INFO - Iteration through files over. 02:11:54 INFO - Return code: 0 02:11:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:11:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:11:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec6a741f7e53adb044a949b3fe37276a4f6458a70d059a4e6bb4443c571b92e9f6e2754ad2c4343cfd08fc85fbf0a0bfa1a420fb2388e1858118a99e9fd48a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df6835f0b9b3073fd92702d4ec9a195f8145fb9a437c60962588ee599d085930301652b3e1de751ba971bfca22346a7b7c0f54dd74d02efd1af2773c98b3f42b"} 02:11:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:11:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:11:54 INFO - Contents: 02:11:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec6a741f7e53adb044a949b3fe37276a4f6458a70d059a4e6bb4443c571b92e9f6e2754ad2c4343cfd08fc85fbf0a0bfa1a420fb2388e1858118a99e9fd48a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df6835f0b9b3073fd92702d4ec9a195f8145fb9a437c60962588ee599d085930301652b3e1de751ba971bfca22346a7b7c0f54dd74d02efd1af2773c98b3f42b"} 02:11:54 INFO - Running post-run listener: copy_logs_to_upload_dir 02:11:54 INFO - Copying logs to upload dir... 02:11:54 INFO - mkdir: /builds/slave/test/build/upload/logs 02:11:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.869173 ========= master_lag: 1.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-28 02:11:56.109178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.113472) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec6a741f7e53adb044a949b3fe37276a4f6458a70d059a4e6bb4443c571b92e9f6e2754ad2c4343cfd08fc85fbf0a0bfa1a420fb2388e1858118a99e9fd48a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df6835f0b9b3073fd92702d4ec9a195f8145fb9a437c60962588ee599d085930301652b3e1de751ba971bfca22346a7b7c0f54dd74d02efd1af2773c98b3f42b"} build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009765 build_url: 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec6a741f7e53adb044a949b3fe37276a4f6458a70d059a4e6bb4443c571b92e9f6e2754ad2c4343cfd08fc85fbf0a0bfa1a420fb2388e1858118a99e9fd48a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df6835f0b9b3073fd92702d4ec9a195f8145fb9a437c60962588ee599d085930301652b3e1de751ba971bfca22346a7b7c0f54dd74d02efd1af2773c98b3f42b"}' ========= master_lag: 0.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.560195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.560498) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467103627.272420-1292399594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:11:56.641995) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-06-28 02:11:56.645984) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-06-28 02:12:00.041367) ========= ========= Total master_lag: 2.23 =========