builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1463282189.08 results: success (0) buildid: 20160514172927 builduid: fe204d59909d4d6db640a19d5da4b4ae revision: f91af8c3595bdc4f79deec29119216460bf0f0c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.079500) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.080159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.080424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.117281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.117600) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 20:16:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-05-14 20:16:29 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.351215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.483995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.484603) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.535256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:29.535607) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f91af8c3595bdc4f79deec29119216460bf0f0c0 --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 f91af8c3595bdc4f79deec29119216460bf0f0c0 --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=c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 20:16:29,799 truncating revision to first 12 chars 2016-05-14 20:16:29,799 Setting DEBUG logging. 2016-05-14 20:16:29,799 attempt 1/10 2016-05-14 20:16:29,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f91af8c3595b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 20:16:30,092 unpacking tar archive at: mozilla-beta-f91af8c3595b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:30.190860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:30.191214) ========= script_repo_revision: f91af8c3595bdc4f79deec29119216460bf0f0c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:30.191606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:30.191869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 20:16:30.201629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-14 20:16:30.202049) ========= /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=c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:16:30 INFO - MultiFileLogger online at 20160514 20:16:30 in /builds/slave/test 20:16:30 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:16:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:30 INFO - {'append_to_log': False, 20:16:30 INFO - 'base_work_dir': '/builds/slave/test', 20:16:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:16:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:30 INFO - 'branch': 'Mozilla-Beta', 20:16:30 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:30 INFO - 'config_files': ('talos/linux_config.py',), 20:16:30 INFO - 'default_actions': ('clobber', 20:16:30 INFO - 'read-buildbot-config', 20:16:30 INFO - 'download-and-extract', 20:16:30 INFO - 'populate-webroot', 20:16:30 INFO - 'create-virtualenv', 20:16:30 INFO - 'install', 20:16:30 INFO - 'run-tests'), 20:16:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:30 INFO - 'download_minidump_stackwalk': True, 20:16:30 INFO - 'download_symbols': 'ondemand', 20:16:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:30 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:30 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:30 INFO - 'installer_path': 'installer.exe', 20:16:30 INFO - 'log_level': 'info', 20:16:30 INFO - 'log_name': 'talos', 20:16:30 INFO - 'log_to_console': True, 20:16:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:16:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:16:30 INFO - 'opt_config_files': (), 20:16:30 INFO - 'pip_index': False, 20:16:30 INFO - 'sps_profile': False, 20:16:30 INFO - 'sps_profile_interval': 0, 20:16:30 INFO - 'suite': 'dromaeojs-e10s', 20:16:30 INFO - 'system_bits': '32', 20:16:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:30 INFO - 'title': 'talos-linux64-ix-004', 20:16:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:30 INFO - 'use_talos_json': True, 20:16:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:30 INFO - 'work_dir': 'build'} 20:16:30 INFO - ##### 20:16:30 INFO - ##### Running clobber step. 20:16:30 INFO - ##### 20:16:30 INFO - Running pre-action listener: _resource_record_pre_action 20:16:30 INFO - Running main action method: clobber 20:16:30 INFO - rmtree: /builds/slave/test/build 20:16:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:31 INFO - Running post-action listener: _resource_record_post_action 20:16:31 INFO - ##### 20:16:31 INFO - ##### Running read-buildbot-config step. 20:16:31 INFO - ##### 20:16:31 INFO - Running pre-action listener: _resource_record_pre_action 20:16:31 INFO - Running main action method: read_buildbot_config 20:16:31 INFO - Using buildbot properties: 20:16:31 INFO - { 20:16:31 INFO - "project": "", 20:16:31 INFO - "product": "firefox", 20:16:31 INFO - "script_repo_revision": "production", 20:16:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 20:16:31 INFO - "repository": "", 20:16:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 20:16:31 INFO - "buildid": "20160514172927", 20:16:31 INFO - "pgo_build": "True", 20:16:31 INFO - "basedir": "/builds/slave/test", 20:16:31 INFO - "buildnumber": 101, 20:16:31 INFO - "slavename": "talos-linux64-ix-004", 20:16:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:16:31 INFO - "platform": "ubuntu64_hw", 20:16:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:16:31 INFO - "branch": "mozilla-beta", 20:16:31 INFO - "repo_path": "releases/mozilla-beta", 20:16:31 INFO - "revision": "f91af8c3595bdc4f79deec29119216460bf0f0c0", 20:16:31 INFO - "stage_platform": "linux64-pgo", 20:16:31 INFO - "builduid": "fe204d59909d4d6db640a19d5da4b4ae", 20:16:31 INFO - "slavebuilddir": "test" 20:16:31 INFO - } 20:16:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 20:16:31 INFO - Running post-action listener: _resource_record_post_action 20:16:31 INFO - ##### 20:16:31 INFO - ##### Running download-and-extract step. 20:16:31 INFO - ##### 20:16:31 INFO - Running pre-action listener: _resource_record_pre_action 20:16:31 INFO - Running main action method: download_and_extract 20:16:31 INFO - mkdir: /builds/slave/test/build/tests 20:16: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:16:31 INFO - https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 20:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 20:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 20:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:16:34 INFO - Downloaded 1412 bytes. 20:16:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 20:16:34 INFO - Using the following test package requirements: 20:16:34 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 20:16:34 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:16:34 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 20:16:34 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'jsshell-linux-x86_64.zip'], 20:16:34 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:16:34 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 20:16:34 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 20:16:34 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 20:16:34 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:16:34 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 20:16:34 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 20:16:34 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:16:34 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:16:34 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:16:34 INFO - https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 20:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 20:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 20:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:35 INFO - Downloaded 23364687 bytes. 20:16:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:16:36 INFO - Return code: 0 20:16:36 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:16: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:16:36 INFO - https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 20:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 20:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 20:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:40 INFO - Downloaded 23364687 bytes. 20:16:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:16:41 INFO - Return code: 0 20:16: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:16:41 INFO - https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 20:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 20:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 20:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:16:43 INFO - Downloaded 10845194 bytes. 20:16:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:16:43 INFO - Return code: 0 20:16: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:16:43 INFO - https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 20:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 20:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 20:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:16:44 INFO - Downloaded 53795040 bytes. 20:16:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 20:16:44 INFO - mkdir: /builds/slave/test/properties 20:16:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:44 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:44 INFO - Contents: 20:16:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 20:16:45 INFO - Running post-action listener: _resource_record_post_action 20:16:45 INFO - Running post-action listener: set_extra_try_arguments 20:16:45 INFO - ##### 20:16:45 INFO - ##### Running populate-webroot step. 20:16:45 INFO - ##### 20:16:45 INFO - Running pre-action listener: _resource_record_pre_action 20:16:45 INFO - Running main action method: populate_webroot 20:16:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:45 INFO - '--tppagecycles', 20:16:45 INFO - '7'], 20:16:45 INFO - 'tests': ['tsvgm']}}, 20:16:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:16:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:16:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'tests': ['damp', 'tps']}, 20:16:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['damp', 'tps']}, 20:16:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:16:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:45 INFO - 'other': {'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other_l64': {'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'other_nol64': {'tests': ['a11yr', 20:16:45 INFO - 'ts_paint', 20:16:45 INFO - 'tpaint', 20:16:45 INFO - 'sessionrestore', 20:16:45 INFO - 'sessionrestore_no_auto_restore', 20:16:45 INFO - 'tabpaint']}, 20:16:45 INFO - 'svgr': {'tests': ['tsvgx', 20:16:45 INFO - 'tsvgr_opacity', 20:16:45 INFO - 'tart', 20:16:45 INFO - 'tscrollx', 20:16:45 INFO - 'cart']}, 20:16:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['tsvgx', 20:16:45 INFO - 'tsvgr_opacity', 20:16:45 INFO - 'tart', 20:16:45 INFO - 'tscrollx', 20:16:45 INFO - 'cart']}, 20:16:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'tests': ['tp5o']}, 20:16:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--e10s'], 20:16:45 INFO - 'tests': ['tp5o']}, 20:16:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--xperf_path', 20:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:45 INFO - 'tests': ['tp5n']}, 20:16:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:45 INFO - 'talos_options': ['--e10s', 20:16:45 INFO - '--xperf_path', 20:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:45 INFO - 'tests': ['tp5n']}}, 20:16:45 INFO - 'talos.zip': {'path': '', 20:16:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:45 INFO - Running post-action listener: _resource_record_post_action 20:16:45 INFO - ##### 20:16:45 INFO - ##### Running create-virtualenv step. 20:16:45 INFO - ##### 20:16:45 INFO - Running pre-action listener: _resource_record_pre_action 20:16:45 INFO - Running main action method: create_virtualenv 20:16:45 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:45 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:16:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:45 INFO - Using real prefix '/usr' 20:16:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:47 INFO - Installing pip.................done. 20:16:47 INFO - Return code: 0 20:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:47 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:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:47 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:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:47 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:16:47 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:16:47 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:16:47 INFO - Using env: {'DISPLAY': ':0', 20:16:47 INFO - 'HOME': '/home/cltbld', 20:16:47 INFO - 'LANG': 'en_US.UTF-8', 20:16:47 INFO - 'LANGUAGE': 'en_US:en', 20:16:47 INFO - 'LOGNAME': 'cltbld', 20:16:47 INFO - 'MAIL': '/var/mail/cltbld', 20:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:47 INFO - 'MOZ_NO_REMOTE': '1', 20:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:47 INFO - 'NO_EM_RESTART': '1', 20:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:47 INFO - 'PWD': '/builds/slave/test', 20:16:47 INFO - 'SHELL': '/bin/bash', 20:16:47 INFO - 'SHLVL': '1', 20:16:47 INFO - 'TERM': 'linux', 20:16:47 INFO - 'TMOUT': '86400', 20:16:47 INFO - 'USER': 'cltbld', 20:16:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:47 INFO - '_': '/tools/buildbot/bin/python'} 20:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:48 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:16:48 INFO - Cleaning up... 20:16:48 INFO - Return code: 0 20:16:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:16:48 INFO - Using env: {'DISPLAY': ':0', 20:16:48 INFO - 'HOME': '/home/cltbld', 20:16:48 INFO - 'LANG': 'en_US.UTF-8', 20:16:48 INFO - 'LANGUAGE': 'en_US:en', 20:16:48 INFO - 'LOGNAME': 'cltbld', 20:16:48 INFO - 'MAIL': '/var/mail/cltbld', 20:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:48 INFO - 'MOZ_NO_REMOTE': '1', 20:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:48 INFO - 'NO_EM_RESTART': '1', 20:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:48 INFO - 'PWD': '/builds/slave/test', 20:16:48 INFO - 'SHELL': '/bin/bash', 20:16:48 INFO - 'SHLVL': '1', 20:16:48 INFO - 'TERM': 'linux', 20:16:48 INFO - 'TMOUT': '86400', 20:16:48 INFO - 'USER': 'cltbld', 20:16:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:48 INFO - '_': '/tools/buildbot/bin/python'} 20:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:48 INFO - Downloading/unpacking psutil>=0.7.1 20:16:48 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:16:48 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:16:48 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:16:48 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:16:48 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:16:48 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:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:50 INFO - Installing collected packages: psutil 20:16:50 INFO - Running setup.py install for psutil 20:16:50 INFO - building 'psutil._psutil_linux' extension 20:16:50 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:16:50 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:16:50 INFO - building 'psutil._psutil_posix' extension 20:16:50 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:16:50 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:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:50 INFO - Successfully installed psutil 20:16:50 INFO - Cleaning up... 20:16:50 INFO - Return code: 0 20:16:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:16:50 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:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:50 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:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:50 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:16:50 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:16:50 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:16:50 INFO - Using env: {'DISPLAY': ':0', 20:16:50 INFO - 'HOME': '/home/cltbld', 20:16:50 INFO - 'LANG': 'en_US.UTF-8', 20:16:50 INFO - 'LANGUAGE': 'en_US:en', 20:16:50 INFO - 'LOGNAME': 'cltbld', 20:16:50 INFO - 'MAIL': '/var/mail/cltbld', 20:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:50 INFO - 'MOZ_NO_REMOTE': '1', 20:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:50 INFO - 'NO_EM_RESTART': '1', 20:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:50 INFO - 'PWD': '/builds/slave/test', 20:16:50 INFO - 'SHELL': '/bin/bash', 20:16:50 INFO - 'SHLVL': '1', 20:16:50 INFO - 'TERM': 'linux', 20:16:50 INFO - 'TMOUT': '86400', 20:16:50 INFO - 'USER': 'cltbld', 20:16:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:50 INFO - '_': '/tools/buildbot/bin/python'} 20:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:52 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:16:52 INFO - Installing collected packages: mozsystemmonitor 20:16:52 INFO - Running setup.py install for mozsystemmonitor 20:16:52 INFO - Successfully installed mozsystemmonitor 20:16:52 INFO - Cleaning up... 20:16:53 INFO - Return code: 0 20:16:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16:53 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:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:53 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:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:53 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:16:53 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:16:53 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:16:53 INFO - Using env: {'DISPLAY': ':0', 20:16:53 INFO - 'HOME': '/home/cltbld', 20:16:53 INFO - 'LANG': 'en_US.UTF-8', 20:16:53 INFO - 'LANGUAGE': 'en_US:en', 20:16:53 INFO - 'LOGNAME': 'cltbld', 20:16:53 INFO - 'MAIL': '/var/mail/cltbld', 20:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:53 INFO - 'MOZ_NO_REMOTE': '1', 20:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:53 INFO - 'NO_EM_RESTART': '1', 20:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:53 INFO - 'PWD': '/builds/slave/test', 20:16:53 INFO - 'SHELL': '/bin/bash', 20:16:53 INFO - 'SHLVL': '1', 20:16:53 INFO - 'TERM': 'linux', 20:16:53 INFO - 'TMOUT': '86400', 20:16:53 INFO - 'USER': 'cltbld', 20:16:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:53 INFO - '_': '/tools/buildbot/bin/python'} 20:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 INFO - Downloading docopt-0.6.1.tar.gz 20:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:55 INFO - Running setup.py install for blobuploader 20:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:55 INFO - Running setup.py install for requests 20:16:56 INFO - Running setup.py install for docopt 20:16:56 INFO - Successfully installed blobuploader requests docopt 20:16:56 INFO - Cleaning up... 20:16:56 INFO - Return code: 0 20:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:56 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:16:56 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:16:56 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:16:56 INFO - Using env: {'DISPLAY': ':0', 20:16:56 INFO - 'HOME': '/home/cltbld', 20:16:56 INFO - 'LANG': 'en_US.UTF-8', 20:16:56 INFO - 'LANGUAGE': 'en_US:en', 20:16:56 INFO - 'LOGNAME': 'cltbld', 20:16:56 INFO - 'MAIL': '/var/mail/cltbld', 20:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:56 INFO - 'MOZ_NO_REMOTE': '1', 20:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:56 INFO - 'NO_EM_RESTART': '1', 20:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:56 INFO - 'PWD': '/builds/slave/test', 20:16:56 INFO - 'SHELL': '/bin/bash', 20:16:56 INFO - 'SHLVL': '1', 20:16:56 INFO - 'TERM': 'linux', 20:16:56 INFO - 'TMOUT': '86400', 20:16:56 INFO - 'USER': 'cltbld', 20:16:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:56 INFO - '_': '/tools/buildbot/bin/python'} 20:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:56 INFO - Running setup.py (path:/tmp/pip-RI7TR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:56 INFO - Running setup.py (path:/tmp/pip-m86e_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:56 INFO - Running setup.py (path:/tmp/pip-wtUsrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:56 INFO - Running setup.py (path:/tmp/pip-Om2PoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:56 INFO - Running setup.py (path:/tmp/pip-5GphtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:57 INFO - Running setup.py (path:/tmp/pip-PSCKeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:57 INFO - Running setup.py (path:/tmp/pip-7QsgwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:57 INFO - Running setup.py (path:/tmp/pip-o3X6N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:57 INFO - Running setup.py (path:/tmp/pip-GvaHSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:57 INFO - Running setup.py (path:/tmp/pip-uRLZYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:57 INFO - Running setup.py (path:/tmp/pip-IM9vOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:57 INFO - Running setup.py (path:/tmp/pip-HfE3AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:57 INFO - Running setup.py (path:/tmp/pip-pwP824-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:57 INFO - Running setup.py (path:/tmp/pip-r1q6Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:57 INFO - Running setup.py (path:/tmp/pip-6iyKYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:57 INFO - Running setup.py (path:/tmp/pip-6aDYAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:57 INFO - Running setup.py (path:/tmp/pip-nEwROu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:57 INFO - Running setup.py install for manifestparser 20:16:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozcrash 20:16:58 INFO - Running setup.py install for mozdebug 20:16:58 INFO - Running setup.py install for mozdevice 20:16:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozfile 20:16:58 INFO - Running setup.py install for mozhttpd 20:16:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozinfo 20:16:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozInstall 20:16:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozleak 20:16:58 INFO - Running setup.py install for mozlog 20:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for moznetwork 20:16:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Running setup.py install for mozprocess 20:16:59 INFO - Running setup.py install for mozprofile 20:16:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Running setup.py install for mozrunner 20:16:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Running setup.py install for mozscreenshot 20:16:59 INFO - Running setup.py install for moztest 20:16:59 INFO - Running setup.py install for mozversion 20:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:59 INFO - Cleaning up... 20:16:59 INFO - Return code: 0 20:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:59 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:16:59 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:16:59 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:16:59 INFO - Using env: {'DISPLAY': ':0', 20:16:59 INFO - 'HOME': '/home/cltbld', 20:16:59 INFO - 'LANG': 'en_US.UTF-8', 20:16:59 INFO - 'LANGUAGE': 'en_US:en', 20:16:59 INFO - 'LOGNAME': 'cltbld', 20:16:59 INFO - 'MAIL': '/var/mail/cltbld', 20:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:59 INFO - 'MOZ_NO_REMOTE': '1', 20:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:59 INFO - 'NO_EM_RESTART': '1', 20:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:59 INFO - 'PWD': '/builds/slave/test', 20:16:59 INFO - 'SHELL': '/bin/bash', 20:16:59 INFO - 'SHLVL': '1', 20:16:59 INFO - 'TERM': 'linux', 20:16:59 INFO - 'TMOUT': '86400', 20:16:59 INFO - 'USER': 'cltbld', 20:16:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:59 INFO - '_': '/tools/buildbot/bin/python'} 20:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:59 INFO - Running setup.py (path:/tmp/pip-L3t9Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:00 INFO - Running setup.py (path:/tmp/pip-WqJr3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:00 INFO - Running setup.py (path:/tmp/pip-QkJrTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:00 INFO - Running setup.py (path:/tmp/pip-rDhjPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:00 INFO - Running setup.py (path:/tmp/pip-qRYv4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:00 INFO - Running setup.py (path:/tmp/pip-4glf7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:00 INFO - Running setup.py (path:/tmp/pip-MPNbch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:00 INFO - Running setup.py (path:/tmp/pip-Eo1kHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:00 INFO - Running setup.py (path:/tmp/pip-YDyqY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:00 INFO - Running setup.py (path:/tmp/pip-55vVmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:00 INFO - Running setup.py (path:/tmp/pip-LRDffL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:00 INFO - Running setup.py (path:/tmp/pip-XIHffd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:00 INFO - Running setup.py (path:/tmp/pip-gcphpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:00 INFO - Running setup.py (path:/tmp/pip-vKM3Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:00 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:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:00 INFO - Running setup.py (path:/tmp/pip-JvxK7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:01 INFO - Running setup.py (path:/tmp/pip-wjya7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:01 INFO - Running setup.py (path:/tmp/pip-YopNvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:01 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:17:01 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:17:01 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:17:01 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:17:01 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:17:01 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:17:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17: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:17: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:17: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:17: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:17: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:17: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:17:03 INFO - Downloading blessings-1.6.tar.gz 20:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:17:03 INFO - Installing collected packages: blessings 20:17:03 INFO - Running setup.py install for blessings 20:17:03 INFO - Successfully installed blessings 20:17:03 INFO - Cleaning up... 20:17:03 INFO - Return code: 0 20:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:03 INFO - Reading from file tmpfile_stdout 20:17:03 INFO - Current package versions: 20:17:03 INFO - argparse == 1.2.1 20:17:03 INFO - blessings == 1.6 20:17:03 INFO - blobuploader == 1.2.4 20:17:03 INFO - docopt == 0.6.1 20:17:03 INFO - manifestparser == 1.1 20:17:03 INFO - mozInstall == 1.12 20:17:03 INFO - mozcrash == 0.17 20:17:03 INFO - mozdebug == 0.1 20:17:03 INFO - mozdevice == 0.48 20:17:03 INFO - mozfile == 1.2 20:17:03 INFO - mozhttpd == 0.7 20:17:03 INFO - mozinfo == 0.9 20:17:03 INFO - mozleak == 0.1 20:17:03 INFO - mozlog == 3.1 20:17:03 INFO - moznetwork == 0.27 20:17:03 INFO - mozprocess == 0.22 20:17:03 INFO - mozprofile == 0.28 20:17:03 INFO - mozrunner == 6.11 20:17:03 INFO - mozscreenshot == 0.1 20:17:03 INFO - mozsystemmonitor == 0.0 20:17:03 INFO - moztest == 0.7 20:17:03 INFO - mozversion == 1.4 20:17:03 INFO - psutil == 3.1.1 20:17:03 INFO - requests == 1.2.3 20:17:03 INFO - wsgiref == 0.1.2 20:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:03 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:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:17:03 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:17:03 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:17:03 INFO - Using env: {'DISPLAY': ':0', 20:17:03 INFO - 'HOME': '/home/cltbld', 20:17:03 INFO - 'LANG': 'en_US.UTF-8', 20:17:03 INFO - 'LANGUAGE': 'en_US:en', 20:17:03 INFO - 'LOGNAME': 'cltbld', 20:17:03 INFO - 'MAIL': '/var/mail/cltbld', 20:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:03 INFO - 'MOZ_NO_REMOTE': '1', 20:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:03 INFO - 'NO_EM_RESTART': '1', 20:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:03 INFO - 'PWD': '/builds/slave/test', 20:17:03 INFO - 'SHELL': '/bin/bash', 20:17:03 INFO - 'SHLVL': '1', 20:17:03 INFO - 'TERM': 'linux', 20:17:03 INFO - 'TMOUT': '86400', 20:17:03 INFO - 'USER': 'cltbld', 20:17:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:03 INFO - '_': '/tools/buildbot/bin/python'} 20:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:03 INFO - Cleaning up... 20:17:03 INFO - Return code: 0 20:17:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:17:03 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:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:17:03 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:17:03 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:17:03 INFO - Using env: {'DISPLAY': ':0', 20:17:03 INFO - 'HOME': '/home/cltbld', 20:17:03 INFO - 'LANG': 'en_US.UTF-8', 20:17:03 INFO - 'LANGUAGE': 'en_US:en', 20:17:03 INFO - 'LOGNAME': 'cltbld', 20:17:03 INFO - 'MAIL': '/var/mail/cltbld', 20:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:03 INFO - 'MOZ_NO_REMOTE': '1', 20:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:03 INFO - 'NO_EM_RESTART': '1', 20:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:03 INFO - 'PWD': '/builds/slave/test', 20:17:03 INFO - 'SHELL': '/bin/bash', 20:17:03 INFO - 'SHLVL': '1', 20:17:03 INFO - 'TERM': 'linux', 20:17:03 INFO - 'TMOUT': '86400', 20:17:03 INFO - 'USER': 'cltbld', 20:17:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:03 INFO - '_': '/tools/buildbot/bin/python'} 20:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:03 INFO - Downloading/unpacking jsonschema 20:17: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:17: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:17: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:17: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:17: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:17: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:17:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:17:05 INFO - Downloading/unpacking functools32 (from jsonschema) 20:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:06 INFO - Downloading functools32-3.2.3-2.tar.gz 20:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:17:06 INFO - warning: no files found matching '*.txt' 20:17:06 INFO - no previously-included directories found matching 'build' 20:17:06 INFO - no previously-included directories found matching 'dist' 20:17:06 INFO - no previously-included directories found matching '.git*' 20:17:06 INFO - Installing collected packages: jsonschema, functools32 20:17:06 INFO - Running setup.py install for functools32 20:17:06 INFO - warning: no files found matching '*.txt' 20:17:06 INFO - no previously-included directories found matching 'build' 20:17:06 INFO - no previously-included directories found matching 'dist' 20:17:06 INFO - no previously-included directories found matching '.git*' 20:17:06 INFO - Successfully installed jsonschema functools32 20:17:06 INFO - Cleaning up... 20:17:06 INFO - Return code: 0 20:17:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:17:06 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:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:06 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:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:06 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 0x7fb5dbe76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', '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:17:06 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:17:06 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:17:06 INFO - Using env: {'DISPLAY': ':0', 20:17:06 INFO - 'HOME': '/home/cltbld', 20:17:06 INFO - 'LANG': 'en_US.UTF-8', 20:17:06 INFO - 'LANGUAGE': 'en_US:en', 20:17:06 INFO - 'LOGNAME': 'cltbld', 20:17:06 INFO - 'MAIL': '/var/mail/cltbld', 20:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:06 INFO - 'MOZ_NO_REMOTE': '1', 20:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:06 INFO - 'NO_EM_RESTART': '1', 20:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:06 INFO - 'PWD': '/builds/slave/test', 20:17:06 INFO - 'SHELL': '/bin/bash', 20:17:06 INFO - 'SHLVL': '1', 20:17:06 INFO - 'TERM': 'linux', 20:17:06 INFO - 'TMOUT': '86400', 20:17:06 INFO - 'USER': 'cltbld', 20:17:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:06 INFO - '_': '/tools/buildbot/bin/python'} 20:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:06 INFO - Downloading/unpacking flake8 20:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:17:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:17:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:17:09 INFO - no previously-included directories found matching 'docs/_build' 20:17:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:17:09 INFO - Running setup.py install for pep8 20:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:17:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:17:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:17:09 INFO - no previously-included directories found matching 'docs/_build' 20:17:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:17:09 INFO - Cleaning up... 20:17:09 INFO - Return code: 0 20:17:09 INFO - Running post-action listener: _resource_record_post_action 20:17:09 INFO - Running post-action listener: _start_resource_monitoring 20:17:09 INFO - Starting resource monitoring. 20:17:09 INFO - ##### 20:17:09 INFO - ##### Running install step. 20:17:09 INFO - ##### 20:17:09 INFO - Running pre-action listener: _resource_record_pre_action 20:17:09 INFO - Running main action method: install 20:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:09 INFO - Reading from file tmpfile_stdout 20:17:09 INFO - Detecting whether we're running mozinstall >=1.0... 20:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:17:09 INFO - Reading from file tmpfile_stdout 20:17:09 INFO - Output received: 20:17:09 INFO - Usage: mozinstall [options] installer 20:17:09 INFO - Options: 20:17:09 INFO - -h, --help show this help message and exit 20:17:09 INFO - -d DEST, --destination=DEST 20:17:09 INFO - Directory to install application into. [default: 20:17:09 INFO - "/builds/slave/test"] 20:17:09 INFO - --app=APP Application being installed. [default: firefox] 20:17:09 INFO - mkdir: /builds/slave/test/build/application 20:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:17:22 INFO - Reading from file tmpfile_stdout 20:17:22 INFO - Output received: 20:17:22 INFO - /builds/slave/test/build/application/firefox/firefox 20:17:22 INFO - Running post-action listener: _resource_record_post_action 20:17:22 INFO - ##### 20:17:22 INFO - ##### Running run-tests step. 20:17:22 INFO - ##### 20:17:22 INFO - Running pre-action listener: _resource_record_pre_action 20:17:22 INFO - Running main action method: run_tests 20:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:22 INFO - Python 2.7.3 20:17:22 INFO - Return code: 0 20:17:22 INFO - grabbing minidump binary from tooltool 20:17:22 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:17:22 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 0x1b88160>, '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 0x1b89060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b894f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:22 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:17:22 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:17:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:22 INFO - Return code: 0 20:17:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:17:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:17:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:17:23 INFO - Return code: 0 20:17:23 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/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:17:23 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/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:17:23 INFO - Using env: {'DISPLAY': ':0', 20:17:23 INFO - 'HOME': '/home/cltbld', 20:17:23 INFO - 'LANG': 'en_US.UTF-8', 20:17:23 INFO - 'LANGUAGE': 'en_US:en', 20:17:23 INFO - 'LOGNAME': 'cltbld', 20:17:23 INFO - 'MAIL': '/var/mail/cltbld', 20:17:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:23 INFO - 'MOZ_NO_REMOTE': '1', 20:17:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:23 INFO - 'NO_EM_RESTART': '1', 20:17:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:23 INFO - 'PWD': '/builds/slave/test', 20:17:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:23 INFO - 'SHELL': '/bin/bash', 20:17:23 INFO - 'SHLVL': '1', 20:17:23 INFO - 'TERM': 'linux', 20:17:23 INFO - 'TMOUT': '86400', 20:17:23 INFO - 'USER': 'cltbld', 20:17:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210', 20:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:23 INFO - '_': '/tools/buildbot/bin/python'} 20:17:23 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/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:17:23 INFO - mozversion application_buildid: 20160514172927 20:17:23 INFO - mozversion application_changeset: f91af8c3595bdc4f79deec29119216460bf0f0c0 20:17:23 INFO - mozversion application_display_name: Firefox 20:17:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:23 INFO - mozversion application_name: Firefox 20:17:23 INFO - mozversion application_remotingname: firefox 20:17:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:17:23 INFO - mozversion application_vendor: Mozilla 20:17:23 INFO - mozversion application_version: 47.0 20:17:23 INFO - mozversion platform_buildid: 20160514172927 20:17:23 INFO - mozversion platform_changeset: f91af8c3595bdc4f79deec29119216460bf0f0c0 20:17:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:17:23 INFO - mozversion platform_version: 47.0 20:17:23 INFO - using testdate: 1463282243 20:17:23 INFO - actual date: 1463282243 20:17:23 INFO - starting webserver on 'localhost:37106' 20:17:23 INFO - SUITE-START | Running 2 tests 20:17:23 INFO - TEST-START | dromaeo_css 20:17:23 INFO - operating with platform_type : linux_ 20:17:23 INFO - Initialising browser for dromaeo_css test... 20:17:23 INFO - TEST-INFO | started process 13197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB6albV/profile http://localhost:37106/getInfo.html) 20:17:27 INFO - PROCESS | 13197 | 20:17:27 INFO - PROCESS | 13197 | (process:13273): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:28 INFO - PROCESS | 13197 | __metrics Screen width/height:1600/1200 20:17:28 INFO - PROCESS | 13197 | colorDepth:24 20:17:28 INFO - PROCESS | 13197 | Browser inner width/height: 1024/697 20:17:28 INFO - PROCESS | 13197 | __metrics 20:17:28 ERROR - PROCESS | 13197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 20:17:29 INFO - TEST-INFO | 13197: exit 0 20:17:29 INFO - Browser initialized. 20:17:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:29 INFO - TEST-INFO | started process 13323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB6albV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:31 INFO - PROCESS | 13323 | 20:17:31 INFO - PROCESS | 13323 | (process:13392): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:41 INFO - PROCESS | 13323 | RSS: Main: 149970944 20:17:41 INFO - PROCESS | 13323 | 20:18:31 INFO - PROCESS | 13323 | 1463282311164 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:20:39 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37106/tests/dromaeo/cssquery-ext.html) 20:20:40 INFO - PROCESS | 13323 | RSS: Main: 153939968 20:20:40 INFO - PROCESS | 13323 | 20:23:41 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-ext.html (next: http://localhost:37106/tests/dromaeo/cssquery-jquery.html) 20:23:42 INFO - PROCESS | 13323 | RSS: Main: 152567808 20:23:42 INFO - PROCESS | 13323 | 20:26:44 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37106/tests/dromaeo/cssquery-mootools.html) 20:26:44 INFO - PROCESS | 13323 | RSS: Main: 151703552 20:26:44 INFO - PROCESS | 13323 | 20:29:46 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37106/tests/dromaeo/cssquery-prototype.html) 20:29:47 INFO - PROCESS | 13323 | RSS: Main: 152604672 20:29:47 INFO - PROCESS | 13323 | 20:32:49 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37106/tests/dromaeo/cssquery-yui.html) 20:32:49 INFO - PROCESS | 13323 | RSS: Main: 151347200 20:32:49 INFO - PROCESS | 13323 | 20:35:51 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-yui.html (next: http://localhost:37106/tests/dromaeo/cssquery-dojo.html) 20:35:52 INFO - PROCESS | 13323 | RSS: Main: 155447296 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | __start_tp_report 20:35:52 INFO - PROCESS | 13323 | _x_x_mozilla_page_load 20:35:52 INFO - PROCESS | 13323 | _x_x_mozilla_page_load_details 20:35:52 INFO - PROCESS | 13323 | |i|pagename|runs| 20:35:52 INFO - PROCESS | 13323 | |0;dojo.html;3333.050080726993;3389.74576906732;3397.7621566490325;3440.6731360520757;3440.741944354174;5585.134304182848;5606.831795046145;5620.325560932689;5634.690092044936;5640.379558248595;5590.077637189859;5593.608447408683;5632.971835140829;5635.436456354362;5656.915146272799;5099.031184075023;5131.820386286481;5163.993021360836;5196.402413722432;5211.765470553834;5043.36957880265;5174.896502069956;5205.60957928155;5223.8432847014465;5224.555912747421;5200.167973124282;5200.661956972804;5207.6354655174155;5264.6051546134;5265.578753699695;5222.3472065991755;5238.68567885928;5251.2385704072885;5252.107141785906;5280.894382112375;4988.102141614508;5050.191969284933;5095.108356037678;5128.948710512885;5213.635045546814;5457.781688732446;5462.781488740446;5482.945170548283;5492.588055895823;5494.80768173112;6015.097735339734;6020.2775666919815;6025.668588227646;6045.72794224261;6052.394760523956;6045.33501314855;6054.485368743662;6064.787732429344;6076.726547305338;6099.57302988791;5669.291338582677;5672.06410942194;5673.120666296731;5673.716314184274;5694.2312787773535;5921.319048309413;6137.315698286963;6179.5056395488255;6185.938140618537;6197.938020619736;5874.353821079763;5880.294364676266;5880.294364676266;5888.823335299948;5936.495397891227;5968.910466343008;5969.403059693996;5974.462298393166;5978.402159784074;5986.700664966821;5790.913136302959;5792.88414231713;5828.242328497353;5867.031939729982;5939.316978547436;5987.880242395127;5988.131720900445;6016.578839481194;6020.849478763066;6043.305019922677;4576.771161441915;4589.5639914208095;4606.193916064675;4607.216773148572;4646.558576935186;4001.919961600752;4098.672106231495;4123.257813593522;4129.752214867118;4168.7707176105;5559.110542313291;5681.687507187145;5716.57125715573;5721.713914304351;5779.33537643168;6017.187679663277;6029.758809647653;6033.12519684652;6048.364921683248;6061.242344706911;5633.859153521113;5678.290213723285;5750.424957504216;5750.712464376765;5760.42395760429;5153.2785410042625;5175.378954525406;5178.663386879841;5180.948190518046;5189.844304670866;6231.626102433868;6233.438990490878;6237.844053898598;6240.906386404207;6267.71795269214;5845.766169353178;5921.644701317935;5925.200097986716;6019.127226552037;6060.606060606135;6206.968965155145;6258;6261.874762504815;6272.2159730033745;6272.5922815016875;5964.612300200647;5978.844702931421;5980.491658209101;5980.671063091398;5992.250968628921;5918.408159184047;5931.970340148272;5946.762129514771;6083.087536869505;6085.878282434238;5871.2073870027;5903.586748927705;5912.054071348563;5923.703814809156;5925.644461332334;5887.764489420375;5913.733881975408;5917.644941303535;5951.821445356646;5970.134330522137;5689.857753556194;5752.309722833287;5822.883542329045;5830.679312637845;5864.413558644272;5929.792457263975;5969.134475500941;6002.909956350745;6021.729022194099;6026.096085587197;5875.911861321998;5876.882462350814;5881.147233651182;5892.941070589411;5896.705164741831 20:35:52 INFO - PROCESS | 13323 | |1;ext.html;549.3545084525682;570.1846359705622;580.7618876260731;592.8280798568416;629.6599836088512;30630.23424414388;39543;40605.59394406055;40683.79658101709;40762;42520.78739606305;42927.14145717084;43047.784761076226;43106;43116.56883431165;8812.339074569401;9009.324300677443;9011.459312441242;9020;9026.909730902673;8819.51492667903;8933.419327743708;8937.865932011026;8967.910320896804;8980.820383592325;8874.2456891164;8932;8940.374173807804;8967.282617390592;9011.549422528848;8857.95571022144;9041.050689677588;9046.411983221102;9066.048064953216;9078.90921090794;9046.276297896153;9101.681441149529;9121.635134594608;9166.220871225954;9184;42707.57292427067;43388.78305608452;43413.56586434158;43500.56499435029;43621.78189109066;3663.1757854482794;3785.7539259948016;3786.0345611868797;3798.803035478265;3873.1866308075337;32706.509402358985;32737.508937365958;32897;33008.6699133008;34022.14944626404;3726.75776074557;3757.079515518715;3759.812009399519;3770.924581508382;3793.3172029034763;298517;298652;299324;299413;299590;47093.76453117713;47689.5231047692;63610;64346.35653643404;64478.677606612604;45265;45314.546854531036;45341.77329113399;45379.54620453753;45454.77272613616;16159.515214543582;16368.263428145761;16369.427070052729;16378.099204543865;16382;13598.864011359958;13624.114432561852;13631;13670.726585468235;13761.449542018207;15265.694686106215;15715;15727.135007574694;15731.4493992712;15793.526194214191;6016.608920420159;6044;6050.788222412194;6052.576319657582;6341.4292713656;1097.9560817567208;1133.994330028361;1171;1201.6094769200045;1228.7173949991552;30148.24629384283;30767.69232307693;30892.382152357277;30977.225569360497;31330.530042049388;1237.9071569632313;1238.5231685801032;1250.474800583739;1262.9368531573384;1272.866349033338;15795.684086318439;15916.283767230503;15960.441384551717;15981.60045998836;16250.024998500128;333605;526850;532110;840047;851873;56530.15204771932;57322.85354292974;57357.42642573604;57437.13844292339;57482.7125864368;1468.4786900650329;1506.0060360162458;1510.5392855179275;1538.5076775431978;1542.2288855572215;29571.704282956896;31690.683093169697;31818.84090579625;32283.031509054767;32661.836690817345;49997.25004125014;58957.705211473665;60808;61215.69392153011;61308.69345653243;304271;304723;305190;307821;308131;41941.790291048346;42140.367894482224;42289.57710422856;42482.15035699207;46518.302225465966;50632.493675062775;50882;50931.745341273054;51112.23331650103;52007;42714.78642606767;43387.56612433962;43577.78211108924;43578.78210609053;44820.32769508525;41570;42375.36436953386;43190.13619727651;43656;43656.47202347903;41909;42092.78953605212;42877.78561107175;43097.78451107725;43124.78437607792;36269.63730362662;37561.81219093996;38098.80950595229;38149.4277585842;38290.6170938287;28173.154805355873;28690;28704.569431458127;28737.712622873503;28803.855980719964 20:35:52 INFO - PROCESS | 13323 | |2;jquery.html;342.6847300483556;349.3711319624676;354.2065772669222;365.7384969746631;367.5717788776076;17223;17635.55911102223;18073.7288940666;18095.72856407155;18104.185311660975;17116.400925967595;17417.47747567575;18102.366417175403;18154.273829046822;18180;4970.826021089262;5593.664380137185;5593.804216852411;5607.775688972436;5610.018246806813;5522.861928451781;5615.522680572156;5618.12918997554;5620.241267428885;5623.437656234385;5239.711815850127;5313.1764576490705;5314.893702125955;5315.760790764425;5656.490915817576;5222.086134926372;5250.05499010178;5252.999999999981;5288.629795914288;5288.947110528903;5097.643164978453;5114.539691427789;5188.092083885305;5416.945830541723;5421.647592906488;14416.71166576673;14474.782878256834;14516.201608911506;19827;22118;2400.0279886645935;2427.2596857958315;2498;2531.240627811649;2958.378740464505;10004.649837255734;10241.487925603764;10273.911001409078;10475.738106547322;10523.631672891488;1924.951876203092;1955.7750858651295;1969.5371587676884;1973.1712680674152;1977.683570628707;56545;65675.67162164206;69737;74448;75452.24547754508;9655.855162172573;10115.494225288707;10437.530311136017;10703.357798532114;10759.139268858473;15029.398824047134;15096.39614415433;15132.167730774692;15155.772663410058;15209.771853422208;7736.6518506667335;7811.921880781233;7876.330511906437;7885.329746971457;7903.328217101496;7841.686332546634;8001.759947201594;8050.59747012647;8201.71294004707;8239.588020598947;4646.395968524071;4690.624750019991;4752.95247047532;4791.305260737174;4797.7601119943865;1998.8300994415638;2015.7782643909159;2018.8123401773516;2021.8584699070923;2024.8582599218207;1073.8926107389354;1103.933763974164;1117.474786850179;1119.6361182615683;1144.2848219862585;17316;17485.912570437067;17566.209520571603;17807.910960445115;18137.18382672783;1007.773251018515;1017.0897047142765;1030.1449796668746;1062.6865074802952;1063.1601035182275;9911.900880991241;10096.34373765703;10136.746581335525;10167.796644067224;10300.381977081399;464843;467233;478339;483862;495994;74987.62506187434;78432.60783696045;80882.19117808864;80905.59547202227;82825;1078.8166011778017;1079.0504356166523;1079.7246702090918;1092.3445932440632;1109.995454114028;15615.531534053996;15690;15789.289481973108;16009.679806403574;16189.919050405144;34323.14192145217;34512.30975380528;34960.30079398449;35513;35839.64160358363;49875;50928.74535627298;51074.48925510697;51230;52294;8396.538190399586;8716.91283087161;8866.290696744116;8929.821403572023;9105.362624616213;11474.196806223485;13521.391537380645;13574.524891628746;13692.931535342259;13712.93143534276;11554.191206615456;11621.47703353368;11942.554799697533;11996.100292477924;12206.145569810027;11592.420378980849;11625.302481851117;11662.475188616701;11713.121515886172;11767.176297659424;12064.698382540155;12081.818772718592;12323.69190770238;12361.690957726129;12444.440000199831;8318.209770071833;8751.431156974777;8848.380613357003;8908.5991130398;8919.55402229873;12082.818757718816;12115.333656648969;12218.389080546114;12242.081843861924;12317.137800353888 20:35:52 INFO - PROCESS | 13323 | |3;mootools.html;1591.9999999999998;1607.7749115123884;1878.3050271399584;1923.8460923126152;1990.5720270141917;8203.466774659642;8388.748337549876;8418.200270974256;8531.872021919677;8718.956405217965;8446.028706698731;8476.449030813008;8519.190676885686;8519.190676885686;8560.143985601453;2434.4157402223473;2440.2923152285816;2458.360826185196;2459.1515927005153;2474.2206205045445;2461.679981602389;2505.3987043109614;2506.035176457059;2522.066835270952;2522.810789190818;2492.239866840613;2507.7241503434607;2508.49830033993;2511.0709037656093;2514.949701005988;2489.65144879717;2489.8879550420274;2507.084914006393;2508.7114981777145;2536.8477891326393;2498.4503409249937;2501.5997440409446;2520.659710939018;2529.3297276221815;2540.8475491470385;8755.25580325673;8792.34057445694;8814;8814.382993190478;8823;5240.082985477527;5336.759845806948;5373.919391209135;5384.542313903323;5391.622586418952;3380.9661903380897;3396.184915620258;3414.5219669246326;3432.0390290718387;3442.1738782692223;997.6059456514708;1023.253025291534;1027.398971601614;1930.3147382679228;1934.9516262093418;11696.18126731129;11742.823857642057;11801.586944456989;11819.527218911233;11847.88152118485;4529.569690879427;4615.192341340252;4618.422697162855;4647.465541462708;4669.719816811003;9366.438013719198;9424.246060315158;9457.668981585612;9479.668211612698;9487.288453366025;5338.519533241949;5340.359156901119;5369.382521010056;5372.70450125239;5411.945880541223;4765.11845308619;4868.9756551217015;4889.853304400874;4903.41159060915;5008.924866127011;3486.0761898097026;3557.5375201223674;3580.6598373154507;3584.8924532264073;3586.193106551057;1098.9945050274857;1105.171121658756;1113.5935383584933;1117.8602674665667;1142.8514293141839;1363.7477066742683;1366.371469124214;1367.2411811444545;1403.4175817035816;1407.8099456573436;7777.650005749755;7867.527948323119;7908.762737117896;7927.286544211049;7935.9206407936335;525.8422473258007;529.2220435959134;534.9026457336781;538.8598964269319;549.4478049560166;6042.758289668452;6050.788222412194;6092.695365231721;6094.603850749687;6154.076888466766;10167.644132455476;10483.528241229164;10539.94730026345;10642.73393165177;10648.733781655366;9579.90420095804;10352.430616316024;10400.739981500372;10401.167906567456;10592.311499752492;8027.438079334391;8079.636416361278;8096.635651395702;8193.713220037389;8194.918050819535;7628.42786791004;7643.235676432535;7706.7687969361;7736.883946740691;7754.612269386395;8710.69512567057;8778.385513014284;9170.495622740813;9206.815863682556;9315.441073535609;9234.353595248536;9235.630574777202;9329.813403731752;9425.434473931586;9494.382865114021;7732.188120247293;7876.291133797986;7905.762827115196;8043.83912321762;8155.79610509742;8079.87880181786;8080;8127.83744325122;8146.022477302761;8183.099859015622;7037.366637002694;7360.263973602597;7370.815729606588;7486.737964171228;7547.05661792276;7253.347198752138;7286.599237041802;7338.96330518344;7421.109466864011;7444;7283.963580182065;7293.161286452126;7316.487845850739;7333.1200255969625;7337.633118344168;6859.451243900576;6940.479464040116;6974.232834388112;6983.650817459208;6990.405815505535;7082.114735658043;7105.253948335557;7132.607706576188;7137.321954414322;7145.17830449505 20:35:52 INFO - PROCESS | 13323 | |4;prototype.html;362.95281613390256;365.8262325395436;369.2596344329619;372.2573465935459;372.3260897775027;6334.429901308881;6339.7464101436;6378.2664993525705;6388.8402789930215;6392.296847346788;6359.71381287842;6363.268224154223;6365.299817020135;6382.617042977425;6405.775797847076;4779.402574678165;4857.708537487744;4902.362692849924;4916.655834091615;4971.428285747131;4895.192293271606;4924.532169443897;4928.1129396708575;4931.0630980113665;4946.282788995612;4882.56056954874;4894.608431325503;4896.045271172123;4896.290037944496;4905.043516514281;4881.8291359802415;4902.681325713835;4908.950910490885;4909.165441874889;4914.410270767531;4312.568743125694;4315.978420107911;4320.956790432087;4323.956760432418;4331.415258940035;5874.1776151338845;6122.47958923492;6134.447899689005;6137.478314343286;6138.8772224555705;5622.297212848394;5623.8594035149035;5624.21261023457;5635.943640563582;5643.266375371217;6815.829604259933;6817.386435220805;6826.93173068268;6833.829154271133;6840.863182736367;4739.312799644033;4739.976300118512;4742.668013239075;4743.0988112258565;4747.074320507502;7013.684384202672;7067.15194176697;7096.751613693547;7097.787066388017;7116.679749411237;4725.078609671081;4845.466998630148;4857.9028419432125;4892.168331383673;4899.167141585939;4914.852554423373;4943.110240156806;4948.307236986825;4949.628777841676;4960.603151747851;5695.686737229492;5702.7433765480655;5708.40061793514;5708.71456427177;5714.171445140514;6828.829279268058;6833.248342682301;6854.074699915447;6858.622775747382;6876.759313424006;1721.277063633277;1759.8856074355126;1761.1722490429477;1762.3303144804893;1763.938262160818;1125.9943700281447;1144.3477217985835;1158.2355645274247;1159.478234794346;1177.3465726521863;6627.304133066055;6639.800805975829;6653.600783952978;6717.764878229238;6721.6975236114495;7038.40173585251;7072.611006394698;7080.575165490087;7085.32689394517;7092.113485814273;6505.381988711065;6566.6388348641285;6600.702968366435;6615.338466153346;6627.801165965029;3839.2705385976574;3849.230153969161;3853.537575490903;3857.691384689218;3859.55615104261;7385.900825042153;7407.9999200107295;7409.444291678145;7411.332980031823;7422.703091876372;7296.671649775667;7300.342969132804;7312.268773122752;7338.376238019828;7343.522671026366;7202.135743710788;7475.738349157645;7481.700731970769;7487.5507469552;7495.775126746206;7082.362587367162;7115.430765538848;7119.252478489684;7137.750178743719;7138.428925685829;6959.582425054513;7000.299970003162;7019.473539484661;7029.332213439715;7032.894506582507;7289.068396874726;7424;7446.627668616439;7447.962760186165;7453.068366454193;4858.58702010333;4899.632527560376;4911.950880491292;4913.70517768935;4916.70499770015;7080.362767350963;7090.964545177241;7111.217766045835;7112.644367781487;7123.465740069412;6835.965820171066;6884.311568843075;6889.345512176335;6891.310868913069;6899.068625735462;6788.389044985975;6882.380585747307;6887.93112068893;6891.655417229018;6967.1291088613925;6706.463482921452;6772.52592318533;6773.119494465688;6787.490938179755;6792.113351825553;6899.0341352209725;6904.067950826574;6932.688029038604;6947.4789390796905;6967.54710943787;6775.186977562724;6775.728970841111;6777;6779.186497620317;6785.626790526569 20:35:52 INFO - PROCESS | 13323 | |5;yui.html;751.6767789850369;810.339573247803;820.8973878265217;864.084070884862;915.2860768600491;14570.635734106652;14887.330070146842;14887.925560372196;14910.478133265338;14938.626534336634;13290.468381264762;13384.732305353911;13398.12912160709;13405.530806421777;13458.865411345883;766.0692258905443;914.8856392950881;935.1817159985013;935.9719208423725;937.0348541002778;901.8466860633708;903.9638414463413;906.9410488318272;907.5280853955938;908.1735620585268;974.4250891973734;975.6633961283381;976.3507267666993;976.775341671416;977.0669011094424;963.2149797914677;968.1963969904962;969.6654654144344;971.3977334052862;974.2644303550809;721.6499997501207;722.2488611843677;724.2576359231776;727.752564128199;728.2462651156028;14870;14913.701725965528;14941.70116597662;14996.47512337074;15039.323230454656;14006.439742410292;14246.643833904132;14498.782518262235;14572.70854582913;14732.410703571844;11798;11858.051355891508;12110.697232569168;12251.326177060258;12399.318037507934;3936.5472970608175;3950.071733142709;4000.3799411091327;4041.838326466938;4044.1911617676583;47652.523474765505;47704.04591908177;47889.52110478885;48064.75967620139;48137.75931120357;10216.540255688511;10569.788604227871;10637.787244255072;10702.892971070345;10727.409992450333;19410.4176874694;19417.902910485638;19456.124474398686;19495.220191192195;19523.414297571097;7619;7832.960835195788;7870.527768333918;7921.049474063034;7926.365890728728;4330.956690433055;4435.2016637005645;4500.054988452462;4501.549845015472;4558.0655965526985;3421.469672200813;3478.32172726321;3484.7560670752805;3498.2129020970588;3507.7895326280504;603.408659513679;615.0896672924098;617.1945610977627;623.803501896901;626.6709977261883;578.0866231354449;652.9477641788645;653.5980372071142;654.8297442664846;660.2704012066597;8120.147384524658;8201.8359632807;8653.524056176844;8762.255208307237;8931.687390941286;593.5459373579215;634.2547506679633;636.6053047110821;637.9170707807955;659.6437923521245;3885.300645883768;4217.810198541073;4222.704410691222;4327.7619730914475;4378.759168245777;58527;59774.70112649496;60071.098933516034;60175.39824601698;60313.09530357048;52996.20505692418;53154.7342263294;54060.45939540633;54430.455695442535;54558.45441545613;49204.75397622989;49423.25865112026;49893.501064988886;49991.99999999927;50496.242556361685;8167.754967350989;8484.787880303042;8514.78713032179;8588.22705956467;8684.39209255346;36902.630973691;36992.81503592465;37726.811365942995;37816.81091594524;37932.3101534772;43403.348949765146;43453.130937381706;46979.76510117428;47540;47933;10298.124659404035;10626.36241825493;10821.837672434762;10839.241253112206;10905.945470272598;12021.398930053638;12146.331951742739;12249.938750306192;12283;12429.192102513307;10573.207009474167;10605.787884242427;10758.51586678617;11025.83461248098;11315.321080735182;10827.51276192589;11109.611163609236;11481.311121332747;11574.537018519502;12727.236365817711;10736.51685674131;10878.40168790724;11120.499577519193;11149.888501114885;12326.81509777372;10365.222608304257;10381.584736610452;10468.319559228627;10937.890621094006;11482.36846973391;10415.062644362044;10495.737606559896;10649.339062941295;10692.14462842955;10895.455227238765 20:35:52 INFO - PROCESS | 13323 | __end_tp_report 20:35:52 INFO - PROCESS | 13323 | __start_cc_report 20:35:52 INFO - PROCESS | 13323 | _x_x_mozilla_cycle_collect,331 20:35:52 INFO - PROCESS | 13323 | __end_cc_report 20:35:52 INFO - PROCESS | 13323 | __startTimestamp1463283352238__endTimestamp 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | ------- Summary: start ------- 20:35:52 INFO - PROCESS | 13323 | Number of tests: 6 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | [#0] dojo.html Cycles:165 Average:5603.15 Median:5845.77 stddev:612.49 (10.5%) stddev-sans-first:587.91 20:35:52 INFO - PROCESS | 13323 | Values: 3333.1 3389.7 3397.8 3440.7 3440.7 5585.1 5606.8 5620.3 5634.7 5640.4 5590.1 5593.6 5633.0 5635.4 5656.9 5099.0 5131.8 5164.0 5196.4 5211.8 5043.4 5174.9 5205.6 5223.8 5224.6 5200.2 5200.7 5207.6 5264.6 5265.6 5222.3 5238.7 5251.2 5252.1 5280.9 4988.1 5050.2 5095.1 5128.9 5213.6 5457.8 5462.8 5482.9 5492.6 5494.8 6015.1 6020.3 6025.7 6045.7 6052.4 6045.3 6054.5 6064.8 6076.7 6099.6 5669.3 5672.1 5673.1 5673.7 5694.2 5921.3 6137.3 6179.5 6185.9 6197.9 5874.4 5880.3 5880.3 5888.8 5936.5 5968.9 5969.4 5974.5 5978.4 5986.7 5790.9 5792.9 5828.2 5867.0 5939.3 5987.9 5988.1 6016.6 6020.8 6043.3 4576.8 4589.6 4606.2 4607.2 4646.6 4001.9 4098.7 4123.3 4129.8 4168.8 5559.1 5681.7 5716.6 5721.7 5779.3 6017.2 6029.8 6033.1 6048.4 6061.2 5633.9 5678.3 5750.4 5750.7 5760.4 5153.3 5175.4 5178.7 5180.9 5189.8 6231.6 6233.4 6237.8 6240.9 6267.7 5845.8 5921.6 5925.2 6019.1 6060.6 6207.0 6258.0 6261.9 6272.2 6272.6 5964.6 5978.8 5980.5 5980.7 5992.3 5918.4 5932.0 5946.8 6083.1 6085.9 5871.2 5903.6 5912.1 5923.7 5925.6 5887.8 5913.7 5917.6 5951.8 5970.1 5689.9 5752.3 5822.9 5830.7 5864.4 5929.8 5969.1 6002.9 6021.7 6026.1 5875.9 5876.9 5881.1 5892.9 5896.7 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | [#1] ext.html Cycles:180 Average:57641.58 Median:42214.97 stddev:120319.87 (285.0%) stddev-sans-first:120581.05 20:35:52 INFO - PROCESS | 13323 | Values: 549.4 570.2 580.8 592.8 629.7 30630.2 39543.0 40605.6 40683.8 40762.0 42520.8 42927.1 43047.8 43106.0 43116.6 8812.3 9009.3 9011.5 9020.0 9026.9 8819.5 8933.4 8937.9 8967.9 8980.8 8874.2 8932.0 8940.4 8967.3 9011.5 8858.0 9041.1 9046.4 9066.0 9078.9 9046.3 9101.7 9121.6 9166.2 9184.0 42707.6 43388.8 43413.6 43500.6 43621.8 3663.2 3785.8 3786.0 3798.8 3873.2 32706.5 32737.5 32897.0 33008.7 34022.1 3726.8 3757.1 3759.8 3770.9 3793.3 298517.0 298652.0 299324.0 299413.0 299590.0 47093.8 47689.5 63610.0 64346.4 64478.7 45265.0 45314.5 45341.8 45379.5 45454.8 16159.5 16368.3 16369.4 16378.1 16382.0 13598.9 13624.1 13631.0 13670.7 13761.4 15265.7 15715.0 15727.1 15731.4 15793.5 6016.6 6044.0 6050.8 6052.6 6341.4 1098.0 1134.0 1171.0 1201.6 1228.7 30148.2 30767.7 30892.4 30977.2 31330.5 1237.9 1238.5 1250.5 1262.9 1272.9 15795.7 15916.3 15960.4 15981.6 16250.0 333605.0 526850.0 532110.0 840047.0 851873.0 56530.2 57322.9 57357.4 57437.1 57482.7 1468.5 1506.0 1510.5 1538.5 1542.2 29571.7 31690.7 31818.8 32283.0 32661.8 49997.3 58957.7 60808.0 61215.7 61308.7 304271.0 304723.0 305190.0 307821.0 308131.0 41941.8 42140.4 42289.6 42482.2 46518.3 50632.5 50882.0 50931.7 51112.2 52007.0 42714.8 43387.6 43577.8 43578.8 44820.3 41570.0 42375.4 43190.1 43656.0 43656.5 41909.0 42092.8 42877.8 43097.8 43124.8 36269.6 37561.8 38098.8 38149.4 38290.6 28173.2 28690.0 28704.6 28737.7 28803.9 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | [#2] jquery.html Cycles:180 Average:27241.75 Median:2023.36 stddev:78412.19 (3875.3%) stddev-sans-first:78606.14 20:35:52 INFO - PROCESS | 13323 | Values: 342.7 349.4 354.2 365.7 367.6 17223.0 17635.6 18073.7 18095.7 18104.2 17116.4 17417.5 18102.4 18154.3 18180.0 4970.8 5593.7 5593.8 5607.8 5610.0 5522.9 5615.5 5618.1 5620.2 5623.4 5239.7 5313.2 5314.9 5315.8 5656.5 5222.1 5250.1 5253.0 5288.6 5288.9 5097.6 5114.5 5188.1 5416.9 5421.6 14416.7 14474.8 14516.2 19827.0 22118.0 2400.0 2427.3 2498.0 2531.2 2958.4 10004.6 10241.5 10273.9 10475.7 10523.6 1925.0 1955.8 1969.5 1973.2 1977.7 56545.0 65675.7 69737.0 74448.0 75452.2 9655.9 10115.5 10437.5 10703.4 10759.1 15029.4 15096.4 15132.2 15155.8 15209.8 7736.7 7811.9 7876.3 7885.3 7903.3 7841.7 8001.8 8050.6 8201.7 8239.6 4646.4 4690.6 4753.0 4791.3 4797.8 1998.8 2015.8 2018.8 2021.9 2024.9 1073.9 1103.9 1117.5 1119.6 1144.3 17316.0 17485.9 17566.2 17807.9 18137.2 1007.8 1017.1 1030.1 1062.7 1063.2 9911.9 10096.3 10136.7 10167.8 10300.4 464843.0 467233.0 478339.0 483862.0 495994.0 74987.6 78432.6 80882.2 80905.6 82825.0 1078.8 1079.1 1079.7 1092.3 1110.0 15615.5 15690.0 15789.3 16009.7 16189.9 34323.1 34512.3 34960.3 35513.0 35839.6 49875.0 50928.7 51074.5 51230.0 52294.0 8396.5 8716.9 8866.3 8929.8 9105.4 11474.2 13521.4 13574.5 13692.9 13712.9 11554.2 11621.5 11942.6 11996.1 12206.1 11592.4 11625.3 11662.5 11713.1 11767.2 12064.7 12081.8 12323.7 12361.7 12444.4 8318.2 8751.4 8848.4 8908.6 8919.6 12082.8 12115.3 12218.4 12242.1 12317.1 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | [#3] mootools.html Cycles:180 Average:5943.18 Median:5401.78 stddev:3097.18 (57.3%) stddev-sans-first:3088.60 20:35:52 INFO - PROCESS | 13323 | Values: 1592.0 1607.8 1878.3 1923.8 1990.6 8203.5 8388.7 8418.2 8531.9 8719.0 8446.0 8476.4 8519.2 8519.2 8560.1 2434.4 2440.3 2458.4 2459.2 2474.2 2461.7 2505.4 2506.0 2522.1 2522.8 2492.2 2507.7 2508.5 2511.1 2514.9 2489.7 2489.9 2507.1 2508.7 2536.8 2498.5 2501.6 2520.7 2529.3 2540.8 8755.3 8792.3 8814.0 8814.4 8823.0 5240.1 5336.8 5373.9 5384.5 5391.6 3381.0 3396.2 3414.5 3432.0 3442.2 997.6 1023.3 1027.4 1930.3 1935.0 11696.2 11742.8 11801.6 11819.5 11847.9 4529.6 4615.2 4618.4 4647.5 4669.7 9366.4 9424.2 9457.7 9479.7 9487.3 5338.5 5340.4 5369.4 5372.7 5411.9 4765.1 4869.0 4889.9 4903.4 5008.9 3486.1 3557.5 3580.7 3584.9 3586.2 1099.0 1105.2 1113.6 1117.9 1142.9 1363.7 1366.4 1367.2 1403.4 1407.8 7777.7 7867.5 7908.8 7927.3 7935.9 525.8 529.2 534.9 538.9 549.4 6042.8 6050.8 6092.7 6094.6 6154.1 10167.6 10483.5 10539.9 10642.7 10648.7 9579.9 10352.4 10400.7 10401.2 10592.3 8027.4 8079.6 8096.6 8193.7 8194.9 7628.4 7643.2 7706.8 7736.9 7754.6 8710.7 8778.4 9170.5 9206.8 9315.4 9234.4 9235.6 9329.8 9425.4 9494.4 7732.2 7876.3 7905.8 8043.8 8155.8 8079.9 8080.0 8127.8 8146.0 8183.1 7037.4 7360.3 7370.8 7486.7 7547.1 7253.3 7286.6 7339.0 7421.1 7444.0 7284.0 7293.2 7316.5 7333.1 7337.6 6859.5 6940.5 6974.2 6983.7 6990.4 7082.1 7105.3 7132.6 7137.3 7145.2 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | [#4] prototype.html Cycles:180 Average:5743.52 Median:6536.01 stddev:1739.24 (26.6%) stddev-sans-first:1696.58 20:35:52 INFO - PROCESS | 13323 | Values: 363.0 365.8 369.3 372.3 372.3 6334.4 6339.7 6378.3 6388.8 6392.3 6359.7 6363.3 6365.3 6382.6 6405.8 4779.4 4857.7 4902.4 4916.7 4971.4 4895.2 4924.5 4928.1 4931.1 4946.3 4882.6 4894.6 4896.0 4896.3 4905.0 4881.8 4902.7 4909.0 4909.2 4914.4 4312.6 4316.0 4321.0 4324.0 4331.4 5874.2 6122.5 6134.4 6137.5 6138.9 5622.3 5623.9 5624.2 5635.9 5643.3 6815.8 6817.4 6826.9 6833.8 6840.9 4739.3 4740.0 4742.7 4743.1 4747.1 7013.7 7067.2 7096.8 7097.8 7116.7 4725.1 4845.5 4857.9 4892.2 4899.2 4914.9 4943.1 4948.3 4949.6 4960.6 5695.7 5702.7 5708.4 5708.7 5714.2 6828.8 6833.2 6854.1 6858.6 6876.8 1721.3 1759.9 1761.2 1762.3 1763.9 1126.0 1144.3 1158.2 1159.5 1177.3 6627.3 6639.8 6653.6 6717.8 6721.7 7038.4 7072.6 7080.6 7085.3 7092.1 6505.4 6566.6 6600.7 6615.3 6627.8 3839.3 3849.2 3853.5 3857.7 3859.6 7385.9 7408.0 7409.4 7411.3 7422.7 7296.7 7300.3 7312.3 7338.4 7343.5 7202.1 7475.7 7481.7 7487.6 7495.8 7082.4 7115.4 7119.3 7137.8 7138.4 6959.6 7000.3 7019.5 7029.3 7032.9 7289.1 7424.0 7446.6 7448.0 7453.1 4858.6 4899.6 4912.0 4913.7 4916.7 7080.4 7091.0 7111.2 7112.6 7123.5 6836.0 6884.3 6889.3 6891.3 6899.1 6788.4 6882.4 6887.9 6891.7 6967.1 6706.5 6772.5 6773.1 6787.5 6792.1 6899.0 6904.1 6932.7 6947.5 6967.5 6775.2 6775.7 6777.0 6779.2 6785.6 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - PROCESS | 13323 | [#5] yui.html Cycles:180 Average:14457.34 Median:43428.24 stddev:16586.92 (38.2%) stddev-sans-first:16601.52 20:35:52 INFO - PROCESS | 13323 | Values: 751.7 810.3 820.9 864.1 915.3 14570.6 14887.3 14887.9 14910.5 14938.6 13290.5 13384.7 13398.1 13405.5 13458.9 766.1 914.9 935.2 936.0 937.0 901.8 904.0 906.9 907.5 908.2 974.4 975.7 976.4 976.8 977.1 963.2 968.2 969.7 971.4 974.3 721.6 722.2 724.3 727.8 728.2 14870.0 14913.7 14941.7 14996.5 15039.3 14006.4 14246.6 14498.8 14572.7 14732.4 11798.0 11858.1 12110.7 12251.3 12399.3 3936.5 3950.1 4000.4 4041.8 4044.2 47652.5 47704.0 47889.5 48064.8 48137.8 10216.5 10569.8 10637.8 10702.9 10727.4 19410.4 19417.9 19456.1 19495.2 19523.4 7619.0 7833.0 7870.5 7921.0 7926.4 4331.0 4435.2 4500.1 4501.5 4558.1 3421.5 3478.3 3484.8 3498.2 3507.8 603.4 615.1 617.2 623.8 626.7 578.1 652.9 653.6 654.8 660.3 8120.1 8201.8 8653.5 8762.3 8931.7 593.5 634.3 636.6 637.9 659.6 3885.3 4217.8 4222.7 4327.8 4378.8 58527.0 59774.7 60071.1 60175.4 60313.1 52996.2 53154.7 54060.5 54430.5 54558.5 49204.8 49423.3 49893.5 49992.0 50496.2 8167.8 8484.8 8514.8 8588.2 8684.4 36902.6 36992.8 37726.8 37816.8 37932.3 43403.3 43453.1 46979.8 47540.0 47933.0 10298.1 10626.4 10821.8 10839.2 10905.9 12021.4 12146.3 12249.9 12283.0 12429.2 10573.2 10605.8 10758.5 11025.8 11315.3 10827.5 11109.6 11481.3 11574.5 12727.2 10736.5 10878.4 11120.5 11149.9 12326.8 10365.2 10381.6 10468.3 10937.9 11482.4 10415.1 10495.7 10649.3 10692.1 10895.5 20:35:52 INFO - PROCESS | 13323 | -------- Summary: end -------- 20:35:52 INFO - PROCESS | 13323 | 20:35:52 INFO - TEST-INFO | 13323: exit 0 20:35:52 INFO - TEST-OK | dromaeo_css | took 1109271ms 20:35:52 INFO - TEST-START | kraken 20:35:52 INFO - operating with platform_type : linux_ 20:35:52 INFO - Initialising browser for kraken test... 20:35:52 INFO - TEST-INFO | started process 13563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVH6f1N/profile http://localhost:37106/getInfo.html) 20:35:56 INFO - PROCESS | 13563 | 20:35:56 INFO - PROCESS | 13563 | (process:13636): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:35:57 INFO - PROCESS | 13563 | __metrics Screen width/height:1600/1200 20:35:57 INFO - PROCESS | 13563 | colorDepth:24 20:35:57 INFO - PROCESS | 13563 | Browser inner width/height: 1024/697 20:35:57 INFO - PROCESS | 13563 | __metrics 20:35:57 ERROR - PROCESS | 13563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 20:35:58 INFO - TEST-INFO | 13563: exit 0 20:35:58 INFO - Browser initialized. 20:35:58 INFO - Running cycle 1/1 for kraken test... 20:35:58 INFO - TEST-INFO | started process 13686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVH6f1N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:00 INFO - PROCESS | 13686 | 20:36:00 INFO - PROCESS | 13686 | (process:13754): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:36:10 INFO - PROCESS | 13686 | RSS: Main: 149962752 20:36:10 INFO - PROCESS | 13686 | 20:36:13 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:13 INFO - PROCESS | 13686 | RSS: Main: 153722880 20:36:13 INFO - PROCESS | 13686 | 20:36:16 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-dft) 20:36:16 INFO - PROCESS | 13686 | RSS: Main: 154222592 20:36:16 INFO - PROCESS | 13686 | 20:36:19 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-fft) 20:36:20 INFO - PROCESS | 13686 | RSS: Main: 154640384 20:36:20 INFO - PROCESS | 13686 | 20:36:22 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-oscillator) 20:36:23 INFO - PROCESS | 13686 | RSS: Main: 154488832 20:36:23 INFO - PROCESS | 13686 | 20:36:25 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:25 INFO - PROCESS | 13686 | RSS: Main: 155250688 20:36:25 INFO - PROCESS | 13686 | 20:36:28 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37106/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:29 INFO - PROCESS | 13686 | RSS: Main: 154537984 20:36:29 INFO - PROCESS | 13686 | 20:36:32 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37106/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:33 INFO - PROCESS | 13686 | RSS: Main: 154660864 20:36:33 INFO - PROCESS | 13686 | 20:36:36 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37106/tests/kraken/driver.html?testName=json-parse-financial) 20:36:36 INFO - PROCESS | 13686 | RSS: Main: 154869760 20:36:36 INFO - PROCESS | 13686 | 20:36:38 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:38 INFO - PROCESS | 13686 | RSS: Main: 155439104 20:36:38 INFO - PROCESS | 13686 | 20:36:40 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:41 INFO - PROCESS | 13686 | RSS: Main: 154222592 20:36:41 INFO - PROCESS | 13686 | 20:36:43 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:44 INFO - PROCESS | 13686 | RSS: Main: 154607616 20:36:44 INFO - PROCESS | 13686 | 20:36:46 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:47 INFO - PROCESS | 13686 | RSS: Main: 154804224 20:36:47 INFO - PROCESS | 13686 | 20:36:49 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:50 INFO - PROCESS | 13686 | RSS: Main: 155283456 20:36:50 INFO - PROCESS | 13686 | 20:36:51 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37106/tests/kraken/driver.html?testName=ai-astar) 20:36:52 INFO - PROCESS | 13686 | RSS: Main: 157138944 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | __start_tp_report 20:36:52 INFO - PROCESS | 13686 | _x_x_mozilla_page_load 20:36:52 INFO - PROCESS | 13686 | _x_x_mozilla_page_load_details 20:36:52 INFO - PROCESS | 13686 | |i|pagename|runs| 20:36:52 INFO - PROCESS | 13686 | |0;ai-astar;110;106;113;109;110;121;111;110;109;109 20:36:52 INFO - PROCESS | 13686 | |1;audio-beat-detection;152;137;158;178;128;155;151;128;168;130 20:36:52 INFO - PROCESS | 13686 | |2;audio-dft;163;163;163;162;164;164;164;163;165;162 20:36:52 INFO - PROCESS | 13686 | |3;audio-fft;76;81;74;168;77;77;77;76;161;75 20:36:52 INFO - PROCESS | 13686 | |4;audio-oscillator;93;93;143;93;93;94;138;93;93;144 20:36:52 INFO - PROCESS | 13686 | |5;imaging-gaussian-blur;117;119;116;117;119;117;117;117;117;117 20:36:52 INFO - PROCESS | 13686 | |6;imaging-darkroom;147;147;147;147;147;146;146;146;146;148 20:36:52 INFO - PROCESS | 13686 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;97;96 20:36:52 INFO - PROCESS | 13686 | |8;json-parse-financial;56;57;56;56;55;59;55;56;56;55 20:36:52 INFO - PROCESS | 13686 | |9;json-stringify-tinderbox;73;73;73;72;72;72;73;72;73;73 20:36:52 INFO - PROCESS | 13686 | |10;stanford-crypto-aes;77;86;81;80;79;80;80;79;79;78 20:36:52 INFO - PROCESS | 13686 | |11;stanford-crypto-ccm;117;118;115;123;120;113;115;113;112;115 20:36:52 INFO - PROCESS | 13686 | |12;stanford-crypto-pbkdf2;143;150;146;149;148;138;151;146;149;150 20:36:52 INFO - PROCESS | 13686 | |13;stanford-crypto-sha256-iterative;73;68;66;78;69;74;66;70;67;66 20:36:52 INFO - PROCESS | 13686 | __end_tp_report 20:36:52 INFO - PROCESS | 13686 | __start_cc_report 20:36:52 INFO - PROCESS | 13686 | _x_x_mozilla_cycle_collect,839 20:36:52 INFO - PROCESS | 13686 | __end_cc_report 20:36:52 INFO - PROCESS | 13686 | __startTimestamp1463283412144__endTimestamp 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | ------- Summary: start ------- 20:36:52 INFO - PROCESS | 13686 | Number of tests: 14 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:3.99 (3.6%) stddev-sans-first:4.23 20:36:52 INFO - PROCESS | 13686 | Values: 110.0 106.0 113.0 109.0 110.0 121.0 111.0 110.0 109.0 109.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:17.37 (11.3%) stddev-sans-first:18.38 20:36:52 INFO - PROCESS | 13686 | Values: 152.0 137.0 158.0 178.0 128.0 155.0 151.0 128.0 168.0 130.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 20:36:52 INFO - PROCESS | 13686 | Values: 163.0 163.0 163.0 162.0 164.0 164.0 164.0 163.0 165.0 162.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.50 stddev:37.13 (48.5%) stddev-sans-first:38.80 20:36:52 INFO - PROCESS | 13686 | Values: 76.0 81.0 74.0 168.0 77.0 77.0 77.0 76.0 161.0 75.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.49 (25.3%) stddev-sans-first:24.31 20:36:52 INFO - PROCESS | 13686 | Values: 93.0 93.0 143.0 93.0 93.0 94.0 138.0 93.0 93.0 144.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 20:36:52 INFO - PROCESS | 13686 | Values: 117.0 119.0 116.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:36:52 INFO - PROCESS | 13686 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 148.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:36:52 INFO - PROCESS | 13686 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 20:36:52 INFO - PROCESS | 13686 | Values: 56.0 57.0 56.0 56.0 55.0 59.0 55.0 56.0 56.0 55.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 20:36:52 INFO - PROCESS | 13686 | Values: 73.0 73.0 73.0 72.0 72.0 72.0 73.0 72.0 73.0 73.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:2.42 (3.0%) stddev-sans-first:2.33 20:36:52 INFO - PROCESS | 13686 | Values: 77.0 86.0 81.0 80.0 79.0 80.0 80.0 79.0 79.0 78.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.00 stddev:3.45 (3.0%) stddev-sans-first:3.64 20:36:52 INFO - PROCESS | 13686 | Values: 117.0 118.0 115.0 123.0 120.0 113.0 115.0 113.0 112.0 115.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:149.00 stddev:3.97 (2.7%) stddev-sans-first:3.94 20:36:52 INFO - PROCESS | 13686 | Values: 143.0 150.0 146.0 149.0 148.0 138.0 151.0 146.0 149.0 150.0 20:36:52 INFO - PROCESS | 13686 | 20:36:52 INFO - PROCESS | 13686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:4.08 (5.9%) stddev-sans-first:4.15 20:36:52 INFO - PROCESS | 13686 | Values: 73.0 68.0 66.0 78.0 69.0 74.0 66.0 70.0 67.0 66.0 20:36:52 INFO - PROCESS | 13686 | -------- Summary: end -------- 20:36:52 INFO - PROCESS | 13686 | 20:36:53 INFO - TEST-INFO | 13686: exit 0 20:36:53 INFO - TEST-OK | kraken | took 60169ms 20:36:53 INFO - SUITE-END | took 1169s 20:36:53 INFO - Completed test suite (00:19:29) 20:36:53 INFO - javascript benchmark 20:36:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3333.050080726993, 3389.74576906732, 3397.7621566490325, 3440.6731360520757, 3440.741944354174, 5585.134304182848, 5606.831795046145, 5620.325560932689, 5634.690092044936, 5640.379558248595, 5590.077637189859, 5593.608447408683, 5632.971835140829, 5635.436456354362, 5656.915146272799, 5099.031184075023, 5131.820386286481, 5163.993021360836, 5196.402413722432, 5211.765470553834, 5043.36957880265, 5174.896502069956, 5205.60957928155, 5223.8432847014465, 5224.555912747421, 5200.167973124282, 5200.661956972804, 5207.6354655174155, 5264.6051546134, 5265.578753699695, 5222.3472065991755, 5238.68567885928, 5251.2385704072885, 5252.107141785906, 5280.894382112375, 4988.102141614508, 5050.191969284933, 5095.108356037678, 5128.948710512885, 5213.635045546814, 5457.781688732446, 5462.781488740446, 5482.945170548283, 5492.588055895823, 5494.80768173112, 6015.097735339734, 6020.2775666919815, 6025.668588227646, 6045.72794224261, 6052.394760523956, 6045.33501314855, 6054.485368743662, 6064.787732429344, 6076.726547305338, 6099.57302988791, 5669.291338582677, 5672.06410942194, 5673.120666296731, 5673.716314184274, 5694.2312787773535, 5921.319048309413, 6137.315698286963, 6179.5056395488255, 6185.938140618537, 6197.938020619736, 5874.353821079763, 5880.294364676266, 5880.294364676266, 5888.823335299948, 5936.495397891227, 5968.910466343008, 5969.403059693996, 5974.462298393166, 5978.402159784074, 5986.700664966821, 5790.913136302959, 5792.88414231713, 5828.242328497353, 5867.031939729982, 5939.316978547436, 5987.880242395127, 5988.131720900445, 6016.578839481194, 6020.849478763066, 6043.305019922677, 4576.771161441915, 4589.5639914208095, 4606.193916064675, 4607.216773148572, 4646.558576935186, 4001.919961600752, 4098.672106231495, 4123.257813593522, 4129.752214867118, 4168.7707176105, 5559.110542313291, 5681.687507187145, 5716.57125715573, 5721.713914304351, 5779.33537643168, 6017.187679663277, 6029.758809647653, 6033.12519684652, 6048.364921683248, 6061.242344706911, 5633.859153521113, 5678.290213723285, 5750.424957504216, 5750.712464376765, 5760.42395760429, 5153.2785410042625, 5175.378954525406, 5178.663386879841, 5180.948190518046, 5189.844304670866, 6231.626102433868, 6233.438990490878, 6237.844053898598, 6240.906386404207, 6267.71795269214, 5845.766169353178, 5921.644701317935, 5925.200097986716, 6019.127226552037, 6060.606060606135, 6206.968965155145, 6258.0, 6261.874762504815, 6272.2159730033745, 6272.5922815016875, 5964.612300200647, 5978.844702931421, 5980.491658209101, 5980.671063091398, 5992.250968628921, 5918.408159184047, 5931.970340148272, 5946.762129514771, 6083.087536869505, 6085.878282434238, 5871.2073870027, 5903.586748927705, 5912.054071348563, 5923.703814809156, 5925.644461332334, 5887.764489420375, 5913.733881975408, 5917.644941303535, 5951.821445356646, 5970.134330522137, 5689.857753556194, 5752.309722833287, 5822.883542329045, 5830.679312637845, 5864.413558644272, 5929.792457263975, 5969.134475500941, 6002.909956350745, 6021.729022194099, 6026.096085587197, 5875.911861321998, 5876.882462350814, 5881.147233651182, 5892.941070589411, 5896.705164741831], "unit": "score", "name": "dojo.html", "value": 5563.797198045609}, {"lowerIsBetter": false, "replicates": [549.3545084525682, 570.1846359705622, 580.7618876260731, 592.8280798568416, 629.6599836088512, 30630.23424414388, 39543.0, 40605.59394406055, 40683.79658101709, 40762.0, 42520.78739606305, 42927.14145717084, 43047.784761076226, 43106.0, 43116.56883431165, 8812.339074569401, 9009.324300677443, 9011.459312441242, 9020.0, 9026.909730902673, 8819.51492667903, 8933.419327743708, 8937.865932011026, 8967.910320896804, 8980.820383592325, 8874.2456891164, 8932.0, 8940.374173807804, 8967.282617390592, 9011.549422528848, 8857.95571022144, 9041.050689677588, 9046.411983221102, 9066.048064953216, 9078.90921090794, 9046.276297896153, 9101.681441149529, 9121.635134594608, 9166.220871225954, 9184.0, 42707.57292427067, 43388.78305608452, 43413.56586434158, 43500.56499435029, 43621.78189109066, 3663.1757854482794, 3785.7539259948016, 3786.0345611868797, 3798.803035478265, 3873.1866308075337, 32706.509402358985, 32737.508937365958, 32897.0, 33008.6699133008, 34022.14944626404, 3726.75776074557, 3757.079515518715, 3759.812009399519, 3770.924581508382, 3793.3172029034763, 298517.0, 298652.0, 299324.0, 299413.0, 299590.0, 47093.76453117713, 47689.5231047692, 63610.0, 64346.35653643404, 64478.677606612604, 45265.0, 45314.546854531036, 45341.77329113399, 45379.54620453753, 45454.77272613616, 16159.515214543582, 16368.263428145761, 16369.427070052729, 16378.099204543865, 16382.0, 13598.864011359958, 13624.114432561852, 13631.0, 13670.726585468235, 13761.449542018207, 15265.694686106215, 15715.0, 15727.135007574694, 15731.4493992712, 15793.526194214191, 6016.608920420159, 6044.0, 6050.788222412194, 6052.576319657582, 6341.4292713656, 1097.9560817567208, 1133.994330028361, 1171.0, 1201.6094769200045, 1228.7173949991552, 30148.24629384283, 30767.69232307693, 30892.382152357277, 30977.225569360497, 31330.530042049388, 1237.9071569632313, 1238.5231685801032, 1250.474800583739, 1262.9368531573384, 1272.866349033338, 15795.684086318439, 15916.283767230503, 15960.441384551717, 15981.60045998836, 16250.024998500128, 333605.0, 526850.0, 532110.0, 840047.0, 851873.0, 56530.15204771932, 57322.85354292974, 57357.42642573604, 57437.13844292339, 57482.7125864368, 1468.4786900650329, 1506.0060360162458, 1510.5392855179275, 1538.5076775431978, 1542.2288855572215, 29571.704282956896, 31690.683093169697, 31818.84090579625, 32283.031509054767, 32661.836690817345, 49997.25004125014, 58957.705211473665, 60808.0, 61215.69392153011, 61308.69345653243, 304271.0, 304723.0, 305190.0, 307821.0, 308131.0, 41941.790291048346, 42140.367894482224, 42289.57710422856, 42482.15035699207, 46518.302225465966, 50632.493675062775, 50882.0, 50931.745341273054, 51112.23331650103, 52007.0, 42714.78642606767, 43387.56612433962, 43577.78211108924, 43578.78210609053, 44820.32769508525, 41570.0, 42375.36436953386, 43190.13619727651, 43656.0, 43656.47202347903, 41909.0, 42092.78953605212, 42877.78561107175, 43097.78451107725, 43124.78437607792, 36269.63730362662, 37561.81219093996, 38098.80950595229, 38149.4277585842, 38290.6170938287, 28173.154805355873, 28690.0, 28704.569431458127, 28737.712622873503, 28803.855980719964], "unit": "score", "name": "ext.html", "value": 20081.39571321581}, {"lowerIsBetter": false, "replicates": [342.6847300483556, 349.3711319624676, 354.2065772669222, 365.7384969746631, 367.5717788776076, 17223.0, 17635.55911102223, 18073.7288940666, 18095.72856407155, 18104.185311660975, 17116.400925967595, 17417.47747567575, 18102.366417175403, 18154.273829046822, 18180.0, 4970.826021089262, 5593.664380137185, 5593.804216852411, 5607.775688972436, 5610.018246806813, 5522.861928451781, 5615.522680572156, 5618.12918997554, 5620.241267428885, 5623.437656234385, 5239.711815850127, 5313.1764576490705, 5314.893702125955, 5315.760790764425, 5656.490915817576, 5222.086134926372, 5250.05499010178, 5252.999999999981, 5288.629795914288, 5288.947110528903, 5097.643164978453, 5114.539691427789, 5188.092083885305, 5416.945830541723, 5421.647592906488, 14416.71166576673, 14474.782878256834, 14516.201608911506, 19827.0, 22118.0, 2400.0279886645935, 2427.2596857958315, 2498.0, 2531.240627811649, 2958.378740464505, 10004.649837255734, 10241.487925603764, 10273.911001409078, 10475.738106547322, 10523.631672891488, 1924.951876203092, 1955.7750858651295, 1969.5371587676884, 1973.1712680674152, 1977.683570628707, 56545.0, 65675.67162164206, 69737.0, 74448.0, 75452.24547754508, 9655.855162172573, 10115.494225288707, 10437.530311136017, 10703.357798532114, 10759.139268858473, 15029.398824047134, 15096.39614415433, 15132.167730774692, 15155.772663410058, 15209.771853422208, 7736.6518506667335, 7811.921880781233, 7876.330511906437, 7885.329746971457, 7903.328217101496, 7841.686332546634, 8001.759947201594, 8050.59747012647, 8201.71294004707, 8239.588020598947, 4646.395968524071, 4690.624750019991, 4752.95247047532, 4791.305260737174, 4797.7601119943865, 1998.8300994415638, 2015.7782643909159, 2018.8123401773516, 2021.8584699070923, 2024.8582599218207, 1073.8926107389354, 1103.933763974164, 1117.474786850179, 1119.6361182615683, 1144.2848219862585, 17316.0, 17485.912570437067, 17566.209520571603, 17807.910960445115, 18137.18382672783, 1007.773251018515, 1017.0897047142765, 1030.1449796668746, 1062.6865074802952, 1063.1601035182275, 9911.900880991241, 10096.34373765703, 10136.746581335525, 10167.796644067224, 10300.381977081399, 464843.0, 467233.0, 478339.0, 483862.0, 495994.0, 74987.62506187434, 78432.60783696045, 80882.19117808864, 80905.59547202227, 82825.0, 1078.8166011778017, 1079.0504356166523, 1079.7246702090918, 1092.3445932440632, 1109.995454114028, 15615.531534053996, 15690.0, 15789.289481973108, 16009.679806403574, 16189.919050405144, 34323.14192145217, 34512.30975380528, 34960.30079398449, 35513.0, 35839.64160358363, 49875.0, 50928.74535627298, 51074.48925510697, 51230.0, 52294.0, 8396.538190399586, 8716.91283087161, 8866.290696744116, 8929.821403572023, 9105.362624616213, 11474.196806223485, 13521.391537380645, 13574.524891628746, 13692.931535342259, 13712.93143534276, 11554.191206615456, 11621.47703353368, 11942.554799697533, 11996.100292477924, 12206.145569810027, 11592.420378980849, 11625.302481851117, 11662.475188616701, 11713.121515886172, 11767.176297659424, 12064.698382540155, 12081.818772718592, 12323.69190770238, 12361.690957726129, 12444.440000199831, 8318.209770071833, 8751.431156974777, 8848.380613357003, 8908.5991130398, 8919.55402229873, 12082.818757718816, 12115.333656648969, 12218.389080546114, 12242.081843861924, 12317.137800353888], "unit": "score", "name": "jquery.html", "value": 8898.57217836734}, {"lowerIsBetter": false, "replicates": [1591.9999999999998, 1607.7749115123884, 1878.3050271399584, 1923.8460923126152, 1990.5720270141917, 8203.466774659642, 8388.748337549876, 8418.200270974256, 8531.872021919677, 8718.956405217965, 8446.028706698731, 8476.449030813008, 8519.190676885686, 8519.190676885686, 8560.143985601453, 2434.4157402223473, 2440.2923152285816, 2458.360826185196, 2459.1515927005153, 2474.2206205045445, 2461.679981602389, 2505.3987043109614, 2506.035176457059, 2522.066835270952, 2522.810789190818, 2492.239866840613, 2507.7241503434607, 2508.49830033993, 2511.0709037656093, 2514.949701005988, 2489.65144879717, 2489.8879550420274, 2507.084914006393, 2508.7114981777145, 2536.8477891326393, 2498.4503409249937, 2501.5997440409446, 2520.659710939018, 2529.3297276221815, 2540.8475491470385, 8755.25580325673, 8792.34057445694, 8814.0, 8814.382993190478, 8823.0, 5240.082985477527, 5336.759845806948, 5373.919391209135, 5384.542313903323, 5391.622586418952, 3380.9661903380897, 3396.184915620258, 3414.5219669246326, 3432.0390290718387, 3442.1738782692223, 997.6059456514708, 1023.253025291534, 1027.398971601614, 1930.3147382679228, 1934.9516262093418, 11696.18126731129, 11742.823857642057, 11801.586944456989, 11819.527218911233, 11847.88152118485, 4529.569690879427, 4615.192341340252, 4618.422697162855, 4647.465541462708, 4669.719816811003, 9366.438013719198, 9424.246060315158, 9457.668981585612, 9479.668211612698, 9487.288453366025, 5338.519533241949, 5340.359156901119, 5369.382521010056, 5372.70450125239, 5411.945880541223, 4765.11845308619, 4868.9756551217015, 4889.853304400874, 4903.41159060915, 5008.924866127011, 3486.0761898097026, 3557.5375201223674, 3580.6598373154507, 3584.8924532264073, 3586.193106551057, 1098.9945050274857, 1105.171121658756, 1113.5935383584933, 1117.8602674665667, 1142.8514293141839, 1363.7477066742683, 1366.371469124214, 1367.2411811444545, 1403.4175817035816, 1407.8099456573436, 7777.650005749755, 7867.527948323119, 7908.762737117896, 7927.286544211049, 7935.9206407936335, 525.8422473258007, 529.2220435959134, 534.9026457336781, 538.8598964269319, 549.4478049560166, 6042.758289668452, 6050.788222412194, 6092.695365231721, 6094.603850749687, 6154.076888466766, 10167.644132455476, 10483.528241229164, 10539.94730026345, 10642.73393165177, 10648.733781655366, 9579.90420095804, 10352.430616316024, 10400.739981500372, 10401.167906567456, 10592.311499752492, 8027.438079334391, 8079.636416361278, 8096.635651395702, 8193.713220037389, 8194.918050819535, 7628.42786791004, 7643.235676432535, 7706.7687969361, 7736.883946740691, 7754.612269386395, 8710.69512567057, 8778.385513014284, 9170.495622740813, 9206.815863682556, 9315.441073535609, 9234.353595248536, 9235.630574777202, 9329.813403731752, 9425.434473931586, 9494.382865114021, 7732.188120247293, 7876.291133797986, 7905.762827115196, 8043.83912321762, 8155.79610509742, 8079.87880181786, 8080.0, 8127.83744325122, 8146.022477302761, 8183.099859015622, 7037.366637002694, 7360.263973602597, 7370.815729606588, 7486.737964171228, 7547.05661792276, 7253.347198752138, 7286.599237041802, 7338.96330518344, 7421.109466864011, 7444.0, 7283.963580182065, 7293.161286452126, 7316.487845850739, 7333.1200255969625, 7337.633118344168, 6859.451243900576, 6940.479464040116, 6974.232834388112, 6983.650817459208, 6990.405815505535, 7082.114735658043, 7105.253948335557, 7132.607706576188, 7137.321954414322, 7145.17830449505], "unit": "score", "name": "mootools.html", "value": 4817.446019172224}, {"lowerIsBetter": false, "replicates": [362.95281613390256, 365.8262325395436, 369.2596344329619, 372.2573465935459, 372.3260897775027, 6334.429901308881, 6339.7464101436, 6378.2664993525705, 6388.8402789930215, 6392.296847346788, 6359.71381287842, 6363.268224154223, 6365.299817020135, 6382.617042977425, 6405.775797847076, 4779.402574678165, 4857.708537487744, 4902.362692849924, 4916.655834091615, 4971.428285747131, 4895.192293271606, 4924.532169443897, 4928.1129396708575, 4931.0630980113665, 4946.282788995612, 4882.56056954874, 4894.608431325503, 4896.045271172123, 4896.290037944496, 4905.043516514281, 4881.8291359802415, 4902.681325713835, 4908.950910490885, 4909.165441874889, 4914.410270767531, 4312.568743125694, 4315.978420107911, 4320.956790432087, 4323.956760432418, 4331.415258940035, 5874.1776151338845, 6122.47958923492, 6134.447899689005, 6137.478314343286, 6138.8772224555705, 5622.297212848394, 5623.8594035149035, 5624.21261023457, 5635.943640563582, 5643.266375371217, 6815.829604259933, 6817.386435220805, 6826.93173068268, 6833.829154271133, 6840.863182736367, 4739.312799644033, 4739.976300118512, 4742.668013239075, 4743.0988112258565, 4747.074320507502, 7013.684384202672, 7067.15194176697, 7096.751613693547, 7097.787066388017, 7116.679749411237, 4725.078609671081, 4845.466998630148, 4857.9028419432125, 4892.168331383673, 4899.167141585939, 4914.852554423373, 4943.110240156806, 4948.307236986825, 4949.628777841676, 4960.603151747851, 5695.686737229492, 5702.7433765480655, 5708.40061793514, 5708.71456427177, 5714.171445140514, 6828.829279268058, 6833.248342682301, 6854.074699915447, 6858.622775747382, 6876.759313424006, 1721.277063633277, 1759.8856074355126, 1761.1722490429477, 1762.3303144804893, 1763.938262160818, 1125.9943700281447, 1144.3477217985835, 1158.2355645274247, 1159.478234794346, 1177.3465726521863, 6627.304133066055, 6639.800805975829, 6653.600783952978, 6717.764878229238, 6721.6975236114495, 7038.40173585251, 7072.611006394698, 7080.575165490087, 7085.32689394517, 7092.113485814273, 6505.381988711065, 6566.6388348641285, 6600.702968366435, 6615.338466153346, 6627.801165965029, 3839.2705385976574, 3849.230153969161, 3853.537575490903, 3857.691384689218, 3859.55615104261, 7385.900825042153, 7407.9999200107295, 7409.444291678145, 7411.332980031823, 7422.703091876372, 7296.671649775667, 7300.342969132804, 7312.268773122752, 7338.376238019828, 7343.522671026366, 7202.135743710788, 7475.738349157645, 7481.700731970769, 7487.5507469552, 7495.775126746206, 7082.362587367162, 7115.430765538848, 7119.252478489684, 7137.750178743719, 7138.428925685829, 6959.582425054513, 7000.299970003162, 7019.473539484661, 7029.332213439715, 7032.894506582507, 7289.068396874726, 7424.0, 7446.627668616439, 7447.962760186165, 7453.068366454193, 4858.58702010333, 4899.632527560376, 4911.950880491292, 4913.70517768935, 4916.70499770015, 7080.362767350963, 7090.964545177241, 7111.217766045835, 7112.644367781487, 7123.465740069412, 6835.965820171066, 6884.311568843075, 6889.345512176335, 6891.310868913069, 6899.068625735462, 6788.389044985975, 6882.380585747307, 6887.93112068893, 6891.655417229018, 6967.1291088613925, 6706.463482921452, 6772.52592318533, 6773.119494465688, 6787.490938179755, 6792.113351825553, 6899.0341352209725, 6904.067950826574, 6932.688029038604, 6947.4789390796905, 6967.54710943787, 6775.186977562724, 6775.728970841111, 6777.0, 6779.186497620317, 6785.626790526569], "unit": "score", "name": "prototype.html", "value": 5179.792336620917}, {"lowerIsBetter": false, "replicates": [751.6767789850369, 810.339573247803, 820.8973878265217, 864.084070884862, 915.2860768600491, 14570.635734106652, 14887.330070146842, 14887.925560372196, 14910.478133265338, 14938.626534336634, 13290.468381264762, 13384.732305353911, 13398.12912160709, 13405.530806421777, 13458.865411345883, 766.0692258905443, 914.8856392950881, 935.1817159985013, 935.9719208423725, 937.0348541002778, 901.8466860633708, 903.9638414463413, 906.9410488318272, 907.5280853955938, 908.1735620585268, 974.4250891973734, 975.6633961283381, 976.3507267666993, 976.775341671416, 977.0669011094424, 963.2149797914677, 968.1963969904962, 969.6654654144344, 971.3977334052862, 974.2644303550809, 721.6499997501207, 722.2488611843677, 724.2576359231776, 727.752564128199, 728.2462651156028, 14870.0, 14913.701725965528, 14941.70116597662, 14996.47512337074, 15039.323230454656, 14006.439742410292, 14246.643833904132, 14498.782518262235, 14572.70854582913, 14732.410703571844, 11798.0, 11858.051355891508, 12110.697232569168, 12251.326177060258, 12399.318037507934, 3936.5472970608175, 3950.071733142709, 4000.3799411091327, 4041.838326466938, 4044.1911617676583, 47652.523474765505, 47704.04591908177, 47889.52110478885, 48064.75967620139, 48137.75931120357, 10216.540255688511, 10569.788604227871, 10637.787244255072, 10702.892971070345, 10727.409992450333, 19410.4176874694, 19417.902910485638, 19456.124474398686, 19495.220191192195, 19523.414297571097, 7619.0, 7832.960835195788, 7870.527768333918, 7921.049474063034, 7926.365890728728, 4330.956690433055, 4435.2016637005645, 4500.054988452462, 4501.549845015472, 4558.0655965526985, 3421.469672200813, 3478.32172726321, 3484.7560670752805, 3498.2129020970588, 3507.7895326280504, 603.408659513679, 615.0896672924098, 617.1945610977627, 623.803501896901, 626.6709977261883, 578.0866231354449, 652.9477641788645, 653.5980372071142, 654.8297442664846, 660.2704012066597, 8120.147384524658, 8201.8359632807, 8653.524056176844, 8762.255208307237, 8931.687390941286, 593.5459373579215, 634.2547506679633, 636.6053047110821, 637.9170707807955, 659.6437923521245, 3885.300645883768, 4217.810198541073, 4222.704410691222, 4327.7619730914475, 4378.759168245777, 58527.0, 59774.70112649496, 60071.098933516034, 60175.39824601698, 60313.09530357048, 52996.20505692418, 53154.7342263294, 54060.45939540633, 54430.455695442535, 54558.45441545613, 49204.75397622989, 49423.25865112026, 49893.501064988886, 49991.99999999927, 50496.242556361685, 8167.754967350989, 8484.787880303042, 8514.78713032179, 8588.22705956467, 8684.39209255346, 36902.630973691, 36992.81503592465, 37726.811365942995, 37816.81091594524, 37932.3101534772, 43403.348949765146, 43453.130937381706, 46979.76510117428, 47540.0, 47933.0, 10298.124659404035, 10626.36241825493, 10821.837672434762, 10839.241253112206, 10905.945470272598, 12021.398930053638, 12146.331951742739, 12249.938750306192, 12283.0, 12429.192102513307, 10573.207009474167, 10605.787884242427, 10758.51586678617, 11025.83461248098, 11315.321080735182, 10827.51276192589, 11109.611163609236, 11481.311121332747, 11574.537018519502, 12727.236365817711, 10736.51685674131, 10878.40168790724, 11120.499577519193, 11149.888501114885, 12326.81509777372, 10365.222608304257, 10381.584736610452, 10468.319559228627, 10937.890621094006, 11482.36846973391, 10415.062644362044, 10495.737606559896, 10649.339062941295, 10692.14462842955, 10895.455227238765], "unit": "score", "name": "yui.html", "value": 6687.024944464048}], "name": "dromaeo_css", "value": 7412.771157327025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 113.0, 109.0, 110.0, 121.0, 111.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [152.0, 137.0, 158.0, 178.0, 128.0, 155.0, 151.0, 128.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 164.0, 164.0, 164.0, 163.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [76.0, 81.0, 74.0, 168.0, 77.0, 77.0, 77.0, 76.0, 161.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 143.0, 93.0, 93.0, 94.0, 138.0, 93.0, 93.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 119.0, 116.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 56.0, 55.0, 59.0, 55.0, 56.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 72.0, 72.0, 72.0, 73.0, 72.0, 73.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.6}, {"lowerIsBetter": true, "replicates": [77.0, 86.0, 81.0, 80.0, 79.0, 80.0, 80.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 115.0, 123.0, 120.0, 113.0, 115.0, 113.0, 112.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [143.0, 150.0, 146.0, 149.0, 148.0, 138.0, 151.0, 146.0, 149.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 66.0, 78.0, 69.0, 74.0, 66.0, 70.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1526.1}]} 20:36:53 INFO - Return code: 0 20:36:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:36:53 ERROR - # TBPL SUCCESS # 20:36:53 INFO - Running post-action listener: _resource_record_post_action 20:36:53 INFO - Running post-run listener: _resource_record_post_run 20:36:54 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 460320768; Read time: 28; Write time: 467408 20:36:54 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 238039040; Read time: 0; Write time: 317824 20:36:54 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 16384; Write bytes: 222281728; Read time: 28; Write time: 149584 20:36:54 INFO - Running post-run listener: _upload_blobber_files 20:36:54 INFO - Blob upload gear active. 20:36:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:54 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:36:54 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:36:54 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:36:54 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:55 INFO - (blobuploader) - INFO - Done attempting. 20:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:56 INFO - (blobuploader) - INFO - Done attempting. 20:36:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:56 INFO - Return code: 0 20:36:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/597c3fa8963dca442e5c426701178d9e16fb4a5ea25618de3f8c256a09a7b678bd13ea06c2e9a69f66225c78991e8c9f7ae2b91375040e40fc7db96b867d350b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0429930fafc516e99fb2cfdfcaab549d96b3b81313b579c4023aa6c3df379c36c4d78f600ba8cbaca0b6da575a51bacb6ca784656a9b8f4e0745c17381fbe2d"} 20:36:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:56 INFO - Contents: 20:36:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/597c3fa8963dca442e5c426701178d9e16fb4a5ea25618de3f8c256a09a7b678bd13ea06c2e9a69f66225c78991e8c9f7ae2b91375040e40fc7db96b867d350b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0429930fafc516e99fb2cfdfcaab549d96b3b81313b579c4023aa6c3df379c36c4d78f600ba8cbaca0b6da575a51bacb6ca784656a9b8f4e0745c17381fbe2d"} 20:36:56 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:56 INFO - Copying logs to upload dir... 20:36:56 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.118585 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-14 20:36:56.337082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 20:36:56.340876) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210 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/597c3fa8963dca442e5c426701178d9e16fb4a5ea25618de3f8c256a09a7b678bd13ea06c2e9a69f66225c78991e8c9f7ae2b91375040e40fc7db96b867d350b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0429930fafc516e99fb2cfdfcaab549d96b3b81313b579c4023aa6c3df379c36c4d78f600ba8cbaca0b6da575a51bacb6ca784656a9b8f4e0745c17381fbe2d"} build_url:https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/UESxonQ3SWeDd6oY0cTHpA/artifacts/public/build/firefox-47.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/597c3fa8963dca442e5c426701178d9e16fb4a5ea25618de3f8c256a09a7b678bd13ea06c2e9a69f66225c78991e8c9f7ae2b91375040e40fc7db96b867d350b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0429930fafc516e99fb2cfdfcaab549d96b3b81313b579c4023aa6c3df379c36c4d78f600ba8cbaca0b6da575a51bacb6ca784656a9b8f4e0745c17381fbe2d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 20:36:56.366026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:36:56.366513) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463278941.742183-2008286210 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 20:36:56.450968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 20:36:56.451274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 20:36:56.451582) ========= ========= Total master_lag: 0.17 =========