builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1464037257.09 results: success (0) buildid: 20160523111242 builduid: 639b9d3aeb644c6896626fcf57d0116a revision: 59dbf171604d52960e6e54cbefdb52d7bbcb989d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.088416) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.089023) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.089537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.106611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.106911) ========= 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-1464037257.850344-1757129479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 14:00:58-- 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% 225M=0s 2016-05-23 14:00:58 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084822 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.205345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.205692) ========= 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-1464037257.850344-1757129479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014773 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.255306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.255685) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59dbf171604d52960e6e54cbefdb52d7bbcb989d --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 59dbf171604d52960e6e54cbefdb52d7bbcb989d --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-1464037257.850344-1757129479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 14:00:58,802 truncating revision to first 12 chars 2016-05-23 14:00:58,802 Setting DEBUG logging. 2016-05-23 14:00:58,802 attempt 1/10 2016-05-23 14:00:58,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/59dbf171604d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 14:00:59,059 unpacking tar archive at: mozilla-beta-59dbf171604d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545334 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.817558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.818233) ========= script_repo_revision: 59dbf171604d52960e6e54cbefdb52d7bbcb989d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.818992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.819256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:00:57.829288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-05-23 14:00:57.829608) ========= /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-1464037257.850344-1757129479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:59 INFO - MultiFileLogger online at 20160523 14:00:59 in /builds/slave/test 14:00:59 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 14:00:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:00:59 INFO - {'append_to_log': False, 14:00:59 INFO - 'base_work_dir': '/builds/slave/test', 14:00:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:00:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:00:59 INFO - 'branch': 'Mozilla-Beta', 14:00:59 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:59 INFO - 'config_files': ('talos/linux_config.py',), 14:00:59 INFO - 'default_actions': ('clobber', 14:00:59 INFO - 'read-buildbot-config', 14:00:59 INFO - 'download-and-extract', 14:00:59 INFO - 'populate-webroot', 14:00:59 INFO - 'create-virtualenv', 14:00:59 INFO - 'install', 14:00:59 INFO - 'run-tests'), 14:00:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:59 INFO - 'download_minidump_stackwalk': True, 14:00:59 INFO - 'download_symbols': 'ondemand', 14:00:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:59 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:59 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:59 INFO - 'installer_path': 'installer.exe', 14:00:59 INFO - 'log_level': 'info', 14:00:59 INFO - 'log_name': 'talos', 14:00:59 INFO - 'log_to_console': True, 14:00:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:59 INFO - 'opt_config_files': (), 14:00:59 INFO - 'pip_index': False, 14:00:59 INFO - 'sps_profile': False, 14:00:59 INFO - 'sps_profile_interval': 0, 14:00:59 INFO - 'suite': 'dromaeojs-e10s', 14:00:59 INFO - 'system_bits': '32', 14:00:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:59 INFO - 'title': 'talos-linux64-ix-004', 14:00:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:59 INFO - 'use_talos_json': True, 14:00:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:00:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:59 INFO - 'work_dir': 'build'} 14:00:59 INFO - ##### 14:00:59 INFO - ##### Running clobber step. 14:00:59 INFO - ##### 14:00:59 INFO - Running pre-action listener: _resource_record_pre_action 14:00:59 INFO - Running main action method: clobber 14:00:59 INFO - rmtree: /builds/slave/test/build 14:00:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:00 INFO - Running post-action listener: _resource_record_post_action 14:01:00 INFO - ##### 14:01:00 INFO - ##### Running read-buildbot-config step. 14:01:00 INFO - ##### 14:01:00 INFO - Running pre-action listener: _resource_record_pre_action 14:01:00 INFO - Running main action method: read_buildbot_config 14:01:00 INFO - Using buildbot properties: 14:01:00 INFO - { 14:01:00 INFO - "project": "", 14:01:00 INFO - "product": "firefox", 14:01:00 INFO - "script_repo_revision": "production", 14:01:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:01:00 INFO - "repository": "", 14:01:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 14:01:00 INFO - "buildid": "20160523111242", 14:01:00 INFO - "pgo_build": "True", 14:01:00 INFO - "basedir": "/builds/slave/test", 14:01:00 INFO - "buildnumber": 118, 14:01:00 INFO - "slavename": "talos-linux64-ix-004", 14:01:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:01:00 INFO - "platform": "ubuntu64_hw", 14:01:00 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:01:00 INFO - "branch": "mozilla-beta", 14:01:00 INFO - "repo_path": "releases/mozilla-beta", 14:01:00 INFO - "revision": "59dbf171604d52960e6e54cbefdb52d7bbcb989d", 14:01:00 INFO - "stage_platform": "linux64-pgo", 14:01:00 INFO - "builduid": "639b9d3aeb644c6896626fcf57d0116a", 14:01:00 INFO - "slavebuilddir": "test" 14:01:00 INFO - } 14:01:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 14:01:00 INFO - Running post-action listener: _resource_record_post_action 14:01:00 INFO - ##### 14:01:00 INFO - ##### Running download-and-extract step. 14:01:00 INFO - ##### 14:01:00 INFO - Running pre-action listener: _resource_record_pre_action 14:01:00 INFO - Running main action method: download_and_extract 14:01:00 INFO - mkdir: /builds/slave/test/build/tests 14:01:00 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')]} 14:01:00 INFO - https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:01 INFO - Downloaded 1412 bytes. 14:01:01 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 14:01:01 INFO - Using the following test package requirements: 14:01:01 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:01:01 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:01:01 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 14:01:01 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'jsshell-linux-x86_64.zip'], 14:01:01 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:01:01 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:01:01 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 14:01:01 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 14:01:01 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:01:01 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 14:01:01 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 14:01:01 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:01:01 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:01 INFO - https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:02 INFO - Downloaded 23364948 bytes. 14:01:02 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'] 14:01:02 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 14:01:03 INFO - Return code: 0 14:01:03 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 14:01: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')]} 14:01:03 INFO - https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 14:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:04 INFO - Downloaded 23364948 bytes. 14:01:04 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'] 14:01:04 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 14:01:06 INFO - Return code: 0 14:01: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')]} 14:01:06 INFO - https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 14:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:07 INFO - Downloaded 10845194 bytes. 14:01:07 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'] 14:01:07 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 14:01:07 INFO - Return code: 0 14:01:07 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')]} 14:01:07 INFO - https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:08 INFO - Downloaded 53796144 bytes. 14:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:08 INFO - mkdir: /builds/slave/test/properties 14:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:08 INFO - Contents: 14:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 14:01:09 INFO - Running post-action listener: _resource_record_post_action 14:01:09 INFO - Running post-action listener: set_extra_try_arguments 14:01:09 INFO - ##### 14:01:09 INFO - ##### Running populate-webroot step. 14:01:09 INFO - ##### 14:01:09 INFO - Running pre-action listener: _resource_record_pre_action 14:01:09 INFO - Running main action method: populate_webroot 14:01:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:09 INFO - '--tppagecycles', 14:01:09 INFO - '7'], 14:01:09 INFO - 'tests': ['tsvgm']}}, 14:01:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:01:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'tests': ['damp', 'tps']}, 14:01:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['damp', 'tps']}, 14:01:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:09 INFO - 'other': {'tests': ['a11yr', 14:01:09 INFO - 'ts_paint', 14:01:09 INFO - 'tpaint', 14:01:09 INFO - 'sessionrestore', 14:01:09 INFO - 'sessionrestore_no_auto_restore', 14:01:09 INFO - 'tabpaint']}, 14:01:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['a11yr', 14:01:09 INFO - 'ts_paint', 14:01:09 INFO - 'tpaint', 14:01:09 INFO - 'sessionrestore', 14:01:09 INFO - 'sessionrestore_no_auto_restore', 14:01:09 INFO - 'tabpaint']}, 14:01:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['a11yr', 14:01:09 INFO - 'ts_paint', 14:01:09 INFO - 'tpaint', 14:01:09 INFO - 'sessionrestore', 14:01:09 INFO - 'sessionrestore_no_auto_restore', 14:01:09 INFO - 'tabpaint']}, 14:01:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['a11yr', 14:01:09 INFO - 'ts_paint', 14:01:09 INFO - 'tpaint', 14:01:09 INFO - 'sessionrestore', 14:01:09 INFO - 'sessionrestore_no_auto_restore', 14:01:09 INFO - 'tabpaint']}, 14:01:09 INFO - 'other_l64': {'tests': ['a11yr', 14:01:09 INFO - 'ts_paint', 14:01:09 INFO - 'tpaint', 14:01:09 INFO - 'sessionrestore', 14:01:09 INFO - 'sessionrestore_no_auto_restore', 14:01:09 INFO - 'tabpaint']}, 14:01:09 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:09 INFO - 'ts_paint', 14:01:09 INFO - 'tpaint', 14:01:09 INFO - 'sessionrestore', 14:01:09 INFO - 'sessionrestore_no_auto_restore', 14:01:09 INFO - 'tabpaint']}, 14:01:09 INFO - 'svgr': {'tests': ['tsvgx', 14:01:09 INFO - 'tsvgr_opacity', 14:01:09 INFO - 'tart', 14:01:09 INFO - 'tscrollx', 14:01:09 INFO - 'cart']}, 14:01:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['tsvgx', 14:01:09 INFO - 'tsvgr_opacity', 14:01:09 INFO - 'tart', 14:01:09 INFO - 'tscrollx', 14:01:09 INFO - 'cart']}, 14:01:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'tests': ['tp5o']}, 14:01:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'talos_options': ['--e10s'], 14:01:09 INFO - 'tests': ['tp5o']}, 14:01:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'talos_options': ['--xperf_path', 14:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:09 INFO - 'tests': ['tp5n']}, 14:01:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:09 INFO - 'talos_options': ['--e10s', 14:01:09 INFO - '--xperf_path', 14:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:09 INFO - 'tests': ['tp5n']}}, 14:01:09 INFO - 'talos.zip': {'path': '', 14:01:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:09 INFO - Running post-action listener: _resource_record_post_action 14:01:09 INFO - ##### 14:01:09 INFO - ##### Running create-virtualenv step. 14:01:09 INFO - ##### 14:01:09 INFO - Running pre-action listener: _resource_record_pre_action 14:01:09 INFO - Running main action method: create_virtualenv 14:01:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:09 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 14:01:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:09 INFO - Using real prefix '/usr' 14:01:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:10 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:12 INFO - Installing pip.................done. 14:01:12 INFO - Return code: 0 14:01:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:01:12 INFO - Using env: {'DISPLAY': ':0', 14:01:12 INFO - 'HOME': '/home/cltbld', 14:01:12 INFO - 'LANG': 'en_US.UTF-8', 14:01:12 INFO - 'LANGUAGE': 'en_US:en', 14:01:12 INFO - 'LOGNAME': 'cltbld', 14:01:12 INFO - 'MAIL': '/var/mail/cltbld', 14:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:12 INFO - 'MOZ_NO_REMOTE': '1', 14:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:12 INFO - 'NO_EM_RESTART': '1', 14:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:12 INFO - 'PWD': '/builds/slave/test', 14:01:12 INFO - 'SHELL': '/bin/bash', 14:01:12 INFO - 'SHLVL': '1', 14:01:12 INFO - 'TERM': 'linux', 14:01:12 INFO - 'TMOUT': '86400', 14:01:12 INFO - 'USER': 'cltbld', 14:01:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:12 INFO - '_': '/tools/buildbot/bin/python'} 14:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:12 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 14:01:12 INFO - Cleaning up... 14:01:12 INFO - Return code: 0 14:01:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:01:12 INFO - Using env: {'DISPLAY': ':0', 14:01:12 INFO - 'HOME': '/home/cltbld', 14:01:12 INFO - 'LANG': 'en_US.UTF-8', 14:01:12 INFO - 'LANGUAGE': 'en_US:en', 14:01:12 INFO - 'LOGNAME': 'cltbld', 14:01:12 INFO - 'MAIL': '/var/mail/cltbld', 14:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:12 INFO - 'MOZ_NO_REMOTE': '1', 14:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:12 INFO - 'NO_EM_RESTART': '1', 14:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:12 INFO - 'PWD': '/builds/slave/test', 14:01:12 INFO - 'SHELL': '/bin/bash', 14:01:12 INFO - 'SHLVL': '1', 14:01:12 INFO - 'TERM': 'linux', 14:01:12 INFO - 'TMOUT': '86400', 14:01:12 INFO - 'USER': 'cltbld', 14:01:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:12 INFO - '_': '/tools/buildbot/bin/python'} 14:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:12 INFO - Downloading/unpacking psutil>=0.7.1 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:14 INFO - Installing collected packages: psutil 14:01:14 INFO - Running setup.py install for psutil 14:01:14 INFO - building 'psutil._psutil_linux' extension 14:01:14 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 14:01:14 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 14:01:14 INFO - building 'psutil._psutil_posix' extension 14:01:14 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 14:01:15 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 14:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:15 INFO - Successfully installed psutil 14:01:15 INFO - Cleaning up... 14:01:15 INFO - Return code: 0 14:01:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:01:15 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')]} 14:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:15 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')]} 14:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:15 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:15 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 14:01:15 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 14:01:15 INFO - Using env: {'DISPLAY': ':0', 14:01:15 INFO - 'HOME': '/home/cltbld', 14:01:15 INFO - 'LANG': 'en_US.UTF-8', 14:01:15 INFO - 'LANGUAGE': 'en_US:en', 14:01:15 INFO - 'LOGNAME': 'cltbld', 14:01:15 INFO - 'MAIL': '/var/mail/cltbld', 14:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:15 INFO - 'MOZ_NO_REMOTE': '1', 14:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:15 INFO - 'NO_EM_RESTART': '1', 14:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:15 INFO - 'PWD': '/builds/slave/test', 14:01:15 INFO - 'SHELL': '/bin/bash', 14:01:15 INFO - 'SHLVL': '1', 14:01:15 INFO - 'TERM': 'linux', 14:01:15 INFO - 'TMOUT': '86400', 14:01:15 INFO - 'USER': 'cltbld', 14:01:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:15 INFO - '_': '/tools/buildbot/bin/python'} 14:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:15 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 14:01:15 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 14:01:15 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 14:01:15 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 14:01:15 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 14:01:15 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 14:01:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:17 INFO - Installing collected packages: mozsystemmonitor 14:01:17 INFO - Running setup.py install for mozsystemmonitor 14:01:17 INFO - Successfully installed mozsystemmonitor 14:01:17 INFO - Cleaning up... 14:01:17 INFO - Return code: 0 14:01:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:01:17 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')]} 14:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:17 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')]} 14:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:17 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:17 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 14:01:17 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 14:01:17 INFO - Using env: {'DISPLAY': ':0', 14:01:17 INFO - 'HOME': '/home/cltbld', 14:01:17 INFO - 'LANG': 'en_US.UTF-8', 14:01:17 INFO - 'LANGUAGE': 'en_US:en', 14:01:17 INFO - 'LOGNAME': 'cltbld', 14:01:17 INFO - 'MAIL': '/var/mail/cltbld', 14:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:17 INFO - 'MOZ_NO_REMOTE': '1', 14:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:17 INFO - 'NO_EM_RESTART': '1', 14:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:17 INFO - 'PWD': '/builds/slave/test', 14:01:17 INFO - 'SHELL': '/bin/bash', 14:01:17 INFO - 'SHLVL': '1', 14:01:17 INFO - 'TERM': 'linux', 14:01:17 INFO - 'TMOUT': '86400', 14:01:17 INFO - 'USER': 'cltbld', 14:01:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:17 INFO - '_': '/tools/buildbot/bin/python'} 14:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:17 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:19 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 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 14:01:19 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 14:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:01:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 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 14:01:20 INFO - Downloading docopt-0.6.1.tar.gz 14:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:20 INFO - Running setup.py install for blobuploader 14:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:01:20 INFO - Running setup.py install for requests 14:01:20 INFO - Running setup.py install for docopt 14:01:21 INFO - Successfully installed blobuploader requests docopt 14:01:21 INFO - Cleaning up... 14:01:21 INFO - Return code: 0 14:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:21 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:21 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 14:01:21 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 14:01:21 INFO - Using env: {'DISPLAY': ':0', 14:01:21 INFO - 'HOME': '/home/cltbld', 14:01:21 INFO - 'LANG': 'en_US.UTF-8', 14:01:21 INFO - 'LANGUAGE': 'en_US:en', 14:01:21 INFO - 'LOGNAME': 'cltbld', 14:01:21 INFO - 'MAIL': '/var/mail/cltbld', 14:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:21 INFO - 'MOZ_NO_REMOTE': '1', 14:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:21 INFO - 'NO_EM_RESTART': '1', 14:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:21 INFO - 'PWD': '/builds/slave/test', 14:01:21 INFO - 'SHELL': '/bin/bash', 14:01:21 INFO - 'SHLVL': '1', 14:01:21 INFO - 'TERM': 'linux', 14:01:21 INFO - 'TMOUT': '86400', 14:01:21 INFO - 'USER': 'cltbld', 14:01:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:21 INFO - '_': '/tools/buildbot/bin/python'} 14:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:21 INFO - Running setup.py (path:/tmp/pip-Mp40Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:21 INFO - Running setup.py (path:/tmp/pip-jWsSSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:21 INFO - Running setup.py (path:/tmp/pip-cMKP0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:21 INFO - Running setup.py (path:/tmp/pip-Bg0AnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:21 INFO - Running setup.py (path:/tmp/pip-XZkyoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:21 INFO - Running setup.py (path:/tmp/pip-4yTlU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:21 INFO - Running setup.py (path:/tmp/pip-D_P6No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:21 INFO - Running setup.py (path:/tmp/pip-328qDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:21 INFO - Running setup.py (path:/tmp/pip-5yk96I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:21 INFO - Running setup.py (path:/tmp/pip-NPR4YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:22 INFO - Running setup.py (path:/tmp/pip-NhRkXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:22 INFO - Running setup.py (path:/tmp/pip-DMNXl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:22 INFO - Running setup.py (path:/tmp/pip-9gEvR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:22 INFO - Running setup.py (path:/tmp/pip-hC3ttu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:22 INFO - Running setup.py (path:/tmp/pip-z7TvVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:22 INFO - Running setup.py (path:/tmp/pip-D8Zdx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:22 INFO - Running setup.py (path:/tmp/pip-XGkArl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:22 INFO - Running setup.py install for manifestparser 14:01:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozcrash 14:01:22 INFO - Running setup.py install for mozdebug 14:01:22 INFO - Running setup.py install for mozdevice 14:01:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Running setup.py install for mozfile 14:01:23 INFO - Running setup.py install for mozhttpd 14:01:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Running setup.py install for mozinfo 14:01:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Running setup.py install for mozInstall 14:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Running setup.py install for mozleak 14:01:23 INFO - Running setup.py install for mozlog 14:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Running setup.py install for moznetwork 14:01:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Running setup.py install for mozprocess 14:01:23 INFO - Running setup.py install for mozprofile 14:01:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:01:23 INFO - Running setup.py install for mozrunner 14:01:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:01:24 INFO - Running setup.py install for mozscreenshot 14:01:24 INFO - Running setup.py install for moztest 14:01:24 INFO - Running setup.py install for mozversion 14:01:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:24 INFO - Cleaning up... 14:01:24 INFO - Return code: 0 14:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:24 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')]} 14:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:24 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')]} 14:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:24 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:24 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 14:01:24 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 14:01:24 INFO - Using env: {'DISPLAY': ':0', 14:01:24 INFO - 'HOME': '/home/cltbld', 14:01:24 INFO - 'LANG': 'en_US.UTF-8', 14:01:24 INFO - 'LANGUAGE': 'en_US:en', 14:01:24 INFO - 'LOGNAME': 'cltbld', 14:01:24 INFO - 'MAIL': '/var/mail/cltbld', 14:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:24 INFO - 'MOZ_NO_REMOTE': '1', 14:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:24 INFO - 'NO_EM_RESTART': '1', 14:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:24 INFO - 'PWD': '/builds/slave/test', 14:01:24 INFO - 'SHELL': '/bin/bash', 14:01:24 INFO - 'SHLVL': '1', 14:01:24 INFO - 'TERM': 'linux', 14:01:24 INFO - 'TMOUT': '86400', 14:01:24 INFO - 'USER': 'cltbld', 14:01:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:24 INFO - '_': '/tools/buildbot/bin/python'} 14:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:24 INFO - Running setup.py (path:/tmp/pip-XSrHuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:24 INFO - Running setup.py (path:/tmp/pip-_XOyDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:24 INFO - Running setup.py (path:/tmp/pip-NwzyBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:24 INFO - Running setup.py (path:/tmp/pip-k4c_OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:24 INFO - Running setup.py (path:/tmp/pip-9JdcTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:24 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)) 14:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:24 INFO - Running setup.py (path:/tmp/pip-YZMZ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:25 INFO - Running setup.py (path:/tmp/pip-WnQZ8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:25 INFO - Running setup.py (path:/tmp/pip-ilRz98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:25 INFO - Running setup.py (path:/tmp/pip-A94qXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:25 INFO - Running setup.py (path:/tmp/pip-yYSe9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:25 INFO - Running setup.py (path:/tmp/pip-n7g66G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:25 INFO - Running setup.py (path:/tmp/pip-VZC788-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:25 INFO - Running setup.py (path:/tmp/pip-FDcOgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:25 INFO - Running setup.py (path:/tmp/pip-LyaxoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:25 INFO - Running setup.py (path:/tmp/pip-NpxRV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:25 INFO - Running setup.py (path:/tmp/pip-JOa8UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:25 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)) 14:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:25 INFO - Running setup.py (path:/tmp/pip-4NVmdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:27 INFO - Downloading blessings-1.6.tar.gz 14:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:27 INFO - Installing collected packages: blessings 14:01:27 INFO - Running setup.py install for blessings 14:01:27 INFO - Successfully installed blessings 14:01:27 INFO - Cleaning up... 14:01:27 INFO - Return code: 0 14:01:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:01:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:28 INFO - Reading from file tmpfile_stdout 14:01:28 INFO - Current package versions: 14:01:28 INFO - argparse == 1.2.1 14:01:28 INFO - blessings == 1.6 14:01:28 INFO - blobuploader == 1.2.4 14:01:28 INFO - docopt == 0.6.1 14:01:28 INFO - manifestparser == 1.1 14:01:28 INFO - mozInstall == 1.12 14:01:28 INFO - mozcrash == 0.17 14:01:28 INFO - mozdebug == 0.1 14:01:28 INFO - mozdevice == 0.48 14:01:28 INFO - mozfile == 1.2 14:01:28 INFO - mozhttpd == 0.7 14:01:28 INFO - mozinfo == 0.9 14:01:28 INFO - mozleak == 0.1 14:01:28 INFO - mozlog == 3.1 14:01:28 INFO - moznetwork == 0.27 14:01:28 INFO - mozprocess == 0.22 14:01:28 INFO - mozprofile == 0.28 14:01:28 INFO - mozrunner == 6.11 14:01:28 INFO - mozscreenshot == 0.1 14:01:28 INFO - mozsystemmonitor == 0.0 14:01:28 INFO - moztest == 0.7 14:01:28 INFO - mozversion == 1.4 14:01:28 INFO - psutil == 3.1.1 14:01:28 INFO - requests == 1.2.3 14:01:28 INFO - wsgiref == 0.1.2 14:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:28 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')]} 14:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:28 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')]} 14:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:28 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:28 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 14:01:28 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 14:01:28 INFO - Using env: {'DISPLAY': ':0', 14:01:28 INFO - 'HOME': '/home/cltbld', 14:01:28 INFO - 'LANG': 'en_US.UTF-8', 14:01:28 INFO - 'LANGUAGE': 'en_US:en', 14:01:28 INFO - 'LOGNAME': 'cltbld', 14:01:28 INFO - 'MAIL': '/var/mail/cltbld', 14:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:28 INFO - 'MOZ_NO_REMOTE': '1', 14:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:28 INFO - 'NO_EM_RESTART': '1', 14:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:28 INFO - 'PWD': '/builds/slave/test', 14:01:28 INFO - 'SHELL': '/bin/bash', 14:01:28 INFO - 'SHLVL': '1', 14:01:28 INFO - 'TERM': 'linux', 14:01:28 INFO - 'TMOUT': '86400', 14:01:28 INFO - 'USER': 'cltbld', 14:01:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:28 INFO - '_': '/tools/buildbot/bin/python'} 14:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 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)) 14:01:28 INFO - Cleaning up... 14:01:28 INFO - Return code: 0 14:01:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:01:28 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')]} 14:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:28 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')]} 14:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:28 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:28 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 14:01:28 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 14:01:28 INFO - Using env: {'DISPLAY': ':0', 14:01:28 INFO - 'HOME': '/home/cltbld', 14:01:28 INFO - 'LANG': 'en_US.UTF-8', 14:01:28 INFO - 'LANGUAGE': 'en_US:en', 14:01:28 INFO - 'LOGNAME': 'cltbld', 14:01:28 INFO - 'MAIL': '/var/mail/cltbld', 14:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:28 INFO - 'MOZ_NO_REMOTE': '1', 14:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:28 INFO - 'NO_EM_RESTART': '1', 14:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:28 INFO - 'PWD': '/builds/slave/test', 14:01:28 INFO - 'SHELL': '/bin/bash', 14:01:28 INFO - 'SHLVL': '1', 14:01:28 INFO - 'TERM': 'linux', 14:01:28 INFO - 'TMOUT': '86400', 14:01:28 INFO - 'USER': 'cltbld', 14:01:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:28 INFO - '_': '/tools/buildbot/bin/python'} 14:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:28 INFO - Downloading/unpacking jsonschema 14:01:28 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 14:01:28 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 14:01:28 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 14:01:28 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 14:01:28 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 14:01:28 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 14:01:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:30 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:30 INFO - warning: no files found matching '*.txt' 14:01:30 INFO - no previously-included directories found matching 'build' 14:01:30 INFO - no previously-included directories found matching 'dist' 14:01:30 INFO - no previously-included directories found matching '.git*' 14:01:30 INFO - Installing collected packages: jsonschema, functools32 14:01:30 INFO - Running setup.py install for functools32 14:01:30 INFO - warning: no files found matching '*.txt' 14:01:30 INFO - no previously-included directories found matching 'build' 14:01:30 INFO - no previously-included directories found matching 'dist' 14:01:30 INFO - no previously-included directories found matching '.git*' 14:01:30 INFO - Successfully installed jsonschema functools32 14:01:30 INFO - Cleaning up... 14:01:31 INFO - Return code: 0 14:01:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:01: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')]} 14:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:31 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 0x7f292dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f25410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, '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-1464037257.850344-1757129479', '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 14:01:31 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 14:01:31 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 14:01:31 INFO - Using env: {'DISPLAY': ':0', 14:01:31 INFO - 'HOME': '/home/cltbld', 14:01:31 INFO - 'LANG': 'en_US.UTF-8', 14:01:31 INFO - 'LANGUAGE': 'en_US:en', 14:01:31 INFO - 'LOGNAME': 'cltbld', 14:01:31 INFO - 'MAIL': '/var/mail/cltbld', 14:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:31 INFO - 'MOZ_NO_REMOTE': '1', 14:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:31 INFO - 'NO_EM_RESTART': '1', 14:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:31 INFO - 'PWD': '/builds/slave/test', 14:01:31 INFO - 'SHELL': '/bin/bash', 14:01:31 INFO - 'SHLVL': '1', 14:01:31 INFO - 'TERM': 'linux', 14:01:31 INFO - 'TMOUT': '86400', 14:01:31 INFO - 'USER': 'cltbld', 14:01:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:31 INFO - '_': '/tools/buildbot/bin/python'} 14:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:31 INFO - Downloading/unpacking flake8 14:01:31 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 14:01:31 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 14:01:31 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 14:01:31 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 14:01:31 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 14:01:31 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 14:01:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:33 INFO - no previously-included directories found matching 'docs/_build' 14:01:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:33 INFO - Running setup.py install for pep8 14:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:33 INFO - no previously-included directories found matching 'docs/_build' 14:01:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:01:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:34 INFO - Cleaning up... 14:01:34 INFO - Return code: 0 14:01:34 INFO - Running post-action listener: _resource_record_post_action 14:01:34 INFO - Running post-action listener: _start_resource_monitoring 14:01:34 INFO - Starting resource monitoring. 14:01:34 INFO - ##### 14:01:34 INFO - ##### Running install step. 14:01:34 INFO - ##### 14:01:34 INFO - Running pre-action listener: _resource_record_pre_action 14:01:34 INFO - Running main action method: install 14:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:34 INFO - Reading from file tmpfile_stdout 14:01:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:01:34 INFO - Reading from file tmpfile_stdout 14:01:34 INFO - Output received: 14:01:34 INFO - Usage: mozinstall [options] installer 14:01:34 INFO - Options: 14:01:34 INFO - -h, --help show this help message and exit 14:01:34 INFO - -d DEST, --destination=DEST 14:01:34 INFO - Directory to install application into. [default: 14:01:34 INFO - "/builds/slave/test"] 14:01:34 INFO - --app=APP Application being installed. [default: firefox] 14:01:34 INFO - mkdir: /builds/slave/test/build/application 14:01:34 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'] 14:01:34 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 14:01:47 INFO - Reading from file tmpfile_stdout 14:01:47 INFO - Output received: 14:01:47 INFO - /builds/slave/test/build/application/firefox/firefox 14:01:47 INFO - Running post-action listener: _resource_record_post_action 14:01:47 INFO - ##### 14:01:47 INFO - ##### Running run-tests step. 14:01:47 INFO - ##### 14:01:47 INFO - Running pre-action listener: _resource_record_pre_action 14:01:47 INFO - Running main action method: run_tests 14:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:01:47 INFO - Python 2.7.3 14:01:47 INFO - Return code: 0 14:01:47 INFO - grabbing minidump binary from tooltool 14:01: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')]} 14:01:47 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 0x1fb4160>, '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 0x1fb5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:01:47 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 14:01:47 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 14:01:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:47 INFO - Return code: 0 14:01:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:01:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:01:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:01:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:01:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:01:48 INFO - Return code: 0 14:01:48 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/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:48 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/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:48 INFO - Using env: {'DISPLAY': ':0', 14:01:48 INFO - 'HOME': '/home/cltbld', 14:01:48 INFO - 'LANG': 'en_US.UTF-8', 14:01:48 INFO - 'LANGUAGE': 'en_US:en', 14:01:48 INFO - 'LOGNAME': 'cltbld', 14:01:48 INFO - 'MAIL': '/var/mail/cltbld', 14:01:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:01:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:48 INFO - 'MOZ_NO_REMOTE': '1', 14:01:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:48 INFO - 'NO_EM_RESTART': '1', 14:01:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:48 INFO - 'PWD': '/builds/slave/test', 14:01:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:01:48 INFO - 'SHELL': '/bin/bash', 14:01:48 INFO - 'SHLVL': '1', 14:01:48 INFO - 'TERM': 'linux', 14:01:48 INFO - 'TMOUT': '86400', 14:01:48 INFO - 'USER': 'cltbld', 14:01:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464037257.850344-1757129479', 14:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:48 INFO - '_': '/tools/buildbot/bin/python'} 14:01:48 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/F4dCmJ-ZSISPOH_ypVfDtg/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 14:01:48 INFO - mozversion application_buildid: 20160523111242 14:01:48 INFO - mozversion application_changeset: 59dbf171604d52960e6e54cbefdb52d7bbcb989d 14:01:48 INFO - mozversion application_display_name: Firefox 14:01:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:48 INFO - mozversion application_name: Firefox 14:01:48 INFO - mozversion application_remotingname: firefox 14:01:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:01:48 INFO - mozversion application_vendor: Mozilla 14:01:48 INFO - mozversion application_version: 47.0 14:01:48 INFO - mozversion platform_buildid: 20160523111242 14:01:48 INFO - mozversion platform_changeset: 59dbf171604d52960e6e54cbefdb52d7bbcb989d 14:01:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:01:48 INFO - mozversion platform_version: 47.0 14:01:48 INFO - using testdate: 1464037308 14:01:48 INFO - actual date: 1464037308 14:01:48 INFO - starting webserver on 'localhost:52868' 14:01:48 INFO - SUITE-START | Running 2 tests 14:01:48 INFO - TEST-START | dromaeo_css 14:01:48 INFO - operating with platform_type : linux_ 14:01:48 INFO - Initialising browser for dromaeo_css test... 14:01:48 INFO - TEST-INFO | started process 16822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmporMGtr/profile http://localhost:52868/getInfo.html) 14:01:51 INFO - PROCESS | 16822 | 14:01:51 INFO - PROCESS | 16822 | (process:16896): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:01:52 INFO - PROCESS | 16822 | __metrics Screen width/height:1600/1200 14:01:52 INFO - PROCESS | 16822 | colorDepth:24 14:01:52 INFO - PROCESS | 16822 | Browser inner width/height: 1024/697 14:01:52 INFO - PROCESS | 16822 | __metrics 14:01:53 ERROR - PROCESS | 16822 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 14:01:54 INFO - TEST-INFO | 16822: exit 0 14:01:54 INFO - Browser initialized. 14:01:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:54 INFO - TEST-INFO | started process 16946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmporMGtr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:56 INFO - PROCESS | 16946 | 14:01:56 INFO - PROCESS | 16946 | (process:17014): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:02:06 INFO - PROCESS | 16946 | RSS: Main: 149831680 14:02:06 INFO - PROCESS | 16946 | 14:02:55 INFO - PROCESS | 16946 | 1464037375768 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] 14:05:03 INFO - PROCESS | 16946 | Cycle 1(1): loaded http://localhost:52868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52868/tests/dromaeo/cssquery-ext.html) 14:05:04 INFO - PROCESS | 16946 | RSS: Main: 153395200 14:05:04 INFO - PROCESS | 16946 | 14:08:06 INFO - PROCESS | 16946 | Cycle 1(1): loaded http://localhost:52868/tests/dromaeo/cssquery-ext.html (next: http://localhost:52868/tests/dromaeo/cssquery-jquery.html) 14:08:06 INFO - PROCESS | 16946 | RSS: Main: 151953408 14:08:06 INFO - PROCESS | 16946 | 14:11:08 INFO - PROCESS | 16946 | Cycle 1(1): loaded http://localhost:52868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52868/tests/dromaeo/cssquery-mootools.html) 14:11:09 INFO - PROCESS | 16946 | RSS: Main: 151494656 14:11:09 INFO - PROCESS | 16946 | 14:14:10 INFO - PROCESS | 16946 | Cycle 1(1): loaded http://localhost:52868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52868/tests/dromaeo/cssquery-prototype.html) 14:14:11 INFO - PROCESS | 16946 | RSS: Main: 152154112 14:14:11 INFO - PROCESS | 16946 | 14:17:13 INFO - PROCESS | 16946 | Cycle 1(1): loaded http://localhost:52868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52868/tests/dromaeo/cssquery-yui.html) 14:17:14 INFO - PROCESS | 16946 | RSS: Main: 151154688 14:17:14 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | Cycle 1(1): loaded http://localhost:52868/tests/dromaeo/cssquery-yui.html (next: http://localhost:52868/tests/dromaeo/cssquery-dojo.html) 14:20:16 INFO - PROCESS | 16946 | RSS: Main: 155639808 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | __start_tp_report 14:20:16 INFO - PROCESS | 16946 | _x_x_mozilla_page_load 14:20:16 INFO - PROCESS | 16946 | _x_x_mozilla_page_load_details 14:20:16 INFO - PROCESS | 16946 | |i|pagename|runs| 14:20:16 INFO - PROCESS | 16946 | |0;dojo.html;3320.63473017968;3342.4986252062185;3350.966490335096;3367.3938691035605;3377.881774137904;5375.650582712121;5386.245925570423;5405.54052905503;5420.295361602991;5429.484199001094;5357.598180136486;5359.30329057223;5360.812371566996;5371.301730775003;5379.193121031847;4922.556969872702;4964.404271487427;5017.49825017499;5041.1682072458;5065.265536497206;4854.635902307324;4945.35710357653;4957;5007.574356179711;5053.696778193302;4982.402111746577;5002.8249011284615;5027.396712394518;5075.822346217883;5088.465711100337;5049.116404629175;5052.418971818232;5063.518965698271;5067.417247016603;5073.873153171164;4562.028321885869;4905.901881962341;4980.178270585349;5020.899582008339;5048.873778155539;5314.681119132826;5327.920081198785;5330.093884039684;5341.2255222992835;5365.7585408656705;5861.6189947653265;5896.351401345849;5908.468237858613;5919.1713160157615;5950.7917222896995;5866.208061911672;5909.261342332208;5931.792387266425;5935.228420305376;5966.791162309299;5457.754401051922;5513.255710479074;5518.420565840609;5520.420355862657;5542.362628297717;5863.70681465925;6012.939870601325;6014.729337179838;6021.337652858182;6053.939460605337;5718;5808.3901190375245;5816.82549523515;5823.475887170091;5836.299644042657;5880.970830104715;5891.646501209942;5894.469497745224;5896.292444906553;5916.171735956969;5707.3721890592005;5815.534757219412;5858.121281807763;5863.237779088777;5874.236349274653;5893.675847828325;5924.585279030426;5926.644401335848;5934.6142500737315;5978.342382337939;4494.438195225597;4519.118771839459;4533.909321813545;4536;4567.429071366079;3954.406838974177;3999.7200195986584;4045.352743561075;4074.4703188585295;4117.835286588503;5439.809606663748;5549.1676248563035;5557.472040156179;5591.27313449249;5627.986962346817;5876.853078672982;5919.378465261172;5926;5931.228940237742;5934.406559344031;5492.945070549324;5572.108462646038;5572.331320241597;5584.52531534816;5651.604387692904;5098.031374038921;5113;5113.769880355393;5114.872128196825;5149.407818100892;5986.2517185351835;6031.638101713911;6034.969825150934;6048.667323297261;6096.573239873166;5745.368009518866;5825.650460972355;5896.233489646319;5911.201987731602;5917.112433135064;6050.84872878164;6064.332923378513;6074.696265186812;6076.453119219114;6105.358937311518;5778.248827652378;5783.884322313446;5784.2769653793275;5785.652860828363;5794.652320860593;5803.158542011469;5866.560007999503;5872.119182122716;5953.851153721192;5992.340842507234;5746.396628353963;5759.539236861125;5789.623674461147;5804.796832110856;5804.912926306024;5752.827415177551;5770.826875193751;5776.595638305278;5795.768169273182;5816.952948469316;5489.478499542537;5583.469570390806;5644.209810626434;5673.205751194753;5691.2032315475035;5657.179708942263;5684.204211410323;5718.942810571841;5773.22061521706;5778.451047150514;5562.276904002454;5566.053770858883;5623.100303951348;5633.746481408264;5652.123920792284 14:20:16 INFO - PROCESS | 16946 | |1;ext.html;529.8754792623732;541.3125330829844;564.0861803877718;580.5645765675744;589.6579983609504;40183.1963360733;40794.98012549684;41112;41132;41204.17591648173;42274.57725422745;42393.57606423935;42610.14779704404;42779;42976;8840.557972101402;9094.363394562382;9096.499692516909;9108.18026377626;9114;8928.107189281085;9047.638094476213;9068.637254509811;9198.678046268382;9229.953850230739;9206.677766278182;9280;9307.72076837696;9315.953420232889;9349.018353072897;9172.12864777845;9226.953865230698;9285.58214880332;9300.11648893354;9327.113924177193;9050.502222377767;9241.445513269226;9245.214156796681;9273.536323183815;9276.07239276067;43879.561204387865;44308.3353749694;44331.55668443339;44432.77783611094;44544.554554454364;3683.336999340118;3710.870119545803;3764.228333191689;3783.8675646352244;3785.3943369060817;31360.21599460009;32629;32673;32827.50758738621;33132.3373532528;4369.71596846204;4385.934210986838;4387.210302145612;4439.289713645833;4444.400005999181;282895;285542;286805;286988;286998;62285;62341;62368;62400;62453.37546624475;75718;76000.61999689967;76809.61595191988;77142.22857771463;77350.22649773542;15308.923455382652;15487.690246195012;15565.766513502307;15590.610234743996;15706.764398534031;13388.933055334855;13485.325733713275;13507.797383039262;13512.459501620022;13521.729565408834;23431.531369372857;23619.645705314433;23757.287281381585;23946.52106957851;23982.28053158408;8043.919560804434;8108.027066737256;8153.470024448392;8343.16568343173;8463.661453541912;1023.7542989682422;1056.2395075545594;1076.8438576406534;1078.320657985464;1152.4007516091754;29618.851905740332;30001.849990749906;30288.848555757522;30912.227194319872;31128.53307200394;1115.4645770030431;1118.4910865556153;1148.3511815824033;1157.976840463186;1171.2562522798085;15074;15118.622034449227;15248.695026099416;15335.92332038355;15576.221188940508;330742;518387;521912;523116;530731;58613.706931465924;59004.40995590075;59052.11421828676;59069.40930590725;59441.10838337428;1484.4284950293998;1484.5546336099128;1490.8360080391365;1502.0762231227716;1502.136271643809;29574.260643483223;30161.849190753906;30677.079687609406;32322.515162273055;33142;51824.22263666124;52032;52141.47858521366;52231;52232.21651675152;330429;331175;334133;335537;336527;35033.474497883064;47520.7623961878;48719.51280487292;49134;49647.751761240965;44097.77951110224;45078;45312.54687453083;45755;45820.7708961453;40453.98865028398;41203.175936481704;41482.37776433416;41497.79251103725;42321.365179521716;40282.79858600688;40549.18901621892;40892.59107408888;41000;41325;40114.598854011085;40251.396229056;40291.395629065;40588.79705601453;40830.79584602058;34846.47730284098;34893.651063489044;35241.647583524864;35480.82259588686;36073.45889811603;26658.466830662892;26659.20022399331;27094.458110838066;27118.72881271241;27308.453830922874 14:20:16 INFO - PROCESS | 16946 | |2;jquery.html;361.4018798887841;377.1514093290097;385.92474467478837;387.91853710720727;399.17371041943187;12260.325682087481;12822.67943301418;17831.37590184344;18646.720299195506;19393.903030484864;19413.514662133453;19674.311399101036;19834.206631734713;20129.69805452916;20179.697304540445;6351.555391122612;6393.872122557569;6633.369829866155;6654.4676425886055;6666.500012499057;6449.806505804833;6590.373914478141;6598.47212223021;6610.338966103375;6627.1716035495565;6549.803505894831;6595.967020164892;6622.8675426491445;6917;6937.826554336157;6700.497462690293;6821;6851.280615535372;7177.964110179468;7270.818229544251;6957.547759395623;6962.443004559623;6986.371226589631;6998.75504357345;7013.26360732126;23042.654360184442;23791.286261412184;24105.397365065837;24195.153169639154;24232;2375.4417711837705;2556.821022528424;2626.3828000419885;2898.463784199909;3068;14408.855911440856;14739.263036848222;14848.777268340984;15106.169160696158;15296.541103766906;1974.9506262343557;2016.9798302016939;2075.823554997827;2098.443912363225;2117.2272120676;74614.62692686502;75478;76198.23801761967;76948;79113.19713414891;14378.07565813588;15599.61000974962;15906.204689765465;16146.192690365435;16192.43326483591;14990.175540345386;15543.222838858012;27960.48355647961;27993;28076.43847123087;8068.233517815798;8239.134890836376;8241.876371854427;8273.503589784632;8436.620352084172;7896.210378962172;7916.089649690244;7936.206379362133;7947.682092716343;8013.919860801434;4575.519570445122;4683.672142949961;4769.594584460359;4851.878703032452;4852.102361063215;1905.2759951218725;1928.3154480159621;1955.6577598920132;2049.2008116834445;2067.297118979524;915.9816803663889;937.3298091864214;978.4031740638205;1012.2256473797551;1083.6586475260267;17174.570635734206;17358.39245626397;17496.91251543734;17598;18040.368587099652;983.3755565216139;991.5785791038779;1016.786474840277;1029.4235228272191;1051.75283808305;9960.601575937026;9985;9995.250356223312;10026.69919902404;10058;422855;440238;449591;451865;451962;53197.46802532003;77065;79532;79555.20444795478;79882;1073.5652060915343;1106.2422240765102;1108.4346983038708;1109.5728144664363;1112.404863398078;15832.841671583137;15931.8284401984;15937.203139843194;16054.839451605334;16089;29100.563491548066;34746.826265868505;34913;35237.11907202341;35849.1037724059;47115.76442117905;47299;47325.053498930516;47777;47834.521654783006;8252.46358986664;8613.913860861561;8690.956545217234;8778.956105219688;8803.647854085764;9854.704358869245;12689.23864568092;13023.218606883618;13071.15037522558;13267.734645307233;10938.343699378063;10970.835437468284;11032.669019929415;11042.889571104186;11132.833007505056;10686.946565267124;10756.892431075588;10989.285696429706;11078.279911805706;11168.497417616065;10874.456277185951;11236.101111911192;11311.660650180507;11370.602028928948;11521.078313734713;8304.086550479322;8637;8659.653613855375;8696.043435222247;8713.477191368538;8590.441621294596;8939.463632182089;10730.946345268223;11354.886451135382;11414.429278536207 14:20:16 INFO - PROCESS | 16946 | |3;mootools.html;1563.1949545983816;1589.253051065999;1852.5553867071899;1940.8253257206848;1963.7839837617869;7708.884366734504;8197.303229225508;8352.91647083529;8587.570621468925;8615.913840861589;8370.162983701626;8388.245057944783;8422.747317580466;8433.620487078097;8483.151684831513;2442.6702395176644;2461.9261422157365;2473.826832121752;2485.453200295932;2492.7382624824404;2416.263039772877;2463.5935070713313;2471.406862353031;2472.81453890958;2475.851448913062;2427.599446091393;2447.0578827151585;2461.4830885513975;2463.950720985579;2476.913308034219;2430.149447693311;2435.2450740270483;2459.8032157427365;2468.938276543101;2472.554940110779;2425.126954296452;2437.890294936732;2446.0704932125855;2446.1805295226122;2472.357187131359;8644.789729437884;8717.607707653107;8720.171583699539;8733.03936566977;8751.3874028818;5176.275321454999;5305.602079844027;5309.150535914274;5318.574514038867;5319.414864364917;3307.4212012897647;3317.253617935969;3360.1263671445354;3363.360961417323;3386.153461634591;1071.7534966957564;1076.6016573867641;1079.3038490173794;1091.9508622112023;1094.1356328500476;11999.580014699532;12059.638210853689;12079.57721479744;12188.207766495238;12189.207701499463;4564.13281476525;4640.95359046412;4650.116477869194;4682.1103990241745;4767.308740232646;10269.383836969806;10300.124489418333;10305.330153539995;10306.690799276033;10344.844827327595;5276.736163191825;5279.41926388097;5287.391949925808;5295.338082739658;5306.708131052752;4724.173269677793;4746.406699162605;4840.346553215341;4842.346283251716;4870.14772414826;3479.5824501060033;3575.0883524701035;3590.964090359063;3652.926941461156;3662.3957047086933;1088.4013792414298;1119.6137332620397;1120.3222050659397;1122.9494672739747;1123.8876112388696;1444.83384410792;1451.5500194939602;1459.4308219794289;1465.4284828916732;1487.6355292953297;8073.19268073188;8084.474509157004;8103.189681031968;8158.061822890325;8170.673173073011;544.4854612391252;547.5504322766634;547.942466041068;553.1785298831232;554.5286506469549;6199.504039676815;6203.503719702413;6214;6222.097795819581;6285.497160227171;10287.279890407599;10706.892931070746;10711.036006759428;10779.730506737395;10837;10357;10362.533685984148;10417.218708596885;10422.687319380431;10446.895531044744;8158.510489370657;8259.339252859756;8281.585920703941;8379.958100209582;8379.994400671958;7702.499337543042;7765.378769698524;7786.727464538714;7791.415643826849;7796.844063118592;9385.108414700593;9396.342256042011;9450.574724137292;9505.66730164441;9725.367851089657;8862.291016718777;9190.40262382943;9345.299102567198;9546.761330966503;9720.902790972283;7409.8147546311775;7449.776506704808;7595.164531901597;7630.2751238632245;7647.235276472308;8208.876866847122;8231.835363292821;8240.50556966584;8302.460340077876;8314.667413303641;7362.668679909524;7387.704491820267;7400.185979542139;7413.258674132544;7591.962040189985;7342;7481.663325150273;7485.363744081814;7557.697692092474;7584.355329797029;7531.58576278288;7543.0948286206;7621.923780762121;7633.389328853789;7639.694412223671;7049.436045116276;7056.717731290691;7060.823479413056;7120.181179164255;7161.283871612797;7150.034745309525;7212.386947109554;7259.6007219603425;7309.780706578811;7369.226231245856 14:20:16 INFO - PROCESS | 16946 | |4;prototype.html;359.8884345852785;361.8407900523769;362.38394728960776;363.3405369254804;363.64362924334154;6376;6388.712507937143;6436.873547129251;6445.419912207901;6446.613203207811;6286.119943207955;6298;6307.526935479835;6307.653079080649;6310.368963103699;4719.622430205575;4781.545753153462;4831.227003679412;4855.223164293714;4858;4830.73430961297;4837.612990960714;4849.806007759703;4851.708897466164;4870.829520966767;4796.280557916306;4821.662483626147;4829.637777166709;4835.1296766582;4836.782344794493;4826.3001864729595;4842.4189097308545;4843.733594652293;4851.757412129397;4853.126437241295;4231.407602935591;4236.068065025689;4238.152369526107;4239.533651298355;4272.6154646082;5909.852253693649;6038.818835434944;6041.879162416771;6045.244344456943;6045.909311360333;5639.351474580394;5642.57680673947;5642.915356269659;5647;5651.519620832234;6645.9667701661665;6661.866762664768;6681.665916704194;6705.128333316687;6731.427828634572;4629.490756016836;4660.813567457331;4670.392848929618;4679.532046795327;4685.718856868599;6981.0924579804805;6990.021397004423;7021.61381124038;7056.929430705679;7068.939659051183;4615.861524154281;4783.354247176656;4787.162246606899;4793.832215872428;4796.06476737033;4855.927161092586;4865.929495510982;4870.902581948412;4876.146674331978;4878.609711223094;5616.1014237721765;5625.971870140623;5626.2967129108865;5630.071038278638;5644.774209031675;6765.830854228684;6787.694553745093;6787.864242715118;6813.1142951415995;6819.863602727918;1705.4116329866176;1725.887817291872;1727.8617710583123;1729.8789084763946;1730.3684155283484;1086.5219303506433;1136.78969390663;1141.697450175704;1141.8743938166795;1157.2130950953433;6535.215774107138;6542.574732642363;6556.967215163893;6557.770478033246;6560.737570497126;6958.234594194634;6973.476989225828;6990.126234220723;6990.580565166107;7026.016357709823;6324.272708638474;6419.839504012343;6482.157319548429;6519.8044058678315;6529.640869752209;3792.867249646249;3794.962050379516;3804.8478060877255;3820.388737801994;3831.578526362098;7248.383887369527;7349.338559529668;7365.48441609093;7372.668229929666;7373.410127189812;7208.243134470805;7209.783706488814;7214.098237720285;7216.206217316091;7238.384737297389;7077.681504332318;7081.114860642419;7095.574265544084;7238.131424229021;7337.844726767541;6884.827879303058;6894.482913781386;6914.170299564084;6919.6886140124825;6921.930780692129;6825.795226143224;6841.315868413119;6915.619640919797;6915.757948471779;6926.792196234121;7364.631768411451;7365.8158546036775;7372.59450730215;7375.889361659472;7391.039164908528;4795.832145874878;4916.360873086619;4930.506949305184;4937.28409380645;4944.788526810954;6819.420349270367;6873.415759660485;6960.234374218933;6965.44276457872;6990.825229369307;6728.360805723449;6739.966300168468;6740.966295168689;6748.561343512656;6752.223494298219;6682.866342673022;6686.598804071771;6715.496337774589;6720.966395167993;6739.427148692416;6391.96804015977;6579.736810527716;6593.901091483535;6639.804835129723;6670.83322916931;6730.6971186297715;6760.560563563353;6789.762358317435;6817.454603631797;6820.658967051727;6571.3757193066585;6594.604323740591;6630.237522684953;6647.401733843977;6674.299198584273 14:20:16 INFO - PROCESS | 16946 | |5;yui.html;756.1531085184592;827.8178800663853;834.1158372125548;850.425962475329;855.1747563601124;14482.131072135666;14724.92637536812;14905.478308259213;14910.925445372757;14912.776308355384;13863.722725545484;14004.859951400484;14006.089604175722;14037.36831842567;14105;921.6866265469722;943.03810113684;943.1370296178987;980.3725615606018;984.3700031979503;967.796762679838;982.9950850245739;984.9015098490165;985.6845809341014;986.9259805514579;997.4015590645627;1006.8791744990612;1007.8891321954579;1007.9496025198711;1009.8737657792776;981.043482604462;986.9753256168582;990.1781521337309;993.7565296502368;994.0953732103823;732.2823632839846;733.9669714862844;736.830528978338;737.0860133434556;739.3309055304958;15229.543113706606;15252;15261.38954441821;15290.923545382313;15305.699015583688;13540.796888046687;13682;13777.724445511134;13801.51694690691;13917.512887049006;11750.412479376082;11768.882311176863;11811.114166437466;11884.643460696192;11890.28658280506;3869.148787266825;3909;3926.8625598104213;3956.287868183726;3968.2658708138797;51405.742971285275;51873.48126518724;52062.479375206145;52247.216291755656;52320.738396307774;10175.643852465128;10796.838047429295;10845.674629761119;10902.672919812418;10957.287776294515;17169.399071032705;17262.395816146374;17269.309227630754;17299.221535030953;17307.826921730873;8112.675492980333;8233.300169485541;8257.38069644767;8538.316934645214;8555.31557475413;4754.405699287589;4760.452547957029;4810.326554282333;4864.027194561102;4877.024595080998;3363.6972672459597;3401.557797486311;3406.5060566218253;3407.727381809449;3411.727061835047;617.5029101573276;622.17561730707;624.753222477119;628.0610487321484;642.720416618763;603.499095750526;636.901280301554;675.770238119032;689.672331002913;691.695653912277;8830.823383532294;8914.687985920462;9021;9071.637134514678;9264.95367523158;688.579966220605;692.8960655901656;707.5012116457884;708.4084789200972;720.9423246140296;4252.744835309892;4260.744355338627;4265.594768496988;4308.186545964739;4312.849050283287;59849;59855.102173467436;60515;62071.37928620746;62189.68905155445;51795;52752.47247527476;53107.46892531103;53559;54138.45861541334;46847.29729054067;48138.9999999993;48181.759091204316;49598;49839.75080124576;7967.282944534788;8086.555239461651;8155.836883262183;8179.222973817716;8318.500889946623;34612.82693586516;34831.65168348284;35971.28057438889;37777.81111094427;38609;46807;47074;47299.76350118227;47520.7623961878;48868;11953.880461195276;12141.453634586642;12251.69370765738;12252.938735306267;12364.319962402154;12990.090693651353;13168.934155329162;13181.143225690299;13662.18026918388;13847.30763461843;12226.20529665569;12247.448864801283;12268.263904165779;12372.938135309267;12556.372181391076;12014.579489717818;12486;12574.245545267313;12769.680757981125;12921.483140674643;11907.880921191023;12035.578754743541;12121.515139394325;12310.630681079581;12348.629541113782;10702.09032232269;10898.237123401286;10953.17851161182;11017;11379.54481820718;10465.790684186122;10542.13719410553;10735.94632026835;10809.919008099127;10824.188185885932 14:20:16 INFO - PROCESS | 16946 | __end_tp_report 14:20:16 INFO - PROCESS | 16946 | __start_cc_report 14:20:16 INFO - PROCESS | 16946 | _x_x_mozilla_cycle_collect,328 14:20:16 INFO - PROCESS | 16946 | __end_cc_report 14:20:16 INFO - PROCESS | 16946 | __startTimestamp1464038416573__endTimestamp 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | ------- Summary: start ------- 14:20:16 INFO - PROCESS | 16946 | Number of tests: 6 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | [#0] dojo.html Cycles:165 Average:5457.74 Median:5652.12 stddev:598.53 (10.6%) stddev-sans-first:576.41 14:20:16 INFO - PROCESS | 16946 | Values: 3320.6 3342.5 3351.0 3367.4 3377.9 5375.7 5386.2 5405.5 5420.3 5429.5 5357.6 5359.3 5360.8 5371.3 5379.2 4922.6 4964.4 5017.5 5041.2 5065.3 4854.6 4945.4 4957.0 5007.6 5053.7 4982.4 5002.8 5027.4 5075.8 5088.5 5049.1 5052.4 5063.5 5067.4 5073.9 4562.0 4905.9 4980.2 5020.9 5048.9 5314.7 5327.9 5330.1 5341.2 5365.8 5861.6 5896.4 5908.5 5919.2 5950.8 5866.2 5909.3 5931.8 5935.2 5966.8 5457.8 5513.3 5518.4 5520.4 5542.4 5863.7 6012.9 6014.7 6021.3 6053.9 5718.0 5808.4 5816.8 5823.5 5836.3 5881.0 5891.6 5894.5 5896.3 5916.2 5707.4 5815.5 5858.1 5863.2 5874.2 5893.7 5924.6 5926.6 5934.6 5978.3 4494.4 4519.1 4533.9 4536.0 4567.4 3954.4 3999.7 4045.4 4074.5 4117.8 5439.8 5549.2 5557.5 5591.3 5628.0 5876.9 5919.4 5926.0 5931.2 5934.4 5492.9 5572.1 5572.3 5584.5 5651.6 5098.0 5113.0 5113.8 5114.9 5149.4 5986.3 6031.6 6035.0 6048.7 6096.6 5745.4 5825.7 5896.2 5911.2 5917.1 6050.8 6064.3 6074.7 6076.5 6105.4 5778.2 5783.9 5784.3 5785.7 5794.7 5803.2 5866.6 5872.1 5953.9 5992.3 5746.4 5759.5 5789.6 5804.8 5804.9 5752.8 5770.8 5776.6 5795.8 5817.0 5489.5 5583.5 5644.2 5673.2 5691.2 5657.2 5684.2 5718.9 5773.2 5778.5 5562.3 5566.1 5623.1 5633.7 5652.1 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | [#1] ext.html Cycles:180 Average:55196.67 Median:41167.59 stddev:100523.05 (244.2%) stddev-sans-first:100721.25 14:20:16 INFO - PROCESS | 16946 | Values: 529.9 541.3 564.1 580.6 589.7 40183.2 40795.0 41112.0 41132.0 41204.2 42274.6 42393.6 42610.1 42779.0 42976.0 8840.6 9094.4 9096.5 9108.2 9114.0 8928.1 9047.6 9068.6 9198.7 9230.0 9206.7 9280.0 9307.7 9316.0 9349.0 9172.1 9227.0 9285.6 9300.1 9327.1 9050.5 9241.4 9245.2 9273.5 9276.1 43879.6 44308.3 44331.6 44432.8 44544.6 3683.3 3710.9 3764.2 3783.9 3785.4 31360.2 32629.0 32673.0 32827.5 33132.3 4369.7 4385.9 4387.2 4439.3 4444.4 282895.0 285542.0 286805.0 286988.0 286998.0 62285.0 62341.0 62368.0 62400.0 62453.4 75718.0 76000.6 76809.6 77142.2 77350.2 15308.9 15487.7 15565.8 15590.6 15706.8 13388.9 13485.3 13507.8 13512.5 13521.7 23431.5 23619.6 23757.3 23946.5 23982.3 8043.9 8108.0 8153.5 8343.2 8463.7 1023.8 1056.2 1076.8 1078.3 1152.4 29618.9 30001.8 30288.8 30912.2 31128.5 1115.5 1118.5 1148.4 1158.0 1171.3 15074.0 15118.6 15248.7 15335.9 15576.2 330742.0 518387.0 521912.0 523116.0 530731.0 58613.7 59004.4 59052.1 59069.4 59441.1 1484.4 1484.6 1490.8 1502.1 1502.1 29574.3 30161.8 30677.1 32322.5 33142.0 51824.2 52032.0 52141.5 52231.0 52232.2 330429.0 331175.0 334133.0 335537.0 336527.0 35033.5 47520.8 48719.5 49134.0 49647.8 44097.8 45078.0 45312.5 45755.0 45820.8 40454.0 41203.2 41482.4 41497.8 42321.4 40282.8 40549.2 40892.6 41000.0 41325.0 40114.6 40251.4 40291.4 40588.8 40830.8 34846.5 34893.7 35241.6 35480.8 36073.5 26658.5 26659.2 27094.5 27118.7 27308.5 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | [#2] jquery.html Cycles:180 Average:26941.93 Median:34829.91 stddev:72743.56 (208.9%) stddev-sans-first:72920.25 14:20:16 INFO - PROCESS | 16946 | Values: 361.4 377.2 385.9 387.9 399.2 12260.3 12822.7 17831.4 18646.7 19393.9 19413.5 19674.3 19834.2 20129.7 20179.7 6351.6 6393.9 6633.4 6654.5 6666.5 6449.8 6590.4 6598.5 6610.3 6627.2 6549.8 6596.0 6622.9 6917.0 6937.8 6700.5 6821.0 6851.3 7178.0 7270.8 6957.5 6962.4 6986.4 6998.8 7013.3 23042.7 23791.3 24105.4 24195.2 24232.0 2375.4 2556.8 2626.4 2898.5 3068.0 14408.9 14739.3 14848.8 15106.2 15296.5 1975.0 2017.0 2075.8 2098.4 2117.2 74614.6 75478.0 76198.2 76948.0 79113.2 14378.1 15599.6 15906.2 16146.2 16192.4 14990.2 15543.2 27960.5 27993.0 28076.4 8068.2 8239.1 8241.9 8273.5 8436.6 7896.2 7916.1 7936.2 7947.7 8013.9 4575.5 4683.7 4769.6 4851.9 4852.1 1905.3 1928.3 1955.7 2049.2 2067.3 916.0 937.3 978.4 1012.2 1083.7 17174.6 17358.4 17496.9 17598.0 18040.4 983.4 991.6 1016.8 1029.4 1051.8 9960.6 9985.0 9995.3 10026.7 10058.0 422855.0 440238.0 449591.0 451865.0 451962.0 53197.5 77065.0 79532.0 79555.2 79882.0 1073.6 1106.2 1108.4 1109.6 1112.4 15832.8 15931.8 15937.2 16054.8 16089.0 29100.6 34746.8 34913.0 35237.1 35849.1 47115.8 47299.0 47325.1 47777.0 47834.5 8252.5 8613.9 8691.0 8779.0 8803.6 9854.7 12689.2 13023.2 13071.2 13267.7 10938.3 10970.8 11032.7 11042.9 11132.8 10686.9 10756.9 10989.3 11078.3 11168.5 10874.5 11236.1 11311.7 11370.6 11521.1 8304.1 8637.0 8659.7 8696.0 8713.5 8590.4 8939.5 10730.9 11354.9 11414.4 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | [#3] mootools.html Cycles:180 Average:6001.56 Median:5306.16 stddev:3193.12 (60.2%) stddev-sans-first:3184.66 14:20:16 INFO - PROCESS | 16946 | Values: 1563.2 1589.3 1852.6 1940.8 1963.8 7708.9 8197.3 8352.9 8587.6 8615.9 8370.2 8388.2 8422.7 8433.6 8483.2 2442.7 2461.9 2473.8 2485.5 2492.7 2416.3 2463.6 2471.4 2472.8 2475.9 2427.6 2447.1 2461.5 2464.0 2476.9 2430.1 2435.2 2459.8 2468.9 2472.6 2425.1 2437.9 2446.1 2446.2 2472.4 8644.8 8717.6 8720.2 8733.0 8751.4 5176.3 5305.6 5309.2 5318.6 5319.4 3307.4 3317.3 3360.1 3363.4 3386.2 1071.8 1076.6 1079.3 1092.0 1094.1 11999.6 12059.6 12079.6 12188.2 12189.2 4564.1 4641.0 4650.1 4682.1 4767.3 10269.4 10300.1 10305.3 10306.7 10344.8 5276.7 5279.4 5287.4 5295.3 5306.7 4724.2 4746.4 4840.3 4842.3 4870.1 3479.6 3575.1 3591.0 3652.9 3662.4 1088.4 1119.6 1120.3 1122.9 1123.9 1444.8 1451.6 1459.4 1465.4 1487.6 8073.2 8084.5 8103.2 8158.1 8170.7 544.5 547.6 547.9 553.2 554.5 6199.5 6203.5 6214.0 6222.1 6285.5 10287.3 10706.9 10711.0 10779.7 10837.0 10357.0 10362.5 10417.2 10422.7 10446.9 8158.5 8259.3 8281.6 8380.0 8380.0 7702.5 7765.4 7786.7 7791.4 7796.8 9385.1 9396.3 9450.6 9505.7 9725.4 8862.3 9190.4 9345.3 9546.8 9720.9 7409.8 7449.8 7595.2 7630.3 7647.2 8208.9 8231.8 8240.5 8302.5 8314.7 7362.7 7387.7 7400.2 7413.3 7592.0 7342.0 7481.7 7485.4 7557.7 7584.4 7531.6 7543.1 7621.9 7633.4 7639.7 7049.4 7056.7 7060.8 7120.2 7161.3 7150.0 7212.4 7259.6 7309.8 7369.2 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | [#4] prototype.html Cycles:180 Average:5654.04 Median:6441.15 stddev:1706.12 (26.5%) stddev-sans-first:1663.98 14:20:16 INFO - PROCESS | 16946 | Values: 359.9 361.8 362.4 363.3 363.6 6376.0 6388.7 6436.9 6445.4 6446.6 6286.1 6298.0 6307.5 6307.7 6310.4 4719.6 4781.5 4831.2 4855.2 4858.0 4830.7 4837.6 4849.8 4851.7 4870.8 4796.3 4821.7 4829.6 4835.1 4836.8 4826.3 4842.4 4843.7 4851.8 4853.1 4231.4 4236.1 4238.2 4239.5 4272.6 5909.9 6038.8 6041.9 6045.2 6045.9 5639.4 5642.6 5642.9 5647.0 5651.5 6646.0 6661.9 6681.7 6705.1 6731.4 4629.5 4660.8 4670.4 4679.5 4685.7 6981.1 6990.0 7021.6 7056.9 7068.9 4615.9 4783.4 4787.2 4793.8 4796.1 4855.9 4865.9 4870.9 4876.1 4878.6 5616.1 5626.0 5626.3 5630.1 5644.8 6765.8 6787.7 6787.9 6813.1 6819.9 1705.4 1725.9 1727.9 1729.9 1730.4 1086.5 1136.8 1141.7 1141.9 1157.2 6535.2 6542.6 6557.0 6557.8 6560.7 6958.2 6973.5 6990.1 6990.6 7026.0 6324.3 6419.8 6482.2 6519.8 6529.6 3792.9 3795.0 3804.8 3820.4 3831.6 7248.4 7349.3 7365.5 7372.7 7373.4 7208.2 7209.8 7214.1 7216.2 7238.4 7077.7 7081.1 7095.6 7238.1 7337.8 6884.8 6894.5 6914.2 6919.7 6921.9 6825.8 6841.3 6915.6 6915.8 6926.8 7364.6 7365.8 7372.6 7375.9 7391.0 4795.8 4916.4 4930.5 4937.3 4944.8 6819.4 6873.4 6960.2 6965.4 6990.8 6728.4 6740.0 6741.0 6748.6 6752.2 6682.9 6686.6 6715.5 6721.0 6739.4 6392.0 6579.7 6593.9 6639.8 6670.8 6730.7 6760.6 6789.8 6817.5 6820.7 6571.4 6594.6 6630.2 6647.4 6674.3 14:20:16 INFO - PROCESS | 16946 | 14:20:16 INFO - PROCESS | 16946 | [#5] yui.html Cycles:180 Average:14711.85 Median:4263.17 stddev:16777.24 (393.5%) stddev-sans-first:16791.57 14:20:16 INFO - PROCESS | 16946 | Values: 756.2 827.8 834.1 850.4 855.2 14482.1 14724.9 14905.5 14910.9 14912.8 13863.7 14004.9 14006.1 14037.4 14105.0 921.7 943.0 943.1 980.4 984.4 967.8 983.0 984.9 985.7 986.9 997.4 1006.9 1007.9 1007.9 1009.9 981.0 987.0 990.2 993.8 994.1 732.3 734.0 736.8 737.1 739.3 15229.5 15252.0 15261.4 15290.9 15305.7 13540.8 13682.0 13777.7 13801.5 13917.5 11750.4 11768.9 11811.1 11884.6 11890.3 3869.1 3909.0 3926.9 3956.3 3968.3 51405.7 51873.5 52062.5 52247.2 52320.7 10175.6 10796.8 10845.7 10902.7 10957.3 17169.4 17262.4 17269.3 17299.2 17307.8 8112.7 8233.3 8257.4 8538.3 8555.3 4754.4 4760.5 4810.3 4864.0 4877.0 3363.7 3401.6 3406.5 3407.7 3411.7 617.5 622.2 624.8 628.1 642.7 603.5 636.9 675.8 689.7 691.7 8830.8 8914.7 9021.0 9071.6 9265.0 688.6 692.9 707.5 708.4 720.9 4252.7 4260.7 4265.6 4308.2 4312.8 59849.0 59855.1 60515.0 62071.4 62189.7 51795.0 52752.5 53107.5 53559.0 54138.5 46847.3 48139.0 48181.8 49598.0 49839.8 7967.3 8086.6 8155.8 8179.2 8318.5 34612.8 34831.7 35971.3 37777.8 38609.0 46807.0 47074.0 47299.8 47520.8 48868.0 11953.9 12141.5 12251.7 12252.9 12364.3 12990.1 13168.9 13181.1 13662.2 13847.3 12226.2 12247.4 12268.3 12372.9 12556.4 12014.6 12486.0 12574.2 12769.7 12921.5 11907.9 12035.6 12121.5 12310.6 12348.6 10702.1 10898.2 10953.2 11017.0 11379.5 10465.8 10542.1 10735.9 10809.9 10824.2 14:20:16 INFO - PROCESS | 16946 | -------- Summary: end -------- 14:20:16 INFO - PROCESS | 16946 | 14:20:17 INFO - TEST-INFO | 16946: exit 0 14:20:17 INFO - TEST-OK | dromaeo_css | took 1108853ms 14:20:17 INFO - TEST-START | kraken 14:20:17 INFO - operating with platform_type : linux_ 14:20:17 INFO - Initialising browser for kraken test... 14:20:17 INFO - TEST-INFO | started process 17189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG34XqS/profile http://localhost:52868/getInfo.html) 14:20:20 INFO - PROCESS | 17189 | 14:20:20 INFO - PROCESS | 17189 | (process:17263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:20:21 INFO - PROCESS | 17189 | __metrics Screen width/height:1600/1200 14:20:21 INFO - PROCESS | 17189 | colorDepth:24 14:20:21 INFO - PROCESS | 17189 | Browser inner width/height: 1024/697 14:20:21 INFO - PROCESS | 17189 | __metrics 14:20:22 ERROR - PROCESS | 17189 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 14:20:23 INFO - TEST-INFO | 17189: exit 0 14:20:23 INFO - Browser initialized. 14:20:23 INFO - Running cycle 1/1 for kraken test... 14:20:23 INFO - TEST-INFO | started process 17313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG34XqS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:25 INFO - PROCESS | 17313 | 14:20:25 INFO - PROCESS | 17313 | (process:17381): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:20:35 INFO - PROCESS | 17313 | RSS: Main: 149753856 14:20:35 INFO - PROCESS | 17313 | 14:20:37 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52868/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:38 INFO - PROCESS | 17313 | RSS: Main: 154525696 14:20:38 INFO - PROCESS | 17313 | 14:20:40 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52868/tests/kraken/driver.html?testName=audio-dft) 14:20:41 INFO - PROCESS | 17313 | RSS: Main: 154341376 14:20:41 INFO - PROCESS | 17313 | 14:20:44 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52868/tests/kraken/driver.html?testName=audio-fft) 14:20:44 INFO - PROCESS | 17313 | RSS: Main: 154714112 14:20:44 INFO - PROCESS | 17313 | 14:20:46 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52868/tests/kraken/driver.html?testName=audio-oscillator) 14:20:47 INFO - PROCESS | 17313 | RSS: Main: 154611712 14:20:47 INFO - PROCESS | 17313 | 14:20:49 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:50 INFO - PROCESS | 17313 | RSS: Main: 154828800 14:20:50 INFO - PROCESS | 17313 | 14:20:53 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52868/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:53 INFO - PROCESS | 17313 | RSS: Main: 154935296 14:20:53 INFO - PROCESS | 17313 | 14:20:57 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52868/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:57 INFO - PROCESS | 17313 | RSS: Main: 155058176 14:20:57 INFO - PROCESS | 17313 | 14:21:00 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52868/tests/kraken/driver.html?testName=json-parse-financial) 14:21:01 INFO - PROCESS | 17313 | RSS: Main: 155394048 14:21:01 INFO - PROCESS | 17313 | 14:21:02 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:03 INFO - PROCESS | 17313 | RSS: Main: 154959872 14:21:03 INFO - PROCESS | 17313 | 14:21:05 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:05 INFO - PROCESS | 17313 | RSS: Main: 155066368 14:21:05 INFO - PROCESS | 17313 | 14:21:07 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:08 INFO - PROCESS | 17313 | RSS: Main: 155512832 14:21:08 INFO - PROCESS | 17313 | 14:21:10 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:11 INFO - PROCESS | 17313 | RSS: Main: 155566080 14:21:11 INFO - PROCESS | 17313 | 14:21:14 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:14 INFO - PROCESS | 17313 | RSS: Main: 155570176 14:21:14 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | Cycle 1(1): loaded http://localhost:52868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52868/tests/kraken/driver.html?testName=ai-astar) 14:21:16 INFO - PROCESS | 17313 | RSS: Main: 157274112 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | __start_tp_report 14:21:16 INFO - PROCESS | 17313 | _x_x_mozilla_page_load 14:21:16 INFO - PROCESS | 17313 | _x_x_mozilla_page_load_details 14:21:16 INFO - PROCESS | 17313 | |i|pagename|runs| 14:21:16 INFO - PROCESS | 17313 | |0;ai-astar;111;105;112;109;111;122;110;111;111;109 14:21:16 INFO - PROCESS | 17313 | |1;audio-beat-detection;157;129;157;172;128;158;154;130;175;129 14:21:16 INFO - PROCESS | 17313 | |2;audio-dft;162;163;162;164;163;162;163;162;163;166 14:21:16 INFO - PROCESS | 17313 | |3;audio-fft;76;78;75;165;73;75;74;74;162;76 14:21:16 INFO - PROCESS | 17313 | |4;audio-oscillator;94;94;152;93;93;93;147;92;93;147 14:21:16 INFO - PROCESS | 17313 | |5;imaging-gaussian-blur;117;117;118;117;118;117;116;121;118;118 14:21:16 INFO - PROCESS | 17313 | |6;imaging-darkroom;147;146;146;146;147;146;147;147;148;146 14:21:16 INFO - PROCESS | 17313 | |7;imaging-desaturate;96;97;96;96;96;97;96;96;96;96 14:21:16 INFO - PROCESS | 17313 | |8;json-parse-financial;63;56;59;56;55;57;55;57;55;54 14:21:16 INFO - PROCESS | 17313 | |9;json-stringify-tinderbox;65;63;63;64;64;64;65;64;65;65 14:21:16 INFO - PROCESS | 17313 | |10;stanford-crypto-aes;80;80;79;79;79;78;79;80;85;78 14:21:16 INFO - PROCESS | 17313 | |11;stanford-crypto-ccm;121;112;111;113;123;121;119;113;117;120 14:21:16 INFO - PROCESS | 17313 | |12;stanford-crypto-pbkdf2;143;142;146;144;143;142;143;142;142;135 14:21:16 INFO - PROCESS | 17313 | |13;stanford-crypto-sha256-iterative;66;66;68;65;66;70;67;68;72;64 14:21:16 INFO - PROCESS | 17313 | __end_tp_report 14:21:16 INFO - PROCESS | 17313 | __start_cc_report 14:21:16 INFO - PROCESS | 17313 | _x_x_mozilla_cycle_collect,819 14:21:16 INFO - PROCESS | 17313 | __end_cc_report 14:21:16 INFO - PROCESS | 17313 | __startTimestamp1464038476539__endTimestamp 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | ------- Summary: start ------- 14:21:16 INFO - PROCESS | 17313 | Number of tests: 14 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.31 (3.9%) stddev-sans-first:4.57 14:21:16 INFO - PROCESS | 17313 | Values: 111.0 105.0 112.0 109.0 111.0 122.0 110.0 111.0 111.0 109.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:157.00 stddev:18.38 (11.7%) stddev-sans-first:19.26 14:21:16 INFO - PROCESS | 17313 | Values: 157.0 129.0 157.0 172.0 128.0 158.0 154.0 130.0 175.0 129.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 14:21:16 INFO - PROCESS | 17313 | Values: 162.0 163.0 162.0 164.0 163.0 162.0 163.0 162.0 163.0 166.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:37.29 (49.7%) stddev-sans-first:39.06 14:21:16 INFO - PROCESS | 17313 | Values: 76.0 78.0 75.0 165.0 73.0 75.0 74.0 74.0 162.0 76.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:26.86 (28.9%) stddev-sans-first:27.88 14:21:16 INFO - PROCESS | 17313 | Values: 94.0 94.0 152.0 93.0 93.0 93.0 147.0 92.0 93.0 147.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:1.34 (1.1%) stddev-sans-first:1.39 14:21:16 INFO - PROCESS | 17313 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 116.0 121.0 118.0 118.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:21:16 INFO - PROCESS | 17313 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 148.0 146.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:21:16 INFO - PROCESS | 17313 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.63 (4.6%) stddev-sans-first:1.50 14:21:16 INFO - PROCESS | 17313 | Values: 63.0 56.0 59.0 56.0 55.0 57.0 55.0 57.0 55.0 54.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 14:21:16 INFO - PROCESS | 17313 | Values: 65.0 63.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.00 (2.5%) stddev-sans-first:2.12 14:21:16 INFO - PROCESS | 17313 | Values: 80.0 80.0 79.0 79.0 79.0 78.0 79.0 80.0 85.0 78.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:119.50 stddev:4.40 (3.7%) stddev-sans-first:4.42 14:21:16 INFO - PROCESS | 17313 | Values: 121.0 112.0 111.0 113.0 123.0 121.0 119.0 113.0 117.0 120.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:143.00 stddev:2.82 (2.0%) stddev-sans-first:2.98 14:21:16 INFO - PROCESS | 17313 | Values: 143.0 142.0 146.0 144.0 143.0 142.0 143.0 142.0 142.0 135.0 14:21:16 INFO - PROCESS | 17313 | 14:21:16 INFO - PROCESS | 17313 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.39 (3.5%) stddev-sans-first:2.50 14:21:16 INFO - PROCESS | 17313 | Values: 66.0 66.0 68.0 65.0 66.0 70.0 67.0 68.0 72.0 64.0 14:21:16 INFO - PROCESS | 17313 | -------- Summary: end -------- 14:21:16 INFO - PROCESS | 17313 | 14:21:17 INFO - TEST-INFO | 17313: exit 0 14:21:17 INFO - TEST-OK | kraken | took 60142ms 14:21:17 INFO - SUITE-END | took 1168s 14:21:17 INFO - Completed test suite (00:19:29) 14:21:17 INFO - javascript benchmark 14:21:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3320.63473017968, 3342.4986252062185, 3350.966490335096, 3367.3938691035605, 3377.881774137904, 5375.650582712121, 5386.245925570423, 5405.54052905503, 5420.295361602991, 5429.484199001094, 5357.598180136486, 5359.30329057223, 5360.812371566996, 5371.301730775003, 5379.193121031847, 4922.556969872702, 4964.404271487427, 5017.49825017499, 5041.1682072458, 5065.265536497206, 4854.635902307324, 4945.35710357653, 4957.0, 5007.574356179711, 5053.696778193302, 4982.402111746577, 5002.8249011284615, 5027.396712394518, 5075.822346217883, 5088.465711100337, 5049.116404629175, 5052.418971818232, 5063.518965698271, 5067.417247016603, 5073.873153171164, 4562.028321885869, 4905.901881962341, 4980.178270585349, 5020.899582008339, 5048.873778155539, 5314.681119132826, 5327.920081198785, 5330.093884039684, 5341.2255222992835, 5365.7585408656705, 5861.6189947653265, 5896.351401345849, 5908.468237858613, 5919.1713160157615, 5950.7917222896995, 5866.208061911672, 5909.261342332208, 5931.792387266425, 5935.228420305376, 5966.791162309299, 5457.754401051922, 5513.255710479074, 5518.420565840609, 5520.420355862657, 5542.362628297717, 5863.70681465925, 6012.939870601325, 6014.729337179838, 6021.337652858182, 6053.939460605337, 5718.0, 5808.3901190375245, 5816.82549523515, 5823.475887170091, 5836.299644042657, 5880.970830104715, 5891.646501209942, 5894.469497745224, 5896.292444906553, 5916.171735956969, 5707.3721890592005, 5815.534757219412, 5858.121281807763, 5863.237779088777, 5874.236349274653, 5893.675847828325, 5924.585279030426, 5926.644401335848, 5934.6142500737315, 5978.342382337939, 4494.438195225597, 4519.118771839459, 4533.909321813545, 4536.0, 4567.429071366079, 3954.406838974177, 3999.7200195986584, 4045.352743561075, 4074.4703188585295, 4117.835286588503, 5439.809606663748, 5549.1676248563035, 5557.472040156179, 5591.27313449249, 5627.986962346817, 5876.853078672982, 5919.378465261172, 5926.0, 5931.228940237742, 5934.406559344031, 5492.945070549324, 5572.108462646038, 5572.331320241597, 5584.52531534816, 5651.604387692904, 5098.031374038921, 5113.0, 5113.769880355393, 5114.872128196825, 5149.407818100892, 5986.2517185351835, 6031.638101713911, 6034.969825150934, 6048.667323297261, 6096.573239873166, 5745.368009518866, 5825.650460972355, 5896.233489646319, 5911.201987731602, 5917.112433135064, 6050.84872878164, 6064.332923378513, 6074.696265186812, 6076.453119219114, 6105.358937311518, 5778.248827652378, 5783.884322313446, 5784.2769653793275, 5785.652860828363, 5794.652320860593, 5803.158542011469, 5866.560007999503, 5872.119182122716, 5953.851153721192, 5992.340842507234, 5746.396628353963, 5759.539236861125, 5789.623674461147, 5804.796832110856, 5804.912926306024, 5752.827415177551, 5770.826875193751, 5776.595638305278, 5795.768169273182, 5816.952948469316, 5489.478499542537, 5583.469570390806, 5644.209810626434, 5673.205751194753, 5691.2032315475035, 5657.179708942263, 5684.204211410323, 5718.942810571841, 5773.22061521706, 5778.451047150514, 5562.276904002454, 5566.053770858883, 5623.100303951348, 5633.746481408264, 5652.123920792284], "unit": "score", "name": "dojo.html", "value": 5419.725540458334}, {"lowerIsBetter": false, "replicates": [529.8754792623732, 541.3125330829844, 564.0861803877718, 580.5645765675744, 589.6579983609504, 40183.1963360733, 40794.98012549684, 41112.0, 41132.0, 41204.17591648173, 42274.57725422745, 42393.57606423935, 42610.14779704404, 42779.0, 42976.0, 8840.557972101402, 9094.363394562382, 9096.499692516909, 9108.18026377626, 9114.0, 8928.107189281085, 9047.638094476213, 9068.637254509811, 9198.678046268382, 9229.953850230739, 9206.677766278182, 9280.0, 9307.72076837696, 9315.953420232889, 9349.018353072897, 9172.12864777845, 9226.953865230698, 9285.58214880332, 9300.11648893354, 9327.113924177193, 9050.502222377767, 9241.445513269226, 9245.214156796681, 9273.536323183815, 9276.07239276067, 43879.561204387865, 44308.3353749694, 44331.55668443339, 44432.77783611094, 44544.554554454364, 3683.336999340118, 3710.870119545803, 3764.228333191689, 3783.8675646352244, 3785.3943369060817, 31360.21599460009, 32629.0, 32673.0, 32827.50758738621, 33132.3373532528, 4369.71596846204, 4385.934210986838, 4387.210302145612, 4439.289713645833, 4444.400005999181, 282895.0, 285542.0, 286805.0, 286988.0, 286998.0, 62285.0, 62341.0, 62368.0, 62400.0, 62453.37546624475, 75718.0, 76000.61999689967, 76809.61595191988, 77142.22857771463, 77350.22649773542, 15308.923455382652, 15487.690246195012, 15565.766513502307, 15590.610234743996, 15706.764398534031, 13388.933055334855, 13485.325733713275, 13507.797383039262, 13512.459501620022, 13521.729565408834, 23431.531369372857, 23619.645705314433, 23757.287281381585, 23946.52106957851, 23982.28053158408, 8043.919560804434, 8108.027066737256, 8153.470024448392, 8343.16568343173, 8463.661453541912, 1023.7542989682422, 1056.2395075545594, 1076.8438576406534, 1078.320657985464, 1152.4007516091754, 29618.851905740332, 30001.849990749906, 30288.848555757522, 30912.227194319872, 31128.53307200394, 1115.4645770030431, 1118.4910865556153, 1148.3511815824033, 1157.976840463186, 1171.2562522798085, 15074.0, 15118.622034449227, 15248.695026099416, 15335.92332038355, 15576.221188940508, 330742.0, 518387.0, 521912.0, 523116.0, 530731.0, 58613.706931465924, 59004.40995590075, 59052.11421828676, 59069.40930590725, 59441.10838337428, 1484.4284950293998, 1484.5546336099128, 1490.8360080391365, 1502.0762231227716, 1502.136271643809, 29574.260643483223, 30161.849190753906, 30677.079687609406, 32322.515162273055, 33142.0, 51824.22263666124, 52032.0, 52141.47858521366, 52231.0, 52232.21651675152, 330429.0, 331175.0, 334133.0, 335537.0, 336527.0, 35033.474497883064, 47520.7623961878, 48719.51280487292, 49134.0, 49647.751761240965, 44097.77951110224, 45078.0, 45312.54687453083, 45755.0, 45820.7708961453, 40453.98865028398, 41203.175936481704, 41482.37776433416, 41497.79251103725, 42321.365179521716, 40282.79858600688, 40549.18901621892, 40892.59107408888, 41000.0, 41325.0, 40114.598854011085, 40251.396229056, 40291.395629065, 40588.79705601453, 40830.79584602058, 34846.47730284098, 34893.651063489044, 35241.647583524864, 35480.82259588686, 36073.45889811603, 26658.466830662892, 26659.20022399331, 27094.458110838066, 27118.72881271241, 27308.453830922874], "unit": "score", "name": "ext.html", "value": 20446.668552633655}, {"lowerIsBetter": false, "replicates": [361.4018798887841, 377.1514093290097, 385.92474467478837, 387.91853710720727, 399.17371041943187, 12260.325682087481, 12822.67943301418, 17831.37590184344, 18646.720299195506, 19393.903030484864, 19413.514662133453, 19674.311399101036, 19834.206631734713, 20129.69805452916, 20179.697304540445, 6351.555391122612, 6393.872122557569, 6633.369829866155, 6654.4676425886055, 6666.500012499057, 6449.806505804833, 6590.373914478141, 6598.47212223021, 6610.338966103375, 6627.1716035495565, 6549.803505894831, 6595.967020164892, 6622.8675426491445, 6917.0, 6937.826554336157, 6700.497462690293, 6821.0, 6851.280615535372, 7177.964110179468, 7270.818229544251, 6957.547759395623, 6962.443004559623, 6986.371226589631, 6998.75504357345, 7013.26360732126, 23042.654360184442, 23791.286261412184, 24105.397365065837, 24195.153169639154, 24232.0, 2375.4417711837705, 2556.821022528424, 2626.3828000419885, 2898.463784199909, 3068.0, 14408.855911440856, 14739.263036848222, 14848.777268340984, 15106.169160696158, 15296.541103766906, 1974.9506262343557, 2016.9798302016939, 2075.823554997827, 2098.443912363225, 2117.2272120676, 74614.62692686502, 75478.0, 76198.23801761967, 76948.0, 79113.19713414891, 14378.07565813588, 15599.61000974962, 15906.204689765465, 16146.192690365435, 16192.43326483591, 14990.175540345386, 15543.222838858012, 27960.48355647961, 27993.0, 28076.43847123087, 8068.233517815798, 8239.134890836376, 8241.876371854427, 8273.503589784632, 8436.620352084172, 7896.210378962172, 7916.089649690244, 7936.206379362133, 7947.682092716343, 8013.919860801434, 4575.519570445122, 4683.672142949961, 4769.594584460359, 4851.878703032452, 4852.102361063215, 1905.2759951218725, 1928.3154480159621, 1955.6577598920132, 2049.2008116834445, 2067.297118979524, 915.9816803663889, 937.3298091864214, 978.4031740638205, 1012.2256473797551, 1083.6586475260267, 17174.570635734206, 17358.39245626397, 17496.91251543734, 17598.0, 18040.368587099652, 983.3755565216139, 991.5785791038779, 1016.786474840277, 1029.4235228272191, 1051.75283808305, 9960.601575937026, 9985.0, 9995.250356223312, 10026.69919902404, 10058.0, 422855.0, 440238.0, 449591.0, 451865.0, 451962.0, 53197.46802532003, 77065.0, 79532.0, 79555.20444795478, 79882.0, 1073.5652060915343, 1106.2422240765102, 1108.4346983038708, 1109.5728144664363, 1112.404863398078, 15832.841671583137, 15931.8284401984, 15937.203139843194, 16054.839451605334, 16089.0, 29100.563491548066, 34746.826265868505, 34913.0, 35237.11907202341, 35849.1037724059, 47115.76442117905, 47299.0, 47325.053498930516, 47777.0, 47834.521654783006, 8252.46358986664, 8613.913860861561, 8690.956545217234, 8778.956105219688, 8803.647854085764, 9854.704358869245, 12689.23864568092, 13023.218606883618, 13071.15037522558, 13267.734645307233, 10938.343699378063, 10970.835437468284, 11032.669019929415, 11042.889571104186, 11132.833007505056, 10686.946565267124, 10756.892431075588, 10989.285696429706, 11078.279911805706, 11168.497417616065, 10874.456277185951, 11236.101111911192, 11311.660650180507, 11370.602028928948, 11521.078313734713, 8304.086550479322, 8637.0, 8659.653613855375, 8696.043435222247, 8713.477191368538, 8590.441621294596, 8939.463632182089, 10730.946345268223, 11354.886451135382, 11414.429278536207], "unit": "score", "name": "jquery.html", "value": 9428.8378959521}, {"lowerIsBetter": false, "replicates": [1563.1949545983816, 1589.253051065999, 1852.5553867071899, 1940.8253257206848, 1963.7839837617869, 7708.884366734504, 8197.303229225508, 8352.91647083529, 8587.570621468925, 8615.913840861589, 8370.162983701626, 8388.245057944783, 8422.747317580466, 8433.620487078097, 8483.151684831513, 2442.6702395176644, 2461.9261422157365, 2473.826832121752, 2485.453200295932, 2492.7382624824404, 2416.263039772877, 2463.5935070713313, 2471.406862353031, 2472.81453890958, 2475.851448913062, 2427.599446091393, 2447.0578827151585, 2461.4830885513975, 2463.950720985579, 2476.913308034219, 2430.149447693311, 2435.2450740270483, 2459.8032157427365, 2468.938276543101, 2472.554940110779, 2425.126954296452, 2437.890294936732, 2446.0704932125855, 2446.1805295226122, 2472.357187131359, 8644.789729437884, 8717.607707653107, 8720.171583699539, 8733.03936566977, 8751.3874028818, 5176.275321454999, 5305.602079844027, 5309.150535914274, 5318.574514038867, 5319.414864364917, 3307.4212012897647, 3317.253617935969, 3360.1263671445354, 3363.360961417323, 3386.153461634591, 1071.7534966957564, 1076.6016573867641, 1079.3038490173794, 1091.9508622112023, 1094.1356328500476, 11999.580014699532, 12059.638210853689, 12079.57721479744, 12188.207766495238, 12189.207701499463, 4564.13281476525, 4640.95359046412, 4650.116477869194, 4682.1103990241745, 4767.308740232646, 10269.383836969806, 10300.124489418333, 10305.330153539995, 10306.690799276033, 10344.844827327595, 5276.736163191825, 5279.41926388097, 5287.391949925808, 5295.338082739658, 5306.708131052752, 4724.173269677793, 4746.406699162605, 4840.346553215341, 4842.346283251716, 4870.14772414826, 3479.5824501060033, 3575.0883524701035, 3590.964090359063, 3652.926941461156, 3662.3957047086933, 1088.4013792414298, 1119.6137332620397, 1120.3222050659397, 1122.9494672739747, 1123.8876112388696, 1444.83384410792, 1451.5500194939602, 1459.4308219794289, 1465.4284828916732, 1487.6355292953297, 8073.19268073188, 8084.474509157004, 8103.189681031968, 8158.061822890325, 8170.673173073011, 544.4854612391252, 547.5504322766634, 547.942466041068, 553.1785298831232, 554.5286506469549, 6199.504039676815, 6203.503719702413, 6214.0, 6222.097795819581, 6285.497160227171, 10287.279890407599, 10706.892931070746, 10711.036006759428, 10779.730506737395, 10837.0, 10357.0, 10362.533685984148, 10417.218708596885, 10422.687319380431, 10446.895531044744, 8158.510489370657, 8259.339252859756, 8281.585920703941, 8379.958100209582, 8379.994400671958, 7702.499337543042, 7765.378769698524, 7786.727464538714, 7791.415643826849, 7796.844063118592, 9385.108414700593, 9396.342256042011, 9450.574724137292, 9505.66730164441, 9725.367851089657, 8862.291016718777, 9190.40262382943, 9345.299102567198, 9546.761330966503, 9720.902790972283, 7409.8147546311775, 7449.776506704808, 7595.164531901597, 7630.2751238632245, 7647.235276472308, 8208.876866847122, 8231.835363292821, 8240.50556966584, 8302.460340077876, 8314.667413303641, 7362.668679909524, 7387.704491820267, 7400.185979542139, 7413.258674132544, 7591.962040189985, 7342.0, 7481.663325150273, 7485.363744081814, 7557.697692092474, 7584.355329797029, 7531.58576278288, 7543.0948286206, 7621.923780762121, 7633.389328853789, 7639.694412223671, 7049.436045116276, 7056.717731290691, 7060.823479413056, 7120.181179164255, 7161.283871612797, 7150.034745309525, 7212.386947109554, 7259.6007219603425, 7309.780706578811, 7369.226231245856], "unit": "score", "name": "mootools.html", "value": 4818.602599010848}, {"lowerIsBetter": false, "replicates": [359.8884345852785, 361.8407900523769, 362.38394728960776, 363.3405369254804, 363.64362924334154, 6376.0, 6388.712507937143, 6436.873547129251, 6445.419912207901, 6446.613203207811, 6286.119943207955, 6298.0, 6307.526935479835, 6307.653079080649, 6310.368963103699, 4719.622430205575, 4781.545753153462, 4831.227003679412, 4855.223164293714, 4858.0, 4830.73430961297, 4837.612990960714, 4849.806007759703, 4851.708897466164, 4870.829520966767, 4796.280557916306, 4821.662483626147, 4829.637777166709, 4835.1296766582, 4836.782344794493, 4826.3001864729595, 4842.4189097308545, 4843.733594652293, 4851.757412129397, 4853.126437241295, 4231.407602935591, 4236.068065025689, 4238.152369526107, 4239.533651298355, 4272.6154646082, 5909.852253693649, 6038.818835434944, 6041.879162416771, 6045.244344456943, 6045.909311360333, 5639.351474580394, 5642.57680673947, 5642.915356269659, 5647.0, 5651.519620832234, 6645.9667701661665, 6661.866762664768, 6681.665916704194, 6705.128333316687, 6731.427828634572, 4629.490756016836, 4660.813567457331, 4670.392848929618, 4679.532046795327, 4685.718856868599, 6981.0924579804805, 6990.021397004423, 7021.61381124038, 7056.929430705679, 7068.939659051183, 4615.861524154281, 4783.354247176656, 4787.162246606899, 4793.832215872428, 4796.06476737033, 4855.927161092586, 4865.929495510982, 4870.902581948412, 4876.146674331978, 4878.609711223094, 5616.1014237721765, 5625.971870140623, 5626.2967129108865, 5630.071038278638, 5644.774209031675, 6765.830854228684, 6787.694553745093, 6787.864242715118, 6813.1142951415995, 6819.863602727918, 1705.4116329866176, 1725.887817291872, 1727.8617710583123, 1729.8789084763946, 1730.3684155283484, 1086.5219303506433, 1136.78969390663, 1141.697450175704, 1141.8743938166795, 1157.2130950953433, 6535.215774107138, 6542.574732642363, 6556.967215163893, 6557.770478033246, 6560.737570497126, 6958.234594194634, 6973.476989225828, 6990.126234220723, 6990.580565166107, 7026.016357709823, 6324.272708638474, 6419.839504012343, 6482.157319548429, 6519.8044058678315, 6529.640869752209, 3792.867249646249, 3794.962050379516, 3804.8478060877255, 3820.388737801994, 3831.578526362098, 7248.383887369527, 7349.338559529668, 7365.48441609093, 7372.668229929666, 7373.410127189812, 7208.243134470805, 7209.783706488814, 7214.098237720285, 7216.206217316091, 7238.384737297389, 7077.681504332318, 7081.114860642419, 7095.574265544084, 7238.131424229021, 7337.844726767541, 6884.827879303058, 6894.482913781386, 6914.170299564084, 6919.6886140124825, 6921.930780692129, 6825.795226143224, 6841.315868413119, 6915.619640919797, 6915.757948471779, 6926.792196234121, 7364.631768411451, 7365.8158546036775, 7372.59450730215, 7375.889361659472, 7391.039164908528, 4795.832145874878, 4916.360873086619, 4930.506949305184, 4937.28409380645, 4944.788526810954, 6819.420349270367, 6873.415759660485, 6960.234374218933, 6965.44276457872, 6990.825229369307, 6728.360805723449, 6739.966300168468, 6740.966295168689, 6748.561343512656, 6752.223494298219, 6682.866342673022, 6686.598804071771, 6715.496337774589, 6720.966395167993, 6739.427148692416, 6391.96804015977, 6579.736810527716, 6593.901091483535, 6639.804835129723, 6670.83322916931, 6730.6971186297715, 6760.560563563353, 6789.762358317435, 6817.454603631797, 6820.658967051727, 6571.3757193066585, 6594.604323740591, 6630.237522684953, 6647.401733843977, 6674.299198584273], "unit": "score", "name": "prototype.html", "value": 5100.135980312627}, {"lowerIsBetter": false, "replicates": [756.1531085184592, 827.8178800663853, 834.1158372125548, 850.425962475329, 855.1747563601124, 14482.131072135666, 14724.92637536812, 14905.478308259213, 14910.925445372757, 14912.776308355384, 13863.722725545484, 14004.859951400484, 14006.089604175722, 14037.36831842567, 14105.0, 921.6866265469722, 943.03810113684, 943.1370296178987, 980.3725615606018, 984.3700031979503, 967.796762679838, 982.9950850245739, 984.9015098490165, 985.6845809341014, 986.9259805514579, 997.4015590645627, 1006.8791744990612, 1007.8891321954579, 1007.9496025198711, 1009.8737657792776, 981.043482604462, 986.9753256168582, 990.1781521337309, 993.7565296502368, 994.0953732103823, 732.2823632839846, 733.9669714862844, 736.830528978338, 737.0860133434556, 739.3309055304958, 15229.543113706606, 15252.0, 15261.38954441821, 15290.923545382313, 15305.699015583688, 13540.796888046687, 13682.0, 13777.724445511134, 13801.51694690691, 13917.512887049006, 11750.412479376082, 11768.882311176863, 11811.114166437466, 11884.643460696192, 11890.28658280506, 3869.148787266825, 3909.0, 3926.8625598104213, 3956.287868183726, 3968.2658708138797, 51405.742971285275, 51873.48126518724, 52062.479375206145, 52247.216291755656, 52320.738396307774, 10175.643852465128, 10796.838047429295, 10845.674629761119, 10902.672919812418, 10957.287776294515, 17169.399071032705, 17262.395816146374, 17269.309227630754, 17299.221535030953, 17307.826921730873, 8112.675492980333, 8233.300169485541, 8257.38069644767, 8538.316934645214, 8555.31557475413, 4754.405699287589, 4760.452547957029, 4810.326554282333, 4864.027194561102, 4877.024595080998, 3363.6972672459597, 3401.557797486311, 3406.5060566218253, 3407.727381809449, 3411.727061835047, 617.5029101573276, 622.17561730707, 624.753222477119, 628.0610487321484, 642.720416618763, 603.499095750526, 636.901280301554, 675.770238119032, 689.672331002913, 691.695653912277, 8830.823383532294, 8914.687985920462, 9021.0, 9071.637134514678, 9264.95367523158, 688.579966220605, 692.8960655901656, 707.5012116457884, 708.4084789200972, 720.9423246140296, 4252.744835309892, 4260.744355338627, 4265.594768496988, 4308.186545964739, 4312.849050283287, 59849.0, 59855.102173467436, 60515.0, 62071.37928620746, 62189.68905155445, 51795.0, 52752.47247527476, 53107.46892531103, 53559.0, 54138.45861541334, 46847.29729054067, 48138.9999999993, 48181.759091204316, 49598.0, 49839.75080124576, 7967.282944534788, 8086.555239461651, 8155.836883262183, 8179.222973817716, 8318.500889946623, 34612.82693586516, 34831.65168348284, 35971.28057438889, 37777.81111094427, 38609.0, 46807.0, 47074.0, 47299.76350118227, 47520.7623961878, 48868.0, 11953.880461195276, 12141.453634586642, 12251.69370765738, 12252.938735306267, 12364.319962402154, 12990.090693651353, 13168.934155329162, 13181.143225690299, 13662.18026918388, 13847.30763461843, 12226.20529665569, 12247.448864801283, 12268.263904165779, 12372.938135309267, 12556.372181391076, 12014.579489717818, 12486.0, 12574.245545267313, 12769.680757981125, 12921.483140674643, 11907.880921191023, 12035.578754743541, 12121.515139394325, 12310.630681079581, 12348.629541113782, 10702.09032232269, 10898.237123401286, 10953.17851161182, 11017.0, 11379.54481820718, 10465.790684186122, 10542.13719410553, 10735.94632026835, 10809.919008099127, 10824.188185885932], "unit": "score", "name": "yui.html", "value": 6869.642731298096}], "name": "dromaeo_css", "value": 7488.971351405517}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 109.0, 111.0, 122.0, 110.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 157.0, 172.0, 128.0, 158.0, 154.0, 130.0, 175.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 164.0, 163.0, 162.0, 163.0, 162.0, 163.0, 166.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 75.0, 165.0, 73.0, 75.0, 74.0, 74.0, 162.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 152.0, 93.0, 93.0, 93.0, 147.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0, 121.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [63.0, 56.0, 59.0, 56.0, 55.0, 57.0, 55.0, 57.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 79.0, 79.0, 79.0, 78.0, 79.0, 80.0, 85.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [121.0, 112.0, 111.0, 113.0, 123.0, 121.0, 119.0, 113.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 146.0, 144.0, 143.0, 142.0, 143.0, 142.0, 142.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 65.0, 66.0, 70.0, 67.0, 68.0, 72.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1513.1000000000001}]} 14:21:17 INFO - Return code: 0 14:21:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:17 ERROR - # TBPL SUCCESS # 14:21:17 INFO - Running post-action listener: _resource_record_post_action 14:21:17 INFO - Running post-run listener: _resource_record_post_run 14:21:18 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 461926400; Read time: 0; Write time: 434232 14:21:18 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237572096; Read time: 0; Write time: 294156 14:21:18 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 223965184; Read time: 0; Write time: 140052 14:21:18 INFO - Running post-run listener: _upload_blobber_files 14:21:18 INFO - Blob upload gear active. 14:21:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:21:18 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 14:21:18 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'] 14:21:18 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 14:21:19 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:20 INFO - (blobuploader) - INFO - Done attempting. 14:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:21 INFO - (blobuploader) - INFO - Done attempting. 14:21:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:21 INFO - Return code: 0 14:21:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:21:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f23dcd99501f0684256bb2dc4a4a5f0abb3aa546021968e913fbd319e700e6c5f719024f71e7bce37770e8bc2fe870a72367d6f7a5c81d8dbae69b61972b16c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44951bc27c98f0f4508d4fe4ba69beabe3476e32553cecad7386771d0e3a833be5749065412eabfb459b6f511443c7b324bde276649395bbee4e030530f6f64e"} 14:21:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:21:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:21:21 INFO - Contents: 14:21:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f23dcd99501f0684256bb2dc4a4a5f0abb3aa546021968e913fbd319e700e6c5f719024f71e7bce37770e8bc2fe870a72367d6f7a5c81d8dbae69b61972b16c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44951bc27c98f0f4508d4fe4ba69beabe3476e32553cecad7386771d0e3a833be5749065412eabfb459b6f511443c7b324bde276649395bbee4e030530f6f64e"} 14:21:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:21 INFO - Copying logs to upload dir... 14:21:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:21:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.803068 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-05-23 14:21:19.647876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:19.651846) ========= 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-1464037257.850344-1757129479 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/f23dcd99501f0684256bb2dc4a4a5f0abb3aa546021968e913fbd319e700e6c5f719024f71e7bce37770e8bc2fe870a72367d6f7a5c81d8dbae69b61972b16c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44951bc27c98f0f4508d4fe4ba69beabe3476e32553cecad7386771d0e3a833be5749065412eabfb459b6f511443c7b324bde276649395bbee4e030530f6f64e"} build_url:https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/F4dCmJ-ZSISPOH_ypVfDtg/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/f23dcd99501f0684256bb2dc4a4a5f0abb3aa546021968e913fbd319e700e6c5f719024f71e7bce37770e8bc2fe870a72367d6f7a5c81d8dbae69b61972b16c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44951bc27c98f0f4508d4fe4ba69beabe3476e32553cecad7386771d0e3a833be5749065412eabfb459b6f511443c7b324bde276649395bbee4e030530f6f64e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:19.676673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:19.676990) ========= 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-1464037257.850344-1757129479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:19.762042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:21:19.762352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:21:19.762661) ========= ========= Total master_lag: 0.17 =========