builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1467985097.5 results: success (0) buildid: 20160708005427 builduid: 1be2550c729e46f989018bc39f180feb revision: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.502672) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.503204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.503508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.518346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.518638) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 06:38:17-- 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% 70.1M=0s 2016-07-08 06:38:17 (70.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121409 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.654273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.654600) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.704406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:17.704781) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60d09be974d615ae5c7fa1129516dbd0a6884dc5 --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 60d09be974d615ae5c7fa1129516dbd0a6884dc5 --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=56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 06:38:18,017 truncating revision to first 12 chars 2016-07-08 06:38:18,017 Setting DEBUG logging. 2016-07-08 06:38:18,017 attempt 1/10 2016-07-08 06:38:18,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60d09be974d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 06:38:18,567 unpacking tar archive at: mozilla-beta-60d09be974d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:18.620473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:18.621079) ========= script_repo_revision: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:18.621539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:18.621821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 06:38:18.632328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-08 06:38:18.632678) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:38:19 INFO - MultiFileLogger online at 20160708 06:38:19 in /builds/slave/test 06:38:19 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 06:38:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:38:19 INFO - {'append_to_log': False, 06:38:19 INFO - 'base_work_dir': '/builds/slave/test', 06:38:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:38:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:38:19 INFO - 'branch': 'Mozilla-Beta', 06:38:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:19 INFO - 'config_files': ('talos/linux_config.py',), 06:38:19 INFO - 'default_actions': ('clobber', 06:38:19 INFO - 'read-buildbot-config', 06:38:19 INFO - 'download-and-extract', 06:38:19 INFO - 'populate-webroot', 06:38:19 INFO - 'create-virtualenv', 06:38:19 INFO - 'install', 06:38:19 INFO - 'run-tests'), 06:38:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:19 INFO - 'download_minidump_stackwalk': True, 06:38:19 INFO - 'download_symbols': 'ondemand', 06:38:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:38:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:38:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:38:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:38:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:19 INFO - 'installer_path': 'installer.exe', 06:38:19 INFO - 'log_level': 'info', 06:38:19 INFO - 'log_name': 'talos', 06:38:19 INFO - 'log_to_console': True, 06:38:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:38:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:38:19 INFO - 'opt_config_files': (), 06:38:19 INFO - 'pip_index': False, 06:38:19 INFO - 'sps_profile': False, 06:38:19 INFO - 'sps_profile_interval': 0, 06:38:19 INFO - 'suite': 'dromaeojs-e10s', 06:38:19 INFO - 'system_bits': '32', 06:38:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:19 INFO - 'title': 'talos-linux64-ix-037', 06:38:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:38:19 INFO - 'use_talos_json': True, 06:38:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:38:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:19 INFO - 'work_dir': 'build'} 06:38:19 INFO - ##### 06:38:19 INFO - ##### Running clobber step. 06:38:19 INFO - ##### 06:38:19 INFO - Running pre-action listener: _resource_record_pre_action 06:38:19 INFO - Running main action method: clobber 06:38:19 INFO - rmtree: /builds/slave/test/build 06:38:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:38:20 INFO - Running post-action listener: _resource_record_post_action 06:38:20 INFO - ##### 06:38:20 INFO - ##### Running read-buildbot-config step. 06:38:20 INFO - ##### 06:38:20 INFO - Running pre-action listener: _resource_record_pre_action 06:38:20 INFO - Running main action method: read_buildbot_config 06:38:20 INFO - Using buildbot properties: 06:38:20 INFO - { 06:38:20 INFO - "project": "", 06:38:20 INFO - "product": "firefox", 06:38:20 INFO - "script_repo_revision": "production", 06:38:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:38:20 INFO - "repository": "", 06:38:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:38:20 INFO - "buildid": "20160708005427", 06:38:20 INFO - "pgo_build": "True", 06:38:20 INFO - "basedir": "/builds/slave/test", 06:38:20 INFO - "buildnumber": 39, 06:38:20 INFO - "slavename": "talos-linux64-ix-037", 06:38:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:38:20 INFO - "platform": "ubuntu64_hw", 06:38:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:38:20 INFO - "branch": "mozilla-beta", 06:38:20 INFO - "repo_path": "releases/mozilla-beta", 06:38:20 INFO - "revision": "60d09be974d615ae5c7fa1129516dbd0a6884dc5", 06:38:20 INFO - "stage_platform": "linux64-pgo", 06:38:20 INFO - "builduid": "1be2550c729e46f989018bc39f180feb", 06:38:20 INFO - "slavebuilddir": "test" 06:38:20 INFO - } 06:38:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:38:20 INFO - Running post-action listener: _resource_record_post_action 06:38:20 INFO - ##### 06:38:20 INFO - ##### Running download-and-extract step. 06:38:20 INFO - ##### 06:38:20 INFO - Running pre-action listener: _resource_record_pre_action 06:38:20 INFO - Running main action method: download_and_extract 06:38:20 INFO - mkdir: /builds/slave/test/build/tests 06:38: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')]} 06:38:20 INFO - https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:20 INFO - Downloaded 1327 bytes. 06:38:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:38:20 INFO - Using the following test package requirements: 06:38:20 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:38:20 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:38:20 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:38:20 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'jsshell-linux-x86_64.zip'], 06:38:20 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:38:20 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:38:20 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:38:20 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:38:20 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:38:20 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:38:20 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:38:20 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:38: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')]} 06:38:20 INFO - https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:22 INFO - Downloaded 24237472 bytes. 06:38:22 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'] 06:38:22 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 06:38:23 INFO - Return code: 0 06:38:23 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 06:38:23 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')]} 06:38:23 INFO - https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:38:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:38:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:38:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:24 INFO - Downloaded 24237472 bytes. 06:38:24 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'] 06:38:24 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 06:38:26 INFO - Return code: 0 06:38:26 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')]} 06:38:26 INFO - https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:27 INFO - Downloaded 10840145 bytes. 06:38:27 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'] 06:38:27 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 06:38:27 INFO - Return code: 0 06:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:27 INFO - https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QInwY6wvR1SkDrpsMg4o9g/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 06:38:29 INFO - Downloaded 56028714 bytes. 06:38:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:38:29 INFO - mkdir: /builds/slave/test/properties 06:38:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:38:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:38:29 INFO - Contents: 06:38:29 INFO - build_url:https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:38:30 INFO - Running post-action listener: _resource_record_post_action 06:38:30 INFO - Running post-action listener: set_extra_try_arguments 06:38:30 INFO - ##### 06:38:30 INFO - ##### Running populate-webroot step. 06:38:30 INFO - ##### 06:38:30 INFO - Running pre-action listener: _resource_record_pre_action 06:38:30 INFO - Running main action method: populate_webroot 06:38:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:30 INFO - '--tppagecycles', 06:38:30 INFO - '7'], 06:38:30 INFO - 'tests': ['tsvgm']}}, 06:38:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:38:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:38:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:38:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['damp', 'tps']}, 06:38:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'tests': ['damp', 'tps']}, 06:38:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['dromaeo_dom']}, 06:38:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['a11yr', 06:38:30 INFO - 'ts_paint', 06:38:30 INFO - 'tpaint', 06:38:30 INFO - 'sessionrestore', 06:38:30 INFO - 'sessionrestore_no_auto_restore', 06:38:30 INFO - 'tabpaint']}, 06:38:30 INFO - 'other-e10s': {'tests': ['a11yr', 06:38:30 INFO - 'ts_paint', 06:38:30 INFO - 'tpaint', 06:38:30 INFO - 'sessionrestore', 06:38:30 INFO - 'sessionrestore_no_auto_restore', 06:38:30 INFO - 'tabpaint']}, 06:38:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:38:30 INFO - 'ts_paint', 06:38:30 INFO - 'tpaint', 06:38:30 INFO - 'sessionrestore', 06:38:30 INFO - 'sessionrestore_no_auto_restore', 06:38:30 INFO - 'tabpaint']}, 06:38:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:38:30 INFO - 'ts_paint', 06:38:30 INFO - 'tpaint', 06:38:30 INFO - 'sessionrestore', 06:38:30 INFO - 'sessionrestore_no_auto_restore', 06:38:30 INFO - 'tabpaint']}, 06:38:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['a11yr', 06:38:30 INFO - 'ts_paint', 06:38:30 INFO - 'tpaint', 06:38:30 INFO - 'sessionrestore', 06:38:30 INFO - 'sessionrestore_no_auto_restore', 06:38:30 INFO - 'tabpaint']}, 06:38:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['a11yr', 06:38:30 INFO - 'ts_paint', 06:38:30 INFO - 'tpaint', 06:38:30 INFO - 'sessionrestore', 06:38:30 INFO - 'sessionrestore_no_auto_restore', 06:38:30 INFO - 'tabpaint']}, 06:38:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['tsvgx', 06:38:30 INFO - 'tsvgr_opacity', 06:38:30 INFO - 'tart', 06:38:30 INFO - 'tscrollx', 06:38:30 INFO - 'cart']}, 06:38:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:38:30 INFO - 'tsvgr_opacity', 06:38:30 INFO - 'tart', 06:38:30 INFO - 'tscrollx', 06:38:30 INFO - 'cart']}, 06:38:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'talos_options': ['--disable-e10s'], 06:38:30 INFO - 'tests': ['tp5o']}, 06:38:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'tests': ['tp5o']}, 06:38:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'talos_options': ['--disable-e10s', 06:38:30 INFO - '--xperf_path', 06:38:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:30 INFO - 'tests': ['tp5n']}, 06:38:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:30 INFO - 'talos_options': ['--xperf_path', 06:38:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:30 INFO - 'tests': ['tp5n']}}, 06:38:30 INFO - 'talos.zip': {'path': '', 06:38:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:30 INFO - Running post-action listener: _resource_record_post_action 06:38:30 INFO - ##### 06:38:30 INFO - ##### Running create-virtualenv step. 06:38:30 INFO - ##### 06:38:30 INFO - Running pre-action listener: _resource_record_pre_action 06:38:30 INFO - Running main action method: create_virtualenv 06:38:30 INFO - Creating virtualenv /builds/slave/test/build/venv 06:38:30 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 06:38:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:38:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:30 INFO - Using real prefix '/usr' 06:38:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:38:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:32 INFO - Installing pip.................done. 06:38:32 INFO - Return code: 0 06:38:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38: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', 'pip>=1.5'] in /builds/slave/test/build 06:38: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 pip>=1.5 06:38:32 INFO - Using env: {'DISPLAY': ':0', 06:38:32 INFO - 'HOME': '/home/cltbld', 06:38:32 INFO - 'LANG': 'en_US.UTF-8', 06:38:32 INFO - 'LANGUAGE': 'en_US:en', 06:38:32 INFO - 'LOGNAME': 'cltbld', 06:38:32 INFO - 'MAIL': '/var/mail/cltbld', 06:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:32 INFO - 'MOZ_NO_REMOTE': '1', 06:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:32 INFO - 'NO_EM_RESTART': '1', 06:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:32 INFO - 'PWD': '/builds/slave/test', 06:38:32 INFO - 'SHELL': '/bin/bash', 06:38:32 INFO - 'SHLVL': '1', 06:38:32 INFO - 'TERM': 'linux', 06:38:32 INFO - 'TMOUT': '86400', 06:38:32 INFO - 'USER': 'cltbld', 06:38:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:32 INFO - '_': '/tools/buildbot/bin/python'} 06:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:32 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 06:38:32 INFO - Cleaning up... 06:38:32 INFO - Return code: 0 06:38:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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', '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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:38: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 psutil>=0.7.1 06:38:32 INFO - Using env: {'DISPLAY': ':0', 06:38:32 INFO - 'HOME': '/home/cltbld', 06:38:32 INFO - 'LANG': 'en_US.UTF-8', 06:38:32 INFO - 'LANGUAGE': 'en_US:en', 06:38:32 INFO - 'LOGNAME': 'cltbld', 06:38:32 INFO - 'MAIL': '/var/mail/cltbld', 06:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:32 INFO - 'MOZ_NO_REMOTE': '1', 06:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:32 INFO - 'NO_EM_RESTART': '1', 06:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:32 INFO - 'PWD': '/builds/slave/test', 06:38:32 INFO - 'SHELL': '/bin/bash', 06:38:32 INFO - 'SHLVL': '1', 06:38:32 INFO - 'TERM': 'linux', 06:38:32 INFO - 'TMOUT': '86400', 06:38:32 INFO - 'USER': 'cltbld', 06:38:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:32 INFO - '_': '/tools/buildbot/bin/python'} 06:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:33 INFO - Downloading/unpacking psutil>=0.7.1 06:38:33 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 06:38:33 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 06:38:33 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 06:38:33 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 06:38:33 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 06:38:33 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 06:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:35 INFO - Installing collected packages: psutil 06:38:35 INFO - Running setup.py install for psutil 06:38:35 INFO - building 'psutil._psutil_linux' extension 06:38:35 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 06:38:35 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 06:38:35 INFO - building 'psutil._psutil_posix' extension 06:38:35 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 06:38:35 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 06:38:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:35 INFO - Successfully installed psutil 06:38:35 INFO - Cleaning up... 06:38:35 INFO - Return code: 0 06:38:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:35 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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:35 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 06:38:35 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 06:38:35 INFO - Using env: {'DISPLAY': ':0', 06:38:35 INFO - 'HOME': '/home/cltbld', 06:38:35 INFO - 'LANG': 'en_US.UTF-8', 06:38:35 INFO - 'LANGUAGE': 'en_US:en', 06:38:35 INFO - 'LOGNAME': 'cltbld', 06:38:35 INFO - 'MAIL': '/var/mail/cltbld', 06:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:35 INFO - 'MOZ_NO_REMOTE': '1', 06:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:35 INFO - 'NO_EM_RESTART': '1', 06:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:35 INFO - 'PWD': '/builds/slave/test', 06:38:35 INFO - 'SHELL': '/bin/bash', 06:38:35 INFO - 'SHLVL': '1', 06:38:35 INFO - 'TERM': 'linux', 06:38:35 INFO - 'TMOUT': '86400', 06:38:35 INFO - 'USER': 'cltbld', 06:38:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:35 INFO - '_': '/tools/buildbot/bin/python'} 06:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:38:37 INFO - Installing collected packages: mozsystemmonitor 06:38:37 INFO - Running setup.py install for mozsystemmonitor 06:38:37 INFO - Successfully installed mozsystemmonitor 06:38:37 INFO - Cleaning up... 06:38:38 INFO - Return code: 0 06:38:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:38 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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:38 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 06:38:38 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 06:38:38 INFO - Using env: {'DISPLAY': ':0', 06:38:38 INFO - 'HOME': '/home/cltbld', 06:38:38 INFO - 'LANG': 'en_US.UTF-8', 06:38:38 INFO - 'LANGUAGE': 'en_US:en', 06:38:38 INFO - 'LOGNAME': 'cltbld', 06:38:38 INFO - 'MAIL': '/var/mail/cltbld', 06:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:38 INFO - 'MOZ_NO_REMOTE': '1', 06:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:38 INFO - 'NO_EM_RESTART': '1', 06:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:38 INFO - 'PWD': '/builds/slave/test', 06:38:38 INFO - 'SHELL': '/bin/bash', 06:38:38 INFO - 'SHLVL': '1', 06:38:38 INFO - 'TERM': 'linux', 06:38:38 INFO - 'TMOUT': '86400', 06:38:38 INFO - 'USER': 'cltbld', 06:38:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:38 INFO - '_': '/tools/buildbot/bin/python'} 06:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:38 INFO - Downloading/unpacking blobuploader==1.2.4 06:38:38 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 06:38:38 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 06:38:38 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 06:38:38 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 06:38:38 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 06:38:38 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 06:38:40 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:40 INFO - Downloading docopt-0.6.1.tar.gz 06:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:40 INFO - Running setup.py install for blobuploader 06:38:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:41 INFO - Running setup.py install for requests 06:38:41 INFO - Running setup.py install for docopt 06:38:41 INFO - Successfully installed blobuploader requests docopt 06:38:41 INFO - Cleaning up... 06:38:41 INFO - Return code: 0 06:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:41 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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:41 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 06:38:41 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 06:38:41 INFO - Using env: {'DISPLAY': ':0', 06:38:41 INFO - 'HOME': '/home/cltbld', 06:38:41 INFO - 'LANG': 'en_US.UTF-8', 06:38:41 INFO - 'LANGUAGE': 'en_US:en', 06:38:41 INFO - 'LOGNAME': 'cltbld', 06:38:41 INFO - 'MAIL': '/var/mail/cltbld', 06:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:41 INFO - 'MOZ_NO_REMOTE': '1', 06:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:41 INFO - 'NO_EM_RESTART': '1', 06:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:41 INFO - 'PWD': '/builds/slave/test', 06:38:41 INFO - 'SHELL': '/bin/bash', 06:38:41 INFO - 'SHLVL': '1', 06:38:41 INFO - 'TERM': 'linux', 06:38:41 INFO - 'TMOUT': '86400', 06:38:41 INFO - 'USER': 'cltbld', 06:38:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:41 INFO - '_': '/tools/buildbot/bin/python'} 06:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:41 INFO - Running setup.py (path:/tmp/pip-YNzbGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:41 INFO - Running setup.py (path:/tmp/pip-ICMxUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:41 INFO - Running setup.py (path:/tmp/pip-P7gpcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:42 INFO - Running setup.py (path:/tmp/pip-ohtqGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:42 INFO - Running setup.py (path:/tmp/pip-wqrUHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:42 INFO - Running setup.py (path:/tmp/pip-Od8jdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:42 INFO - Running setup.py (path:/tmp/pip-PcB94h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:42 INFO - Running setup.py (path:/tmp/pip-TYTjoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:42 INFO - Running setup.py (path:/tmp/pip-BZS0qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:42 INFO - Running setup.py (path:/tmp/pip-LNC4ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:42 INFO - Running setup.py (path:/tmp/pip-fGS303-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:42 INFO - Running setup.py (path:/tmp/pip-gk952q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:42 INFO - Running setup.py (path:/tmp/pip-rmPS16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:42 INFO - Running setup.py (path:/tmp/pip-MQM7hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:42 INFO - Running setup.py (path:/tmp/pip-Q4Di5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:42 INFO - Running setup.py (path:/tmp/pip-uF4yXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:42 INFO - Running setup.py (path:/tmp/pip-_5fXGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:43 INFO - Running setup.py install for manifestparser 06:38:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Running setup.py install for mozcrash 06:38:43 INFO - Running setup.py install for mozdebug 06:38:43 INFO - Running setup.py install for mozdevice 06:38:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Running setup.py install for mozfile 06:38:43 INFO - Running setup.py install for mozhttpd 06:38:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Running setup.py install for mozinfo 06:38:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Running setup.py install for mozInstall 06:38:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:43 INFO - Running setup.py install for mozleak 06:38:43 INFO - Running setup.py install for mozlog 06:38:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Running setup.py install for moznetwork 06:38:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Running setup.py install for mozprocess 06:38:44 INFO - Running setup.py install for mozprofile 06:38:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Running setup.py install for mozrunner 06:38:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Running setup.py install for mozscreenshot 06:38:44 INFO - Running setup.py install for moztest 06:38:44 INFO - Running setup.py install for mozversion 06:38:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:44 INFO - Cleaning up... 06:38:44 INFO - Return code: 0 06:38:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:44 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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:44 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 06:38:44 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 06:38:44 INFO - Using env: {'DISPLAY': ':0', 06:38:44 INFO - 'HOME': '/home/cltbld', 06:38:44 INFO - 'LANG': 'en_US.UTF-8', 06:38:44 INFO - 'LANGUAGE': 'en_US:en', 06:38:44 INFO - 'LOGNAME': 'cltbld', 06:38:44 INFO - 'MAIL': '/var/mail/cltbld', 06:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:44 INFO - 'MOZ_NO_REMOTE': '1', 06:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:44 INFO - 'NO_EM_RESTART': '1', 06:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:44 INFO - 'PWD': '/builds/slave/test', 06:38:44 INFO - 'SHELL': '/bin/bash', 06:38:44 INFO - 'SHLVL': '1', 06:38:44 INFO - 'TERM': 'linux', 06:38:44 INFO - 'TMOUT': '86400', 06:38:44 INFO - 'USER': 'cltbld', 06:38:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:44 INFO - '_': '/tools/buildbot/bin/python'} 06:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:45 INFO - Running setup.py (path:/tmp/pip-mFkR71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:45 INFO - Running setup.py (path:/tmp/pip-gDLIQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:45 INFO - Running setup.py (path:/tmp/pip-PLCExd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:45 INFO - Running setup.py (path:/tmp/pip-GTGrhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:45 INFO - Running setup.py (path:/tmp/pip-Lo6nMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:45 INFO - Running setup.py (path:/tmp/pip-TXhX_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:45 INFO - Running setup.py (path:/tmp/pip-MCqCzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:45 INFO - Running setup.py (path:/tmp/pip-AhFxf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:45 INFO - Running setup.py (path:/tmp/pip-3p9vJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:45 INFO - Running setup.py (path:/tmp/pip-MYFfQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:45 INFO - Running setup.py (path:/tmp/pip-ntmN5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:45 INFO - Running setup.py (path:/tmp/pip-4EGRiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:45 INFO - Running setup.py (path:/tmp/pip-VVZui1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:45 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)) 06:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:45 INFO - Running setup.py (path:/tmp/pip-U2bjWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:46 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)) 06:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:46 INFO - Running setup.py (path:/tmp/pip-taaXkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:46 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)) 06:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:46 INFO - Running setup.py (path:/tmp/pip-AEiOxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:46 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)) 06:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:46 INFO - Running setup.py (path:/tmp/pip-sXsK25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:46 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)) 06:38:46 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)) 06:38:46 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)) 06:38:46 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)) 06:38:46 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)) 06:38:46 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)) 06:38:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:48 INFO - Downloading blessings-1.6.tar.gz 06:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:48 INFO - Installing collected packages: blessings 06:38:48 INFO - Running setup.py install for blessings 06:38:48 INFO - Successfully installed blessings 06:38:48 INFO - Cleaning up... 06:38:48 INFO - Return code: 0 06:38:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:48 INFO - Reading from file tmpfile_stdout 06:38:48 INFO - Current package versions: 06:38:48 INFO - argparse == 1.2.1 06:38:48 INFO - blessings == 1.6 06:38:48 INFO - blobuploader == 1.2.4 06:38:48 INFO - docopt == 0.6.1 06:38:48 INFO - manifestparser == 1.1 06:38:48 INFO - mozInstall == 1.12 06:38:48 INFO - mozcrash == 0.17 06:38:48 INFO - mozdebug == 0.1 06:38:48 INFO - mozdevice == 0.48 06:38:48 INFO - mozfile == 1.2 06:38:48 INFO - mozhttpd == 0.7 06:38:48 INFO - mozinfo == 0.9 06:38:48 INFO - mozleak == 0.1 06:38:48 INFO - mozlog == 3.1 06:38:48 INFO - moznetwork == 0.27 06:38:48 INFO - mozprocess == 0.22 06:38:48 INFO - mozprofile == 0.28 06:38:48 INFO - mozrunner == 6.11 06:38:48 INFO - mozscreenshot == 0.1 06:38:48 INFO - mozsystemmonitor == 0.0 06:38:48 INFO - moztest == 0.7 06:38:48 INFO - mozversion == 1.4 06:38:48 INFO - psutil == 3.1.1 06:38:48 INFO - requests == 1.2.3 06:38:48 INFO - wsgiref == 0.1.2 06:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:48 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')]} 06:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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')]} 06:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:48 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 06:38:48 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 06:38:48 INFO - Using env: {'DISPLAY': ':0', 06:38:48 INFO - 'HOME': '/home/cltbld', 06:38:48 INFO - 'LANG': 'en_US.UTF-8', 06:38:48 INFO - 'LANGUAGE': 'en_US:en', 06:38:48 INFO - 'LOGNAME': 'cltbld', 06:38:48 INFO - 'MAIL': '/var/mail/cltbld', 06:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:48 INFO - 'MOZ_NO_REMOTE': '1', 06:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:48 INFO - 'NO_EM_RESTART': '1', 06:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:48 INFO - 'PWD': '/builds/slave/test', 06:38:48 INFO - 'SHELL': '/bin/bash', 06:38:48 INFO - 'SHLVL': '1', 06:38:48 INFO - 'TERM': 'linux', 06:38:48 INFO - 'TMOUT': '86400', 06:38:48 INFO - 'USER': 'cltbld', 06:38:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:48 INFO - '_': '/tools/buildbot/bin/python'} 06:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 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)) 06:38:48 INFO - Cleaning up... 06:38:48 INFO - Return code: 0 06:38:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:48 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')]} 06:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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')]} 06:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:48 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 06:38:48 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 06:38:48 INFO - Using env: {'DISPLAY': ':0', 06:38:48 INFO - 'HOME': '/home/cltbld', 06:38:48 INFO - 'LANG': 'en_US.UTF-8', 06:38:48 INFO - 'LANGUAGE': 'en_US:en', 06:38:48 INFO - 'LOGNAME': 'cltbld', 06:38:48 INFO - 'MAIL': '/var/mail/cltbld', 06:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:48 INFO - 'MOZ_NO_REMOTE': '1', 06:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:48 INFO - 'NO_EM_RESTART': '1', 06:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:48 INFO - 'PWD': '/builds/slave/test', 06:38:48 INFO - 'SHELL': '/bin/bash', 06:38:48 INFO - 'SHLVL': '1', 06:38:48 INFO - 'TERM': 'linux', 06:38:48 INFO - 'TMOUT': '86400', 06:38:48 INFO - 'USER': 'cltbld', 06:38:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:48 INFO - '_': '/tools/buildbot/bin/python'} 06:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:49 INFO - Downloading/unpacking jsonschema 06:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:50 INFO - Downloading/unpacking functools32 (from jsonschema) 06:38:50 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 06:38:50 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 06:38:50 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 06:38:50 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 06:38:50 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 06:38:50 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 06:38:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:51 INFO - warning: no files found matching '*.txt' 06:38:51 INFO - no previously-included directories found matching 'build' 06:38:51 INFO - no previously-included directories found matching 'dist' 06:38:51 INFO - no previously-included directories found matching '.git*' 06:38:51 INFO - Installing collected packages: jsonschema, functools32 06:38:51 INFO - Running setup.py install for functools32 06:38:51 INFO - warning: no files found matching '*.txt' 06:38:51 INFO - no previously-included directories found matching 'build' 06:38:51 INFO - no previously-included directories found matching 'dist' 06:38:51 INFO - no previously-included directories found matching '.git*' 06:38:51 INFO - Successfully installed jsonschema functools32 06:38:51 INFO - Cleaning up... 06:38:51 INFO - Return code: 0 06:38:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d99e67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', '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 06:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:38:51 INFO - Using env: {'DISPLAY': ':0', 06:38:51 INFO - 'HOME': '/home/cltbld', 06:38:51 INFO - 'LANG': 'en_US.UTF-8', 06:38:51 INFO - 'LANGUAGE': 'en_US:en', 06:38:51 INFO - 'LOGNAME': 'cltbld', 06:38:51 INFO - 'MAIL': '/var/mail/cltbld', 06:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:51 INFO - 'MOZ_NO_REMOTE': '1', 06:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:51 INFO - 'NO_EM_RESTART': '1', 06:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:51 INFO - 'PWD': '/builds/slave/test', 06:38:51 INFO - 'SHELL': '/bin/bash', 06:38:51 INFO - 'SHLVL': '1', 06:38:51 INFO - 'TERM': 'linux', 06:38:51 INFO - 'TMOUT': '86400', 06:38:51 INFO - 'USER': 'cltbld', 06:38:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:51 INFO - '_': '/tools/buildbot/bin/python'} 06:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:51 INFO - Downloading/unpacking flake8 06:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:38:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:38:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:38:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:54 INFO - no previously-included directories found matching 'docs/_build' 06:38:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:38:54 INFO - Running setup.py install for pep8 06:38:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:54 INFO - no previously-included directories found matching 'docs/_build' 06:38:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:38:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:38:54 INFO - Cleaning up... 06:38:54 INFO - Return code: 0 06:38:54 INFO - Running post-action listener: _resource_record_post_action 06:38:54 INFO - Running post-action listener: _start_resource_monitoring 06:38:54 INFO - Starting resource monitoring. 06:38:54 INFO - ##### 06:38:54 INFO - ##### Running install step. 06:38:54 INFO - ##### 06:38:54 INFO - Running pre-action listener: _resource_record_pre_action 06:38:54 INFO - Running main action method: install 06:38:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:54 INFO - Reading from file tmpfile_stdout 06:38:54 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:54 INFO - Reading from file tmpfile_stdout 06:38:54 INFO - Output received: 06:38:54 INFO - Usage: mozinstall [options] installer 06:38:54 INFO - Options: 06:38:54 INFO - -h, --help show this help message and exit 06:38:54 INFO - -d DEST, --destination=DEST 06:38:54 INFO - Directory to install application into. [default: 06:38:54 INFO - "/builds/slave/test"] 06:38:54 INFO - --app=APP Application being installed. [default: firefox] 06:38:54 INFO - mkdir: /builds/slave/test/build/application 06:38:54 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'] 06:38:54 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 06:39:08 INFO - Reading from file tmpfile_stdout 06:39:08 INFO - Output received: 06:39:08 INFO - /builds/slave/test/build/application/firefox/firefox 06:39:08 INFO - Running post-action listener: _resource_record_post_action 06:39:08 INFO - ##### 06:39:08 INFO - ##### Running run-tests step. 06:39:08 INFO - ##### 06:39:08 INFO - Running pre-action listener: _resource_record_pre_action 06:39:08 INFO - Running main action method: run_tests 06:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:39:08 INFO - Python 2.7.3 06:39:08 INFO - Return code: 0 06:39:08 INFO - grabbing minidump binary from tooltool 06:39: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')]} 06:39:08 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 0x11fd640>, '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 0x11fe540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fe9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:39:08 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 06:39:08 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 06:39:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:08 INFO - Return code: 0 06:39:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:39:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:39:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:39:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:39:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:39:09 INFO - Return code: 0 06:39:09 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/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 06:39:09 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/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 06:39:09 INFO - Using env: {'DISPLAY': ':0', 06:39:09 INFO - 'HOME': '/home/cltbld', 06:39:09 INFO - 'LANG': 'en_US.UTF-8', 06:39:09 INFO - 'LANGUAGE': 'en_US:en', 06:39:09 INFO - 'LOGNAME': 'cltbld', 06:39:09 INFO - 'MAIL': '/var/mail/cltbld', 06:39:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:39:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:09 INFO - 'MOZ_NO_REMOTE': '1', 06:39:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:09 INFO - 'NO_EM_RESTART': '1', 06:39:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:09 INFO - 'PWD': '/builds/slave/test', 06:39:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:39:09 INFO - 'SHELL': '/bin/bash', 06:39:09 INFO - 'SHLVL': '1', 06:39:09 INFO - 'TERM': 'linux', 06:39:09 INFO - 'TMOUT': '86400', 06:39:09 INFO - 'USER': 'cltbld', 06:39:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941', 06:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:09 INFO - '_': '/tools/buildbot/bin/python'} 06:39:09 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/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 06:39:09 INFO - mozversion application_buildid: 20160708005427 06:39:09 INFO - mozversion application_changeset: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 06:39:09 INFO - mozversion application_display_name: Firefox 06:39:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:09 INFO - mozversion application_name: Firefox 06:39:09 INFO - mozversion application_remotingname: firefox 06:39:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:39:09 INFO - mozversion application_vendor: Mozilla 06:39:09 INFO - mozversion application_version: 48.0 06:39:09 INFO - mozversion platform_buildid: 20160708005427 06:39:09 INFO - mozversion platform_changeset: 60d09be974d615ae5c7fa1129516dbd0a6884dc5 06:39:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:39:09 INFO - mozversion platform_version: 48.0 06:39:09 INFO - using testdate: 1467985149 06:39:09 INFO - actual date: 1467985149 06:39:09 INFO - starting webserver on 'localhost:39384' 06:39:09 INFO - SUITE-START | Running 2 tests 06:39:09 INFO - TEST-START | dromaeo_css 06:39:09 INFO - operating with platform_type : linux_ 06:39:09 INFO - Initialising browser for dromaeo_css test... 06:39:09 INFO - TEST-INFO | started process 15358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_vE5cV/profile http://localhost:39384/getInfo.html) 06:39:12 INFO - PROCESS | 15358 | 06:39:12 INFO - PROCESS | 15358 | (process:15437): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:39:13 INFO - PROCESS | 15358 | __metrics Screen width/height:1600/1200 06:39:13 INFO - PROCESS | 15358 | colorDepth:24 06:39:13 INFO - PROCESS | 15358 | Browser inner width/height: 1024/697 06:39:13 INFO - PROCESS | 15358 | __metrics 06:39:14 ERROR - PROCESS | 15358 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:39:14 INFO - TEST-INFO | 15358: exit 0 06:39:14 INFO - Browser initialized. 06:39:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:14 INFO - TEST-INFO | started process 15488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_vE5cV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:16 INFO - PROCESS | 15488 | 06:39:16 INFO - PROCESS | 15488 | (process:15555): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:39:26 INFO - PROCESS | 15488 | RSS: Main: 149987328 06:39:26 INFO - PROCESS | 15488 | 06:40:16 INFO - PROCESS | 15488 | 1467985216285 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] 06:42:23 INFO - PROCESS | 15488 | Cycle 1(1): loaded http://localhost:39384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39384/tests/dromaeo/cssquery-ext.html) 06:42:24 INFO - PROCESS | 15488 | RSS: Main: 154161152 06:42:24 INFO - PROCESS | 15488 | 06:45:26 INFO - PROCESS | 15488 | Cycle 1(1): loaded http://localhost:39384/tests/dromaeo/cssquery-ext.html (next: http://localhost:39384/tests/dromaeo/cssquery-jquery.html) 06:45:27 INFO - PROCESS | 15488 | RSS: Main: 151736320 06:45:27 INFO - PROCESS | 15488 | 06:48:28 INFO - PROCESS | 15488 | Cycle 1(1): loaded http://localhost:39384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39384/tests/dromaeo/cssquery-mootools.html) 06:48:29 INFO - PROCESS | 15488 | RSS: Main: 151887872 06:48:29 INFO - PROCESS | 15488 | 06:51:31 INFO - PROCESS | 15488 | Cycle 1(1): loaded http://localhost:39384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39384/tests/dromaeo/cssquery-prototype.html) 06:51:31 INFO - PROCESS | 15488 | RSS: Main: 152997888 06:51:31 INFO - PROCESS | 15488 | 06:54:34 INFO - PROCESS | 15488 | Cycle 1(1): loaded http://localhost:39384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39384/tests/dromaeo/cssquery-yui.html) 06:54:34 INFO - PROCESS | 15488 | RSS: Main: 152158208 06:54:34 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | Cycle 1(1): loaded http://localhost:39384/tests/dromaeo/cssquery-yui.html (next: http://localhost:39384/tests/dromaeo/cssquery-dojo.html) 06:57:37 INFO - PROCESS | 15488 | RSS: Main: 155848704 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | __start_tp_report 06:57:37 INFO - PROCESS | 15488 | _x_x_mozilla_page_load 06:57:37 INFO - PROCESS | 15488 | _x_x_mozilla_page_load_details 06:57:37 INFO - PROCESS | 15488 | |i|pagename|runs| 06:57:37 INFO - PROCESS | 15488 | |0;dojo.html;3260.8695652173906;3312.9337413251733;3385.1706331948676;3430.9313813723725;3438.570178727659;5509.752061157247;5529.281193444852;5561.3882472928;5563.721813909304;5568.1091025435935;5542.667439953596;5561.721913904299;5575.080111781551;5585.05054140796;5606.131049687295;5021.472745361739;5025.321581586476;5065.290859279704;5081.8475445736685;5088.694678319294;4999.8000079996755;5059.721715305656;5121.590272778188;5159.974200129013;5189.377274727038;5107.693538387709;5121;5157.071727089123;5166.767495462695;5178.741062946857;5120.820771272987;5122.487751224885;5130.127878260705;5143.871403214912;5181.637285390024;4968.87577810554;4985.077760614262;5069.417017043051;5070.03669302835;5103.56619687327;5473.75368108436;5487.314085739283;5489.39616642169;5514;5556.72216389183;5997.370276120988;6029.879402411927;6038.396160383971;6041.818745437644;6057.939420605781;5829.766809327622;6009.429104235091;6035.698215089228;6101.969490152565;6103.786367477117;5700.458456446672;5705.429457054262;5712.542996560265;5713.285839270091;5717.599768016241;6190;6206.100115483229;6209.875802483925;6220.688965551704;6221.160143380676;5850.824475265749;5932.851678707981;5972.313183983897;5996.580239383288;6029.879402411927;6094.146819445281;6105.755769769159;6111.908321375183;6118.265808103056;6125.264968203844;6030.065339872327;6056.697165141725;6065.150878876961;6065.666388348595;6081.17904082952;5949.553783466171;5988.730507127189;6043.335233124353;6067.939320606737;6081.422264884917;4559.088182363541;4633.791479383436;4636.9536304637195;4638.536146385402;4656.813727450932;4036.475258216472;4118;4137.731047481904;4142.482189726285;4172.8122234498915;5691.459311365414;5773.855653608609;5786.913196302059;5834.737436815353;5880.441358070976;6086.60437071589;6107.267127944675;6110.953680641517;6122.825290667262;6146.7233974471255;5688.488036076773;5805.506531944748;5821.53427725781;5822.592418530747;5826.796062137805;4968.8757781055765;4974.9751251243515;4996.925046124311;5015.623828212899;5028.748562571856;6198.318184999646;6219.067139928957;6223.0354295084335;6227.564070515111;6229.781957631551;5938.2280303560265;5941.821745347646;5967.731452084579;5981.252343457068;5997.190379298739;6163.137160797402;6195;6214.223222097238;6241.407066328691;6307.905381419374;5890.204822348928;5890.764369425175;5894.646321220741;5897.469227769521;5908.05471124618;5927.2590926134235;5984.670843103671;5991.7603295867675;5998.160257563857;6002.159697642421;5773.711314434177;5853.297604287342;5858.94141058584;5910.911336330045;5932.406759324033;5828.300603927556;5908.497777688945;5922.2597175353085;5927.347991720821;5943.732532036155;5704.286964129484;5846.473817356458;5853.64878107315;5873.207117039145;5873.794417195378;5935.0207215808905;5949.286085669747;5974;5975.731092100953;5976.223090998143;5792.9710351447975;5796.82609521715;5797.826065218051;5801.100829371454;5802.361740208658 06:57:37 INFO - PROCESS | 15488 | |1;ext.html;665.2549144957649;668.191488299158;676.7191615479576;696.742205384008;789.3093543149744;31978;32211;32303.676963230333;32312.192195195134;32324.353512929727;40569.797151014274;40786.796066019706;41121.79439102808;41203.381949270784;41204.58795412045;8629.09394513578;8932.151445612657;8932.910670893305;8946.910530894706;8955.910440895605;8523.57382130894;8570.571471426403;8792.032876383593;8794.912050879506;8815.60329785158;8795.516246606434;8803;8812.206901378875;8822.470651760883;8825.470471771681;8729.60716767747;8767.035626081126;8779.253763430115;8789.868151977693;8807.119288071206;8977.910220897838;9110.681126160618;9149.405288656217;9177.541122943827;9209.953950230207;41155.38266925998;41357.379639305436;41856.79071604653;41916;44248.77875610634;3469;3638.399664055428;3651.087228192952;3762.360398732222;4113.753174809521;32192.839035804904;34371.312573748386;34642.65357346445;34767;34965.65034349649;4692.36653051837;4699.906001879944;4717.174494463489;4792.131523874052;4814.638902082323;323737;324967;327745;328959;329046;39338.21323573512;66331.00503492451;66691;66738.66630666815;66759.33240667531;37816.24367512689;38057;38126.23747525089;38129.42805857914;38270.234595308495;16405.42581009659;16837.2423240952;16867.831321686626;16877.818552701192;16903.323867045427;14297.428102875976;14355.85644143566;14358.497452589318;14394;14395.280235988159;9274.118958698913;9383.202427793578;9407.153356197976;9469.90530094704;9473.526323683789;3603.8017909015257;3691.8523259069875;3696.2053158571034;3723.627637236309;3748.9437658435145;1084.2410312780928;1138.3397629374942;1154.5901205072078;1206.1556910162922;1246.9127161098818;33325.833370833476;33804;33969.66030339665;34399;34731.55612510957;1195.54569263681;1222.1872454817624;1292.1536393662166;1308.9280089594972;1346.9393877275545;17486.29522575496;17564.824351756575;17627.118644067745;17845.196966136555;17939;472810;500196;509101;518339;519059;56872;57483.42516574781;57488.137677934865;57622.7118864403;57755.71122144363;1550.6356006338501;1551.441481066815;1564.5071802382213;1571.1672813408911;1574.8582627563346;30896.84551577228;31567.052988410385;31748.841255793574;32208.35583288368;32434.351312973136;54118.458815411344;59724.40275597188;61515.38484615096;61535.38464615297;61753;404736;405731;410847;412086;412280;46233.537664624266;46463;46902.82742931454;47220.7638961803;47857.76071119622;43187;51648.741756290976;51829;52878.471215287354;52959.470405297;33441.331173376886;34038.319233615686;34194.31611367709;34394;34701;41410.37884431676;41669.16661666689;41908.79045604752;42174;42666.5733342675;41888;42343;42509.14981700287;43260.35109473424;43338.13323733571;36204;36768.63231367759;37046.07384815401;37157.81421092877;37237;26542.867285663448;29326.560101598065;30683.386332272785;30865.537016944316;31030.379392412477 06:57:37 INFO - PROCESS | 15488 | |2;jquery.html;421.75116681158113;427.7711424387953;435.1775144975994;436.9300911854104;443.54315055492845;17111.14444277786;17748.112594370294;17761.289548418063;18109.909450452764;19182.328618498355;18337.54156146097;18412.815871841278;18458.446246612588;18808.05959702016;18823.90588047061;5477.260569823073;5733.254676891998;5761.078227483604;5761.654300741948;7006.194287656934;7104.183018952835;7123.928760712379;7181.85636287274;7182.06633137694;7185.281471852799;6861.245263021064;7106.147262328528;7139.89290160648;7159.105111861018;7164.498485106019;6461.289258181596;7097.858042839166;7354.154272258678;7601;7614;7311.634418279064;7371.520851144658;7375.373093287077;7382.52013619113;7419.03552538172;26065;26274.6058809118;26921.865390673116;27350.863245683842;27504.58743118855;2753.490604238222;2778.1665500349814;2779.0829026421234;2819.9436011279863;2861.542153255469;15142.394304227817;15462.536123916301;15855.682886342209;15989.680206395924;16128.112953787537;2175.042981088316;2204.0853045986055;2232.6651002349777;2312.456572705413;2423.4426082001064;63514.68242658757;74921;78273.60863195705;80603.5969820153;84800.99999999939;16782.916085419496;17263.65472690539;18397.632047359246;18745.156467958976;19680.80319196818;33480.83259583735;33558.328833423686;33866.661333386844;33926.32147357039;34121.65878341234;8021.719239826695;8339.45793523419;8357.414980951275;8817.338699597556;10372.740681482872;7943.721969731032;7982.800429989181;8448.11294814048;8696;8968.461892286483;5010;5023.1711767557945;5035.219540971156;5121.231815227671;5214.556762675215;2152.2036846366946;2181.879996600202;2194.967075493837;2199.571083638675;2204.9669254961186;1046.9895301047045;1077.6874706335232;1089.6839916424308;1093;1166.2827361172988;19521;19570.412887613395;19601.80398196028;19672.409827705193;20168.49578760543;1061.1192710050639;1074.5648012554927;1108.2463924531235;1113.8607674040745;1182.1134149387958;10585.629502967358;11078.390688512209;11125.944370278097;11162.944185279022;11208.15938804593;448480;452117;475491;488519;489530;86574;92801;93032;93979;95049;1169.0472265104083;1170.1165619957048;1170.39724541861;1174.6887074925153;1185.5080141741253;17435.215415306597;17922.820771792114;17955.551111222325;18048;18246.361377351728;34544.82727586346;39821.60178398295;40168;40187;40326.39510407405;56638.15042774444;59495.40504594899;59711.40288597059;59737.40262597492;59820.70089649698;8994.235489983424;9078;9124.95437522808;9243.121903419164;9257.86113208289;12717.745645087232;13581.864181358455;13615.57036511152;13695;13717.519886804314;11121.83317250258;11337.773244535229;11412.828807567726;11762.941185294361;11972.880271197177;11385.487653055467;11663.76672466563;11740.471678774646;12101.75796484083;12309.507619695112;11933.701657458285;11998.64004079879;12019.63941081769;12107.939460302641;12123.939380303042;8910.930688317185;8944.776380590538;9047.547622618975;9048.230900373279;9145.496997665192;11273.661790146309;12274;12319.384030798603;12392.442340094538;12659.240445573296 06:57:37 INFO - PROCESS | 15488 | |3;mootools.html;1450.5648305508348;1494.7757836324554;1721.9311227550897;1856.1090676475283;1903.7144428335757;7588.051493563305;8139.145389734082;8454.619542120605;8712.869306960392;8732.476051436919;8207.507549547017;8330.250277475026;8505.106963768809;8704.347173961962;8725.38922275441;2410.301012706313;2460.3480077779404;2476.554220240356;2483.888225029878;2483.987580062106;2482.8013758899247;2528.5954247320433;2530.177692250017;2531.0761572026263;2531.746825317463;2478.677771889652;2488.315713178872;2494.663220465241;2495.438526331579;2495.987520062397;2442.7068751749816;2470.950580988379;2488.3032750829707;2493.501299740059;2513.3716570857287;2511.987440062788;2528.089887640448;2530.316814460104;2530.4180038591226;2541.898324067035;8722.389432739647;8760.123987601253;8774.912250877473;8790.86813697795;8793.912060879373;5505.229267902497;5624.128260119688;5624.690642014688;5626.690532020737;5629.577781666391;3636.8727094551564;3688.428293614494;3747.925041499182;3763.5107436033413;3787.431885217212;1142.3659868772827;1186.1341220908785;1194.6834088966432;1222.9388530573435;1224.3388570172096;12375.814362784566;12430.067744919168;12447;12487.625371238877;12502.124851260416;4668;4777.378940737682;4813.711177329372;4816.133096042746;4840.249761287007;9940.602375905028;10015.39907605546;10031.598736050477;10059.497025148714;10067.244956628283;5428;5467.043267428184;5470.890582188334;5503.091989821634;5508.063629182969;4925.876853078702;4954.133026720309;4997.400311962588;5028.19548872186;5036.219385995177;4189.6438802701505;4204.789760511962;4242.300020496584;4273.636740876998;4301.612854843079;1351.8377794664702;1382.8617138286293;1399.811025511543;1402;1402.9649258768409;837.392890154633;888.7244954064261;949.6960972488737;975.9021101261081;1017.8320577104843;5754.280714910637;5875.3243377012195;5958.165856780054;6003.369646187175;6185.752569897154;463.1385622741698;465.1441347919776;485.55329097230634;500.3420502039806;500.60452242727837;4107.199096176217;4130.215259100762;4147.688923330762;4150.896227594274;4177.4778152730905;10574.101201397967;10822.567097316176;10980.615678451215;11004.834927476095;11027.17296202788;10653.73365665849;10742.624008159677;10809;10839.783204335869;10893.346399216072;7896.368290536858;8137.145599712064;8168.83662326762;8171.591420429074;8173.95913020443;6021.518278537794;6032.668203248863;6087.969560152171;6158;6173.567850250619;9557.713268601952;9722.611095556098;9817.607295708378;9958.053984871425;9966.103050725469;9868.358556693793;9968.152707019985;9970.152537034433;10086.949565252127;10134.594616215563;6844.5208835381045;7325.6337183141695;7503.737369192052;7825.178356272737;7936.325412340016;8017.438779285394;8042.195780422145;8044.477108987897;8047.034355877332;8047.074586422402;7101.715931362688;7383.224761400191;7387.298206670358;7413.518121322097;7417;7435.996140521177;7460.142083660448;7474.39420434674;7520.435967302584;7530.623468826428;7263.273672632695;7268.854622907618;7274.527155734861;7275.490715649854;7321.74373896911;4764.642651801059;5102.311187989574;5152.381714194321;5239.869003274948;5286.074936885952;5389.137737961907;5393.43368946255;5420.864478388072;5429.402765695691;5538.196961440649 06:57:37 INFO - PROCESS | 15488 | |4;prototype.html;367.83998960452203;368.9206820533586;369.8132443116226;374.7545357790648;377.1194261399632;6357.68211589421;6434.581752186111;6445.581037232582;6447.7420903163875;6469.902951455732;6393.232812062547;6409.423151916327;6450.548461607689;6455.870882582346;6455.935440645592;4905.509449055102;4919.335889654904;4933.33399991002;4980.526849949267;4996.825111121111;4988.42633097193;4988.65079444439;4992.201247800353;4998.800047998076;5000.19996800512;4942.5304596063315;4950.158473059589;4950.579200767939;4953.306537084793;4959.950400496003;4707.058588282323;4819.879503012417;4935.0376676548085;4944.283078953549;4951.628627852925;4220.493540775126;4222.809973551198;4233.301505251629;4254.255505286594;4272;6248.468880145193;6249.750009999594;6262.405071518198;6279;6283.622982621057;5581;5641.746121424546;5692.601517893749;5722.570807189436;5795.391483894173;6874.2814296425895;6877.931220687779;6881.174259088892;6882.655867206619;6895.379415852547;4790.377250957354;4790.377250957388;4791.520847915215;4800.303955926371;4810.374651295309;7103.147622285359;7175.461840361993;7184.44952042028;7186.317299856505;7191.316824901678;4921.532454416824;4922.606191504671;4926.852194434101;4927.7536123193695;4937.1606826839525;4826.686265392738;4953;5000.62495312853;5003.174476211384;5013.523715247045;5721.39925307845;5744.224529688522;5759.769609215668;5766.308043034779;5768.913466298009;6961.686724097428;6962.825929351807;6964.303569642995;6988.615626140611;7034.40207582351;1737.5569229846308;1763.5414792154131;1763.7883453985348;1765.1703699261327;1769.51338381946;1129.7627498225465;1139.9373034483183;1160.802663547199;1181.9468123934444;1201.3212534917743;6552.246491653425;6562.278149403562;6562.67186640666;6568.047633093175;6689.464842812563;7067.823304417328;7116.466265030143;7123;7123.43012558994;7123.964380178169;6632.0383544385795;6645.136132302867;6645.568038077509;6649.202095748445;6651.3681200286865;3811.7712937223855;3820.9235815284096;3821.5796262411113;3844.500214972036;3848.422736589478;7266.890996635055;7525.134609519866;7530.397568194531;7538.208488108779;7542.094948606093;7245.094363204599;7291.052163218747;7337.88993165103;7337.926620733831;7338.853222935511;7550.282723141293;7556.735514256975;7559.1684914659345;7563.848723025509;7572.280633339934;6959.965200173967;7205.315495027964;7211.927880721336;7216.0258365120035;7218.458615603746;7040.788776336718;7077.6461176941975;7116.822079448055;7121.216666166614;7132.928670713226;7527.2096429876265;7561.962190189014;7564.659590318559;7573.166951635426;7575.886361704469;4874.756262186947;4915.877103072452;4920.901581968412;4921.557059864629;4924.606031517542;6973.686184121625;7151.53515021522;7199.02813120243;7211.891821622785;7213.20654727969;6920;6943.930560694328;6958.512904096665;6958.860822783415;6973.721051157897;6913.343232392915;6929.896051559332;6947.826304342432;6953.582785032914;6966.616836073862;6809.740198063374;6823.727050917908;6830.146231721035;6840.384365407137;6844.247132815486;6753.898691519533;6991.44068474531;7028.156621205488;7033.859322813412;7035.753748618774;6671.833204169935;6784.830379240559;6866.759663411756;6889;6902.275261097713 06:57:37 INFO - PROCESS | 15488 | |5;yui.html;796.2236819101377;810.3517186250998;815.3762371785585;830.6843399508186;884.7478468636438;14704.149398312273;14748.262586870655;14896.702065958674;15011.774823377658;15786.921065394657;14683.706325873503;14852.55442336729;14876.181810000446;14898.106113633163;14917.701645967101;881.1056777370974;900.1403659505173;917.0325306801356;927.2906226736552;928.9489078100702;894.065701342099;898.6630013744846;900.063933509153;900.693764120199;906.0260220263243;936.0125068053201;938.3619138985487;939.7274790310836;944.2257348973844;946;931.4690626342987;931.6646007437317;934.3319526538558;937.610891480035;938.0853667674031;688.0298778722027;689.6551724137931;693.462566510953;693.5076095971866;695.9338862808025;15494.922525387414;15509.767353489593;15531.922340388339;15539.378424862993;15591.532254032398;14092.859071409257;14289.785653215211;14291.356888940023;14433.134011959211;14705.55883323502;11872.168948173632;11994.16040877139;12093.274403535728;12098;12271.877281227253;3913;3960.6237407446247;4001.755943769901;4022.7787471689044;4106.466159399289;56171.43828561703;56508;56634.716826416014;56693.433065669225;57362.42637573654;10446.947765261126;11200.887991120147;11374;11554.59558915434;11604.593839215588;16953.237104330336;16969.490915272563;17023.914880425767;17063.658726825393;17065.829341706423;8773.912260877438;8816.647334106563;8878.73363799087;8900;9118.36171468004;4902.068606964665;4967.925481117786;5042.369703787027;5093.363329583802;5214.687118772886;3511.754177207571;3536.45184996326;3544.7873127612424;3548.0420286522494;3552.289542091592;665.4776000839414;681.2302098628518;688.1913751342153;693.7571849852612;703.0508813102373;654.8395643067479;710.8151880511105;710.9040279562296;775.0970119810357;777.7200207925142;9678.27412944032;9918.900810991798;10201.438920859275;10297;10300.845487317696;669.5012215899186;801.6312496251672;802.9638666260032;804.1355542791523;805.3597390074788;4718.159917632126;4763.095011947719;4852.927206091911;4890.168671325812;4926.679765815211;59177.70411148003;59629.403705963254;59787;59838.10242846361;67292.66353668299;54400.45599544033;55188.72405637946;56090.43909560934;56324.71837640786;56480.717596411756;49921.50078499169;50850.237246441335;50887.491125089015;51263.231051534254;52189;10101.292909496558;10162.18702503783;10177.338472999232;10348.793024139324;10353.63762268317;36665.26669466542;37587.62412375841;37732.811335943145;38259.80870095632;38494.230115398095;45309.77345113253;46956.295655565875;48031.75984120057;48588.27117593168;49934.50065499298;11870.52517899309;12017.519299227934;12043.277403355827;12056;12151.57469488599;13746.93126534361;13909.58271251864;14013.472964648485;14083.859161408254;14662.120272783666;12825.871741282468;13830.515931942333;14043.297835108408;14432.927835361175;14557.636059098608;12220.266783992989;12790.936045319713;13622.250776207404;13682;13766.793498097737;12533.310667912987;12847.421866016239;13272.13731107475;13334;13552.728945420838;11085.722856928642;11180.217384783313;11251.043661288883;11420.428978551205;11459.885401145882;11168.720781980515;11204.66386008421;11205.71985700364;11211.383373914514;11256.155788315746 06:57:37 INFO - PROCESS | 15488 | __end_tp_report 06:57:37 INFO - PROCESS | 15488 | __start_cc_report 06:57:37 INFO - PROCESS | 15488 | _x_x_mozilla_cycle_collect,317 06:57:37 INFO - PROCESS | 15488 | __end_cc_report 06:57:37 INFO - PROCESS | 15488 | __startTimestamp1467986257249__endTimestamp 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | ------- Summary: start ------- 06:57:37 INFO - PROCESS | 15488 | Number of tests: 6 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | [#0] dojo.html Cycles:165 Average:5596.79 Median:5834.74 stddev:635.01 (10.9%) stddev-sans-first:609.94 06:57:37 INFO - PROCESS | 15488 | Values: 3260.9 3312.9 3385.2 3430.9 3438.6 5509.8 5529.3 5561.4 5563.7 5568.1 5542.7 5561.7 5575.1 5585.1 5606.1 5021.5 5025.3 5065.3 5081.8 5088.7 4999.8 5059.7 5121.6 5160.0 5189.4 5107.7 5121.0 5157.1 5166.8 5178.7 5120.8 5122.5 5130.1 5143.9 5181.6 4968.9 4985.1 5069.4 5070.0 5103.6 5473.8 5487.3 5489.4 5514.0 5556.7 5997.4 6029.9 6038.4 6041.8 6057.9 5829.8 6009.4 6035.7 6102.0 6103.8 5700.5 5705.4 5712.5 5713.3 5717.6 6190.0 6206.1 6209.9 6220.7 6221.2 5850.8 5932.9 5972.3 5996.6 6029.9 6094.1 6105.8 6111.9 6118.3 6125.3 6030.1 6056.7 6065.2 6065.7 6081.2 5949.6 5988.7 6043.3 6067.9 6081.4 4559.1 4633.8 4637.0 4638.5 4656.8 4036.5 4118.0 4137.7 4142.5 4172.8 5691.5 5773.9 5786.9 5834.7 5880.4 6086.6 6107.3 6111.0 6122.8 6146.7 5688.5 5805.5 5821.5 5822.6 5826.8 4968.9 4975.0 4996.9 5015.6 5028.7 6198.3 6219.1 6223.0 6227.6 6229.8 5938.2 5941.8 5967.7 5981.3 5997.2 6163.1 6195.0 6214.2 6241.4 6307.9 5890.2 5890.8 5894.6 5897.5 5908.1 5927.3 5984.7 5991.8 5998.2 6002.2 5773.7 5853.3 5858.9 5910.9 5932.4 5828.3 5908.5 5922.3 5927.3 5943.7 5704.3 5846.5 5853.6 5873.2 5873.8 5935.0 5949.3 5974.0 5975.7 5976.2 5793.0 5796.8 5797.8 5801.1 5802.4 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | [#1] ext.html Cycles:180 Average:57606.96 Median:22617.77 stddev:111129.13 (491.3%) stddev-sans-first:111358.64 06:57:37 INFO - PROCESS | 15488 | Values: 665.3 668.2 676.7 696.7 789.3 31978.0 32211.0 32303.7 32312.2 32324.4 40569.8 40786.8 41121.8 41203.4 41204.6 8629.1 8932.2 8932.9 8946.9 8955.9 8523.6 8570.6 8792.0 8794.9 8815.6 8795.5 8803.0 8812.2 8822.5 8825.5 8729.6 8767.0 8779.3 8789.9 8807.1 8977.9 9110.7 9149.4 9177.5 9210.0 41155.4 41357.4 41856.8 41916.0 44248.8 3469.0 3638.4 3651.1 3762.4 4113.8 32192.8 34371.3 34642.7 34767.0 34965.7 4692.4 4699.9 4717.2 4792.1 4814.6 323737.0 324967.0 327745.0 328959.0 329046.0 39338.2 66331.0 66691.0 66738.7 66759.3 37816.2 38057.0 38126.2 38129.4 38270.2 16405.4 16837.2 16867.8 16877.8 16903.3 14297.4 14355.9 14358.5 14394.0 14395.3 9274.1 9383.2 9407.2 9469.9 9473.5 3603.8 3691.9 3696.2 3723.6 3748.9 1084.2 1138.3 1154.6 1206.2 1246.9 33325.8 33804.0 33969.7 34399.0 34731.6 1195.5 1222.2 1292.2 1308.9 1346.9 17486.3 17564.8 17627.1 17845.2 17939.0 472810.0 500196.0 509101.0 518339.0 519059.0 56872.0 57483.4 57488.1 57622.7 57755.7 1550.6 1551.4 1564.5 1571.2 1574.9 30896.8 31567.1 31748.8 32208.4 32434.4 54118.5 59724.4 61515.4 61535.4 61753.0 404736.0 405731.0 410847.0 412086.0 412280.0 46233.5 46463.0 46902.8 47220.8 47857.8 43187.0 51648.7 51829.0 52878.5 52959.5 33441.3 34038.3 34194.3 34394.0 34701.0 41410.4 41669.2 41908.8 42174.0 42666.6 41888.0 42343.0 42509.1 43260.4 43338.1 36204.0 36768.6 37046.1 37157.8 37237.0 26542.9 29326.6 30683.4 30865.5 31030.4 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | [#2] jquery.html Cycles:180 Average:29574.21 Median:15129.04 stddev:77536.93 (512.5%) stddev-sans-first:77723.55 06:57:37 INFO - PROCESS | 15488 | Values: 421.8 427.8 435.2 436.9 443.5 17111.1 17748.1 17761.3 18109.9 19182.3 18337.5 18412.8 18458.4 18808.1 18823.9 5477.3 5733.3 5761.1 5761.7 7006.2 7104.2 7123.9 7181.9 7182.1 7185.3 6861.2 7106.1 7139.9 7159.1 7164.5 6461.3 7097.9 7354.2 7601.0 7614.0 7311.6 7371.5 7375.4 7382.5 7419.0 26065.0 26274.6 26921.9 27350.9 27504.6 2753.5 2778.2 2779.1 2819.9 2861.5 15142.4 15462.5 15855.7 15989.7 16128.1 2175.0 2204.1 2232.7 2312.5 2423.4 63514.7 74921.0 78273.6 80603.6 84801.0 16782.9 17263.7 18397.6 18745.2 19680.8 33480.8 33558.3 33866.7 33926.3 34121.7 8021.7 8339.5 8357.4 8817.3 10372.7 7943.7 7982.8 8448.1 8696.0 8968.5 5010.0 5023.2 5035.2 5121.2 5214.6 2152.2 2181.9 2195.0 2199.6 2205.0 1047.0 1077.7 1089.7 1093.0 1166.3 19521.0 19570.4 19601.8 19672.4 20168.5 1061.1 1074.6 1108.2 1113.9 1182.1 10585.6 11078.4 11125.9 11162.9 11208.2 448480.0 452117.0 475491.0 488519.0 489530.0 86574.0 92801.0 93032.0 93979.0 95049.0 1169.0 1170.1 1170.4 1174.7 1185.5 17435.2 17922.8 17955.6 18048.0 18246.4 34544.8 39821.6 40168.0 40187.0 40326.4 56638.2 59495.4 59711.4 59737.4 59820.7 8994.2 9078.0 9125.0 9243.1 9257.9 12717.7 13581.9 13615.6 13695.0 13717.5 11121.8 11337.8 11412.8 11762.9 11972.9 11385.5 11663.8 11740.5 12101.8 12309.5 11933.7 11998.6 12019.6 12107.9 12123.9 8910.9 8944.8 9047.5 9048.2 9145.5 11273.7 12274.0 12319.4 12392.4 12659.2 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | [#3] mootools.html Cycles:180 Average:5805.63 Median:2764.40 stddev:3198.52 (115.7%) stddev-sans-first:3190.75 06:57:37 INFO - PROCESS | 15488 | Values: 1450.6 1494.8 1721.9 1856.1 1903.7 7588.1 8139.1 8454.6 8712.9 8732.5 8207.5 8330.3 8505.1 8704.3 8725.4 2410.3 2460.3 2476.6 2483.9 2484.0 2482.8 2528.6 2530.2 2531.1 2531.7 2478.7 2488.3 2494.7 2495.4 2496.0 2442.7 2471.0 2488.3 2493.5 2513.4 2512.0 2528.1 2530.3 2530.4 2541.9 8722.4 8760.1 8774.9 8790.9 8793.9 5505.2 5624.1 5624.7 5626.7 5629.6 3636.9 3688.4 3747.9 3763.5 3787.4 1142.4 1186.1 1194.7 1222.9 1224.3 12375.8 12430.1 12447.0 12487.6 12502.1 4668.0 4777.4 4813.7 4816.1 4840.2 9940.6 10015.4 10031.6 10059.5 10067.2 5428.0 5467.0 5470.9 5503.1 5508.1 4925.9 4954.1 4997.4 5028.2 5036.2 4189.6 4204.8 4242.3 4273.6 4301.6 1351.8 1382.9 1399.8 1402.0 1403.0 837.4 888.7 949.7 975.9 1017.8 5754.3 5875.3 5958.2 6003.4 6185.8 463.1 465.1 485.6 500.3 500.6 4107.2 4130.2 4147.7 4150.9 4177.5 10574.1 10822.6 10980.6 11004.8 11027.2 10653.7 10742.6 10809.0 10839.8 10893.3 7896.4 8137.1 8168.8 8171.6 8174.0 6021.5 6032.7 6088.0 6158.0 6173.6 9557.7 9722.6 9817.6 9958.1 9966.1 9868.4 9968.2 9970.2 10086.9 10134.6 6844.5 7325.6 7503.7 7825.2 7936.3 8017.4 8042.2 8044.5 8047.0 8047.1 7101.7 7383.2 7387.3 7413.5 7417.0 7436.0 7460.1 7474.4 7520.4 7530.6 7263.3 7268.9 7274.5 7275.5 7321.7 4764.6 5102.3 5152.4 5239.9 5286.1 5389.1 5393.4 5420.9 5429.4 5538.2 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | [#4] prototype.html Cycles:180 Average:5791.72 Median:6557.26 stddev:1762.45 (26.9%) stddev-sans-first:1719.74 06:57:37 INFO - PROCESS | 15488 | Values: 367.8 368.9 369.8 374.8 377.1 6357.7 6434.6 6445.6 6447.7 6469.9 6393.2 6409.4 6450.5 6455.9 6455.9 4905.5 4919.3 4933.3 4980.5 4996.8 4988.4 4988.7 4992.2 4998.8 5000.2 4942.5 4950.2 4950.6 4953.3 4960.0 4707.1 4819.9 4935.0 4944.3 4951.6 4220.5 4222.8 4233.3 4254.3 4272.0 6248.5 6249.8 6262.4 6279.0 6283.6 5581.0 5641.7 5692.6 5722.6 5795.4 6874.3 6877.9 6881.2 6882.7 6895.4 4790.4 4790.4 4791.5 4800.3 4810.4 7103.1 7175.5 7184.4 7186.3 7191.3 4921.5 4922.6 4926.9 4927.8 4937.2 4826.7 4953.0 5000.6 5003.2 5013.5 5721.4 5744.2 5759.8 5766.3 5768.9 6961.7 6962.8 6964.3 6988.6 7034.4 1737.6 1763.5 1763.8 1765.2 1769.5 1129.8 1139.9 1160.8 1181.9 1201.3 6552.2 6562.3 6562.7 6568.0 6689.5 7067.8 7116.5 7123.0 7123.4 7124.0 6632.0 6645.1 6645.6 6649.2 6651.4 3811.8 3820.9 3821.6 3844.5 3848.4 7266.9 7525.1 7530.4 7538.2 7542.1 7245.1 7291.1 7337.9 7337.9 7338.9 7550.3 7556.7 7559.2 7563.8 7572.3 6960.0 7205.3 7211.9 7216.0 7218.5 7040.8 7077.6 7116.8 7121.2 7132.9 7527.2 7562.0 7564.7 7573.2 7575.9 4874.8 4915.9 4920.9 4921.6 4924.6 6973.7 7151.5 7199.0 7211.9 7213.2 6920.0 6943.9 6958.5 6958.9 6973.7 6913.3 6929.9 6947.8 6953.6 6966.6 6809.7 6823.7 6830.1 6840.4 6844.2 6753.9 6991.4 7028.2 7033.9 7035.8 6671.8 6784.8 6866.8 6889.0 6902.3 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - PROCESS | 15488 | [#5] yui.html Cycles:180 Average:15361.54 Median:4012.27 stddev:17403.44 (433.8%) stddev-sans-first:17417.89 06:57:37 INFO - PROCESS | 15488 | Values: 796.2 810.4 815.4 830.7 884.7 14704.1 14748.3 14896.7 15011.8 15786.9 14683.7 14852.6 14876.2 14898.1 14917.7 881.1 900.1 917.0 927.3 928.9 894.1 898.7 900.1 900.7 906.0 936.0 938.4 939.7 944.2 946.0 931.5 931.7 934.3 937.6 938.1 688.0 689.7 693.5 693.5 695.9 15494.9 15509.8 15531.9 15539.4 15591.5 14092.9 14289.8 14291.4 14433.1 14705.6 11872.2 11994.2 12093.3 12098.0 12271.9 3913.0 3960.6 4001.8 4022.8 4106.5 56171.4 56508.0 56634.7 56693.4 57362.4 10446.9 11200.9 11374.0 11554.6 11604.6 16953.2 16969.5 17023.9 17063.7 17065.8 8773.9 8816.6 8878.7 8900.0 9118.4 4902.1 4967.9 5042.4 5093.4 5214.7 3511.8 3536.5 3544.8 3548.0 3552.3 665.5 681.2 688.2 693.8 703.1 654.8 710.8 710.9 775.1 777.7 9678.3 9918.9 10201.4 10297.0 10300.8 669.5 801.6 803.0 804.1 805.4 4718.2 4763.1 4852.9 4890.2 4926.7 59177.7 59629.4 59787.0 59838.1 67292.7 54400.5 55188.7 56090.4 56324.7 56480.7 49921.5 50850.2 50887.5 51263.2 52189.0 10101.3 10162.2 10177.3 10348.8 10353.6 36665.3 37587.6 37732.8 38259.8 38494.2 45309.8 46956.3 48031.8 48588.3 49934.5 11870.5 12017.5 12043.3 12056.0 12151.6 13746.9 13909.6 14013.5 14083.9 14662.1 12825.9 13830.5 14043.3 14432.9 14557.6 12220.3 12790.9 13622.3 13682.0 13766.8 12533.3 12847.4 13272.1 13334.0 13552.7 11085.7 11180.2 11251.0 11420.4 11459.9 11168.7 11204.7 11205.7 11211.4 11256.2 06:57:37 INFO - PROCESS | 15488 | -------- Summary: end -------- 06:57:37 INFO - PROCESS | 15488 | 06:57:37 INFO - TEST-INFO | 15488: exit 0 06:57:37 INFO - TEST-OK | dromaeo_css | took 1108633ms 06:57:37 INFO - TEST-START | kraken 06:57:37 INFO - operating with platform_type : linux_ 06:57:37 INFO - Initialising browser for kraken test... 06:57:37 INFO - TEST-INFO | started process 15729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZZHYv/profile http://localhost:39384/getInfo.html) 06:57:41 INFO - PROCESS | 15729 | 06:57:41 INFO - PROCESS | 15729 | (process:15807): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:57:42 INFO - PROCESS | 15729 | __metrics Screen width/height:1600/1200 06:57:42 INFO - PROCESS | 15729 | colorDepth:24 06:57:42 INFO - PROCESS | 15729 | Browser inner width/height: 1024/697 06:57:42 INFO - PROCESS | 15729 | __metrics 06:57:42 ERROR - PROCESS | 15729 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:57:43 INFO - TEST-INFO | 15729: exit 0 06:57:43 INFO - Browser initialized. 06:57:43 INFO - Running cycle 1/1 for kraken test... 06:57:43 INFO - TEST-INFO | started process 15858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZZHYv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:45 INFO - PROCESS | 15858 | 06:57:45 INFO - PROCESS | 15858 | (process:15926): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:57:55 INFO - PROCESS | 15858 | RSS: Main: 150614016 06:57:55 INFO - PROCESS | 15858 | 06:57:57 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39384/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:58 INFO - PROCESS | 15858 | RSS: Main: 156188672 06:57:58 INFO - PROCESS | 15858 | 06:58:01 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39384/tests/kraken/driver.html?testName=audio-dft) 06:58:01 INFO - PROCESS | 15858 | RSS: Main: 156016640 06:58:01 INFO - PROCESS | 15858 | 06:58:04 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39384/tests/kraken/driver.html?testName=audio-fft) 06:58:05 INFO - PROCESS | 15858 | RSS: Main: 156368896 06:58:05 INFO - PROCESS | 15858 | 06:58:07 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39384/tests/kraken/driver.html?testName=audio-oscillator) 06:58:08 INFO - PROCESS | 15858 | RSS: Main: 156037120 06:58:08 INFO - PROCESS | 15858 | 06:58:10 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:10 INFO - PROCESS | 15858 | RSS: Main: 155947008 06:58:10 INFO - PROCESS | 15858 | 06:58:13 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39384/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:14 INFO - PROCESS | 15858 | RSS: Main: 156295168 06:58:14 INFO - PROCESS | 15858 | 06:58:17 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39384/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:18 INFO - PROCESS | 15858 | RSS: Main: 156446720 06:58:18 INFO - PROCESS | 15858 | 06:58:21 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39384/tests/kraken/driver.html?testName=json-parse-financial) 06:58:21 INFO - PROCESS | 15858 | RSS: Main: 156516352 06:58:21 INFO - PROCESS | 15858 | 06:58:23 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:23 INFO - PROCESS | 15858 | RSS: Main: 156250112 06:58:23 INFO - PROCESS | 15858 | 06:58:25 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:26 INFO - PROCESS | 15858 | RSS: Main: 156209152 06:58:26 INFO - PROCESS | 15858 | 06:58:28 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:28 INFO - PROCESS | 15858 | RSS: Main: 156340224 06:58:28 INFO - PROCESS | 15858 | 06:58:31 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:31 INFO - PROCESS | 15858 | RSS: Main: 156934144 06:58:31 INFO - PROCESS | 15858 | 06:58:34 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:35 INFO - PROCESS | 15858 | RSS: Main: 156811264 06:58:35 INFO - PROCESS | 15858 | 06:58:36 INFO - PROCESS | 15858 | Cycle 1(1): loaded http://localhost:39384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39384/tests/kraken/driver.html?testName=ai-astar) 06:58:37 INFO - PROCESS | 15858 | RSS: Main: 158314496 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | __start_tp_report 06:58:37 INFO - PROCESS | 15858 | _x_x_mozilla_page_load 06:58:37 INFO - PROCESS | 15858 | _x_x_mozilla_page_load_details 06:58:37 INFO - PROCESS | 15858 | |i|pagename|runs| 06:58:37 INFO - PROCESS | 15858 | |0;ai-astar;107;111;104;111;111;111;102;113;111;113 06:58:37 INFO - PROCESS | 15858 | |1;audio-beat-detection;161;128;161;174;136;157;164;128;185;132 06:58:37 INFO - PROCESS | 15858 | |2;audio-dft;164;164;162;163;163;162;163;163;162;167 06:58:37 INFO - PROCESS | 15858 | |3;audio-fft;76;76;76;175;72;77;76;76;177;76 06:58:37 INFO - PROCESS | 15858 | |4;audio-oscillator;94;92;146;92;92;92;150;91;93;148 06:58:37 INFO - PROCESS | 15858 | |5;imaging-gaussian-blur;117;117;116;117;118;117;119;117;118;117 06:58:37 INFO - PROCESS | 15858 | |6;imaging-darkroom;146;146;146;147;147;146;147;145;147;146 06:58:37 INFO - PROCESS | 15858 | |7;imaging-desaturate;95;95;94;98;95;95;95;95;96;95 06:58:37 INFO - PROCESS | 15858 | |8;json-parse-financial;59;56;57;56;59;57;60;73;59;54 06:58:37 INFO - PROCESS | 15858 | |9;json-stringify-tinderbox;58;58;58;58;58;58;57;58;57;58 06:58:37 INFO - PROCESS | 15858 | |10;stanford-crypto-aes;72;72;88;73;82;73;73;73;81;72 06:58:37 INFO - PROCESS | 15858 | |11;stanford-crypto-ccm;116;112;113;116;121;113;112;113;137;133 06:58:37 INFO - PROCESS | 15858 | |12;stanford-crypto-pbkdf2;165;159;159;159;161;157;160;164;160;161 06:58:37 INFO - PROCESS | 15858 | |13;stanford-crypto-sha256-iterative;66;68;68;66;67;64;67;68;67;64 06:58:37 INFO - PROCESS | 15858 | __end_tp_report 06:58:37 INFO - PROCESS | 15858 | __start_cc_report 06:58:37 INFO - PROCESS | 15858 | _x_x_mozilla_cycle_collect,823 06:58:37 INFO - PROCESS | 15858 | __end_cc_report 06:58:37 INFO - PROCESS | 15858 | __startTimestamp1467986317177__endTimestamp 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | ------- Summary: start ------- 06:58:37 INFO - PROCESS | 15858 | Number of tests: 14 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:3.91 06:58:37 INFO - PROCESS | 15858 | Values: 107.0 111.0 104.0 111.0 111.0 111.0 102.0 113.0 111.0 113.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:161.00 stddev:20.30 (12.6%) stddev-sans-first:21.30 06:58:37 INFO - PROCESS | 15858 | Values: 161.0 128.0 161.0 174.0 136.0 157.0 164.0 128.0 185.0 132.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 06:58:37 INFO - PROCESS | 15858 | Values: 164.0 164.0 162.0 163.0 163.0 162.0 163.0 163.0 162.0 167.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.35 (55.7%) stddev-sans-first:44.31 06:58:37 INFO - PROCESS | 15858 | Values: 76.0 76.0 76.0 175.0 72.0 77.0 76.0 76.0 177.0 76.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:26.94 (29.3%) stddev-sans-first:28.02 06:58:37 INFO - PROCESS | 15858 | Values: 94.0 92.0 146.0 92.0 92.0 92.0 150.0 91.0 93.0 148.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 06:58:37 INFO - PROCESS | 15858 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 119.0 117.0 118.0 117.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:58:37 INFO - PROCESS | 15858 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 147.0 145.0 147.0 146.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 06:58:37 INFO - PROCESS | 15858 | Values: 95.0 95.0 94.0 98.0 95.0 95.0 95.0 95.0 96.0 95.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:5.25 (8.9%) stddev-sans-first:5.57 06:58:37 INFO - PROCESS | 15858 | Values: 59.0 56.0 57.0 56.0 59.0 57.0 60.0 73.0 59.0 54.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 06:58:37 INFO - PROCESS | 15858 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 57.0 58.0 57.0 58.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:73.00 stddev:5.67 (7.8%) stddev-sans-first:5.83 06:58:37 INFO - PROCESS | 15858 | Values: 72.0 72.0 88.0 73.0 82.0 73.0 73.0 73.0 81.0 72.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:116.00 stddev:9.11 (7.9%) stddev-sans-first:9.61 06:58:37 INFO - PROCESS | 15858 | Values: 116.0 112.0 113.0 116.0 121.0 113.0 112.0 113.0 137.0 133.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:2.42 (1.5%) stddev-sans-first:1.94 06:58:37 INFO - PROCESS | 15858 | Values: 165.0 159.0 159.0 159.0 161.0 157.0 160.0 164.0 160.0 161.0 06:58:37 INFO - PROCESS | 15858 | 06:58:37 INFO - PROCESS | 15858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 06:58:37 INFO - PROCESS | 15858 | Values: 66.0 68.0 68.0 66.0 67.0 64.0 67.0 68.0 67.0 64.0 06:58:37 INFO - PROCESS | 15858 | -------- Summary: end -------- 06:58:37 INFO - PROCESS | 15858 | 06:58:38 INFO - TEST-INFO | 15858: exit 0 06:58:38 INFO - TEST-OK | kraken | took 60131ms 06:58:38 INFO - SUITE-END | took 1168s 06:58:38 INFO - Completed test suite (00:19:29) 06:58:38 INFO - javascript benchmark 06:58:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3260.8695652173906, 3312.9337413251733, 3385.1706331948676, 3430.9313813723725, 3438.570178727659, 5509.752061157247, 5529.281193444852, 5561.3882472928, 5563.721813909304, 5568.1091025435935, 5542.667439953596, 5561.721913904299, 5575.080111781551, 5585.05054140796, 5606.131049687295, 5021.472745361739, 5025.321581586476, 5065.290859279704, 5081.8475445736685, 5088.694678319294, 4999.8000079996755, 5059.721715305656, 5121.590272778188, 5159.974200129013, 5189.377274727038, 5107.693538387709, 5121.0, 5157.071727089123, 5166.767495462695, 5178.741062946857, 5120.820771272987, 5122.487751224885, 5130.127878260705, 5143.871403214912, 5181.637285390024, 4968.87577810554, 4985.077760614262, 5069.417017043051, 5070.03669302835, 5103.56619687327, 5473.75368108436, 5487.314085739283, 5489.39616642169, 5514.0, 5556.72216389183, 5997.370276120988, 6029.879402411927, 6038.396160383971, 6041.818745437644, 6057.939420605781, 5829.766809327622, 6009.429104235091, 6035.698215089228, 6101.969490152565, 6103.786367477117, 5700.458456446672, 5705.429457054262, 5712.542996560265, 5713.285839270091, 5717.599768016241, 6190.0, 6206.100115483229, 6209.875802483925, 6220.688965551704, 6221.160143380676, 5850.824475265749, 5932.851678707981, 5972.313183983897, 5996.580239383288, 6029.879402411927, 6094.146819445281, 6105.755769769159, 6111.908321375183, 6118.265808103056, 6125.264968203844, 6030.065339872327, 6056.697165141725, 6065.150878876961, 6065.666388348595, 6081.17904082952, 5949.553783466171, 5988.730507127189, 6043.335233124353, 6067.939320606737, 6081.422264884917, 4559.088182363541, 4633.791479383436, 4636.9536304637195, 4638.536146385402, 4656.813727450932, 4036.475258216472, 4118.0, 4137.731047481904, 4142.482189726285, 4172.8122234498915, 5691.459311365414, 5773.855653608609, 5786.913196302059, 5834.737436815353, 5880.441358070976, 6086.60437071589, 6107.267127944675, 6110.953680641517, 6122.825290667262, 6146.7233974471255, 5688.488036076773, 5805.506531944748, 5821.53427725781, 5822.592418530747, 5826.796062137805, 4968.8757781055765, 4974.9751251243515, 4996.925046124311, 5015.623828212899, 5028.748562571856, 6198.318184999646, 6219.067139928957, 6223.0354295084335, 6227.564070515111, 6229.781957631551, 5938.2280303560265, 5941.821745347646, 5967.731452084579, 5981.252343457068, 5997.190379298739, 6163.137160797402, 6195.0, 6214.223222097238, 6241.407066328691, 6307.905381419374, 5890.204822348928, 5890.764369425175, 5894.646321220741, 5897.469227769521, 5908.05471124618, 5927.2590926134235, 5984.670843103671, 5991.7603295867675, 5998.160257563857, 6002.159697642421, 5773.711314434177, 5853.297604287342, 5858.94141058584, 5910.911336330045, 5932.406759324033, 5828.300603927556, 5908.497777688945, 5922.2597175353085, 5927.347991720821, 5943.732532036155, 5704.286964129484, 5846.473817356458, 5853.64878107315, 5873.207117039145, 5873.794417195378, 5935.0207215808905, 5949.286085669747, 5974.0, 5975.731092100953, 5976.223090998143, 5792.9710351447975, 5796.82609521715, 5797.826065218051, 5801.100829371454, 5802.361740208658], "value": 5554.709647515627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.2549144957649, 668.191488299158, 676.7191615479576, 696.742205384008, 789.3093543149744, 31978.0, 32211.0, 32303.676963230333, 32312.192195195134, 32324.353512929727, 40569.797151014274, 40786.796066019706, 41121.79439102808, 41203.381949270784, 41204.58795412045, 8629.09394513578, 8932.151445612657, 8932.910670893305, 8946.910530894706, 8955.910440895605, 8523.57382130894, 8570.571471426403, 8792.032876383593, 8794.912050879506, 8815.60329785158, 8795.516246606434, 8803.0, 8812.206901378875, 8822.470651760883, 8825.470471771681, 8729.60716767747, 8767.035626081126, 8779.253763430115, 8789.868151977693, 8807.119288071206, 8977.910220897838, 9110.681126160618, 9149.405288656217, 9177.541122943827, 9209.953950230207, 41155.38266925998, 41357.379639305436, 41856.79071604653, 41916.0, 44248.77875610634, 3469.0, 3638.399664055428, 3651.087228192952, 3762.360398732222, 4113.753174809521, 32192.839035804904, 34371.312573748386, 34642.65357346445, 34767.0, 34965.65034349649, 4692.36653051837, 4699.906001879944, 4717.174494463489, 4792.131523874052, 4814.638902082323, 323737.0, 324967.0, 327745.0, 328959.0, 329046.0, 39338.21323573512, 66331.00503492451, 66691.0, 66738.66630666815, 66759.33240667531, 37816.24367512689, 38057.0, 38126.23747525089, 38129.42805857914, 38270.234595308495, 16405.42581009659, 16837.2423240952, 16867.831321686626, 16877.818552701192, 16903.323867045427, 14297.428102875976, 14355.85644143566, 14358.497452589318, 14394.0, 14395.280235988159, 9274.118958698913, 9383.202427793578, 9407.153356197976, 9469.90530094704, 9473.526323683789, 3603.8017909015257, 3691.8523259069875, 3696.2053158571034, 3723.627637236309, 3748.9437658435145, 1084.2410312780928, 1138.3397629374942, 1154.5901205072078, 1206.1556910162922, 1246.9127161098818, 33325.833370833476, 33804.0, 33969.66030339665, 34399.0, 34731.55612510957, 1195.54569263681, 1222.1872454817624, 1292.1536393662166, 1308.9280089594972, 1346.9393877275545, 17486.29522575496, 17564.824351756575, 17627.118644067745, 17845.196966136555, 17939.0, 472810.0, 500196.0, 509101.0, 518339.0, 519059.0, 56872.0, 57483.42516574781, 57488.137677934865, 57622.7118864403, 57755.71122144363, 1550.6356006338501, 1551.441481066815, 1564.5071802382213, 1571.1672813408911, 1574.8582627563346, 30896.84551577228, 31567.052988410385, 31748.841255793574, 32208.35583288368, 32434.351312973136, 54118.458815411344, 59724.40275597188, 61515.38484615096, 61535.38464615297, 61753.0, 404736.0, 405731.0, 410847.0, 412086.0, 412280.0, 46233.537664624266, 46463.0, 46902.82742931454, 47220.7638961803, 47857.76071119622, 43187.0, 51648.741756290976, 51829.0, 52878.471215287354, 52959.470405297, 33441.331173376886, 34038.319233615686, 34194.31611367709, 34394.0, 34701.0, 41410.37884431676, 41669.16661666689, 41908.79045604752, 42174.0, 42666.5733342675, 41888.0, 42343.0, 42509.14981700287, 43260.35109473424, 43338.13323733571, 36204.0, 36768.63231367759, 37046.07384815401, 37157.81421092877, 37237.0, 26542.867285663448, 29326.560101598065, 30683.386332272785, 30865.537016944316, 31030.379392412477], "value": 19712.71040424993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.75116681158113, 427.7711424387953, 435.1775144975994, 436.9300911854104, 443.54315055492845, 17111.14444277786, 17748.112594370294, 17761.289548418063, 18109.909450452764, 19182.328618498355, 18337.54156146097, 18412.815871841278, 18458.446246612588, 18808.05959702016, 18823.90588047061, 5477.260569823073, 5733.254676891998, 5761.078227483604, 5761.654300741948, 7006.194287656934, 7104.183018952835, 7123.928760712379, 7181.85636287274, 7182.06633137694, 7185.281471852799, 6861.245263021064, 7106.147262328528, 7139.89290160648, 7159.105111861018, 7164.498485106019, 6461.289258181596, 7097.858042839166, 7354.154272258678, 7601.0, 7614.0, 7311.634418279064, 7371.520851144658, 7375.373093287077, 7382.52013619113, 7419.03552538172, 26065.0, 26274.6058809118, 26921.865390673116, 27350.863245683842, 27504.58743118855, 2753.490604238222, 2778.1665500349814, 2779.0829026421234, 2819.9436011279863, 2861.542153255469, 15142.394304227817, 15462.536123916301, 15855.682886342209, 15989.680206395924, 16128.112953787537, 2175.042981088316, 2204.0853045986055, 2232.6651002349777, 2312.456572705413, 2423.4426082001064, 63514.68242658757, 74921.0, 78273.60863195705, 80603.5969820153, 84800.99999999939, 16782.916085419496, 17263.65472690539, 18397.632047359246, 18745.156467958976, 19680.80319196818, 33480.83259583735, 33558.328833423686, 33866.661333386844, 33926.32147357039, 34121.65878341234, 8021.719239826695, 8339.45793523419, 8357.414980951275, 8817.338699597556, 10372.740681482872, 7943.721969731032, 7982.800429989181, 8448.11294814048, 8696.0, 8968.461892286483, 5010.0, 5023.1711767557945, 5035.219540971156, 5121.231815227671, 5214.556762675215, 2152.2036846366946, 2181.879996600202, 2194.967075493837, 2199.571083638675, 2204.9669254961186, 1046.9895301047045, 1077.6874706335232, 1089.6839916424308, 1093.0, 1166.2827361172988, 19521.0, 19570.412887613395, 19601.80398196028, 19672.409827705193, 20168.49578760543, 1061.1192710050639, 1074.5648012554927, 1108.2463924531235, 1113.8607674040745, 1182.1134149387958, 10585.629502967358, 11078.390688512209, 11125.944370278097, 11162.944185279022, 11208.15938804593, 448480.0, 452117.0, 475491.0, 488519.0, 489530.0, 86574.0, 92801.0, 93032.0, 93979.0, 95049.0, 1169.0472265104083, 1170.1165619957048, 1170.39724541861, 1174.6887074925153, 1185.5080141741253, 17435.215415306597, 17922.820771792114, 17955.551111222325, 18048.0, 18246.361377351728, 34544.82727586346, 39821.60178398295, 40168.0, 40187.0, 40326.39510407405, 56638.15042774444, 59495.40504594899, 59711.40288597059, 59737.40262597492, 59820.70089649698, 8994.235489983424, 9078.0, 9124.95437522808, 9243.121903419164, 9257.86113208289, 12717.745645087232, 13581.864181358455, 13615.57036511152, 13695.0, 13717.519886804314, 11121.83317250258, 11337.773244535229, 11412.828807567726, 11762.941185294361, 11972.880271197177, 11385.487653055467, 11663.76672466563, 11740.471678774646, 12101.75796484083, 12309.507619695112, 11933.701657458285, 11998.64004079879, 12019.63941081769, 12107.939460302641, 12123.939380303042, 8910.930688317185, 8944.776380590538, 9047.547622618975, 9048.230900373279, 9145.496997665192, 11273.661790146309, 12274.0, 12319.384030798603, 12392.442340094538, 12659.240445573296], "value": 10306.924925182775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.5648305508348, 1494.7757836324554, 1721.9311227550897, 1856.1090676475283, 1903.7144428335757, 7588.051493563305, 8139.145389734082, 8454.619542120605, 8712.869306960392, 8732.476051436919, 8207.507549547017, 8330.250277475026, 8505.106963768809, 8704.347173961962, 8725.38922275441, 2410.301012706313, 2460.3480077779404, 2476.554220240356, 2483.888225029878, 2483.987580062106, 2482.8013758899247, 2528.5954247320433, 2530.177692250017, 2531.0761572026263, 2531.746825317463, 2478.677771889652, 2488.315713178872, 2494.663220465241, 2495.438526331579, 2495.987520062397, 2442.7068751749816, 2470.950580988379, 2488.3032750829707, 2493.501299740059, 2513.3716570857287, 2511.987440062788, 2528.089887640448, 2530.316814460104, 2530.4180038591226, 2541.898324067035, 8722.389432739647, 8760.123987601253, 8774.912250877473, 8790.86813697795, 8793.912060879373, 5505.229267902497, 5624.128260119688, 5624.690642014688, 5626.690532020737, 5629.577781666391, 3636.8727094551564, 3688.428293614494, 3747.925041499182, 3763.5107436033413, 3787.431885217212, 1142.3659868772827, 1186.1341220908785, 1194.6834088966432, 1222.9388530573435, 1224.3388570172096, 12375.814362784566, 12430.067744919168, 12447.0, 12487.625371238877, 12502.124851260416, 4668.0, 4777.378940737682, 4813.711177329372, 4816.133096042746, 4840.249761287007, 9940.602375905028, 10015.39907605546, 10031.598736050477, 10059.497025148714, 10067.244956628283, 5428.0, 5467.043267428184, 5470.890582188334, 5503.091989821634, 5508.063629182969, 4925.876853078702, 4954.133026720309, 4997.400311962588, 5028.19548872186, 5036.219385995177, 4189.6438802701505, 4204.789760511962, 4242.300020496584, 4273.636740876998, 4301.612854843079, 1351.8377794664702, 1382.8617138286293, 1399.811025511543, 1402.0, 1402.9649258768409, 837.392890154633, 888.7244954064261, 949.6960972488737, 975.9021101261081, 1017.8320577104843, 5754.280714910637, 5875.3243377012195, 5958.165856780054, 6003.369646187175, 6185.752569897154, 463.1385622741698, 465.1441347919776, 485.55329097230634, 500.3420502039806, 500.60452242727837, 4107.199096176217, 4130.215259100762, 4147.688923330762, 4150.896227594274, 4177.4778152730905, 10574.101201397967, 10822.567097316176, 10980.615678451215, 11004.834927476095, 11027.17296202788, 10653.73365665849, 10742.624008159677, 10809.0, 10839.783204335869, 10893.346399216072, 7896.368290536858, 8137.145599712064, 8168.83662326762, 8171.591420429074, 8173.95913020443, 6021.518278537794, 6032.668203248863, 6087.969560152171, 6158.0, 6173.567850250619, 9557.713268601952, 9722.611095556098, 9817.607295708378, 9958.053984871425, 9966.103050725469, 9868.358556693793, 9968.152707019985, 9970.152537034433, 10086.949565252127, 10134.594616215563, 6844.5208835381045, 7325.6337183141695, 7503.737369192052, 7825.178356272737, 7936.325412340016, 8017.438779285394, 8042.195780422145, 8044.477108987897, 8047.034355877332, 8047.074586422402, 7101.715931362688, 7383.224761400191, 7387.298206670358, 7413.518121322097, 7417.0, 7435.996140521177, 7460.142083660448, 7474.39420434674, 7520.435967302584, 7530.623468826428, 7263.273672632695, 7268.854622907618, 7274.527155734861, 7275.490715649854, 7321.74373896911, 4764.642651801059, 5102.311187989574, 5152.381714194321, 5239.869003274948, 5286.074936885952, 5389.137737961907, 5393.43368946255, 5420.864478388072, 5429.402765695691, 5538.196961440649], "value": 4645.462073515257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.83998960452203, 368.9206820533586, 369.8132443116226, 374.7545357790648, 377.1194261399632, 6357.68211589421, 6434.581752186111, 6445.581037232582, 6447.7420903163875, 6469.902951455732, 6393.232812062547, 6409.423151916327, 6450.548461607689, 6455.870882582346, 6455.935440645592, 4905.509449055102, 4919.335889654904, 4933.33399991002, 4980.526849949267, 4996.825111121111, 4988.42633097193, 4988.65079444439, 4992.201247800353, 4998.800047998076, 5000.19996800512, 4942.5304596063315, 4950.158473059589, 4950.579200767939, 4953.306537084793, 4959.950400496003, 4707.058588282323, 4819.879503012417, 4935.0376676548085, 4944.283078953549, 4951.628627852925, 4220.493540775126, 4222.809973551198, 4233.301505251629, 4254.255505286594, 4272.0, 6248.468880145193, 6249.750009999594, 6262.405071518198, 6279.0, 6283.622982621057, 5581.0, 5641.746121424546, 5692.601517893749, 5722.570807189436, 5795.391483894173, 6874.2814296425895, 6877.931220687779, 6881.174259088892, 6882.655867206619, 6895.379415852547, 4790.377250957354, 4790.377250957388, 4791.520847915215, 4800.303955926371, 4810.374651295309, 7103.147622285359, 7175.461840361993, 7184.44952042028, 7186.317299856505, 7191.316824901678, 4921.532454416824, 4922.606191504671, 4926.852194434101, 4927.7536123193695, 4937.1606826839525, 4826.686265392738, 4953.0, 5000.62495312853, 5003.174476211384, 5013.523715247045, 5721.39925307845, 5744.224529688522, 5759.769609215668, 5766.308043034779, 5768.913466298009, 6961.686724097428, 6962.825929351807, 6964.303569642995, 6988.615626140611, 7034.40207582351, 1737.5569229846308, 1763.5414792154131, 1763.7883453985348, 1765.1703699261327, 1769.51338381946, 1129.7627498225465, 1139.9373034483183, 1160.802663547199, 1181.9468123934444, 1201.3212534917743, 6552.246491653425, 6562.278149403562, 6562.67186640666, 6568.047633093175, 6689.464842812563, 7067.823304417328, 7116.466265030143, 7123.0, 7123.43012558994, 7123.964380178169, 6632.0383544385795, 6645.136132302867, 6645.568038077509, 6649.202095748445, 6651.3681200286865, 3811.7712937223855, 3820.9235815284096, 3821.5796262411113, 3844.500214972036, 3848.422736589478, 7266.890996635055, 7525.134609519866, 7530.397568194531, 7538.208488108779, 7542.094948606093, 7245.094363204599, 7291.052163218747, 7337.88993165103, 7337.926620733831, 7338.853222935511, 7550.282723141293, 7556.735514256975, 7559.1684914659345, 7563.848723025509, 7572.280633339934, 6959.965200173967, 7205.315495027964, 7211.927880721336, 7216.0258365120035, 7218.458615603746, 7040.788776336718, 7077.6461176941975, 7116.822079448055, 7121.216666166614, 7132.928670713226, 7527.2096429876265, 7561.962190189014, 7564.659590318559, 7573.166951635426, 7575.886361704469, 4874.756262186947, 4915.877103072452, 4920.901581968412, 4921.557059864629, 4924.606031517542, 6973.686184121625, 7151.53515021522, 7199.02813120243, 7211.891821622785, 7213.20654727969, 6920.0, 6943.930560694328, 6958.512904096665, 6958.860822783415, 6973.721051157897, 6913.343232392915, 6929.896051559332, 6947.826304342432, 6953.582785032914, 6966.616836073862, 6809.740198063374, 6823.727050917908, 6830.146231721035, 6840.384365407137, 6844.247132815486, 6753.898691519533, 6991.44068474531, 7028.156621205488, 7033.859322813412, 7035.753748618774, 6671.833204169935, 6784.830379240559, 6866.759663411756, 6889.0, 6902.275261097713], "value": 5220.371742022786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.2236819101377, 810.3517186250998, 815.3762371785585, 830.6843399508186, 884.7478468636438, 14704.149398312273, 14748.262586870655, 14896.702065958674, 15011.774823377658, 15786.921065394657, 14683.706325873503, 14852.55442336729, 14876.181810000446, 14898.106113633163, 14917.701645967101, 881.1056777370974, 900.1403659505173, 917.0325306801356, 927.2906226736552, 928.9489078100702, 894.065701342099, 898.6630013744846, 900.063933509153, 900.693764120199, 906.0260220263243, 936.0125068053201, 938.3619138985487, 939.7274790310836, 944.2257348973844, 946.0, 931.4690626342987, 931.6646007437317, 934.3319526538558, 937.610891480035, 938.0853667674031, 688.0298778722027, 689.6551724137931, 693.462566510953, 693.5076095971866, 695.9338862808025, 15494.922525387414, 15509.767353489593, 15531.922340388339, 15539.378424862993, 15591.532254032398, 14092.859071409257, 14289.785653215211, 14291.356888940023, 14433.134011959211, 14705.55883323502, 11872.168948173632, 11994.16040877139, 12093.274403535728, 12098.0, 12271.877281227253, 3913.0, 3960.6237407446247, 4001.755943769901, 4022.7787471689044, 4106.466159399289, 56171.43828561703, 56508.0, 56634.716826416014, 56693.433065669225, 57362.42637573654, 10446.947765261126, 11200.887991120147, 11374.0, 11554.59558915434, 11604.593839215588, 16953.237104330336, 16969.490915272563, 17023.914880425767, 17063.658726825393, 17065.829341706423, 8773.912260877438, 8816.647334106563, 8878.73363799087, 8900.0, 9118.36171468004, 4902.068606964665, 4967.925481117786, 5042.369703787027, 5093.363329583802, 5214.687118772886, 3511.754177207571, 3536.45184996326, 3544.7873127612424, 3548.0420286522494, 3552.289542091592, 665.4776000839414, 681.2302098628518, 688.1913751342153, 693.7571849852612, 703.0508813102373, 654.8395643067479, 710.8151880511105, 710.9040279562296, 775.0970119810357, 777.7200207925142, 9678.27412944032, 9918.900810991798, 10201.438920859275, 10297.0, 10300.845487317696, 669.5012215899186, 801.6312496251672, 802.9638666260032, 804.1355542791523, 805.3597390074788, 4718.159917632126, 4763.095011947719, 4852.927206091911, 4890.168671325812, 4926.679765815211, 59177.70411148003, 59629.403705963254, 59787.0, 59838.10242846361, 67292.66353668299, 54400.45599544033, 55188.72405637946, 56090.43909560934, 56324.71837640786, 56480.717596411756, 49921.50078499169, 50850.237246441335, 50887.491125089015, 51263.231051534254, 52189.0, 10101.292909496558, 10162.18702503783, 10177.338472999232, 10348.793024139324, 10353.63762268317, 36665.26669466542, 37587.62412375841, 37732.811335943145, 38259.80870095632, 38494.230115398095, 45309.77345113253, 46956.295655565875, 48031.75984120057, 48588.27117593168, 49934.50065499298, 11870.52517899309, 12017.519299227934, 12043.277403355827, 12056.0, 12151.57469488599, 13746.93126534361, 13909.58271251864, 14013.472964648485, 14083.859161408254, 14662.120272783666, 12825.871741282468, 13830.515931942333, 14043.297835108408, 14432.927835361175, 14557.636059098608, 12220.266783992989, 12790.936045319713, 13622.250776207404, 13682.0, 13766.793498097737, 12533.310667912987, 12847.421866016239, 13272.13731107475, 13334.0, 13552.728945420838, 11085.722856928642, 11180.217384783313, 11251.043661288883, 11420.428978551205, 11459.885401145882, 11168.720781980515, 11204.66386008421, 11205.71985700364, 11211.383373914514, 11256.155788315746], "value": 7138.746049698068, "unit": "score"}], "name": "dromaeo_css", "value": 7617.652339573458, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 104.0, 111.0, 111.0, 111.0, 102.0, 113.0, 111.0, 113.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 161.0, 174.0, 136.0, 157.0, 164.0, 128.0, 185.0, 132.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0, 162.0, 167.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 72.0, 77.0, 76.0, 76.0, 177.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 146.0, 92.0, 92.0, 92.0, 150.0, 91.0, 93.0, 148.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 98.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 57.0, 56.0, 59.0, 57.0, 60.0, 73.0, 59.0, 54.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 88.0, 73.0, 82.0, 73.0, 73.0, 73.0, 81.0, 72.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 113.0, 116.0, 121.0, 113.0, 112.0, 113.0, 137.0, 133.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 159.0, 159.0, 161.0, 157.0, 160.0, 164.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 66.0, 67.0, 64.0, 67.0, 68.0, 67.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1527.1999999999998, "alertThreshold": 2.0}]} 06:58:38 INFO - Return code: 0 06:58:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:58:38 ERROR - # TBPL SUCCESS # 06:58:38 INFO - Running post-action listener: _resource_record_post_action 06:58:38 INFO - Running post-run listener: _resource_record_post_run 06:58:39 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 464080896; Read time: 0; Write time: 325028 06:58:39 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242348032; Read time: 0; Write time: 225168 06:58:39 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 221134848; Read time: 0; Write time: 99860 06:58:39 INFO - Running post-run listener: _upload_blobber_files 06:58:39 INFO - Blob upload gear active. 06:58:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:39 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:58:39 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:58:39 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:58:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:58:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:58:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:41 INFO - (blobuploader) - INFO - Done attempting. 06:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:58:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:41 INFO - (blobuploader) - INFO - Done attempting. 06:58:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:41 INFO - Return code: 0 06:58:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1084512af1eaf72a33fbb2c4f7f0490a984ac5e318c73c5037805521c30cd077bb04d614ad179248ec26c4311389d6e0fd4facad150a749ebda5d2359e9787c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c47abfa258f7aab078a9787cb249f2a372aa23c37add76906970f3503c8db2ee3fbd6528ed377ae38b3b64ea30e80af0a3fc3551158baa8a625959b1e0f484a4"} 06:58:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:41 INFO - Contents: 06:58:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1084512af1eaf72a33fbb2c4f7f0490a984ac5e318c73c5037805521c30cd077bb04d614ad179248ec26c4311389d6e0fd4facad150a749ebda5d2359e9787c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c47abfa258f7aab078a9787cb249f2a372aa23c37add76906970f3503c8db2ee3fbd6528ed377ae38b3b64ea30e80af0a3fc3551158baa8a625959b1e0f484a4"} 06:58:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:41 INFO - Copying logs to upload dir... 06:58:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.908535 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-08 06:58:41.564017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:58:41.567799) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941 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/1084512af1eaf72a33fbb2c4f7f0490a984ac5e318c73c5037805521c30cd077bb04d614ad179248ec26c4311389d6e0fd4facad150a749ebda5d2359e9787c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c47abfa258f7aab078a9787cb249f2a372aa23c37add76906970f3503c8db2ee3fbd6528ed377ae38b3b64ea30e80af0a3fc3551158baa8a625959b1e0f484a4"} build_url:https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/QInwY6wvR1SkDrpsMg4o9g/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/1084512af1eaf72a33fbb2c4f7f0490a984ac5e318c73c5037805521c30cd077bb04d614ad179248ec26c4311389d6e0fd4facad150a749ebda5d2359e9787c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c47abfa258f7aab078a9787cb249f2a372aa23c37add76906970f3503c8db2ee3fbd6528ed377ae38b3b64ea30e80af0a3fc3551158baa8a625959b1e0f484a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:58:41.593525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:58:41.593888) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467985097.66825-633050941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:58:41.679695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:58:41.680209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:58:41.680736) ========= ========= Total master_lag: 0.18 =========