builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1463039973.01 results: success (0) buildid: 20160511222516 builduid: 23079a7e4f56498cb22887933fbe0902 revision: 584c4d11538d9b1124c212906ec8e5b7d7254a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.009035) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.009595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.010249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.045798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.046155) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 00:59:34-- 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% 35.2M=0s 2016-05-12 00:59:34 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.227412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.227726) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009508 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.281614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.282199) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 584c4d11538d9b1124c212906ec8e5b7d7254a19 --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 584c4d11538d9b1124c212906ec8e5b7d7254a19 --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=3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 00:59:34,477 truncating revision to first 12 chars 2016-05-12 00:59:34,477 Setting DEBUG logging. 2016-05-12 00:59:34,477 attempt 1/10 2016-05-12 00:59:34,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/584c4d11538d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 00:59:34,727 unpacking tar archive at: mozilla-aurora-584c4d11538d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.499968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.795150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.795556) ========= script_repo_revision: 584c4d11538d9b1124c212906ec8e5b7d7254a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.796002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.796294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 00:59:33.802985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-12 00:59:33.803337) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:59:35 INFO - MultiFileLogger online at 20160512 00:59:35 in /builds/slave/test 00:59:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:59:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:59:35 INFO - {'append_to_log': False, 00:59:35 INFO - 'base_work_dir': '/builds/slave/test', 00:59:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:59:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:59:35 INFO - 'branch': 'Mozilla-Aurora', 00:59:35 INFO - 'buildbot_json_path': 'buildprops.json', 00:59:35 INFO - 'config_files': ('talos/linux_config.py',), 00:59:35 INFO - 'default_actions': ('clobber', 00:59:35 INFO - 'read-buildbot-config', 00:59:35 INFO - 'download-and-extract', 00:59:35 INFO - 'populate-webroot', 00:59:35 INFO - 'create-virtualenv', 00:59:35 INFO - 'install', 00:59:35 INFO - 'run-tests'), 00:59:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:59:35 INFO - 'download_minidump_stackwalk': True, 00:59:35 INFO - 'download_symbols': 'ondemand', 00:59:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:59:35 INFO - 'tooltool.py': '/tools/tooltool.py', 00:59:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:59:35 INFO - '/tools/misc-python/virtualenv.py')}, 00:59:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:59:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:59:35 INFO - 'installer_path': 'installer.exe', 00:59:35 INFO - 'log_level': 'info', 00:59:35 INFO - 'log_name': 'talos', 00:59:35 INFO - 'log_to_console': True, 00:59:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:59:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:59:35 INFO - 'opt_config_files': (), 00:59:35 INFO - 'pip_index': False, 00:59:35 INFO - 'sps_profile': False, 00:59:35 INFO - 'sps_profile_interval': 0, 00:59:35 INFO - 'suite': 'dromaeojs', 00:59:35 INFO - 'system_bits': '32', 00:59:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:59:35 INFO - 'title': 'talos-linux64-ix-059', 00:59:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:59:35 INFO - 'use_talos_json': True, 00:59:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:59:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:59:35 INFO - 'work_dir': 'build'} 00:59:35 INFO - ##### 00:59:35 INFO - ##### Running clobber step. 00:59:35 INFO - ##### 00:59:35 INFO - Running pre-action listener: _resource_record_pre_action 00:59:35 INFO - Running main action method: clobber 00:59:35 INFO - rmtree: /builds/slave/test/build 00:59:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:59:36 INFO - Running post-action listener: _resource_record_post_action 00:59:36 INFO - ##### 00:59:36 INFO - ##### Running read-buildbot-config step. 00:59:36 INFO - ##### 00:59:36 INFO - Running pre-action listener: _resource_record_pre_action 00:59:36 INFO - Running main action method: read_buildbot_config 00:59:36 INFO - Using buildbot properties: 00:59:36 INFO - { 00:59:36 INFO - "project": "", 00:59:36 INFO - "product": "firefox", 00:59:36 INFO - "script_repo_revision": "production", 00:59:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 00:59:36 INFO - "repository": "", 00:59:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 00:59:36 INFO - "buildid": "20160511222516", 00:59:36 INFO - "pgo_build": "True", 00:59:36 INFO - "basedir": "/builds/slave/test", 00:59:36 INFO - "buildnumber": 327, 00:59:36 INFO - "slavename": "talos-linux64-ix-059", 00:59:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:59:36 INFO - "platform": "ubuntu64_hw", 00:59:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:59:36 INFO - "branch": "mozilla-aurora", 00:59:36 INFO - "repo_path": "releases/mozilla-aurora", 00:59:36 INFO - "revision": "584c4d11538d9b1124c212906ec8e5b7d7254a19", 00:59:36 INFO - "stage_platform": "linux64-pgo", 00:59:36 INFO - "builduid": "23079a7e4f56498cb22887933fbe0902", 00:59:36 INFO - "slavebuilddir": "test" 00:59:36 INFO - } 00:59:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 00:59:36 INFO - Running post-action listener: _resource_record_post_action 00:59:36 INFO - ##### 00:59:36 INFO - ##### Running download-and-extract step. 00:59:36 INFO - ##### 00:59:36 INFO - Running pre-action listener: _resource_record_pre_action 00:59:36 INFO - Running main action method: download_and_extract 00:59:36 INFO - mkdir: /builds/slave/test/build/tests 00:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:36 INFO - https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:59:39 INFO - Downloaded 1361 bytes. 00:59:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 00:59:39 INFO - Using the following test package requirements: 00:59:39 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 00:59:39 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:59:39 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:59:39 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'jsshell-linux-x86_64.zip'], 00:59:39 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:59:39 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 00:59:39 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:59:39 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:59:39 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:59:39 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 00:59:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:59:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:59: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')]} 00:59:39 INFO - https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:41 INFO - Downloaded 23799188 bytes. 00:59:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:59:42 INFO - Return code: 0 00:59:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:59:42 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')]} 00:59:42 INFO - https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 00:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:47 INFO - Downloaded 23799188 bytes. 00:59:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:59:49 INFO - Return code: 0 00:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:49 INFO - https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 00:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 00:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 00:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:59:49 INFO - Downloaded 10840145 bytes. 00:59:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:59:50 INFO - Return code: 0 00:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:50 INFO - https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:59:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:59:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:59:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:59:51 INFO - Downloaded 62715379 bytes. 00:59:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:59:51 INFO - mkdir: /builds/slave/test/properties 00:59:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:59:51 INFO - Writing to file /builds/slave/test/properties/build_url 00:59:51 INFO - Contents: 00:59:51 INFO - build_url:https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 00:59:52 INFO - Running post-action listener: _resource_record_post_action 00:59:52 INFO - Running post-action listener: set_extra_try_arguments 00:59:52 INFO - ##### 00:59:52 INFO - ##### Running populate-webroot step. 00:59:52 INFO - ##### 00:59:52 INFO - Running pre-action listener: _resource_record_pre_action 00:59:52 INFO - Running main action method: populate_webroot 00:59:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:59:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:59:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:59:52 INFO - '--tppagecycles', 00:59:52 INFO - '7'], 00:59:52 INFO - 'tests': ['tsvgm']}}, 00:59:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:59:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:59:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:59:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:59:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['damp', 'tps']}, 00:59:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'tests': ['damp', 'tps']}, 00:59:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['dromaeo_dom']}, 00:59:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:59:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['a11yr', 00:59:52 INFO - 'ts_paint', 00:59:52 INFO - 'tpaint', 00:59:52 INFO - 'sessionrestore', 00:59:52 INFO - 'sessionrestore_no_auto_restore', 00:59:52 INFO - 'tabpaint']}, 00:59:52 INFO - 'other-e10s': {'tests': ['a11yr', 00:59:52 INFO - 'ts_paint', 00:59:52 INFO - 'tpaint', 00:59:52 INFO - 'sessionrestore', 00:59:52 INFO - 'sessionrestore_no_auto_restore', 00:59:52 INFO - 'tabpaint']}, 00:59:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:59:52 INFO - 'ts_paint', 00:59:52 INFO - 'tpaint', 00:59:52 INFO - 'sessionrestore', 00:59:52 INFO - 'sessionrestore_no_auto_restore', 00:59:52 INFO - 'tabpaint']}, 00:59:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:59:52 INFO - 'ts_paint', 00:59:52 INFO - 'tpaint', 00:59:52 INFO - 'sessionrestore', 00:59:52 INFO - 'sessionrestore_no_auto_restore', 00:59:52 INFO - 'tabpaint']}, 00:59:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['a11yr', 00:59:52 INFO - 'ts_paint', 00:59:52 INFO - 'tpaint', 00:59:52 INFO - 'sessionrestore', 00:59:52 INFO - 'sessionrestore_no_auto_restore', 00:59:52 INFO - 'tabpaint']}, 00:59:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['a11yr', 00:59:52 INFO - 'ts_paint', 00:59:52 INFO - 'tpaint', 00:59:52 INFO - 'sessionrestore', 00:59:52 INFO - 'sessionrestore_no_auto_restore', 00:59:52 INFO - 'tabpaint']}, 00:59:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['tsvgx', 00:59:52 INFO - 'tsvgr_opacity', 00:59:52 INFO - 'tart', 00:59:52 INFO - 'tscrollx', 00:59:52 INFO - 'cart']}, 00:59:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:59:52 INFO - 'tsvgr_opacity', 00:59:52 INFO - 'tart', 00:59:52 INFO - 'tscrollx', 00:59:52 INFO - 'cart']}, 00:59:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'talos_options': ['--disable-e10s'], 00:59:52 INFO - 'tests': ['tp5o']}, 00:59:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'tests': ['tp5o']}, 00:59:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'talos_options': ['--disable-e10s', 00:59:52 INFO - '--xperf_path', 00:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:52 INFO - 'tests': ['tp5n']}, 00:59:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:52 INFO - 'talos_options': ['--xperf_path', 00:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:52 INFO - 'tests': ['tp5n']}}, 00:59:52 INFO - 'talos.zip': {'path': '', 00:59:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:59:52 INFO - Running post-action listener: _resource_record_post_action 00:59:52 INFO - ##### 00:59:52 INFO - ##### Running create-virtualenv step. 00:59:52 INFO - ##### 00:59:52 INFO - Running pre-action listener: _resource_record_pre_action 00:59:52 INFO - Running main action method: create_virtualenv 00:59:52 INFO - Creating virtualenv /builds/slave/test/build/venv 00:59:52 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 00:59:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:59:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:59:52 INFO - Using real prefix '/usr' 00:59:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:59:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:59:54 INFO - Installing pip.................done. 00:59:54 INFO - Return code: 0 00:59:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:59:54 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')]} 00:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:54 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')]} 00:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:54 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 00:59:54 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 00:59:54 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 00:59:54 INFO - Using env: {'DISPLAY': ':0', 00:59:54 INFO - 'HOME': '/home/cltbld', 00:59:54 INFO - 'LANG': 'en_US.UTF-8', 00:59:54 INFO - 'LANGUAGE': 'en_US:en', 00:59:54 INFO - 'LOGNAME': 'cltbld', 00:59:54 INFO - 'MAIL': '/var/mail/cltbld', 00:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:54 INFO - 'MOZ_NO_REMOTE': '1', 00:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:54 INFO - 'NO_EM_RESTART': '1', 00:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:54 INFO - 'PWD': '/builds/slave/test', 00:59:54 INFO - 'SHELL': '/bin/bash', 00:59:54 INFO - 'SHLVL': '1', 00:59:54 INFO - 'TERM': 'linux', 00:59:54 INFO - 'TMOUT': '86400', 00:59:54 INFO - 'USER': 'cltbld', 00:59:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 00:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:54 INFO - '_': '/tools/buildbot/bin/python'} 00:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:54 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 00:59:54 INFO - Cleaning up... 00:59:55 INFO - Return code: 0 00:59:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:55 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 00:59:55 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 00:59:55 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 00:59:55 INFO - Using env: {'DISPLAY': ':0', 00:59:55 INFO - 'HOME': '/home/cltbld', 00:59:55 INFO - 'LANG': 'en_US.UTF-8', 00:59:55 INFO - 'LANGUAGE': 'en_US:en', 00:59:55 INFO - 'LOGNAME': 'cltbld', 00:59:55 INFO - 'MAIL': '/var/mail/cltbld', 00:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:55 INFO - 'MOZ_NO_REMOTE': '1', 00:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:55 INFO - 'NO_EM_RESTART': '1', 00:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:55 INFO - 'PWD': '/builds/slave/test', 00:59:55 INFO - 'SHELL': '/bin/bash', 00:59:55 INFO - 'SHLVL': '1', 00:59:55 INFO - 'TERM': 'linux', 00:59:55 INFO - 'TMOUT': '86400', 00:59:55 INFO - 'USER': 'cltbld', 00:59:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 00:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:55 INFO - '_': '/tools/buildbot/bin/python'} 00:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:55 INFO - Downloading/unpacking psutil>=0.7.1 00:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:59:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:57 INFO - Installing collected packages: psutil 00:59:57 INFO - Running setup.py install for psutil 00:59:57 INFO - building 'psutil._psutil_linux' extension 00:59:57 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 00:59:57 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 00:59:57 INFO - building 'psutil._psutil_posix' extension 00:59:57 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 00:59:57 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 00:59:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:57 INFO - Successfully installed psutil 00:59:57 INFO - Cleaning up... 00:59:57 INFO - Return code: 0 00:59:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:57 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 00:59:57 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 00:59:57 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 00:59:57 INFO - Using env: {'DISPLAY': ':0', 00:59:57 INFO - 'HOME': '/home/cltbld', 00:59:57 INFO - 'LANG': 'en_US.UTF-8', 00:59:57 INFO - 'LANGUAGE': 'en_US:en', 00:59:57 INFO - 'LOGNAME': 'cltbld', 00:59:57 INFO - 'MAIL': '/var/mail/cltbld', 00:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:57 INFO - 'MOZ_NO_REMOTE': '1', 00:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:57 INFO - 'NO_EM_RESTART': '1', 00:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:57 INFO - 'PWD': '/builds/slave/test', 00:59:57 INFO - 'SHELL': '/bin/bash', 00:59:57 INFO - 'SHLVL': '1', 00:59:57 INFO - 'TERM': 'linux', 00:59:57 INFO - 'TMOUT': '86400', 00:59:57 INFO - 'USER': 'cltbld', 00:59:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 00:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:57 INFO - '_': '/tools/buildbot/bin/python'} 00:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:59:57 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 00:59:57 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 00:59:57 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 00:59:57 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 00:59:57 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 00:59:57 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 00:59:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:59:59 INFO - Installing collected packages: mozsystemmonitor 00:59:59 INFO - Running setup.py install for mozsystemmonitor 00:59:59 INFO - Successfully installed mozsystemmonitor 00:59:59 INFO - Cleaning up... 00:59:59 INFO - Return code: 0 00:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 00:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:59:59 INFO - Using env: {'DISPLAY': ':0', 00:59:59 INFO - 'HOME': '/home/cltbld', 00:59:59 INFO - 'LANG': 'en_US.UTF-8', 00:59:59 INFO - 'LANGUAGE': 'en_US:en', 00:59:59 INFO - 'LOGNAME': 'cltbld', 00:59:59 INFO - 'MAIL': '/var/mail/cltbld', 00:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:59 INFO - 'MOZ_NO_REMOTE': '1', 00:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:59 INFO - 'NO_EM_RESTART': '1', 00:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:59 INFO - 'PWD': '/builds/slave/test', 00:59:59 INFO - 'SHELL': '/bin/bash', 00:59:59 INFO - 'SHLVL': '1', 00:59:59 INFO - 'TERM': 'linux', 00:59:59 INFO - 'TMOUT': '86400', 00:59:59 INFO - 'USER': 'cltbld', 00:59:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 00:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:59 INFO - '_': '/tools/buildbot/bin/python'} 01:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:00 INFO - Downloading/unpacking blobuploader==1.2.4 01:00:00 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 01:00:00 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 01:00:00 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 01:00:00 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 01:00:00 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 01:00:00 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 01:00:01 INFO - Downloading blobuploader-1.2.4.tar.gz 01:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:00:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:00:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:02 INFO - Downloading docopt-0.6.1.tar.gz 01:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 01:00:02 INFO - Running setup.py install for blobuploader 01:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:00:02 INFO - Running setup.py install for requests 01:00:03 INFO - Running setup.py install for docopt 01:00:03 INFO - Successfully installed blobuploader requests docopt 01:00:03 INFO - Cleaning up... 01:00:03 INFO - Return code: 0 01:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:03 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 01:00:03 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 01:00:03 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 01:00:03 INFO - Using env: {'DISPLAY': ':0', 01:00:03 INFO - 'HOME': '/home/cltbld', 01:00:03 INFO - 'LANG': 'en_US.UTF-8', 01:00:03 INFO - 'LANGUAGE': 'en_US:en', 01:00:03 INFO - 'LOGNAME': 'cltbld', 01:00:03 INFO - 'MAIL': '/var/mail/cltbld', 01:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:03 INFO - 'MOZ_NO_REMOTE': '1', 01:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:03 INFO - 'NO_EM_RESTART': '1', 01:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:03 INFO - 'PWD': '/builds/slave/test', 01:00:03 INFO - 'SHELL': '/bin/bash', 01:00:03 INFO - 'SHLVL': '1', 01:00:03 INFO - 'TERM': 'linux', 01:00:03 INFO - 'TMOUT': '86400', 01:00:03 INFO - 'USER': 'cltbld', 01:00:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 01:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:03 INFO - '_': '/tools/buildbot/bin/python'} 01:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:03 INFO - Running setup.py (path:/tmp/pip-TgUSMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:03 INFO - Running setup.py (path:/tmp/pip-ufKWZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:03 INFO - Running setup.py (path:/tmp/pip-2N15PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:03 INFO - Running setup.py (path:/tmp/pip-aOtoUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:03 INFO - Running setup.py (path:/tmp/pip-VjIYC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:03 INFO - Running setup.py (path:/tmp/pip-dEdZSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:03 INFO - Running setup.py (path:/tmp/pip-Ki7EQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:03 INFO - Running setup.py (path:/tmp/pip-rQF5Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:03 INFO - Running setup.py (path:/tmp/pip-Xs62Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:03 INFO - Running setup.py (path:/tmp/pip-bg7hlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:03 INFO - Running setup.py (path:/tmp/pip-sNsvAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:03 INFO - Running setup.py (path:/tmp/pip-jmBg7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:04 INFO - Running setup.py (path:/tmp/pip-eWfxNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:04 INFO - Running setup.py (path:/tmp/pip-NqjOMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:04 INFO - Running setup.py (path:/tmp/pip-BJBFFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:04 INFO - Running setup.py (path:/tmp/pip-pQkTQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:04 INFO - Running setup.py (path:/tmp/pip-64vwbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:00:04 INFO - Running setup.py install for manifestparser 01:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:00:04 INFO - Running setup.py install for mozcrash 01:00:04 INFO - Running setup.py install for mozdebug 01:00:04 INFO - Running setup.py install for mozdevice 01:00:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:00:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:00:04 INFO - Running setup.py install for mozfile 01:00:04 INFO - Running setup.py install for mozhttpd 01:00:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:00:04 INFO - Running setup.py install for mozinfo 01:00:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:00:04 INFO - Running setup.py install for mozInstall 01:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Running setup.py install for mozleak 01:00:05 INFO - Running setup.py install for mozlog 01:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Running setup.py install for moznetwork 01:00:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Running setup.py install for mozprocess 01:00:05 INFO - Running setup.py install for mozprofile 01:00:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Running setup.py install for mozrunner 01:00:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Running setup.py install for mozscreenshot 01:00:05 INFO - Running setup.py install for moztest 01:00:05 INFO - Running setup.py install for mozversion 01:00:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:05 INFO - Cleaning up... 01:00:05 INFO - Return code: 0 01:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00: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')]} 01:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00: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')]} 01:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:05 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 01:00:05 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 01:00:05 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 01:00:05 INFO - Using env: {'DISPLAY': ':0', 01:00:05 INFO - 'HOME': '/home/cltbld', 01:00:05 INFO - 'LANG': 'en_US.UTF-8', 01:00:05 INFO - 'LANGUAGE': 'en_US:en', 01:00:05 INFO - 'LOGNAME': 'cltbld', 01:00:05 INFO - 'MAIL': '/var/mail/cltbld', 01:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:05 INFO - 'MOZ_NO_REMOTE': '1', 01:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:05 INFO - 'NO_EM_RESTART': '1', 01:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:05 INFO - 'PWD': '/builds/slave/test', 01:00:05 INFO - 'SHELL': '/bin/bash', 01:00:05 INFO - 'SHLVL': '1', 01:00:05 INFO - 'TERM': 'linux', 01:00:05 INFO - 'TMOUT': '86400', 01:00:05 INFO - 'USER': 'cltbld', 01:00:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 01:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:05 INFO - '_': '/tools/buildbot/bin/python'} 01:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:06 INFO - Running setup.py (path:/tmp/pip-Wv0lz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:06 INFO - Running setup.py (path:/tmp/pip-taJ5jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:06 INFO - Running setup.py (path:/tmp/pip-E2MemR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:06 INFO - Running setup.py (path:/tmp/pip-cjjV8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:06 INFO - Running setup.py (path:/tmp/pip-O8hUSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:06 INFO - Running setup.py (path:/tmp/pip-UTSvmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:06 INFO - Running setup.py (path:/tmp/pip-FV7Qfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:06 INFO - Running setup.py (path:/tmp/pip-OeLVSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:06 INFO - Running setup.py (path:/tmp/pip-JVOPAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:06 INFO - Running setup.py (path:/tmp/pip-18tNHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:06 INFO - Running setup.py (path:/tmp/pip-vXIjcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:06 INFO - Running setup.py (path:/tmp/pip-tmv6t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:06 INFO - Running setup.py (path:/tmp/pip-BLQmHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:06 INFO - Running setup.py (path:/tmp/pip-JMAQK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:06 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)) 01:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:06 INFO - Running setup.py (path:/tmp/pip-ffW1yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:07 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)) 01:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:07 INFO - Running setup.py (path:/tmp/pip-0rjkZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:07 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)) 01:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:07 INFO - Running setup.py (path:/tmp/pip-PNqq33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:08 INFO - Downloading blessings-1.6.tar.gz 01:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:09 INFO - Installing collected packages: blessings 01:00:09 INFO - Running setup.py install for blessings 01:00:09 INFO - Successfully installed blessings 01:00:09 INFO - Cleaning up... 01:00:09 INFO - Return code: 0 01:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:09 INFO - Reading from file tmpfile_stdout 01:00:09 INFO - Current package versions: 01:00:09 INFO - argparse == 1.2.1 01:00:09 INFO - blessings == 1.6 01:00:09 INFO - blobuploader == 1.2.4 01:00:09 INFO - docopt == 0.6.1 01:00:09 INFO - manifestparser == 1.1 01:00:09 INFO - mozInstall == 1.12 01:00:09 INFO - mozcrash == 0.17 01:00:09 INFO - mozdebug == 0.1 01:00:09 INFO - mozdevice == 0.48 01:00:09 INFO - mozfile == 1.2 01:00:09 INFO - mozhttpd == 0.7 01:00:09 INFO - mozinfo == 0.9 01:00:09 INFO - mozleak == 0.1 01:00:09 INFO - mozlog == 3.1 01:00:09 INFO - moznetwork == 0.27 01:00:09 INFO - mozprocess == 0.22 01:00:09 INFO - mozprofile == 0.28 01:00:09 INFO - mozrunner == 6.11 01:00:09 INFO - mozscreenshot == 0.1 01:00:09 INFO - mozsystemmonitor == 0.0 01:00:09 INFO - moztest == 0.7 01:00:09 INFO - mozversion == 1.4 01:00:09 INFO - psutil == 3.1.1 01:00:09 INFO - requests == 1.2.3 01:00:09 INFO - wsgiref == 0.1.2 01:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:09 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')]} 01:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:09 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')]} 01:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:09 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 01:00:09 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 01:00:09 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 01:00:09 INFO - Using env: {'DISPLAY': ':0', 01:00:09 INFO - 'HOME': '/home/cltbld', 01:00:09 INFO - 'LANG': 'en_US.UTF-8', 01:00:09 INFO - 'LANGUAGE': 'en_US:en', 01:00:09 INFO - 'LOGNAME': 'cltbld', 01:00:09 INFO - 'MAIL': '/var/mail/cltbld', 01:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:09 INFO - 'MOZ_NO_REMOTE': '1', 01:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:09 INFO - 'NO_EM_RESTART': '1', 01:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:09 INFO - 'PWD': '/builds/slave/test', 01:00:09 INFO - 'SHELL': '/bin/bash', 01:00:09 INFO - 'SHLVL': '1', 01:00:09 INFO - 'TERM': 'linux', 01:00:09 INFO - 'TMOUT': '86400', 01:00:09 INFO - 'USER': 'cltbld', 01:00:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 01:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:09 INFO - '_': '/tools/buildbot/bin/python'} 01:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 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)) 01:00:09 INFO - Cleaning up... 01:00:09 INFO - Return code: 0 01:00:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:00:09 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')]} 01:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:09 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')]} 01:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:09 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 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 01:00:09 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 01:00:09 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 01:00:09 INFO - Using env: {'DISPLAY': ':0', 01:00:09 INFO - 'HOME': '/home/cltbld', 01:00:09 INFO - 'LANG': 'en_US.UTF-8', 01:00:09 INFO - 'LANGUAGE': 'en_US:en', 01:00:09 INFO - 'LOGNAME': 'cltbld', 01:00:09 INFO - 'MAIL': '/var/mail/cltbld', 01:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:09 INFO - 'MOZ_NO_REMOTE': '1', 01:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:09 INFO - 'NO_EM_RESTART': '1', 01:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:09 INFO - 'PWD': '/builds/slave/test', 01:00:09 INFO - 'SHELL': '/bin/bash', 01:00:09 INFO - 'SHLVL': '1', 01:00:09 INFO - 'TERM': 'linux', 01:00:09 INFO - 'TMOUT': '86400', 01:00:09 INFO - 'USER': 'cltbld', 01:00:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 01:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:09 INFO - '_': '/tools/buildbot/bin/python'} 01:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:09 INFO - Downloading/unpacking jsonschema 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:00:11 INFO - Downloading/unpacking functools32 (from jsonschema) 01:00:11 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 01:00:11 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 01:00:11 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 01:00:11 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 01:00:11 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 01:00:11 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 01:00:11 INFO - Downloading functools32-3.2.3-2.tar.gz 01:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:00:11 INFO - warning: no files found matching '*.txt' 01:00:11 INFO - no previously-included directories found matching 'build' 01:00:11 INFO - no previously-included directories found matching 'dist' 01:00:11 INFO - no previously-included directories found matching '.git*' 01:00:11 INFO - Installing collected packages: jsonschema, functools32 01:00:12 INFO - Running setup.py install for functools32 01:00:12 INFO - warning: no files found matching '*.txt' 01:00:12 INFO - no previously-included directories found matching 'build' 01:00:12 INFO - no previously-included directories found matching 'dist' 01:00:12 INFO - no previously-included directories found matching '.git*' 01:00:12 INFO - Successfully installed jsonschema functools32 01:00:12 INFO - Cleaning up... 01:00:12 INFO - Return code: 0 01:00:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec110f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb27d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', '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 01:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:00:12 INFO - Using env: {'DISPLAY': ':0', 01:00:12 INFO - 'HOME': '/home/cltbld', 01:00:12 INFO - 'LANG': 'en_US.UTF-8', 01:00:12 INFO - 'LANGUAGE': 'en_US:en', 01:00:12 INFO - 'LOGNAME': 'cltbld', 01:00:12 INFO - 'MAIL': '/var/mail/cltbld', 01:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:12 INFO - 'MOZ_NO_REMOTE': '1', 01:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:12 INFO - 'NO_EM_RESTART': '1', 01:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:12 INFO - 'PWD': '/builds/slave/test', 01:00:12 INFO - 'SHELL': '/bin/bash', 01:00:12 INFO - 'SHLVL': '1', 01:00:12 INFO - 'TERM': 'linux', 01:00:12 INFO - 'TMOUT': '86400', 01:00:12 INFO - 'USER': 'cltbld', 01:00:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 01:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:12 INFO - '_': '/tools/buildbot/bin/python'} 01:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:12 INFO - Downloading/unpacking flake8 01:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:00:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:00:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:14 INFO - no previously-included directories found matching 'docs/_build' 01:00:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:00:15 INFO - Running setup.py install for pep8 01:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:15 INFO - no previously-included directories found matching 'docs/_build' 01:00:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:00:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:00:15 INFO - Cleaning up... 01:00:15 INFO - Return code: 0 01:00:15 INFO - Running post-action listener: _resource_record_post_action 01:00:15 INFO - Running post-action listener: _start_resource_monitoring 01:00:15 INFO - Starting resource monitoring. 01:00:15 INFO - ##### 01:00:15 INFO - ##### Running install step. 01:00:15 INFO - ##### 01:00:15 INFO - Running pre-action listener: _resource_record_pre_action 01:00:15 INFO - Running main action method: install 01:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:15 INFO - Reading from file tmpfile_stdout 01:00:15 INFO - Detecting whether we're running mozinstall >=1.0... 01:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:00:15 INFO - Reading from file tmpfile_stdout 01:00:15 INFO - Output received: 01:00:15 INFO - Usage: mozinstall [options] installer 01:00:15 INFO - Options: 01:00:15 INFO - -h, --help show this help message and exit 01:00:15 INFO - -d DEST, --destination=DEST 01:00:15 INFO - Directory to install application into. [default: 01:00:15 INFO - "/builds/slave/test"] 01:00:15 INFO - --app=APP Application being installed. [default: firefox] 01:00:15 INFO - mkdir: /builds/slave/test/build/application 01:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:00:31 INFO - Reading from file tmpfile_stdout 01:00:31 INFO - Output received: 01:00:31 INFO - /builds/slave/test/build/application/firefox/firefox 01:00:31 INFO - Running post-action listener: _resource_record_post_action 01:00:31 INFO - ##### 01:00:31 INFO - ##### Running run-tests step. 01:00:31 INFO - ##### 01:00:31 INFO - Running pre-action listener: _resource_record_pre_action 01:00:31 INFO - Running main action method: run_tests 01:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:00:31 INFO - Python 2.7.3 01:00:31 INFO - Return code: 0 01:00:31 INFO - grabbing minidump binary from tooltool 01:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c41640>, '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 0x2c42540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c429d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:00:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:00:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:00:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:00:31 INFO - Return code: 0 01:00:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:00:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:00:32 INFO - Return code: 0 01:00:32 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:00:32 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:00:32 INFO - Using env: {'DISPLAY': ':0', 01:00:32 INFO - 'HOME': '/home/cltbld', 01:00:32 INFO - 'LANG': 'en_US.UTF-8', 01:00:32 INFO - 'LANGUAGE': 'en_US:en', 01:00:32 INFO - 'LOGNAME': 'cltbld', 01:00:32 INFO - 'MAIL': '/var/mail/cltbld', 01:00:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:00:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:32 INFO - 'MOZ_NO_REMOTE': '1', 01:00:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:32 INFO - 'NO_EM_RESTART': '1', 01:00:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:32 INFO - 'PWD': '/builds/slave/test', 01:00:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:00:32 INFO - 'SHELL': '/bin/bash', 01:00:32 INFO - 'SHLVL': '1', 01:00:32 INFO - 'TERM': 'linux', 01:00:32 INFO - 'TMOUT': '86400', 01:00:32 INFO - 'USER': 'cltbld', 01:00:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771', 01:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:32 INFO - '_': '/tools/buildbot/bin/python'} 01:00:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:00:32 INFO - mozversion application_buildid: 20160511222516 01:00:32 INFO - mozversion application_changeset: 584c4d11538d9b1124c212906ec8e5b7d7254a19 01:00:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:00:32 INFO - mozversion application_name: Firefox 01:00:32 INFO - mozversion application_remotingname: firefox-dev 01:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:00:32 INFO - mozversion application_vendor: Mozilla 01:00:32 INFO - mozversion application_version: 48.0a2 01:00:32 INFO - mozversion platform_buildid: 20160511222516 01:00:32 INFO - mozversion platform_changeset: 584c4d11538d9b1124c212906ec8e5b7d7254a19 01:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:00:32 INFO - mozversion platform_version: 48.0a2 01:00:32 INFO - using testdate: 1463040032 01:00:32 INFO - actual date: 1463040032 01:00:32 INFO - starting webserver on 'localhost:42488' 01:00:32 INFO - SUITE-START | Running 2 tests 01:00:32 INFO - TEST-START | dromaeo_css 01:00:32 INFO - operating with platform_type : linux_ 01:00:32 INFO - Initialising browser for dromaeo_css test... 01:00:32 INFO - TEST-INFO | started process 15212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVUpkV/profile http://localhost:42488/getInfo.html) 01:00:35 INFO - PROCESS | 15212 | __metrics Screen width/height:1600/1200 01:00:35 INFO - PROCESS | 15212 | colorDepth:24 01:00:35 INFO - PROCESS | 15212 | Browser inner width/height: 1024/697 01:00:35 INFO - PROCESS | 15212 | __metrics 01:00:36 ERROR - PROCESS | 15212 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:00:37 INFO - TEST-INFO | 15212: exit 0 01:00:37 INFO - Browser initialized. 01:00:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:00:37 INFO - TEST-INFO | started process 15302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVUpkV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:00:48 INFO - PROCESS | 15302 | RSS: Main: 140603392 01:00:48 INFO - PROCESS | 15302 | 01:01:39 INFO - PROCESS | 15302 | 1463040099846 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] 01:03:46 INFO - PROCESS | 15302 | Cycle 1(1): loaded http://localhost:42488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42488/tests/dromaeo/cssquery-ext.html) 01:03:47 INFO - PROCESS | 15302 | RSS: Main: 245227520 01:03:47 INFO - PROCESS | 15302 | 01:06:49 INFO - PROCESS | 15302 | Cycle 1(1): loaded http://localhost:42488/tests/dromaeo/cssquery-ext.html (next: http://localhost:42488/tests/dromaeo/cssquery-jquery.html) 01:06:50 INFO - PROCESS | 15302 | RSS: Main: 221491200 01:06:50 INFO - PROCESS | 15302 | 01:09:51 INFO - PROCESS | 15302 | Cycle 1(1): loaded http://localhost:42488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42488/tests/dromaeo/cssquery-mootools.html) 01:09:52 INFO - PROCESS | 15302 | RSS: Main: 215166976 01:09:52 INFO - PROCESS | 15302 | 01:12:54 INFO - PROCESS | 15302 | Cycle 1(1): loaded http://localhost:42488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42488/tests/dromaeo/cssquery-prototype.html) 01:12:54 INFO - PROCESS | 15302 | RSS: Main: 222359552 01:12:54 INFO - PROCESS | 15302 | 01:15:57 INFO - PROCESS | 15302 | Cycle 1(1): loaded http://localhost:42488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42488/tests/dromaeo/cssquery-yui.html) 01:15:57 INFO - PROCESS | 15302 | RSS: Main: 213868544 01:15:57 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | Cycle 1(1): loaded http://localhost:42488/tests/dromaeo/cssquery-yui.html (next: http://localhost:42488/tests/dromaeo/cssquery-dojo.html) 01:19:00 INFO - PROCESS | 15302 | RSS: Main: 253947904 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | __start_tp_report 01:19:00 INFO - PROCESS | 15302 | _x_x_mozilla_page_load 01:19:00 INFO - PROCESS | 15302 | _x_x_mozilla_page_load_details 01:19:00 INFO - PROCESS | 15302 | |i|pagename|runs| 01:19:00 INFO - PROCESS | 15302 | |0;dojo.html;3215.1319143831165;3255.1048461673045;3296.917577060575;3315.436375816111;3346.9330613387733;5355.08963476209;5376.086065368887;5376.301080859493;5378.381486129097;5407.972485227809;5380.435054319299;5385.649932754368;5403.540699040576;5427.891442171154;5437.048516509615;4776.164171270031;4896.92654610182;4981.651284410093;5013.849584512471;5097.515736005073;4780.450248221464;4830.396200474941;4928.186849169882;4965.006998600276;4983.003399320132;4672.252439609663;4769;4800.8319708810195;4913.3612630358;4940.357753492041;4809.855704328876;4939.333190019337;4963.280324352984;4976.701397916118;4994.325766021595;4815.398075240595;4824.879378015543;4843.975780121112;4854.732989685566;4865.756712164413;5111.642185047048;5147.433782283946;5151.330327057459;5170.353705786777;5222.712750798704;5599.216109744639;5604.747786349624;5610.438956104398;5613.298337707786;5626.915596266059;5617.269754931874;5621.437856214346;5697.544196464273;5822;5825.9417405825825;5293.708846013467;5306.044911915815;5312.574994000471;5318.840434786924;5327.627066105374;5714.828555143353;5747.540196784247;5781.421857814269;5787.855303617359;5806.883862322815;5521.944780552143;5629.7185140742795;5710.971445142831;5728.828135155952;5729;5771.711414429262;5774.653520788766;5810.244668193108;5820.3888591698105;5821.359650438449;5577.553795696415;5710.942890571041;5765.509931655773;5769;5783.045797443375;5723.284589426322;5755.165501002415;5772.336181339116;5776.96014717355;5794.072948328248;4305.31115021595;4335.978320108379;4339.327404252346;4343.543927887589;4371.650267978554;3824.0822202671156;3899.0447340401215;3901.804909754501;3904.941425878614;3924.843006279717;5489.231507588941;5531.197976293415;5532.446755324436;5533.9485497755295;5574.1917421973585;5810.738516766671;5825.38833422493;5838.4453476919625;5838.591298609056;5842.065269556851;5313.973430132902;5424.969255841377;5541.806036788774;5543.334799824047;5556.6943818089585;4871.48849370811;4892.608591312757;4896.46138924718;4898.681585696918;4905.460399356068;5918.704064796829;5937.168796368512;5937.228160339128;5942.6731529766275;5946.959282125611;5494.2857428534035;5654.095344744821;5669.773209071591;5707.657540547414;5759.539236861125;6030.7889223876955;6081.6351018939;6092.8781424372155;6097.4817140543555;6102.1762062122825;5710.743016564347;5737.9139312911175;5741.62679425836;5741.827745167651;5745.166950792195;5597.44025597437;5728.570357223308;5783.334916484658;5807.157962095557;5826.8928903508195;5654.46282603152;5661.0659241226385;5681.744321505625;5689.317281926195;5703.372629010722;5469.042917489503;5620.775168993195;5626;5641.633293835887;5649.039663257338;5417.295751552273;5453.209284653783;5470.480304371078;5472.042392581203;5482.5613950883035;5510.448955104457;5546.889062218653;5549.7780088796;5559.63862348946;5591.412901645432;5387.218853266333;5440.694233383881;5489.094299440548;5490.533304669148;5564.10974244119 01:19:00 INFO - PROCESS | 15302 | |1;ext.html;593.4510577715612;625.9092431597421;634.2895956528688;648.8702259548089;650.7657243392377;32079.19802004951;37435.43846842296;39947.80026099866;39976.60023399762;40001.19997600046;42773.075211615476;43428;43515.78242108785;43593;43689.34465983005;7831.530108193527;8770.780730481725;8958.641654333851;8984.910150898506;10387.792244155113;10522.473876306192;10534.26260161789;10658.413787241698;10677.466126693673;10682.893171068268;10660.040596346327;10797.83803242952;10801.459927003658;10843.295185812936;10868.67393978182;10567.313124646873;10649.84025239622;10654.946725266364;10689.786204275872;10727.195460340507;10466.842997355046;10573.9471302643;10611.628592999208;10878.891211087866;10924.836127458095;43362.34956475655;43599.12801743947;43950.340744888854;43965.560344396785;44221.55778442207;3825.1393436476847;3933.6853051755793;3986.5016872890887;4247.171801498709;4652.116097941414;33548;34036.48945265823;34070.48894266588;34419.31161376784;35381.29237415263;4452.1986042512335;4521.570450807168;4555.954440455586;4604.194266003469;4643.9767801161115;380185;381016;381301;382084.9999999972;384126;38826.80586597049;39307.80346098309;55532.88934221374;55964;56464.43535564674;37507.49970001224;37534.62465375311;37602;37695.81152094277;37747.433788493196;16060.19699015068;16206.837931620534;16236.18819059066;16297.266623001757;16308.429204977769;12570.182938108994;13575.66060848467;13800;14092.295385230902;14135;9078.455292682329;9163.450192988443;9196.724098277062;9207;9238.769030774285;3495.4407294832704;3572.267685124595;3595.586507551665;3604.116991337087;3630.8729194478065;1074.6346242277664;1120.4285814234636;1143.2168964259508;1149.3104137517423;1214.1440284599337;32680.67319326776;32713.18217044593;32725.345493090004;33306;34253.14367140841;1215.471269997554;1220.713132413882;1249.7125661097816;1252.380071864433;1317.0714646174424;16798.146631782653;17288.913555432144;17544.649107018042;17687.73468397975;17775.377861775036;511011;514173;514378;518235;519036;63327;63681.68159159175;63903;64021.679891600244;64125;1344.2942455210896;1506.8493150685063;1521.2621878388973;1540.3992442947035;1594.0435738556773;31083;31898.681013189573;32037.35925281528;32179.35641287208;32257.838710806296;49470.50529494659;49653.50346496489;49781.253281200086;50013.74993125011;50029.74985125197;309328;316212.02727836405;316360;316770;317098;26509.60235596429;29754.256143596584;29818.509074545753;29902.850485747433;30518.389632207676;45078.32382514199;45810.31284530668;45868.31197531973;56496.87006259769;59012.40987590069;40652.3902141474;41909.371359430246;42081.57918420777;42386.36420453634;42615.360769589104;40444.797776010935;41014.79492602637;41172.79413602913;41676;42376.152476950905;43406.78296608497;44034;44451.77774111109;44842.327365090205;44919.32621010753;39945.60054399419;41749.79125104355;42331.7883410581;42570.5742942579;43297.350539741296;30379.544306835858;30466.08601741951;31080.68919310778;31110.688893111685;31434.528482073245 01:19:00 INFO - PROCESS | 15302 | |2;jquery.html;411.68711779047925;413.5471658533906;429.6412495566202;431.6589893983753;441.71950811234876;13913.582592522214;18590.07049647517;19151;19186.232550697972;21027.789722102774;14445.92777036116;18291.817081829176;18314.633707325844;18536.44390668282;18927;5664.150377443396;5673.092305231175;5879.235699359077;5883.23517942669;5892.469677729004;5827.825165245049;5833.445822646841;5844.152597873306;5850.502707269866;5867.530597552207;5698.287714035746;5772.682502462384;5788.27646544182;5821.18503409523;5833.7374818133285;5733.799317023905;5837.824865254007;5866.354700982888;5876;5890.499307558884;5252.159654455307;5286.286351342558;5293.073712100367;5309.389420216686;5331.893362132774;23219;23565.882170589208;24342;24424.145154919494;24520.754792452026;2633.210036988896;2736.6852811926683;2850.987899295741;3089.1504836170006;3096.194989302775;13961.930190348983;14190.361433735507;14456.638584035378;14682.265886705622;14989.850101499063;1911.627232689626;1943.8639295249338;1964.204497178645;2088.3839267416147;2115.7672656007826;76387.23612763856;76528;77372.61313693452;77899.99999999943;79371.6031419845;10723.195760318007;10969.616063437741;11121.888781112086;11132;11245.437728113562;15506.9224653876;15522.611934701723;15553.688926221412;15693.843061569467;15781.28984195691;8178.550179740052;8486.32109431244;8523.232909038092;8596;8603.31173506118;8521.105283945097;8531.872021919677;8535;8598.613062412207;8612.224899759052;4285.400043993844;4819.518048195223;4913.557779799835;4938.333325001151;4951.603871690256;1847.9353222637144;1933.719610656447;1941.39816656834;1961.7253584498183;1967.5769709512524;481.1603751453666;493.1247036510223;976.9853452198223;1063.7500187455942;1079.0935614084208;11260.268082574607;11771.293722376684;12029.338386388657;12080.879191207976;12217.450214740358;478.58124141376294;490.40415894688124;511.7032121369597;515.0805811626229;518.0467938992273;6547.934520654732;6689.264180940093;6702.296258892844;6705.128333316735;6755.2231493378895;490606;515107;524721;525926;533953;93242;96929.51535242419;99263.50368248257;99995;100639.49680251552;482.97826597803186;491.34160225298274;492.6674494716052;494.52278551198265;494.7130664214747;11173;11177.217594768288;11302.208845380745;11381;11418.543258269576;38653;38914.6108538911;39745.40381894216;39963;40319;55404.72297638486;56467.15299270597;56922.7153864228;56934.43065569457;57171;8946.060663630225;9076.863847042432;9218.21645160169;9292.070792920655;9342.39274447186;10638.73403164896;12245.632631021084;12310.630681079581;12477.750444990868;12797.808032879328;10640.574377024832;11607.652982646165;11865.822012669643;11872.881271187178;11891.464884080064;11172.21794474379;11205.991460768244;11450.912163344468;11917;12104.75790484203;11398.20212585111;11962.76074478523;11975.580854670045;11991.22057066288;11997.460114294703;8410.873836892573;8724.563771811258;8795.868061979203;8834.028256891608;8936.329775266751;8739.213470787405;11119.166062545502;11987.820182697093;12347.814782778087;12426.813597796221 01:19:00 INFO - PROCESS | 15302 | |3;mootools.html;1403.9789403158948;1527.4577524978633;1532.2185685300494;1710.90590017549;1857.4613362124985;8078.878816817745;8259.463134896228;8267.669293228264;8272.958635206816;8286.295664868487;8137.837243255131;8277.213664701858;8277.668893244263;8298.419110662257;8304.46021008634;2008.4476768888526;2319.652052192168;2375.798057165143;2380.5476959377747;2400.6759087523137;2327.976720232801;2332.9416764580938;2332.9618319847673;2336;2338.9649155262687;2336.5677349690277;2392.1627430399394;2408.3617841272076;2409.9518009639796;2421.406755344943;1990.8009199080047;2285.725712914444;2340.2628172125724;2353.9411514712097;2353.9529209415714;2323.0707716913203;2326.232343326698;2344.4842134730334;2350.917717879883;2393.748656391089;8523.573821308972;8557.657693692245;8589;8597.312215022783;8655.610497527627;5159;5314.468553144655;5342.866428339284;5354.651947623392;5361.115415956362;3398.2014226656715;3427.8971630851115;3437.364087643794;3459.844307006191;3500.5449291592186;1120.2326406411635;1130.1015692524463;1133.6769020829106;1151.5163631274884;1211.5941159711508;11932.164748467698;11979.101567382395;11993.280403175837;11994.400279985966;12015;4492.303692927601;4502.977485112619;4573.519780423007;4608.124456353282;4641.187792136363;10128.936461671567;10163.237757168243;10186.745331366776;10198.133158681447;10213.74465638365;4668.673192876466;5179;5192.1952097424955;5203.427622961472;5230.267762513251;4582.95417045832;4609.3086037094035;4626.7223966562115;4637.536246375403;4697.4832768395445;4000.459937908345;4017.802257247512;4041.8787436376956;4049.0484736086996;4050.594940505926;1300.07694536878;1308.8363954505687;1312.744014917082;1320.1221187910123;1320.9696436779327;927.0405130689704;936.1901954809177;941.9623215071457;952.309575557729;973.8831340239075;5508.669479831223;5562.110062389998;5630.211770352154;5710.486056254957;5934.673592952429;932.1238036246043;959.3859929645033;1021.3361315145215;1043.2853495355705;1049.5434485998614;3890.844366225376;4039.3335099708806;4042.8584999524874;4080.449139366207;4081.4490043844294;10155.695329140137;10303;10422.739431514272;10442.164626829835;10485.790284194274;10294.073533382032;10301.072903438726;10315.484225788681;10365.429901355497;10393.53229104692;8013.2387423194705;8144.5520496373265;8152.38857085721;8236.464629799044;8307.210814972568;5477.616566840442;5513.9448605513435;5529.170624406372;5605.411431799603;5767.68277744728;9412.105849944244;9450.291228158054;9547.665831695856;9661.033896610283;9702.126808587262;9101.499417532099;9520.952395237979;9522.714318570454;9599.232061435208;9702.805943880941;6727.091842601186;7128.536645118051;7272.272772722897;7286.599237042014;7444.069491313586;7552.848943020999;7583.848323033398;7644.0827100748265;7653.425993050655;7679.193684663253;6865.656717164222;7017.614031228331;7099.148102227766;7103.573785572882;7197.172325182671;7130.928690713234;7145.964270178823;7152.535085219444;7250.528715633467;7255.274472552703;6720.663966801738;6888.965555172393;6945.131858517685;6964.26875178099;6966.268541803038;4885.389326334208;4891.33966914462;4910.803567857389;4924.089043526959;4967.7019378837385;5027.371578552681;5034.748262586929;5040.294358789845;5045.091883460866;5095.490450954875 01:19:00 INFO - PROCESS | 15302 | |4;prototype.html;341.4553786710196;357.42097801561465;357.72812662376595;362.1164358964129;364.48971439984;6137.693115344232;6198.0083186690135;6215.409536094069;6226.875462490748;6246.375362463751;6109.938900610992;6137.171481849949;6137.539684523667;6144.047672610753;6165.16770236018;4537.636989040877;4561.1105834362315;4671.509491503377;4678.204705200124;4682.6019788318035;4643.744594047326;4668.206404911156;4681.74250416227;4689.742064186468;4690.530946905299;4394.231009573328;4599.954000459986;4608.654350923694;4613.884652883671;4615.284630882219;4502.189605870942;4578.473475550321;4586.701864378805;4596.264597664391;4598.126355992367;4002.579729128429;4020.3768415895584;4030.3148464760766;4032.1532478179615;4033.1328764315813;5826.592138550303;5833.404135159855;5834.766609335621;5845.912311315334;5850.3564607893095;5325.893482130375;5326.9612425577025;5336.252924590561;5345.518903298722;5352.91970620441;6398.16823812906;6401.295857455676;6405.839854003687;6424.421802037792;6448.258450278231;4321.049369138785;4418.3593378960195;4433.800478978422;4456.977715111436;4484.394606728115;6606.570572912793;6699.129113215299;6707.128073350434;6745.628990405526;6762.966185169092;4554.4990051094355;4588.655850811202;4598.965232822655;4607.8848028798875;4616.60758835496;4628.745419001987;4642.117997580449;4653.953460465352;4657.138429390574;4659.044895796354;5354.223637572531;5358.892822143535;5365.141577347606;5365.141577347684;5366.248725178478;6227.346128656516;6433.806985790434;6447.967760161169;6455.709493072823;6459.677016149174;1602.6634406774708;1611.315191043825;1619.7408414653598;1625.4392234679017;1635.149722144502;1003.7590978165334;1014.5079636376352;1022.4274406332478;1069.4706120470416;1095.5891540672249;6133.96933015341;6136.447719705158;6173.876522469525;6193.102000209944;6194.566380353332;6604.735810567524;6610.4050635443045;6611.074449577063;6620.073189753439;6670;6259.405356491126;6261.092141639528;6266.780662676784;6274;6282.780102696383;3560.430331147004;3589.9282014359565;3599.046252743025;3604.8377822998027;3608.747387682837;6863.313668633196;6954.860902782018;6957.9304206958295;7010.894836577456;7026.473014523931;6755.560888542229;6789;6806.4554835613035;6851.07510486078;6884.65576721162;7112.25321341262;7121.71513139479;7124.501284910007;7125.857482850314;7149.785506434815;6783.321667833177;6802.897956530557;6805.04729337903;6807.5575087619145;6815.079964204967;6580.144581204413;6675.299093595103;6682;6692.330766923464;6702.83242918931;7005.719771209095;7012.544184627983;7021.508494405342;7028;7045.330693584101;4581.015081757439;4647.628189744744;4653.744044077608;4661.743604101807;4685.273782563708;6690.69891854858;6694.531382803157;6719.630420326929;6728;6734.528582999143;6369.936300636934;6526.759915616018;6552.082708420729;6558;6579.835504112435;6459.257185423737;6462.483001359974;6490.188726409199;6491;6495.512836537184;6362.777302794565;6380.330065343072;6394.433363825892;6429.9678501607195;6440.903386449113;6532.41208291256;6533.444657204001;6555.836104097436;6578.572392794453;6585.078089067439;5711.659854403044;6043.879122417615;6165.876682466415;6399.904001440075;6404.359564043744 01:19:00 INFO - PROCESS | 15302 | |5;yui.html;807.3420162567503;848.4061157189968;912.0696889173043;932.4545141092461;937.6952490440608;14769.70460590789;15036.323365448554;15072.698546029073;15128.621784455394;16064.83935160648;15461;15479.690406191869;15537.22313884307;15544.76682849758;15607.297671604776;712.0600806934848;863.5207459859806;873.8820259264998;893.9240164586018;894.8612964990436;886.1847100667402;887.7780554861284;891.0421297105605;895.7581453007684;896.66375109334;933.9813203735921;934.6541779541545;936.3024546712709;937.6999360204737;939.3847030195199;738;899.1323372945106;923.3444254579223;924.8612708093773;928.3547934185743;676.5534747066912;677.7560078371782;677.8034370032684;681.2370145437093;685.6468918506923;14857.628559286104;14868.107913525224;14883.776743348859;14920.62698432537;14934;13897.305134743223;14212.289385530683;14262;14297.499587514387;14335.211563364011;11983.580574679932;12122.151449398545;12136.635900922898;12465.875341246563;12479.812802807965;4030.8589199378175;4033.3748269018056;4039.899002524931;4082.0611259410207;4104.630583247522;51011.23483147756;53551.732241338934;54116;54718.45281547173;55152;11180.776384472265;11350.772984540263;11359.65921022354;11579.247348922294;11707.239029463228;19637.705434418494;19637.901810490857;20469;20686.379408617766;20707.4823129423;8829.646814127364;8942.374033817701;9006.54967251648;9017.774555636162;9216.262698984065;4852.296417019513;5005.224190250517;5048.495150484922;5051.974740126276;5090.287359769635;3515.6835884770494;3579.8031108288774;3592.856285748541;3600.6579374959338;3613.638636136365;588.9440503152193;662.3012721578781;668.5554106519111;668.8227619680788;711.1643818513227;710.6553321639001;727.1347096954607;752.8644843928035;763.5952944939191;768.1243382543904;9500.857487137699;9551.379160354554;9706.466144361986;9977.501124943868;10210.489475526194;624.687656171914;716.9856602867914;784.5724080376209;811.3063330852154;839.6053854688287;4628.335167613586;4691.272852707836;4693.976530117396;4705.270683044134;4725.314829349725;61938.69030654818;62371.688141559;66777;67179.32820671731;67943;27890.163295101178;27985.440291194063;28146.155615331572;28232.435351292857;28256.85871570629;51583.48416515862;54743.726281369134;55508.72245638746;55688.16467752987;57726.134107988415;9451.858222126537;9462.952685236529;9481.146696797321;9548.665796697082;9567.665131720356;35930.10174745652;37309.25381492409;37668;38694.419583705705;38878.222435551696;49662.50337496579;50435;50690;50800;50833.23750143677;12528.624141275777;12859.357032148542;12926.51345095326;13014.739705206031;13101.148425352321;12611.87388126107;12961.481540738265;13863.930680346533;13891.861081389057;13931.58205253844;10505.789884202426;12501.43743531525;12863.29251891155;13047.28239946812;13101.672458188621;12800.74398512043;12926.741465170831;13308.733825323632;13312.267825269702;13509.527166549124;13166.144200626928;13562.321883905568;13638.454461821417;13703.520376786764;13762.380692868644;10491.895081049091;10553.577856885639;10780.622678206226;10786.622468213574;10907.727306817393;10535.789284214427;10659.200559957879;10716.785664286826;10764;10817.891821081688 01:19:00 INFO - PROCESS | 15302 | __end_tp_report 01:19:00 INFO - PROCESS | 15302 | __start_cc_report 01:19:00 INFO - PROCESS | 15302 | _x_x_mozilla_cycle_collect,731 01:19:00 INFO - PROCESS | 15302 | __end_cc_report 01:19:00 INFO - PROCESS | 15302 | __startTimestamp1463041140361__endTimestamp 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | ------- Summary: start ------- 01:19:00 INFO - PROCESS | 15302 | Number of tests: 6 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | [#0] dojo.html Cycles:165 Average:5330.97 Median:5532.45 stddev:594.86 (10.8%) stddev-sans-first:573.06 01:19:00 INFO - PROCESS | 15302 | Values: 3215.1 3255.1 3296.9 3315.4 3346.9 5355.1 5376.1 5376.3 5378.4 5408.0 5380.4 5385.6 5403.5 5427.9 5437.0 4776.2 4896.9 4981.7 5013.8 5097.5 4780.5 4830.4 4928.2 4965.0 4983.0 4672.3 4769.0 4800.8 4913.4 4940.4 4809.9 4939.3 4963.3 4976.7 4994.3 4815.4 4824.9 4844.0 4854.7 4865.8 5111.6 5147.4 5151.3 5170.4 5222.7 5599.2 5604.7 5610.4 5613.3 5626.9 5617.3 5621.4 5697.5 5822.0 5825.9 5293.7 5306.0 5312.6 5318.8 5327.6 5714.8 5747.5 5781.4 5787.9 5806.9 5521.9 5629.7 5711.0 5728.8 5729.0 5771.7 5774.7 5810.2 5820.4 5821.4 5577.6 5710.9 5765.5 5769.0 5783.0 5723.3 5755.2 5772.3 5777.0 5794.1 4305.3 4336.0 4339.3 4343.5 4371.7 3824.1 3899.0 3901.8 3904.9 3924.8 5489.2 5531.2 5532.4 5533.9 5574.2 5810.7 5825.4 5838.4 5838.6 5842.1 5314.0 5425.0 5541.8 5543.3 5556.7 4871.5 4892.6 4896.5 4898.7 4905.5 5918.7 5937.2 5937.2 5942.7 5947.0 5494.3 5654.1 5669.8 5707.7 5759.5 6030.8 6081.6 6092.9 6097.5 6102.2 5710.7 5737.9 5741.6 5741.8 5745.2 5597.4 5728.6 5783.3 5807.2 5826.9 5654.5 5661.1 5681.7 5689.3 5703.4 5469.0 5620.8 5626.0 5641.6 5649.0 5417.3 5453.2 5470.5 5472.0 5482.6 5510.4 5546.9 5549.8 5559.6 5591.4 5387.2 5440.7 5489.1 5490.5 5564.1 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | [#1] ext.html Cycles:180 Average:56731.55 Median:37648.91 stddev:109190.76 (290.0%) stddev-sans-first:109415.71 01:19:00 INFO - PROCESS | 15302 | Values: 593.5 625.9 634.3 648.9 650.8 32079.2 37435.4 39947.8 39976.6 40001.2 42773.1 43428.0 43515.8 43593.0 43689.3 7831.5 8770.8 8958.6 8984.9 10387.8 10522.5 10534.3 10658.4 10677.5 10682.9 10660.0 10797.8 10801.5 10843.3 10868.7 10567.3 10649.8 10654.9 10689.8 10727.2 10466.8 10573.9 10611.6 10878.9 10924.8 43362.3 43599.1 43950.3 43965.6 44221.6 3825.1 3933.7 3986.5 4247.2 4652.1 33548.0 34036.5 34070.5 34419.3 35381.3 4452.2 4521.6 4556.0 4604.2 4644.0 380185.0 381016.0 381301.0 382085.0 384126.0 38826.8 39307.8 55532.9 55964.0 56464.4 37507.5 37534.6 37602.0 37695.8 37747.4 16060.2 16206.8 16236.2 16297.3 16308.4 12570.2 13575.7 13800.0 14092.3 14135.0 9078.5 9163.5 9196.7 9207.0 9238.8 3495.4 3572.3 3595.6 3604.1 3630.9 1074.6 1120.4 1143.2 1149.3 1214.1 32680.7 32713.2 32725.3 33306.0 34253.1 1215.5 1220.7 1249.7 1252.4 1317.1 16798.1 17288.9 17544.6 17687.7 17775.4 511011.0 514173.0 514378.0 518235.0 519036.0 63327.0 63681.7 63903.0 64021.7 64125.0 1344.3 1506.8 1521.3 1540.4 1594.0 31083.0 31898.7 32037.4 32179.4 32257.8 49470.5 49653.5 49781.3 50013.7 50029.7 309328.0 316212.0 316360.0 316770.0 317098.0 26509.6 29754.3 29818.5 29902.9 30518.4 45078.3 45810.3 45868.3 56496.9 59012.4 40652.4 41909.4 42081.6 42386.4 42615.4 40444.8 41014.8 41172.8 41676.0 42376.2 43406.8 44034.0 44451.8 44842.3 44919.3 39945.6 41749.8 42331.8 42570.6 43297.4 30379.5 30466.1 31080.7 31110.7 31434.5 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | [#2] jquery.html Cycles:180 Average:29347.42 Median:430.65 stddev:85435.84 (19838.8%) stddev-sans-first:85647.88 01:19:00 INFO - PROCESS | 15302 | Values: 411.7 413.5 429.6 431.7 441.7 13913.6 18590.1 19151.0 19186.2 21027.8 14445.9 18291.8 18314.6 18536.4 18927.0 5664.2 5673.1 5879.2 5883.2 5892.5 5827.8 5833.4 5844.2 5850.5 5867.5 5698.3 5772.7 5788.3 5821.2 5833.7 5733.8 5837.8 5866.4 5876.0 5890.5 5252.2 5286.3 5293.1 5309.4 5331.9 23219.0 23565.9 24342.0 24424.1 24520.8 2633.2 2736.7 2851.0 3089.2 3096.2 13961.9 14190.4 14456.6 14682.3 14989.9 1911.6 1943.9 1964.2 2088.4 2115.8 76387.2 76528.0 77372.6 77900.0 79371.6 10723.2 10969.6 11121.9 11132.0 11245.4 15506.9 15522.6 15553.7 15693.8 15781.3 8178.6 8486.3 8523.2 8596.0 8603.3 8521.1 8531.9 8535.0 8598.6 8612.2 4285.4 4819.5 4913.6 4938.3 4951.6 1847.9 1933.7 1941.4 1961.7 1967.6 481.2 493.1 977.0 1063.8 1079.1 11260.3 11771.3 12029.3 12080.9 12217.5 478.6 490.4 511.7 515.1 518.0 6547.9 6689.3 6702.3 6705.1 6755.2 490606.0 515107.0 524721.0 525926.0 533953.0 93242.0 96929.5 99263.5 99995.0 100639.5 483.0 491.3 492.7 494.5 494.7 11173.0 11177.2 11302.2 11381.0 11418.5 38653.0 38914.6 39745.4 39963.0 40319.0 55404.7 56467.2 56922.7 56934.4 57171.0 8946.1 9076.9 9218.2 9292.1 9342.4 10638.7 12245.6 12310.6 12477.8 12797.8 10640.6 11607.7 11865.8 11872.9 11891.5 11172.2 11206.0 11450.9 11917.0 12104.8 11398.2 11962.8 11975.6 11991.2 11997.5 8410.9 8724.6 8795.9 8834.0 8936.3 8739.2 11119.2 11987.8 12347.8 12426.8 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | [#3] mootools.html Cycles:180 Average:5584.67 Median:4901.07 stddev:3097.62 (63.2%) stddev-sans-first:3090.38 01:19:00 INFO - PROCESS | 15302 | Values: 1404.0 1527.5 1532.2 1710.9 1857.5 8078.9 8259.5 8267.7 8273.0 8286.3 8137.8 8277.2 8277.7 8298.4 8304.5 2008.4 2319.7 2375.8 2380.5 2400.7 2328.0 2332.9 2333.0 2336.0 2339.0 2336.6 2392.2 2408.4 2410.0 2421.4 1990.8 2285.7 2340.3 2353.9 2354.0 2323.1 2326.2 2344.5 2350.9 2393.7 8523.6 8557.7 8589.0 8597.3 8655.6 5159.0 5314.5 5342.9 5354.7 5361.1 3398.2 3427.9 3437.4 3459.8 3500.5 1120.2 1130.1 1133.7 1151.5 1211.6 11932.2 11979.1 11993.3 11994.4 12015.0 4492.3 4503.0 4573.5 4608.1 4641.2 10128.9 10163.2 10186.7 10198.1 10213.7 4668.7 5179.0 5192.2 5203.4 5230.3 4583.0 4609.3 4626.7 4637.5 4697.5 4000.5 4017.8 4041.9 4049.0 4050.6 1300.1 1308.8 1312.7 1320.1 1321.0 927.0 936.2 942.0 952.3 973.9 5508.7 5562.1 5630.2 5710.5 5934.7 932.1 959.4 1021.3 1043.3 1049.5 3890.8 4039.3 4042.9 4080.4 4081.4 10155.7 10303.0 10422.7 10442.2 10485.8 10294.1 10301.1 10315.5 10365.4 10393.5 8013.2 8144.6 8152.4 8236.5 8307.2 5477.6 5513.9 5529.2 5605.4 5767.7 9412.1 9450.3 9547.7 9661.0 9702.1 9101.5 9521.0 9522.7 9599.2 9702.8 6727.1 7128.5 7272.3 7286.6 7444.1 7552.8 7583.8 7644.1 7653.4 7679.2 6865.7 7017.6 7099.1 7103.6 7197.2 7130.9 7146.0 7152.5 7250.5 7255.3 6720.7 6889.0 6945.1 6964.3 6966.3 4885.4 4891.3 4910.8 4924.1 4967.7 5027.4 5034.7 5040.3 5045.1 5095.5 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | [#4] prototype.html Cycles:180 Average:5418.35 Median:6169.88 stddev:1653.56 (26.8%) stddev-sans-first:1613.70 01:19:00 INFO - PROCESS | 15302 | Values: 341.5 357.4 357.7 362.1 364.5 6137.7 6198.0 6215.4 6226.9 6246.4 6109.9 6137.2 6137.5 6144.0 6165.2 4537.6 4561.1 4671.5 4678.2 4682.6 4643.7 4668.2 4681.7 4689.7 4690.5 4394.2 4600.0 4608.7 4613.9 4615.3 4502.2 4578.5 4586.7 4596.3 4598.1 4002.6 4020.4 4030.3 4032.2 4033.1 5826.6 5833.4 5834.8 5845.9 5850.4 5325.9 5327.0 5336.3 5345.5 5352.9 6398.2 6401.3 6405.8 6424.4 6448.3 4321.0 4418.4 4433.8 4457.0 4484.4 6606.6 6699.1 6707.1 6745.6 6763.0 4554.5 4588.7 4599.0 4607.9 4616.6 4628.7 4642.1 4654.0 4657.1 4659.0 5354.2 5358.9 5365.1 5365.1 5366.2 6227.3 6433.8 6448.0 6455.7 6459.7 1602.7 1611.3 1619.7 1625.4 1635.1 1003.8 1014.5 1022.4 1069.5 1095.6 6134.0 6136.4 6173.9 6193.1 6194.6 6604.7 6610.4 6611.1 6620.1 6670.0 6259.4 6261.1 6266.8 6274.0 6282.8 3560.4 3589.9 3599.0 3604.8 3608.7 6863.3 6954.9 6957.9 7010.9 7026.5 6755.6 6789.0 6806.5 6851.1 6884.7 7112.3 7121.7 7124.5 7125.9 7149.8 6783.3 6802.9 6805.0 6807.6 6815.1 6580.1 6675.3 6682.0 6692.3 6702.8 7005.7 7012.5 7021.5 7028.0 7045.3 4581.0 4647.6 4653.7 4661.7 4685.3 6690.7 6694.5 6719.6 6728.0 6734.5 6369.9 6526.8 6552.1 6558.0 6579.8 6459.3 6462.5 6490.2 6491.0 6495.5 6362.8 6380.3 6394.4 6430.0 6440.9 6532.4 6533.4 6555.8 6578.6 6585.1 5711.7 6043.9 6165.9 6399.9 6404.4 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - PROCESS | 15302 | [#5] yui.html Cycles:180 Average:14828.31 Median:4366.48 stddev:16758.39 (383.8%) stddev-sans-first:16772.32 01:19:00 INFO - PROCESS | 15302 | Values: 807.3 848.4 912.1 932.5 937.7 14769.7 15036.3 15072.7 15128.6 16064.8 15461.0 15479.7 15537.2 15544.8 15607.3 712.1 863.5 873.9 893.9 894.9 886.2 887.8 891.0 895.8 896.7 934.0 934.7 936.3 937.7 939.4 738.0 899.1 923.3 924.9 928.4 676.6 677.8 677.8 681.2 685.6 14857.6 14868.1 14883.8 14920.6 14934.0 13897.3 14212.3 14262.0 14297.5 14335.2 11983.6 12122.2 12136.6 12465.9 12479.8 4030.9 4033.4 4039.9 4082.1 4104.6 51011.2 53551.7 54116.0 54718.5 55152.0 11180.8 11350.8 11359.7 11579.2 11707.2 19637.7 19637.9 20469.0 20686.4 20707.5 8829.6 8942.4 9006.5 9017.8 9216.3 4852.3 5005.2 5048.5 5052.0 5090.3 3515.7 3579.8 3592.9 3600.7 3613.6 588.9 662.3 668.6 668.8 711.2 710.7 727.1 752.9 763.6 768.1 9500.9 9551.4 9706.5 9977.5 10210.5 624.7 717.0 784.6 811.3 839.6 4628.3 4691.3 4694.0 4705.3 4725.3 61938.7 62371.7 66777.0 67179.3 67943.0 27890.2 27985.4 28146.2 28232.4 28256.9 51583.5 54743.7 55508.7 55688.2 57726.1 9451.9 9463.0 9481.1 9548.7 9567.7 35930.1 37309.3 37668.0 38694.4 38878.2 49662.5 50435.0 50690.0 50800.0 50833.2 12528.6 12859.4 12926.5 13014.7 13101.1 12611.9 12961.5 13863.9 13891.9 13931.6 10505.8 12501.4 12863.3 13047.3 13101.7 12800.7 12926.7 13308.7 13312.3 13509.5 13166.1 13562.3 13638.5 13703.5 13762.4 10491.9 10553.6 10780.6 10786.6 10907.7 10535.8 10659.2 10716.8 10764.0 10817.9 01:19:00 INFO - PROCESS | 15302 | -------- Summary: end -------- 01:19:00 INFO - PROCESS | 15302 | 01:19:00 INFO - TEST-INFO | 15302: exit 0 01:19:00 INFO - TEST-OK | dromaeo_css | took 1108531ms 01:19:00 INFO - TEST-START | kraken 01:19:00 INFO - operating with platform_type : linux_ 01:19:00 INFO - Initialising browser for kraken test... 01:19:00 INFO - TEST-INFO | started process 15494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzWa9L/profile http://localhost:42488/getInfo.html) 01:19:04 INFO - PROCESS | 15494 | __metrics Screen width/height:1600/1200 01:19:04 INFO - PROCESS | 15494 | colorDepth:24 01:19:04 INFO - PROCESS | 15494 | Browser inner width/height: 1024/697 01:19:04 INFO - PROCESS | 15494 | __metrics 01:19:04 ERROR - PROCESS | 15494 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:19:05 INFO - TEST-INFO | 15494: exit 0 01:19:05 INFO - Browser initialized. 01:19:05 INFO - Running cycle 1/1 for kraken test... 01:19:05 INFO - TEST-INFO | started process 15589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzWa9L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:19:16 INFO - PROCESS | 15589 | RSS: Main: 141332480 01:19:16 INFO - PROCESS | 15589 | 01:19:19 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42488/tests/kraken/driver.html?testName=audio-beat-detection) 01:19:20 INFO - PROCESS | 15589 | RSS: Main: 195231744 01:19:20 INFO - PROCESS | 15589 | 01:19:22 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42488/tests/kraken/driver.html?testName=audio-dft) 01:19:23 INFO - PROCESS | 15589 | RSS: Main: 181473280 01:19:23 INFO - PROCESS | 15589 | 01:19:26 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42488/tests/kraken/driver.html?testName=audio-fft) 01:19:26 INFO - PROCESS | 15589 | RSS: Main: 272224256 01:19:26 INFO - PROCESS | 15589 | 01:19:28 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42488/tests/kraken/driver.html?testName=audio-oscillator) 01:19:29 INFO - PROCESS | 15589 | RSS: Main: 177827840 01:19:29 INFO - PROCESS | 15589 | 01:19:31 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:19:32 INFO - PROCESS | 15589 | RSS: Main: 176893952 01:19:32 INFO - PROCESS | 15589 | 01:19:35 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42488/tests/kraken/driver.html?testName=imaging-darkroom) 01:19:35 INFO - PROCESS | 15589 | RSS: Main: 211877888 01:19:35 INFO - PROCESS | 15589 | 01:19:39 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42488/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:39 INFO - PROCESS | 15589 | RSS: Main: 212033536 01:19:39 INFO - PROCESS | 15589 | 01:19:42 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42488/tests/kraken/driver.html?testName=json-parse-financial) 01:19:43 INFO - PROCESS | 15589 | RSS: Main: 211390464 01:19:43 INFO - PROCESS | 15589 | 01:19:44 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:19:45 INFO - PROCESS | 15589 | RSS: Main: 191303680 01:19:45 INFO - PROCESS | 15589 | 01:19:46 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:19:47 INFO - PROCESS | 15589 | RSS: Main: 194535424 01:19:47 INFO - PROCESS | 15589 | 01:19:49 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:19:49 INFO - PROCESS | 15589 | RSS: Main: 209309696 01:19:49 INFO - PROCESS | 15589 | 01:19:52 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:19:52 INFO - PROCESS | 15589 | RSS: Main: 214425600 01:19:52 INFO - PROCESS | 15589 | 01:19:55 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:19:56 INFO - PROCESS | 15589 | RSS: Main: 212393984 01:19:56 INFO - PROCESS | 15589 | 01:19:57 INFO - PROCESS | 15589 | Cycle 1(1): loaded http://localhost:42488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42488/tests/kraken/driver.html?testName=ai-astar) 01:19:58 INFO - PROCESS | 15589 | RSS: Main: 276729856 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | __start_tp_report 01:19:58 INFO - PROCESS | 15589 | _x_x_mozilla_page_load 01:19:58 INFO - PROCESS | 15589 | _x_x_mozilla_page_load_details 01:19:58 INFO - PROCESS | 15589 | |i|pagename|runs| 01:19:58 INFO - PROCESS | 15589 | |0;ai-astar;114;114;114;113;113;116;109;112;113;114 01:19:58 INFO - PROCESS | 15589 | |1;audio-beat-detection;153;135;159;182;131;154;161;139;188;131 01:19:58 INFO - PROCESS | 15589 | |2;audio-dft;163;164;165;163;164;164;162;162;162;162 01:19:58 INFO - PROCESS | 15589 | |3;audio-fft;77;75;75;175;78;73;79;77;162;77 01:19:58 INFO - PROCESS | 15589 | |4;audio-oscillator;93;95;144;94;93;94;144;94;94;141 01:19:58 INFO - PROCESS | 15589 | |5;imaging-gaussian-blur;118;118;118;118;118;119;119;118;117;117 01:19:58 INFO - PROCESS | 15589 | |6;imaging-darkroom;148;149;148;149;148;148;149;147;147;147 01:19:58 INFO - PROCESS | 15589 | |7;imaging-desaturate;97;96;96;97;95;97;96;97;95;95 01:19:58 INFO - PROCESS | 15589 | |8;json-parse-financial;53;54;54;54;55;54;54;70;51;52 01:19:58 INFO - PROCESS | 15589 | |9;json-stringify-tinderbox;57;64;58;58;59;58;57;58;58;58 01:19:58 INFO - PROCESS | 15589 | |10;stanford-crypto-aes;77;75;76;76;85;78;77;75;78;77 01:19:58 INFO - PROCESS | 15589 | |11;stanford-crypto-ccm;122;122;116;121;131;118;127;131;131;143 01:19:58 INFO - PROCESS | 15589 | |12;stanford-crypto-pbkdf2;163;162;160;161;165;163;170;159;160;159 01:19:58 INFO - PROCESS | 15589 | |13;stanford-crypto-sha256-iterative;69;67;65;68;66;65;68;70;68;63 01:19:58 INFO - PROCESS | 15589 | __end_tp_report 01:19:58 INFO - PROCESS | 15589 | __start_cc_report 01:19:58 INFO - PROCESS | 15589 | _x_x_mozilla_cycle_collect,1464 01:19:58 INFO - PROCESS | 15589 | __end_cc_report 01:19:58 INFO - PROCESS | 15589 | __startTimestamp1463041198079__endTimestamp 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | ------- Summary: start ------- 01:19:58 INFO - PROCESS | 15589 | Number of tests: 14 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 01:19:58 INFO - PROCESS | 15589 | Values: 114.0 114.0 114.0 113.0 113.0 116.0 109.0 112.0 113.0 114.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:156.50 stddev:20.15 (12.9%) stddev-sans-first:21.37 01:19:58 INFO - PROCESS | 15589 | Values: 153.0 135.0 159.0 182.0 131.0 154.0 161.0 139.0 188.0 131.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 01:19:58 INFO - PROCESS | 15589 | Values: 163.0 164.0 165.0 163.0 164.0 164.0 162.0 162.0 162.0 162.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:39.00 (50.7%) stddev-sans-first:40.83 01:19:58 INFO - PROCESS | 15589 | Values: 77.0 75.0 75.0 175.0 78.0 73.0 79.0 77.0 162.0 77.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:94.00 stddev:23.76 (25.3%) stddev-sans-first:24.52 01:19:58 INFO - PROCESS | 15589 | Values: 93.0 95.0 144.0 94.0 93.0 94.0 144.0 94.0 94.0 141.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 01:19:58 INFO - PROCESS | 15589 | Values: 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 117.0 117.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 01:19:58 INFO - PROCESS | 15589 | Values: 148.0 149.0 148.0 149.0 148.0 148.0 149.0 147.0 147.0 147.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.50 stddev:0.88 (0.9%) stddev-sans-first:0.87 01:19:58 INFO - PROCESS | 15589 | Values: 97.0 96.0 96.0 97.0 95.0 97.0 96.0 97.0 95.0 95.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:5.36 (9.9%) stddev-sans-first:5.63 01:19:58 INFO - PROCESS | 15589 | Values: 53.0 54.0 54.0 54.0 55.0 54.0 54.0 70.0 51.0 52.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:2.01 (3.5%) stddev-sans-first:2.06 01:19:58 INFO - PROCESS | 15589 | Values: 57.0 64.0 58.0 58.0 59.0 58.0 57.0 58.0 58.0 58.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.00 stddev:2.88 (3.7%) stddev-sans-first:3.05 01:19:58 INFO - PROCESS | 15589 | Values: 77.0 75.0 76.0 76.0 85.0 78.0 77.0 75.0 78.0 77.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:129.00 stddev:8.07 (6.3%) stddev-sans-first:8.41 01:19:58 INFO - PROCESS | 15589 | Values: 122.0 122.0 116.0 121.0 131.0 118.0 127.0 131.0 131.0 143.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:3.36 (2.1%) stddev-sans-first:3.55 01:19:58 INFO - PROCESS | 15589 | Values: 163.0 162.0 160.0 161.0 165.0 163.0 170.0 159.0 160.0 159.0 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - PROCESS | 15589 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:68.00 stddev:2.13 (3.1%) stddev-sans-first:2.12 01:19:58 INFO - PROCESS | 15589 | Values: 69.0 67.0 65.0 68.0 66.0 65.0 68.0 70.0 68.0 63.0 01:19:58 INFO - PROCESS | 15589 | -------- Summary: end -------- 01:19:58 INFO - PROCESS | 15589 | 01:19:58 INFO - TEST-INFO | 15589: exit 0 01:19:58 INFO - TEST-OK | kraken | took 57914ms 01:19:58 INFO - SUITE-END | took 1166s 01:19:59 INFO - Completed test suite (00:19:26) 01:19:59 INFO - javascript benchmark 01:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.1319143831165, 3255.1048461673045, 3296.917577060575, 3315.436375816111, 3346.9330613387733, 5355.08963476209, 5376.086065368887, 5376.301080859493, 5378.381486129097, 5407.972485227809, 5380.435054319299, 5385.649932754368, 5403.540699040576, 5427.891442171154, 5437.048516509615, 4776.164171270031, 4896.92654610182, 4981.651284410093, 5013.849584512471, 5097.515736005073, 4780.450248221464, 4830.396200474941, 4928.186849169882, 4965.006998600276, 4983.003399320132, 4672.252439609663, 4769.0, 4800.8319708810195, 4913.3612630358, 4940.357753492041, 4809.855704328876, 4939.333190019337, 4963.280324352984, 4976.701397916118, 4994.325766021595, 4815.398075240595, 4824.879378015543, 4843.975780121112, 4854.732989685566, 4865.756712164413, 5111.642185047048, 5147.433782283946, 5151.330327057459, 5170.353705786777, 5222.712750798704, 5599.216109744639, 5604.747786349624, 5610.438956104398, 5613.298337707786, 5626.915596266059, 5617.269754931874, 5621.437856214346, 5697.544196464273, 5822.0, 5825.9417405825825, 5293.708846013467, 5306.044911915815, 5312.574994000471, 5318.840434786924, 5327.627066105374, 5714.828555143353, 5747.540196784247, 5781.421857814269, 5787.855303617359, 5806.883862322815, 5521.944780552143, 5629.7185140742795, 5710.971445142831, 5728.828135155952, 5729.0, 5771.711414429262, 5774.653520788766, 5810.244668193108, 5820.3888591698105, 5821.359650438449, 5577.553795696415, 5710.942890571041, 5765.509931655773, 5769.0, 5783.045797443375, 5723.284589426322, 5755.165501002415, 5772.336181339116, 5776.96014717355, 5794.072948328248, 4305.31115021595, 4335.978320108379, 4339.327404252346, 4343.543927887589, 4371.650267978554, 3824.0822202671156, 3899.0447340401215, 3901.804909754501, 3904.941425878614, 3924.843006279717, 5489.231507588941, 5531.197976293415, 5532.446755324436, 5533.9485497755295, 5574.1917421973585, 5810.738516766671, 5825.38833422493, 5838.4453476919625, 5838.591298609056, 5842.065269556851, 5313.973430132902, 5424.969255841377, 5541.806036788774, 5543.334799824047, 5556.6943818089585, 4871.48849370811, 4892.608591312757, 4896.46138924718, 4898.681585696918, 4905.460399356068, 5918.704064796829, 5937.168796368512, 5937.228160339128, 5942.6731529766275, 5946.959282125611, 5494.2857428534035, 5654.095344744821, 5669.773209071591, 5707.657540547414, 5759.539236861125, 6030.7889223876955, 6081.6351018939, 6092.8781424372155, 6097.4817140543555, 6102.1762062122825, 5710.743016564347, 5737.9139312911175, 5741.62679425836, 5741.827745167651, 5745.166950792195, 5597.44025597437, 5728.570357223308, 5783.334916484658, 5807.157962095557, 5826.8928903508195, 5654.46282603152, 5661.0659241226385, 5681.744321505625, 5689.317281926195, 5703.372629010722, 5469.042917489503, 5620.775168993195, 5626.0, 5641.633293835887, 5649.039663257338, 5417.295751552273, 5453.209284653783, 5470.480304371078, 5472.042392581203, 5482.5613950883035, 5510.448955104457, 5546.889062218653, 5549.7780088796, 5559.63862348946, 5591.412901645432, 5387.218853266333, 5440.694233383881, 5489.094299440548, 5490.533304669148, 5564.10974244119], "value": 5292.6300519751085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4510577715612, 625.9092431597421, 634.2895956528688, 648.8702259548089, 650.7657243392377, 32079.19802004951, 37435.43846842296, 39947.80026099866, 39976.60023399762, 40001.19997600046, 42773.075211615476, 43428.0, 43515.78242108785, 43593.0, 43689.34465983005, 7831.530108193527, 8770.780730481725, 8958.641654333851, 8984.910150898506, 10387.792244155113, 10522.473876306192, 10534.26260161789, 10658.413787241698, 10677.466126693673, 10682.893171068268, 10660.040596346327, 10797.83803242952, 10801.459927003658, 10843.295185812936, 10868.67393978182, 10567.313124646873, 10649.84025239622, 10654.946725266364, 10689.786204275872, 10727.195460340507, 10466.842997355046, 10573.9471302643, 10611.628592999208, 10878.891211087866, 10924.836127458095, 43362.34956475655, 43599.12801743947, 43950.340744888854, 43965.560344396785, 44221.55778442207, 3825.1393436476847, 3933.6853051755793, 3986.5016872890887, 4247.171801498709, 4652.116097941414, 33548.0, 34036.48945265823, 34070.48894266588, 34419.31161376784, 35381.29237415263, 4452.1986042512335, 4521.570450807168, 4555.954440455586, 4604.194266003469, 4643.9767801161115, 380185.0, 381016.0, 381301.0, 382084.9999999972, 384126.0, 38826.80586597049, 39307.80346098309, 55532.88934221374, 55964.0, 56464.43535564674, 37507.49970001224, 37534.62465375311, 37602.0, 37695.81152094277, 37747.433788493196, 16060.19699015068, 16206.837931620534, 16236.18819059066, 16297.266623001757, 16308.429204977769, 12570.182938108994, 13575.66060848467, 13800.0, 14092.295385230902, 14135.0, 9078.455292682329, 9163.450192988443, 9196.724098277062, 9207.0, 9238.769030774285, 3495.4407294832704, 3572.267685124595, 3595.586507551665, 3604.116991337087, 3630.8729194478065, 1074.6346242277664, 1120.4285814234636, 1143.2168964259508, 1149.3104137517423, 1214.1440284599337, 32680.67319326776, 32713.18217044593, 32725.345493090004, 33306.0, 34253.14367140841, 1215.471269997554, 1220.713132413882, 1249.7125661097816, 1252.380071864433, 1317.0714646174424, 16798.146631782653, 17288.913555432144, 17544.649107018042, 17687.73468397975, 17775.377861775036, 511011.0, 514173.0, 514378.0, 518235.0, 519036.0, 63327.0, 63681.68159159175, 63903.0, 64021.679891600244, 64125.0, 1344.2942455210896, 1506.8493150685063, 1521.2621878388973, 1540.3992442947035, 1594.0435738556773, 31083.0, 31898.681013189573, 32037.35925281528, 32179.35641287208, 32257.838710806296, 49470.50529494659, 49653.50346496489, 49781.253281200086, 50013.74993125011, 50029.74985125197, 309328.0, 316212.02727836405, 316360.0, 316770.0, 317098.0, 26509.60235596429, 29754.256143596584, 29818.509074545753, 29902.850485747433, 30518.389632207676, 45078.32382514199, 45810.31284530668, 45868.31197531973, 56496.87006259769, 59012.40987590069, 40652.3902141474, 41909.371359430246, 42081.57918420777, 42386.36420453634, 42615.360769589104, 40444.797776010935, 41014.79492602637, 41172.79413602913, 41676.0, 42376.152476950905, 43406.78296608497, 44034.0, 44451.77774111109, 44842.327365090205, 44919.32621010753, 39945.60054399419, 41749.79125104355, 42331.7883410581, 42570.5742942579, 43297.350539741296, 30379.544306835858, 30466.08601741951, 31080.68919310778, 31110.688893111685, 31434.528482073245], "value": 19857.753950585306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.68711779047925, 413.5471658533906, 429.6412495566202, 431.6589893983753, 441.71950811234876, 13913.582592522214, 18590.07049647517, 19151.0, 19186.232550697972, 21027.789722102774, 14445.92777036116, 18291.817081829176, 18314.633707325844, 18536.44390668282, 18927.0, 5664.150377443396, 5673.092305231175, 5879.235699359077, 5883.23517942669, 5892.469677729004, 5827.825165245049, 5833.445822646841, 5844.152597873306, 5850.502707269866, 5867.530597552207, 5698.287714035746, 5772.682502462384, 5788.27646544182, 5821.18503409523, 5833.7374818133285, 5733.799317023905, 5837.824865254007, 5866.354700982888, 5876.0, 5890.499307558884, 5252.159654455307, 5286.286351342558, 5293.073712100367, 5309.389420216686, 5331.893362132774, 23219.0, 23565.882170589208, 24342.0, 24424.145154919494, 24520.754792452026, 2633.210036988896, 2736.6852811926683, 2850.987899295741, 3089.1504836170006, 3096.194989302775, 13961.930190348983, 14190.361433735507, 14456.638584035378, 14682.265886705622, 14989.850101499063, 1911.627232689626, 1943.8639295249338, 1964.204497178645, 2088.3839267416147, 2115.7672656007826, 76387.23612763856, 76528.0, 77372.61313693452, 77899.99999999943, 79371.6031419845, 10723.195760318007, 10969.616063437741, 11121.888781112086, 11132.0, 11245.437728113562, 15506.9224653876, 15522.611934701723, 15553.688926221412, 15693.843061569467, 15781.28984195691, 8178.550179740052, 8486.32109431244, 8523.232909038092, 8596.0, 8603.31173506118, 8521.105283945097, 8531.872021919677, 8535.0, 8598.613062412207, 8612.224899759052, 4285.400043993844, 4819.518048195223, 4913.557779799835, 4938.333325001151, 4951.603871690256, 1847.9353222637144, 1933.719610656447, 1941.39816656834, 1961.7253584498183, 1967.5769709512524, 481.1603751453666, 493.1247036510223, 976.9853452198223, 1063.7500187455942, 1079.0935614084208, 11260.268082574607, 11771.293722376684, 12029.338386388657, 12080.879191207976, 12217.450214740358, 478.58124141376294, 490.40415894688124, 511.7032121369597, 515.0805811626229, 518.0467938992273, 6547.934520654732, 6689.264180940093, 6702.296258892844, 6705.128333316735, 6755.2231493378895, 490606.0, 515107.0, 524721.0, 525926.0, 533953.0, 93242.0, 96929.51535242419, 99263.50368248257, 99995.0, 100639.49680251552, 482.97826597803186, 491.34160225298274, 492.6674494716052, 494.52278551198265, 494.7130664214747, 11173.0, 11177.217594768288, 11302.208845380745, 11381.0, 11418.543258269576, 38653.0, 38914.6108538911, 39745.40381894216, 39963.0, 40319.0, 55404.72297638486, 56467.15299270597, 56922.7153864228, 56934.43065569457, 57171.0, 8946.060663630225, 9076.863847042432, 9218.21645160169, 9292.070792920655, 9342.39274447186, 10638.73403164896, 12245.632631021084, 12310.630681079581, 12477.750444990868, 12797.808032879328, 10640.574377024832, 11607.652982646165, 11865.822012669643, 11872.881271187178, 11891.464884080064, 11172.21794474379, 11205.991460768244, 11450.912163344468, 11917.0, 12104.75790484203, 11398.20212585111, 11962.76074478523, 11975.580854670045, 11991.22057066288, 11997.460114294703, 8410.873836892573, 8724.563771811258, 8795.868061979203, 8834.028256891608, 8936.329775266751, 8739.213470787405, 11119.166062545502, 11987.820182697093, 12347.814782778087, 12426.813597796221], "value": 8651.798209828345, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.9789403158948, 1527.4577524978633, 1532.2185685300494, 1710.90590017549, 1857.4613362124985, 8078.878816817745, 8259.463134896228, 8267.669293228264, 8272.958635206816, 8286.295664868487, 8137.837243255131, 8277.213664701858, 8277.668893244263, 8298.419110662257, 8304.46021008634, 2008.4476768888526, 2319.652052192168, 2375.798057165143, 2380.5476959377747, 2400.6759087523137, 2327.976720232801, 2332.9416764580938, 2332.9618319847673, 2336.0, 2338.9649155262687, 2336.5677349690277, 2392.1627430399394, 2408.3617841272076, 2409.9518009639796, 2421.406755344943, 1990.8009199080047, 2285.725712914444, 2340.2628172125724, 2353.9411514712097, 2353.9529209415714, 2323.0707716913203, 2326.232343326698, 2344.4842134730334, 2350.917717879883, 2393.748656391089, 8523.573821308972, 8557.657693692245, 8589.0, 8597.312215022783, 8655.610497527627, 5159.0, 5314.468553144655, 5342.866428339284, 5354.651947623392, 5361.115415956362, 3398.2014226656715, 3427.8971630851115, 3437.364087643794, 3459.844307006191, 3500.5449291592186, 1120.2326406411635, 1130.1015692524463, 1133.6769020829106, 1151.5163631274884, 1211.5941159711508, 11932.164748467698, 11979.101567382395, 11993.280403175837, 11994.400279985966, 12015.0, 4492.303692927601, 4502.977485112619, 4573.519780423007, 4608.124456353282, 4641.187792136363, 10128.936461671567, 10163.237757168243, 10186.745331366776, 10198.133158681447, 10213.74465638365, 4668.673192876466, 5179.0, 5192.1952097424955, 5203.427622961472, 5230.267762513251, 4582.95417045832, 4609.3086037094035, 4626.7223966562115, 4637.536246375403, 4697.4832768395445, 4000.459937908345, 4017.802257247512, 4041.8787436376956, 4049.0484736086996, 4050.594940505926, 1300.07694536878, 1308.8363954505687, 1312.744014917082, 1320.1221187910123, 1320.9696436779327, 927.0405130689704, 936.1901954809177, 941.9623215071457, 952.309575557729, 973.8831340239075, 5508.669479831223, 5562.110062389998, 5630.211770352154, 5710.486056254957, 5934.673592952429, 932.1238036246043, 959.3859929645033, 1021.3361315145215, 1043.2853495355705, 1049.5434485998614, 3890.844366225376, 4039.3335099708806, 4042.8584999524874, 4080.449139366207, 4081.4490043844294, 10155.695329140137, 10303.0, 10422.739431514272, 10442.164626829835, 10485.790284194274, 10294.073533382032, 10301.072903438726, 10315.484225788681, 10365.429901355497, 10393.53229104692, 8013.2387423194705, 8144.5520496373265, 8152.38857085721, 8236.464629799044, 8307.210814972568, 5477.616566840442, 5513.9448605513435, 5529.170624406372, 5605.411431799603, 5767.68277744728, 9412.105849944244, 9450.291228158054, 9547.665831695856, 9661.033896610283, 9702.126808587262, 9101.499417532099, 9520.952395237979, 9522.714318570454, 9599.232061435208, 9702.805943880941, 6727.091842601186, 7128.536645118051, 7272.272772722897, 7286.599237042014, 7444.069491313586, 7552.848943020999, 7583.848323033398, 7644.0827100748265, 7653.425993050655, 7679.193684663253, 6865.656717164222, 7017.614031228331, 7099.148102227766, 7103.573785572882, 7197.172325182671, 7130.928690713234, 7145.964270178823, 7152.535085219444, 7250.528715633467, 7255.274472552703, 6720.663966801738, 6888.965555172393, 6945.131858517685, 6964.26875178099, 6966.268541803038, 4885.389326334208, 4891.33966914462, 4910.803567857389, 4924.089043526959, 4967.7019378837385, 5027.371578552681, 5034.748262586929, 5040.294358789845, 5045.091883460866, 5095.490450954875], "value": 4532.708934151167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.4553786710196, 357.42097801561465, 357.72812662376595, 362.1164358964129, 364.48971439984, 6137.693115344232, 6198.0083186690135, 6215.409536094069, 6226.875462490748, 6246.375362463751, 6109.938900610992, 6137.171481849949, 6137.539684523667, 6144.047672610753, 6165.16770236018, 4537.636989040877, 4561.1105834362315, 4671.509491503377, 4678.204705200124, 4682.6019788318035, 4643.744594047326, 4668.206404911156, 4681.74250416227, 4689.742064186468, 4690.530946905299, 4394.231009573328, 4599.954000459986, 4608.654350923694, 4613.884652883671, 4615.284630882219, 4502.189605870942, 4578.473475550321, 4586.701864378805, 4596.264597664391, 4598.126355992367, 4002.579729128429, 4020.3768415895584, 4030.3148464760766, 4032.1532478179615, 4033.1328764315813, 5826.592138550303, 5833.404135159855, 5834.766609335621, 5845.912311315334, 5850.3564607893095, 5325.893482130375, 5326.9612425577025, 5336.252924590561, 5345.518903298722, 5352.91970620441, 6398.16823812906, 6401.295857455676, 6405.839854003687, 6424.421802037792, 6448.258450278231, 4321.049369138785, 4418.3593378960195, 4433.800478978422, 4456.977715111436, 4484.394606728115, 6606.570572912793, 6699.129113215299, 6707.128073350434, 6745.628990405526, 6762.966185169092, 4554.4990051094355, 4588.655850811202, 4598.965232822655, 4607.8848028798875, 4616.60758835496, 4628.745419001987, 4642.117997580449, 4653.953460465352, 4657.138429390574, 4659.044895796354, 5354.223637572531, 5358.892822143535, 5365.141577347606, 5365.141577347684, 5366.248725178478, 6227.346128656516, 6433.806985790434, 6447.967760161169, 6455.709493072823, 6459.677016149174, 1602.6634406774708, 1611.315191043825, 1619.7408414653598, 1625.4392234679017, 1635.149722144502, 1003.7590978165334, 1014.5079636376352, 1022.4274406332478, 1069.4706120470416, 1095.5891540672249, 6133.96933015341, 6136.447719705158, 6173.876522469525, 6193.102000209944, 6194.566380353332, 6604.735810567524, 6610.4050635443045, 6611.074449577063, 6620.073189753439, 6670.0, 6259.405356491126, 6261.092141639528, 6266.780662676784, 6274.0, 6282.780102696383, 3560.430331147004, 3589.9282014359565, 3599.046252743025, 3604.8377822998027, 3608.747387682837, 6863.313668633196, 6954.860902782018, 6957.9304206958295, 7010.894836577456, 7026.473014523931, 6755.560888542229, 6789.0, 6806.4554835613035, 6851.07510486078, 6884.65576721162, 7112.25321341262, 7121.71513139479, 7124.501284910007, 7125.857482850314, 7149.785506434815, 6783.321667833177, 6802.897956530557, 6805.04729337903, 6807.5575087619145, 6815.079964204967, 6580.144581204413, 6675.299093595103, 6682.0, 6692.330766923464, 6702.83242918931, 7005.719771209095, 7012.544184627983, 7021.508494405342, 7028.0, 7045.330693584101, 4581.015081757439, 4647.628189744744, 4653.744044077608, 4661.743604101807, 4685.273782563708, 6690.69891854858, 6694.531382803157, 6719.630420326929, 6728.0, 6734.528582999143, 6369.936300636934, 6526.759915616018, 6552.082708420729, 6558.0, 6579.835504112435, 6459.257185423737, 6462.483001359974, 6490.188726409199, 6491.0, 6495.512836537184, 6362.777302794565, 6380.330065343072, 6394.433363825892, 6429.9678501607195, 6440.903386449113, 6532.41208291256, 6533.444657204001, 6555.836104097436, 6578.572392794453, 6585.078089067439, 5711.659854403044, 6043.879122417615, 6165.876682466415, 6399.904001440075, 6404.359564043744], "value": 4880.823822767498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.3420162567503, 848.4061157189968, 912.0696889173043, 932.4545141092461, 937.6952490440608, 14769.70460590789, 15036.323365448554, 15072.698546029073, 15128.621784455394, 16064.83935160648, 15461.0, 15479.690406191869, 15537.22313884307, 15544.76682849758, 15607.297671604776, 712.0600806934848, 863.5207459859806, 873.8820259264998, 893.9240164586018, 894.8612964990436, 886.1847100667402, 887.7780554861284, 891.0421297105605, 895.7581453007684, 896.66375109334, 933.9813203735921, 934.6541779541545, 936.3024546712709, 937.6999360204737, 939.3847030195199, 738.0, 899.1323372945106, 923.3444254579223, 924.8612708093773, 928.3547934185743, 676.5534747066912, 677.7560078371782, 677.8034370032684, 681.2370145437093, 685.6468918506923, 14857.628559286104, 14868.107913525224, 14883.776743348859, 14920.62698432537, 14934.0, 13897.305134743223, 14212.289385530683, 14262.0, 14297.499587514387, 14335.211563364011, 11983.580574679932, 12122.151449398545, 12136.635900922898, 12465.875341246563, 12479.812802807965, 4030.8589199378175, 4033.3748269018056, 4039.899002524931, 4082.0611259410207, 4104.630583247522, 51011.23483147756, 53551.732241338934, 54116.0, 54718.45281547173, 55152.0, 11180.776384472265, 11350.772984540263, 11359.65921022354, 11579.247348922294, 11707.239029463228, 19637.705434418494, 19637.901810490857, 20469.0, 20686.379408617766, 20707.4823129423, 8829.646814127364, 8942.374033817701, 9006.54967251648, 9017.774555636162, 9216.262698984065, 4852.296417019513, 5005.224190250517, 5048.495150484922, 5051.974740126276, 5090.287359769635, 3515.6835884770494, 3579.8031108288774, 3592.856285748541, 3600.6579374959338, 3613.638636136365, 588.9440503152193, 662.3012721578781, 668.5554106519111, 668.8227619680788, 711.1643818513227, 710.6553321639001, 727.1347096954607, 752.8644843928035, 763.5952944939191, 768.1243382543904, 9500.857487137699, 9551.379160354554, 9706.466144361986, 9977.501124943868, 10210.489475526194, 624.687656171914, 716.9856602867914, 784.5724080376209, 811.3063330852154, 839.6053854688287, 4628.335167613586, 4691.272852707836, 4693.976530117396, 4705.270683044134, 4725.314829349725, 61938.69030654818, 62371.688141559, 66777.0, 67179.32820671731, 67943.0, 27890.163295101178, 27985.440291194063, 28146.155615331572, 28232.435351292857, 28256.85871570629, 51583.48416515862, 54743.726281369134, 55508.72245638746, 55688.16467752987, 57726.134107988415, 9451.858222126537, 9462.952685236529, 9481.146696797321, 9548.665796697082, 9567.665131720356, 35930.10174745652, 37309.25381492409, 37668.0, 38694.419583705705, 38878.222435551696, 49662.50337496579, 50435.0, 50690.0, 50800.0, 50833.23750143677, 12528.624141275777, 12859.357032148542, 12926.51345095326, 13014.739705206031, 13101.148425352321, 12611.87388126107, 12961.481540738265, 13863.930680346533, 13891.861081389057, 13931.58205253844, 10505.789884202426, 12501.43743531525, 12863.29251891155, 13047.28239946812, 13101.672458188621, 12800.74398512043, 12926.741465170831, 13308.733825323632, 13312.267825269702, 13509.527166549124, 13166.144200626928, 13562.321883905568, 13638.454461821417, 13703.520376786764, 13762.380692868644, 10491.895081049091, 10553.577856885639, 10780.622678206226, 10786.622468213574, 10907.727306817393, 10535.789284214427, 10659.200559957879, 10716.785664286826, 10764.0, 10817.891821081688], "value": 6995.335047807789, "unit": "score"}], "name": "dromaeo_css", "value": 7212.20179974877, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 116.0, 109.0, 112.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 135.0, 159.0, 182.0, 131.0, 154.0, 161.0, 139.0, 188.0, 131.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 163.0, 164.0, 164.0, 162.0, 162.0, 162.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 175.0, 78.0, 73.0, 79.0, 77.0, 162.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 144.0, 94.0, 93.0, 94.0, 144.0, 94.0, 94.0, 141.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 95.0, 97.0, 96.0, 97.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 70.0, 51.0, 52.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 58.0, 58.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 76.0, 85.0, 78.0, 77.0, 75.0, 78.0, 77.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 116.0, 121.0, 131.0, 118.0, 127.0, 131.0, 131.0, 143.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 161.0, 165.0, 163.0, 170.0, 159.0, 160.0, 159.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 68.0, 66.0, 65.0, 68.0, 70.0, 68.0, 63.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1541.4000000000003, "alertThreshold": 2.0}]} 01:19:59 INFO - Return code: 0 01:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:19:59 ERROR - # TBPL SUCCESS # 01:19:59 INFO - Running post-action listener: _resource_record_post_action 01:19:59 INFO - Running post-run listener: _resource_record_post_run 01:20:00 INFO - Total resource usage - Wall time: 1184s; CPU: 25.0%; Read bytes: 4096; Write bytes: 491282432; Read time: 36; Write time: 360044 01:20:00 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 248627200; Read time: 0; Write time: 222040 01:20:00 INFO - run-tests - Wall time: 1168s; CPU: 25.0%; Read bytes: 4096; Write bytes: 242638848; Read time: 36; Write time: 138004 01:20:00 INFO - Running post-run listener: _upload_blobber_files 01:20:00 INFO - Blob upload gear active. 01:20:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:20:00 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 01:20:00 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'] 01:20:00 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 01:20:00 INFO - (blobuploader) - INFO - Open directory for files ... 01:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:01 INFO - (blobuploader) - INFO - Done attempting. 01:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:02 INFO - (blobuploader) - INFO - Done attempting. 01:20:02 INFO - (blobuploader) - INFO - Iteration through files over. 01:20:02 INFO - Return code: 0 01:20:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:20:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:20:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b31c82fa2982b672b7b61ee18d0bb61273805263c9fd421265b8d53014c5853fbbd696ece9b3379858cd06ecf12108644d6c6e9caeb966b68010923df0279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e8ab291394dafde54a05a80c71df7da4f9dc65a5309126119b593b61414515fb75a6204539c6a7ce7422de7ef6a7c7a53b38d28e48944d1baa1c3289a9de90"} 01:20:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:20:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:20:02 INFO - Contents: 01:20:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b31c82fa2982b672b7b61ee18d0bb61273805263c9fd421265b8d53014c5853fbbd696ece9b3379858cd06ecf12108644d6c6e9caeb966b68010923df0279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e8ab291394dafde54a05a80c71df7da4f9dc65a5309126119b593b61414515fb75a6204539c6a7ce7422de7ef6a7c7a53b38d28e48944d1baa1c3289a9de90"} 01:20:02 INFO - Running post-run listener: copy_logs_to_upload_dir 01:20:02 INFO - Copying logs to upload dir... 01:20:02 INFO - mkdir: /builds/slave/test/build/upload/logs 01:20:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.501230 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-12 01:20:01.309971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 01:20:01.314486) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b31c82fa2982b672b7b61ee18d0bb61273805263c9fd421265b8d53014c5853fbbd696ece9b3379858cd06ecf12108644d6c6e9caeb966b68010923df0279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e8ab291394dafde54a05a80c71df7da4f9dc65a5309126119b593b61414515fb75a6204539c6a7ce7422de7ef6a7c7a53b38d28e48944d1baa1c3289a9de90"} build_url:https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005386 build_url: 'https://queue.taskcluster.net/v1/task/cXwa6G47TOaGRmFeq_xxUg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c55b31c82fa2982b672b7b61ee18d0bb61273805263c9fd421265b8d53014c5853fbbd696ece9b3379858cd06ecf12108644d6c6e9caeb966b68010923df0279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e8ab291394dafde54a05a80c71df7da4f9dc65a5309126119b593b61414515fb75a6204539c6a7ce7422de7ef6a7c7a53b38d28e48944d1baa1c3289a9de90"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 01:20:01.337254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 01:20:01.337910) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463039023.583849-20292771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002142 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 01:20:01.417465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 01:20:01.418012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 01:20:01.418590) ========= ========= Total master_lag: 0.18 =========