builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1468672977.08 results: success (0) buildid: 20160716031551 builduid: f0444271b36645f7946ad9d54604da1d revision: 24af5e8917a2a3efabc8f1c614c709282fc2d473 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.079694) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.080173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.080550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.129087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.129437) ========= 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=232498196343f89f466a4a9a000001c8-1468672267.221793-311033106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 05:42:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-16 05:42:57 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225367 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.387638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.388249) ========= 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=232498196343f89f466a4a9a000001c8-1468672267.221793-311033106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.080839 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.490003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:57.490386) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 24af5e8917a2a3efabc8f1c614c709282fc2d473 --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 24af5e8917a2a3efabc8f1c614c709282fc2d473 --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=232498196343f89f466a4a9a000001c8-1468672267.221793-311033106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 05:42:57,565 truncating revision to first 12 chars 2016-07-16 05:42:57,565 Setting DEBUG logging. 2016-07-16 05:42:57,565 attempt 1/10 2016-07-16 05:42:57,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/24af5e8917a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 05:42:57,890 unpacking tar archive at: mozilla-beta-24af5e8917a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668563 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:58.179088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:58.179841) ========= script_repo_revision: 24af5e8917a2a3efabc8f1c614c709282fc2d473 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:58.180806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:58.181508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 05:42:58.193926) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-07-16 05:42:58.194236) ========= /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=232498196343f89f466a4a9a000001c8-1468672267.221793-311033106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:58 INFO - MultiFileLogger online at 20160716 05:42:58 in /builds/slave/test 05:42:58 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 05:42:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:58 INFO - {'append_to_log': False, 05:42:58 INFO - 'base_work_dir': '/builds/slave/test', 05:42:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:42:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:58 INFO - 'branch': 'Mozilla-Beta', 05:42:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:58 INFO - 'config_files': ('talos/linux_config.py',), 05:42:58 INFO - 'default_actions': ('clobber', 05:42:58 INFO - 'read-buildbot-config', 05:42:58 INFO - 'download-and-extract', 05:42:58 INFO - 'populate-webroot', 05:42:58 INFO - 'create-virtualenv', 05:42:58 INFO - 'install', 05:42:58 INFO - 'run-tests'), 05:42:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:58 INFO - 'download_minidump_stackwalk': True, 05:42:58 INFO - 'download_symbols': 'ondemand', 05:42:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:58 INFO - 'installer_path': 'installer.exe', 05:42:58 INFO - 'log_level': 'info', 05:42:58 INFO - 'log_name': 'talos', 05:42:58 INFO - 'log_to_console': True, 05:42:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:58 INFO - 'opt_config_files': (), 05:42:58 INFO - 'pip_index': False, 05:42:58 INFO - 'sps_profile': False, 05:42:58 INFO - 'sps_profile_interval': 0, 05:42:58 INFO - 'suite': 'dromaeojs-e10s', 05:42:58 INFO - 'system_bits': '32', 05:42:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:58 INFO - 'title': 'talos-linux64-ix-025', 05:42:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:58 INFO - 'use_talos_json': True, 05:42:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:58 INFO - 'work_dir': 'build'} 05:42:58 INFO - ##### 05:42:58 INFO - ##### Running clobber step. 05:42:58 INFO - ##### 05:42:58 INFO - Running pre-action listener: _resource_record_pre_action 05:42:58 INFO - Running main action method: clobber 05:42:58 INFO - rmtree: /builds/slave/test/build 05:42:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:59 INFO - Running post-action listener: _resource_record_post_action 05:42:59 INFO - ##### 05:42:59 INFO - ##### Running read-buildbot-config step. 05:42:59 INFO - ##### 05:42:59 INFO - Running pre-action listener: _resource_record_pre_action 05:42:59 INFO - Running main action method: read_buildbot_config 05:42:59 INFO - Using buildbot properties: 05:42:59 INFO - { 05:42:59 INFO - "project": "", 05:42:59 INFO - "product": "firefox", 05:42:59 INFO - "script_repo_revision": "production", 05:42:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:42:59 INFO - "repository": "", 05:42:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:42:59 INFO - "buildid": "20160716031551", 05:42:59 INFO - "pgo_build": "True", 05:42:59 INFO - "basedir": "/builds/slave/test", 05:42:59 INFO - "buildnumber": 178, 05:42:59 INFO - "slavename": "talos-linux64-ix-025", 05:42:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:42:59 INFO - "platform": "ubuntu64_hw", 05:42:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:42:59 INFO - "branch": "mozilla-beta", 05:42:59 INFO - "repo_path": "releases/mozilla-beta", 05:42:59 INFO - "revision": "24af5e8917a2a3efabc8f1c614c709282fc2d473", 05:42:59 INFO - "stage_platform": "linux64-pgo", 05:42:59 INFO - "builduid": "f0444271b36645f7946ad9d54604da1d", 05:42:59 INFO - "slavebuilddir": "test" 05:42:59 INFO - } 05:42:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:42:59 INFO - Running post-action listener: _resource_record_post_action 05:42:59 INFO - ##### 05:42:59 INFO - ##### Running download-and-extract step. 05:42:59 INFO - ##### 05:42:59 INFO - Running pre-action listener: _resource_record_pre_action 05:42:59 INFO - Running main action method: download_and_extract 05:42:59 INFO - mkdir: /builds/slave/test/build/tests 05:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:59 INFO - https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:42:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:42:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:42:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:04 INFO - Downloaded 1327 bytes. 05:43:04 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:43:04 INFO - Using the following test package requirements: 05:43:04 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:43:04 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:04 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:43:04 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'jsshell-linux-x86_64.zip'], 05:43:04 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:04 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:43:04 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:43:04 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:43:04 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:04 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:43:04 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:04 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:04 INFO - https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:07 INFO - Downloaded 24200502 bytes. 05:43:07 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'] 05:43:07 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 05:43:08 INFO - Return code: 0 05:43:08 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 05:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:08 INFO - https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:43:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:43:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:16 INFO - Downloaded 24200502 bytes. 05:43:16 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'] 05:43:16 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 05:43:18 INFO - Return code: 0 05:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:18 INFO - https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:19 INFO - Downloaded 10840145 bytes. 05:43:19 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'] 05:43:19 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 05:43:20 INFO - Return code: 0 05:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:20 INFO - https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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 05:43:21 INFO - Downloaded 56017548 bytes. 05:43:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:43:21 INFO - mkdir: /builds/slave/test/properties 05:43:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:21 INFO - Contents: 05:43:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:43:22 INFO - Running post-action listener: _resource_record_post_action 05:43:22 INFO - Running post-action listener: set_extra_try_arguments 05:43:22 INFO - ##### 05:43:22 INFO - ##### Running populate-webroot step. 05:43:22 INFO - ##### 05:43:22 INFO - Running pre-action listener: _resource_record_pre_action 05:43:22 INFO - Running main action method: populate_webroot 05:43:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:22 INFO - '--tppagecycles', 05:43:22 INFO - '7'], 05:43:22 INFO - 'tests': ['tsvgm']}}, 05:43:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['damp', 'tps']}, 05:43:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'tests': ['damp', 'tps']}, 05:43:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['dromaeo_dom']}, 05:43:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['a11yr', 05:43:22 INFO - 'ts_paint', 05:43:22 INFO - 'tpaint', 05:43:22 INFO - 'sessionrestore', 05:43:22 INFO - 'sessionrestore_no_auto_restore', 05:43:22 INFO - 'tabpaint']}, 05:43:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:22 INFO - 'ts_paint', 05:43:22 INFO - 'tpaint', 05:43:22 INFO - 'sessionrestore', 05:43:22 INFO - 'sessionrestore_no_auto_restore', 05:43:22 INFO - 'tabpaint']}, 05:43:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:22 INFO - 'ts_paint', 05:43:22 INFO - 'tpaint', 05:43:22 INFO - 'sessionrestore', 05:43:22 INFO - 'sessionrestore_no_auto_restore', 05:43:22 INFO - 'tabpaint']}, 05:43:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:22 INFO - 'ts_paint', 05:43:22 INFO - 'tpaint', 05:43:22 INFO - 'sessionrestore', 05:43:22 INFO - 'sessionrestore_no_auto_restore', 05:43:22 INFO - 'tabpaint']}, 05:43:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['a11yr', 05:43:22 INFO - 'ts_paint', 05:43:22 INFO - 'tpaint', 05:43:22 INFO - 'sessionrestore', 05:43:22 INFO - 'sessionrestore_no_auto_restore', 05:43:22 INFO - 'tabpaint']}, 05:43:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['a11yr', 05:43:22 INFO - 'ts_paint', 05:43:22 INFO - 'tpaint', 05:43:22 INFO - 'sessionrestore', 05:43:22 INFO - 'sessionrestore_no_auto_restore', 05:43:22 INFO - 'tabpaint']}, 05:43:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['tsvgx', 05:43:22 INFO - 'tsvgr_opacity', 05:43:22 INFO - 'tart', 05:43:22 INFO - 'tscrollx', 05:43:22 INFO - 'cart']}, 05:43:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:22 INFO - 'tsvgr_opacity', 05:43:22 INFO - 'tart', 05:43:22 INFO - 'tscrollx', 05:43:22 INFO - 'cart']}, 05:43:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'talos_options': ['--disable-e10s'], 05:43:22 INFO - 'tests': ['tp5o']}, 05:43:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'tests': ['tp5o']}, 05:43:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'talos_options': ['--disable-e10s', 05:43:22 INFO - '--xperf_path', 05:43:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:22 INFO - 'tests': ['tp5n']}, 05:43:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:22 INFO - 'talos_options': ['--xperf_path', 05:43:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:22 INFO - 'tests': ['tp5n']}}, 05:43:22 INFO - 'talos.zip': {'path': '', 05:43:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:22 INFO - Running post-action listener: _resource_record_post_action 05:43:22 INFO - ##### 05:43:22 INFO - ##### Running create-virtualenv step. 05:43:22 INFO - ##### 05:43:22 INFO - Running pre-action listener: _resource_record_pre_action 05:43:22 INFO - Running main action method: create_virtualenv 05:43:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:43:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:22 INFO - Using real prefix '/usr' 05:43:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:25 INFO - Installing pip.................done. 05:43:25 INFO - Return code: 0 05:43:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:25 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:25 INFO - Using env: {'DISPLAY': ':0', 05:43:25 INFO - 'HOME': '/home/cltbld', 05:43:25 INFO - 'LANG': 'en_US.UTF-8', 05:43:25 INFO - 'LANGUAGE': 'en_US:en', 05:43:25 INFO - 'LOGNAME': 'cltbld', 05:43:25 INFO - 'MAIL': '/var/mail/cltbld', 05:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:25 INFO - 'MOZ_NO_REMOTE': '1', 05:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:25 INFO - 'NO_EM_RESTART': '1', 05:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:25 INFO - 'PWD': '/builds/slave/test', 05:43:25 INFO - 'SHELL': '/bin/bash', 05:43:25 INFO - 'SHLVL': '1', 05:43:25 INFO - 'TERM': 'linux', 05:43:25 INFO - 'TMOUT': '86400', 05:43:25 INFO - 'USER': 'cltbld', 05:43:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:25 INFO - '_': '/tools/buildbot/bin/python'} 05:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:25 INFO - Cleaning up... 05:43:25 INFO - Return code: 0 05:43:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:25 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:43:25 INFO - Using env: {'DISPLAY': ':0', 05:43:25 INFO - 'HOME': '/home/cltbld', 05:43:25 INFO - 'LANG': 'en_US.UTF-8', 05:43:25 INFO - 'LANGUAGE': 'en_US:en', 05:43:25 INFO - 'LOGNAME': 'cltbld', 05:43:25 INFO - 'MAIL': '/var/mail/cltbld', 05:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:25 INFO - 'MOZ_NO_REMOTE': '1', 05:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:25 INFO - 'NO_EM_RESTART': '1', 05:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:25 INFO - 'PWD': '/builds/slave/test', 05:43:25 INFO - 'SHELL': '/bin/bash', 05:43:25 INFO - 'SHLVL': '1', 05:43:25 INFO - 'TERM': 'linux', 05:43:25 INFO - 'TMOUT': '86400', 05:43:25 INFO - 'USER': 'cltbld', 05:43:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:25 INFO - '_': '/tools/buildbot/bin/python'} 05:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:25 INFO - Downloading/unpacking psutil>=0.7.1 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:27 INFO - Installing collected packages: psutil 05:43:27 INFO - Running setup.py install for psutil 05:43:27 INFO - building 'psutil._psutil_linux' extension 05:43:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:43:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:43:29 INFO - building 'psutil._psutil_posix' extension 05:43:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:43:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:43:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:29 INFO - Successfully installed psutil 05:43:29 INFO - Cleaning up... 05:43:29 INFO - Return code: 0 05:43:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:29 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:29 INFO - Using env: {'DISPLAY': ':0', 05:43:29 INFO - 'HOME': '/home/cltbld', 05:43:29 INFO - 'LANG': 'en_US.UTF-8', 05:43:29 INFO - 'LANGUAGE': 'en_US:en', 05:43:29 INFO - 'LOGNAME': 'cltbld', 05:43:29 INFO - 'MAIL': '/var/mail/cltbld', 05:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:29 INFO - 'MOZ_NO_REMOTE': '1', 05:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:29 INFO - 'NO_EM_RESTART': '1', 05:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:29 INFO - 'PWD': '/builds/slave/test', 05:43:29 INFO - 'SHELL': '/bin/bash', 05:43:29 INFO - 'SHLVL': '1', 05:43:29 INFO - 'TERM': 'linux', 05:43:29 INFO - 'TMOUT': '86400', 05:43:29 INFO - 'USER': 'cltbld', 05:43:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:29 INFO - '_': '/tools/buildbot/bin/python'} 05:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:31 INFO - Installing collected packages: mozsystemmonitor 05:43:31 INFO - Running setup.py install for mozsystemmonitor 05:43:31 INFO - Successfully installed mozsystemmonitor 05:43:31 INFO - Cleaning up... 05:43:32 INFO - Return code: 0 05:43:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:32 INFO - Using env: {'DISPLAY': ':0', 05:43:32 INFO - 'HOME': '/home/cltbld', 05:43:32 INFO - 'LANG': 'en_US.UTF-8', 05:43:32 INFO - 'LANGUAGE': 'en_US:en', 05:43:32 INFO - 'LOGNAME': 'cltbld', 05:43:32 INFO - 'MAIL': '/var/mail/cltbld', 05:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:32 INFO - 'MOZ_NO_REMOTE': '1', 05:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:32 INFO - 'NO_EM_RESTART': '1', 05:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:32 INFO - 'PWD': '/builds/slave/test', 05:43:32 INFO - 'SHELL': '/bin/bash', 05:43:32 INFO - 'SHLVL': '1', 05:43:32 INFO - 'TERM': 'linux', 05:43:32 INFO - 'TMOUT': '86400', 05:43:32 INFO - 'USER': 'cltbld', 05:43:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:32 INFO - '_': '/tools/buildbot/bin/python'} 05:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:34 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:34 INFO - Downloading docopt-0.6.1.tar.gz 05:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:34 INFO - Running setup.py install for blobuploader 05:43:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:34 INFO - Running setup.py install for requests 05:43:35 INFO - Running setup.py install for docopt 05:43:35 INFO - Successfully installed blobuploader requests docopt 05:43:35 INFO - Cleaning up... 05:43:35 INFO - Return code: 0 05:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:35 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:35 INFO - Using env: {'DISPLAY': ':0', 05:43:35 INFO - 'HOME': '/home/cltbld', 05:43:35 INFO - 'LANG': 'en_US.UTF-8', 05:43:35 INFO - 'LANGUAGE': 'en_US:en', 05:43:35 INFO - 'LOGNAME': 'cltbld', 05:43:35 INFO - 'MAIL': '/var/mail/cltbld', 05:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:35 INFO - 'MOZ_NO_REMOTE': '1', 05:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:35 INFO - 'NO_EM_RESTART': '1', 05:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:35 INFO - 'PWD': '/builds/slave/test', 05:43:35 INFO - 'SHELL': '/bin/bash', 05:43:35 INFO - 'SHLVL': '1', 05:43:35 INFO - 'TERM': 'linux', 05:43:35 INFO - 'TMOUT': '86400', 05:43:35 INFO - 'USER': 'cltbld', 05:43:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:35 INFO - '_': '/tools/buildbot/bin/python'} 05:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:35 INFO - Running setup.py (path:/tmp/pip-2WzpZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:35 INFO - Running setup.py (path:/tmp/pip-eve6H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:35 INFO - Running setup.py (path:/tmp/pip-CHybpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:35 INFO - Running setup.py (path:/tmp/pip-VZTDtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:35 INFO - Running setup.py (path:/tmp/pip-U_XteF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:36 INFO - Running setup.py (path:/tmp/pip-Kwvkez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:36 INFO - Running setup.py (path:/tmp/pip-xo9P2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:36 INFO - Running setup.py (path:/tmp/pip-M4ewuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:36 INFO - Running setup.py (path:/tmp/pip-KStSl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:36 INFO - Running setup.py (path:/tmp/pip-M6oMpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:36 INFO - Running setup.py (path:/tmp/pip-4ruok9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:36 INFO - Running setup.py (path:/tmp/pip-EHteR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:36 INFO - Running setup.py (path:/tmp/pip-Fpyjur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:36 INFO - Running setup.py (path:/tmp/pip-krfRGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:36 INFO - Running setup.py (path:/tmp/pip-r6EXCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:36 INFO - Running setup.py (path:/tmp/pip-0zVsbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:36 INFO - Running setup.py (path:/tmp/pip-WVNuXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:36 INFO - Running setup.py install for manifestparser 05:43:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozcrash 05:43:37 INFO - Running setup.py install for mozdebug 05:43:37 INFO - Running setup.py install for mozdevice 05:43:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozfile 05:43:37 INFO - Running setup.py install for mozhttpd 05:43:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozinfo 05:43:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozInstall 05:43:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for mozleak 05:43:37 INFO - Running setup.py install for mozlog 05:43:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:37 INFO - Running setup.py install for moznetwork 05:43:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for mozprocess 05:43:38 INFO - Running setup.py install for mozprofile 05:43:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for mozrunner 05:43:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Running setup.py install for mozscreenshot 05:43:38 INFO - Running setup.py install for moztest 05:43:38 INFO - Running setup.py install for mozversion 05:43:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:38 INFO - Cleaning up... 05:43:38 INFO - Return code: 0 05:43:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:38 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:38 INFO - Using env: {'DISPLAY': ':0', 05:43:38 INFO - 'HOME': '/home/cltbld', 05:43:38 INFO - 'LANG': 'en_US.UTF-8', 05:43:38 INFO - 'LANGUAGE': 'en_US:en', 05:43:38 INFO - 'LOGNAME': 'cltbld', 05:43:38 INFO - 'MAIL': '/var/mail/cltbld', 05:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:38 INFO - 'MOZ_NO_REMOTE': '1', 05:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:38 INFO - 'NO_EM_RESTART': '1', 05:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:38 INFO - 'PWD': '/builds/slave/test', 05:43:38 INFO - 'SHELL': '/bin/bash', 05:43:38 INFO - 'SHLVL': '1', 05:43:38 INFO - 'TERM': 'linux', 05:43:38 INFO - 'TMOUT': '86400', 05:43:38 INFO - 'USER': 'cltbld', 05:43:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:38 INFO - '_': '/tools/buildbot/bin/python'} 05:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:38 INFO - Running setup.py (path:/tmp/pip-4uGOMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:38 INFO - Running setup.py (path:/tmp/pip-rdpW3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:39 INFO - Running setup.py (path:/tmp/pip-URL26o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:39 INFO - Running setup.py (path:/tmp/pip-Urp77D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:39 INFO - Running setup.py (path:/tmp/pip-8D5N_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:39 INFO - Running setup.py (path:/tmp/pip-tpH3F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:39 INFO - Running setup.py (path:/tmp/pip-qzdgU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:39 INFO - Running setup.py (path:/tmp/pip-xuqa9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:39 INFO - Running setup.py (path:/tmp/pip-ZOgcpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:39 INFO - Running setup.py (path:/tmp/pip-fK7TVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:39 INFO - Running setup.py (path:/tmp/pip-jToeqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:39 INFO - Running setup.py (path:/tmp/pip-rVf6j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:39 INFO - Running setup.py (path:/tmp/pip-7cFi2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:39 INFO - Running setup.py (path:/tmp/pip-ceHIMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:39 INFO - Running setup.py (path:/tmp/pip-XoorYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:39 INFO - Running setup.py (path:/tmp/pip-wdLkJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:40 INFO - Running setup.py (path:/tmp/pip-nD7ISd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:42 INFO - Downloading blessings-1.6.tar.gz 05:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:42 INFO - Installing collected packages: blessings 05:43:42 INFO - Running setup.py install for blessings 05:43:42 INFO - Successfully installed blessings 05:43:42 INFO - Cleaning up... 05:43:42 INFO - Return code: 0 05:43:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:42 INFO - Reading from file tmpfile_stdout 05:43:42 INFO - Current package versions: 05:43:42 INFO - argparse == 1.2.1 05:43:42 INFO - blessings == 1.6 05:43:42 INFO - blobuploader == 1.2.4 05:43:42 INFO - docopt == 0.6.1 05:43:42 INFO - manifestparser == 1.1 05:43:42 INFO - mozInstall == 1.12 05:43:42 INFO - mozcrash == 0.17 05:43:42 INFO - mozdebug == 0.1 05:43:42 INFO - mozdevice == 0.48 05:43:42 INFO - mozfile == 1.2 05:43:42 INFO - mozhttpd == 0.7 05:43:42 INFO - mozinfo == 0.9 05:43:42 INFO - mozleak == 0.1 05:43:42 INFO - mozlog == 3.1 05:43:42 INFO - moznetwork == 0.27 05:43:42 INFO - mozprocess == 0.22 05:43:42 INFO - mozprofile == 0.28 05:43:42 INFO - mozrunner == 6.11 05:43:42 INFO - mozscreenshot == 0.1 05:43:42 INFO - mozsystemmonitor == 0.0 05:43:42 INFO - moztest == 0.7 05:43:42 INFO - mozversion == 1.4 05:43:42 INFO - psutil == 3.1.1 05:43:42 INFO - requests == 1.2.3 05:43:42 INFO - wsgiref == 0.1.2 05:43:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:42 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:43:42 INFO - Using env: {'DISPLAY': ':0', 05:43:42 INFO - 'HOME': '/home/cltbld', 05:43:42 INFO - 'LANG': 'en_US.UTF-8', 05:43:42 INFO - 'LANGUAGE': 'en_US:en', 05:43:42 INFO - 'LOGNAME': 'cltbld', 05:43:42 INFO - 'MAIL': '/var/mail/cltbld', 05:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:42 INFO - 'MOZ_NO_REMOTE': '1', 05:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:42 INFO - 'NO_EM_RESTART': '1', 05:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:42 INFO - 'PWD': '/builds/slave/test', 05:43:42 INFO - 'SHELL': '/bin/bash', 05:43:42 INFO - 'SHLVL': '1', 05:43:42 INFO - 'TERM': 'linux', 05:43:42 INFO - 'TMOUT': '86400', 05:43:42 INFO - 'USER': 'cltbld', 05:43:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:42 INFO - '_': '/tools/buildbot/bin/python'} 05:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:43:42 INFO - Cleaning up... 05:43:42 INFO - Return code: 0 05:43:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:42 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:42 INFO - Using env: {'DISPLAY': ':0', 05:43:42 INFO - 'HOME': '/home/cltbld', 05:43:42 INFO - 'LANG': 'en_US.UTF-8', 05:43:42 INFO - 'LANGUAGE': 'en_US:en', 05:43:42 INFO - 'LOGNAME': 'cltbld', 05:43:42 INFO - 'MAIL': '/var/mail/cltbld', 05:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:42 INFO - 'MOZ_NO_REMOTE': '1', 05:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:42 INFO - 'NO_EM_RESTART': '1', 05:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:42 INFO - 'PWD': '/builds/slave/test', 05:43:42 INFO - 'SHELL': '/bin/bash', 05:43:42 INFO - 'SHLVL': '1', 05:43:42 INFO - 'TERM': 'linux', 05:43:42 INFO - 'TMOUT': '86400', 05:43:42 INFO - 'USER': 'cltbld', 05:43:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:42 INFO - '_': '/tools/buildbot/bin/python'} 05:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:42 INFO - Downloading/unpacking jsonschema 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:44 INFO - Downloading/unpacking functools32 (from jsonschema) 05:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:45 INFO - warning: no files found matching '*.txt' 05:43:45 INFO - no previously-included directories found matching 'build' 05:43:45 INFO - no previously-included directories found matching 'dist' 05:43:45 INFO - no previously-included directories found matching '.git*' 05:43:45 INFO - Installing collected packages: jsonschema, functools32 05:43:45 INFO - Running setup.py install for functools32 05:43:45 INFO - warning: no files found matching '*.txt' 05:43:45 INFO - no previously-included directories found matching 'build' 05:43:45 INFO - no previously-included directories found matching 'dist' 05:43:45 INFO - no previously-included directories found matching '.git*' 05:43:45 INFO - Successfully installed jsonschema functools32 05:43:45 INFO - Cleaning up... 05:43:45 INFO - Return code: 0 05:43:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:45 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 0x7f0a26b29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, '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': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:43:45 INFO - Using env: {'DISPLAY': ':0', 05:43:45 INFO - 'HOME': '/home/cltbld', 05:43:45 INFO - 'LANG': 'en_US.UTF-8', 05:43:45 INFO - 'LANGUAGE': 'en_US:en', 05:43:45 INFO - 'LOGNAME': 'cltbld', 05:43:45 INFO - 'MAIL': '/var/mail/cltbld', 05:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:45 INFO - 'MOZ_NO_REMOTE': '1', 05:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:45 INFO - 'NO_EM_RESTART': '1', 05:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:45 INFO - 'PWD': '/builds/slave/test', 05:43:45 INFO - 'SHELL': '/bin/bash', 05:43:45 INFO - 'SHLVL': '1', 05:43:45 INFO - 'TERM': 'linux', 05:43:45 INFO - 'TMOUT': '86400', 05:43:45 INFO - 'USER': 'cltbld', 05:43:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:45 INFO - '_': '/tools/buildbot/bin/python'} 05:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:45 INFO - Downloading/unpacking flake8 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:43:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:43:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:48 INFO - no previously-included directories found matching 'docs/_build' 05:43:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:43:48 INFO - Running setup.py install for pep8 05:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:48 INFO - no previously-included directories found matching 'docs/_build' 05:43:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:43:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:43:48 INFO - Cleaning up... 05:43:48 INFO - Return code: 0 05:43:48 INFO - Running post-action listener: _resource_record_post_action 05:43:48 INFO - Running post-action listener: _start_resource_monitoring 05:43:48 INFO - Starting resource monitoring. 05:43:48 INFO - ##### 05:43:48 INFO - ##### Running install step. 05:43:48 INFO - ##### 05:43:48 INFO - Running pre-action listener: _resource_record_pre_action 05:43:48 INFO - Running main action method: install 05:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:48 INFO - Reading from file tmpfile_stdout 05:43:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:48 INFO - Reading from file tmpfile_stdout 05:43:48 INFO - Output received: 05:43:48 INFO - Usage: mozinstall [options] installer 05:43:48 INFO - Options: 05:43:48 INFO - -h, --help show this help message and exit 05:43:48 INFO - -d DEST, --destination=DEST 05:43:48 INFO - Directory to install application into. [default: 05:43:48 INFO - "/builds/slave/test"] 05:43:48 INFO - --app=APP Application being installed. [default: firefox] 05:43:48 INFO - mkdir: /builds/slave/test/build/application 05:43:48 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'] 05:43:48 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 05:44:01 INFO - Reading from file tmpfile_stdout 05:44:01 INFO - Output received: 05:44:01 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:01 INFO - Running post-action listener: _resource_record_post_action 05:44:01 INFO - ##### 05:44:01 INFO - ##### Running run-tests step. 05:44:01 INFO - ##### 05:44:01 INFO - Running pre-action listener: _resource_record_pre_action 05:44:01 INFO - Running main action method: run_tests 05:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:01 INFO - Python 2.7.3 05:44:01 INFO - Return code: 0 05:44:02 INFO - grabbing minidump binary from tooltool 05:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:02 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 0x2433410>, '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 0x2434310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24347a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:44:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:44:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:02 INFO - Return code: 0 05:44:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:44:03 INFO - Return code: 0 05:44:03 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/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:44:03 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/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:44:03 INFO - Using env: {'DISPLAY': ':0', 05:44:03 INFO - 'HOME': '/home/cltbld', 05:44:03 INFO - 'LANG': 'en_US.UTF-8', 05:44:03 INFO - 'LANGUAGE': 'en_US:en', 05:44:03 INFO - 'LOGNAME': 'cltbld', 05:44:03 INFO - 'MAIL': '/var/mail/cltbld', 05:44:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:03 INFO - 'MOZ_NO_REMOTE': '1', 05:44:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:03 INFO - 'NO_EM_RESTART': '1', 05:44:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:03 INFO - 'PWD': '/builds/slave/test', 05:44:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:03 INFO - 'SHELL': '/bin/bash', 05:44:03 INFO - 'SHLVL': '1', 05:44:03 INFO - 'TERM': 'linux', 05:44:03 INFO - 'TMOUT': '86400', 05:44:03 INFO - 'USER': 'cltbld', 05:44:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1468672267.221793-311033106', 05:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:03 INFO - '_': '/tools/buildbot/bin/python'} 05:44:03 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/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:44:03 INFO - mozversion application_buildid: 20160716031551 05:44:03 INFO - mozversion application_changeset: 24af5e8917a2a3efabc8f1c614c709282fc2d473 05:44:03 INFO - mozversion application_display_name: Firefox 05:44:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:03 INFO - mozversion application_name: Firefox 05:44:03 INFO - mozversion application_remotingname: firefox 05:44:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:44:03 INFO - mozversion application_vendor: Mozilla 05:44:03 INFO - mozversion application_version: 48.0 05:44:03 INFO - mozversion platform_buildid: 20160716031551 05:44:03 INFO - mozversion platform_changeset: 24af5e8917a2a3efabc8f1c614c709282fc2d473 05:44:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:44:03 INFO - mozversion platform_version: 48.0 05:44:03 INFO - using testdate: 1468673043 05:44:03 INFO - actual date: 1468673043 05:44:03 INFO - starting webserver on 'localhost:32953' 05:44:03 INFO - SUITE-START | Running 2 tests 05:44:03 INFO - TEST-START | dromaeo_css 05:44:03 INFO - operating with platform_type : linux_ 05:44:03 INFO - Initialising browser for dromaeo_css test... 05:44:03 INFO - TEST-INFO | started process 3352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGojNaY/profile http://localhost:32953/getInfo.html) 05:44:07 INFO - PROCESS | 3352 | 05:44:07 INFO - PROCESS | 3352 | (process:3430): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:08 INFO - PROCESS | 3352 | __metrics Screen width/height:1600/1200 05:44:08 INFO - PROCESS | 3352 | colorDepth:24 05:44:08 INFO - PROCESS | 3352 | Browser inner width/height: 1024/697 05:44:08 INFO - PROCESS | 3352 | __metrics 05:44:09 ERROR - PROCESS | 3352 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:44:09 INFO - TEST-INFO | 3352: exit 0 05:44:09 INFO - Browser initialized. 05:44:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:09 INFO - TEST-INFO | started process 3482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGojNaY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:11 INFO - PROCESS | 3482 | 05:44:11 INFO - PROCESS | 3482 | (process:3550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:44:21 INFO - PROCESS | 3482 | RSS: Main: 150761472 05:44:21 INFO - PROCESS | 3482 | 05:45:11 INFO - PROCESS | 3482 | 1468673111254 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:47:18 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:32953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32953/tests/dromaeo/cssquery-ext.html) 05:47:19 INFO - PROCESS | 3482 | RSS: Main: 154406912 05:47:19 INFO - PROCESS | 3482 | 05:50:21 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:32953/tests/dromaeo/cssquery-ext.html (next: http://localhost:32953/tests/dromaeo/cssquery-jquery.html) 05:50:22 INFO - PROCESS | 3482 | RSS: Main: 152252416 05:50:22 INFO - PROCESS | 3482 | 05:53:23 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:32953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32953/tests/dromaeo/cssquery-mootools.html) 05:53:24 INFO - PROCESS | 3482 | RSS: Main: 152330240 05:53:24 INFO - PROCESS | 3482 | 05:56:26 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:32953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32953/tests/dromaeo/cssquery-prototype.html) 05:56:26 INFO - PROCESS | 3482 | RSS: Main: 153214976 05:56:26 INFO - PROCESS | 3482 | 05:59:28 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:32953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32953/tests/dromaeo/cssquery-yui.html) 05:59:29 INFO - PROCESS | 3482 | RSS: Main: 152354816 05:59:29 INFO - PROCESS | 3482 | 06:02:31 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:32953/tests/dromaeo/cssquery-yui.html (next: http://localhost:32953/tests/dromaeo/cssquery-dojo.html) 06:02:31 INFO - PROCESS | 3482 | RSS: Main: 155705344 06:02:31 INFO - PROCESS | 3482 | 06:02:31 INFO - PROCESS | 3482 | __start_tp_report 06:02:31 INFO - PROCESS | 3482 | _x_x_mozilla_page_load 06:02:31 INFO - PROCESS | 3482 | _x_x_mozilla_page_load_details 06:02:31 INFO - PROCESS | 3482 | |i|pagename|runs| 06:02:31 INFO - PROCESS | 3482 | |0;dojo.html;3343.1474973881654;3361.1093060339;3375.898723038308;3402.047426720516;3405.744569157314;5558.944410555893;5563.332400111992;5576.525995290405;5580.386157522669;5614.326280846299;5530.419305972875;5545.639533430334;5552.3892371839065;5592.133219350997;5600.52395546378;5029.145045342282;5076.796928122871;5101.234814777776;5103.872403189931;5109.310243117169;5070.619703522232;5103.464136265694;5128.358955130609;5201.2458193561915;5231.790728370861;5126.769295381698;5155.123628983063;5184.144616138333;5191.766370513336;5198.350206224222;5167.560757335631;5179.81870634526;5188.143956247215;5197.168453047532;5210.557102646279;5022.522860328263;5044.672096313728;5078.162103252959;5095.3376061112185;5097.821576244851;5491.121420572689;5510.614257002011;5514.117741161395;5527.5577953764005;5536.141898005815;5970.432808883149;6022.939770602282;6023.397660233985;6032.788852390146;6036.788712395089;5933.584649074566;5983.730732117066;6002.189704389895;6070.817875463743;6128.295246046717;5632.7746890124345;5634.943650563483;5636.15457681347;5673.971630141864;5690.2887139107615;6116.26604807426;6150.938490615126;6157.0456579230295;6182.536309776785;6186.381361863778;5959.463648271676;6016.639001659914;6028.156058151862;6030.6080104793045;6067.150598916155;5997.640141591519;6058.1518587397795;6062.878742425215;6071.453569178795;6077.726502307407;5893.174955506232;5914.142449344821;6030.427109424598;6035.66803825785;6053.848653783691;5929.466348028698;6009.759609615654;6021.729022194012;6027.698615069229;6063.7574497020505;4556.88607784808;4561.954380456153;4568.291914753218;4578.5421457853945;4595.058013107372;4066.0851308455362;4102.261592913304;4105.281575724236;4127.29835927893;4160.521540022936;5741.913871291934;5835.183074369592;5841.211436456024;5862.237909071879;5922.526197904157;5967.462928336384;6002.579819412686;6006.159137720722;6006.909896351558;6015.909761353583;5726.055200891889;5779.711014449261;5789.189513468118;5800.158976948319;5841;5133.024725302181;5136.306598609214;5146.794128234904;5162.174052151638;5164.32863727713;6307.400796924285;6346.650934198663;6362.172917520786;6381.23425188971;6390.4248617624635;5905.675187864708;6001.489873360639;6038.426349496791;6050.878982420327;6092.969535152473;6254.968725156527;6258.43674069336;6297.275813281348;6303.684815759102;6307.274663413767;5934.732937017931;5936.643801371759;5937.198478205387;5958.523318134626;5985.970070149621;6040.456358927718;6047.425494578008;6083.574149809471;6086.2087928569;6120.234970628671;5852.531797456279;5861.531077513874;5864.618799778001;5877.823665290048;5882.029465138205;5754.769809207753;5808.273965754281;5854.531637469077;5868.413158684098;5873.970630146993;5815.534757219328;5827.621204621686;5834.124881267674;5869.618474799125;5897.587168898136;5929.318128415288;5938.524918006636;5945.702714864326;5975.282966044103;5979.983402821444;5659.6321239119325;5776.162456443876;5787.305523337226;5806.4193580641595;5833.416658334133 06:02:31 INFO - PROCESS | 3482 | |1;ext.html;654.9847736009184;667.9646547850833;680.0479328939484;730.0946825935838;747.3535391886016;39935.40096898545;40438.79780601097;40723.18553628925;40792;40901.795491022574;43084.138317233715;43743.12513749731;43803.12393752123;43852.780736096356;43893;8774.473531588124;8883.933927928625;8936.106389361077;8946.731598052069;8966.86549701755;8754.6935857245;8861.645534178626;8861.645534178626;8863;8874.955625221864;9126.133017363372;9204.447733136;9211;9214.769630759218;9216.585253663601;9089.63641454341;9103.54482275887;9129.908700913038;9130.08699130085;9162.175404213653;8858.955705221497;8973.147550982712;8999.775005624912;9024.142706442943;9035.096490350978;44157.77921110374;44700;44712.10575788466;44749.55250447519;44801.77599111984;3814.7901865397394;4015.217032678629;4025.134596061861;4034.1931613677384;4532.954670453286;33917;34695.30609387824;34698.6530134698;35043.64956350455;35733.46399804005;4612.630989520864;4648.604868586174;4748.311494833264;4751.881202969954;4768.308595253703;329347;330503;330509;330561;333219;64930.67534662391;64960.350396496375;65326;65437.67281163564;65877;67877;72187.27812721806;72248;72449.63775181196;72684.63657681784;19359;19511.121999510055;19520.70718939217;19556.21775128979;19634.31279905225;15869.52391428259;15903.681926361409;15977;15978.440754573767;15987.200639967956;21429.142834286453;21577.784222157577;21645.56708865814;21676.24133155332;21678.132874684838;7687.461877668621;7716.382689384835;7768.65041073153;7909.604519773989;8012.439129261013;1153.7173392518887;1197.2098415046028;1198.1433275208094;1211.6062279759115;1234.672811704899;30006.249843753645;30035.849820751195;30559;30727.69272307293;30983;1248.3383806582526;1251.570696292171;1278.1755767529892;1281.2440660010452;1289.9742005159844;16703.582410439594;17189.57026074358;17255.3960611378;17333.046682432334;17373.391931282596;485494;643296;650897;870233;884516;57048;58028.4197158023;58124.70937645285;58190.41809581935;58314.41685583175;1532.073095777061;1543.0818662895335;1546.4896584127212;1562.7577725452572;1624.7237969545206;33127.66872331342;33847.49228761521;34310.65689343175;34428.48357274693;34902.650973490956;56577.71711141418;61457.692711537944;62864.37135628768;63033;63323.36676633175;344386;346349;347158;348621;349377;42914.57085429231;43206.56793432026;43210.69237075448;43722.56277437185;44296;47524.54501915753;47722.5227747732;47778.5222147788;48633;48851.26723099227;44069.33895991499;45021;45301.773491132335;45793.313100302854;46522.30216546822;42987.570124298356;43746;43900.780496097315;44174.779126104164;44254.77872610616;43861.78069109634;44993.55006449894;45136.32295515504;45508.77245613751;45576.31635525536;38331.616683832806;38895.6110438892;38931;39567.010824729616;39862.40206396848;30172.54741178928;30942.535861961638;30948.845255773576;31039.224019399695;31117.8444107778 06:02:31 INFO - PROCESS | 3482 | |2;jquery.html;424.23002250914607;425.26429277350184;428.89277680579846;436.2300539547697;442.7343593843693;18627.906860465697;19169.808301916975;19288.903555482222;19393.806061939376;20396.694049589267;13007.739845203114;13194.34028298586;13218;13281.269530175836;13353.53262635808;5185.870353241171;5381.139017757159;5397;5403.567714582844;5414.864628384283;4120.320147175712;5310.973445132789;6198.566100372953;6238.469730072927;6271.122042913996;6186.752529898821;6203.937960620381;6226.719797609096;6290.339514350996;6602.207735071774;6577.177852768404;6579.0460383244645;6600.93399066008;6613.107230523866;6632.734690612369;5741.856453588652;5824.155497452888;5841.3282472515775;5917.378675239124;6026.54800889935;14617.707645847024;14974.401023959028;14992.700145997129;15096;15196.696066078726;2442.120836498859;2453.5951567991438;2455.987720061406;2541.9237422877345;2949.1005243400755;10224.079832815083;10598.841017384746;11033.932931386667;12306.446209920576;14787.112773233534;2042.867213631124;2069.615236993876;2119.9046042927953;2149.634562124427;2240.574290884743;85303.57348213281;88883;90038.09961900428;90074.54962725144;90421.09578904192;11196.328220306645;11755.294682319089;11798.587049453228;11836.526538938519;11996.520139194508;16655.583610409594;16794.328226870788;16801.747973780402;16805.327786888633;16845.747313790303;9097.1812536872;9246;9317.767055823659;9360.62557497706;9375.10936461035;9158.954205229065;9188.23282454204;9189.494577798152;9197.448153110834;9234.076592340713;4963.801447942042;5067.41724701664;5083.466236045162;5124.820631277962;5144.61415393847;2063.6801295799173;2067.524469372023;2133.2213741984065;2141.625215587297;2155.7628660847295;1103.6413165721174;1116.0290547223967;1125.5722825326325;1181.161375423459;1200.2258543239561;18705.81294187041;18980;19160.329388471335;19415.90292048559;19653.60692786165;1111.3165403276926;1186.5655298731788;1196.3958201108385;1199.7660456210956;1240.6278116564995;10826.404547749791;11144.2199046066;11162.720931976603;11175.161862860155;11201.271917325348;479055;480858;490333;493274;498370;88195.55902220577;89045;92758.53620731852;93153;95283.52358238165;1095.8137116690023;1101.2126329674322;1121.315997241682;1122.9157813164045;1135.318808714781;17140.485785426456;17554.648907022045;17601.911990439967;17835.554111147325;17923.37268195607;38909;39708.60291397049;39824.60175398209;40107.39838902477;40587.797061014506;57876.710616446646;57944;58367;58420;58537.707311464874;9162.763026991272;9162.770930726518;9179.265658747418;9309.581068851783;9389.530523473662;7469.327760501581;10580.947095264475;12100.636980890587;12761.61715148547;13691.452341906212;11357;12023.879761202626;12166.635000949986;12172.756544868877;12323.198992065487;11988.040956723267;12066.758664826479;12146.696332591757;12256.325902075472;12287.262764234174;12493.375331233583;12512.687182820502;12727.93636031814;12734.61796146117;12785.36073196355;9038.367314287936;9039.096090390909;9101.590428430869;9297.488638124969;9458.196053335269;9596.376235544667;12431.93784031074;12497.500099995897;12655.303958282382;12698.111132221025 06:02:31 INFO - PROCESS | 3482 | |3;mootools.html;1548.1175729833997;1566.0368873143018;1816.1645643004217;1915.9233630654774;1942.3201879342232;7733.342665873393;8425.873611895826;8529.87205191922;8837.558122093902;8840.204381605654;8550.315974722023;8568.571571421435;8582.742517724462;8635.91364086359;8649.135086491347;2436.3787234255283;2460.0405841721745;2460.4955984023322;2464.7042354917435;2467.481828815951;2411.3850968003135;2446.840955337906;2448.963265551018;2451.3748994006505;2457.1645640482234;2415.8689038764137;2432.7567243275707;2444.743301953296;2468.123816045305;2531.076157202617;2421.418859473731;2446.779789818916;2449.755024497536;2453.889574969113;2463.4457247119344;2357.045396614357;2388.1163969331283;2393.772591603795;2406.446517301013;2417.8549287042833;8368.121347258511;8467.745967620982;8500.404971651988;8513.659453621847;8516.105808890039;5464.562834973192;5606.495415412633;5635.943640563582;5667.631603945731;5672.858178545528;3484.564429446319;3499.965000349989;3640.672339489459;3647.1611529348397;3662.304162209172;1159.4087015622094;1200.8498937632796;1203.3381640097912;1239.151181440707;1240.4789988204886;12270.447829847679;12437.440315185839;12439.875601244054;12450.875491244971;12478.376081195904;4857.927131093036;4904.2643603459765;4906.362172917497;4934.6545741798445;4947.554720075139;10658.467076646137;10659.893401066045;10687.358758474516;10697.786044279226;10713.625023124154;5630.07103827872;5631.267935168402;5632.2678051853;5645.1532270159805;5647.209390685307;5076.416212135578;5116.309298244763;5118.820841270538;5121.257417674491;5171.741412929414;4184.288670925889;4214.957850421457;4239.682023848224;4252.702310838212;4254.255505286625;1345.7443085813663;1370.2189751841354;1375.6010756880594;1382.9973269379618;1383.0733408616252;1011.1506334678905;1041.0786453988276;1063.4310643805527;1065;1069.502681253221;6084.39156084388;6097.908531372033;6132.233470816148;6148.634469526686;6186.783462578788;984.7493683022665;989.5596459575564;1061.787642471509;1081.7187531241777;1084.978300433987;4022.4368588397647;4071.328230841878;4154;4156.106437116035;4186.581341865789;10611.893881061245;10816.891831081746;10904.836427453594;10938.56245750161;10956.397398143179;10632.46837658114;10677.893221067845;10681;10690.839637405445;10739.409332486632;8196.385271104571;8378.874316885252;8378.916210837935;8379.539125348165;8384.371172161991;5748.827535173951;5833.67914764692;5862.208601838868;5908;5993.67034813072;9593.568289427132;9746.074122958307;9770.413775173512;9864.901350986398;9922.702318930444;9210.861837072584;9581.377210481296;9608.95195524018;9844.114029737359;9845.852312215466;7568.129665088585;7629.351505122127;7646.388288936983;7710.4217183710325;7987.760367188994;8353.665853365797;8359.038710548364;8359.540225287668;8375.32997360222;8392.16078392156;7695.730649427243;7885.369170466234;7951.801204969922;7976.800579985546;8022.0373555173755;7622.847543049219;7631.465797394351;7632.122305934889;7685.4620176587105;7754.495957762728;6757.560758550679;6806.727730890709;6814.965925170342;6827.112475378368;6841.726330946706;5394.08300588893;5415;5512.80705175333;5520.254765606753;5558.805441809517;5202.3497062867145;5335.6265061446875;5352.732363381893;5462.235287059894;5515.61390702647 06:02:31 INFO - PROCESS | 3482 | |4;prototype.html;364.686369722039;365.327796853789;366.89360085575186;371.41131306878594;376.3526734017489;6332.905006424896;6366.490680745541;6413.679316034197;6531.477481801457;6550.574212676179;6391.936080639192;6395.520335974809;6404.551681382305;6405.615663060208;6438.323975982525;4951.232558953368;4968.925466118011;4973.353464049668;4983.22759972203;4992.750362481879;4962.627802914778;4981.427135879366;4983.476734942833;4988.32657591226;4999.075171093359;4941.925871111936;4957.925631115518;4959.60323174147;4967.577755890736;4967.726775027372;4691.507391723888;4826.155422800995;4955.801767929279;4959.082569724613;4966.726830024347;4233.343831706091;4236.195122926665;4245.745255284693;4250.362445633149;4254.064105896698;6145.262568491765;6213.906791398133;6220.875582488325;6227.283862355796;6235.438810507076;5682.54539636828;5688.175214593902;5692.0608099663505;5692.231548740909;5700.230468886689;6776.72893084281;6784.7964561063245;6786.083878676365;6788.321167883221;6801.149856267966;4660.766961651904;4734.431868175807;4750;4754.881127971794;4762.618990480753;7022.54353467023;7049.612271325023;7105.289471052905;7110.6800193990875;7145;4722.6221902247735;4728.739919304471;4731.905361892743;4734.479207287196;4748.9789695215695;4802.159622066194;4810.63920205986;4813.78337974792;4815.133276010351;4819.349387832598;5597.468240517144;5604.97197514018;5606.439356064442;5608.018596745554;5619.690916999522;6683.398494135551;6820.31796820314;6823.147106611674;6834.8633027340165;6846.8972965405555;1705.121862240947;1721.2082442076535;1726.3871325679454;1727.8013028501632;1730.8442240198442;1114.9275297105662;1125.799062832161;1133.4616057372848;1144.7882141803627;1147.6442302886132;6560.048792924999;6601.834954126185;6612.239592446834;6612.471002319803;6632.602043877383;6885;6906.274841141708;6908.205556360982;6909.861802763917;6922.757703480454;6558.770443034471;6579.572327798678;6601.6699165041555;6602.6698665067515;6611.537192396582;3721.832517536717;3759.5676497202626;3762.473253744478;3762.830672619739;3767.9246415071543;7105.2894710528535;7295.124585049722;7335.816604584928;7344;7348.77953661391;6992.440604751608;7024.789256322319;7028.648567571703;7042.6830792614455;7056.294370562902;7245.637718114073;7287.198408175096;7287.635618219174;7300.8174795629475;7304.306090921354;6808.455323574201;6841.486888483284;6866.622335771581;6884.552504087419;6890.552114112566;6804.21751498584;6924.757633482804;7005.474589405917;7012.158540975116;7024.648767561704;7462.701491940262;7465.888011679721;7470.589117598584;7475.626218689153;7482.551046937201;4798.95201047999;4865.367502224688;4882.365292512093;4883.316335713074;4888.902221955612;7042.753503627348;7075.938609208454;7086.645667716491;7094.148702155774;7095.325944035309;6701.798946031627;6824.965875170592;6846.760363387258;6847.21257055445;6875.965620171867;6839.794806155824;6850.143732033496;6870.141232345957;6872.41584465306;6884.242733299233;6747.865042699021;6749.055132281386;6750.5274630775375;6750.628715420699;6760.019797129487;6800.421964133104;6914.135733033371;6919.204291506541;6933.7226510939;6937.7571784987285;6636.83407914806;6713.765018224339;6750.122484077038;6789.2871248518195;6802.14973128359 06:02:31 INFO - PROCESS | 3482 | |5;yui.html;829.100426037749;872.6029656506289;875.4198671398124;887.1970866365941;961.1733908838402;15053.849461505382;15289.847101528982;15353.462628807994;15383.538493845188;15395.846041539582;13131.277779722112;13171.341432928339;13171.73656526869;13211.273379964097;13213.075084744072;920.3235621817959;928.9396189247711;944.0182210501105;951.8191543606728;954.7517645412208;934.7522906429801;943.6366998705513;947.4930911962101;950.1780959470043;950.5864948747283;987.5062468765617;993.4784238274891;994.9253805964545;995.6117114325419;996.9351992120526;984.4191926763208;989.0653332600696;989.6981420666693;991.2714155095998;991.4794732765283;715.6564848872518;716.4984510842431;722.1334398721555;723.2297603052732;726.0488759724725;15891.443799466962;15897.76153357689;15941.521754347272;15961.281742321624;16012.279447424893;14588.927055364762;14791.40834366624;14804.259787010606;14822.555323340317;14898.627534311621;11759.764804703858;11830.112741544419;11851.881481185164;11903.226290291102;12134;3965.5637879833193;4016.879493615167;4078.4086307485545;4111.465509483778;4168.458100446953;45686.77156614229;46103.077938441376;46117.999999999665;46166;46232.30651540196;11502.137339699557;11516.94241528787;11661.825072623917;11693.824592631117;11786.292822430682;19945.401637950883;20047.198112075355;20083.497912552302;20283.188672452936;20338.593228135356;8500.234978851933;8611.440256383315;8787.384883058252;8850.070742571937;8999.37004409698;4896.755162241873;5144.254083157921;5177.223416487482;5232.39827419844;5239.1093514102695;3640.0353906214873;3662.597114317423;3673.2653469306247;3696.7966761828357;3702.148505843671;647.6793986976477;657.9407853293227;660.4914216053612;661.5369241530948;667.7863083813133;721.1598487761698;828.6909458575308;829.7593697827683;846.8560344741409;848.3086284677968;9658;9709.36889102206;9819.36174148678;9863.654772082942;10078.697639070839;663.5355251324092;737.8081698758361;739.4897520710692;754.9169591344947;759.2142132892429;4574.222382195035;4638.165130276515;4662.7202367858035;4678.438587369537;4686.695364801277;61731.38268617346;63167.68416157982;63239.36760632427;63381.683091584244;63608.36391636024;54708.452915470334;54765.726171369686;55112.72443637756;55688.443115569135;56144.15783763247;49789.50210497921;50588.241176382384;50961;51734.96530069377;52163.73918130385;9124.726258212264;9246.95376523113;9299.349045566745;9361.344705870524;9393.436393816393;36491.817540912125;37844.810775945945;38098;38206.235875282895;39686.206275873745;44556.55443445524;45818.31272530848;49031.26453103135;49403.752981234866;49476.257856131466;11861.110416718608;11969.16215864916;11990.700232494257;11998.760024799281;12209.084318675958;12380.566680166152;14717.705645886808;14767.409303627735;14880.851191487947;15206.011609245807;13200.735985280433;13529.2558909257;13559.661008474866;13729.695678910488;13947.930260348634;12988.545400910923;13373.86322162627;13433.395497202453;13909.791353129509;14030.579082627537;12318.199317044364;12437;13548.254845983565;13600.93199533996;13781.931090344886;10713.303635263683;10787.730306742395;11003.17476189305;11104;11295.717607059889;10950.452477376259;11002.50488727993;11175.21773475849;11351.48918298695;11352 06:02:31 INFO - PROCESS | 3482 | __end_tp_report 06:02:31 INFO - PROCESS | 3482 | __start_cc_report 06:02:31 INFO - PROCESS | 3482 | _x_x_mozilla_cycle_collect,336 06:02:31 INFO - PROCESS | 3482 | __end_cc_report 06:02:31 INFO - PROCESS | 3482 | __startTimestamp1468674151986__endTimestamp 06:02:31 INFO - PROCESS | 3482 | 06:02:31 INFO - PROCESS | 3482 | ------- Summary: start ------- 06:02:31 INFO - PROCESS | 3482 | Number of tests: 6 06:02:31 INFO - PROCESS | 3482 | 06:02:31 INFO - PROCESS | 3482 | [#0] dojo.html Cycles:165 Average:5607.27 Median:5841.21 stddev:631.97 (10.8%) stddev-sans-first:608.44 06:02:31 INFO - PROCESS | 3482 | Values: 3343.1 3361.1 3375.9 3402.0 3405.7 5558.9 5563.3 5576.5 5580.4 5614.3 5530.4 5545.6 5552.4 5592.1 5600.5 5029.1 5076.8 5101.2 5103.9 5109.3 5070.6 5103.5 5128.4 5201.2 5231.8 5126.8 5155.1 5184.1 5191.8 5198.4 5167.6 5179.8 5188.1 5197.2 5210.6 5022.5 5044.7 5078.2 5095.3 5097.8 5491.1 5510.6 5514.1 5527.6 5536.1 5970.4 6022.9 6023.4 6032.8 6036.8 5933.6 5983.7 6002.2 6070.8 6128.3 5632.8 5634.9 5636.2 5674.0 5690.3 6116.3 6150.9 6157.0 6182.5 6186.4 5959.5 6016.6 6028.2 6030.6 6067.2 5997.6 6058.2 6062.9 6071.5 6077.7 5893.2 5914.1 6030.4 6035.7 6053.8 5929.5 6009.8 6021.7 6027.7 6063.8 4556.9 4562.0 4568.3 4578.5 4595.1 4066.1 4102.3 4105.3 4127.3 4160.5 5741.9 5835.2 5841.2 5862.2 5922.5 5967.5 6002.6 6006.2 6006.9 6015.9 5726.1 5779.7 5789.2 5800.2 5841.0 5133.0 5136.3 5146.8 5162.2 5164.3 6307.4 6346.7 6362.2 6381.2 6390.4 5905.7 6001.5 6038.4 6050.9 6093.0 6255.0 6258.4 6297.3 6303.7 6307.3 5934.7 5936.6 5937.2 5958.5 5986.0 6040.5 6047.4 6083.6 6086.2 6120.2 5852.5 5861.5 5864.6 5877.8 5882.0 5754.8 5808.3 5854.5 5868.4 5874.0 5815.5 5827.6 5834.1 5869.6 5897.6 5929.3 5938.5 5945.7 5975.3 5980.0 5659.6 5776.2 5787.3 5806.4 5833.4 06:02:32 INFO - PROCESS | 3482 | 06:02:32 INFO - PROCESS | 3482 | [#1] ext.html Cycles:180 Average:64045.96 Median:43896.89 stddev:134211.71 (305.7%) stddev-sans-first:134503.82 06:02:32 INFO - PROCESS | 3482 | Values: 655.0 668.0 680.0 730.1 747.4 39935.4 40438.8 40723.2 40792.0 40901.8 43084.1 43743.1 43803.1 43852.8 43893.0 8774.5 8883.9 8936.1 8946.7 8966.9 8754.7 8861.6 8861.6 8863.0 8875.0 9126.1 9204.4 9211.0 9214.8 9216.6 9089.6 9103.5 9129.9 9130.1 9162.2 8859.0 8973.1 8999.8 9024.1 9035.1 44157.8 44700.0 44712.1 44749.6 44801.8 3814.8 4015.2 4025.1 4034.2 4533.0 33917.0 34695.3 34698.7 35043.6 35733.5 4612.6 4648.6 4748.3 4751.9 4768.3 329347.0 330503.0 330509.0 330561.0 333219.0 64930.7 64960.4 65326.0 65437.7 65877.0 67877.0 72187.3 72248.0 72449.6 72684.6 19359.0 19511.1 19520.7 19556.2 19634.3 15869.5 15903.7 15977.0 15978.4 15987.2 21429.1 21577.8 21645.6 21676.2 21678.1 7687.5 7716.4 7768.7 7909.6 8012.4 1153.7 1197.2 1198.1 1211.6 1234.7 30006.2 30035.8 30559.0 30727.7 30983.0 1248.3 1251.6 1278.2 1281.2 1290.0 16703.6 17189.6 17255.4 17333.0 17373.4 485494.0 643296.0 650897.0 870233.0 884516.0 57048.0 58028.4 58124.7 58190.4 58314.4 1532.1 1543.1 1546.5 1562.8 1624.7 33127.7 33847.5 34310.7 34428.5 34902.7 56577.7 61457.7 62864.4 63033.0 63323.4 344386.0 346349.0 347158.0 348621.0 349377.0 42914.6 43206.6 43210.7 43722.6 44296.0 47524.5 47722.5 47778.5 48633.0 48851.3 44069.3 45021.0 45301.8 45793.3 46522.3 42987.6 43746.0 43900.8 44174.8 44254.8 43861.8 44993.6 45136.3 45508.8 45576.3 38331.6 38895.6 38931.0 39567.0 39862.4 30172.5 30942.5 30948.8 31039.2 31117.8 06:02:32 INFO - PROCESS | 3482 | 06:02:32 INFO - PROCESS | 3482 | [#2] jquery.html Cycles:180 Average:29037.10 Median:2152.70 stddev:80666.00 (3747.2%) stddev-sans-first:80863.68 06:02:32 INFO - PROCESS | 3482 | Values: 424.2 425.3 428.9 436.2 442.7 18627.9 19169.8 19288.9 19393.8 20396.7 13007.7 13194.3 13218.0 13281.3 13353.5 5185.9 5381.1 5397.0 5403.6 5414.9 4120.3 5311.0 6198.6 6238.5 6271.1 6186.8 6203.9 6226.7 6290.3 6602.2 6577.2 6579.0 6600.9 6613.1 6632.7 5741.9 5824.2 5841.3 5917.4 6026.5 14617.7 14974.4 14992.7 15096.0 15196.7 2442.1 2453.6 2456.0 2541.9 2949.1 10224.1 10598.8 11033.9 12306.4 14787.1 2042.9 2069.6 2119.9 2149.6 2240.6 85303.6 88883.0 90038.1 90074.5 90421.1 11196.3 11755.3 11798.6 11836.5 11996.5 16655.6 16794.3 16801.7 16805.3 16845.7 9097.2 9246.0 9317.8 9360.6 9375.1 9159.0 9188.2 9189.5 9197.4 9234.1 4963.8 5067.4 5083.5 5124.8 5144.6 2063.7 2067.5 2133.2 2141.6 2155.8 1103.6 1116.0 1125.6 1181.2 1200.2 18705.8 18980.0 19160.3 19415.9 19653.6 1111.3 1186.6 1196.4 1199.8 1240.6 10826.4 11144.2 11162.7 11175.2 11201.3 479055.0 480858.0 490333.0 493274.0 498370.0 88195.6 89045.0 92758.5 93153.0 95283.5 1095.8 1101.2 1121.3 1122.9 1135.3 17140.5 17554.6 17601.9 17835.6 17923.4 38909.0 39708.6 39824.6 40107.4 40587.8 57876.7 57944.0 58367.0 58420.0 58537.7 9162.8 9162.8 9179.3 9309.6 9389.5 7469.3 10580.9 12100.6 12761.6 13691.5 11357.0 12023.9 12166.6 12172.8 12323.2 11988.0 12066.8 12146.7 12256.3 12287.3 12493.4 12512.7 12727.9 12734.6 12785.4 9038.4 9039.1 9101.6 9297.5 9458.2 9596.4 12431.9 12497.5 12655.3 12698.1 06:02:32 INFO - PROCESS | 3482 | 06:02:32 INFO - PROCESS | 3482 | [#3] mootools.html Cycles:180 Average:5862.90 Median:5120.04 stddev:3197.19 (62.4%) stddev-sans-first:3189.72 06:02:32 INFO - PROCESS | 3482 | Values: 1548.1 1566.0 1816.2 1915.9 1942.3 7733.3 8425.9 8529.9 8837.6 8840.2 8550.3 8568.6 8582.7 8635.9 8649.1 2436.4 2460.0 2460.5 2464.7 2467.5 2411.4 2446.8 2449.0 2451.4 2457.2 2415.9 2432.8 2444.7 2468.1 2531.1 2421.4 2446.8 2449.8 2453.9 2463.4 2357.0 2388.1 2393.8 2406.4 2417.9 8368.1 8467.7 8500.4 8513.7 8516.1 5464.6 5606.5 5635.9 5667.6 5672.9 3484.6 3500.0 3640.7 3647.2 3662.3 1159.4 1200.8 1203.3 1239.2 1240.5 12270.4 12437.4 12439.9 12450.9 12478.4 4857.9 4904.3 4906.4 4934.7 4947.6 10658.5 10659.9 10687.4 10697.8 10713.6 5630.1 5631.3 5632.3 5645.2 5647.2 5076.4 5116.3 5118.8 5121.3 5171.7 4184.3 4215.0 4239.7 4252.7 4254.3 1345.7 1370.2 1375.6 1383.0 1383.1 1011.2 1041.1 1063.4 1065.0 1069.5 6084.4 6097.9 6132.2 6148.6 6186.8 984.7 989.6 1061.8 1081.7 1085.0 4022.4 4071.3 4154.0 4156.1 4186.6 10611.9 10816.9 10904.8 10938.6 10956.4 10632.5 10677.9 10681.0 10690.8 10739.4 8196.4 8378.9 8378.9 8379.5 8384.4 5748.8 5833.7 5862.2 5908.0 5993.7 9593.6 9746.1 9770.4 9864.9 9922.7 9210.9 9581.4 9609.0 9844.1 9845.9 7568.1 7629.4 7646.4 7710.4 7987.8 8353.7 8359.0 8359.5 8375.3 8392.2 7695.7 7885.4 7951.8 7976.8 8022.0 7622.8 7631.5 7632.1 7685.5 7754.5 6757.6 6806.7 6815.0 6827.1 6841.7 5394.1 5415.0 5512.8 5520.3 5558.8 5202.3 5335.6 5352.7 5462.2 5515.6 06:02:32 INFO - PROCESS | 3482 | 06:02:32 INFO - PROCESS | 3482 | [#4] prototype.html Cycles:180 Average:5703.55 Median:6559.41 stddev:1723.64 (26.3%) stddev-sans-first:1681.25 06:02:32 INFO - PROCESS | 3482 | Values: 364.7 365.3 366.9 371.4 376.4 6332.9 6366.5 6413.7 6531.5 6550.6 6391.9 6395.5 6404.6 6405.6 6438.3 4951.2 4968.9 4973.4 4983.2 4992.8 4962.6 4981.4 4983.5 4988.3 4999.1 4941.9 4957.9 4959.6 4967.6 4967.7 4691.5 4826.2 4955.8 4959.1 4966.7 4233.3 4236.2 4245.7 4250.4 4254.1 6145.3 6213.9 6220.9 6227.3 6235.4 5682.5 5688.2 5692.1 5692.2 5700.2 6776.7 6784.8 6786.1 6788.3 6801.1 4660.8 4734.4 4750.0 4754.9 4762.6 7022.5 7049.6 7105.3 7110.7 7145.0 4722.6 4728.7 4731.9 4734.5 4749.0 4802.2 4810.6 4813.8 4815.1 4819.3 5597.5 5605.0 5606.4 5608.0 5619.7 6683.4 6820.3 6823.1 6834.9 6846.9 1705.1 1721.2 1726.4 1727.8 1730.8 1114.9 1125.8 1133.5 1144.8 1147.6 6560.0 6601.8 6612.2 6612.5 6632.6 6885.0 6906.3 6908.2 6909.9 6922.8 6558.8 6579.6 6601.7 6602.7 6611.5 3721.8 3759.6 3762.5 3762.8 3767.9 7105.3 7295.1 7335.8 7344.0 7348.8 6992.4 7024.8 7028.6 7042.7 7056.3 7245.6 7287.2 7287.6 7300.8 7304.3 6808.5 6841.5 6866.6 6884.6 6890.6 6804.2 6924.8 7005.5 7012.2 7024.6 7462.7 7465.9 7470.6 7475.6 7482.6 4799.0 4865.4 4882.4 4883.3 4888.9 7042.8 7075.9 7086.6 7094.1 7095.3 6701.8 6825.0 6846.8 6847.2 6876.0 6839.8 6850.1 6870.1 6872.4 6884.2 6747.9 6749.1 6750.5 6750.6 6760.0 6800.4 6914.1 6919.2 6933.7 6937.8 6636.8 6713.8 6750.1 6789.3 6802.1 06:02:32 INFO - PROCESS | 3482 | 06:02:32 INFO - PROCESS | 3482 | [#5] yui.html Cycles:180 Average:15163.77 Median:46110.54 stddev:16921.73 (36.7%) stddev-sans-first:16934.96 06:02:32 INFO - PROCESS | 3482 | Values: 829.1 872.6 875.4 887.2 961.2 15053.8 15289.8 15353.5 15383.5 15395.8 13131.3 13171.3 13171.7 13211.3 13213.1 920.3 928.9 944.0 951.8 954.8 934.8 943.6 947.5 950.2 950.6 987.5 993.5 994.9 995.6 996.9 984.4 989.1 989.7 991.3 991.5 715.7 716.5 722.1 723.2 726.0 15891.4 15897.8 15941.5 15961.3 16012.3 14588.9 14791.4 14804.3 14822.6 14898.6 11759.8 11830.1 11851.9 11903.2 12134.0 3965.6 4016.9 4078.4 4111.5 4168.5 45686.8 46103.1 46118.0 46166.0 46232.3 11502.1 11516.9 11661.8 11693.8 11786.3 19945.4 20047.2 20083.5 20283.2 20338.6 8500.2 8611.4 8787.4 8850.1 8999.4 4896.8 5144.3 5177.2 5232.4 5239.1 3640.0 3662.6 3673.3 3696.8 3702.1 647.7 657.9 660.5 661.5 667.8 721.2 828.7 829.8 846.9 848.3 9658.0 9709.4 9819.4 9863.7 10078.7 663.5 737.8 739.5 754.9 759.2 4574.2 4638.2 4662.7 4678.4 4686.7 61731.4 63167.7 63239.4 63381.7 63608.4 54708.5 54765.7 55112.7 55688.4 56144.2 49789.5 50588.2 50961.0 51735.0 52163.7 9124.7 9247.0 9299.3 9361.3 9393.4 36491.8 37844.8 38098.0 38206.2 39686.2 44556.6 45818.3 49031.3 49403.8 49476.3 11861.1 11969.2 11990.7 11998.8 12209.1 12380.6 14717.7 14767.4 14880.9 15206.0 13200.7 13529.3 13559.7 13729.7 13947.9 12988.5 13373.9 13433.4 13909.8 14030.6 12318.2 12437.0 13548.3 13600.9 13781.9 10713.3 10787.7 11003.2 11104.0 11295.7 10950.5 11002.5 11175.2 11351.5 11352.0 06:02:32 INFO - PROCESS | 3482 | -------- Summary: end -------- 06:02:32 INFO - PROCESS | 3482 | 06:02:32 INFO - TEST-INFO | 3482: exit 0 06:02:32 INFO - TEST-OK | dromaeo_css | took 1109405ms 06:02:32 INFO - TEST-START | kraken 06:02:32 INFO - operating with platform_type : linux_ 06:02:32 INFO - Initialising browser for kraken test... 06:02:32 INFO - TEST-INFO | started process 3721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQypo7M/profile http://localhost:32953/getInfo.html) 06:02:36 INFO - PROCESS | 3721 | 06:02:36 INFO - PROCESS | 3721 | (process:3801): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:37 INFO - PROCESS | 3721 | __metrics Screen width/height:1600/1200 06:02:37 INFO - PROCESS | 3721 | colorDepth:24 06:02:37 INFO - PROCESS | 3721 | Browser inner width/height: 1024/697 06:02:37 INFO - PROCESS | 3721 | __metrics 06:02:37 ERROR - PROCESS | 3721 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:02:38 INFO - TEST-INFO | 3721: exit 0 06:02:38 INFO - Browser initialized. 06:02:38 INFO - Running cycle 1/1 for kraken test... 06:02:38 INFO - TEST-INFO | started process 3851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQypo7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:40 INFO - PROCESS | 3851 | 06:02:40 INFO - PROCESS | 3851 | (process:3920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:50 INFO - PROCESS | 3851 | RSS: Main: 150573056 06:02:50 INFO - PROCESS | 3851 | 06:02:52 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32953/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:53 INFO - PROCESS | 3851 | RSS: Main: 156413952 06:02:53 INFO - PROCESS | 3851 | 06:02:56 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32953/tests/kraken/driver.html?testName=audio-dft) 06:02:57 INFO - PROCESS | 3851 | RSS: Main: 156008448 06:02:57 INFO - PROCESS | 3851 | 06:02:59 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32953/tests/kraken/driver.html?testName=audio-fft) 06:03:00 INFO - PROCESS | 3851 | RSS: Main: 156069888 06:03:00 INFO - PROCESS | 3851 | 06:03:02 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32953/tests/kraken/driver.html?testName=audio-oscillator) 06:03:03 INFO - PROCESS | 3851 | RSS: Main: 156061696 06:03:03 INFO - PROCESS | 3851 | 06:03:05 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:06 INFO - PROCESS | 3851 | RSS: Main: 156180480 06:03:06 INFO - PROCESS | 3851 | 06:03:09 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32953/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:09 INFO - PROCESS | 3851 | RSS: Main: 156700672 06:03:09 INFO - PROCESS | 3851 | 06:03:13 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32953/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:13 INFO - PROCESS | 3851 | RSS: Main: 156962816 06:03:13 INFO - PROCESS | 3851 | 06:03:16 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32953/tests/kraken/driver.html?testName=json-parse-financial) 06:03:17 INFO - PROCESS | 3851 | RSS: Main: 156459008 06:03:17 INFO - PROCESS | 3851 | 06:03:18 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:19 INFO - PROCESS | 3851 | RSS: Main: 156319744 06:03:19 INFO - PROCESS | 3851 | 06:03:20 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:21 INFO - PROCESS | 3851 | RSS: Main: 156450816 06:03:21 INFO - PROCESS | 3851 | 06:03:23 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:24 INFO - PROCESS | 3851 | RSS: Main: 156794880 06:03:24 INFO - PROCESS | 3851 | 06:03:26 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:27 INFO - PROCESS | 3851 | RSS: Main: 157360128 06:03:27 INFO - PROCESS | 3851 | 06:03:30 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:30 INFO - PROCESS | 3851 | RSS: Main: 157368320 06:03:30 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:32953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32953/tests/kraken/driver.html?testName=ai-astar) 06:03:32 INFO - PROCESS | 3851 | RSS: Main: 158662656 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | __start_tp_report 06:03:32 INFO - PROCESS | 3851 | _x_x_mozilla_page_load 06:03:32 INFO - PROCESS | 3851 | _x_x_mozilla_page_load_details 06:03:32 INFO - PROCESS | 3851 | |i|pagename|runs| 06:03:32 INFO - PROCESS | 3851 | |0;ai-astar;109;111;107;110;112;112;102;109;110;112 06:03:32 INFO - PROCESS | 3851 | |1;audio-beat-detection;150;126;155;187;132;157;153;127;187;135 06:03:32 INFO - PROCESS | 3851 | |2;audio-dft;164;173;162;163;164;158;160;159;163;162 06:03:32 INFO - PROCESS | 3851 | |3;audio-fft;74;77;74;185;74;76;72;77;165;76 06:03:32 INFO - PROCESS | 3851 | |4;audio-oscillator;91;92;150;94;93;92;154;92;93;144 06:03:32 INFO - PROCESS | 3851 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;119 06:03:32 INFO - PROCESS | 3851 | |6;imaging-darkroom;150;146;146;148;146;146;146;146;146;146 06:03:32 INFO - PROCESS | 3851 | |7;imaging-desaturate;96;96;95;97;96;100;95;97;95;95 06:03:32 INFO - PROCESS | 3851 | |8;json-parse-financial;55;56;55;54;53;55;55;74;53;56 06:03:32 INFO - PROCESS | 3851 | |9;json-stringify-tinderbox;60;57;57;58;59;58;58;59;58;58 06:03:32 INFO - PROCESS | 3851 | |10;stanford-crypto-aes;72;79;73;75;72;73;75;74;74;76 06:03:32 INFO - PROCESS | 3851 | |11;stanford-crypto-ccm;123;113;125;114;120;116;116;115;125;131 06:03:32 INFO - PROCESS | 3851 | |12;stanford-crypto-pbkdf2;161;163;167;165;164;158;161;156;161;159 06:03:32 INFO - PROCESS | 3851 | |13;stanford-crypto-sha256-iterative;70;67;70;65;66;68;63;66;64;63 06:03:32 INFO - PROCESS | 3851 | __end_tp_report 06:03:32 INFO - PROCESS | 3851 | __start_cc_report 06:03:32 INFO - PROCESS | 3851 | _x_x_mozilla_cycle_collect,834 06:03:32 INFO - PROCESS | 3851 | __end_cc_report 06:03:32 INFO - PROCESS | 3851 | __startTimestamp1468674212684__endTimestamp 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | ------- Summary: start ------- 06:03:32 INFO - PROCESS | 3851 | Number of tests: 14 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.06 (2.8%) stddev-sans-first:3.24 06:03:32 INFO - PROCESS | 3851 | Values: 109.0 111.0 107.0 110.0 112.0 112.0 102.0 109.0 110.0 112.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:154.00 stddev:22.28 (14.5%) stddev-sans-first:23.63 06:03:32 INFO - PROCESS | 3851 | Values: 150.0 126.0 155.0 187.0 132.0 157.0 153.0 127.0 187.0 135.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:4.13 (2.5%) stddev-sans-first:4.36 06:03:32 INFO - PROCESS | 3851 | Values: 164.0 173.0 162.0 163.0 164.0 158.0 160.0 159.0 163.0 162.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:42.46 (56.6%) stddev-sans-first:44.35 06:03:32 INFO - PROCESS | 3851 | Values: 74.0 77.0 74.0 185.0 74.0 76.0 72.0 77.0 165.0 76.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.60 (30.0%) stddev-sans-first:28.45 06:03:32 INFO - PROCESS | 3851 | Values: 91.0 92.0 150.0 94.0 93.0 92.0 154.0 92.0 93.0 144.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:03:32 INFO - PROCESS | 3851 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.35 (0.9%) stddev-sans-first:0.67 06:03:32 INFO - PROCESS | 3851 | Values: 150.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 06:03:32 INFO - PROCESS | 3851 | Values: 96.0 96.0 95.0 97.0 96.0 100.0 95.0 97.0 95.0 95.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:55.00 stddev:6.20 (11.3%) stddev-sans-first:6.55 06:03:32 INFO - PROCESS | 3851 | Values: 55.0 56.0 55.0 54.0 53.0 55.0 55.0 74.0 53.0 56.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.71 06:03:32 INFO - PROCESS | 3851 | Values: 60.0 57.0 57.0 58.0 59.0 58.0 58.0 59.0 58.0 58.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:2.11 (2.8%) stddev-sans-first:2.07 06:03:32 INFO - PROCESS | 3851 | Values: 72.0 79.0 73.0 75.0 72.0 73.0 75.0 74.0 74.0 76.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:121.50 stddev:5.98 (4.9%) stddev-sans-first:6.23 06:03:32 INFO - PROCESS | 3851 | Values: 123.0 113.0 125.0 114.0 120.0 116.0 116.0 115.0 125.0 131.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:3.34 (2.1%) stddev-sans-first:3.54 06:03:32 INFO - PROCESS | 3851 | Values: 161.0 163.0 167.0 165.0 164.0 158.0 161.0 156.0 161.0 159.0 06:03:32 INFO - PROCESS | 3851 | 06:03:32 INFO - PROCESS | 3851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:2.57 (3.9%) stddev-sans-first:2.33 06:03:32 INFO - PROCESS | 3851 | Values: 70.0 67.0 70.0 65.0 66.0 68.0 63.0 66.0 64.0 63.0 06:03:32 INFO - PROCESS | 3851 | -------- Summary: end -------- 06:03:32 INFO - PROCESS | 3851 | 06:03:33 INFO - TEST-INFO | 3851: exit 0 06:03:33 INFO - TEST-OK | kraken | took 60901ms 06:03:33 INFO - SUITE-END | took 1170s 06:03:33 INFO - Completed test suite (00:19:30) 06:03:33 INFO - javascript benchmark 06:03:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.1474973881654, 3361.1093060339, 3375.898723038308, 3402.047426720516, 3405.744569157314, 5558.944410555893, 5563.332400111992, 5576.525995290405, 5580.386157522669, 5614.326280846299, 5530.419305972875, 5545.639533430334, 5552.3892371839065, 5592.133219350997, 5600.52395546378, 5029.145045342282, 5076.796928122871, 5101.234814777776, 5103.872403189931, 5109.310243117169, 5070.619703522232, 5103.464136265694, 5128.358955130609, 5201.2458193561915, 5231.790728370861, 5126.769295381698, 5155.123628983063, 5184.144616138333, 5191.766370513336, 5198.350206224222, 5167.560757335631, 5179.81870634526, 5188.143956247215, 5197.168453047532, 5210.557102646279, 5022.522860328263, 5044.672096313728, 5078.162103252959, 5095.3376061112185, 5097.821576244851, 5491.121420572689, 5510.614257002011, 5514.117741161395, 5527.5577953764005, 5536.141898005815, 5970.432808883149, 6022.939770602282, 6023.397660233985, 6032.788852390146, 6036.788712395089, 5933.584649074566, 5983.730732117066, 6002.189704389895, 6070.817875463743, 6128.295246046717, 5632.7746890124345, 5634.943650563483, 5636.15457681347, 5673.971630141864, 5690.2887139107615, 6116.26604807426, 6150.938490615126, 6157.0456579230295, 6182.536309776785, 6186.381361863778, 5959.463648271676, 6016.639001659914, 6028.156058151862, 6030.6080104793045, 6067.150598916155, 5997.640141591519, 6058.1518587397795, 6062.878742425215, 6071.453569178795, 6077.726502307407, 5893.174955506232, 5914.142449344821, 6030.427109424598, 6035.66803825785, 6053.848653783691, 5929.466348028698, 6009.759609615654, 6021.729022194012, 6027.698615069229, 6063.7574497020505, 4556.88607784808, 4561.954380456153, 4568.291914753218, 4578.5421457853945, 4595.058013107372, 4066.0851308455362, 4102.261592913304, 4105.281575724236, 4127.29835927893, 4160.521540022936, 5741.913871291934, 5835.183074369592, 5841.211436456024, 5862.237909071879, 5922.526197904157, 5967.462928336384, 6002.579819412686, 6006.159137720722, 6006.909896351558, 6015.909761353583, 5726.055200891889, 5779.711014449261, 5789.189513468118, 5800.158976948319, 5841.0, 5133.024725302181, 5136.306598609214, 5146.794128234904, 5162.174052151638, 5164.32863727713, 6307.400796924285, 6346.650934198663, 6362.172917520786, 6381.23425188971, 6390.4248617624635, 5905.675187864708, 6001.489873360639, 6038.426349496791, 6050.878982420327, 6092.969535152473, 6254.968725156527, 6258.43674069336, 6297.275813281348, 6303.684815759102, 6307.274663413767, 5934.732937017931, 5936.643801371759, 5937.198478205387, 5958.523318134626, 5985.970070149621, 6040.456358927718, 6047.425494578008, 6083.574149809471, 6086.2087928569, 6120.234970628671, 5852.531797456279, 5861.531077513874, 5864.618799778001, 5877.823665290048, 5882.029465138205, 5754.769809207753, 5808.273965754281, 5854.531637469077, 5868.413158684098, 5873.970630146993, 5815.534757219328, 5827.621204621686, 5834.124881267674, 5869.618474799125, 5897.587168898136, 5929.318128415288, 5938.524918006636, 5945.702714864326, 5975.282966044103, 5979.983402821444, 5659.6321239119325, 5776.162456443876, 5787.305523337226, 5806.4193580641595, 5833.416658334133], "value": 5565.545685652652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9847736009184, 667.9646547850833, 680.0479328939484, 730.0946825935838, 747.3535391886016, 39935.40096898545, 40438.79780601097, 40723.18553628925, 40792.0, 40901.795491022574, 43084.138317233715, 43743.12513749731, 43803.12393752123, 43852.780736096356, 43893.0, 8774.473531588124, 8883.933927928625, 8936.106389361077, 8946.731598052069, 8966.86549701755, 8754.6935857245, 8861.645534178626, 8861.645534178626, 8863.0, 8874.955625221864, 9126.133017363372, 9204.447733136, 9211.0, 9214.769630759218, 9216.585253663601, 9089.63641454341, 9103.54482275887, 9129.908700913038, 9130.08699130085, 9162.175404213653, 8858.955705221497, 8973.147550982712, 8999.775005624912, 9024.142706442943, 9035.096490350978, 44157.77921110374, 44700.0, 44712.10575788466, 44749.55250447519, 44801.77599111984, 3814.7901865397394, 4015.217032678629, 4025.134596061861, 4034.1931613677384, 4532.954670453286, 33917.0, 34695.30609387824, 34698.6530134698, 35043.64956350455, 35733.46399804005, 4612.630989520864, 4648.604868586174, 4748.311494833264, 4751.881202969954, 4768.308595253703, 329347.0, 330503.0, 330509.0, 330561.0, 333219.0, 64930.67534662391, 64960.350396496375, 65326.0, 65437.67281163564, 65877.0, 67877.0, 72187.27812721806, 72248.0, 72449.63775181196, 72684.63657681784, 19359.0, 19511.121999510055, 19520.70718939217, 19556.21775128979, 19634.31279905225, 15869.52391428259, 15903.681926361409, 15977.0, 15978.440754573767, 15987.200639967956, 21429.142834286453, 21577.784222157577, 21645.56708865814, 21676.24133155332, 21678.132874684838, 7687.461877668621, 7716.382689384835, 7768.65041073153, 7909.604519773989, 8012.439129261013, 1153.7173392518887, 1197.2098415046028, 1198.1433275208094, 1211.6062279759115, 1234.672811704899, 30006.249843753645, 30035.849820751195, 30559.0, 30727.69272307293, 30983.0, 1248.3383806582526, 1251.570696292171, 1278.1755767529892, 1281.2440660010452, 1289.9742005159844, 16703.582410439594, 17189.57026074358, 17255.3960611378, 17333.046682432334, 17373.391931282596, 485494.0, 643296.0, 650897.0, 870233.0, 884516.0, 57048.0, 58028.4197158023, 58124.70937645285, 58190.41809581935, 58314.41685583175, 1532.073095777061, 1543.0818662895335, 1546.4896584127212, 1562.7577725452572, 1624.7237969545206, 33127.66872331342, 33847.49228761521, 34310.65689343175, 34428.48357274693, 34902.650973490956, 56577.71711141418, 61457.692711537944, 62864.37135628768, 63033.0, 63323.36676633175, 344386.0, 346349.0, 347158.0, 348621.0, 349377.0, 42914.57085429231, 43206.56793432026, 43210.69237075448, 43722.56277437185, 44296.0, 47524.54501915753, 47722.5227747732, 47778.5222147788, 48633.0, 48851.26723099227, 44069.33895991499, 45021.0, 45301.773491132335, 45793.313100302854, 46522.30216546822, 42987.570124298356, 43746.0, 43900.780496097315, 44174.779126104164, 44254.77872610616, 43861.78069109634, 44993.55006449894, 45136.32295515504, 45508.77245613751, 45576.31635525536, 38331.616683832806, 38895.6110438892, 38931.0, 39567.010824729616, 39862.40206396848, 30172.54741178928, 30942.535861961638, 30948.845255773576, 31039.224019399695, 31117.8444107778], "value": 21783.703460600525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.23002250914607, 425.26429277350184, 428.89277680579846, 436.2300539547697, 442.7343593843693, 18627.906860465697, 19169.808301916975, 19288.903555482222, 19393.806061939376, 20396.694049589267, 13007.739845203114, 13194.34028298586, 13218.0, 13281.269530175836, 13353.53262635808, 5185.870353241171, 5381.139017757159, 5397.0, 5403.567714582844, 5414.864628384283, 4120.320147175712, 5310.973445132789, 6198.566100372953, 6238.469730072927, 6271.122042913996, 6186.752529898821, 6203.937960620381, 6226.719797609096, 6290.339514350996, 6602.207735071774, 6577.177852768404, 6579.0460383244645, 6600.93399066008, 6613.107230523866, 6632.734690612369, 5741.856453588652, 5824.155497452888, 5841.3282472515775, 5917.378675239124, 6026.54800889935, 14617.707645847024, 14974.401023959028, 14992.700145997129, 15096.0, 15196.696066078726, 2442.120836498859, 2453.5951567991438, 2455.987720061406, 2541.9237422877345, 2949.1005243400755, 10224.079832815083, 10598.841017384746, 11033.932931386667, 12306.446209920576, 14787.112773233534, 2042.867213631124, 2069.615236993876, 2119.9046042927953, 2149.634562124427, 2240.574290884743, 85303.57348213281, 88883.0, 90038.09961900428, 90074.54962725144, 90421.09578904192, 11196.328220306645, 11755.294682319089, 11798.587049453228, 11836.526538938519, 11996.520139194508, 16655.583610409594, 16794.328226870788, 16801.747973780402, 16805.327786888633, 16845.747313790303, 9097.1812536872, 9246.0, 9317.767055823659, 9360.62557497706, 9375.10936461035, 9158.954205229065, 9188.23282454204, 9189.494577798152, 9197.448153110834, 9234.076592340713, 4963.801447942042, 5067.41724701664, 5083.466236045162, 5124.820631277962, 5144.61415393847, 2063.6801295799173, 2067.524469372023, 2133.2213741984065, 2141.625215587297, 2155.7628660847295, 1103.6413165721174, 1116.0290547223967, 1125.5722825326325, 1181.161375423459, 1200.2258543239561, 18705.81294187041, 18980.0, 19160.329388471335, 19415.90292048559, 19653.60692786165, 1111.3165403276926, 1186.5655298731788, 1196.3958201108385, 1199.7660456210956, 1240.6278116564995, 10826.404547749791, 11144.2199046066, 11162.720931976603, 11175.161862860155, 11201.271917325348, 479055.0, 480858.0, 490333.0, 493274.0, 498370.0, 88195.55902220577, 89045.0, 92758.53620731852, 93153.0, 95283.52358238165, 1095.8137116690023, 1101.2126329674322, 1121.315997241682, 1122.9157813164045, 1135.318808714781, 17140.485785426456, 17554.648907022045, 17601.911990439967, 17835.554111147325, 17923.37268195607, 38909.0, 39708.60291397049, 39824.60175398209, 40107.39838902477, 40587.797061014506, 57876.710616446646, 57944.0, 58367.0, 58420.0, 58537.707311464874, 9162.763026991272, 9162.770930726518, 9179.265658747418, 9309.581068851783, 9389.530523473662, 7469.327760501581, 10580.947095264475, 12100.636980890587, 12761.61715148547, 13691.452341906212, 11357.0, 12023.879761202626, 12166.635000949986, 12172.756544868877, 12323.198992065487, 11988.040956723267, 12066.758664826479, 12146.696332591757, 12256.325902075472, 12287.262764234174, 12493.375331233583, 12512.687182820502, 12727.93636031814, 12734.61796146117, 12785.36073196355, 9038.367314287936, 9039.096090390909, 9101.590428430869, 9297.488638124969, 9458.196053335269, 9596.376235544667, 12431.93784031074, 12497.500099995897, 12655.303958282382, 12698.111132221025], "value": 9500.382239554581, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.1175729833997, 1566.0368873143018, 1816.1645643004217, 1915.9233630654774, 1942.3201879342232, 7733.342665873393, 8425.873611895826, 8529.87205191922, 8837.558122093902, 8840.204381605654, 8550.315974722023, 8568.571571421435, 8582.742517724462, 8635.91364086359, 8649.135086491347, 2436.3787234255283, 2460.0405841721745, 2460.4955984023322, 2464.7042354917435, 2467.481828815951, 2411.3850968003135, 2446.840955337906, 2448.963265551018, 2451.3748994006505, 2457.1645640482234, 2415.8689038764137, 2432.7567243275707, 2444.743301953296, 2468.123816045305, 2531.076157202617, 2421.418859473731, 2446.779789818916, 2449.755024497536, 2453.889574969113, 2463.4457247119344, 2357.045396614357, 2388.1163969331283, 2393.772591603795, 2406.446517301013, 2417.8549287042833, 8368.121347258511, 8467.745967620982, 8500.404971651988, 8513.659453621847, 8516.105808890039, 5464.562834973192, 5606.495415412633, 5635.943640563582, 5667.631603945731, 5672.858178545528, 3484.564429446319, 3499.965000349989, 3640.672339489459, 3647.1611529348397, 3662.304162209172, 1159.4087015622094, 1200.8498937632796, 1203.3381640097912, 1239.151181440707, 1240.4789988204886, 12270.447829847679, 12437.440315185839, 12439.875601244054, 12450.875491244971, 12478.376081195904, 4857.927131093036, 4904.2643603459765, 4906.362172917497, 4934.6545741798445, 4947.554720075139, 10658.467076646137, 10659.893401066045, 10687.358758474516, 10697.786044279226, 10713.625023124154, 5630.07103827872, 5631.267935168402, 5632.2678051853, 5645.1532270159805, 5647.209390685307, 5076.416212135578, 5116.309298244763, 5118.820841270538, 5121.257417674491, 5171.741412929414, 4184.288670925889, 4214.957850421457, 4239.682023848224, 4252.702310838212, 4254.255505286625, 1345.7443085813663, 1370.2189751841354, 1375.6010756880594, 1382.9973269379618, 1383.0733408616252, 1011.1506334678905, 1041.0786453988276, 1063.4310643805527, 1065.0, 1069.502681253221, 6084.39156084388, 6097.908531372033, 6132.233470816148, 6148.634469526686, 6186.783462578788, 984.7493683022665, 989.5596459575564, 1061.787642471509, 1081.7187531241777, 1084.978300433987, 4022.4368588397647, 4071.328230841878, 4154.0, 4156.106437116035, 4186.581341865789, 10611.893881061245, 10816.891831081746, 10904.836427453594, 10938.56245750161, 10956.397398143179, 10632.46837658114, 10677.893221067845, 10681.0, 10690.839637405445, 10739.409332486632, 8196.385271104571, 8378.874316885252, 8378.916210837935, 8379.539125348165, 8384.371172161991, 5748.827535173951, 5833.67914764692, 5862.208601838868, 5908.0, 5993.67034813072, 9593.568289427132, 9746.074122958307, 9770.413775173512, 9864.901350986398, 9922.702318930444, 9210.861837072584, 9581.377210481296, 9608.95195524018, 9844.114029737359, 9845.852312215466, 7568.129665088585, 7629.351505122127, 7646.388288936983, 7710.4217183710325, 7987.760367188994, 8353.665853365797, 8359.038710548364, 8359.540225287668, 8375.32997360222, 8392.16078392156, 7695.730649427243, 7885.369170466234, 7951.801204969922, 7976.800579985546, 8022.0373555173755, 7622.847543049219, 7631.465797394351, 7632.122305934889, 7685.4620176587105, 7754.495957762728, 6757.560758550679, 6806.727730890709, 6814.965925170342, 6827.112475378368, 6841.726330946706, 5394.08300588893, 5415.0, 5512.80705175333, 5520.254765606753, 5558.805441809517, 5202.3497062867145, 5335.6265061446875, 5352.732363381893, 5462.235287059894, 5515.61390702647], "value": 4779.884199520106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.686369722039, 365.327796853789, 366.89360085575186, 371.41131306878594, 376.3526734017489, 6332.905006424896, 6366.490680745541, 6413.679316034197, 6531.477481801457, 6550.574212676179, 6391.936080639192, 6395.520335974809, 6404.551681382305, 6405.615663060208, 6438.323975982525, 4951.232558953368, 4968.925466118011, 4973.353464049668, 4983.22759972203, 4992.750362481879, 4962.627802914778, 4981.427135879366, 4983.476734942833, 4988.32657591226, 4999.075171093359, 4941.925871111936, 4957.925631115518, 4959.60323174147, 4967.577755890736, 4967.726775027372, 4691.507391723888, 4826.155422800995, 4955.801767929279, 4959.082569724613, 4966.726830024347, 4233.343831706091, 4236.195122926665, 4245.745255284693, 4250.362445633149, 4254.064105896698, 6145.262568491765, 6213.906791398133, 6220.875582488325, 6227.283862355796, 6235.438810507076, 5682.54539636828, 5688.175214593902, 5692.0608099663505, 5692.231548740909, 5700.230468886689, 6776.72893084281, 6784.7964561063245, 6786.083878676365, 6788.321167883221, 6801.149856267966, 4660.766961651904, 4734.431868175807, 4750.0, 4754.881127971794, 4762.618990480753, 7022.54353467023, 7049.612271325023, 7105.289471052905, 7110.6800193990875, 7145.0, 4722.6221902247735, 4728.739919304471, 4731.905361892743, 4734.479207287196, 4748.9789695215695, 4802.159622066194, 4810.63920205986, 4813.78337974792, 4815.133276010351, 4819.349387832598, 5597.468240517144, 5604.97197514018, 5606.439356064442, 5608.018596745554, 5619.690916999522, 6683.398494135551, 6820.31796820314, 6823.147106611674, 6834.8633027340165, 6846.8972965405555, 1705.121862240947, 1721.2082442076535, 1726.3871325679454, 1727.8013028501632, 1730.8442240198442, 1114.9275297105662, 1125.799062832161, 1133.4616057372848, 1144.7882141803627, 1147.6442302886132, 6560.048792924999, 6601.834954126185, 6612.239592446834, 6612.471002319803, 6632.602043877383, 6885.0, 6906.274841141708, 6908.205556360982, 6909.861802763917, 6922.757703480454, 6558.770443034471, 6579.572327798678, 6601.6699165041555, 6602.6698665067515, 6611.537192396582, 3721.832517536717, 3759.5676497202626, 3762.473253744478, 3762.830672619739, 3767.9246415071543, 7105.2894710528535, 7295.124585049722, 7335.816604584928, 7344.0, 7348.77953661391, 6992.440604751608, 7024.789256322319, 7028.648567571703, 7042.6830792614455, 7056.294370562902, 7245.637718114073, 7287.198408175096, 7287.635618219174, 7300.8174795629475, 7304.306090921354, 6808.455323574201, 6841.486888483284, 6866.622335771581, 6884.552504087419, 6890.552114112566, 6804.21751498584, 6924.757633482804, 7005.474589405917, 7012.158540975116, 7024.648767561704, 7462.701491940262, 7465.888011679721, 7470.589117598584, 7475.626218689153, 7482.551046937201, 4798.95201047999, 4865.367502224688, 4882.365292512093, 4883.316335713074, 4888.902221955612, 7042.753503627348, 7075.938609208454, 7086.645667716491, 7094.148702155774, 7095.325944035309, 6701.798946031627, 6824.965875170592, 6846.760363387258, 6847.21257055445, 6875.965620171867, 6839.794806155824, 6850.143732033496, 6870.141232345957, 6872.41584465306, 6884.242733299233, 6747.865042699021, 6749.055132281386, 6750.5274630775375, 6750.628715420699, 6760.019797129487, 6800.421964133104, 6914.135733033371, 6919.204291506541, 6933.7226510939, 6937.7571784987285, 6636.83407914806, 6713.765018224339, 6750.122484077038, 6789.2871248518195, 6802.14973128359], "value": 5143.2388638082475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.100426037749, 872.6029656506289, 875.4198671398124, 887.1970866365941, 961.1733908838402, 15053.849461505382, 15289.847101528982, 15353.462628807994, 15383.538493845188, 15395.846041539582, 13131.277779722112, 13171.341432928339, 13171.73656526869, 13211.273379964097, 13213.075084744072, 920.3235621817959, 928.9396189247711, 944.0182210501105, 951.8191543606728, 954.7517645412208, 934.7522906429801, 943.6366998705513, 947.4930911962101, 950.1780959470043, 950.5864948747283, 987.5062468765617, 993.4784238274891, 994.9253805964545, 995.6117114325419, 996.9351992120526, 984.4191926763208, 989.0653332600696, 989.6981420666693, 991.2714155095998, 991.4794732765283, 715.6564848872518, 716.4984510842431, 722.1334398721555, 723.2297603052732, 726.0488759724725, 15891.443799466962, 15897.76153357689, 15941.521754347272, 15961.281742321624, 16012.279447424893, 14588.927055364762, 14791.40834366624, 14804.259787010606, 14822.555323340317, 14898.627534311621, 11759.764804703858, 11830.112741544419, 11851.881481185164, 11903.226290291102, 12134.0, 3965.5637879833193, 4016.879493615167, 4078.4086307485545, 4111.465509483778, 4168.458100446953, 45686.77156614229, 46103.077938441376, 46117.999999999665, 46166.0, 46232.30651540196, 11502.137339699557, 11516.94241528787, 11661.825072623917, 11693.824592631117, 11786.292822430682, 19945.401637950883, 20047.198112075355, 20083.497912552302, 20283.188672452936, 20338.593228135356, 8500.234978851933, 8611.440256383315, 8787.384883058252, 8850.070742571937, 8999.37004409698, 4896.755162241873, 5144.254083157921, 5177.223416487482, 5232.39827419844, 5239.1093514102695, 3640.0353906214873, 3662.597114317423, 3673.2653469306247, 3696.7966761828357, 3702.148505843671, 647.6793986976477, 657.9407853293227, 660.4914216053612, 661.5369241530948, 667.7863083813133, 721.1598487761698, 828.6909458575308, 829.7593697827683, 846.8560344741409, 848.3086284677968, 9658.0, 9709.36889102206, 9819.36174148678, 9863.654772082942, 10078.697639070839, 663.5355251324092, 737.8081698758361, 739.4897520710692, 754.9169591344947, 759.2142132892429, 4574.222382195035, 4638.165130276515, 4662.7202367858035, 4678.438587369537, 4686.695364801277, 61731.38268617346, 63167.68416157982, 63239.36760632427, 63381.683091584244, 63608.36391636024, 54708.452915470334, 54765.726171369686, 55112.72443637756, 55688.443115569135, 56144.15783763247, 49789.50210497921, 50588.241176382384, 50961.0, 51734.96530069377, 52163.73918130385, 9124.726258212264, 9246.95376523113, 9299.349045566745, 9361.344705870524, 9393.436393816393, 36491.817540912125, 37844.810775945945, 38098.0, 38206.235875282895, 39686.206275873745, 44556.55443445524, 45818.31272530848, 49031.26453103135, 49403.752981234866, 49476.257856131466, 11861.110416718608, 11969.16215864916, 11990.700232494257, 11998.760024799281, 12209.084318675958, 12380.566680166152, 14717.705645886808, 14767.409303627735, 14880.851191487947, 15206.011609245807, 13200.735985280433, 13529.2558909257, 13559.661008474866, 13729.695678910488, 13947.930260348634, 12988.545400910923, 13373.86322162627, 13433.395497202453, 13909.791353129509, 14030.579082627537, 12318.199317044364, 12437.0, 13548.254845983565, 13600.93199533996, 13781.931090344886, 10713.303635263683, 10787.730306742395, 11003.17476189305, 11104.0, 11295.717607059889, 10950.452477376259, 11002.50488727993, 11175.21773475849, 11351.48918298695, 11352.0], "value": 7171.496115422686, "unit": "score"}], "name": "dromaeo_css", "value": 7666.797743250516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 107.0, 110.0, 112.0, 112.0, 102.0, 109.0, 110.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 155.0, 187.0, 132.0, 157.0, 153.0, 127.0, 187.0, 135.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 173.0, 162.0, 163.0, 164.0, 158.0, 160.0, 159.0, 163.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 185.0, 74.0, 76.0, 72.0, 77.0, 165.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 150.0, 94.0, 93.0, 92.0, 154.0, 92.0, 93.0, 144.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 97.0, 96.0, 100.0, 95.0, 97.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 53.0, 55.0, 55.0, 74.0, 53.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 58.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 73.0, 75.0, 72.0, 73.0, 75.0, 74.0, 74.0, 76.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 113.0, 125.0, 114.0, 120.0, 116.0, 116.0, 115.0, 125.0, 131.0], "value": 119.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 167.0, 165.0, 164.0, 158.0, 161.0, 156.0, 161.0, 159.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 65.0, 66.0, 68.0, 63.0, 66.0, 64.0, 63.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1524.2, "alertThreshold": 2.0}]} 06:03:33 INFO - Return code: 0 06:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:03:33 ERROR - # TBPL SUCCESS # 06:03:33 INFO - Running post-action listener: _resource_record_post_action 06:03:33 INFO - Running post-run listener: _resource_record_post_run 06:03:35 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 7651328; Write bytes: 351584256; Read time: 1436; Write time: 254888 06:03:35 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 7892992; Read time: 0; Write time: 1784 06:03:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 5890048; Write bytes: 343691264; Read time: 1372; Write time: 253104 06:03:35 INFO - Running post-run listener: _upload_blobber_files 06:03:35 INFO - Blob upload gear active. 06:03:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:35 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 06:03:35 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'] 06:03:35 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 06:03:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:36 INFO - (blobuploader) - INFO - Done attempting. 06:03:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:03:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:36 INFO - (blobuploader) - INFO - Done attempting. 06:03:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:37 INFO - Return code: 0 06:03:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/285e06a6bd91e7d21a6a55d2de8fa3c18ca2cb2b551d993cfe9953c48ccfc16e30ffa0d7e45b9cf382af2f2a178dd5a9f946eefcface0f6ecb30bd45122af6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a7de0b2cc7253c826c1076770396c4ac07d4024c5e7817660153912679440988b743eb4ef7549e615332637c7696c0960564449190a471f4a1b10d0161db26"} 06:03:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:37 INFO - Contents: 06:03:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/285e06a6bd91e7d21a6a55d2de8fa3c18ca2cb2b551d993cfe9953c48ccfc16e30ffa0d7e45b9cf382af2f2a178dd5a9f946eefcface0f6ecb30bd45122af6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a7de0b2cc7253c826c1076770396c4ac07d4024c5e7817660153912679440988b743eb4ef7549e615332637c7696c0960564449190a471f4a1b10d0161db26"} 06:03:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:37 INFO - Copying logs to upload dir... 06:03:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.807064 ========= master_lag: 45.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-07-16 06:04:22.395699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 06:04:22.398704) ========= 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=232498196343f89f466a4a9a000001c8-1468672267.221793-311033106 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/285e06a6bd91e7d21a6a55d2de8fa3c18ca2cb2b551d993cfe9953c48ccfc16e30ffa0d7e45b9cf382af2f2a178dd5a9f946eefcface0f6ecb30bd45122af6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a7de0b2cc7253c826c1076770396c4ac07d4024c5e7817660153912679440988b743eb4ef7549e615332637c7696c0960564449190a471f4a1b10d0161db26"} build_url:https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/dl3nvxSpSJO2MXb5E-DJ0Q/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/285e06a6bd91e7d21a6a55d2de8fa3c18ca2cb2b551d993cfe9953c48ccfc16e30ffa0d7e45b9cf382af2f2a178dd5a9f946eefcface0f6ecb30bd45122af6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73a7de0b2cc7253c826c1076770396c4ac07d4024c5e7817660153912679440988b743eb4ef7549e615332637c7696c0960564449190a471f4a1b10d0161db26"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 06:04:22.572655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 06:04:22.572972) ========= 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=232498196343f89f466a4a9a000001c8-1468672267.221793-311033106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 06:04:22.695495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 06:04:22.695901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 06:04:22.696161) ========= ========= Total master_lag: 45.75 =========