builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1467687992.96 results: success (0) buildid: 20160704172224 builduid: 268ab60db08e424a962a62fdb5b0e1e5 revision: c2280cbee4ed9092158c59bd9ba224a3bf909afa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:32.958669) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:32.959144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:32.959413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:32.984947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:32.985209) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 20:06:33-- 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% 46.6M=0s 2016-07-04 20:06:33 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:33.115955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:33.116268) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:33.165401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 20:06:33.165728) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c2280cbee4ed9092158c59bd9ba224a3bf909afa --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 c2280cbee4ed9092158c59bd9ba224a3bf909afa --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=934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 20:06:33,699 truncating revision to first 12 chars 2016-07-04 20:06:33,699 Setting DEBUG logging. 2016-07-04 20:06:33,699 attempt 1/10 2016-07-04 20:06:33,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c2280cbee4ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 20:06:35,108 unpacking tar archive at: mozilla-beta-c2280cbee4ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.771032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 20:06:34.951328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:34.951658) ========= script_repo_revision: c2280cbee4ed9092158c59bd9ba224a3bf909afa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:34.952087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:34.952359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 20:06:34.963308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-04 20:06:34.963588) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:35 INFO - MultiFileLogger online at 20160704 20:06:35 in /builds/slave/test 20:06:35 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 20:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:35 INFO - {'append_to_log': False, 20:06:35 INFO - 'base_work_dir': '/builds/slave/test', 20:06:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:35 INFO - 'branch': 'Mozilla-Beta', 20:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:35 INFO - 'config_files': ('talos/linux_config.py',), 20:06:35 INFO - 'default_actions': ('clobber', 20:06:35 INFO - 'read-buildbot-config', 20:06:35 INFO - 'download-and-extract', 20:06:35 INFO - 'populate-webroot', 20:06:35 INFO - 'create-virtualenv', 20:06:35 INFO - 'install', 20:06:35 INFO - 'run-tests'), 20:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:35 INFO - 'download_minidump_stackwalk': True, 20:06:35 INFO - 'download_symbols': 'ondemand', 20:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:35 INFO - 'installer_path': 'installer.exe', 20:06:35 INFO - 'log_level': 'info', 20:06:35 INFO - 'log_name': 'talos', 20:06:35 INFO - 'log_to_console': True, 20:06:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:35 INFO - 'opt_config_files': (), 20:06:35 INFO - 'pip_index': False, 20:06:35 INFO - 'sps_profile': False, 20:06:35 INFO - 'sps_profile_interval': 0, 20:06:35 INFO - 'suite': 'dromaeojs-e10s', 20:06:35 INFO - 'system_bits': '32', 20:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:35 INFO - 'title': 'talos-linux64-ix-057', 20:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:35 INFO - 'use_talos_json': True, 20:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:35 INFO - 'work_dir': 'build'} 20:06:35 INFO - ##### 20:06:35 INFO - ##### Running clobber step. 20:06:35 INFO - ##### 20:06:35 INFO - Running pre-action listener: _resource_record_pre_action 20:06:35 INFO - Running main action method: clobber 20:06:35 INFO - rmtree: /builds/slave/test/build 20:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:36 INFO - Running post-action listener: _resource_record_post_action 20:06:36 INFO - ##### 20:06:36 INFO - ##### Running read-buildbot-config step. 20:06:36 INFO - ##### 20:06:36 INFO - Running pre-action listener: _resource_record_pre_action 20:06:36 INFO - Running main action method: read_buildbot_config 20:06:36 INFO - Using buildbot properties: 20:06:36 INFO - { 20:06:36 INFO - "project": "", 20:06:36 INFO - "product": "firefox", 20:06:36 INFO - "script_repo_revision": "production", 20:06:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 20:06:36 INFO - "repository": "", 20:06:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 20:06:36 INFO - "buildid": "20160704172224", 20:06:36 INFO - "pgo_build": "True", 20:06:36 INFO - "basedir": "/builds/slave/test", 20:06:36 INFO - "buildnumber": 164, 20:06:36 INFO - "slavename": "talos-linux64-ix-057", 20:06:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:06:36 INFO - "platform": "ubuntu64_hw", 20:06:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:06:36 INFO - "branch": "mozilla-beta", 20:06:36 INFO - "repo_path": "releases/mozilla-beta", 20:06:36 INFO - "revision": "c2280cbee4ed9092158c59bd9ba224a3bf909afa", 20:06:36 INFO - "stage_platform": "linux64-pgo", 20:06:36 INFO - "builduid": "268ab60db08e424a962a62fdb5b0e1e5", 20:06:36 INFO - "slavebuilddir": "test" 20:06:36 INFO - } 20:06:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 20:06:36 INFO - Running post-action listener: _resource_record_post_action 20:06:36 INFO - ##### 20:06:36 INFO - ##### Running download-and-extract step. 20:06:36 INFO - ##### 20:06:36 INFO - Running pre-action listener: _resource_record_pre_action 20:06:36 INFO - Running main action method: download_and_extract 20:06:36 INFO - mkdir: /builds/slave/test/build/tests 20:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:36 INFO - https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:41 INFO - Downloaded 1327 bytes. 20:06:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 20:06:41 INFO - Using the following test package requirements: 20:06:41 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 20:06:41 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:41 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 20:06:41 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'jsshell-linux-x86_64.zip'], 20:06:41 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:41 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 20:06:41 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 20:06:41 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 20:06:41 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:41 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 20:06:41 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:41 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06: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')]} 20:06:41 INFO - https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:42 INFO - Downloaded 24237016 bytes. 20:06:42 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'] 20:06:42 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 20:06:43 INFO - Return code: 0 20:06:43 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 20:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:43 INFO - https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 20:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:45 INFO - Downloaded 24237016 bytes. 20:06:45 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'] 20:06:45 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 20:06:46 INFO - Return code: 0 20:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:46 INFO - https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 20:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 20:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:49 INFO - Downloaded 10840145 bytes. 20:06:49 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'] 20:06:49 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 20:06:49 INFO - Return code: 0 20:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:49 INFO - https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fKXXGT0SQDqNk2NSznN49Q/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 20:06:52 INFO - Downloaded 56023419 bytes. 20:06:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:06:52 INFO - mkdir: /builds/slave/test/properties 20:06:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:52 INFO - Contents: 20:06:52 INFO - build_url:https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 20:06:53 INFO - Running post-action listener: _resource_record_post_action 20:06:53 INFO - Running post-action listener: set_extra_try_arguments 20:06:53 INFO - ##### 20:06:53 INFO - ##### Running populate-webroot step. 20:06:53 INFO - ##### 20:06:53 INFO - Running pre-action listener: _resource_record_pre_action 20:06:53 INFO - Running main action method: populate_webroot 20:06:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:53 INFO - '--tppagecycles', 20:06:53 INFO - '7'], 20:06:53 INFO - 'tests': ['tsvgm']}}, 20:06:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['damp', 'tps']}, 20:06:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'tests': ['damp', 'tps']}, 20:06:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['dromaeo_dom']}, 20:06:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['a11yr', 20:06:53 INFO - 'ts_paint', 20:06:53 INFO - 'tpaint', 20:06:53 INFO - 'sessionrestore', 20:06:53 INFO - 'sessionrestore_no_auto_restore', 20:06:53 INFO - 'tabpaint']}, 20:06:53 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:53 INFO - 'ts_paint', 20:06:53 INFO - 'tpaint', 20:06:53 INFO - 'sessionrestore', 20:06:53 INFO - 'sessionrestore_no_auto_restore', 20:06:53 INFO - 'tabpaint']}, 20:06:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:53 INFO - 'ts_paint', 20:06:53 INFO - 'tpaint', 20:06:53 INFO - 'sessionrestore', 20:06:53 INFO - 'sessionrestore_no_auto_restore', 20:06:53 INFO - 'tabpaint']}, 20:06:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:53 INFO - 'ts_paint', 20:06:53 INFO - 'tpaint', 20:06:53 INFO - 'sessionrestore', 20:06:53 INFO - 'sessionrestore_no_auto_restore', 20:06:53 INFO - 'tabpaint']}, 20:06:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['a11yr', 20:06:53 INFO - 'ts_paint', 20:06:53 INFO - 'tpaint', 20:06:53 INFO - 'sessionrestore', 20:06:53 INFO - 'sessionrestore_no_auto_restore', 20:06:53 INFO - 'tabpaint']}, 20:06:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['a11yr', 20:06:53 INFO - 'ts_paint', 20:06:53 INFO - 'tpaint', 20:06:53 INFO - 'sessionrestore', 20:06:53 INFO - 'sessionrestore_no_auto_restore', 20:06:53 INFO - 'tabpaint']}, 20:06:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['tsvgx', 20:06:53 INFO - 'tsvgr_opacity', 20:06:53 INFO - 'tart', 20:06:53 INFO - 'tscrollx', 20:06:53 INFO - 'cart']}, 20:06:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:53 INFO - 'tsvgr_opacity', 20:06:53 INFO - 'tart', 20:06:53 INFO - 'tscrollx', 20:06:53 INFO - 'cart']}, 20:06:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'talos_options': ['--disable-e10s'], 20:06:53 INFO - 'tests': ['tp5o']}, 20:06:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'tests': ['tp5o']}, 20:06:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'talos_options': ['--disable-e10s', 20:06:53 INFO - '--xperf_path', 20:06:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:53 INFO - 'tests': ['tp5n']}, 20:06:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:53 INFO - 'talos_options': ['--xperf_path', 20:06:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:53 INFO - 'tests': ['tp5n']}}, 20:06:53 INFO - 'talos.zip': {'path': '', 20:06:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:53 INFO - Running post-action listener: _resource_record_post_action 20:06:53 INFO - ##### 20:06:53 INFO - ##### Running create-virtualenv step. 20:06:53 INFO - ##### 20:06:53 INFO - Running pre-action listener: _resource_record_pre_action 20:06:53 INFO - Running main action method: create_virtualenv 20:06:53 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:53 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 20:06:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:53 INFO - Using real prefix '/usr' 20:06:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:54 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:56 INFO - Installing pip.................done. 20:06:56 INFO - Return code: 0 20:06:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:06:56 INFO - Using env: {'DISPLAY': ':0', 20:06:56 INFO - 'HOME': '/home/cltbld', 20:06:56 INFO - 'LANG': 'en_US.UTF-8', 20:06:56 INFO - 'LANGUAGE': 'en_US:en', 20:06:56 INFO - 'LOGNAME': 'cltbld', 20:06:56 INFO - 'MAIL': '/var/mail/cltbld', 20:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:56 INFO - 'MOZ_NO_REMOTE': '1', 20:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:56 INFO - 'NO_EM_RESTART': '1', 20:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:56 INFO - 'PWD': '/builds/slave/test', 20:06:56 INFO - 'SHELL': '/bin/bash', 20:06:56 INFO - 'SHLVL': '1', 20:06:56 INFO - 'TERM': 'linux', 20:06:56 INFO - 'TMOUT': '86400', 20:06:56 INFO - 'USER': 'cltbld', 20:06:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:56 INFO - '_': '/tools/buildbot/bin/python'} 20:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:56 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 20:06:56 INFO - Cleaning up... 20:06:56 INFO - Return code: 0 20:06:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:06:56 INFO - Using env: {'DISPLAY': ':0', 20:06:56 INFO - 'HOME': '/home/cltbld', 20:06:56 INFO - 'LANG': 'en_US.UTF-8', 20:06:56 INFO - 'LANGUAGE': 'en_US:en', 20:06:56 INFO - 'LOGNAME': 'cltbld', 20:06:56 INFO - 'MAIL': '/var/mail/cltbld', 20:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:56 INFO - 'MOZ_NO_REMOTE': '1', 20:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:56 INFO - 'NO_EM_RESTART': '1', 20:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:56 INFO - 'PWD': '/builds/slave/test', 20:06:56 INFO - 'SHELL': '/bin/bash', 20:06:56 INFO - 'SHLVL': '1', 20:06:56 INFO - 'TERM': 'linux', 20:06:56 INFO - 'TMOUT': '86400', 20:06:56 INFO - 'USER': 'cltbld', 20:06:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:56 INFO - '_': '/tools/buildbot/bin/python'} 20:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:56 INFO - Downloading/unpacking psutil>=0.7.1 20:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:58 INFO - Installing collected packages: psutil 20:06:58 INFO - Running setup.py install for psutil 20:06:58 INFO - building 'psutil._psutil_linux' extension 20:06:58 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 20:06:58 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 20:06:58 INFO - building 'psutil._psutil_posix' extension 20:06:58 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 20:06:58 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 20:06:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:59 INFO - Successfully installed psutil 20:06:59 INFO - Cleaning up... 20:06:59 INFO - Return code: 0 20:06:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:59 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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:06:59 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 20:06:59 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 20:06:59 INFO - Using env: {'DISPLAY': ':0', 20:06:59 INFO - 'HOME': '/home/cltbld', 20:06:59 INFO - 'LANG': 'en_US.UTF-8', 20:06:59 INFO - 'LANGUAGE': 'en_US:en', 20:06:59 INFO - 'LOGNAME': 'cltbld', 20:06:59 INFO - 'MAIL': '/var/mail/cltbld', 20:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:59 INFO - 'MOZ_NO_REMOTE': '1', 20:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:59 INFO - 'NO_EM_RESTART': '1', 20:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:59 INFO - 'PWD': '/builds/slave/test', 20:06:59 INFO - 'SHELL': '/bin/bash', 20:06:59 INFO - 'SHLVL': '1', 20:06:59 INFO - 'TERM': 'linux', 20:06:59 INFO - 'TMOUT': '86400', 20:06:59 INFO - 'USER': 'cltbld', 20:06:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:59 INFO - '_': '/tools/buildbot/bin/python'} 20:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:07:01 INFO - Installing collected packages: mozsystemmonitor 20:07:01 INFO - Running setup.py install for mozsystemmonitor 20:07:01 INFO - Successfully installed mozsystemmonitor 20:07:01 INFO - Cleaning up... 20:07:01 INFO - Return code: 0 20:07:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:01 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')]} 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:01 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')]} 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:01 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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:07:01 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 20:07:01 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 20:07:01 INFO - Using env: {'DISPLAY': ':0', 20:07:01 INFO - 'HOME': '/home/cltbld', 20:07:01 INFO - 'LANG': 'en_US.UTF-8', 20:07:01 INFO - 'LANGUAGE': 'en_US:en', 20:07:01 INFO - 'LOGNAME': 'cltbld', 20:07:01 INFO - 'MAIL': '/var/mail/cltbld', 20:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:01 INFO - 'MOZ_NO_REMOTE': '1', 20:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:01 INFO - 'NO_EM_RESTART': '1', 20:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:01 INFO - 'PWD': '/builds/slave/test', 20:07:01 INFO - 'SHELL': '/bin/bash', 20:07:01 INFO - 'SHLVL': '1', 20:07:01 INFO - 'TERM': 'linux', 20:07:01 INFO - 'TMOUT': '86400', 20:07:01 INFO - 'USER': 'cltbld', 20:07:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:01 INFO - '_': '/tools/buildbot/bin/python'} 20:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:03 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 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 20:07:03 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 20:07:04 INFO - Downloading docopt-0.6.1.tar.gz 20:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:04 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:04 INFO - Running setup.py install for blobuploader 20:07:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:04 INFO - Running setup.py install for requests 20:07:04 INFO - Running setup.py install for docopt 20:07:04 INFO - Successfully installed blobuploader requests docopt 20:07:04 INFO - Cleaning up... 20:07:04 INFO - Return code: 0 20:07:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:07:04 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 20:07:04 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 20:07:04 INFO - Using env: {'DISPLAY': ':0', 20:07:04 INFO - 'HOME': '/home/cltbld', 20:07:04 INFO - 'LANG': 'en_US.UTF-8', 20:07:04 INFO - 'LANGUAGE': 'en_US:en', 20:07:04 INFO - 'LOGNAME': 'cltbld', 20:07:04 INFO - 'MAIL': '/var/mail/cltbld', 20:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:04 INFO - 'MOZ_NO_REMOTE': '1', 20:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:04 INFO - 'NO_EM_RESTART': '1', 20:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:04 INFO - 'PWD': '/builds/slave/test', 20:07:04 INFO - 'SHELL': '/bin/bash', 20:07:04 INFO - 'SHLVL': '1', 20:07:04 INFO - 'TERM': 'linux', 20:07:04 INFO - 'TMOUT': '86400', 20:07:04 INFO - 'USER': 'cltbld', 20:07:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:04 INFO - '_': '/tools/buildbot/bin/python'} 20:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:05 INFO - Running setup.py (path:/tmp/pip-Q8CW3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:05 INFO - Running setup.py (path:/tmp/pip-txrabq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:05 INFO - Running setup.py (path:/tmp/pip-JGaEBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:05 INFO - Running setup.py (path:/tmp/pip-DSDzPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:05 INFO - Running setup.py (path:/tmp/pip-LZ9khs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:05 INFO - Running setup.py (path:/tmp/pip-b6MNeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:05 INFO - Running setup.py (path:/tmp/pip-p09vIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:05 INFO - Running setup.py (path:/tmp/pip-NPI2bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:05 INFO - Running setup.py (path:/tmp/pip-0XmYiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:05 INFO - Running setup.py (path:/tmp/pip-jkmh5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:05 INFO - Running setup.py (path:/tmp/pip-OQWOnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:05 INFO - Running setup.py (path:/tmp/pip-YrD_l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:05 INFO - Running setup.py (path:/tmp/pip-C1vYtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:05 INFO - Running setup.py (path:/tmp/pip-vtkIrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:06 INFO - Running setup.py (path:/tmp/pip-uBicg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:06 INFO - Running setup.py (path:/tmp/pip-mowGRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:06 INFO - Running setup.py (path:/tmp/pip-xT0eYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:07:06 INFO - Running setup.py install for manifestparser 20:07:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:07:06 INFO - Running setup.py install for mozcrash 20:07:06 INFO - Running setup.py install for mozdebug 20:07:06 INFO - Running setup.py install for mozdevice 20:07:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:07:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:07:06 INFO - Running setup.py install for mozfile 20:07:06 INFO - Running setup.py install for mozhttpd 20:07:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:07:06 INFO - Running setup.py install for mozinfo 20:07:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:07:06 INFO - Running setup.py install for mozInstall 20:07:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Running setup.py install for mozleak 20:07:07 INFO - Running setup.py install for mozlog 20:07:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Running setup.py install for moznetwork 20:07:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Running setup.py install for mozprocess 20:07:07 INFO - Running setup.py install for mozprofile 20:07:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Running setup.py install for mozrunner 20:07:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:07:07 INFO - Running setup.py install for mozscreenshot 20:07:07 INFO - Running setup.py install for moztest 20:07:07 INFO - Running setup.py install for mozversion 20:07:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:07:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:07:08 INFO - Cleaning up... 20:07:08 INFO - Return code: 0 20:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:08 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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:07:08 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 20:07:08 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 20:07:08 INFO - Using env: {'DISPLAY': ':0', 20:07:08 INFO - 'HOME': '/home/cltbld', 20:07:08 INFO - 'LANG': 'en_US.UTF-8', 20:07:08 INFO - 'LANGUAGE': 'en_US:en', 20:07:08 INFO - 'LOGNAME': 'cltbld', 20:07:08 INFO - 'MAIL': '/var/mail/cltbld', 20:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:08 INFO - 'MOZ_NO_REMOTE': '1', 20:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:08 INFO - 'NO_EM_RESTART': '1', 20:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:08 INFO - 'PWD': '/builds/slave/test', 20:07:08 INFO - 'SHELL': '/bin/bash', 20:07:08 INFO - 'SHLVL': '1', 20:07:08 INFO - 'TERM': 'linux', 20:07:08 INFO - 'TMOUT': '86400', 20:07:08 INFO - 'USER': 'cltbld', 20:07:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:08 INFO - '_': '/tools/buildbot/bin/python'} 20:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:08 INFO - Running setup.py (path:/tmp/pip-ieKzEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:08 INFO - Running setup.py (path:/tmp/pip-qMvYUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:08 INFO - Running setup.py (path:/tmp/pip-RjJdGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:08 INFO - Running setup.py (path:/tmp/pip-wOnLX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:08 INFO - Running setup.py (path:/tmp/pip-VwJvPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:08 INFO - Running setup.py (path:/tmp/pip-7e34vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:08 INFO - Running setup.py (path:/tmp/pip-krx1aB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:08 INFO - Running setup.py (path:/tmp/pip-jdWE4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:08 INFO - Running setup.py (path:/tmp/pip-5z2EBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:08 INFO - Running setup.py (path:/tmp/pip-L8bNuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:08 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)) 20:07:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:08 INFO - Running setup.py (path:/tmp/pip-0jMwGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:09 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)) 20:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:09 INFO - Running setup.py (path:/tmp/pip-PNfDS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:09 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)) 20:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:09 INFO - Running setup.py (path:/tmp/pip-M2EFWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:09 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)) 20:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:09 INFO - Running setup.py (path:/tmp/pip-oXn5pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:09 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)) 20:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:09 INFO - Running setup.py (path:/tmp/pip-nJRhmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:09 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)) 20:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:09 INFO - Running setup.py (path:/tmp/pip-zYNrxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:09 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)) 20:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:09 INFO - Running setup.py (path:/tmp/pip-KdaYwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:09 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)) 20:07:09 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)) 20:07:09 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)) 20:07:09 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)) 20:07:09 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)) 20:07:09 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)) 20:07:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:11 INFO - Downloading blessings-1.6.tar.gz 20:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:11 INFO - Installing collected packages: blessings 20:07:11 INFO - Running setup.py install for blessings 20:07:11 INFO - Successfully installed blessings 20:07:11 INFO - Cleaning up... 20:07:11 INFO - Return code: 0 20:07:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:11 INFO - Reading from file tmpfile_stdout 20:07:11 INFO - Current package versions: 20:07:11 INFO - argparse == 1.2.1 20:07:11 INFO - blessings == 1.6 20:07:11 INFO - blobuploader == 1.2.4 20:07:11 INFO - docopt == 0.6.1 20:07:11 INFO - manifestparser == 1.1 20:07:11 INFO - mozInstall == 1.12 20:07:11 INFO - mozcrash == 0.17 20:07:11 INFO - mozdebug == 0.1 20:07:11 INFO - mozdevice == 0.48 20:07:11 INFO - mozfile == 1.2 20:07:11 INFO - mozhttpd == 0.7 20:07:11 INFO - mozinfo == 0.9 20:07:11 INFO - mozleak == 0.1 20:07:11 INFO - mozlog == 3.1 20:07:11 INFO - moznetwork == 0.27 20:07:11 INFO - mozprocess == 0.22 20:07:11 INFO - mozprofile == 0.28 20:07:11 INFO - mozrunner == 6.11 20:07:11 INFO - mozscreenshot == 0.1 20:07:11 INFO - mozsystemmonitor == 0.0 20:07:11 INFO - moztest == 0.7 20:07:11 INFO - mozversion == 1.4 20:07:11 INFO - psutil == 3.1.1 20:07:11 INFO - requests == 1.2.3 20:07:11 INFO - wsgiref == 0.1.2 20:07:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:11 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')]} 20:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:11 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')]} 20:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:11 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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:07:11 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 20:07:11 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 20:07:11 INFO - Using env: {'DISPLAY': ':0', 20:07:11 INFO - 'HOME': '/home/cltbld', 20:07:11 INFO - 'LANG': 'en_US.UTF-8', 20:07:11 INFO - 'LANGUAGE': 'en_US:en', 20:07:11 INFO - 'LOGNAME': 'cltbld', 20:07:11 INFO - 'MAIL': '/var/mail/cltbld', 20:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:11 INFO - 'MOZ_NO_REMOTE': '1', 20:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:11 INFO - 'NO_EM_RESTART': '1', 20:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:11 INFO - 'PWD': '/builds/slave/test', 20:07:11 INFO - 'SHELL': '/bin/bash', 20:07:11 INFO - 'SHLVL': '1', 20:07:11 INFO - 'TERM': 'linux', 20:07:11 INFO - 'TMOUT': '86400', 20:07:11 INFO - 'USER': 'cltbld', 20:07:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:11 INFO - '_': '/tools/buildbot/bin/python'} 20:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 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)) 20:07:12 INFO - Cleaning up... 20:07:12 INFO - Return code: 0 20:07:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:07:12 INFO - Using env: {'DISPLAY': ':0', 20:07:12 INFO - 'HOME': '/home/cltbld', 20:07:12 INFO - 'LANG': 'en_US.UTF-8', 20:07:12 INFO - 'LANGUAGE': 'en_US:en', 20:07:12 INFO - 'LOGNAME': 'cltbld', 20:07:12 INFO - 'MAIL': '/var/mail/cltbld', 20:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:12 INFO - 'MOZ_NO_REMOTE': '1', 20:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:12 INFO - 'NO_EM_RESTART': '1', 20:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:12 INFO - 'PWD': '/builds/slave/test', 20:07:12 INFO - 'SHELL': '/bin/bash', 20:07:12 INFO - 'SHLVL': '1', 20:07:12 INFO - 'TERM': 'linux', 20:07:12 INFO - 'TMOUT': '86400', 20:07:12 INFO - 'USER': 'cltbld', 20:07:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:12 INFO - '_': '/tools/buildbot/bin/python'} 20:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:12 INFO - Downloading/unpacking jsonschema 20:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:14 INFO - Downloading/unpacking functools32 (from jsonschema) 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:14 INFO - warning: no files found matching '*.txt' 20:07:14 INFO - no previously-included directories found matching 'build' 20:07:14 INFO - no previously-included directories found matching 'dist' 20:07:14 INFO - no previously-included directories found matching '.git*' 20:07:14 INFO - Installing collected packages: jsonschema, functools32 20:07:14 INFO - Running setup.py install for functools32 20:07:14 INFO - warning: no files found matching '*.txt' 20:07:14 INFO - no previously-included directories found matching 'build' 20:07:14 INFO - no previously-included directories found matching 'dist' 20:07:14 INFO - no previously-included directories found matching '.git*' 20:07:14 INFO - Successfully installed jsonschema functools32 20:07:14 INFO - Cleaning up... 20:07:14 INFO - Return code: 0 20:07:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:07:14 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')]} 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 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')]} 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 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 0x7fbdcec8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', '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 20:07:14 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 20:07:14 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 20:07:14 INFO - Using env: {'DISPLAY': ':0', 20:07:14 INFO - 'HOME': '/home/cltbld', 20:07:14 INFO - 'LANG': 'en_US.UTF-8', 20:07:14 INFO - 'LANGUAGE': 'en_US:en', 20:07:14 INFO - 'LOGNAME': 'cltbld', 20:07:14 INFO - 'MAIL': '/var/mail/cltbld', 20:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:14 INFO - 'MOZ_NO_REMOTE': '1', 20:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:14 INFO - 'NO_EM_RESTART': '1', 20:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:14 INFO - 'PWD': '/builds/slave/test', 20:07:14 INFO - 'SHELL': '/bin/bash', 20:07:14 INFO - 'SHLVL': '1', 20:07:14 INFO - 'TERM': 'linux', 20:07:14 INFO - 'TMOUT': '86400', 20:07:14 INFO - 'USER': 'cltbld', 20:07:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:14 INFO - '_': '/tools/buildbot/bin/python'} 20:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:14 INFO - Downloading/unpacking flake8 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:07:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:07:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 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 20:07:16 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 20:07:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:07:17 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 20:07:17 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 20:07:17 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 20:07:17 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 20:07:17 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 20:07:17 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 20:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:07:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:07:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:07:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:07:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:07:17 INFO - no previously-included directories found matching 'docs/_build' 20:07:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:07:17 INFO - Running setup.py install for pep8 20:07:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:07:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:07:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:07:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:07:17 INFO - no previously-included directories found matching 'docs/_build' 20:07:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:07:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:07:17 INFO - Cleaning up... 20:07:17 INFO - Return code: 0 20:07:17 INFO - Running post-action listener: _resource_record_post_action 20:07:17 INFO - Running post-action listener: _start_resource_monitoring 20:07:17 INFO - Starting resource monitoring. 20:07:17 INFO - ##### 20:07:17 INFO - ##### Running install step. 20:07:17 INFO - ##### 20:07:17 INFO - Running pre-action listener: _resource_record_pre_action 20:07:17 INFO - Running main action method: install 20:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:17 INFO - Reading from file tmpfile_stdout 20:07:17 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:18 INFO - Reading from file tmpfile_stdout 20:07:18 INFO - Output received: 20:07:18 INFO - Usage: mozinstall [options] installer 20:07:18 INFO - Options: 20:07:18 INFO - -h, --help show this help message and exit 20:07:18 INFO - -d DEST, --destination=DEST 20:07:18 INFO - Directory to install application into. [default: 20:07:18 INFO - "/builds/slave/test"] 20:07:18 INFO - --app=APP Application being installed. [default: firefox] 20:07:18 INFO - mkdir: /builds/slave/test/build/application 20:07:18 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'] 20:07:18 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 20:07:31 INFO - Reading from file tmpfile_stdout 20:07:31 INFO - Output received: 20:07:31 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:31 INFO - Running post-action listener: _resource_record_post_action 20:07:31 INFO - ##### 20:07:31 INFO - ##### Running run-tests step. 20:07:31 INFO - ##### 20:07:31 INFO - Running pre-action listener: _resource_record_pre_action 20:07:31 INFO - Running main action method: run_tests 20:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:31 INFO - Python 2.7.3 20:07:31 INFO - Return code: 0 20:07:31 INFO - grabbing minidump binary from tooltool 20:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, '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 0x2816310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28167a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:07:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:07:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:31 INFO - Return code: 0 20:07:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:07:32 INFO - Return code: 0 20:07:32 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/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:07:32 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/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 20:07:32 INFO - Using env: {'DISPLAY': ':0', 20:07:32 INFO - 'HOME': '/home/cltbld', 20:07:32 INFO - 'LANG': 'en_US.UTF-8', 20:07:32 INFO - 'LANGUAGE': 'en_US:en', 20:07:32 INFO - 'LOGNAME': 'cltbld', 20:07:32 INFO - 'MAIL': '/var/mail/cltbld', 20:07:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:32 INFO - 'MOZ_NO_REMOTE': '1', 20:07:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:32 INFO - 'NO_EM_RESTART': '1', 20:07:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:32 INFO - 'PWD': '/builds/slave/test', 20:07:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:32 INFO - 'SHELL': '/bin/bash', 20:07:32 INFO - 'SHLVL': '1', 20:07:32 INFO - 'TERM': 'linux', 20:07:32 INFO - 'TMOUT': '86400', 20:07:32 INFO - 'USER': 'cltbld', 20:07:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193', 20:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:32 INFO - '_': '/tools/buildbot/bin/python'} 20:07:32 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/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:07:32 INFO - mozversion application_buildid: 20160704172224 20:07:32 INFO - mozversion application_changeset: c2280cbee4ed9092158c59bd9ba224a3bf909afa 20:07:32 INFO - mozversion application_display_name: Firefox 20:07:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:32 INFO - mozversion application_name: Firefox 20:07:32 INFO - mozversion application_remotingname: firefox 20:07:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:07:32 INFO - mozversion application_vendor: Mozilla 20:07:32 INFO - mozversion application_version: 48.0 20:07:32 INFO - mozversion platform_buildid: 20160704172224 20:07:32 INFO - mozversion platform_changeset: c2280cbee4ed9092158c59bd9ba224a3bf909afa 20:07:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:07:32 INFO - mozversion platform_version: 48.0 20:07:32 INFO - using testdate: 1467688052 20:07:32 INFO - actual date: 1467688052 20:07:32 INFO - starting webserver on 'localhost:38725' 20:07:32 INFO - SUITE-START | Running 2 tests 20:07:32 INFO - TEST-START | dromaeo_css 20:07:32 INFO - operating with platform_type : linux_ 20:07:32 INFO - Initialising browser for dromaeo_css test... 20:07:32 INFO - TEST-INFO | started process 26295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3R80kn/profile http://localhost:38725/getInfo.html) 20:07:36 INFO - PROCESS | 26295 | 20:07:36 INFO - PROCESS | 26295 | (process:26371): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:36 INFO - PROCESS | 26295 | __metrics Screen width/height:1600/1200 20:07:36 INFO - PROCESS | 26295 | colorDepth:24 20:07:36 INFO - PROCESS | 26295 | Browser inner width/height: 1024/697 20:07:36 INFO - PROCESS | 26295 | __metrics 20:07:37 ERROR - PROCESS | 26295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:07:38 INFO - TEST-INFO | 26295: exit 0 20:07:38 INFO - Browser initialized. 20:07:38 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:38 INFO - TEST-INFO | started process 26421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3R80kn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:40 INFO - PROCESS | 26421 | 20:07:40 INFO - PROCESS | 26421 | (process:26487): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:50 INFO - PROCESS | 26421 | RSS: Main: 150781952 20:07:50 INFO - PROCESS | 26421 | 20:08:39 INFO - PROCESS | 26421 | 1467688119805 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] 20:10:47 INFO - PROCESS | 26421 | Cycle 1(1): loaded http://localhost:38725/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38725/tests/dromaeo/cssquery-ext.html) 20:10:48 INFO - PROCESS | 26421 | RSS: Main: 154800128 20:10:48 INFO - PROCESS | 26421 | 20:13:49 INFO - PROCESS | 26421 | Cycle 1(1): loaded http://localhost:38725/tests/dromaeo/cssquery-ext.html (next: http://localhost:38725/tests/dromaeo/cssquery-jquery.html) 20:13:50 INFO - PROCESS | 26421 | RSS: Main: 152776704 20:13:50 INFO - PROCESS | 26421 | 20:16:52 INFO - PROCESS | 26421 | Cycle 1(1): loaded http://localhost:38725/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38725/tests/dromaeo/cssquery-mootools.html) 20:16:52 INFO - PROCESS | 26421 | RSS: Main: 152383488 20:16:52 INFO - PROCESS | 26421 | 20:19:54 INFO - PROCESS | 26421 | Cycle 1(1): loaded http://localhost:38725/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38725/tests/dromaeo/cssquery-prototype.html) 20:19:54 INFO - PROCESS | 26421 | RSS: Main: 153923584 20:19:54 INFO - PROCESS | 26421 | 20:22:57 INFO - PROCESS | 26421 | Cycle 1(1): loaded http://localhost:38725/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38725/tests/dromaeo/cssquery-yui.html) 20:22:57 INFO - PROCESS | 26421 | RSS: Main: 152256512 20:22:57 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | Cycle 1(1): loaded http://localhost:38725/tests/dromaeo/cssquery-yui.html (next: http://localhost:38725/tests/dromaeo/cssquery-dojo.html) 20:26:00 INFO - PROCESS | 26421 | RSS: Main: 155865088 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | __start_tp_report 20:26:00 INFO - PROCESS | 26421 | _x_x_mozilla_page_load 20:26:00 INFO - PROCESS | 26421 | _x_x_mozilla_page_load_details 20:26:00 INFO - PROCESS | 26421 | |i|pagename|runs| 20:26:00 INFO - PROCESS | 26421 | |0;dojo.html;3291.111399922021;3330.55037569928;3382.6448222936597;3417.5386322846407;3427.314537092582;5576.163575463677;5585.413531579186;5588.832335029955;5596.860078498034;5636.971815140923;5564.081926482136;5571.052921003429;5577.69322687252;5590.832275031746;5621.550275977922;5042.117629414865;5083.822066227683;5097.847064588068;5104.259882317062;5125.846224613268;5032.11937910866;5162.251473536335;5218.452062533436;5239;5253.579713622901;5194.948050519503;5205.843824685266;5238.947610523884;5239.711815850127;5256.448072952323;5184.844454666366;5198.168293073109;5209.843704688866;5217.530422262014;5234.581233501311;4911.214205727067;4977.377827771528;5084.262781896604;5104.081265372231;5164.870878228036;5486.259354987105;5491.725413729338;5528.198411230389;5529.889402211933;5559.082751346023;5967.701614919237;6007.068904319837;6010.158577799111;6010.338862725097;6015.007523758574;5949.25634295713;6066.363031881633;6075.635461872302;6079.483243924272;6106.328303886569;5630.831075067755;5680.46035626619;5681.034224181899;5682.119271512922;5694.2312787773535;6170;6191.040388739752;6194.907076393858;6197;6204.689765511706;5892.734826932799;5939.732712027882;5981.162637230791;6029.849253768691;6076.301225359052;5968.970155149196;5991.7902873399225;6094.481969032682;6099.390060993954;6101.054336577838;5783.768649254067;6063.151158837766;6070.939290607037;6081.483073938676;6091.695415229221;5978.252718410199;5993.3706960768495;5995.04079347311;5999.130126131687;6023.849403764853;4612.930806037912;4617.607503362252;4624.445066591963;4624.815007399667;4651.09303685778;4014.116894283253;4033.153037862082;4116.361963895601;4128.4632997710105;4159.584041595816;5567.916481252784;5780.219670344533;5781.566382521243;5790.913136302959;5801.448862358069;6094.451499365078;6103.23709536308;6104.877902441926;6107.725152368154;6109.755609775648;5619.409961953936;5766.88466230673;5798.623089499253;5814.79648212319;5823.359430462646;5021.271915572222;5027.547520723152;5043.5460808527405;5051.62112841531;5073.086844368049;6234.1583886175695;6276.466500347522;6287.182666253358;6292.244930608264;6314.494840412756;5960.850978725393;6006.729697163725;6072.817815465455;6085.786997455068;6090.177825993612;6206.913790086626;6222.81331560054;6224.9377506224355;6260.154879091265;6265.592736472115;5835.883282334415;5857.502112320501;5866.061430171152;5870.972579798433;5894.469497745224;5888.882222355614;6017.247844019497;6037.728302226323;6108.847278818065;6121.571489995657;5850.444207800252;5872.911906321323;5881.264841894763;5892.057270836645;5910.881782364415;5823.039198532195;5828.358880523054;5866.208061911588;5889.764409423747;5893.557983151367;5652.293463317085;5734.827955161185;5767.163761254511;5795.8551036224435;5805.129230615442;5928.851778705567;5949.0481522956115;5949.434803693643;5950.077737950624;5964;5698.886022279448;5807.709614519173;5823.4467725566;5831.562632802472;5833.708314584339 20:26:00 INFO - PROCESS | 26421 | |1;ext.html;662.1855118204609;671.8924972004479;678.8574399376131;734.6179986407069;742.8551432470667;33285.33429331412;34033.14917127073;39804.60195398049;40246;40442;43765;43814.34278485825;44203.557964420346;44303;44306.77846610762;8880.777980550489;9075.27397808177;9076.455412675228;9091.363604547685;9097.727068187933;9078.727638170865;9196.494192819393;9205.86191207129;9247.39891907024;9253.537323133816;9234.907650923506;9239.58421871014;9285.117913798178;9292.442453452815;9299.16307532322;9198;9234.67678631248;9250.213731832802;9253.676121335755;9259.398139120936;9037.909620903773;9178.265738740885;9180.632774689004;9202.953985230099;9204.953975230148;44571;45121.32318015232;45301.32048019282;45304.093918121784;45442.09115817665;3842.500474938268;3901.0637447012514;4191.685623578243;4510.143072816154;4556.111558246143;33670;33921.15197120092;33980.83009584961;34000.149996250046;35379.29241415183;4421.172792019244;4452.364195404896;4494.52807455219;4526.705764125354;4608.815647374101;227430;227475.8626206875;228310;228977;229167;62920.370796292365;63004;63437.04844427337;63490.0476492853;63616.363836361044;72417.6379118101;72582;72733;72965.27034729692;73371;19243.51891202731;19391.612167756564;19398.224071037;19410.611787764446;19535.804641953684;15168.544943651708;15256.771148432783;15343.539693809204;15344.309506072253;15378.154201519024;20447.795522044587;20777.376678699664;20832.47918802042;20873.79126208749;21883.67174492384;7865.921340786634;7953.548644338026;8137.104918458965;8244.216799404046;8263.628136733862;1083.3175099687146;1102.8345748137845;1181.4624345922584;1205.8311836342918;1267.2269915351628;33160.834195828866;33377.332453351286;33679.663203368145;34145.82927085349;34240;1172.6306213542707;1228.8033914573625;1254.0281282006517;1270.618814355708;1350.8041334006514;17452.47642570725;17506;17571.824281757275;17720.645587088187;17735.556611084827;468806;474614;617122;621518;895332;62404.375956240765;63608;63937.360626394075;64188.35811641917;64381.67809160924;1529.1742459071977;1544.6678964022565;1551.6276093737647;1556.144120733592;1648.4560095168806;33164.50253246252;33798.66201337955;34089.318213636085;34129.97610071702;34673.30653386968;54375;55050;55133.72433137969;55136;55247.72376138254;423371;424278;426121;426590;426727;30824.383512330078;31316.686833131378;31666;31739.68260317367;31798;49177.26234106563;50270;50331.49668503268;51148.74425627997;51913.7404312976;42315.788421057696;42991.355129672454;43400.131997360506;44348;44637.776811115735;41695.37456938209;42369.15261694811;42505;43407.56592434035;43830.123397531235;39506.209875801746;39848.203035939696;39895.60104398919;40493.797531012155;43780.56219437892;36528.26943461063;37223.441648374755;37843.81078094592;38050;38155.42766858555;28711.856440717664;29025.7097429023;29179.85410072936;29590;29807.850960745058 20:26:00 INFO - PROCESS | 26421 | |2;jquery.html;421.2207416279883;424.93201087825935;431.91361727654436;436.11903954012894;444.2514363297843;18687.252509899605;19271.614567708653;19393.321233756822;20054.59890802183;20954.685679714818;19785.901070494627;20338.288159914406;20546.794532054675;20597.897010514927;20704.37886863393;5236.607254455912;5434.347878254615;5438.619296649236;5483.862903427426;5494.752736126864;5247.816326428576;5387.865303367408;5477.1510415885405;5483.7806487740445;5494.752736126864;5460.808871689492;5478.04134276502;5492.313460817398;5498.5876059295515;5517.944820551803;5382.977234325485;5467.644603100805;5471.616986810925;5847.941520584783;5915.3788852170765;5377.51602355786;5400.243965844785;5408.107662235727;5421.810236641738;5429.484199001088;15074;15211.467598633995;15476.303566339542;15513;24114.36907945996;2442.6336049592524;2479.789217916479;2489.2781093482868;2534.873256337176;2583.483303339321;10813.08088812452;11176.944115279453;11194.496247668792;11332.150088743378;11555.422228888607;2033.4814622271374;2095.6542170541843;2119.3218170185546;2161.7189765330563;2191.7589065202815;79115.20884791136;79871;81384;82170;82949.58525207336;11630.244034137753;11896.22674526153;12161.270323780602;12173.634790956285;12707.87292127067;15160.772588411182;17295.65408691819;17296.740548891776;17313.65372692539;17333.959962402296;8804.811350467733;9147.81704365909;9185.77035574116;9428.15146636806;9564.4739539326;9106.635734570675;9210.769730756785;9211.40125891815;9264.67573634933;9272.119148680864;5149.716765577929;5217.139172036647;5244.580433565306;5252.9737351313;5319.148936170194;2151.4621344663833;2151.817095546865;2160.5354848707602;2163.3618082665653;2218.4675677837527;1009.4952523738131;1057.0697785948316;1057.8043062033394;1103.1119948441421;1152.8386025956372;18978.905105474383;19228.327008554632;19599.706004409945;19636;19834.00829958525;1065.3980501017056;1073.0878753059992;1105.5517272373218;1118.8545489086366;1127.2672762704144;11025.503852326665;11681.299122052704;11681.357525336018;11981.700457488632;12034.157608967464;469718;472845;473901;475028;493203;58076.12885806716;72453;84873.57563212268;95245.52377238208;96487;1166.9299842009507;1177.5633726853225;1187.2638963842473;1194.3311745422418;1217.1601594899491;17348.306067757654;17782.288708451517;18110;18132.72800908014;18331.266749329876;36385.818070909474;37065;37964.2407151861;38945.610543894196;39911.40132897951;51274;52217;52291;52366.47633523616;52935.470645293055;8860.113988601088;8921.866172007554;8977.922649282127;9186.081391861027;9207.539623018689;9913.950430247802;13492.392842322315;13573.11774734639;13575.32123393846;13643.317834108057;11480.827787583026;11806.822897656713;11891.28652280866;11988.400579971141;12309.56916507918;11626.360550169822;11729.061675065803;11742.00192983606;11900.523979040741;12175.878241217475;6852;11847.940760296144;11993;12201.267923924594;12499.687507812378;8110.188981101843;8426.747197584082;8864.290856731575;9257.907420925705;9426.717198484057;10906.727331816768;11037.558497660004;11644.068474521848;12276.570320038756;12291.877081229073 20:26:00 INFO - PROCESS | 26421 | |3;mootools.html;1574.5984773882662;1587.206396801599;1794.9730754038692;1914.1482040491978;1925.7977912319216;7423.665935032923;8188.877166842502;8281.958590207056;8453.957730211348;8489.405741598091;8519.446235994656;8537.060923298432;8586.48481091135;8638.870416943751;8639.136086391358;2389.6893403857516;2401.7598240176017;2405.675233843435;2408.771166739157;2411.2766170148884;2369.656399822025;2392.95214095718;2399.1243196233336;2399.8200134989856;2400.7959323457526;2350.9529809403803;2351.3063646224405;2354.5290941811622;2361.315218586608;2377.2274010946426;2332.288651961151;2345.0385342009863;2348.3542025942916;2349.7297810751725;2350.6003979323473;2328.196772113618;2336.7429582745885;2340.2745149003863;2341.332720174759;2350.3888988862846;8573.52845593492;8685.348598855047;8700.129987001312;8704.390692651517;8710.259627931633;5290.603204759658;5352.277442545284;5387.299651045379;5398.595105367113;5402.6758394496455;3289.62169350523;3298.0765385692043;3342.9803909807497;3375.2574433624563;3394.541736865516;1065.5737704918017;1087.8313861351423;1095.6439157273917;1098.214776434845;1099.1646348774989;11548.711282217928;11552.249103808226;11573.537058517564;11596.768064638743;11633.592824251195;4693.859184224479;4716.151092803259;4724.88187795301;4752.358431611758;4802.519748025239;9880.258980576486;9883.258755593359;9910.950445247727;9924.1068303853;9984.35101718386;5399.325084364455;5413.83758487246;5436.293281873332;5450.91823622646;5467.808626698126;4375.4968178659865;4932.21084626458;4954.925676114861;5031.647784655039;5031.899362012739;4137.882771651697;4154.875353739392;4170.895727606834;4185.539590645027;4209.284421648327;1287.8583355830851;1362.2167253829089;1366.1666383506054;1367.131871261756;1373.2378529915793;921.9262459003263;1070.6466865934224;1083.101026148295;1085.066842515436;1096.4736926275273;6084.756609735561;6161.84595385119;6236.03341482071;6246.664438802728;6274.372562743689;507.35819188726293;508.7074931914164;510.01566975736444;1134.3987686526154;1155.0932517973351;4045.959540404617;4162.41726158338;4200;4241;4282.743035417885;10225.437600931871;10616.363018218932;10654.680359589225;10708.30396024256;10716.142708583295;10426.635067772591;10456.058954694114;10464.424456654804;10514.474276286155;10556.841647375295;7678.424118191158;8243.25810677042;8268.710595129141;8288.668453261922;8332.000159980842;5822.214001109796;5854.326752423355;5854.824355269348;5948.762049517971;5975.492083172805;8946.150115738994;9052.049534799015;9104.408213466104;9149.679761208326;9211.493367864832;8791;9134.771630709285;9141.77145571366;9190.58642361082;9252.629894804402;7465.850682986418;7656.693732250647;7781.182975787461;8046.316063134699;8086.5148091114725;8124.390670699603;8141.348692104736;8172.795680107807;8185.877211841708;8220;7193.964030180025;7378.704851805867;7391.926080739339;7435.293647103516;7556.9798077258865;7338.412926965937;7428;7448.180700123091;7514.135874374517;7579.431542634215;6970.616616086164;6977.33715297046;6980.162380514371;7018.2630823762765;7049.753258635923;5002.449730529712;5066.161442871445;5122.231665250242;5139.280500729976;5245;4941.65408421407;4968.776405061709;5014.648974571745;5165.018646457161;5220.791168353223 20:26:00 INFO - PROCESS | 26421 | |4;prototype.html;350.187564849549;358.2762819105407;360.54571240237294;360.7655024234247;365.29133481046784;6416.326285739989;6546.8690626187445;6576.342365763428;6614.239362473317;6620.801375958717;6425.678716064202;6541.182352205974;6541.738330466787;6555.475561955044;6577.276499585042;4993.226049962262;5000.649954503187;5011.198208286675;5026.52248036436;5030.6981581105065;5008.849734507952;5035.269885866547;5038.2190760432195;5041.445441001505;5051.116054690433;4986.650934434573;4993.325901003354;4996.300517927493;5000.224965130411;5004.049230646184;4793.352897358846;4932.53140951609;4986.975065124688;4998.200287953928;4998.5001499849905;4291.635211007068;4308.612224899743;4313.82744690212;4318.309070548728;4321.416608757841;6319.74721011159;6329.905051424233;6330.082138089997;6349.174607301022;6356.586821856565;5792.507636850873;5820.941790582082;5831.883362332772;5838.2118414013985;5839.532837373;6966.895496567556;6967.651617419159;6973.3375329343635;6977.267386924351;6988.61562614056;4745.430548334188;4817.3737414136285;4822.011487645024;4836.056968891067;4903.411590609114;7191.137063552407;7246.565206087652;7250.057492525938;7284.235155308669;7294.197638259734;5004.624653150955;5004.699718016931;5012.649114562018;5016.623753218523;5027.82402615914;5086.18621020635;5087.97456012725;5090.414602320707;5094.6688465249645;5113.590912726973;5844.1233814927255;5852.15143804146;5854.268216472941;5866.090755932837;5869.765209391577;6740.629265390353;7019.052427922267;7030.402415794612;7062.6821793019435;7064.894026589605;1783.179737320821;1791.9193636286398;1795.721663142215;1800.5048611631644;1802.6755184066994;1135.4890299365318;1185.6739396665814;1194.1939191046183;1203.9879601203875;1209.4920133543933;6650.767223147167;6699.497537684693;6714.563553369113;6718.932810671929;6723.562968407038;7176.102987126609;7179.317964793337;7184.856302874018;7195.352418282379;7197.640117994079;6665.033570132304;6702.497312701566;6704.061431399608;6704.329567043256;6708.127943367331;3868.8065596720053;3884.6892248620043;3896.337622604164;3903.2583809076186;3915.6671682906704;7312.707491700273;7597.658105385271;7646.082470103512;7653.966714493472;7704.036995375578;7485.47601667878;7492.213317601682;7515.849683006419;7528.284812942762;7529.924700752922;7627;7637.121731000895;7638.923610763933;7641.2740789626005;7657.425693073042;7215.170255420694;7347.55914645123;7349.30181632744;7353.338199562065;7357.558546487228;7173.677184526813;7184.820379490555;7206.531575447579;7226.891596625949;7230.313120253568;7561.3194812467145;7578.204288549843;7603.695852166073;7617.200193979553;7617.352525035212;4857.854264372075;4891.608671306358;4894.730789806595;4898.2652602109965;4901.3383193268455;7025.718971241093;7339.192688804121;7341.669624866787;7346.77959661211;7348.889766653398;7089.503734738519;7093.574385536885;7113.928860711534;7126.679299431642;7128.215896251512;7105.609191494517;7106.857862842818;7109.395701365235;7116.323949224816;7125.679344429617;6995.090638217;6995.370416662525;7004.3696067354185;7007.754728584679;7022;6985.987031880247;7157.57054576727;7171.175314838861;7171.211166771755;7182.712691492282;6774.525783195129;6968.616726079911;6970.372666460043;6986.54587451814;6999.860002800017 20:26:00 INFO - PROCESS | 26421 | |5;yui.html;854.1245223645766;863.8747381629664;866.1814585216971;920.7836158502753;945.1210374351855;15590.220488975549;15733.213339333044;15798.131102789343;15828.683426331481;15839.287232074556;16206.918965405157;16303.347866085373;16309;16341;16352.75470867938;926.9675561355338;939.8872135343769;939.9859002114973;942.9905700942971;943.9480828554426;802.7591722483261;912.8219997100568;928.8374534456477;934.7943452440452;935.5930170375874;961.3558915526579;973.522973742868;977.8973207813184;979.4074584876154;980.4264505264429;968.903109689029;971.6453494474537;974.0892265731563;979.3536266064434;982.6560703753629;712.6294326949957;719.7876626395226;722.9421646268286;723.1683563901503;723.1791916175179;15535.611609709735;15723.05661660304;15809.288582013722;15818.209089545591;15851.207439628088;15156.772648410282;15161.848381516264;15190.620234494116;15262.694746105126;15273.312700928374;11977.94011029948;12151.392430378446;12169.93915030428;12222.449989750483;12430.689232769253;4007.83968641254;4012.057166565855;4030.8186131624147;4067.613576710208;4068.5321188063454;56786;57815;58058;58431.70784146094;61062;11654.825177622342;11797.351145686898;12071.939640301742;12104.213226140273;12145.392730363623;20796.27213047536;20843.58312833765;20877.26929557458;20926.790732092486;20944.47638809042;8856.468611883307;8893.377463577488;8949.463032218087;8998.055204203465;9262.166405023445;5176.2494438306985;5210.47895210476;5227.503387178288;5296.867578310496;5302.946970530245;3707.1102935295335;3799.772013679188;3800.201957588882;3802.2585595809105;3812.790296533717;675.2032601530242;675.5037591734332;681.3186813186813;688.4148473797233;710.8080818179062;793.1525822297978;813.9511629302142;829.9377546683902;838.576518857985;840.2521755637488;10114.797704046025;10186.64346747875;10271.178305735522;10567.788644227072;10589.947050264853;643.1542521584196;730.5835673666065;786.4966421490251;792.7304716396453;802.06959926485;4638.8608341749805;4678.60231880294;4724.905501889943;4775.474697783241;4832.251001094836;69828;70052.64973675099;70193.29806701868;71079;71522;60986.695066524386;61511.6924415375;61698.69150654218;62027.6898615504;62080.06879896805;55610.16584751232;55933;56116.71941640266;56265.43734562684;56542.151867722016;8979.416337938013;9278.814423711623;9634.325597208128;9641.566129524328;9681.128698417177;41114.58885411227;41716;41973;42333.788331058146;42403.7879810599;46954;47471.52528474671;52597.7370113147;53433.7328313356;54369.184462232304;11391.601293954673;11478.655640330804;11981.15705286717;12096.878771858186;12161.574344897886;12329.121995934625;12490.500379984698;12883.227006379648;12995.220286782824;13054.869451305365;12383.876161238271;12688.375804119158;12731.108822382716;12889.09776315649;12996.155249908727;12436.564720234748;12589;12648.43082061291;13004.349782511026;13043.608691739262;12312.384380780746;12332.19840710351;12349.444275007467;12787.29669868129;13133.212007279593;9492.477913714813;9976.950115249667;10450.581976720847;11331.603393881174;11348.546058157912;10839.458027098455;11060.834087488854;11135.443227838738;11275.548978040786;11446.484908179318 20:26:00 INFO - PROCESS | 26421 | __end_tp_report 20:26:00 INFO - PROCESS | 26421 | __start_cc_report 20:26:00 INFO - PROCESS | 26421 | _x_x_mozilla_cycle_collect,345 20:26:00 INFO - PROCESS | 26421 | __end_cc_report 20:26:00 INFO - PROCESS | 26421 | __startTimestamp1467689160440__endTimestamp 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | ------- Summary: start ------- 20:26:00 INFO - PROCESS | 26421 | Number of tests: 6 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | [#0] dojo.html Cycles:165 Average:5602.25 Median:5823.04 stddev:629.45 (10.8%) stddev-sans-first:604.70 20:26:00 INFO - PROCESS | 26421 | Values: 3291.1 3330.6 3382.6 3417.5 3427.3 5576.2 5585.4 5588.8 5596.9 5637.0 5564.1 5571.1 5577.7 5590.8 5621.6 5042.1 5083.8 5097.8 5104.3 5125.8 5032.1 5162.3 5218.5 5239.0 5253.6 5194.9 5205.8 5238.9 5239.7 5256.4 5184.8 5198.2 5209.8 5217.5 5234.6 4911.2 4977.4 5084.3 5104.1 5164.9 5486.3 5491.7 5528.2 5529.9 5559.1 5967.7 6007.1 6010.2 6010.3 6015.0 5949.3 6066.4 6075.6 6079.5 6106.3 5630.8 5680.5 5681.0 5682.1 5694.2 6170.0 6191.0 6194.9 6197.0 6204.7 5892.7 5939.7 5981.2 6029.8 6076.3 5969.0 5991.8 6094.5 6099.4 6101.1 5783.8 6063.2 6070.9 6081.5 6091.7 5978.3 5993.4 5995.0 5999.1 6023.8 4612.9 4617.6 4624.4 4624.8 4651.1 4014.1 4033.2 4116.4 4128.5 4159.6 5567.9 5780.2 5781.6 5790.9 5801.4 6094.5 6103.2 6104.9 6107.7 6109.8 5619.4 5766.9 5798.6 5814.8 5823.4 5021.3 5027.5 5043.5 5051.6 5073.1 6234.2 6276.5 6287.2 6292.2 6314.5 5960.9 6006.7 6072.8 6085.8 6090.2 6206.9 6222.8 6224.9 6260.2 6265.6 5835.9 5857.5 5866.1 5871.0 5894.5 5888.9 6017.2 6037.7 6108.8 6121.6 5850.4 5872.9 5881.3 5892.1 5910.9 5823.0 5828.4 5866.2 5889.8 5893.6 5652.3 5734.8 5767.2 5795.9 5805.1 5928.9 5949.0 5949.4 5950.1 5964.0 5698.9 5807.7 5823.4 5831.6 5833.7 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | [#1] ext.html Cycles:180 Average:60254.19 Median:234859.18 stddev:123212.56 (52.5%) stddev-sans-first:123476.96 20:26:00 INFO - PROCESS | 26421 | Values: 662.2 671.9 678.9 734.6 742.9 33285.3 34033.1 39804.6 40246.0 40442.0 43765.0 43814.3 44203.6 44303.0 44306.8 8880.8 9075.3 9076.5 9091.4 9097.7 9078.7 9196.5 9205.9 9247.4 9253.5 9234.9 9239.6 9285.1 9292.4 9299.2 9198.0 9234.7 9250.2 9253.7 9259.4 9037.9 9178.3 9180.6 9203.0 9205.0 44571.0 45121.3 45301.3 45304.1 45442.1 3842.5 3901.1 4191.7 4510.1 4556.1 33670.0 33921.2 33980.8 34000.1 35379.3 4421.2 4452.4 4494.5 4526.7 4608.8 227430.0 227475.9 228310.0 228977.0 229167.0 62920.4 63004.0 63437.0 63490.0 63616.4 72417.6 72582.0 72733.0 72965.3 73371.0 19243.5 19391.6 19398.2 19410.6 19535.8 15168.5 15256.8 15343.5 15344.3 15378.2 20447.8 20777.4 20832.5 20873.8 21883.7 7865.9 7953.5 8137.1 8244.2 8263.6 1083.3 1102.8 1181.5 1205.8 1267.2 33160.8 33377.3 33679.7 34145.8 34240.0 1172.6 1228.8 1254.0 1270.6 1350.8 17452.5 17506.0 17571.8 17720.6 17735.6 468806.0 474614.0 617122.0 621518.0 895332.0 62404.4 63608.0 63937.4 64188.4 64381.7 1529.2 1544.7 1551.6 1556.1 1648.5 33164.5 33798.7 34089.3 34130.0 34673.3 54375.0 55050.0 55133.7 55136.0 55247.7 423371.0 424278.0 426121.0 426590.0 426727.0 30824.4 31316.7 31666.0 31739.7 31798.0 49177.3 50270.0 50331.5 51148.7 51913.7 42315.8 42991.4 43400.1 44348.0 44637.8 41695.4 42369.2 42505.0 43407.6 43830.1 39506.2 39848.2 39895.6 40493.8 43780.6 36528.3 37223.4 37843.8 38050.0 38155.4 28711.9 29025.7 29179.9 29590.0 29807.9 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | [#2] jquery.html Cycles:180 Average:28191.92 Median:2205.11 stddev:78439.00 (3557.1%) stddev-sans-first:78631.32 20:26:00 INFO - PROCESS | 26421 | Values: 421.2 424.9 431.9 436.1 444.3 18687.3 19271.6 19393.3 20054.6 20954.7 19785.9 20338.3 20546.8 20597.9 20704.4 5236.6 5434.3 5438.6 5483.9 5494.8 5247.8 5387.9 5477.2 5483.8 5494.8 5460.8 5478.0 5492.3 5498.6 5517.9 5383.0 5467.6 5471.6 5847.9 5915.4 5377.5 5400.2 5408.1 5421.8 5429.5 15074.0 15211.5 15476.3 15513.0 24114.4 2442.6 2479.8 2489.3 2534.9 2583.5 10813.1 11176.9 11194.5 11332.2 11555.4 2033.5 2095.7 2119.3 2161.7 2191.8 79115.2 79871.0 81384.0 82170.0 82949.6 11630.2 11896.2 12161.3 12173.6 12707.9 15160.8 17295.7 17296.7 17313.7 17334.0 8804.8 9147.8 9185.8 9428.2 9564.5 9106.6 9210.8 9211.4 9264.7 9272.1 5149.7 5217.1 5244.6 5253.0 5319.1 2151.5 2151.8 2160.5 2163.4 2218.5 1009.5 1057.1 1057.8 1103.1 1152.8 18978.9 19228.3 19599.7 19636.0 19834.0 1065.4 1073.1 1105.6 1118.9 1127.3 11025.5 11681.3 11681.4 11981.7 12034.2 469718.0 472845.0 473901.0 475028.0 493203.0 58076.1 72453.0 84873.6 95245.5 96487.0 1166.9 1177.6 1187.3 1194.3 1217.2 17348.3 17782.3 18110.0 18132.7 18331.3 36385.8 37065.0 37964.2 38945.6 39911.4 51274.0 52217.0 52291.0 52366.5 52935.5 8860.1 8921.9 8977.9 9186.1 9207.5 9914.0 13492.4 13573.1 13575.3 13643.3 11480.8 11806.8 11891.3 11988.4 12309.6 11626.4 11729.1 11742.0 11900.5 12175.9 6852.0 11847.9 11993.0 12201.3 12499.7 8110.2 8426.7 8864.3 9257.9 9426.7 10906.7 11037.6 11644.1 12276.6 12291.9 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | [#3] mootools.html Cycles:180 Average:5677.83 Median:2786.76 stddev:3084.05 (110.7%) stddev-sans-first:3077.28 20:26:00 INFO - PROCESS | 26421 | Values: 1574.6 1587.2 1795.0 1914.1 1925.8 7423.7 8188.9 8282.0 8454.0 8489.4 8519.4 8537.1 8586.5 8638.9 8639.1 2389.7 2401.8 2405.7 2408.8 2411.3 2369.7 2393.0 2399.1 2399.8 2400.8 2351.0 2351.3 2354.5 2361.3 2377.2 2332.3 2345.0 2348.4 2349.7 2350.6 2328.2 2336.7 2340.3 2341.3 2350.4 8573.5 8685.3 8700.1 8704.4 8710.3 5290.6 5352.3 5387.3 5398.6 5402.7 3289.6 3298.1 3343.0 3375.3 3394.5 1065.6 1087.8 1095.6 1098.2 1099.2 11548.7 11552.2 11573.5 11596.8 11633.6 4693.9 4716.2 4724.9 4752.4 4802.5 9880.3 9883.3 9911.0 9924.1 9984.4 5399.3 5413.8 5436.3 5450.9 5467.8 4375.5 4932.2 4954.9 5031.6 5031.9 4137.9 4154.9 4170.9 4185.5 4209.3 1287.9 1362.2 1366.2 1367.1 1373.2 921.9 1070.6 1083.1 1085.1 1096.5 6084.8 6161.8 6236.0 6246.7 6274.4 507.4 508.7 510.0 1134.4 1155.1 4046.0 4162.4 4200.0 4241.0 4282.7 10225.4 10616.4 10654.7 10708.3 10716.1 10426.6 10456.1 10464.4 10514.5 10556.8 7678.4 8243.3 8268.7 8288.7 8332.0 5822.2 5854.3 5854.8 5948.8 5975.5 8946.2 9052.0 9104.4 9149.7 9211.5 8791.0 9134.8 9141.8 9190.6 9252.6 7465.9 7656.7 7781.2 8046.3 8086.5 8124.4 8141.3 8172.8 8185.9 8220.0 7194.0 7378.7 7391.9 7435.3 7557.0 7338.4 7428.0 7448.2 7514.1 7579.4 6970.6 6977.3 6980.2 7018.3 7049.8 5002.4 5066.2 5122.2 5139.3 5245.0 4941.7 4968.8 5014.6 5165.0 5220.8 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | [#4] prototype.html Cycles:180 Average:5880.28 Median:6657.90 stddev:1793.31 (26.9%) stddev-sans-first:1749.65 20:26:00 INFO - PROCESS | 26421 | Values: 350.2 358.3 360.5 360.8 365.3 6416.3 6546.9 6576.3 6614.2 6620.8 6425.7 6541.2 6541.7 6555.5 6577.3 4993.2 5000.6 5011.2 5026.5 5030.7 5008.8 5035.3 5038.2 5041.4 5051.1 4986.7 4993.3 4996.3 5000.2 5004.0 4793.4 4932.5 4987.0 4998.2 4998.5 4291.6 4308.6 4313.8 4318.3 4321.4 6319.7 6329.9 6330.1 6349.2 6356.6 5792.5 5820.9 5831.9 5838.2 5839.5 6966.9 6967.7 6973.3 6977.3 6988.6 4745.4 4817.4 4822.0 4836.1 4903.4 7191.1 7246.6 7250.1 7284.2 7294.2 5004.6 5004.7 5012.6 5016.6 5027.8 5086.2 5088.0 5090.4 5094.7 5113.6 5844.1 5852.2 5854.3 5866.1 5869.8 6740.6 7019.1 7030.4 7062.7 7064.9 1783.2 1791.9 1795.7 1800.5 1802.7 1135.5 1185.7 1194.2 1204.0 1209.5 6650.8 6699.5 6714.6 6718.9 6723.6 7176.1 7179.3 7184.9 7195.4 7197.6 6665.0 6702.5 6704.1 6704.3 6708.1 3868.8 3884.7 3896.3 3903.3 3915.7 7312.7 7597.7 7646.1 7654.0 7704.0 7485.5 7492.2 7515.8 7528.3 7529.9 7627.0 7637.1 7638.9 7641.3 7657.4 7215.2 7347.6 7349.3 7353.3 7357.6 7173.7 7184.8 7206.5 7226.9 7230.3 7561.3 7578.2 7603.7 7617.2 7617.4 4857.9 4891.6 4894.7 4898.3 4901.3 7025.7 7339.2 7341.7 7346.8 7348.9 7089.5 7093.6 7113.9 7126.7 7128.2 7105.6 7106.9 7109.4 7116.3 7125.7 6995.1 6995.4 7004.4 7007.8 7022.0 6986.0 7157.6 7171.2 7171.2 7182.7 6774.5 6968.6 6970.4 6986.5 6999.9 20:26:00 INFO - PROCESS | 26421 | 20:26:00 INFO - PROCESS | 26421 | [#5] yui.html Cycles:180 Average:16282.79 Median:25839.45 stddev:19250.01 (74.5%) stddev-sans-first:19269.15 20:26:00 INFO - PROCESS | 26421 | Values: 854.1 863.9 866.2 920.8 945.1 15590.2 15733.2 15798.1 15828.7 15839.3 16206.9 16303.3 16309.0 16341.0 16352.8 927.0 939.9 940.0 943.0 943.9 802.8 912.8 928.8 934.8 935.6 961.4 973.5 977.9 979.4 980.4 968.9 971.6 974.1 979.4 982.7 712.6 719.8 722.9 723.2 723.2 15535.6 15723.1 15809.3 15818.2 15851.2 15156.8 15161.8 15190.6 15262.7 15273.3 11977.9 12151.4 12169.9 12222.4 12430.7 4007.8 4012.1 4030.8 4067.6 4068.5 56786.0 57815.0 58058.0 58431.7 61062.0 11654.8 11797.4 12071.9 12104.2 12145.4 20796.3 20843.6 20877.3 20926.8 20944.5 8856.5 8893.4 8949.5 8998.1 9262.2 5176.2 5210.5 5227.5 5296.9 5302.9 3707.1 3799.8 3800.2 3802.3 3812.8 675.2 675.5 681.3 688.4 710.8 793.2 814.0 829.9 838.6 840.3 10114.8 10186.6 10271.2 10567.8 10589.9 643.2 730.6 786.5 792.7 802.1 4638.9 4678.6 4724.9 4775.5 4832.3 69828.0 70052.6 70193.3 71079.0 71522.0 60986.7 61511.7 61698.7 62027.7 62080.1 55610.2 55933.0 56116.7 56265.4 56542.2 8979.4 9278.8 9634.3 9641.6 9681.1 41114.6 41716.0 41973.0 42333.8 42403.8 46954.0 47471.5 52597.7 53433.7 54369.2 11391.6 11478.7 11981.2 12096.9 12161.6 12329.1 12490.5 12883.2 12995.2 13054.9 12383.9 12688.4 12731.1 12889.1 12996.2 12436.6 12589.0 12648.4 13004.3 13043.6 12312.4 12332.2 12349.4 12787.3 13133.2 9492.5 9977.0 10450.6 11331.6 11348.5 10839.5 11060.8 11135.4 11275.5 11446.5 20:26:00 INFO - PROCESS | 26421 | -------- Summary: end -------- 20:26:00 INFO - PROCESS | 26421 | 20:26:01 INFO - TEST-INFO | 26421: exit 0 20:26:01 INFO - TEST-OK | dromaeo_css | took 1108579ms 20:26:01 INFO - TEST-START | kraken 20:26:01 INFO - operating with platform_type : linux_ 20:26:01 INFO - Initialising browser for kraken test... 20:26:01 INFO - TEST-INFO | started process 26671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbwy2lu/profile http://localhost:38725/getInfo.html) 20:26:04 INFO - PROCESS | 26671 | 20:26:04 INFO - PROCESS | 26671 | (process:26748): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:26:05 INFO - PROCESS | 26671 | __metrics Screen width/height:1600/1200 20:26:05 INFO - PROCESS | 26671 | colorDepth:24 20:26:05 INFO - PROCESS | 26671 | Browser inner width/height: 1024/697 20:26:05 INFO - PROCESS | 26671 | __metrics 20:26:06 ERROR - PROCESS | 26671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:26:06 INFO - TEST-INFO | 26671: exit 0 20:26:06 INFO - Browser initialized. 20:26:06 INFO - Running cycle 1/1 for kraken test... 20:26:06 INFO - TEST-INFO | started process 26798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbwy2lu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:08 INFO - PROCESS | 26798 | 20:26:08 INFO - PROCESS | 26798 | (process:26867): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:26:18 INFO - PROCESS | 26798 | RSS: Main: 150945792 20:26:18 INFO - PROCESS | 26798 | 20:26:21 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38725/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:22 INFO - PROCESS | 26798 | RSS: Main: 156704768 20:26:22 INFO - PROCESS | 26798 | 20:26:24 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38725/tests/kraken/driver.html?testName=audio-dft) 20:26:25 INFO - PROCESS | 26798 | RSS: Main: 156499968 20:26:25 INFO - PROCESS | 26798 | 20:26:28 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38725/tests/kraken/driver.html?testName=audio-fft) 20:26:28 INFO - PROCESS | 26798 | RSS: Main: 156192768 20:26:28 INFO - PROCESS | 26798 | 20:26:30 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38725/tests/kraken/driver.html?testName=audio-oscillator) 20:26:31 INFO - PROCESS | 26798 | RSS: Main: 155983872 20:26:31 INFO - PROCESS | 26798 | 20:26:33 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38725/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:34 INFO - PROCESS | 26798 | RSS: Main: 156131328 20:26:34 INFO - PROCESS | 26798 | 20:26:37 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38725/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:37 INFO - PROCESS | 26798 | RSS: Main: 156782592 20:26:37 INFO - PROCESS | 26798 | 20:26:41 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38725/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:41 INFO - PROCESS | 26798 | RSS: Main: 156717056 20:26:41 INFO - PROCESS | 26798 | 20:26:44 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38725/tests/kraken/driver.html?testName=json-parse-financial) 20:26:45 INFO - PROCESS | 26798 | RSS: Main: 156852224 20:26:45 INFO - PROCESS | 26798 | 20:26:46 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38725/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:47 INFO - PROCESS | 26798 | RSS: Main: 156221440 20:26:47 INFO - PROCESS | 26798 | 20:26:49 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:49 INFO - PROCESS | 26798 | RSS: Main: 156307456 20:26:49 INFO - PROCESS | 26798 | 20:26:51 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:52 INFO - PROCESS | 26798 | RSS: Main: 156700672 20:26:52 INFO - PROCESS | 26798 | 20:26:54 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:55 INFO - PROCESS | 26798 | RSS: Main: 157155328 20:26:55 INFO - PROCESS | 26798 | 20:26:58 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:58 INFO - PROCESS | 26798 | RSS: Main: 156983296 20:26:58 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | Cycle 1(1): loaded http://localhost:38725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38725/tests/kraken/driver.html?testName=ai-astar) 20:27:00 INFO - PROCESS | 26798 | RSS: Main: 158711808 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | __start_tp_report 20:27:00 INFO - PROCESS | 26798 | _x_x_mozilla_page_load 20:27:00 INFO - PROCESS | 26798 | _x_x_mozilla_page_load_details 20:27:00 INFO - PROCESS | 26798 | |i|pagename|runs| 20:27:00 INFO - PROCESS | 26798 | |0;ai-astar;109;112;107;111;112;114;100;110;112;110 20:27:00 INFO - PROCESS | 26798 | |1;audio-beat-detection;171;130;155;182;130;156;152;128;189;135 20:27:00 INFO - PROCESS | 26798 | |2;audio-dft;163;163;163;164;163;161;163;163;162;163 20:27:00 INFO - PROCESS | 26798 | |3;audio-fft;76;75;75;175;77;76;75;75;159;75 20:27:00 INFO - PROCESS | 26798 | |4;audio-oscillator;92;92;159;93;92;92;149;92;92;145 20:27:00 INFO - PROCESS | 26798 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;118;117 20:27:00 INFO - PROCESS | 26798 | |6;imaging-darkroom;145;145;147;152;148;147;146;147;148;146 20:27:00 INFO - PROCESS | 26798 | |7;imaging-desaturate;95;95;95;96;95;95;94;95;95;96 20:27:00 INFO - PROCESS | 26798 | |8;json-parse-financial;53;57;53;54;57;55;58;69;53;53 20:27:00 INFO - PROCESS | 26798 | |9;json-stringify-tinderbox;64;58;60;57;57;58;57;57;57;58 20:27:00 INFO - PROCESS | 26798 | |10;stanford-crypto-aes;82;76;75;77;75;83;76;76;76;77 20:27:00 INFO - PROCESS | 26798 | |11;stanford-crypto-ccm;119;125;128;126;117;128;115;113;132;134 20:27:00 INFO - PROCESS | 26798 | |12;stanford-crypto-pbkdf2;164;167;162;162;169;178;161;165;160;164 20:27:00 INFO - PROCESS | 26798 | |13;stanford-crypto-sha256-iterative;71;71;66;68;74;70;67;67;68;68 20:27:00 INFO - PROCESS | 26798 | __end_tp_report 20:27:00 INFO - PROCESS | 26798 | __start_cc_report 20:27:00 INFO - PROCESS | 26798 | _x_x_mozilla_cycle_collect,824 20:27:00 INFO - PROCESS | 26798 | __end_cc_report 20:27:00 INFO - PROCESS | 26798 | __startTimestamp1467689220892__endTimestamp 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | ------- Summary: start ------- 20:27:00 INFO - PROCESS | 26798 | Number of tests: 14 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.92 (3.5%) stddev-sans-first:4.15 20:27:00 INFO - PROCESS | 26798 | Values: 109.0 112.0 107.0 111.0 112.0 114.0 100.0 110.0 112.0 110.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:155.50 stddev:22.31 (14.4%) stddev-sans-first:22.68 20:27:00 INFO - PROCESS | 26798 | Values: 171.0 130.0 155.0 182.0 130.0 156.0 152.0 128.0 189.0 135.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:27:00 INFO - PROCESS | 26798 | Values: 163.0 163.0 163.0 164.0 163.0 161.0 163.0 163.0 162.0 163.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:38.77 (51.7%) stddev-sans-first:40.58 20:27:00 INFO - PROCESS | 26798 | Values: 76.0 75.0 75.0 175.0 77.0 76.0 75.0 75.0 159.0 75.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.63 (31.1%) stddev-sans-first:29.64 20:27:00 INFO - PROCESS | 26798 | Values: 92.0 92.0 159.0 93.0 92.0 92.0 149.0 92.0 92.0 145.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:27:00 INFO - PROCESS | 26798 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:2.02 (1.4%) stddev-sans-first:2.00 20:27:00 INFO - PROCESS | 26798 | Values: 145.0 145.0 147.0 152.0 148.0 147.0 146.0 147.0 148.0 146.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:27:00 INFO - PROCESS | 26798 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 96.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:4.89 (8.7%) stddev-sans-first:5.05 20:27:00 INFO - PROCESS | 26798 | Values: 53.0 57.0 53.0 54.0 57.0 55.0 58.0 69.0 53.0 53.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:2.21 (3.8%) stddev-sans-first:1.00 20:27:00 INFO - PROCESS | 26798 | Values: 64.0 58.0 60.0 57.0 57.0 58.0 57.0 57.0 57.0 58.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:2.83 (3.7%) stddev-sans-first:2.44 20:27:00 INFO - PROCESS | 26798 | Values: 82.0 76.0 75.0 77.0 75.0 83.0 76.0 76.0 76.0 77.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:127.00 stddev:7.27 (5.7%) stddev-sans-first:7.51 20:27:00 INFO - PROCESS | 26798 | Values: 119.0 125.0 128.0 126.0 117.0 128.0 115.0 113.0 132.0 134.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:164.50 stddev:5.27 (3.2%) stddev-sans-first:5.57 20:27:00 INFO - PROCESS | 26798 | Values: 164.0 167.0 162.0 162.0 169.0 178.0 161.0 165.0 160.0 164.0 20:27:00 INFO - PROCESS | 26798 | 20:27:00 INFO - PROCESS | 26798 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.45 (3.5%) stddev-sans-first:2.49 20:27:00 INFO - PROCESS | 26798 | Values: 71.0 71.0 66.0 68.0 74.0 70.0 67.0 67.0 68.0 68.0 20:27:00 INFO - PROCESS | 26798 | -------- Summary: end -------- 20:27:00 INFO - PROCESS | 26798 | 20:27:01 INFO - TEST-INFO | 26798: exit 0 20:27:01 INFO - TEST-OK | kraken | took 60715ms 20:27:01 INFO - SUITE-END | took 1169s 20:27:02 INFO - Completed test suite (00:19:29) 20:27:02 INFO - javascript benchmark 20:27:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.111399922021, 3330.55037569928, 3382.6448222936597, 3417.5386322846407, 3427.314537092582, 5576.163575463677, 5585.413531579186, 5588.832335029955, 5596.860078498034, 5636.971815140923, 5564.081926482136, 5571.052921003429, 5577.69322687252, 5590.832275031746, 5621.550275977922, 5042.117629414865, 5083.822066227683, 5097.847064588068, 5104.259882317062, 5125.846224613268, 5032.11937910866, 5162.251473536335, 5218.452062533436, 5239.0, 5253.579713622901, 5194.948050519503, 5205.843824685266, 5238.947610523884, 5239.711815850127, 5256.448072952323, 5184.844454666366, 5198.168293073109, 5209.843704688866, 5217.530422262014, 5234.581233501311, 4911.214205727067, 4977.377827771528, 5084.262781896604, 5104.081265372231, 5164.870878228036, 5486.259354987105, 5491.725413729338, 5528.198411230389, 5529.889402211933, 5559.082751346023, 5967.701614919237, 6007.068904319837, 6010.158577799111, 6010.338862725097, 6015.007523758574, 5949.25634295713, 6066.363031881633, 6075.635461872302, 6079.483243924272, 6106.328303886569, 5630.831075067755, 5680.46035626619, 5681.034224181899, 5682.119271512922, 5694.2312787773535, 6170.0, 6191.040388739752, 6194.907076393858, 6197.0, 6204.689765511706, 5892.734826932799, 5939.732712027882, 5981.162637230791, 6029.849253768691, 6076.301225359052, 5968.970155149196, 5991.7902873399225, 6094.481969032682, 6099.390060993954, 6101.054336577838, 5783.768649254067, 6063.151158837766, 6070.939290607037, 6081.483073938676, 6091.695415229221, 5978.252718410199, 5993.3706960768495, 5995.04079347311, 5999.130126131687, 6023.849403764853, 4612.930806037912, 4617.607503362252, 4624.445066591963, 4624.815007399667, 4651.09303685778, 4014.116894283253, 4033.153037862082, 4116.361963895601, 4128.4632997710105, 4159.584041595816, 5567.916481252784, 5780.219670344533, 5781.566382521243, 5790.913136302959, 5801.448862358069, 6094.451499365078, 6103.23709536308, 6104.877902441926, 6107.725152368154, 6109.755609775648, 5619.409961953936, 5766.88466230673, 5798.623089499253, 5814.79648212319, 5823.359430462646, 5021.271915572222, 5027.547520723152, 5043.5460808527405, 5051.62112841531, 5073.086844368049, 6234.1583886175695, 6276.466500347522, 6287.182666253358, 6292.244930608264, 6314.494840412756, 5960.850978725393, 6006.729697163725, 6072.817815465455, 6085.786997455068, 6090.177825993612, 6206.913790086626, 6222.81331560054, 6224.9377506224355, 6260.154879091265, 6265.592736472115, 5835.883282334415, 5857.502112320501, 5866.061430171152, 5870.972579798433, 5894.469497745224, 5888.882222355614, 6017.247844019497, 6037.728302226323, 6108.847278818065, 6121.571489995657, 5850.444207800252, 5872.911906321323, 5881.264841894763, 5892.057270836645, 5910.881782364415, 5823.039198532195, 5828.358880523054, 5866.208061911588, 5889.764409423747, 5893.557983151367, 5652.293463317085, 5734.827955161185, 5767.163761254511, 5795.8551036224435, 5805.129230615442, 5928.851778705567, 5949.0481522956115, 5949.434803693643, 5950.077737950624, 5964.0, 5698.886022279448, 5807.709614519173, 5823.4467725566, 5831.562632802472, 5833.708314584339], "value": 5560.834587899909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.1855118204609, 671.8924972004479, 678.8574399376131, 734.6179986407069, 742.8551432470667, 33285.33429331412, 34033.14917127073, 39804.60195398049, 40246.0, 40442.0, 43765.0, 43814.34278485825, 44203.557964420346, 44303.0, 44306.77846610762, 8880.777980550489, 9075.27397808177, 9076.455412675228, 9091.363604547685, 9097.727068187933, 9078.727638170865, 9196.494192819393, 9205.86191207129, 9247.39891907024, 9253.537323133816, 9234.907650923506, 9239.58421871014, 9285.117913798178, 9292.442453452815, 9299.16307532322, 9198.0, 9234.67678631248, 9250.213731832802, 9253.676121335755, 9259.398139120936, 9037.909620903773, 9178.265738740885, 9180.632774689004, 9202.953985230099, 9204.953975230148, 44571.0, 45121.32318015232, 45301.32048019282, 45304.093918121784, 45442.09115817665, 3842.500474938268, 3901.0637447012514, 4191.685623578243, 4510.143072816154, 4556.111558246143, 33670.0, 33921.15197120092, 33980.83009584961, 34000.149996250046, 35379.29241415183, 4421.172792019244, 4452.364195404896, 4494.52807455219, 4526.705764125354, 4608.815647374101, 227430.0, 227475.8626206875, 228310.0, 228977.0, 229167.0, 62920.370796292365, 63004.0, 63437.04844427337, 63490.0476492853, 63616.363836361044, 72417.6379118101, 72582.0, 72733.0, 72965.27034729692, 73371.0, 19243.51891202731, 19391.612167756564, 19398.224071037, 19410.611787764446, 19535.804641953684, 15168.544943651708, 15256.771148432783, 15343.539693809204, 15344.309506072253, 15378.154201519024, 20447.795522044587, 20777.376678699664, 20832.47918802042, 20873.79126208749, 21883.67174492384, 7865.921340786634, 7953.548644338026, 8137.104918458965, 8244.216799404046, 8263.628136733862, 1083.3175099687146, 1102.8345748137845, 1181.4624345922584, 1205.8311836342918, 1267.2269915351628, 33160.834195828866, 33377.332453351286, 33679.663203368145, 34145.82927085349, 34240.0, 1172.6306213542707, 1228.8033914573625, 1254.0281282006517, 1270.618814355708, 1350.8041334006514, 17452.47642570725, 17506.0, 17571.824281757275, 17720.645587088187, 17735.556611084827, 468806.0, 474614.0, 617122.0, 621518.0, 895332.0, 62404.375956240765, 63608.0, 63937.360626394075, 64188.35811641917, 64381.67809160924, 1529.1742459071977, 1544.6678964022565, 1551.6276093737647, 1556.144120733592, 1648.4560095168806, 33164.50253246252, 33798.66201337955, 34089.318213636085, 34129.97610071702, 34673.30653386968, 54375.0, 55050.0, 55133.72433137969, 55136.0, 55247.72376138254, 423371.0, 424278.0, 426121.0, 426590.0, 426727.0, 30824.383512330078, 31316.686833131378, 31666.0, 31739.68260317367, 31798.0, 49177.26234106563, 50270.0, 50331.49668503268, 51148.74425627997, 51913.7404312976, 42315.788421057696, 42991.355129672454, 43400.131997360506, 44348.0, 44637.776811115735, 41695.37456938209, 42369.15261694811, 42505.0, 43407.56592434035, 43830.123397531235, 39506.209875801746, 39848.203035939696, 39895.60104398919, 40493.797531012155, 43780.56219437892, 36528.26943461063, 37223.441648374755, 37843.81078094592, 38050.0, 38155.42766858555, 28711.856440717664, 29025.7097429023, 29179.85410072936, 29590.0, 29807.850960745058], "value": 21295.816982172284, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.2207416279883, 424.93201087825935, 431.91361727654436, 436.11903954012894, 444.2514363297843, 18687.252509899605, 19271.614567708653, 19393.321233756822, 20054.59890802183, 20954.685679714818, 19785.901070494627, 20338.288159914406, 20546.794532054675, 20597.897010514927, 20704.37886863393, 5236.607254455912, 5434.347878254615, 5438.619296649236, 5483.862903427426, 5494.752736126864, 5247.816326428576, 5387.865303367408, 5477.1510415885405, 5483.7806487740445, 5494.752736126864, 5460.808871689492, 5478.04134276502, 5492.313460817398, 5498.5876059295515, 5517.944820551803, 5382.977234325485, 5467.644603100805, 5471.616986810925, 5847.941520584783, 5915.3788852170765, 5377.51602355786, 5400.243965844785, 5408.107662235727, 5421.810236641738, 5429.484199001088, 15074.0, 15211.467598633995, 15476.303566339542, 15513.0, 24114.36907945996, 2442.6336049592524, 2479.789217916479, 2489.2781093482868, 2534.873256337176, 2583.483303339321, 10813.08088812452, 11176.944115279453, 11194.496247668792, 11332.150088743378, 11555.422228888607, 2033.4814622271374, 2095.6542170541843, 2119.3218170185546, 2161.7189765330563, 2191.7589065202815, 79115.20884791136, 79871.0, 81384.0, 82170.0, 82949.58525207336, 11630.244034137753, 11896.22674526153, 12161.270323780602, 12173.634790956285, 12707.87292127067, 15160.772588411182, 17295.65408691819, 17296.740548891776, 17313.65372692539, 17333.959962402296, 8804.811350467733, 9147.81704365909, 9185.77035574116, 9428.15146636806, 9564.4739539326, 9106.635734570675, 9210.769730756785, 9211.40125891815, 9264.67573634933, 9272.119148680864, 5149.716765577929, 5217.139172036647, 5244.580433565306, 5252.9737351313, 5319.148936170194, 2151.4621344663833, 2151.817095546865, 2160.5354848707602, 2163.3618082665653, 2218.4675677837527, 1009.4952523738131, 1057.0697785948316, 1057.8043062033394, 1103.1119948441421, 1152.8386025956372, 18978.905105474383, 19228.327008554632, 19599.706004409945, 19636.0, 19834.00829958525, 1065.3980501017056, 1073.0878753059992, 1105.5517272373218, 1118.8545489086366, 1127.2672762704144, 11025.503852326665, 11681.299122052704, 11681.357525336018, 11981.700457488632, 12034.157608967464, 469718.0, 472845.0, 473901.0, 475028.0, 493203.0, 58076.12885806716, 72453.0, 84873.57563212268, 95245.52377238208, 96487.0, 1166.9299842009507, 1177.5633726853225, 1187.2638963842473, 1194.3311745422418, 1217.1601594899491, 17348.306067757654, 17782.288708451517, 18110.0, 18132.72800908014, 18331.266749329876, 36385.818070909474, 37065.0, 37964.2407151861, 38945.610543894196, 39911.40132897951, 51274.0, 52217.0, 52291.0, 52366.47633523616, 52935.470645293055, 8860.113988601088, 8921.866172007554, 8977.922649282127, 9186.081391861027, 9207.539623018689, 9913.950430247802, 13492.392842322315, 13573.11774734639, 13575.32123393846, 13643.317834108057, 11480.827787583026, 11806.822897656713, 11891.28652280866, 11988.400579971141, 12309.56916507918, 11626.360550169822, 11729.061675065803, 11742.00192983606, 11900.523979040741, 12175.878241217475, 6852.0, 11847.940760296144, 11993.0, 12201.267923924594, 12499.687507812378, 8110.188981101843, 8426.747197584082, 8864.290856731575, 9257.907420925705, 9426.717198484057, 10906.727331816768, 11037.558497660004, 11644.068474521848, 12276.570320038756, 12291.877081229073], "value": 9414.138902475985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1574.5984773882662, 1587.206396801599, 1794.9730754038692, 1914.1482040491978, 1925.7977912319216, 7423.665935032923, 8188.877166842502, 8281.958590207056, 8453.957730211348, 8489.405741598091, 8519.446235994656, 8537.060923298432, 8586.48481091135, 8638.870416943751, 8639.136086391358, 2389.6893403857516, 2401.7598240176017, 2405.675233843435, 2408.771166739157, 2411.2766170148884, 2369.656399822025, 2392.95214095718, 2399.1243196233336, 2399.8200134989856, 2400.7959323457526, 2350.9529809403803, 2351.3063646224405, 2354.5290941811622, 2361.315218586608, 2377.2274010946426, 2332.288651961151, 2345.0385342009863, 2348.3542025942916, 2349.7297810751725, 2350.6003979323473, 2328.196772113618, 2336.7429582745885, 2340.2745149003863, 2341.332720174759, 2350.3888988862846, 8573.52845593492, 8685.348598855047, 8700.129987001312, 8704.390692651517, 8710.259627931633, 5290.603204759658, 5352.277442545284, 5387.299651045379, 5398.595105367113, 5402.6758394496455, 3289.62169350523, 3298.0765385692043, 3342.9803909807497, 3375.2574433624563, 3394.541736865516, 1065.5737704918017, 1087.8313861351423, 1095.6439157273917, 1098.214776434845, 1099.1646348774989, 11548.711282217928, 11552.249103808226, 11573.537058517564, 11596.768064638743, 11633.592824251195, 4693.859184224479, 4716.151092803259, 4724.88187795301, 4752.358431611758, 4802.519748025239, 9880.258980576486, 9883.258755593359, 9910.950445247727, 9924.1068303853, 9984.35101718386, 5399.325084364455, 5413.83758487246, 5436.293281873332, 5450.91823622646, 5467.808626698126, 4375.4968178659865, 4932.21084626458, 4954.925676114861, 5031.647784655039, 5031.899362012739, 4137.882771651697, 4154.875353739392, 4170.895727606834, 4185.539590645027, 4209.284421648327, 1287.8583355830851, 1362.2167253829089, 1366.1666383506054, 1367.131871261756, 1373.2378529915793, 921.9262459003263, 1070.6466865934224, 1083.101026148295, 1085.066842515436, 1096.4736926275273, 6084.756609735561, 6161.84595385119, 6236.03341482071, 6246.664438802728, 6274.372562743689, 507.35819188726293, 508.7074931914164, 510.01566975736444, 1134.3987686526154, 1155.0932517973351, 4045.959540404617, 4162.41726158338, 4200.0, 4241.0, 4282.743035417885, 10225.437600931871, 10616.363018218932, 10654.680359589225, 10708.30396024256, 10716.142708583295, 10426.635067772591, 10456.058954694114, 10464.424456654804, 10514.474276286155, 10556.841647375295, 7678.424118191158, 8243.25810677042, 8268.710595129141, 8288.668453261922, 8332.000159980842, 5822.214001109796, 5854.326752423355, 5854.824355269348, 5948.762049517971, 5975.492083172805, 8946.150115738994, 9052.049534799015, 9104.408213466104, 9149.679761208326, 9211.493367864832, 8791.0, 9134.771630709285, 9141.77145571366, 9190.58642361082, 9252.629894804402, 7465.850682986418, 7656.693732250647, 7781.182975787461, 8046.316063134699, 8086.5148091114725, 8124.390670699603, 8141.348692104736, 8172.795680107807, 8185.877211841708, 8220.0, 7193.964030180025, 7378.704851805867, 7391.926080739339, 7435.293647103516, 7556.9798077258865, 7338.412926965937, 7428.0, 7448.180700123091, 7514.135874374517, 7579.431542634215, 6970.616616086164, 6977.33715297046, 6980.162380514371, 7018.2630823762765, 7049.753258635923, 5002.449730529712, 5066.161442871445, 5122.231665250242, 5139.280500729976, 5245.0, 4941.65408421407, 4968.776405061709, 5014.648974571745, 5165.018646457161, 5220.791168353223], "value": 4603.152878466249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.187564849549, 358.2762819105407, 360.54571240237294, 360.7655024234247, 365.29133481046784, 6416.326285739989, 6546.8690626187445, 6576.342365763428, 6614.239362473317, 6620.801375958717, 6425.678716064202, 6541.182352205974, 6541.738330466787, 6555.475561955044, 6577.276499585042, 4993.226049962262, 5000.649954503187, 5011.198208286675, 5026.52248036436, 5030.6981581105065, 5008.849734507952, 5035.269885866547, 5038.2190760432195, 5041.445441001505, 5051.116054690433, 4986.650934434573, 4993.325901003354, 4996.300517927493, 5000.224965130411, 5004.049230646184, 4793.352897358846, 4932.53140951609, 4986.975065124688, 4998.200287953928, 4998.5001499849905, 4291.635211007068, 4308.612224899743, 4313.82744690212, 4318.309070548728, 4321.416608757841, 6319.74721011159, 6329.905051424233, 6330.082138089997, 6349.174607301022, 6356.586821856565, 5792.507636850873, 5820.941790582082, 5831.883362332772, 5838.2118414013985, 5839.532837373, 6966.895496567556, 6967.651617419159, 6973.3375329343635, 6977.267386924351, 6988.61562614056, 4745.430548334188, 4817.3737414136285, 4822.011487645024, 4836.056968891067, 4903.411590609114, 7191.137063552407, 7246.565206087652, 7250.057492525938, 7284.235155308669, 7294.197638259734, 5004.624653150955, 5004.699718016931, 5012.649114562018, 5016.623753218523, 5027.82402615914, 5086.18621020635, 5087.97456012725, 5090.414602320707, 5094.6688465249645, 5113.590912726973, 5844.1233814927255, 5852.15143804146, 5854.268216472941, 5866.090755932837, 5869.765209391577, 6740.629265390353, 7019.052427922267, 7030.402415794612, 7062.6821793019435, 7064.894026589605, 1783.179737320821, 1791.9193636286398, 1795.721663142215, 1800.5048611631644, 1802.6755184066994, 1135.4890299365318, 1185.6739396665814, 1194.1939191046183, 1203.9879601203875, 1209.4920133543933, 6650.767223147167, 6699.497537684693, 6714.563553369113, 6718.932810671929, 6723.562968407038, 7176.102987126609, 7179.317964793337, 7184.856302874018, 7195.352418282379, 7197.640117994079, 6665.033570132304, 6702.497312701566, 6704.061431399608, 6704.329567043256, 6708.127943367331, 3868.8065596720053, 3884.6892248620043, 3896.337622604164, 3903.2583809076186, 3915.6671682906704, 7312.707491700273, 7597.658105385271, 7646.082470103512, 7653.966714493472, 7704.036995375578, 7485.47601667878, 7492.213317601682, 7515.849683006419, 7528.284812942762, 7529.924700752922, 7627.0, 7637.121731000895, 7638.923610763933, 7641.2740789626005, 7657.425693073042, 7215.170255420694, 7347.55914645123, 7349.30181632744, 7353.338199562065, 7357.558546487228, 7173.677184526813, 7184.820379490555, 7206.531575447579, 7226.891596625949, 7230.313120253568, 7561.3194812467145, 7578.204288549843, 7603.695852166073, 7617.200193979553, 7617.352525035212, 4857.854264372075, 4891.608671306358, 4894.730789806595, 4898.2652602109965, 4901.3383193268455, 7025.718971241093, 7339.192688804121, 7341.669624866787, 7346.77959661211, 7348.889766653398, 7089.503734738519, 7093.574385536885, 7113.928860711534, 7126.679299431642, 7128.215896251512, 7105.609191494517, 7106.857862842818, 7109.395701365235, 7116.323949224816, 7125.679344429617, 6995.090638217, 6995.370416662525, 7004.3696067354185, 7007.754728584679, 7022.0, 6985.987031880247, 7157.57054576727, 7171.175314838861, 7171.211166771755, 7182.712691492282, 6774.525783195129, 6968.616726079911, 6970.372666460043, 6986.54587451814, 6999.860002800017], "value": 5293.379488043102, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.1245223645766, 863.8747381629664, 866.1814585216971, 920.7836158502753, 945.1210374351855, 15590.220488975549, 15733.213339333044, 15798.131102789343, 15828.683426331481, 15839.287232074556, 16206.918965405157, 16303.347866085373, 16309.0, 16341.0, 16352.75470867938, 926.9675561355338, 939.8872135343769, 939.9859002114973, 942.9905700942971, 943.9480828554426, 802.7591722483261, 912.8219997100568, 928.8374534456477, 934.7943452440452, 935.5930170375874, 961.3558915526579, 973.522973742868, 977.8973207813184, 979.4074584876154, 980.4264505264429, 968.903109689029, 971.6453494474537, 974.0892265731563, 979.3536266064434, 982.6560703753629, 712.6294326949957, 719.7876626395226, 722.9421646268286, 723.1683563901503, 723.1791916175179, 15535.611609709735, 15723.05661660304, 15809.288582013722, 15818.209089545591, 15851.207439628088, 15156.772648410282, 15161.848381516264, 15190.620234494116, 15262.694746105126, 15273.312700928374, 11977.94011029948, 12151.392430378446, 12169.93915030428, 12222.449989750483, 12430.689232769253, 4007.83968641254, 4012.057166565855, 4030.8186131624147, 4067.613576710208, 4068.5321188063454, 56786.0, 57815.0, 58058.0, 58431.70784146094, 61062.0, 11654.825177622342, 11797.351145686898, 12071.939640301742, 12104.213226140273, 12145.392730363623, 20796.27213047536, 20843.58312833765, 20877.26929557458, 20926.790732092486, 20944.47638809042, 8856.468611883307, 8893.377463577488, 8949.463032218087, 8998.055204203465, 9262.166405023445, 5176.2494438306985, 5210.47895210476, 5227.503387178288, 5296.867578310496, 5302.946970530245, 3707.1102935295335, 3799.772013679188, 3800.201957588882, 3802.2585595809105, 3812.790296533717, 675.2032601530242, 675.5037591734332, 681.3186813186813, 688.4148473797233, 710.8080818179062, 793.1525822297978, 813.9511629302142, 829.9377546683902, 838.576518857985, 840.2521755637488, 10114.797704046025, 10186.64346747875, 10271.178305735522, 10567.788644227072, 10589.947050264853, 643.1542521584196, 730.5835673666065, 786.4966421490251, 792.7304716396453, 802.06959926485, 4638.8608341749805, 4678.60231880294, 4724.905501889943, 4775.474697783241, 4832.251001094836, 69828.0, 70052.64973675099, 70193.29806701868, 71079.0, 71522.0, 60986.695066524386, 61511.6924415375, 61698.69150654218, 62027.6898615504, 62080.06879896805, 55610.16584751232, 55933.0, 56116.71941640266, 56265.43734562684, 56542.151867722016, 8979.416337938013, 9278.814423711623, 9634.325597208128, 9641.566129524328, 9681.128698417177, 41114.58885411227, 41716.0, 41973.0, 42333.788331058146, 42403.7879810599, 46954.0, 47471.52528474671, 52597.7370113147, 53433.7328313356, 54369.184462232304, 11391.601293954673, 11478.655640330804, 11981.15705286717, 12096.878771858186, 12161.574344897886, 12329.121995934625, 12490.500379984698, 12883.227006379648, 12995.220286782824, 13054.869451305365, 12383.876161238271, 12688.375804119158, 12731.108822382716, 12889.09776315649, 12996.155249908727, 12436.564720234748, 12589.0, 12648.43082061291, 13004.349782511026, 13043.608691739262, 12312.384380780746, 12332.19840710351, 12349.444275007467, 12787.29669868129, 13133.212007279593, 9492.477913714813, 9976.950115249667, 10450.581976720847, 11331.603393881174, 11348.546058157912, 10839.458027098455, 11060.834087488854, 11135.443227838738, 11275.548978040786, 11446.484908179318], "value": 7347.099119795817, "unit": "score"}], "name": "dromaeo_css", "value": 7644.687641613622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 107.0, 111.0, 112.0, 114.0, 100.0, 110.0, 112.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 130.0, 155.0, 182.0, 130.0, 156.0, 152.0, 128.0, 189.0, 135.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 163.0, 161.0, 163.0, 163.0, 162.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 175.0, 77.0, 76.0, 75.0, 75.0, 159.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 159.0, 93.0, 92.0, 92.0, 149.0, 92.0, 92.0, 145.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 152.0, 148.0, 147.0, 146.0, 147.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 53.0, 54.0, 57.0, 55.0, 58.0, 69.0, 53.0, 53.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 58.0, 60.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 75.0, 77.0, 75.0, 83.0, 76.0, 76.0, 76.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 125.0, 128.0, 126.0, 117.0, 128.0, 115.0, 113.0, 132.0, 134.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 162.0, 162.0, 169.0, 178.0, 161.0, 165.0, 160.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 66.0, 68.0, 74.0, 70.0, 67.0, 67.0, 68.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1538.1, "alertThreshold": 2.0}]} 20:27:02 INFO - Return code: 0 20:27:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:27:02 ERROR - # TBPL SUCCESS # 20:27:02 INFO - Running post-action listener: _resource_record_post_action 20:27:02 INFO - Running post-run listener: _resource_record_post_run 20:27:03 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 28672; Write bytes: 463933440; Read time: 20; Write time: 311176 20:27:03 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 198828032; Read time: 0; Write time: 198636 20:27:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221421568; Read time: 8; Write time: 104648 20:27:03 INFO - Running post-run listener: _upload_blobber_files 20:27:03 INFO - Blob upload gear active. 20:27:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:03 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 20:27:03 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'] 20:27:03 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 20:27:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:04 INFO - (blobuploader) - INFO - Done attempting. 20:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:05 INFO - (blobuploader) - INFO - Done attempting. 20:27:05 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:05 INFO - Return code: 0 20:27:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68b8e40c2affe63b1b514319e83b79dbf85279bdde081d0c29a76aefa8be4f7c5c46b48f52816d15faa8a9fb106f39703d0afbe50324557f746d99b3766a4086", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24fa880eb4ad2964d4e3ad871bb99d8948b2834ec9ed2b660627a9c200d5633e14527da4a888a4ce0ed67a6a958d7da95fc23e136e066dc50a59ecc5ef1af9cd"} 20:27:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:05 INFO - Contents: 20:27:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68b8e40c2affe63b1b514319e83b79dbf85279bdde081d0c29a76aefa8be4f7c5c46b48f52816d15faa8a9fb106f39703d0afbe50324557f746d99b3766a4086", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24fa880eb4ad2964d4e3ad871bb99d8948b2834ec9ed2b660627a9c200d5633e14527da4a888a4ce0ed67a6a958d7da95fc23e136e066dc50a59ecc5ef1af9cd"} 20:27:05 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:05 INFO - Copying logs to upload dir... 20:27:05 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.868985 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-04 20:27:04.845936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 20:27:04.849456) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193 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/68b8e40c2affe63b1b514319e83b79dbf85279bdde081d0c29a76aefa8be4f7c5c46b48f52816d15faa8a9fb106f39703d0afbe50324557f746d99b3766a4086", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24fa880eb4ad2964d4e3ad871bb99d8948b2834ec9ed2b660627a9c200d5633e14527da4a888a4ce0ed67a6a958d7da95fc23e136e066dc50a59ecc5ef1af9cd"} build_url:https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/fKXXGT0SQDqNk2NSznN49Q/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/68b8e40c2affe63b1b514319e83b79dbf85279bdde081d0c29a76aefa8be4f7c5c46b48f52816d15faa8a9fb106f39703d0afbe50324557f746d99b3766a4086", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24fa880eb4ad2964d4e3ad871bb99d8948b2834ec9ed2b660627a9c200d5633e14527da4a888a4ce0ed67a6a958d7da95fc23e136e066dc50a59ecc5ef1af9cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 20:27:04.874604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 20:27:04.874893) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467676029.473603-1264216193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 20:27:04.957777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 20:27:04.958103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 20:27:04.958386) ========= ========= Total master_lag: 0.17 =========