builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1461753573.05 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.048174) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.048614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.048886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.065374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.065720) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:39:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-04-27 03:39:33 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096116 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.175053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.175370) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018266 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.225406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.225735) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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=a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:39:33,320 truncating revision to first 12 chars 2016-04-27 03:39:33,320 Setting DEBUG logging. 2016-04-27 03:39:33,320 attempt 1/10 2016-04-27 03:39:33,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:39:33,566 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.754667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.754986) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.755362) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.755621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.765402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-27 03:39:33.765677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:33 INFO - MultiFileLogger online at 20160427 03:39:33 in /builds/slave/test 03:39:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:39:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:33 INFO - {'append_to_log': False, 03:39:33 INFO - 'base_work_dir': '/builds/slave/test', 03:39:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:33 INFO - 'branch': 'Mozilla-Aurora', 03:39:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:33 INFO - 'config_files': ('talos/linux_config.py',), 03:39:33 INFO - 'default_actions': ('clobber', 03:39:33 INFO - 'read-buildbot-config', 03:39:33 INFO - 'download-and-extract', 03:39:33 INFO - 'populate-webroot', 03:39:33 INFO - 'create-virtualenv', 03:39:33 INFO - 'install', 03:39:33 INFO - 'run-tests'), 03:39:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:33 INFO - 'download_minidump_stackwalk': True, 03:39:33 INFO - 'download_symbols': 'ondemand', 03:39:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:33 INFO - 'installer_path': 'installer.exe', 03:39:33 INFO - 'log_level': 'info', 03:39:33 INFO - 'log_name': 'talos', 03:39:33 INFO - 'log_to_console': True, 03:39:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:33 INFO - 'opt_config_files': (), 03:39:33 INFO - 'pip_index': False, 03:39:33 INFO - 'sps_profile': False, 03:39:33 INFO - 'sps_profile_interval': 0, 03:39:33 INFO - 'suite': 'dromaeojs-e10s', 03:39:33 INFO - 'system_bits': '32', 03:39:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:33 INFO - 'title': 'talos-linux64-ix-062', 03:39:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:33 INFO - 'use_talos_json': True, 03:39:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:33 INFO - 'work_dir': 'build'} 03:39:33 INFO - ##### 03:39:33 INFO - ##### Running clobber step. 03:39:33 INFO - ##### 03:39:33 INFO - Running pre-action listener: _resource_record_pre_action 03:39:33 INFO - Running main action method: clobber 03:39:33 INFO - rmtree: /builds/slave/test/build 03:39:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:34 INFO - Running post-action listener: _resource_record_post_action 03:39:34 INFO - ##### 03:39:34 INFO - ##### Running read-buildbot-config step. 03:39:34 INFO - ##### 03:39:34 INFO - Running pre-action listener: _resource_record_pre_action 03:39:34 INFO - Running main action method: read_buildbot_config 03:39:34 INFO - Using buildbot properties: 03:39:34 INFO - { 03:39:34 INFO - "project": "", 03:39:34 INFO - "product": "firefox", 03:39:34 INFO - "script_repo_revision": "production", 03:39:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:39:34 INFO - "repository": "", 03:39:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:39:34 INFO - "buildid": "20160425062348", 03:39:34 INFO - "pgo_build": "True", 03:39:34 INFO - "basedir": "/builds/slave/test", 03:39:34 INFO - "buildnumber": 264, 03:39:34 INFO - "slavename": "talos-linux64-ix-062", 03:39:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:39:34 INFO - "platform": "ubuntu64_hw", 03:39:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:34 INFO - "branch": "mozilla-aurora", 03:39:34 INFO - "repo_path": "releases/mozilla-aurora", 03:39:34 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 03:39:34 INFO - "stage_platform": "linux64-pgo", 03:39:34 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 03:39:34 INFO - "slavebuilddir": "test" 03:39:34 INFO - } 03:39:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:39:34 INFO - Running post-action listener: _resource_record_post_action 03:39:34 INFO - ##### 03:39:34 INFO - ##### Running download-and-extract step. 03:39:34 INFO - ##### 03:39:34 INFO - Running pre-action listener: _resource_record_pre_action 03:39:34 INFO - Running main action method: download_and_extract 03:39:34 INFO - mkdir: /builds/slave/test/build/tests 03:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:34 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:39:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:39:39 INFO - Downloaded 1448 bytes. 03:39:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:39 INFO - Using the following test package requirements: 03:39:39 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:39 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:39 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:39 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'jsshell-linux-x86_64.zip'], 03:39:39 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:39 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:39 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:39 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:39 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:39 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:39 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:39 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:39 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')]} 03:39:39 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:40 INFO - Downloaded 23359918 bytes. 03:39:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:39:41 INFO - Return code: 0 03:39:41 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:41 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:54 INFO - Downloaded 23359918 bytes. 03:39:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:39:55 INFO - Return code: 0 03:39:55 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')]} 03:39:55 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:39:57 INFO - Downloaded 10845194 bytes. 03:39:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:39:57 INFO - Return code: 0 03:39:57 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')]} 03:39:57 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:39:58 INFO - Downloaded 60835591 bytes. 03:39:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:58 INFO - mkdir: /builds/slave/test/properties 03:39:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:58 INFO - Contents: 03:39:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:59 INFO - Running post-action listener: _resource_record_post_action 03:39:59 INFO - Running post-action listener: set_extra_try_arguments 03:39:59 INFO - ##### 03:39:59 INFO - ##### Running populate-webroot step. 03:39:59 INFO - ##### 03:39:59 INFO - Running pre-action listener: _resource_record_pre_action 03:39:59 INFO - Running main action method: populate_webroot 03:39:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:59 INFO - '--tppagecycles', 03:39:59 INFO - '7'], 03:39:59 INFO - 'tests': ['tsvgm']}}, 03:39:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:39:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:39:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'tests': ['damp', 'tps']}, 03:39:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['damp', 'tps']}, 03:39:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:39:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:59 INFO - 'other': {'tests': ['a11yr', 03:39:59 INFO - 'ts_paint', 03:39:59 INFO - 'tpaint', 03:39:59 INFO - 'sessionrestore', 03:39:59 INFO - 'sessionrestore_no_auto_restore', 03:39:59 INFO - 'tabpaint']}, 03:39:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['a11yr', 03:39:59 INFO - 'ts_paint', 03:39:59 INFO - 'tpaint', 03:39:59 INFO - 'sessionrestore', 03:39:59 INFO - 'sessionrestore_no_auto_restore', 03:39:59 INFO - 'tabpaint']}, 03:39:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['a11yr', 03:39:59 INFO - 'ts_paint', 03:39:59 INFO - 'tpaint', 03:39:59 INFO - 'sessionrestore', 03:39:59 INFO - 'sessionrestore_no_auto_restore', 03:39:59 INFO - 'tabpaint']}, 03:39:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['a11yr', 03:39:59 INFO - 'ts_paint', 03:39:59 INFO - 'tpaint', 03:39:59 INFO - 'sessionrestore', 03:39:59 INFO - 'sessionrestore_no_auto_restore', 03:39:59 INFO - 'tabpaint']}, 03:39:59 INFO - 'other_l64': {'tests': ['a11yr', 03:39:59 INFO - 'ts_paint', 03:39:59 INFO - 'tpaint', 03:39:59 INFO - 'sessionrestore', 03:39:59 INFO - 'sessionrestore_no_auto_restore', 03:39:59 INFO - 'tabpaint']}, 03:39:59 INFO - 'other_nol64': {'tests': ['a11yr', 03:39:59 INFO - 'ts_paint', 03:39:59 INFO - 'tpaint', 03:39:59 INFO - 'sessionrestore', 03:39:59 INFO - 'sessionrestore_no_auto_restore', 03:39:59 INFO - 'tabpaint']}, 03:39:59 INFO - 'svgr': {'tests': ['tsvgx', 03:39:59 INFO - 'tsvgr_opacity', 03:39:59 INFO - 'tart', 03:39:59 INFO - 'tscrollx', 03:39:59 INFO - 'cart']}, 03:39:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['tsvgx', 03:39:59 INFO - 'tsvgr_opacity', 03:39:59 INFO - 'tart', 03:39:59 INFO - 'tscrollx', 03:39:59 INFO - 'cart']}, 03:39:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'tests': ['tp5o']}, 03:39:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'talos_options': ['--e10s'], 03:39:59 INFO - 'tests': ['tp5o']}, 03:39:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'talos_options': ['--xperf_path', 03:39:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:59 INFO - 'tests': ['tp5n']}, 03:39:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:59 INFO - 'talos_options': ['--e10s', 03:39:59 INFO - '--xperf_path', 03:39:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:59 INFO - 'tests': ['tp5n']}}, 03:39:59 INFO - 'talos.zip': {'path': '', 03:39:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:59 INFO - Running post-action listener: _resource_record_post_action 03:39:59 INFO - ##### 03:39:59 INFO - ##### Running create-virtualenv step. 03:39:59 INFO - ##### 03:39:59 INFO - Running pre-action listener: _resource_record_pre_action 03:39:59 INFO - Running main action method: create_virtualenv 03:39:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:59 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 03:39:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:59 INFO - Using real prefix '/usr' 03:39:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:02 INFO - Installing pip.................done. 03:40:02 INFO - Return code: 0 03:40:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:02 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 03:40:02 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 03:40:02 INFO - Using env: {'DISPLAY': ':0', 03:40:02 INFO - 'HOME': '/home/cltbld', 03:40:02 INFO - 'LANG': 'en_US.UTF-8', 03:40:02 INFO - 'LANGUAGE': 'en_US:en', 03:40:02 INFO - 'LOGNAME': 'cltbld', 03:40:02 INFO - 'MAIL': '/var/mail/cltbld', 03:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:02 INFO - 'MOZ_NO_REMOTE': '1', 03:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:02 INFO - 'NO_EM_RESTART': '1', 03:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:02 INFO - 'PWD': '/builds/slave/test', 03:40:02 INFO - 'SHELL': '/bin/bash', 03:40:02 INFO - 'SHLVL': '1', 03:40:02 INFO - 'TERM': 'linux', 03:40:02 INFO - 'TMOUT': '86400', 03:40:02 INFO - 'USER': 'cltbld', 03:40:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:02 INFO - '_': '/tools/buildbot/bin/python'} 03:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:02 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 03:40:02 INFO - Cleaning up... 03:40:02 INFO - Return code: 0 03:40:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:02 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 03:40:02 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 03:40:02 INFO - Using env: {'DISPLAY': ':0', 03:40:02 INFO - 'HOME': '/home/cltbld', 03:40:02 INFO - 'LANG': 'en_US.UTF-8', 03:40:02 INFO - 'LANGUAGE': 'en_US:en', 03:40:02 INFO - 'LOGNAME': 'cltbld', 03:40:02 INFO - 'MAIL': '/var/mail/cltbld', 03:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:02 INFO - 'MOZ_NO_REMOTE': '1', 03:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:02 INFO - 'NO_EM_RESTART': '1', 03:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:02 INFO - 'PWD': '/builds/slave/test', 03:40:02 INFO - 'SHELL': '/bin/bash', 03:40:02 INFO - 'SHLVL': '1', 03:40:02 INFO - 'TERM': 'linux', 03:40:02 INFO - 'TMOUT': '86400', 03:40:02 INFO - 'USER': 'cltbld', 03:40:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:02 INFO - '_': '/tools/buildbot/bin/python'} 03:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:02 INFO - Downloading/unpacking psutil>=0.7.1 03:40:02 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 03:40:02 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 03:40:02 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 03:40:02 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 03:40:02 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 03:40:02 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 03:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:04 INFO - Installing collected packages: psutil 03:40:04 INFO - Running setup.py install for psutil 03:40:04 INFO - building 'psutil._psutil_linux' extension 03:40:04 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 03:40:04 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 03:40:04 INFO - building 'psutil._psutil_posix' extension 03:40:04 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 03:40:04 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 03:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:05 INFO - Successfully installed psutil 03:40:05 INFO - Cleaning up... 03:40:05 INFO - Return code: 0 03:40:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:40:05 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')]} 03:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:05 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')]} 03:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:05 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:05 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 03:40:05 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 03:40:05 INFO - Using env: {'DISPLAY': ':0', 03:40:05 INFO - 'HOME': '/home/cltbld', 03:40:05 INFO - 'LANG': 'en_US.UTF-8', 03:40:05 INFO - 'LANGUAGE': 'en_US:en', 03:40:05 INFO - 'LOGNAME': 'cltbld', 03:40:05 INFO - 'MAIL': '/var/mail/cltbld', 03:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:05 INFO - 'MOZ_NO_REMOTE': '1', 03:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:05 INFO - 'NO_EM_RESTART': '1', 03:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:05 INFO - 'PWD': '/builds/slave/test', 03:40:05 INFO - 'SHELL': '/bin/bash', 03:40:05 INFO - 'SHLVL': '1', 03:40:05 INFO - 'TERM': 'linux', 03:40:05 INFO - 'TMOUT': '86400', 03:40:05 INFO - 'USER': 'cltbld', 03:40:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:05 INFO - '_': '/tools/buildbot/bin/python'} 03:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:40:07 INFO - Installing collected packages: mozsystemmonitor 03:40:07 INFO - Running setup.py install for mozsystemmonitor 03:40:07 INFO - Successfully installed mozsystemmonitor 03:40:07 INFO - Cleaning up... 03:40:07 INFO - Return code: 0 03:40:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:07 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 03:40:07 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 03:40:07 INFO - Using env: {'DISPLAY': ':0', 03:40:07 INFO - 'HOME': '/home/cltbld', 03:40:07 INFO - 'LANG': 'en_US.UTF-8', 03:40:07 INFO - 'LANGUAGE': 'en_US:en', 03:40:07 INFO - 'LOGNAME': 'cltbld', 03:40:07 INFO - 'MAIL': '/var/mail/cltbld', 03:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:07 INFO - 'MOZ_NO_REMOTE': '1', 03:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:07 INFO - 'NO_EM_RESTART': '1', 03:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:07 INFO - 'PWD': '/builds/slave/test', 03:40:07 INFO - 'SHELL': '/bin/bash', 03:40:07 INFO - 'SHLVL': '1', 03:40:07 INFO - 'TERM': 'linux', 03:40:07 INFO - 'TMOUT': '86400', 03:40:07 INFO - 'USER': 'cltbld', 03:40:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:07 INFO - '_': '/tools/buildbot/bin/python'} 03:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:07 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 03:40:07 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 03:40:07 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 03:40:07 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 03:40:07 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 03:40:07 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 03:40:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:10 INFO - Downloading docopt-0.6.1.tar.gz 03:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:10 INFO - Running setup.py install for blobuploader 03:40:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:10 INFO - Running setup.py install for requests 03:40:10 INFO - Running setup.py install for docopt 03:40:10 INFO - Successfully installed blobuploader requests docopt 03:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:10 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')]} 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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')]} 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:10 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 03:40:10 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 03:40:10 INFO - Using env: {'DISPLAY': ':0', 03:40:10 INFO - 'HOME': '/home/cltbld', 03:40:10 INFO - 'LANG': 'en_US.UTF-8', 03:40:10 INFO - 'LANGUAGE': 'en_US:en', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MAIL': '/var/mail/cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SHLVL': '1', 03:40:10 INFO - 'TERM': 'linux', 03:40:10 INFO - 'TMOUT': '86400', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - '_': '/tools/buildbot/bin/python'} 03:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:11 INFO - Running setup.py (path:/tmp/pip-kXBEFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:11 INFO - Running setup.py (path:/tmp/pip-XGac3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:11 INFO - Running setup.py (path:/tmp/pip-VKSnz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:11 INFO - Running setup.py (path:/tmp/pip-ynEqr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:11 INFO - Running setup.py (path:/tmp/pip-xA5aUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:11 INFO - Running setup.py (path:/tmp/pip-2rNnr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:11 INFO - Running setup.py (path:/tmp/pip-Qy3qht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:11 INFO - Running setup.py (path:/tmp/pip-FBcHq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:11 INFO - Running setup.py (path:/tmp/pip-00zDAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:11 INFO - Running setup.py (path:/tmp/pip-w1a_II-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:11 INFO - Running setup.py (path:/tmp/pip-qMBPcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:11 INFO - Running setup.py (path:/tmp/pip-la9zdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:11 INFO - Running setup.py (path:/tmp/pip-6qiB5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:11 INFO - Running setup.py (path:/tmp/pip-FmMLSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:12 INFO - Running setup.py (path:/tmp/pip-WQIXVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:12 INFO - Running setup.py (path:/tmp/pip-QHLV5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:12 INFO - Running setup.py (path:/tmp/pip-6GpacB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:12 INFO - Running setup.py install for manifestparser 03:40:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Running setup.py install for mozcrash 03:40:12 INFO - Running setup.py install for mozdebug 03:40:12 INFO - Running setup.py install for mozdevice 03:40:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Running setup.py install for mozfile 03:40:12 INFO - Running setup.py install for mozhttpd 03:40:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Running setup.py install for mozinfo 03:40:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Running setup.py install for mozInstall 03:40:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozleak 03:40:13 INFO - Running setup.py install for mozlog 03:40:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for moznetwork 03:40:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozprocess 03:40:13 INFO - Running setup.py install for mozprofile 03:40:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozrunner 03:40:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozscreenshot 03:40:13 INFO - Running setup.py install for moztest 03:40:13 INFO - Running setup.py install for mozversion 03:40:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:14 INFO - Cleaning up... 03:40:14 INFO - Return code: 0 03:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:14 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 03:40:14 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 03:40:14 INFO - Using env: {'DISPLAY': ':0', 03:40:14 INFO - 'HOME': '/home/cltbld', 03:40:14 INFO - 'LANG': 'en_US.UTF-8', 03:40:14 INFO - 'LANGUAGE': 'en_US:en', 03:40:14 INFO - 'LOGNAME': 'cltbld', 03:40:14 INFO - 'MAIL': '/var/mail/cltbld', 03:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:14 INFO - 'MOZ_NO_REMOTE': '1', 03:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:14 INFO - 'NO_EM_RESTART': '1', 03:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:14 INFO - 'PWD': '/builds/slave/test', 03:40:14 INFO - 'SHELL': '/bin/bash', 03:40:14 INFO - 'SHLVL': '1', 03:40:14 INFO - 'TERM': 'linux', 03:40:14 INFO - 'TMOUT': '86400', 03:40:14 INFO - 'USER': 'cltbld', 03:40:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:14 INFO - '_': '/tools/buildbot/bin/python'} 03:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:14 INFO - Running setup.py (path:/tmp/pip-hb3Cs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:14 INFO - Running setup.py (path:/tmp/pip-fZbs6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:14 INFO - Running setup.py (path:/tmp/pip-IIDus0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:14 INFO - Running setup.py (path:/tmp/pip-5uVfFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:14 INFO - Running setup.py (path:/tmp/pip-KAmKnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:14 INFO - Running setup.py (path:/tmp/pip-OP6ue5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:14 INFO - Running setup.py (path:/tmp/pip-dDcWKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:14 INFO - Running setup.py (path:/tmp/pip-U4RIYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:14 INFO - Running setup.py (path:/tmp/pip-6Od67h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:14 INFO - Running setup.py (path:/tmp/pip-A9UAEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:14 INFO - Running setup.py (path:/tmp/pip-151MPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:15 INFO - Running setup.py (path:/tmp/pip-JuUU9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:15 INFO - Running setup.py (path:/tmp/pip-awbFwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:15 INFO - Running setup.py (path:/tmp/pip-zAMhjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:15 INFO - Running setup.py (path:/tmp/pip-Ty5dnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:15 INFO - Running setup.py (path:/tmp/pip-PffY9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:15 INFO - Running setup.py (path:/tmp/pip-fiskc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:17 INFO - Downloading blessings-1.6.tar.gz 03:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:17 INFO - Installing collected packages: blessings 03:40:17 INFO - Running setup.py install for blessings 03:40:17 INFO - Successfully installed blessings 03:40:17 INFO - Cleaning up... 03:40:17 INFO - Return code: 0 03:40:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:17 INFO - Reading from file tmpfile_stdout 03:40:17 INFO - Current package versions: 03:40:17 INFO - argparse == 1.2.1 03:40:17 INFO - blessings == 1.6 03:40:17 INFO - blobuploader == 1.2.4 03:40:17 INFO - docopt == 0.6.1 03:40:17 INFO - manifestparser == 1.1 03:40:17 INFO - mozInstall == 1.12 03:40:17 INFO - mozcrash == 0.17 03:40:17 INFO - mozdebug == 0.1 03:40:17 INFO - mozdevice == 0.48 03:40:17 INFO - mozfile == 1.2 03:40:17 INFO - mozhttpd == 0.7 03:40:17 INFO - mozinfo == 0.9 03:40:17 INFO - mozleak == 0.1 03:40:17 INFO - mozlog == 3.1 03:40:17 INFO - moznetwork == 0.27 03:40:17 INFO - mozprocess == 0.22 03:40:17 INFO - mozprofile == 0.28 03:40:17 INFO - mozrunner == 6.11 03:40:17 INFO - mozscreenshot == 0.1 03:40:17 INFO - mozsystemmonitor == 0.0 03:40:17 INFO - moztest == 0.7 03:40:17 INFO - mozversion == 1.4 03:40:17 INFO - psutil == 3.1.1 03:40:17 INFO - requests == 1.2.3 03:40:17 INFO - wsgiref == 0.1.2 03:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:17 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:17 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 03:40:17 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 03:40:17 INFO - Using env: {'DISPLAY': ':0', 03:40:17 INFO - 'HOME': '/home/cltbld', 03:40:17 INFO - 'LANG': 'en_US.UTF-8', 03:40:17 INFO - 'LANGUAGE': 'en_US:en', 03:40:17 INFO - 'LOGNAME': 'cltbld', 03:40:17 INFO - 'MAIL': '/var/mail/cltbld', 03:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:17 INFO - 'MOZ_NO_REMOTE': '1', 03:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:17 INFO - 'NO_EM_RESTART': '1', 03:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:17 INFO - 'PWD': '/builds/slave/test', 03:40:17 INFO - 'SHELL': '/bin/bash', 03:40:17 INFO - 'SHLVL': '1', 03:40:17 INFO - 'TERM': 'linux', 03:40:17 INFO - 'TMOUT': '86400', 03:40:17 INFO - 'USER': 'cltbld', 03:40:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:17 INFO - '_': '/tools/buildbot/bin/python'} 03:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 INFO - Cleaning up... 03:40:18 INFO - Return code: 0 03:40:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:18 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 03:40:18 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 03:40:18 INFO - Using env: {'DISPLAY': ':0', 03:40:18 INFO - 'HOME': '/home/cltbld', 03:40:18 INFO - 'LANG': 'en_US.UTF-8', 03:40:18 INFO - 'LANGUAGE': 'en_US:en', 03:40:18 INFO - 'LOGNAME': 'cltbld', 03:40:18 INFO - 'MAIL': '/var/mail/cltbld', 03:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:18 INFO - 'MOZ_NO_REMOTE': '1', 03:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:18 INFO - 'NO_EM_RESTART': '1', 03:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:18 INFO - 'PWD': '/builds/slave/test', 03:40:18 INFO - 'SHELL': '/bin/bash', 03:40:18 INFO - 'SHLVL': '1', 03:40:18 INFO - 'TERM': 'linux', 03:40:18 INFO - 'TMOUT': '86400', 03:40:18 INFO - 'USER': 'cltbld', 03:40:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:18 INFO - '_': '/tools/buildbot/bin/python'} 03:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:18 INFO - Downloading/unpacking jsonschema 03:40:18 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 03:40:18 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 03:40:18 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 03:40:18 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 03:40:18 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 03:40:18 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 03:40:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:20 INFO - Downloading/unpacking functools32 (from jsonschema) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:20 INFO - warning: no files found matching '*.txt' 03:40:20 INFO - no previously-included directories found matching 'build' 03:40:20 INFO - no previously-included directories found matching 'dist' 03:40:20 INFO - no previously-included directories found matching '.git*' 03:40:20 INFO - Installing collected packages: jsonschema, functools32 03:40:20 INFO - Running setup.py install for functools32 03:40:20 INFO - warning: no files found matching '*.txt' 03:40:20 INFO - no previously-included directories found matching 'build' 03:40:20 INFO - no previously-included directories found matching 'dist' 03:40:20 INFO - no previously-included directories found matching '.git*' 03:40:20 INFO - Successfully installed jsonschema functools32 03:40:20 INFO - Cleaning up... 03:40:20 INFO - Return code: 0 03:40:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:20 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 0x7f958d2f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', '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 03:40:20 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 03:40:20 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 03:40:20 INFO - Using env: {'DISPLAY': ':0', 03:40:20 INFO - 'HOME': '/home/cltbld', 03:40:20 INFO - 'LANG': 'en_US.UTF-8', 03:40:20 INFO - 'LANGUAGE': 'en_US:en', 03:40:20 INFO - 'LOGNAME': 'cltbld', 03:40:20 INFO - 'MAIL': '/var/mail/cltbld', 03:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:20 INFO - 'MOZ_NO_REMOTE': '1', 03:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:20 INFO - 'NO_EM_RESTART': '1', 03:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:20 INFO - 'PWD': '/builds/slave/test', 03:40:20 INFO - 'SHELL': '/bin/bash', 03:40:20 INFO - 'SHLVL': '1', 03:40:20 INFO - 'TERM': 'linux', 03:40:20 INFO - 'TMOUT': '86400', 03:40:20 INFO - 'USER': 'cltbld', 03:40:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:20 INFO - '_': '/tools/buildbot/bin/python'} 03:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:20 INFO - Downloading/unpacking flake8 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:40:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:40:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 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 03:40:22 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 03:40:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:40:23 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 03:40:23 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 03:40:23 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 03:40:23 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 03:40:23 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 03:40:23 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 03:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:23 INFO - no previously-included directories found matching 'docs/_build' 03:40:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:40:23 INFO - Running setup.py install for pep8 03:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:23 INFO - no previously-included directories found matching 'docs/_build' 03:40:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:40:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:40:23 INFO - Cleaning up... 03:40:23 INFO - Return code: 0 03:40:23 INFO - Running post-action listener: _resource_record_post_action 03:40:23 INFO - Running post-action listener: _start_resource_monitoring 03:40:23 INFO - Starting resource monitoring. 03:40:23 INFO - ##### 03:40:23 INFO - ##### Running install step. 03:40:23 INFO - ##### 03:40:23 INFO - Running pre-action listener: _resource_record_pre_action 03:40:23 INFO - Running main action method: install 03:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:23 INFO - Reading from file tmpfile_stdout 03:40:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:23 INFO - Reading from file tmpfile_stdout 03:40:23 INFO - Output received: 03:40:23 INFO - Usage: mozinstall [options] installer 03:40:23 INFO - Options: 03:40:23 INFO - -h, --help show this help message and exit 03:40:23 INFO - -d DEST, --destination=DEST 03:40:23 INFO - Directory to install application into. [default: 03:40:23 INFO - "/builds/slave/test"] 03:40:23 INFO - --app=APP Application being installed. [default: firefox] 03:40:23 INFO - mkdir: /builds/slave/test/build/application 03:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:40:39 INFO - Reading from file tmpfile_stdout 03:40:39 INFO - Output received: 03:40:39 INFO - /builds/slave/test/build/application/firefox/firefox 03:40:39 INFO - Running post-action listener: _resource_record_post_action 03:40:39 INFO - ##### 03:40:39 INFO - ##### Running run-tests step. 03:40:39 INFO - ##### 03:40:39 INFO - Running pre-action listener: _resource_record_pre_action 03:40:39 INFO - Running main action method: run_tests 03:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:39 INFO - Python 2.7.3 03:40:39 INFO - Return code: 0 03:40:39 INFO - grabbing minidump binary from tooltool 03:40:39 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')]} 03:40:39 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 0x14d8160>, '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 0x14d9060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d94f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:39 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 03:40:39 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 03:40:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:39 INFO - Return code: 0 03:40:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:40:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:40:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:40:40 INFO - Return code: 0 03:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 03:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 03:40:40 INFO - Using env: {'DISPLAY': ':0', 03:40:40 INFO - 'HOME': '/home/cltbld', 03:40:40 INFO - 'LANG': 'en_US.UTF-8', 03:40:40 INFO - 'LANGUAGE': 'en_US:en', 03:40:40 INFO - 'LOGNAME': 'cltbld', 03:40:40 INFO - 'MAIL': '/var/mail/cltbld', 03:40:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:40 INFO - 'MOZ_NO_REMOTE': '1', 03:40:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:40 INFO - 'NO_EM_RESTART': '1', 03:40:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:40 INFO - 'PWD': '/builds/slave/test', 03:40:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:40 INFO - 'SHELL': '/bin/bash', 03:40:40 INFO - 'SHLVL': '1', 03:40:40 INFO - 'TERM': 'linux', 03:40:40 INFO - 'TMOUT': '86400', 03:40:40 INFO - 'USER': 'cltbld', 03:40:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822', 03:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:40 INFO - '_': '/tools/buildbot/bin/python'} 03:40:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 03:40:40 INFO - mozversion application_buildid: 20160425062348 03:40:40 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:40:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:40 INFO - mozversion application_name: Firefox 03:40:40 INFO - mozversion application_remotingname: firefox-dev 03:40:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:40 INFO - mozversion application_vendor: Mozilla 03:40:40 INFO - mozversion application_version: 47.0a2 03:40:40 INFO - mozversion platform_buildid: 20160425062348 03:40:40 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:40:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:40 INFO - mozversion platform_version: 47.0a2 03:40:40 INFO - using testdate: 1461753640 03:40:40 INFO - actual date: 1461753640 03:40:40 INFO - starting webserver on 'localhost:33148' 03:40:40 INFO - SUITE-START | Running 2 tests 03:40:40 INFO - TEST-START | dromaeo_css 03:40:40 INFO - operating with platform_type : linux_ 03:40:40 INFO - Initialising browser for dromaeo_css test... 03:40:40 INFO - TEST-INFO | started process 7226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpog57Nx/profile http://localhost:33148/getInfo.html) 03:40:43 INFO - PROCESS | 7226 | 03:40:43 INFO - PROCESS | 7226 | (process:7305): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:40:44 INFO - PROCESS | 7226 | __metrics Screen width/height:1600/1200 03:40:44 INFO - PROCESS | 7226 | colorDepth:24 03:40:44 INFO - PROCESS | 7226 | Browser inner width/height: 1024/697 03:40:44 INFO - PROCESS | 7226 | __metrics 03:40:45 ERROR - PROCESS | 7226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:40:46 INFO - TEST-INFO | 7226: exit 0 03:40:46 INFO - Browser initialized. 03:40:46 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:46 INFO - TEST-INFO | started process 7356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpog57Nx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:48 INFO - PROCESS | 7356 | 03:40:48 INFO - PROCESS | 7356 | (process:7427): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:40:58 INFO - PROCESS | 7356 | RSS: Main: 151580672 03:40:58 INFO - PROCESS | 7356 | 03:41:47 INFO - PROCESS | 7356 | 1461753707845 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] 03:43:56 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:33148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33148/tests/dromaeo/cssquery-ext.html) 03:43:57 INFO - PROCESS | 7356 | RSS: Main: 154779648 03:43:57 INFO - PROCESS | 7356 | 03:46:59 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:33148/tests/dromaeo/cssquery-ext.html (next: http://localhost:33148/tests/dromaeo/cssquery-jquery.html) 03:46:59 INFO - PROCESS | 7356 | RSS: Main: 153546752 03:46:59 INFO - PROCESS | 7356 | 03:50:01 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:33148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33148/tests/dromaeo/cssquery-mootools.html) 03:50:01 INFO - PROCESS | 7356 | RSS: Main: 153694208 03:50:01 INFO - PROCESS | 7356 | 03:53:03 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:33148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33148/tests/dromaeo/cssquery-prototype.html) 03:53:04 INFO - PROCESS | 7356 | RSS: Main: 152543232 03:53:04 INFO - PROCESS | 7356 | 03:56:06 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:33148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33148/tests/dromaeo/cssquery-yui.html) 03:56:07 INFO - PROCESS | 7356 | RSS: Main: 154120192 03:56:07 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:33148/tests/dromaeo/cssquery-yui.html (next: http://localhost:33148/tests/dromaeo/cssquery-dojo.html) 03:59:09 INFO - PROCESS | 7356 | RSS: Main: 155684864 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | __start_tp_report 03:59:09 INFO - PROCESS | 7356 | _x_x_mozilla_page_load 03:59:09 INFO - PROCESS | 7356 | _x_x_mozilla_page_load_details 03:59:09 INFO - PROCESS | 7356 | |i|pagename|runs| 03:59:09 INFO - PROCESS | 7356 | |0;dojo.html;3292.5884264466936;3354.7483938704586;3393.474011528214;3410.2156504004065;3439.6044454887697;5585.944140558603;5597.3283206015285;5608.2428872102255;5610.24261724667;5657.886842263158;5536.916946245799;5657.405972372903;5680.261565996425;5682.886342273152;5700.629459085157;5088.211327244283;5107.974460127694;5134.6662466939715;5209.114450543417;5219.921701174486;4922.433920099181;5049.949500505003;5097.5667068299235;5158.484151584849;5264.868378290555;5112.948870511284;5145.948540514603;5249.317588713462;5251.186066159751;5264.868378290555;5132.563732082777;5143.845684629429;5169.612279079065;5185.507376799198;5191.402988656297;5012.448630650625;5028.823991160292;5119.308893299394;5162.819301324474;5167.173252279617;5366.302380690524;5396.325459317585;5412.5940554458575;5423.864403389907;5433.782648694048;6026.126211699279;6034.5172386209;6035.275766907956;6062.242219722535;6095.634261944298;5971.104334349839;6078.96960515199;6087.752010837812;6117.265928088658;6163.01391777318;5652.632578882401;5702.8289151325525;5729.28383952006;5741.19623252745;5764.365919748824;6199.3490683478485;6211.472024877936;6238.40735130171;6240.188775459162;6246.15676883624;5783.219265399117;5962.5826192167;6017.759289628366;6031.698415079229;6033.42682445167;6052.909206361908;6075.939240607538;6086.543509236825;6095.238095238095;6097.054956481752;6007.098935159674;6022.849428764316;6032.969835150884;6074.574779765374;6077.392260773887;5906.49794767441;6013.218281623448;6064.090386441981;6091.48222401092;6095.786647467317;4638.257878739386;4642.558956899089;4644.790984405709;4645.070985802853;4649.95350046502;4161.83352665896;4163.542010378856;4189.162167566499;4190.51809041964;4193.182329445729;5707.971460142673;5748.367679555246;5784.768609255582;5807;5819.621724587888;5906.734196961147;5949.524038076944;6089.665068421191;6101.328853826164;6136.386361363917;5739.483446489752;5781.335146458211;5786.04530252512;5786.623869448473;5789.8263052108505;5057.266696329012;5144.074066668036;5170.482951704799;5186.5850731941355;5239.869003274873;6258.71696302257;6260.217472815898;6266.968665156736;6271.717772700239;6274.623522588659;6110;6117.541184411098;6119.4798442132915;6124.479419249414;6125.326214116532;6088.908666369919;6143.389059649542;6214.751409943552;6241.095041219089;6292.937070629235;5998.220231369894;6040.486558642565;6043.2748070231855;6057.303410107717;6058.939410605837;6119.755209791737;6138.140660307471;6138.723757431016;6141.416565426277;6158.784442544489;5791.102379131242;5920.8815823684145;5954.791582294599;6011.489023433057;6082.996305609525;5928.436798504135;5942.7920022799;5983.7008149591475;5988.730507127277;5995.9700201500455;5634.830955071355;5735.541156707537;5800.361960184461;5822;5832.3292821326095;5961.463468287875;6003.219581454383;6060.575759696779;6075.848103797441;6094.664793436404;5871.383504732113;5873.177755114202;5880.147378629989;5891.1457838614015;5913.46778789911 03:59:09 INFO - PROCESS | 7356 | |1;ext.html;570.8087790590149;591.057263664455;608.7611710169803;643.433778275118;644.7421031587364;35678.821605891964;37028.81485592575;37239.44140837883;37254.62745372546;37293.62706372936;37329.81335093328;37401.064973375614;37552.43671344925;37844;37943.81028094856;8488.49069055857;8711.869321960176;8745.43154694946;8790;8833.558322083902;8673.176048275403;8748.562571871413;8780.868286975701;8965.282777377794;9026.323025773061;8871.733847984538;8918.464892106462;8957.820843583124;8994.910050899472;9034.728958131234;8814;8955.19403253707;8956.955215223914;9018.59416326267;9037.322200834964;8867.778305542348;9011.864822027675;9019.954900225523;9028;9046.909530904673;38724.80637596822;39173.41239881404;39185.60814391848;39201.60798392008;39204.60795392038;3772.1512659651635;3837.372281572398;3898.4737060496755;3910.237503686754;4385.320275357325;31589.210269743442;32246.355072898645;32563;32641.836790815894;32860.34279314424;3734.1224812169116;3802.125511132427;3807.3717836556934;3839;3899.3760998240427;346737;349000;354558;355708.2214588936;356783;44586.33120503195;45488.545114549095;65260.34739652542;65940;66203.33796662067;43323.783381082896;43379.566204337556;43598.782006089765;43638;43689.34465983013;15597.376104955674;15650;15683.843161568466;15776.211189440482;15849.841501585068;12257.570985015482;12313.199642023239;12365;12412;12417.130800844036;14912.776308355384;15649.843501565067;15655.608609784846;15739.842601573837;15760.369585216693;6107.328193898667;6109.389061093855;6267.1539342188225;6289.119523266746;6291.269900777232;1086.875009373932;1092.6012005617893;1105.1048650593045;1107.2968664897849;1129.4860838318546;27933.831006175602;28496.145115646563;28718.282042948675;28983.7101628981;29164.270893227414;1125.8423820665114;1178.2341478039173;1195.665213740154;1214.8359971403925;1284.8286395990933;15041;15048.398064077533;15065.849341506664;15126.470573529874;15648.765268520981;334744;515509;537569;537959;541811;51539.22691159561;51785.22322165171;51863.48136518662;52192.21711674328;52210.73894630503;1489.5531340597777;1501.7897494350582;1504.1576717038492;1516.8331483536801;1527.618095476131;29184.562231566968;30168.84915575408;30178.54732179063;30497;30619.54070688897;46504.30243546282;46896;47318.76340618275;47469;47526;295579;298158;298790;299480;299515;33112.33775324432;33151.336973260884;33203.50194747129;45338.31992520181;46042.76978615086;44548.55451445444;44608.55391446044;45003.09993800171;45598;45811.77094114508;37376.813115934245;37866.0533486665;38094;38388.80805595954;39323.60676393314;37282.62717372792;38080;38741.61258387493;38877;38886.6111338883;37179.8141009304;37367.6263237375;37975.430368543944;38011.619883800806;38061.619383806916;33440.331193376485;33467.52040276111;33638;34177.31645367029;34368.65631343654;24295.63556546618;24657.520548766413;24682.382940426633;24859.50842949429;24878.751212487645 03:59:09 INFO - PROCESS | 7356 | |2;jquery.html;352.6438297319707;375.79706958242565;376.0954903457185;386.6384930090364;388.9630485103914;17032.744508832377;17708.911455442736;18726.719099213522;18773.436796896098;18802.623947521042;17349.82650173498;17754.556136096606;17793.37723179689;17878.463646090637;17882.37411690591;5538.446155384449;5780.682062486561;5787.276590426197;5794.739236734336;5807;4239.894002649928;5627.887442251153;5896.764129434839;6174.598651087687;6209.596376235553;6056.818295451144;6083.78706745264;6096.634201947897;6110.96944515279;6129.1419201311855;5960.076188190816;6297.811065668037;6300.432961033506;6308.053791931201;6319.399657032574;5455.345358556959;5483.287172667528;5487.890242195133;5491.0116179087745;5521.089020311644;19441;19907.60184796296;20046.49883752918;20126;21128.471788205417;2251.9437014074615;2264.8754318512474;2313.838031337807;2351.3298709867777;2895.3485465770245;10991.395473248967;12593.37033148339;13450.865491345157;13556.796648050287;13685;1813.4468986958973;1824.79927208007;1847.1503108570073;1950.9512262193416;2037.3378651938178;61353.38646613521;62567.37432625661;63975.68012159909;65829.67085164592;67703.32296677069;10272.435016074038;10646.307989980627;10661.89338106609;10759.408232547285;10985.945070274598;15351.769723454157;15381.692366152614;15460.072395656296;15469.767953480707;15529.534113976599;7429.219931907072;7582.317591416689;7632.5038872473115;7845.7253996111;8305.252527272574;7302.087239095114;7418.517796343328;7650.120236172911;7771.961140194263;7992.240737129963;4671.743054131987;4681.953180468152;4815.3017812417;4837.927431088537;4870.439899411542;1843.4285371534868;1928.23834585338;1956.9119389627501;1976.8418526517844;2045.3454894433935;1005.3314545826943;1019.8113349030453;1040.4953597505205;1043.7286305560458;1114.7491814341709;16301.59246018859;16787;17643.73534396985;17791.19939602721;18190.63618727618;994.8159590475785;1000.674780696262;1030.9845352319721;1038.6416686243233;1063.1016790811752;7972.481788683833;9371.437713737198;9431.198348140348;9439.150476457151;9482.099200575934;445925;446310;452117;452377;454325;48767.75616121897;50179.49820501748;78415;78634.6068269655;79918.60040699759;1110.6667999600088;1127.537709539085;1136.4033882211904;1139.789139009286;1155.5493357590547;14539.491117810825;14728.18620522082;14802.333894974967;14960;15124;30715.69284307218;31569.8421507891;32033.67966320307;32130.35739285248;32475.837620811744;48448.27327590159;49745;49972.50027499678;50236.748816255684;50623.49376506188;7836.686532538863;8594.765361006059;8740.431871928304;8944.418612790148;9015.05341939087;12649.241045537297;13287.20276783396;13328.266945317713;13331.866681333062;13695.931520342732;11285.153613478858;11524.539018439169;11530.308181509135;11535.36555489456;11610.76778464443;11189.88810111921;11286.492107855001;11319;11388.032017278292;11415.543378265109;10995.780084398428;11169.832452513056;11619.36093514831;11695.707607309885;11948.70128246766;7969.083555391204;8696.347773917108;8840.115988401109;8935.597898094731;8963.462192268486;11494.137939654393;11633.59282425111;11682.357470339213;11727.35499547533;11769.705757356134 03:59:09 INFO - PROCESS | 7356 | |3;mootools.html;1554.9222538873057;1565.9765103523441;1774.7692799936015;1836.5133239691477;1857.5634725839434;8279.420440569163;8287.254147126758;8511.914880851189;8533.061363250037;8579.099194584565;8390.077091519928;8470.872936905951;8473.576321183931;8522.318214542836;8542.27390671792;2412.867292298927;2416.4442178298914;2417.504411595619;2420.0803694596116;2438.2563318187945;2439.4389290463205;2471.4315707387314;2505.3110394641435;2513.5978243481045;2522.7477252274716;2417.057347634424;2417.8756878051704;2449.2040086971715;2454.1533171055958;2454.6563481112657;2426.4783071639504;2460.6801115855005;2478.8140889433184;2480.6403071554614;2504.0985245311763;2483.1805504183576;2483.9751602483925;2485;2490.601503759408;2508.736582658831;8516.616752246164;8524.488530688179;8571.914280857174;8581.656733730642;8608.698695545689;5161.587073034186;5237.816676416345;5262.526372626482;5291.682499050031;5302.257683924254;3359.5128706337687;3375.206826395795;3403.5235067090625;3409.539712138854;3517.6482351764876;1094.108301734084;1124.9775004499863;1138.0440430038807;1144.376314908377;1144.6794897428733;11435.714107147305;11482.88517114835;11492.195546311761;11532.250403723816;11618.360990145538;4379.496357918816;4395.099004704028;4406.20688276107;4481.395011673382;4500.909981800346;9298.628054877729;9337.066293370744;9364.90635093654;9365.531723413802;9378.765530861783;5114.923276150861;5138.640295179302;5143.537081662594;5145.228215767665;5162.406323272797;4118.670506359484;4563.771811409416;4651.302304654261;4662.790174442158;4682.41469816273;3624.98187509066;3730.5336832895887;3754.4368344748505;3755.830987605564;3773.1510410158044;1149.1324050341939;1156.3871148291419;1164.895159435655;1165.906727461801;1172.4899668644166;1419.8651128143017;1435.6339133520885;1446.6021843992776;1448.2903377345235;1478.1722235548127;7814.648340824677;7913.169117242722;7914.722984695508;7952.562609056442;7965.920340796633;538.2598926476095;540.3231012956867;544.6378158524616;565.8161097643282;567.3815541060181;6084.939150608438;6130.233720784902;6152.8769424611255;6156;6167.876642467215;10235.692929212135;10579.523921423555;10733.78532429347;10757.085647719874;10776.78446431067;10188.08307252336;10218;10423.322484038514;10429.061384475433;10474.68575942723;8058.234467725557;8158.265756081981;8195.46729462583;8205.384596155192;8276.503409795432;7726.729564465441;7873.015873015873;7886.171951945193;7886.960565197367;7937.484063535851;9042;9341.785567876133;9349.906500934903;9494.667686630935;9619.711408657751;9496.195722812643;9611.903880961381;9633.855492167764;9687.70936871895;9836.704898853046;6193.752249909953;6832.111825462857;7023.613701246276;7265.309795569412;7276.30875066889;8025.2777250047775;8040.2361775631225;8051.033875934925;8080.0707918590115;8096.230858068474;7170.928290717026;7226.7109315626785;7280.708771649075;7311.744088956861;7376.4836461447185;7054.788356349318;7093.609851458013;7099.36105750485;7134.32223938725;7162.319579639926;7236.457265704988;7258.20159782413;7297.744578939712;7320.963395183203;7338.046054012944;6582;6633.568818026813;6635.701393437404;6635.900461493178;6647.302033286629;6716.529842910949;6733.091032710718;6793.89809152873;6794.388505034571;6857.382835544825 03:59:09 INFO - PROCESS | 7356 | |4;prototype.html;356.0937414280655;358.64494150790716;359.1183644153603;359.4572195984063;368.10550362618835;6435.839104022396;6460.450861676757;6465.288818230003;6470.514711396652;6471.158749362588;6351.364863513646;6355.332690067546;6369.745210191599;6382.074599183115;6399.232092148949;4775.856724298276;4833;4920.138975679241;4937.703737775727;4947.579455746266;4858.805647774085;4886.267059941002;4904.092742842586;4913.484084171147;4957.702537847723;4852.805887764503;4854.199057155565;4868.05073010763;4874.829380971667;4879.072976134541;4891.779869905845;4897.559219670229;4898.4366797818175;4907.901841963177;4909.975450122726;4253.29820579604;4273.743575385487;4294.355846623001;4301.806418711166;4302.913941721179;5923.822285331447;6116.449519543263;6122;6122.387761223842;6142.938570614281;5758.769649214027;5795.507381872546;5796.1595568642315;5826.126081087828;5839.270091238595;6851.417629501499;6865.244823069458;6875.965620171917;6877.828054298632;6891.793246202622;4840.15297322967;4868.975655121737;4873.098476781771;4890.951090489085;4917.065757506062;7031.542949708252;7080.610566418845;7132.286771322878;7144.499885008052;7147.249538798404;4886.267059941038;4894.070126675921;4972.5276098770555;4976.875578110504;4983.825566105169;5047.621428392885;5055.443901170868;5055.545000949932;5058.215976523645;5065.544101030851;5716.056850619601;5767.942320576741;5784.1034639630925;5802.100674395476;5817.069268916953;6693.933060669428;6695.631740254235;6762.053312536249;6763.086983257197;6766.966165169241;1771.7785276840395;1811.184966764961;1822.5443639090226;1828.31438210671;1829.0945981739123;1181.8286348479423;1213.1265488848014;1217.15407791584;1219.9695007624703;1220.1641875315438;6444.9355506444335;6504.959206526933;6521.576097553739;6536.640484773383;6545.639989800511;6943.548669336477;6993.545419547713;7017.614031228331;7019.122609673791;7020.543664661883;6512.023196520559;6536.281009088996;6543.738250469928;6560.606363618198;6586.341365863375;3725.7391982561503;3759.9248015040093;3796.1838204786104;3803.410471376941;3810.942835857464;7190.8202294942;7234.131904171428;7243.818904527429;7247.710091596383;7275.272472752682;7271.454640901953;7297.197308296083;7303.160136584361;7312.341889229995;7349.0078839357075;7349.30181632744;7368.8894666580045;7388.371988381048;7390.630468476555;7417.480776345712;6961.2342642308295;7075.469339799432;7114.395276401564;7140.214576396488;7145.678444470115;6929.618870962146;6978.127734033246;6983.930160698328;7044.295570442915;7078.823029424306;7305.744298949511;7306.671199796128;7313.451491138292;7337.963310183415;7361.558306501627;4868.464468908488;4906.828261010847;4912;4923.876903077452;4931.580815630711;6921.550099243533;7147.499675022698;7148.892766608609;7155.105611798525;7161.964190179224;6778.593284402951;6817.079694241413;6883.380495755206;6891.793246202622;6901;6801.693923773541;6838.487113466411;6875.243723190545;6878.8624227516175;6897.896336586122;6596.90104648421;6613.735450581923;6676.766313179015;6683.899741503784;6689.531732778659;6691.0967019451755;6937.7571784987285;6944.923536851796;6945.583265004116;6952.617606031717;6740.797776066725;6743.831404214934;6763.357481039294;6766.391024807791;6768.390844823989 03:59:09 INFO - PROCESS | 7356 | |5;yui.html;687.9656017199139;718.1633397092387;762.7787941496966;775.209286527742;780.887235689143;14003.369848356822;14101.435942562312;14171.787423188634;14217.360218790154;14270.4291828327;13303.334833258346;13303.866961330385;13355.332233388315;13410.26243556604;13410.530631427877;755.7203834581185;886.4238245140662;890.679355432044;893.1381217125472;895.2658819767793;901.8647202919549;905.2124651553158;907.7821322882494;907.8728977943093;907.9364444488889;948.1182500274741;948.2271948362097;949.9762505937338;951.172479942451;953.9284553658504;931.5668214280324;932.1657116880355;939.2532936315612;944.7779771753633;947.5499137909507;704.8343639244773;706.7173130747691;710.1478226128614;711.5623891306809;712.081414974682;13901.16593004423;13959.371828267753;14008.85991140096;14013.159210447406;14114.92942535291;12292.631221063382;12499.437525311383;12734.872651273461;12850.421731022127;12868.356582170854;9792.657256995972;9891.90108098917;10060.547275372626;10069;10132.645357412528;3276.655951125121;3337.8497967591516;3340.7828491148;3348.8995330140133;3440.9827950860085;50339.49660503385;50421.49578504205;50642;50699.23951140736;51327.23009154903;9083.273338132933;9297.256219502424;9311.348205625676;9351.719448416557;9397.389169703947;19267.421977340702;19313.130909109124;19332.226710931405;19333.419997400102;19367;7181.281871812881;7204.0994875640545;7230.421566274686;7344.228855970046;7374.373178279906;4132.33882578786;4140.0891803803115;4156.56356082613;4213.873583792491;4242.427272318259;3221.64561898191;3266.575345205156;3282.720968717638;3295.8681652734103;3303.025607445761;587.2659176029963;598.7245866901275;598.8173607049891;600.0009983377628;602.9246344206974;596.0641792385999;682.5188242289174;712.138312641699;729.274371999853;756.1908757629394;8401.70594029206;8528.104549022388;9225.769355766159;9290.256779457628;9462.432254064779;618.6102755264154;696.4915611603558;732.1543617122232;742.9294217049371;787.4173111897155;4164.3961625564725;4183.5398106208295;4235.957640423618;4242.681798865097;4293.549177336397;49597.75201123971;49979.25031124536;50086.749566251936;53644.73177634165;57872.71063644739;50825;51021.489785102414;51391.99999999925;51545.48454515482;51560.74219628878;47061.5293847064;47590.048199036515;47806.282905756445;48008.5199148011;48241.5175848244;8772.254358379609;8864.822703545764;9025.458472491671;9034.63861445561;9152.80332720129;37066.8146659265;37620.62379376281;38120;38839.41740873946;38887.22225555417;46079.308810368544;47771.52228477671;47926.5207347936;48148.75925620349;48197.51802481931;11103.944480277547;11146.554137834395;11931.880681193077;12001.339926303788;12239.082068844695;11935.701607459883;12651.493940242655;12866.144796515813;13090.80363794563;13112.475500980236;11211.55153793839;11306.095512358826;11503.424828758696;11637.709057273636;11677.357745324089;11261.324320540467;11274.718132046437;11343.943280283545;11357.772844542898;11389.715257118638;11717.12121590867;11782.351970641697;11965.820512692142;11970.341631210367;12294.446749896455;9974.700758977242;10042.146417554297;10137.239707021856;10153;10271.332363396356;10014.699559013241;10338.638147664795;10562.419066951392;10569.312994655324;10609 03:59:09 INFO - PROCESS | 7356 | __end_tp_report 03:59:09 INFO - PROCESS | 7356 | __start_cc_report 03:59:09 INFO - PROCESS | 7356 | _x_x_mozilla_cycle_collect,336 03:59:09 INFO - PROCESS | 7356 | __end_cc_report 03:59:09 INFO - PROCESS | 7356 | __startTimestamp1461754749549__endTimestamp 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | ------- Summary: start ------- 03:59:09 INFO - PROCESS | 7356 | Number of tests: 6 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | [#0] dojo.html Cycles:165 Average:5633.70 Median:5871.38 stddev:633.59 (10.8%) stddev-sans-first:608.34 03:59:09 INFO - PROCESS | 7356 | Values: 3292.6 3354.7 3393.5 3410.2 3439.6 5585.9 5597.3 5608.2 5610.2 5657.9 5536.9 5657.4 5680.3 5682.9 5700.6 5088.2 5108.0 5134.7 5209.1 5219.9 4922.4 5049.9 5097.6 5158.5 5264.9 5112.9 5145.9 5249.3 5251.2 5264.9 5132.6 5143.8 5169.6 5185.5 5191.4 5012.4 5028.8 5119.3 5162.8 5167.2 5366.3 5396.3 5412.6 5423.9 5433.8 6026.1 6034.5 6035.3 6062.2 6095.6 5971.1 6079.0 6087.8 6117.3 6163.0 5652.6 5702.8 5729.3 5741.2 5764.4 6199.3 6211.5 6238.4 6240.2 6246.2 5783.2 5962.6 6017.8 6031.7 6033.4 6052.9 6075.9 6086.5 6095.2 6097.1 6007.1 6022.8 6033.0 6074.6 6077.4 5906.5 6013.2 6064.1 6091.5 6095.8 4638.3 4642.6 4644.8 4645.1 4650.0 4161.8 4163.5 4189.2 4190.5 4193.2 5708.0 5748.4 5784.8 5807.0 5819.6 5906.7 5949.5 6089.7 6101.3 6136.4 5739.5 5781.3 5786.0 5786.6 5789.8 5057.3 5144.1 5170.5 5186.6 5239.9 6258.7 6260.2 6267.0 6271.7 6274.6 6110.0 6117.5 6119.5 6124.5 6125.3 6088.9 6143.4 6214.8 6241.1 6292.9 5998.2 6040.5 6043.3 6057.3 6058.9 6119.8 6138.1 6138.7 6141.4 6158.8 5791.1 5920.9 5954.8 6011.5 6083.0 5928.4 5942.8 5983.7 5988.7 5996.0 5634.8 5735.5 5800.4 5822.0 5832.3 5961.5 6003.2 6060.6 6075.8 6094.7 5871.4 5873.2 5880.1 5891.1 5913.5 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | [#1] ext.html Cycles:180 Average:53527.50 Median:37959.62 stddev:104157.69 (274.4%) stddev-sans-first:104373.99 03:59:09 INFO - PROCESS | 7356 | Values: 570.8 591.1 608.8 643.4 644.7 35678.8 37028.8 37239.4 37254.6 37293.6 37329.8 37401.1 37552.4 37844.0 37943.8 8488.5 8711.9 8745.4 8790.0 8833.6 8673.2 8748.6 8780.9 8965.3 9026.3 8871.7 8918.5 8957.8 8994.9 9034.7 8814.0 8955.2 8957.0 9018.6 9037.3 8867.8 9011.9 9020.0 9028.0 9046.9 38724.8 39173.4 39185.6 39201.6 39204.6 3772.2 3837.4 3898.5 3910.2 4385.3 31589.2 32246.4 32563.0 32641.8 32860.3 3734.1 3802.1 3807.4 3839.0 3899.4 346737.0 349000.0 354558.0 355708.2 356783.0 44586.3 45488.5 65260.3 65940.0 66203.3 43323.8 43379.6 43598.8 43638.0 43689.3 15597.4 15650.0 15683.8 15776.2 15849.8 12257.6 12313.2 12365.0 12412.0 12417.1 14912.8 15649.8 15655.6 15739.8 15760.4 6107.3 6109.4 6267.2 6289.1 6291.3 1086.9 1092.6 1105.1 1107.3 1129.5 27933.8 28496.1 28718.3 28983.7 29164.3 1125.8 1178.2 1195.7 1214.8 1284.8 15041.0 15048.4 15065.8 15126.5 15648.8 334744.0 515509.0 537569.0 537959.0 541811.0 51539.2 51785.2 51863.5 52192.2 52210.7 1489.6 1501.8 1504.2 1516.8 1527.6 29184.6 30168.8 30178.5 30497.0 30619.5 46504.3 46896.0 47318.8 47469.0 47526.0 295579.0 298158.0 298790.0 299480.0 299515.0 33112.3 33151.3 33203.5 45338.3 46042.8 44548.6 44608.6 45003.1 45598.0 45811.8 37376.8 37866.1 38094.0 38388.8 39323.6 37282.6 38080.0 38741.6 38877.0 38886.6 37179.8 37367.6 37975.4 38011.6 38061.6 33440.3 33467.5 33638.0 34177.3 34368.7 24295.6 24657.5 24682.4 24859.5 24878.8 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | [#2] jquery.html Cycles:180 Average:25981.58 Median:2289.36 stddev:73635.12 (3216.4%) stddev-sans-first:73816.54 03:59:09 INFO - PROCESS | 7356 | Values: 352.6 375.8 376.1 386.6 389.0 17032.7 17708.9 18726.7 18773.4 18802.6 17349.8 17754.6 17793.4 17878.5 17882.4 5538.4 5780.7 5787.3 5794.7 5807.0 4239.9 5627.9 5896.8 6174.6 6209.6 6056.8 6083.8 6096.6 6111.0 6129.1 5960.1 6297.8 6300.4 6308.1 6319.4 5455.3 5483.3 5487.9 5491.0 5521.1 19441.0 19907.6 20046.5 20126.0 21128.5 2251.9 2264.9 2313.8 2351.3 2895.3 10991.4 12593.4 13450.9 13556.8 13685.0 1813.4 1824.8 1847.2 1951.0 2037.3 61353.4 62567.4 63975.7 65829.7 67703.3 10272.4 10646.3 10661.9 10759.4 10985.9 15351.8 15381.7 15460.1 15469.8 15529.5 7429.2 7582.3 7632.5 7845.7 8305.3 7302.1 7418.5 7650.1 7772.0 7992.2 4671.7 4682.0 4815.3 4837.9 4870.4 1843.4 1928.2 1956.9 1976.8 2045.3 1005.3 1019.8 1040.5 1043.7 1114.7 16301.6 16787.0 17643.7 17791.2 18190.6 994.8 1000.7 1031.0 1038.6 1063.1 7972.5 9371.4 9431.2 9439.2 9482.1 445925.0 446310.0 452117.0 452377.0 454325.0 48767.8 50179.5 78415.0 78634.6 79918.6 1110.7 1127.5 1136.4 1139.8 1155.5 14539.5 14728.2 14802.3 14960.0 15124.0 30715.7 31569.8 32033.7 32130.4 32475.8 48448.3 49745.0 49972.5 50236.7 50623.5 7836.7 8594.8 8740.4 8944.4 9015.1 12649.2 13287.2 13328.3 13331.9 13695.9 11285.2 11524.5 11530.3 11535.4 11610.8 11189.9 11286.5 11319.0 11388.0 11415.5 10995.8 11169.8 11619.4 11695.7 11948.7 7969.1 8696.3 8840.1 8935.6 8963.5 11494.1 11633.6 11682.4 11727.4 11769.7 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | [#3] mootools.html Cycles:180 Average:5869.18 Median:539.29 stddev:3098.30 (574.5%) stddev-sans-first:3090.02 03:59:09 INFO - PROCESS | 7356 | Values: 1554.9 1566.0 1774.8 1836.5 1857.6 8279.4 8287.3 8511.9 8533.1 8579.1 8390.1 8470.9 8473.6 8522.3 8542.3 2412.9 2416.4 2417.5 2420.1 2438.3 2439.4 2471.4 2505.3 2513.6 2522.7 2417.1 2417.9 2449.2 2454.2 2454.7 2426.5 2460.7 2478.8 2480.6 2504.1 2483.2 2484.0 2485.0 2490.6 2508.7 8516.6 8524.5 8571.9 8581.7 8608.7 5161.6 5237.8 5262.5 5291.7 5302.3 3359.5 3375.2 3403.5 3409.5 3517.6 1094.1 1125.0 1138.0 1144.4 1144.7 11435.7 11482.9 11492.2 11532.3 11618.4 4379.5 4395.1 4406.2 4481.4 4500.9 9298.6 9337.1 9364.9 9365.5 9378.8 5114.9 5138.6 5143.5 5145.2 5162.4 4118.7 4563.8 4651.3 4662.8 4682.4 3625.0 3730.5 3754.4 3755.8 3773.2 1149.1 1156.4 1164.9 1165.9 1172.5 1419.9 1435.6 1446.6 1448.3 1478.2 7814.6 7913.2 7914.7 7952.6 7965.9 538.3 540.3 544.6 565.8 567.4 6084.9 6130.2 6152.9 6156.0 6167.9 10235.7 10579.5 10733.8 10757.1 10776.8 10188.1 10218.0 10423.3 10429.1 10474.7 8058.2 8158.3 8195.5 8205.4 8276.5 7726.7 7873.0 7886.2 7887.0 7937.5 9042.0 9341.8 9349.9 9494.7 9619.7 9496.2 9611.9 9633.9 9687.7 9836.7 6193.8 6832.1 7023.6 7265.3 7276.3 8025.3 8040.2 8051.0 8080.1 8096.2 7170.9 7226.7 7280.7 7311.7 7376.5 7054.8 7093.6 7099.4 7134.3 7162.3 7236.5 7258.2 7297.7 7321.0 7338.0 6582.0 6633.6 6635.7 6635.9 6647.3 6716.5 6733.1 6793.9 6794.4 6857.4 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | [#4] prototype.html Cycles:180 Average:5736.82 Median:6488.06 stddev:1714.56 (26.4%) stddev-sans-first:1671.13 03:59:09 INFO - PROCESS | 7356 | Values: 356.1 358.6 359.1 359.5 368.1 6435.8 6460.5 6465.3 6470.5 6471.2 6351.4 6355.3 6369.7 6382.1 6399.2 4775.9 4833.0 4920.1 4937.7 4947.6 4858.8 4886.3 4904.1 4913.5 4957.7 4852.8 4854.2 4868.1 4874.8 4879.1 4891.8 4897.6 4898.4 4907.9 4910.0 4253.3 4273.7 4294.4 4301.8 4302.9 5923.8 6116.4 6122.0 6122.4 6142.9 5758.8 5795.5 5796.2 5826.1 5839.3 6851.4 6865.2 6876.0 6877.8 6891.8 4840.2 4869.0 4873.1 4891.0 4917.1 7031.5 7080.6 7132.3 7144.5 7147.2 4886.3 4894.1 4972.5 4976.9 4983.8 5047.6 5055.4 5055.5 5058.2 5065.5 5716.1 5767.9 5784.1 5802.1 5817.1 6693.9 6695.6 6762.1 6763.1 6767.0 1771.8 1811.2 1822.5 1828.3 1829.1 1181.8 1213.1 1217.2 1220.0 1220.2 6444.9 6505.0 6521.6 6536.6 6545.6 6943.5 6993.5 7017.6 7019.1 7020.5 6512.0 6536.3 6543.7 6560.6 6586.3 3725.7 3759.9 3796.2 3803.4 3810.9 7190.8 7234.1 7243.8 7247.7 7275.3 7271.5 7297.2 7303.2 7312.3 7349.0 7349.3 7368.9 7388.4 7390.6 7417.5 6961.2 7075.5 7114.4 7140.2 7145.7 6929.6 6978.1 6983.9 7044.3 7078.8 7305.7 7306.7 7313.5 7338.0 7361.6 4868.5 4906.8 4912.0 4923.9 4931.6 6921.6 7147.5 7148.9 7155.1 7162.0 6778.6 6817.1 6883.4 6891.8 6901.0 6801.7 6838.5 6875.2 6878.9 6897.9 6596.9 6613.7 6676.8 6683.9 6689.5 6691.1 6937.8 6944.9 6945.6 6952.6 6740.8 6743.8 6763.4 6766.4 6768.4 03:59:09 INFO - PROCESS | 7356 | 03:59:09 INFO - PROCESS | 7356 | [#5] yui.html Cycles:180 Average:14096.57 Median:47788.90 stddev:16089.36 (33.7%) stddev-sans-first:16102.98 03:59:09 INFO - PROCESS | 7356 | Values: 688.0 718.2 762.8 775.2 780.9 14003.4 14101.4 14171.8 14217.4 14270.4 13303.3 13303.9 13355.3 13410.3 13410.5 755.7 886.4 890.7 893.1 895.3 901.9 905.2 907.8 907.9 907.9 948.1 948.2 950.0 951.2 953.9 931.6 932.2 939.3 944.8 947.5 704.8 706.7 710.1 711.6 712.1 13901.2 13959.4 14008.9 14013.2 14114.9 12292.6 12499.4 12734.9 12850.4 12868.4 9792.7 9891.9 10060.5 10069.0 10132.6 3276.7 3337.8 3340.8 3348.9 3441.0 50339.5 50421.5 50642.0 50699.2 51327.2 9083.3 9297.3 9311.3 9351.7 9397.4 19267.4 19313.1 19332.2 19333.4 19367.0 7181.3 7204.1 7230.4 7344.2 7374.4 4132.3 4140.1 4156.6 4213.9 4242.4 3221.6 3266.6 3282.7 3295.9 3303.0 587.3 598.7 598.8 600.0 602.9 596.1 682.5 712.1 729.3 756.2 8401.7 8528.1 9225.8 9290.3 9462.4 618.6 696.5 732.2 742.9 787.4 4164.4 4183.5 4236.0 4242.7 4293.5 49597.8 49979.3 50086.7 53644.7 57872.7 50825.0 51021.5 51392.0 51545.5 51560.7 47061.5 47590.0 47806.3 48008.5 48241.5 8772.3 8864.8 9025.5 9034.6 9152.8 37066.8 37620.6 38120.0 38839.4 38887.2 46079.3 47771.5 47926.5 48148.8 48197.5 11103.9 11146.6 11931.9 12001.3 12239.1 11935.7 12651.5 12866.1 13090.8 13112.5 11211.6 11306.1 11503.4 11637.7 11677.4 11261.3 11274.7 11343.9 11357.8 11389.7 11717.1 11782.4 11965.8 11970.3 12294.4 9974.7 10042.1 10137.2 10153.0 10271.3 10014.7 10338.6 10562.4 10569.3 10609.0 03:59:09 INFO - PROCESS | 7356 | -------- Summary: end -------- 03:59:09 INFO - PROCESS | 7356 | 03:59:10 INFO - TEST-INFO | 7356: exit 0 03:59:10 INFO - TEST-OK | dromaeo_css | took 1109731ms 03:59:10 INFO - TEST-START | kraken 03:59:10 INFO - operating with platform_type : linux_ 03:59:10 INFO - Initialising browser for kraken test... 03:59:10 INFO - TEST-INFO | started process 7606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo1WdVz/profile http://localhost:33148/getInfo.html) 03:59:13 INFO - PROCESS | 7606 | 03:59:13 INFO - PROCESS | 7606 | (process:7682): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:59:14 INFO - PROCESS | 7606 | __metrics Screen width/height:1600/1200 03:59:14 INFO - PROCESS | 7606 | colorDepth:24 03:59:14 INFO - PROCESS | 7606 | Browser inner width/height: 1024/697 03:59:14 INFO - PROCESS | 7606 | __metrics 03:59:14 ERROR - PROCESS | 7606 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:59:15 INFO - TEST-INFO | 7606: exit 0 03:59:15 INFO - Browser initialized. 03:59:15 INFO - Running cycle 1/1 for kraken test... 03:59:15 INFO - TEST-INFO | started process 7733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo1WdVz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:17 INFO - PROCESS | 7733 | 03:59:17 INFO - PROCESS | 7733 | (process:7801): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:59:27 INFO - PROCESS | 7733 | RSS: Main: 151883776 03:59:27 INFO - PROCESS | 7733 | 03:59:29 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33148/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:30 INFO - PROCESS | 7733 | RSS: Main: 155742208 03:59:30 INFO - PROCESS | 7733 | 03:59:33 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33148/tests/kraken/driver.html?testName=audio-dft) 03:59:33 INFO - PROCESS | 7733 | RSS: Main: 156151808 03:59:33 INFO - PROCESS | 7733 | 03:59:36 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33148/tests/kraken/driver.html?testName=audio-fft) 03:59:37 INFO - PROCESS | 7733 | RSS: Main: 156524544 03:59:37 INFO - PROCESS | 7733 | 03:59:39 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33148/tests/kraken/driver.html?testName=audio-oscillator) 03:59:39 INFO - PROCESS | 7733 | RSS: Main: 156401664 03:59:39 INFO - PROCESS | 7733 | 03:59:42 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:42 INFO - PROCESS | 7733 | RSS: Main: 156712960 03:59:42 INFO - PROCESS | 7733 | 03:59:45 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33148/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:46 INFO - PROCESS | 7733 | RSS: Main: 156188672 03:59:46 INFO - PROCESS | 7733 | 03:59:49 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33148/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:50 INFO - PROCESS | 7733 | RSS: Main: 156704768 03:59:50 INFO - PROCESS | 7733 | 03:59:53 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33148/tests/kraken/driver.html?testName=json-parse-financial) 03:59:53 INFO - PROCESS | 7733 | RSS: Main: 156639232 03:59:53 INFO - PROCESS | 7733 | 03:59:55 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:55 INFO - PROCESS | 7733 | RSS: Main: 156831744 03:59:55 INFO - PROCESS | 7733 | 03:59:57 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:58 INFO - PROCESS | 7733 | RSS: Main: 156745728 03:59:58 INFO - PROCESS | 7733 | 04:00:00 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:01 INFO - PROCESS | 7733 | RSS: Main: 156897280 04:00:01 INFO - PROCESS | 7733 | 04:00:03 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:04 INFO - PROCESS | 7733 | RSS: Main: 157298688 04:00:04 INFO - PROCESS | 7733 | 04:00:06 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:07 INFO - PROCESS | 7733 | RSS: Main: 157573120 04:00:07 INFO - PROCESS | 7733 | 04:00:08 INFO - PROCESS | 7733 | Cycle 1(1): loaded http://localhost:33148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33148/tests/kraken/driver.html?testName=ai-astar) 04:00:09 INFO - PROCESS | 7733 | RSS: Main: 159240192 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | __start_tp_report 04:00:09 INFO - PROCESS | 7733 | _x_x_mozilla_page_load 04:00:09 INFO - PROCESS | 7733 | _x_x_mozilla_page_load_details 04:00:09 INFO - PROCESS | 7733 | |i|pagename|runs| 04:00:09 INFO - PROCESS | 7733 | |0;ai-astar;113;106;112;111;113;123;114;111;111;111 04:00:09 INFO - PROCESS | 7733 | |1;audio-beat-detection;151;128;153;173;128;159;158;128;174;132 04:00:09 INFO - PROCESS | 7733 | |2;audio-dft;164;162;162;161;162;163;160;164;167;164 04:00:09 INFO - PROCESS | 7733 | |3;audio-fft;74;77;75;171;79;79;77;74;166;78 04:00:09 INFO - PROCESS | 7733 | |4;audio-oscillator;94;94;150;95;93;93;150;93;92;146 04:00:09 INFO - PROCESS | 7733 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;118;117;119 04:00:09 INFO - PROCESS | 7733 | |6;imaging-darkroom;148;148;148;148;147;148;149;148;149;150 04:00:09 INFO - PROCESS | 7733 | |7;imaging-desaturate;97;97;96;97;98;96;97;96;96;96 04:00:09 INFO - PROCESS | 7733 | |8;json-parse-financial;58;60;61;61;63;61;59;66;58;60 04:00:09 INFO - PROCESS | 7733 | |9;json-stringify-tinderbox;64;75;64;66;65;65;64;65;66;66 04:00:09 INFO - PROCESS | 7733 | |10;stanford-crypto-aes;79;78;79;79;79;77;79;81;78;79 04:00:09 INFO - PROCESS | 7733 | |11;stanford-crypto-ccm;115;113;114;112;120;141;132;115;115;115 04:00:09 INFO - PROCESS | 7733 | |12;stanford-crypto-pbkdf2;142;150;151;161;147;140;146;147;151;134 04:00:09 INFO - PROCESS | 7733 | |13;stanford-crypto-sha256-iterative;67;68;66;68;67;66;66;67;67;68 04:00:09 INFO - PROCESS | 7733 | __end_tp_report 04:00:09 INFO - PROCESS | 7733 | __start_cc_report 04:00:09 INFO - PROCESS | 7733 | _x_x_mozilla_cycle_collect,861 04:00:09 INFO - PROCESS | 7733 | __end_cc_report 04:00:09 INFO - PROCESS | 7733 | __startTimestamp1461754809126__endTimestamp 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | ------- Summary: start ------- 04:00:09 INFO - PROCESS | 7733 | Number of tests: 14 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:4.28 (3.8%) stddev-sans-first:4.53 04:00:09 INFO - PROCESS | 7733 | Values: 113.0 106.0 112.0 111.0 113.0 123.0 114.0 111.0 111.0 111.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:155.50 stddev:18.29 (11.8%) stddev-sans-first:19.37 04:00:09 INFO - PROCESS | 7733 | Values: 151.0 128.0 153.0 173.0 128.0 159.0 158.0 128.0 174.0 132.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:1.97 (1.2%) stddev-sans-first:2.05 04:00:09 INFO - PROCESS | 7733 | Values: 164.0 162.0 162.0 161.0 162.0 163.0 160.0 164.0 167.0 164.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#3] audio-fft Cycles:10 Average:95.00 Median:77.00 stddev:38.80 (50.4%) stddev-sans-first:40.40 04:00:09 INFO - PROCESS | 7733 | Values: 74.0 77.0 75.0 171.0 79.0 79.0 77.0 74.0 166.0 78.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:93.00 stddev:26.72 (28.7%) stddev-sans-first:27.70 04:00:09 INFO - PROCESS | 7733 | Values: 94.0 94.0 150.0 95.0 93.0 93.0 150.0 93.0 92.0 146.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:00:09 INFO - PROCESS | 7733 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 119.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:00:09 INFO - PROCESS | 7733 | Values: 148.0 148.0 148.0 148.0 147.0 148.0 149.0 148.0 149.0 150.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:00:09 INFO - PROCESS | 7733 | Values: 97.0 97.0 96.0 97.0 98.0 96.0 97.0 96.0 96.0 96.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.00 stddev:2.41 (3.9%) stddev-sans-first:2.35 04:00:09 INFO - PROCESS | 7733 | Values: 58.0 60.0 61.0 61.0 63.0 61.0 59.0 66.0 58.0 60.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.50 stddev:3.27 (5.0%) stddev-sans-first:3.38 04:00:09 INFO - PROCESS | 7733 | Values: 64.0 75.0 64.0 66.0 65.0 65.0 64.0 65.0 66.0 66.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:1.03 (1.3%) stddev-sans-first:1.09 04:00:09 INFO - PROCESS | 7733 | Values: 79.0 78.0 79.0 79.0 79.0 77.0 79.0 81.0 78.0 79.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:115.00 stddev:9.59 (8.3%) stddev-sans-first:10.05 04:00:09 INFO - PROCESS | 7733 | Values: 115.0 113.0 114.0 112.0 120.0 141.0 132.0 115.0 115.0 115.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:148.50 stddev:7.31 (4.9%) stddev-sans-first:7.54 04:00:09 INFO - PROCESS | 7733 | Values: 142.0 150.0 151.0 161.0 147.0 140.0 146.0 147.0 151.0 134.0 04:00:09 INFO - PROCESS | 7733 | 04:00:09 INFO - PROCESS | 7733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 04:00:09 INFO - PROCESS | 7733 | Values: 67.0 68.0 66.0 68.0 67.0 66.0 66.0 67.0 67.0 68.0 04:00:09 INFO - PROCESS | 7733 | -------- Summary: end -------- 04:00:09 INFO - PROCESS | 7733 | 04:00:10 INFO - TEST-INFO | 7733: exit 0 04:00:10 INFO - TEST-OK | kraken | took 59961ms 04:00:10 INFO - SUITE-END | took 1169s 04:00:10 INFO - Completed test suite (00:19:29) 04:00:10 INFO - javascript benchmark 04:00:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3292.5884264466936, 3354.7483938704586, 3393.474011528214, 3410.2156504004065, 3439.6044454887697, 5585.944140558603, 5597.3283206015285, 5608.2428872102255, 5610.24261724667, 5657.886842263158, 5536.916946245799, 5657.405972372903, 5680.261565996425, 5682.886342273152, 5700.629459085157, 5088.211327244283, 5107.974460127694, 5134.6662466939715, 5209.114450543417, 5219.921701174486, 4922.433920099181, 5049.949500505003, 5097.5667068299235, 5158.484151584849, 5264.868378290555, 5112.948870511284, 5145.948540514603, 5249.317588713462, 5251.186066159751, 5264.868378290555, 5132.563732082777, 5143.845684629429, 5169.612279079065, 5185.507376799198, 5191.402988656297, 5012.448630650625, 5028.823991160292, 5119.308893299394, 5162.819301324474, 5167.173252279617, 5366.302380690524, 5396.325459317585, 5412.5940554458575, 5423.864403389907, 5433.782648694048, 6026.126211699279, 6034.5172386209, 6035.275766907956, 6062.242219722535, 6095.634261944298, 5971.104334349839, 6078.96960515199, 6087.752010837812, 6117.265928088658, 6163.01391777318, 5652.632578882401, 5702.8289151325525, 5729.28383952006, 5741.19623252745, 5764.365919748824, 6199.3490683478485, 6211.472024877936, 6238.40735130171, 6240.188775459162, 6246.15676883624, 5783.219265399117, 5962.5826192167, 6017.759289628366, 6031.698415079229, 6033.42682445167, 6052.909206361908, 6075.939240607538, 6086.543509236825, 6095.238095238095, 6097.054956481752, 6007.098935159674, 6022.849428764316, 6032.969835150884, 6074.574779765374, 6077.392260773887, 5906.49794767441, 6013.218281623448, 6064.090386441981, 6091.48222401092, 6095.786647467317, 4638.257878739386, 4642.558956899089, 4644.790984405709, 4645.070985802853, 4649.95350046502, 4161.83352665896, 4163.542010378856, 4189.162167566499, 4190.51809041964, 4193.182329445729, 5707.971460142673, 5748.367679555246, 5784.768609255582, 5807.0, 5819.621724587888, 5906.734196961147, 5949.524038076944, 6089.665068421191, 6101.328853826164, 6136.386361363917, 5739.483446489752, 5781.335146458211, 5786.04530252512, 5786.623869448473, 5789.8263052108505, 5057.266696329012, 5144.074066668036, 5170.482951704799, 5186.5850731941355, 5239.869003274873, 6258.71696302257, 6260.217472815898, 6266.968665156736, 6271.717772700239, 6274.623522588659, 6110.0, 6117.541184411098, 6119.4798442132915, 6124.479419249414, 6125.326214116532, 6088.908666369919, 6143.389059649542, 6214.751409943552, 6241.095041219089, 6292.937070629235, 5998.220231369894, 6040.486558642565, 6043.2748070231855, 6057.303410107717, 6058.939410605837, 6119.755209791737, 6138.140660307471, 6138.723757431016, 6141.416565426277, 6158.784442544489, 5791.102379131242, 5920.8815823684145, 5954.791582294599, 6011.489023433057, 6082.996305609525, 5928.436798504135, 5942.7920022799, 5983.7008149591475, 5988.730507127277, 5995.9700201500455, 5634.830955071355, 5735.541156707537, 5800.361960184461, 5822.0, 5832.3292821326095, 5961.463468287875, 6003.219581454383, 6060.575759696779, 6075.848103797441, 6094.664793436404, 5871.383504732113, 5873.177755114202, 5880.147378629989, 5891.1457838614015, 5913.46778789911], "unit": "score", "name": "dojo.html", "value": 5592.076794040404}, {"lowerIsBetter": false, "replicates": [570.8087790590149, 591.057263664455, 608.7611710169803, 643.433778275118, 644.7421031587364, 35678.821605891964, 37028.81485592575, 37239.44140837883, 37254.62745372546, 37293.62706372936, 37329.81335093328, 37401.064973375614, 37552.43671344925, 37844.0, 37943.81028094856, 8488.49069055857, 8711.869321960176, 8745.43154694946, 8790.0, 8833.558322083902, 8673.176048275403, 8748.562571871413, 8780.868286975701, 8965.282777377794, 9026.323025773061, 8871.733847984538, 8918.464892106462, 8957.820843583124, 8994.910050899472, 9034.728958131234, 8814.0, 8955.19403253707, 8956.955215223914, 9018.59416326267, 9037.322200834964, 8867.778305542348, 9011.864822027675, 9019.954900225523, 9028.0, 9046.909530904673, 38724.80637596822, 39173.41239881404, 39185.60814391848, 39201.60798392008, 39204.60795392038, 3772.1512659651635, 3837.372281572398, 3898.4737060496755, 3910.237503686754, 4385.320275357325, 31589.210269743442, 32246.355072898645, 32563.0, 32641.836790815894, 32860.34279314424, 3734.1224812169116, 3802.125511132427, 3807.3717836556934, 3839.0, 3899.3760998240427, 346737.0, 349000.0, 354558.0, 355708.2214588936, 356783.0, 44586.33120503195, 45488.545114549095, 65260.34739652542, 65940.0, 66203.33796662067, 43323.783381082896, 43379.566204337556, 43598.782006089765, 43638.0, 43689.34465983013, 15597.376104955674, 15650.0, 15683.843161568466, 15776.211189440482, 15849.841501585068, 12257.570985015482, 12313.199642023239, 12365.0, 12412.0, 12417.130800844036, 14912.776308355384, 15649.843501565067, 15655.608609784846, 15739.842601573837, 15760.369585216693, 6107.328193898667, 6109.389061093855, 6267.1539342188225, 6289.119523266746, 6291.269900777232, 1086.875009373932, 1092.6012005617893, 1105.1048650593045, 1107.2968664897849, 1129.4860838318546, 27933.831006175602, 28496.145115646563, 28718.282042948675, 28983.7101628981, 29164.270893227414, 1125.8423820665114, 1178.2341478039173, 1195.665213740154, 1214.8359971403925, 1284.8286395990933, 15041.0, 15048.398064077533, 15065.849341506664, 15126.470573529874, 15648.765268520981, 334744.0, 515509.0, 537569.0, 537959.0, 541811.0, 51539.22691159561, 51785.22322165171, 51863.48136518662, 52192.21711674328, 52210.73894630503, 1489.5531340597777, 1501.7897494350582, 1504.1576717038492, 1516.8331483536801, 1527.618095476131, 29184.562231566968, 30168.84915575408, 30178.54732179063, 30497.0, 30619.54070688897, 46504.30243546282, 46896.0, 47318.76340618275, 47469.0, 47526.0, 295579.0, 298158.0, 298790.0, 299480.0, 299515.0, 33112.33775324432, 33151.336973260884, 33203.50194747129, 45338.31992520181, 46042.76978615086, 44548.55451445444, 44608.55391446044, 45003.09993800171, 45598.0, 45811.77094114508, 37376.813115934245, 37866.0533486665, 38094.0, 38388.80805595954, 39323.60676393314, 37282.62717372792, 38080.0, 38741.61258387493, 38877.0, 38886.6111338883, 37179.8141009304, 37367.6263237375, 37975.430368543944, 38011.619883800806, 38061.619383806916, 33440.331193376485, 33467.52040276111, 33638.0, 34177.31645367029, 34368.65631343654, 24295.63556546618, 24657.520548766413, 24682.382940426633, 24859.50842949429, 24878.751212487645], "unit": "score", "name": "ext.html", "value": 19019.411731772645}, {"lowerIsBetter": false, "replicates": [352.6438297319707, 375.79706958242565, 376.0954903457185, 386.6384930090364, 388.9630485103914, 17032.744508832377, 17708.911455442736, 18726.719099213522, 18773.436796896098, 18802.623947521042, 17349.82650173498, 17754.556136096606, 17793.37723179689, 17878.463646090637, 17882.37411690591, 5538.446155384449, 5780.682062486561, 5787.276590426197, 5794.739236734336, 5807.0, 4239.894002649928, 5627.887442251153, 5896.764129434839, 6174.598651087687, 6209.596376235553, 6056.818295451144, 6083.78706745264, 6096.634201947897, 6110.96944515279, 6129.1419201311855, 5960.076188190816, 6297.811065668037, 6300.432961033506, 6308.053791931201, 6319.399657032574, 5455.345358556959, 5483.287172667528, 5487.890242195133, 5491.0116179087745, 5521.089020311644, 19441.0, 19907.60184796296, 20046.49883752918, 20126.0, 21128.471788205417, 2251.9437014074615, 2264.8754318512474, 2313.838031337807, 2351.3298709867777, 2895.3485465770245, 10991.395473248967, 12593.37033148339, 13450.865491345157, 13556.796648050287, 13685.0, 1813.4468986958973, 1824.79927208007, 1847.1503108570073, 1950.9512262193416, 2037.3378651938178, 61353.38646613521, 62567.37432625661, 63975.68012159909, 65829.67085164592, 67703.32296677069, 10272.435016074038, 10646.307989980627, 10661.89338106609, 10759.408232547285, 10985.945070274598, 15351.769723454157, 15381.692366152614, 15460.072395656296, 15469.767953480707, 15529.534113976599, 7429.219931907072, 7582.317591416689, 7632.5038872473115, 7845.7253996111, 8305.252527272574, 7302.087239095114, 7418.517796343328, 7650.120236172911, 7771.961140194263, 7992.240737129963, 4671.743054131987, 4681.953180468152, 4815.3017812417, 4837.927431088537, 4870.439899411542, 1843.4285371534868, 1928.23834585338, 1956.9119389627501, 1976.8418526517844, 2045.3454894433935, 1005.3314545826943, 1019.8113349030453, 1040.4953597505205, 1043.7286305560458, 1114.7491814341709, 16301.59246018859, 16787.0, 17643.73534396985, 17791.19939602721, 18190.63618727618, 994.8159590475785, 1000.674780696262, 1030.9845352319721, 1038.6416686243233, 1063.1016790811752, 7972.481788683833, 9371.437713737198, 9431.198348140348, 9439.150476457151, 9482.099200575934, 445925.0, 446310.0, 452117.0, 452377.0, 454325.0, 48767.75616121897, 50179.49820501748, 78415.0, 78634.6068269655, 79918.60040699759, 1110.6667999600088, 1127.537709539085, 1136.4033882211904, 1139.789139009286, 1155.5493357590547, 14539.491117810825, 14728.18620522082, 14802.333894974967, 14960.0, 15124.0, 30715.69284307218, 31569.8421507891, 32033.67966320307, 32130.35739285248, 32475.837620811744, 48448.27327590159, 49745.0, 49972.50027499678, 50236.748816255684, 50623.49376506188, 7836.686532538863, 8594.765361006059, 8740.431871928304, 8944.418612790148, 9015.05341939087, 12649.241045537297, 13287.20276783396, 13328.266945317713, 13331.866681333062, 13695.931520342732, 11285.153613478858, 11524.539018439169, 11530.308181509135, 11535.36555489456, 11610.76778464443, 11189.88810111921, 11286.492107855001, 11319.0, 11388.032017278292, 11415.543378265109, 10995.780084398428, 11169.832452513056, 11619.36093514831, 11695.707607309885, 11948.70128246766, 7969.083555391204, 8696.347773917108, 8840.115988401109, 8935.597898094731, 8963.462192268486, 11494.137939654393, 11633.59282425111, 11682.357470339213, 11727.35499547533, 11769.705757356134], "unit": "score", "name": "jquery.html", "value": 8872.26708577151}, {"lowerIsBetter": false, "replicates": [1554.9222538873057, 1565.9765103523441, 1774.7692799936015, 1836.5133239691477, 1857.5634725839434, 8279.420440569163, 8287.254147126758, 8511.914880851189, 8533.061363250037, 8579.099194584565, 8390.077091519928, 8470.872936905951, 8473.576321183931, 8522.318214542836, 8542.27390671792, 2412.867292298927, 2416.4442178298914, 2417.504411595619, 2420.0803694596116, 2438.2563318187945, 2439.4389290463205, 2471.4315707387314, 2505.3110394641435, 2513.5978243481045, 2522.7477252274716, 2417.057347634424, 2417.8756878051704, 2449.2040086971715, 2454.1533171055958, 2454.6563481112657, 2426.4783071639504, 2460.6801115855005, 2478.8140889433184, 2480.6403071554614, 2504.0985245311763, 2483.1805504183576, 2483.9751602483925, 2485.0, 2490.601503759408, 2508.736582658831, 8516.616752246164, 8524.488530688179, 8571.914280857174, 8581.656733730642, 8608.698695545689, 5161.587073034186, 5237.816676416345, 5262.526372626482, 5291.682499050031, 5302.257683924254, 3359.5128706337687, 3375.206826395795, 3403.5235067090625, 3409.539712138854, 3517.6482351764876, 1094.108301734084, 1124.9775004499863, 1138.0440430038807, 1144.376314908377, 1144.6794897428733, 11435.714107147305, 11482.88517114835, 11492.195546311761, 11532.250403723816, 11618.360990145538, 4379.496357918816, 4395.099004704028, 4406.20688276107, 4481.395011673382, 4500.909981800346, 9298.628054877729, 9337.066293370744, 9364.90635093654, 9365.531723413802, 9378.765530861783, 5114.923276150861, 5138.640295179302, 5143.537081662594, 5145.228215767665, 5162.406323272797, 4118.670506359484, 4563.771811409416, 4651.302304654261, 4662.790174442158, 4682.41469816273, 3624.98187509066, 3730.5336832895887, 3754.4368344748505, 3755.830987605564, 3773.1510410158044, 1149.1324050341939, 1156.3871148291419, 1164.895159435655, 1165.906727461801, 1172.4899668644166, 1419.8651128143017, 1435.6339133520885, 1446.6021843992776, 1448.2903377345235, 1478.1722235548127, 7814.648340824677, 7913.169117242722, 7914.722984695508, 7952.562609056442, 7965.920340796633, 538.2598926476095, 540.3231012956867, 544.6378158524616, 565.8161097643282, 567.3815541060181, 6084.939150608438, 6130.233720784902, 6152.8769424611255, 6156.0, 6167.876642467215, 10235.692929212135, 10579.523921423555, 10733.78532429347, 10757.085647719874, 10776.78446431067, 10188.08307252336, 10218.0, 10423.322484038514, 10429.061384475433, 10474.68575942723, 8058.234467725557, 8158.265756081981, 8195.46729462583, 8205.384596155192, 8276.503409795432, 7726.729564465441, 7873.015873015873, 7886.171951945193, 7886.960565197367, 7937.484063535851, 9042.0, 9341.785567876133, 9349.906500934903, 9494.667686630935, 9619.711408657751, 9496.195722812643, 9611.903880961381, 9633.855492167764, 9687.70936871895, 9836.704898853046, 6193.752249909953, 6832.111825462857, 7023.613701246276, 7265.309795569412, 7276.30875066889, 8025.2777250047775, 8040.2361775631225, 8051.033875934925, 8080.0707918590115, 8096.230858068474, 7170.928290717026, 7226.7109315626785, 7280.708771649075, 7311.744088956861, 7376.4836461447185, 7054.788356349318, 7093.609851458013, 7099.36105750485, 7134.32223938725, 7162.319579639926, 7236.457265704988, 7258.20159782413, 7297.744578939712, 7320.963395183203, 7338.046054012944, 6582.0, 6633.568818026813, 6635.701393437404, 6635.900461493178, 6647.302033286629, 6716.529842910949, 6733.091032710718, 6793.89809152873, 6794.388505034571, 6857.382835544825], "unit": "score", "name": "mootools.html", "value": 4742.776516515682}, {"lowerIsBetter": false, "replicates": [356.0937414280655, 358.64494150790716, 359.1183644153603, 359.4572195984063, 368.10550362618835, 6435.839104022396, 6460.450861676757, 6465.288818230003, 6470.514711396652, 6471.158749362588, 6351.364863513646, 6355.332690067546, 6369.745210191599, 6382.074599183115, 6399.232092148949, 4775.856724298276, 4833.0, 4920.138975679241, 4937.703737775727, 4947.579455746266, 4858.805647774085, 4886.267059941002, 4904.092742842586, 4913.484084171147, 4957.702537847723, 4852.805887764503, 4854.199057155565, 4868.05073010763, 4874.829380971667, 4879.072976134541, 4891.779869905845, 4897.559219670229, 4898.4366797818175, 4907.901841963177, 4909.975450122726, 4253.29820579604, 4273.743575385487, 4294.355846623001, 4301.806418711166, 4302.913941721179, 5923.822285331447, 6116.449519543263, 6122.0, 6122.387761223842, 6142.938570614281, 5758.769649214027, 5795.507381872546, 5796.1595568642315, 5826.126081087828, 5839.270091238595, 6851.417629501499, 6865.244823069458, 6875.965620171917, 6877.828054298632, 6891.793246202622, 4840.15297322967, 4868.975655121737, 4873.098476781771, 4890.951090489085, 4917.065757506062, 7031.542949708252, 7080.610566418845, 7132.286771322878, 7144.499885008052, 7147.249538798404, 4886.267059941038, 4894.070126675921, 4972.5276098770555, 4976.875578110504, 4983.825566105169, 5047.621428392885, 5055.443901170868, 5055.545000949932, 5058.215976523645, 5065.544101030851, 5716.056850619601, 5767.942320576741, 5784.1034639630925, 5802.100674395476, 5817.069268916953, 6693.933060669428, 6695.631740254235, 6762.053312536249, 6763.086983257197, 6766.966165169241, 1771.7785276840395, 1811.184966764961, 1822.5443639090226, 1828.31438210671, 1829.0945981739123, 1181.8286348479423, 1213.1265488848014, 1217.15407791584, 1219.9695007624703, 1220.1641875315438, 6444.9355506444335, 6504.959206526933, 6521.576097553739, 6536.640484773383, 6545.639989800511, 6943.548669336477, 6993.545419547713, 7017.614031228331, 7019.122609673791, 7020.543664661883, 6512.023196520559, 6536.281009088996, 6543.738250469928, 6560.606363618198, 6586.341365863375, 3725.7391982561503, 3759.9248015040093, 3796.1838204786104, 3803.410471376941, 3810.942835857464, 7190.8202294942, 7234.131904171428, 7243.818904527429, 7247.710091596383, 7275.272472752682, 7271.454640901953, 7297.197308296083, 7303.160136584361, 7312.341889229995, 7349.0078839357075, 7349.30181632744, 7368.8894666580045, 7388.371988381048, 7390.630468476555, 7417.480776345712, 6961.2342642308295, 7075.469339799432, 7114.395276401564, 7140.214576396488, 7145.678444470115, 6929.618870962146, 6978.127734033246, 6983.930160698328, 7044.295570442915, 7078.823029424306, 7305.744298949511, 7306.671199796128, 7313.451491138292, 7337.963310183415, 7361.558306501627, 4868.464468908488, 4906.828261010847, 4912.0, 4923.876903077452, 4931.580815630711, 6921.550099243533, 7147.499675022698, 7148.892766608609, 7155.105611798525, 7161.964190179224, 6778.593284402951, 6817.079694241413, 6883.380495755206, 6891.793246202622, 6901.0, 6801.693923773541, 6838.487113466411, 6875.243723190545, 6878.8624227516175, 6897.896336586122, 6596.90104648421, 6613.735450581923, 6676.766313179015, 6683.899741503784, 6689.531732778659, 6691.0967019451755, 6937.7571784987285, 6944.923536851796, 6945.583265004116, 6952.617606031717, 6740.797776066725, 6743.831404214934, 6763.357481039294, 6766.391024807791, 6768.390844823989], "unit": "score", "name": "prototype.html", "value": 5183.221590819385}, {"lowerIsBetter": false, "replicates": [687.9656017199139, 718.1633397092387, 762.7787941496966, 775.209286527742, 780.887235689143, 14003.369848356822, 14101.435942562312, 14171.787423188634, 14217.360218790154, 14270.4291828327, 13303.334833258346, 13303.866961330385, 13355.332233388315, 13410.26243556604, 13410.530631427877, 755.7203834581185, 886.4238245140662, 890.679355432044, 893.1381217125472, 895.2658819767793, 901.8647202919549, 905.2124651553158, 907.7821322882494, 907.8728977943093, 907.9364444488889, 948.1182500274741, 948.2271948362097, 949.9762505937338, 951.172479942451, 953.9284553658504, 931.5668214280324, 932.1657116880355, 939.2532936315612, 944.7779771753633, 947.5499137909507, 704.8343639244773, 706.7173130747691, 710.1478226128614, 711.5623891306809, 712.081414974682, 13901.16593004423, 13959.371828267753, 14008.85991140096, 14013.159210447406, 14114.92942535291, 12292.631221063382, 12499.437525311383, 12734.872651273461, 12850.421731022127, 12868.356582170854, 9792.657256995972, 9891.90108098917, 10060.547275372626, 10069.0, 10132.645357412528, 3276.655951125121, 3337.8497967591516, 3340.7828491148, 3348.8995330140133, 3440.9827950860085, 50339.49660503385, 50421.49578504205, 50642.0, 50699.23951140736, 51327.23009154903, 9083.273338132933, 9297.256219502424, 9311.348205625676, 9351.719448416557, 9397.389169703947, 19267.421977340702, 19313.130909109124, 19332.226710931405, 19333.419997400102, 19367.0, 7181.281871812881, 7204.0994875640545, 7230.421566274686, 7344.228855970046, 7374.373178279906, 4132.33882578786, 4140.0891803803115, 4156.56356082613, 4213.873583792491, 4242.427272318259, 3221.64561898191, 3266.575345205156, 3282.720968717638, 3295.8681652734103, 3303.025607445761, 587.2659176029963, 598.7245866901275, 598.8173607049891, 600.0009983377628, 602.9246344206974, 596.0641792385999, 682.5188242289174, 712.138312641699, 729.274371999853, 756.1908757629394, 8401.70594029206, 8528.104549022388, 9225.769355766159, 9290.256779457628, 9462.432254064779, 618.6102755264154, 696.4915611603558, 732.1543617122232, 742.9294217049371, 787.4173111897155, 4164.3961625564725, 4183.5398106208295, 4235.957640423618, 4242.681798865097, 4293.549177336397, 49597.75201123971, 49979.25031124536, 50086.749566251936, 53644.73177634165, 57872.71063644739, 50825.0, 51021.489785102414, 51391.99999999925, 51545.48454515482, 51560.74219628878, 47061.5293847064, 47590.048199036515, 47806.282905756445, 48008.5199148011, 48241.5175848244, 8772.254358379609, 8864.822703545764, 9025.458472491671, 9034.63861445561, 9152.80332720129, 37066.8146659265, 37620.62379376281, 38120.0, 38839.41740873946, 38887.22225555417, 46079.308810368544, 47771.52228477671, 47926.5207347936, 48148.75925620349, 48197.51802481931, 11103.944480277547, 11146.554137834395, 11931.880681193077, 12001.339926303788, 12239.082068844695, 11935.701607459883, 12651.493940242655, 12866.144796515813, 13090.80363794563, 13112.475500980236, 11211.55153793839, 11306.095512358826, 11503.424828758696, 11637.709057273636, 11677.357745324089, 11261.324320540467, 11274.718132046437, 11343.943280283545, 11357.772844542898, 11389.715257118638, 11717.12121590867, 11782.351970641697, 11965.820512692142, 11970.341631210367, 12294.446749896455, 9974.700758977242, 10042.146417554297, 10137.239707021856, 10153.0, 10271.332363396356, 10014.699559013241, 10338.638147664795, 10562.419066951392, 10569.312994655324, 10609.0], "unit": "score", "name": "yui.html", "value": 6528.390165436107}], "name": "dromaeo_css", "value": 7300.954257655686}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 112.0, 111.0, 113.0, 123.0, 114.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 153.0, 173.0, 128.0, 159.0, 158.0, 128.0, 174.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 161.0, 162.0, 163.0, 160.0, 164.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 75.0, 171.0, 79.0, 79.0, 77.0, 74.0, 166.0, 78.0], "unit": "score", "name": "audio-fft", "value": 95.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 150.0, 95.0, 93.0, 93.0, 150.0, 93.0, 92.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 149.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 98.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 61.0, 61.0, 63.0, 61.0, 59.0, 66.0, 58.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [64.0, 75.0, 64.0, 66.0, 65.0, 65.0, 64.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 77.0, 79.0, 81.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 114.0, 112.0, 120.0, 141.0, 132.0, 115.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 151.0, 161.0, 147.0, 140.0, 146.0, 147.0, 151.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 66.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1529.9}]} 04:00:10 INFO - Return code: 0 04:00:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:00:10 ERROR - # TBPL SUCCESS # 04:00:10 INFO - Running post-action listener: _resource_record_post_action 04:00:10 INFO - Running post-run listener: _resource_record_post_run 04:00:11 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 20480; Write bytes: 501661696; Read time: 40; Write time: 525080 04:00:11 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245280768; Read time: 0; Write time: 353032 04:00:11 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 20480; Write bytes: 256380928; Read time: 40; Write time: 172048 04:00:11 INFO - Running post-run listener: _upload_blobber_files 04:00:11 INFO - Blob upload gear active. 04:00:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:11 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 04:00:11 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:11 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:00:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:12 INFO - (blobuploader) - INFO - Done attempting. 04:00:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:00:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:14 INFO - (blobuploader) - INFO - Done attempting. 04:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:14 INFO - Return code: 0 04:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a411f9ef0be0055a1f183340948291eb3143ddd4fca7bd2ba8c4d01b3bee43c10408de2e0881894a3252ee6c8a5fc5ccd9c5512e6dc5e0bd441444ca4ea7b47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/128f996c7dd593e118edab1d7b7604a411b93633da755e5e9789f8a5f916c092155572eec85dd2417bd57006150e77a88af4fd2779f7bb44a83314a51cfff4c1"} 04:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:14 INFO - Contents: 04:00:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a411f9ef0be0055a1f183340948291eb3143ddd4fca7bd2ba8c4d01b3bee43c10408de2e0881894a3252ee6c8a5fc5ccd9c5512e6dc5e0bd441444ca4ea7b47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/128f996c7dd593e118edab1d7b7604a411b93633da755e5e9789f8a5f916c092155572eec85dd2417bd57006150e77a88af4fd2779f7bb44a83314a51cfff4c1"} 04:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:14 INFO - Copying logs to upload dir... 04:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.801549 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-27 04:00:14.950954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-27 04:00:14.960461) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822 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-Aurora/sha512/5a411f9ef0be0055a1f183340948291eb3143ddd4fca7bd2ba8c4d01b3bee43c10408de2e0881894a3252ee6c8a5fc5ccd9c5512e6dc5e0bd441444ca4ea7b47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/128f996c7dd593e118edab1d7b7604a411b93633da755e5e9789f8a5f916c092155572eec85dd2417bd57006150e77a88af4fd2779f7bb44a83314a51cfff4c1"} build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010721 build_url: 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a411f9ef0be0055a1f183340948291eb3143ddd4fca7bd2ba8c4d01b3bee43c10408de2e0881894a3252ee6c8a5fc5ccd9c5512e6dc5e0bd441444ca4ea7b47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/128f996c7dd593e118edab1d7b7604a411b93633da755e5e9789f8a5f916c092155572eec85dd2417bd57006150e77a88af4fd2779f7bb44a83314a51cfff4c1"}' ========= master_lag: 2.41 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-27 04:00:17.385548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:00:17.385928) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461753442.291383-80429822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:00:17.471474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:00:17.471889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:00:17.477080) ========= ========= Total master_lag: 2.94 =========