builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1461866802.04 results: success (0) buildid: 20160428082225 builduid: 9bf6aa59b043478d86198874185c9a49 revision: 070a730a51d3bd2e923f81da9e10633b4d926143 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.037106) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.037510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.037791) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.056823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.057085) ========= 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=82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 11:06:43-- 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% 57.8K=0.2s 2016-04-28 11:06:43 (57.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.316491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.386660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.386979) ========= 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=82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.438191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.438485) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070a730a51d3bd2e923f81da9e10633b4d926143 --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 070a730a51d3bd2e923f81da9e10633b4d926143 --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=82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 11:06:43,844 truncating revision to first 12 chars 2016-04-28 11:06:43,844 Setting DEBUG logging. 2016-04-28 11:06:43,844 attempt 1/10 2016-04-28 11:06:43,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/070a730a51d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 11:06:44,072 unpacking tar archive at: mozilla-aurora-070a730a51d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.970509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.970842) ========= script_repo_revision: 070a730a51d3bd2e923f81da9e10633b4d926143 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.971245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.971780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 11:06:42.980039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-28 11:06:42.980349) ========= /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=82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:44 INFO - MultiFileLogger online at 20160428 11:06:44 in /builds/slave/test 11:06:44 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 11:06:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:44 INFO - {'append_to_log': False, 11:06:44 INFO - 'base_work_dir': '/builds/slave/test', 11:06:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:06:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:44 INFO - 'branch': 'Mozilla-Aurora', 11:06:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:44 INFO - 'config_files': ('talos/linux_config.py',), 11:06:44 INFO - 'default_actions': ('clobber', 11:06:44 INFO - 'read-buildbot-config', 11:06:44 INFO - 'download-and-extract', 11:06:44 INFO - 'populate-webroot', 11:06:44 INFO - 'create-virtualenv', 11:06:44 INFO - 'install', 11:06:44 INFO - 'run-tests'), 11:06:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:44 INFO - 'download_minidump_stackwalk': True, 11:06:44 INFO - 'download_symbols': 'ondemand', 11:06:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:44 INFO - 'installer_path': 'installer.exe', 11:06:44 INFO - 'log_level': 'info', 11:06:44 INFO - 'log_name': 'talos', 11:06:44 INFO - 'log_to_console': True, 11:06:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:44 INFO - 'opt_config_files': (), 11:06:44 INFO - 'pip_index': False, 11:06:44 INFO - 'sps_profile': False, 11:06:44 INFO - 'sps_profile_interval': 0, 11:06:44 INFO - 'suite': 'dromaeojs', 11:06:44 INFO - 'system_bits': '32', 11:06:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:44 INFO - 'title': 'talos-linux64-ix-055', 11:06:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:44 INFO - 'use_talos_json': True, 11:06:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:44 INFO - 'work_dir': 'build'} 11:06:44 INFO - ##### 11:06:44 INFO - ##### Running clobber step. 11:06:44 INFO - ##### 11:06:44 INFO - Running pre-action listener: _resource_record_pre_action 11:06:44 INFO - Running main action method: clobber 11:06:44 INFO - rmtree: /builds/slave/test/build 11:06:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:45 INFO - Running post-action listener: _resource_record_post_action 11:06:45 INFO - ##### 11:06:45 INFO - ##### Running read-buildbot-config step. 11:06:45 INFO - ##### 11:06:45 INFO - Running pre-action listener: _resource_record_pre_action 11:06:45 INFO - Running main action method: read_buildbot_config 11:06:45 INFO - Using buildbot properties: 11:06:45 INFO - { 11:06:45 INFO - "project": "", 11:06:45 INFO - "product": "firefox", 11:06:45 INFO - "script_repo_revision": "production", 11:06:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:06:45 INFO - "repository": "", 11:06:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:06:45 INFO - "buildid": "20160428082225", 11:06:45 INFO - "stage_platform": "linux64-pgo", 11:06:45 INFO - "basedir": "/builds/slave/test", 11:06:45 INFO - "nightly_build": "True", 11:06:45 INFO - "buildnumber": 476, 11:06:45 INFO - "slavename": "talos-linux64-ix-055", 11:06:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:06:45 INFO - "platform": "ubuntu64_hw", 11:06:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:06:45 INFO - "branch": "mozilla-aurora", 11:06:45 INFO - "repo_path": "releases/mozilla-aurora", 11:06:45 INFO - "revision": "070a730a51d3bd2e923f81da9e10633b4d926143", 11:06:45 INFO - "pgo_build": "True", 11:06:45 INFO - "builduid": "9bf6aa59b043478d86198874185c9a49", 11:06:45 INFO - "slavebuilddir": "test" 11:06:45 INFO - } 11:06:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 11:06:45 INFO - Running post-action listener: _resource_record_post_action 11:06:45 INFO - ##### 11:06:45 INFO - ##### Running download-and-extract step. 11:06:45 INFO - ##### 11:06:45 INFO - Running pre-action listener: _resource_record_pre_action 11:06:45 INFO - Running main action method: download_and_extract 11:06:45 INFO - mkdir: /builds/slave/test/build/tests 11:06:45 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')]} 11:06:45 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:06:51 INFO - Downloaded 1361 bytes. 11:06:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 11:06:51 INFO - Using the following test package requirements: 11:06:51 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:06:51 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:51 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:06:51 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'jsshell-linux-x86_64.zip'], 11:06:51 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:51 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 11:06:51 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:06:51 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:06:51 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:51 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:51 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')]} 11:06:51 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:02 INFO - Downloaded 23821688 bytes. 11:07:02 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'] 11:07:02 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 11:07:03 INFO - Return code: 0 11:07:03 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 11:07: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')]} 11:07:03 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 11:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:05 INFO - Downloaded 23821688 bytes. 11:07:05 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'] 11:07:05 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 11:07:06 INFO - Return code: 0 11:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:06 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 11:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:07 INFO - Downloaded 10840145 bytes. 11:07:07 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'] 11:07:07 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 11:07:07 INFO - Return code: 0 11:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:07 INFO - https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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 11:07:09 INFO - Downloaded 62660962 bytes. 11:07:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:09 INFO - mkdir: /builds/slave/test/properties 11:07:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:09 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:09 INFO - Contents: 11:07:09 INFO - build_url:https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - Running post-action listener: set_extra_try_arguments 11:07:10 INFO - ##### 11:07:10 INFO - ##### Running populate-webroot step. 11:07:10 INFO - ##### 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: populate_webroot 11:07:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:10 INFO - '--tppagecycles', 11:07:10 INFO - '7'], 11:07:10 INFO - 'tests': ['tsvgm']}}, 11:07:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['damp', 'tps']}, 11:07:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'tests': ['damp', 'tps']}, 11:07:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['dromaeo_dom']}, 11:07:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['a11yr', 11:07:10 INFO - 'ts_paint', 11:07:10 INFO - 'tpaint', 11:07:10 INFO - 'sessionrestore', 11:07:10 INFO - 'sessionrestore_no_auto_restore', 11:07:10 INFO - 'tabpaint']}, 11:07:10 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:10 INFO - 'ts_paint', 11:07:10 INFO - 'tpaint', 11:07:10 INFO - 'sessionrestore', 11:07:10 INFO - 'sessionrestore_no_auto_restore', 11:07:10 INFO - 'tabpaint']}, 11:07:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:10 INFO - 'ts_paint', 11:07:10 INFO - 'tpaint', 11:07:10 INFO - 'sessionrestore', 11:07:10 INFO - 'sessionrestore_no_auto_restore', 11:07:10 INFO - 'tabpaint']}, 11:07:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:10 INFO - 'ts_paint', 11:07:10 INFO - 'tpaint', 11:07:10 INFO - 'sessionrestore', 11:07:10 INFO - 'sessionrestore_no_auto_restore', 11:07:10 INFO - 'tabpaint']}, 11:07:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['a11yr', 11:07:10 INFO - 'ts_paint', 11:07:10 INFO - 'tpaint', 11:07:10 INFO - 'sessionrestore', 11:07:10 INFO - 'sessionrestore_no_auto_restore', 11:07:10 INFO - 'tabpaint']}, 11:07:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['a11yr', 11:07:10 INFO - 'ts_paint', 11:07:10 INFO - 'tpaint', 11:07:10 INFO - 'sessionrestore', 11:07:10 INFO - 'sessionrestore_no_auto_restore', 11:07:10 INFO - 'tabpaint']}, 11:07:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['tsvgx', 11:07:10 INFO - 'tsvgr_opacity', 11:07:10 INFO - 'tart', 11:07:10 INFO - 'tscrollx', 11:07:10 INFO - 'cart']}, 11:07:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:10 INFO - 'tsvgr_opacity', 11:07:10 INFO - 'tart', 11:07:10 INFO - 'tscrollx', 11:07:10 INFO - 'cart']}, 11:07:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'talos_options': ['--disable-e10s'], 11:07:10 INFO - 'tests': ['tp5o']}, 11:07:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'tests': ['tp5o']}, 11:07:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'talos_options': ['--disable-e10s', 11:07:10 INFO - '--xperf_path', 11:07:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:10 INFO - 'tests': ['tp5n']}, 11:07:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:10 INFO - 'talos_options': ['--xperf_path', 11:07:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:10 INFO - 'tests': ['tp5n']}}, 11:07:10 INFO - 'talos.zip': {'path': '', 11:07:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - ##### 11:07:10 INFO - ##### Running create-virtualenv step. 11:07:10 INFO - ##### 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: create_virtualenv 11:07:10 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:10 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 11:07:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:10 INFO - Using real prefix '/usr' 11:07:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:11 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:13 INFO - Installing pip.................done. 11:07:13 INFO - Return code: 0 11:07:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:13 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')]} 11:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:13 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')]} 11:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:13 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 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:13 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 11:07:13 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 11:07:13 INFO - Using env: {'DISPLAY': ':0', 11:07:13 INFO - 'HOME': '/home/cltbld', 11:07:13 INFO - 'LANG': 'en_US.UTF-8', 11:07:13 INFO - 'LANGUAGE': 'en_US:en', 11:07:13 INFO - 'LOGNAME': 'cltbld', 11:07:13 INFO - 'MAIL': '/var/mail/cltbld', 11:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:13 INFO - 'MOZ_NO_REMOTE': '1', 11:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:13 INFO - 'NO_EM_RESTART': '1', 11:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:13 INFO - 'PWD': '/builds/slave/test', 11:07:13 INFO - 'SHELL': '/bin/bash', 11:07:13 INFO - 'SHLVL': '1', 11:07:13 INFO - 'TERM': 'linux', 11:07:13 INFO - 'TMOUT': '86400', 11:07:13 INFO - 'USER': 'cltbld', 11:07:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:13 INFO - '_': '/tools/buildbot/bin/python'} 11:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:13 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 11:07:13 INFO - Cleaning up... 11:07:13 INFO - Return code: 0 11:07:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:07:13 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')]} 11:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:13 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')]} 11:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:13 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 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:13 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 11:07:13 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 11:07:13 INFO - Using env: {'DISPLAY': ':0', 11:07:13 INFO - 'HOME': '/home/cltbld', 11:07:13 INFO - 'LANG': 'en_US.UTF-8', 11:07:13 INFO - 'LANGUAGE': 'en_US:en', 11:07:13 INFO - 'LOGNAME': 'cltbld', 11:07:13 INFO - 'MAIL': '/var/mail/cltbld', 11:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:13 INFO - 'MOZ_NO_REMOTE': '1', 11:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:13 INFO - 'NO_EM_RESTART': '1', 11:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:13 INFO - 'PWD': '/builds/slave/test', 11:07:13 INFO - 'SHELL': '/bin/bash', 11:07:13 INFO - 'SHLVL': '1', 11:07:13 INFO - 'TERM': 'linux', 11:07:13 INFO - 'TMOUT': '86400', 11:07:13 INFO - 'USER': 'cltbld', 11:07:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:13 INFO - '_': '/tools/buildbot/bin/python'} 11:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:13 INFO - Downloading/unpacking psutil>=0.7.1 11:07:13 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 11:07:13 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 11:07:13 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 11:07:13 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 11:07:13 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 11:07:13 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 11:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:15 INFO - Installing collected packages: psutil 11:07:15 INFO - Running setup.py install for psutil 11:07:15 INFO - building 'psutil._psutil_linux' extension 11:07:15 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 11:07:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:07:15 INFO - building 'psutil._psutil_posix' extension 11:07:15 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 11:07:16 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 11:07:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:16 INFO - Successfully installed psutil 11:07:16 INFO - Cleaning up... 11:07:16 INFO - Return code: 0 11:07:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:07:16 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')]} 11:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:16 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')]} 11:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:16 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 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:16 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 11:07:16 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 11:07:16 INFO - Using env: {'DISPLAY': ':0', 11:07:16 INFO - 'HOME': '/home/cltbld', 11:07:16 INFO - 'LANG': 'en_US.UTF-8', 11:07:16 INFO - 'LANGUAGE': 'en_US:en', 11:07:16 INFO - 'LOGNAME': 'cltbld', 11:07:16 INFO - 'MAIL': '/var/mail/cltbld', 11:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:16 INFO - 'MOZ_NO_REMOTE': '1', 11:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:16 INFO - 'NO_EM_RESTART': '1', 11:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:16 INFO - 'PWD': '/builds/slave/test', 11:07:16 INFO - 'SHELL': '/bin/bash', 11:07:16 INFO - 'SHLVL': '1', 11:07:16 INFO - 'TERM': 'linux', 11:07:16 INFO - 'TMOUT': '86400', 11:07:16 INFO - 'USER': 'cltbld', 11:07:16 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:16 INFO - '_': '/tools/buildbot/bin/python'} 11:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:18 INFO - Installing collected packages: mozsystemmonitor 11:07:18 INFO - Running setup.py install for mozsystemmonitor 11:07:18 INFO - Successfully installed mozsystemmonitor 11:07:18 INFO - Cleaning up... 11:07:18 INFO - Return code: 0 11:07:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:07:18 INFO - Using env: {'DISPLAY': ':0', 11:07:18 INFO - 'HOME': '/home/cltbld', 11:07:18 INFO - 'LANG': 'en_US.UTF-8', 11:07:18 INFO - 'LANGUAGE': 'en_US:en', 11:07:18 INFO - 'LOGNAME': 'cltbld', 11:07:18 INFO - 'MAIL': '/var/mail/cltbld', 11:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:18 INFO - 'MOZ_NO_REMOTE': '1', 11:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:18 INFO - 'NO_EM_RESTART': '1', 11:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:18 INFO - 'PWD': '/builds/slave/test', 11:07:18 INFO - 'SHELL': '/bin/bash', 11:07:18 INFO - 'SHLVL': '1', 11:07:18 INFO - 'TERM': 'linux', 11:07:18 INFO - 'TMOUT': '86400', 11:07:18 INFO - 'USER': 'cltbld', 11:07:18 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:18 INFO - '_': '/tools/buildbot/bin/python'} 11:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:21 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 11:07:21 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 11:07:21 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 11:07:21 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 11:07:21 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 11:07:21 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 11:07:21 INFO - Downloading docopt-0.6.1.tar.gz 11:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:21 INFO - Running setup.py install for blobuploader 11:07:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:21 INFO - Running setup.py install for requests 11:07:21 INFO - Running setup.py install for docopt 11:07:21 INFO - Successfully installed blobuploader requests docopt 11:07:21 INFO - Cleaning up... 11:07:21 INFO - Return code: 0 11:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:07:21 INFO - Using env: {'DISPLAY': ':0', 11:07:21 INFO - 'HOME': '/home/cltbld', 11:07:21 INFO - 'LANG': 'en_US.UTF-8', 11:07:21 INFO - 'LANGUAGE': 'en_US:en', 11:07:21 INFO - 'LOGNAME': 'cltbld', 11:07:21 INFO - 'MAIL': '/var/mail/cltbld', 11:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:21 INFO - 'MOZ_NO_REMOTE': '1', 11:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:21 INFO - 'NO_EM_RESTART': '1', 11:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:21 INFO - 'PWD': '/builds/slave/test', 11:07:21 INFO - 'SHELL': '/bin/bash', 11:07:21 INFO - 'SHLVL': '1', 11:07:21 INFO - 'TERM': 'linux', 11:07:21 INFO - 'TMOUT': '86400', 11:07:21 INFO - 'USER': 'cltbld', 11:07:21 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:21 INFO - '_': '/tools/buildbot/bin/python'} 11:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:22 INFO - Running setup.py (path:/tmp/pip-0fT8Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:22 INFO - Running setup.py (path:/tmp/pip-EQwqsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:22 INFO - Running setup.py (path:/tmp/pip-53r586-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:22 INFO - Running setup.py (path:/tmp/pip-Hakqfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:22 INFO - Running setup.py (path:/tmp/pip-dRbtuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:22 INFO - Running setup.py (path:/tmp/pip-AbRXH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:22 INFO - Running setup.py (path:/tmp/pip-lpmIpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:22 INFO - Running setup.py (path:/tmp/pip-uVwGqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:22 INFO - Running setup.py (path:/tmp/pip-8NBsce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:22 INFO - Running setup.py (path:/tmp/pip-0zZTUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:22 INFO - Running setup.py (path:/tmp/pip-lsW70F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:22 INFO - Running setup.py (path:/tmp/pip-F11i56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:22 INFO - Running setup.py (path:/tmp/pip-kX31J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:23 INFO - Running setup.py (path:/tmp/pip-9TRgOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:23 INFO - Running setup.py (path:/tmp/pip-3KY_pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:23 INFO - Running setup.py (path:/tmp/pip-WE_LmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:23 INFO - Running setup.py (path:/tmp/pip-JDTFA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:23 INFO - Running setup.py install for manifestparser 11:07:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:23 INFO - Running setup.py install for mozcrash 11:07:23 INFO - Running setup.py install for mozdebug 11:07:23 INFO - Running setup.py install for mozdevice 11:07:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:23 INFO - Running setup.py install for mozfile 11:07:23 INFO - Running setup.py install for mozhttpd 11:07:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:23 INFO - Running setup.py install for mozinfo 11:07:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Running setup.py install for mozInstall 11:07:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Running setup.py install for mozleak 11:07:24 INFO - Running setup.py install for mozlog 11:07:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Running setup.py install for moznetwork 11:07:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Running setup.py install for mozprocess 11:07:24 INFO - Running setup.py install for mozprofile 11:07:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Running setup.py install for mozrunner 11:07:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:24 INFO - Running setup.py install for mozscreenshot 11:07:24 INFO - Running setup.py install for moztest 11:07:25 INFO - Running setup.py install for mozversion 11:07:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:25 INFO - Cleaning up... 11:07:25 INFO - Return code: 0 11:07:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:25 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')]} 11:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:25 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')]} 11:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:25 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 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:25 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 11:07:25 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 11:07:25 INFO - Using env: {'DISPLAY': ':0', 11:07:25 INFO - 'HOME': '/home/cltbld', 11:07:25 INFO - 'LANG': 'en_US.UTF-8', 11:07:25 INFO - 'LANGUAGE': 'en_US:en', 11:07:25 INFO - 'LOGNAME': 'cltbld', 11:07:25 INFO - 'MAIL': '/var/mail/cltbld', 11:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:25 INFO - 'MOZ_NO_REMOTE': '1', 11:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:25 INFO - 'NO_EM_RESTART': '1', 11:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:25 INFO - 'PWD': '/builds/slave/test', 11:07:25 INFO - 'SHELL': '/bin/bash', 11:07:25 INFO - 'SHLVL': '1', 11:07:25 INFO - 'TERM': 'linux', 11:07:25 INFO - 'TMOUT': '86400', 11:07:25 INFO - 'USER': 'cltbld', 11:07:25 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:25 INFO - '_': '/tools/buildbot/bin/python'} 11:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:25 INFO - Running setup.py (path:/tmp/pip-2hphgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:25 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)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:25 INFO - Running setup.py (path:/tmp/pip-yGUwih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:25 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)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:25 INFO - Running setup.py (path:/tmp/pip-11sJzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:25 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)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:25 INFO - Running setup.py (path:/tmp/pip-iIxnc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:25 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)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:25 INFO - Running setup.py (path:/tmp/pip-04LnMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:25 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)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:25 INFO - Running setup.py (path:/tmp/pip-2SZdzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:25 INFO - Running setup.py (path:/tmp/pip-KSBM14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:25 INFO - Running setup.py (path:/tmp/pip-BW_H5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:25 INFO - Running setup.py (path:/tmp/pip-ZHEAI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:26 INFO - Running setup.py (path:/tmp/pip-maCwBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:26 INFO - Running setup.py (path:/tmp/pip-YAyJhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:26 INFO - Running setup.py (path:/tmp/pip-NheSu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:26 INFO - Running setup.py (path:/tmp/pip-7Ctevh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:26 INFO - Running setup.py (path:/tmp/pip-x0V3Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:26 INFO - Running setup.py (path:/tmp/pip-FI4hi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:26 INFO - Running setup.py (path:/tmp/pip-9Hk5nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:26 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)) 11:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:26 INFO - Running setup.py (path:/tmp/pip-SgMjkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:26 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)) 11:07:26 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)) 11:07:26 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)) 11:07:26 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)) 11:07:26 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)) 11:07:26 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)) 11:07:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:26 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 11:07:26 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 11:07:26 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 11:07:26 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 11:07:26 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 11:07:26 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 11:07:28 INFO - Downloading blessings-1.6.tar.gz 11:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:28 INFO - Installing collected packages: blessings 11:07:28 INFO - Running setup.py install for blessings 11:07:28 INFO - Successfully installed blessings 11:07:28 INFO - Cleaning up... 11:07:28 INFO - Return code: 0 11:07:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:28 INFO - Reading from file tmpfile_stdout 11:07:28 INFO - Current package versions: 11:07:28 INFO - argparse == 1.2.1 11:07:28 INFO - blessings == 1.6 11:07:28 INFO - blobuploader == 1.2.4 11:07:28 INFO - docopt == 0.6.1 11:07:28 INFO - manifestparser == 1.1 11:07:28 INFO - mozInstall == 1.12 11:07:28 INFO - mozcrash == 0.17 11:07:28 INFO - mozdebug == 0.1 11:07:28 INFO - mozdevice == 0.48 11:07:28 INFO - mozfile == 1.2 11:07:28 INFO - mozhttpd == 0.7 11:07:28 INFO - mozinfo == 0.9 11:07:28 INFO - mozleak == 0.1 11:07:28 INFO - mozlog == 3.1 11:07:28 INFO - moznetwork == 0.27 11:07:28 INFO - mozprocess == 0.22 11:07:28 INFO - mozprofile == 0.28 11:07:28 INFO - mozrunner == 6.11 11:07:28 INFO - mozscreenshot == 0.1 11:07:28 INFO - mozsystemmonitor == 0.0 11:07:28 INFO - moztest == 0.7 11:07:28 INFO - mozversion == 1.4 11:07:28 INFO - psutil == 3.1.1 11:07:28 INFO - requests == 1.2.3 11:07:28 INFO - wsgiref == 0.1.2 11:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:07:28 INFO - Using env: {'DISPLAY': ':0', 11:07:28 INFO - 'HOME': '/home/cltbld', 11:07:28 INFO - 'LANG': 'en_US.UTF-8', 11:07:28 INFO - 'LANGUAGE': 'en_US:en', 11:07:28 INFO - 'LOGNAME': 'cltbld', 11:07:28 INFO - 'MAIL': '/var/mail/cltbld', 11:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:28 INFO - 'MOZ_NO_REMOTE': '1', 11:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:28 INFO - 'NO_EM_RESTART': '1', 11:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:28 INFO - 'PWD': '/builds/slave/test', 11:07:28 INFO - 'SHELL': '/bin/bash', 11:07:28 INFO - 'SHLVL': '1', 11:07:28 INFO - 'TERM': 'linux', 11:07:28 INFO - 'TMOUT': '86400', 11:07:28 INFO - 'USER': 'cltbld', 11:07:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:28 INFO - '_': '/tools/buildbot/bin/python'} 11:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 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)) 11:07:29 INFO - Cleaning up... 11:07:29 INFO - Return code: 0 11:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:29 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')]} 11:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:29 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')]} 11:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:29 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 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:29 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 11:07:29 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 11:07:29 INFO - Using env: {'DISPLAY': ':0', 11:07:29 INFO - 'HOME': '/home/cltbld', 11:07:29 INFO - 'LANG': 'en_US.UTF-8', 11:07:29 INFO - 'LANGUAGE': 'en_US:en', 11:07:29 INFO - 'LOGNAME': 'cltbld', 11:07:29 INFO - 'MAIL': '/var/mail/cltbld', 11:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:29 INFO - 'MOZ_NO_REMOTE': '1', 11:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:29 INFO - 'NO_EM_RESTART': '1', 11:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:29 INFO - 'PWD': '/builds/slave/test', 11:07:29 INFO - 'SHELL': '/bin/bash', 11:07:29 INFO - 'SHLVL': '1', 11:07:29 INFO - 'TERM': 'linux', 11:07:29 INFO - 'TMOUT': '86400', 11:07:29 INFO - 'USER': 'cltbld', 11:07:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:29 INFO - '_': '/tools/buildbot/bin/python'} 11:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:29 INFO - Downloading/unpacking jsonschema 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:31 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:31 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:31 INFO - warning: no files found matching '*.txt' 11:07:31 INFO - no previously-included directories found matching 'build' 11:07:31 INFO - no previously-included directories found matching 'dist' 11:07:31 INFO - no previously-included directories found matching '.git*' 11:07:31 INFO - Installing collected packages: jsonschema, functools32 11:07:31 INFO - Running setup.py install for functools32 11:07:31 INFO - warning: no files found matching '*.txt' 11:07:31 INFO - no previously-included directories found matching 'build' 11:07:31 INFO - no previously-included directories found matching 'dist' 11:07:31 INFO - no previously-included directories found matching '.git*' 11:07:31 INFO - Successfully installed jsonschema functools32 11:07:31 INFO - Cleaning up... 11:07:31 INFO - Return code: 0 11:07:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd64c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', '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 11:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:07:31 INFO - Using env: {'DISPLAY': ':0', 11:07:31 INFO - 'HOME': '/home/cltbld', 11:07:31 INFO - 'LANG': 'en_US.UTF-8', 11:07:31 INFO - 'LANGUAGE': 'en_US:en', 11:07:31 INFO - 'LOGNAME': 'cltbld', 11:07:31 INFO - 'MAIL': '/var/mail/cltbld', 11:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:31 INFO - 'MOZ_NO_REMOTE': '1', 11:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:31 INFO - 'NO_EM_RESTART': '1', 11:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:31 INFO - 'PWD': '/builds/slave/test', 11:07:31 INFO - 'SHELL': '/bin/bash', 11:07:31 INFO - 'SHLVL': '1', 11:07:31 INFO - 'TERM': 'linux', 11:07:31 INFO - 'TMOUT': '86400', 11:07:31 INFO - 'USER': 'cltbld', 11:07:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:31 INFO - '_': '/tools/buildbot/bin/python'} 11:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:31 INFO - Downloading/unpacking flake8 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 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 11:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:34 INFO - no previously-included directories found matching 'docs/_build' 11:07:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:34 INFO - Running setup.py install for pep8 11:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:34 INFO - no previously-included directories found matching 'docs/_build' 11:07:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:34 INFO - Cleaning up... 11:07:34 INFO - Return code: 0 11:07:34 INFO - Running post-action listener: _resource_record_post_action 11:07:34 INFO - Running post-action listener: _start_resource_monitoring 11:07:34 INFO - Starting resource monitoring. 11:07:34 INFO - ##### 11:07:34 INFO - ##### Running install step. 11:07:34 INFO - ##### 11:07:34 INFO - Running pre-action listener: _resource_record_pre_action 11:07:34 INFO - Running main action method: install 11:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:35 INFO - Reading from file tmpfile_stdout 11:07:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:35 INFO - Reading from file tmpfile_stdout 11:07:35 INFO - Output received: 11:07:35 INFO - Usage: mozinstall [options] installer 11:07:35 INFO - Options: 11:07:35 INFO - -h, --help show this help message and exit 11:07:35 INFO - -d DEST, --destination=DEST 11:07:35 INFO - Directory to install application into. [default: 11:07:35 INFO - "/builds/slave/test"] 11:07:35 INFO - --app=APP Application being installed. [default: firefox] 11:07:35 INFO - mkdir: /builds/slave/test/build/application 11:07:35 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'] 11:07:35 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 11:07:50 INFO - Reading from file tmpfile_stdout 11:07:50 INFO - Output received: 11:07:50 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:50 INFO - Running post-action listener: _resource_record_post_action 11:07:50 INFO - ##### 11:07:50 INFO - ##### Running run-tests step. 11:07:50 INFO - ##### 11:07:50 INFO - Running pre-action listener: _resource_record_pre_action 11:07:50 INFO - Running main action method: run_tests 11:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:50 INFO - Python 2.7.3 11:07:50 INFO - Return code: 0 11:07:50 INFO - grabbing minidump binary from tooltool 11:07: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')]} 11:07:50 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 0x2a2e410>, '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 0x2a2f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:50 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 11:07:50 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 11:07:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:50 INFO - Return code: 0 11:07:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:07:51 INFO - Return code: 0 11:07:51 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/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:07:51 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/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 11:07:51 INFO - Using env: {'DISPLAY': ':0', 11:07:51 INFO - 'HOME': '/home/cltbld', 11:07:51 INFO - 'LANG': 'en_US.UTF-8', 11:07:51 INFO - 'LANGUAGE': 'en_US:en', 11:07:51 INFO - 'LOGNAME': 'cltbld', 11:07:51 INFO - 'MAIL': '/var/mail/cltbld', 11:07:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:51 INFO - 'MOZ_NO_REMOTE': '1', 11:07:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:51 INFO - 'NO_EM_RESTART': '1', 11:07:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:51 INFO - 'PWD': '/builds/slave/test', 11:07:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:51 INFO - 'SHELL': '/bin/bash', 11:07:51 INFO - 'SHLVL': '1', 11:07:51 INFO - 'TERM': 'linux', 11:07:51 INFO - 'TMOUT': '86400', 11:07:51 INFO - 'USER': 'cltbld', 11:07:51 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219', 11:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:51 INFO - '_': '/tools/buildbot/bin/python'} 11:07:51 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/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:07:51 INFO - mozversion application_buildid: 20160428082225 11:07:51 INFO - mozversion application_changeset: 070a730a51d3bd2e923f81da9e10633b4d926143 11:07:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:07:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:51 INFO - mozversion application_name: Firefox 11:07:51 INFO - mozversion application_remotingname: firefox-dev 11:07:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:07:51 INFO - mozversion application_vendor: Mozilla 11:07:51 INFO - mozversion application_version: 48.0a2 11:07:51 INFO - mozversion platform_buildid: 20160428082225 11:07:51 INFO - mozversion platform_changeset: 070a730a51d3bd2e923f81da9e10633b4d926143 11:07:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:07:51 INFO - mozversion platform_version: 48.0a2 11:07:51 INFO - using testdate: 1461866871 11:07:51 INFO - actual date: 1461866871 11:07:51 INFO - starting webserver on 'localhost:52078' 11:07:51 INFO - SUITE-START | Running 2 tests 11:07:51 INFO - TEST-START | dromaeo_css 11:07:51 INFO - operating with platform_type : linux_ 11:07:51 INFO - Initialising browser for dromaeo_css test... 11:07:51 INFO - TEST-INFO | started process 16354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS87IeJ/profile http://localhost:52078/getInfo.html) 11:07:55 INFO - PROCESS | 16354 | __metrics Screen width/height:1600/1200 11:07:55 INFO - PROCESS | 16354 | colorDepth:24 11:07:55 INFO - PROCESS | 16354 | Browser inner width/height: 1024/697 11:07:55 INFO - PROCESS | 16354 | __metrics 11:07:56 ERROR - PROCESS | 16354 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:07:57 INFO - TEST-INFO | 16354: exit 0 11:07:57 INFO - Browser initialized. 11:07:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:57 INFO - TEST-INFO | started process 16445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS87IeJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:09 INFO - PROCESS | 16445 | RSS: Main: 141803520 11:08:09 INFO - PROCESS | 16445 | 11:09:00 INFO - PROCESS | 16445 | 1461866940362 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] 11:11:07 INFO - PROCESS | 16445 | Cycle 1(1): loaded http://localhost:52078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52078/tests/dromaeo/cssquery-ext.html) 11:11:08 INFO - PROCESS | 16445 | RSS: Main: 254279680 11:11:08 INFO - PROCESS | 16445 | 11:14:11 INFO - PROCESS | 16445 | Cycle 1(1): loaded http://localhost:52078/tests/dromaeo/cssquery-ext.html (next: http://localhost:52078/tests/dromaeo/cssquery-jquery.html) 11:14:11 INFO - PROCESS | 16445 | RSS: Main: 223993856 11:14:11 INFO - PROCESS | 16445 | 11:17:13 INFO - PROCESS | 16445 | Cycle 1(1): loaded http://localhost:52078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52078/tests/dromaeo/cssquery-mootools.html) 11:17:14 INFO - PROCESS | 16445 | RSS: Main: 221528064 11:17:14 INFO - PROCESS | 16445 | 11:20:16 INFO - PROCESS | 16445 | Cycle 1(1): loaded http://localhost:52078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52078/tests/dromaeo/cssquery-prototype.html) 11:20:16 INFO - PROCESS | 16445 | RSS: Main: 216104960 11:20:16 INFO - PROCESS | 16445 | 11:23:19 INFO - PROCESS | 16445 | Cycle 1(1): loaded http://localhost:52078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52078/tests/dromaeo/cssquery-yui.html) 11:23:19 INFO - PROCESS | 16445 | RSS: Main: 202084352 11:23:19 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | Cycle 1(1): loaded http://localhost:52078/tests/dromaeo/cssquery-yui.html (next: http://localhost:52078/tests/dromaeo/cssquery-dojo.html) 11:26:22 INFO - PROCESS | 16445 | RSS: Main: 239865856 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | __start_tp_report 11:26:22 INFO - PROCESS | 16445 | _x_x_mozilla_page_load 11:26:22 INFO - PROCESS | 16445 | _x_x_mozilla_page_load_details 11:26:22 INFO - PROCESS | 16445 | |i|pagename|runs| 11:26:22 INFO - PROCESS | 16445 | |0;dojo.html;3253.6583658715836;3358.798472091676;3367.7810942288734;3372.2749608834097;3401.996411058738;5516.172574113875;5534.501894829465;5537.91693124603;5549.445055494459;5553.750081246343;5517.889642207154;5539.639923404976;5556.749946252418;5572.888542229153;5578.44215578443;4965.131102057144;5006.374203224588;5019.272205530196;5084;5110;4946.505349465043;5011.972545628156;5027.648064635477;5029.270755740416;5035.723035233061;5010.223415370623;5033.169527028036;5071.137906555894;5092.134337162691;5096.79612815487;5107.668001579886;5151.021305951857;5163.096458119814;5164.992826398854;5195.142801437758;4915.459299477055;4964.081644895706;5060.063888180698;5067.39191297043;5076.44159142494;5395.352557693062;5402.729863506809;5461.290032295816;5474.178873169057;5480.232767412565;5878.911816322759;5879.79420720277;5880.8235752927485;5884.499817515516;5886.941130588682;5913.231279933624;5948.524118070544;5991.370906054889;6026.8493287667725;6034.909476357858;5575.330960284751;5575.69333686647;5576.1356989666665;5594.580406469531;5597.216389705444;6016.819495415145;6116.908246376308;6118.632882027093;6122.908156377658;6132.938670613326;5784.884302314014;5874.882502349929;5881.882362352729;5896.734646940898;5898.76404943806;5985.34161242263;6002.939970600325;6003.549733769984;6005.6396616203165;6010.308814486302;5797.072468405035;5800.854978625483;5936.7031648417405;5952.76188952437;5954.047352423591;5949.345571987078;5953.970230148908;5961.225040744675;5961.701914904324;5998.730057147439;4506.887327816765;4520.59314661682;4521.480029796549;4522.525134860858;4552.817887284472;3933.783641899723;3973.7615743055508;4028.5367182774357;4054.8175332110127;4101.52832424275;5726.055200891889;5743.052396354555;5750.396208398141;5750.88498230033;5751.971240143773;6047;6052.12244224585;6060;6065.666388348595;6066.545009124334;5504.394516603171;5685.658860468385;5694.288213973254;5753.395893431213;5806.709664516758;5177.145770947826;5197.610179236497;5202.531772140525;5207.6875387476875;5207.7916883325;6245.000799871998;6249.6875156242;6255.280642726054;6257.812265632038;6262.718177682015;5908.025175846109;5933.465988061095;5992.0712289595185;6021.698915054318;6029.909551356645;6271.429213102002;6277.15258440123;6297.96851015742;6302.432781049728;6302.65335406557;5801.564882633904;5969.343372229138;5972.671503067373;5990.565803273761;6022.548308876764;6003.669798161143;6032.336442991355;6036.486898613667;6039.879202416015;6077.392260773887;5822.097574875901;5843.912341314799;5864.618799778001;5867;5870.324912635102;5705.515031222392;5777.162311464898;5801.274840644919;5819.592628515963;5841.211436456024;5799.536037117105;5827.3881242470625;5834.416558344132;5840.065589505659;5867.031939729897;5938.792142275;5939.10913362999;5942.7920022799;5949.8215053548465;5955.225820643289;5596.720163991866;5726.0838265877255;5807.94192058074;5823.126531020381;5825.70871456434 11:26:22 INFO - PROCESS | 16445 | |1;ext.html;655.3512023097132;670.4770279182236;670.9228438729548;671.3219648155363;726.2048057377172;32354.352912941755;42238.78880605596;42837.7858110709;43033.569664303344;43175;45294.547054529445;46168.3074753879;46214.768926155404;46253.76873115638;46317.30524042134;8029.839403211932;8919.509426981513;9160.129787670161;10515.947420262926;10747.247692661516;10767.407792571405;10973.561057557728;10976;10977.945110274477;10980.780384392347;10891.509882055327;11079.335239885593;11090.390028548427;11094.445277736122;11097.72255693606;8004.079530853939;10723.731906702316;10888.128949684085;10890.401027943539;10919.781604367869;10878.075363594104;11005.61480348184;11009.119270458425;11009.724756881062;11015;42073.78963105196;42810.57189428097;42810.785946070384;42901.57098429038;42929.785351073355;4098.467199264106;4522.751248681321;4564.292534657134;4718.622510199176;4731.1720448921305;34897.47653785195;35328.823355883316;35468;35546.28907421837;36022;4740.786664600101;4753.833615823464;4782.258749893737;4799.2801079837955;4825.613950883921;381069;387426.0628696867;387494;387630;387682;72687.63656181685;74074;74100;74118;74166.25833741593;67746.66126669434;68216.31783682099;68505.31494684989;68560;68602.65698671575;16801;19190.904045479685;19425.611487770166;19452.513687157934;19467.513312167026;13152.934235328954;13438.126521776248;13444.798328024892;13445.193288402532;13449.32753362328;21760.238391656218;23209.3037208884;23411.648825267635;23414.180503682288;23435.179768708353;8070.883849236814;8387.783771353119;8592.441491303045;8645.874850538139;8651.351148663874;1180.1797750563449;1207.7705236005306;1207.8188271759132;1211.1650848963827;1219.2745316536646;35372.82313588416;35470;35652.98860770857;35803.82098089493;35904.82047589745;1298.69480672042;1301.297299458282;1301.537954026326;1343.126967471132;1375.1680233458615;18252.63494730098;18706;18714.1578628962;18985;19127.713084303745;579442;585754;586781;587884;590466;66527.66736166288;66992.66503667548;67225;67263.32736672669;67417.66291168611;1434.985650143506;1514.0915450729694;1514.1369419430819;1544.2899157569368;1655.8344165583346;30882;32101.839490802395;33176.50235246425;34978.30043399169;35329;54394.45605543894;54794;54847;54849.725751370985;55006.44993550013;346392;347277;347321;347591;348405;26681;29549.113526594236;30017.69982300149;30224.84887575548;30380.24049398783;46454.30318545292;47366.52633473759;47478.28782568195;48179;48484.757576211894;39534.011649708984;40873.809155853036;43166.78416608022;44419.111617766815;44940;41269.58730412657;41748.16503669849;42623.36064958966;42706.359404609575;43862.78068609637;42493.57506424896;44073;45349.09301814011;46070.308945366516;46251.76874115608;34447.31105377928;38747.41878871876;39519.407208891316;39643.80178099091;40362.59637403706;30089.849550752107;30468.238294042825;30557.54163687502;30601;30611.2347191322 11:26:22 INFO - PROCESS | 16445 | |2;jquery.html;426.27107645925474;431.07652095890137;435.8627032484769;440.08023231446276;448.18877831125644;18700.719489207673;18994.335198268065;19720.70418943715;19879;19883.204671813146;18419.63160736788;18511.629767404644;19298.51753706158;19378.51553711158;20404.89797551014;5367.919481207785;5487.533559647435;5501.339839219299;5517.393086760453;5517.531009864167;5345.171498417732;5357.866053348658;5387.164989426626;5392.838214853561;5433.1578605316045;5278.049951008817;5348.839534813942;5422.593305502083;5434.076207044812;5438.91841622376;5340.118880384732;5413.377461591928;5421.701806400646;5425.755840987165;5433.646812957145;5163.896722065575;5193.117170081057;5253.527182553588;5285.973570132163;5294.947050529484;14010.36953337092;14381.496647617389;14382.065165764192;14436.639084022878;14487.71024579513;2481.5285095831914;2532.5061612985473;2560.4751026039617;2947.9705202948126;3141.1361875484195;10134;10345.534450949724;10653.733656658567;10794.73013174669;10964.396958167297;2019.1721394228296;2041.7856125106946;2147.162606583434;2172.7935846094597;2259.401258666455;80690;84185;84453;85996.7100493493;86549;10992.560297588167;11378.374189419495;11450.37022963745;11467.713307167387;11553.942230288794;16474.75287870683;16543.586410339838;16594.58513537171;16667.749983750255;16673.91663041677;8232.753017409488;8371.58142092893;8391.874121888177;8609.440386374865;8896.510691911877;8320.37597180214;8325.333973282122;8341.791455213668;8400.243978042006;8417.873731894026;4565.086982603492;4585.747783871852;4605.470370907322;4660.603848672901;4703.129920964632;1803.2313200025344;2082.437741809703;2103.589799989018;2109.7784732603163;2149.7420309562954;1005.8290090684601;1132.8300754886832;1141.2581821815886;1179.2217136689744;1201.3718569918797;19574;19661.410157695293;19764.20943162286;19895.502612434804;19903.502412439517;1113.2429947635524;1117.620009196877;1123.084685980923;1131.3664347965166;1203.2058841164965;10756.569737210424;11075.778484430266;11116.444177791078;11118.944405277922;11195.216334856483;541071;544384;553939;556693;566883;101626;102078;102188;103310.48344758229;103333.48333258285;1059.0521483272428;1078.218291738499;1110.3171549497001;1112.054753459553;1112.449337577904;17435.47693569195;17471.737923931407;17495.82504174942;17607.647847042732;17785;39908.401373978835;40434.79782601068;40550.39174412445;41160.41433370646;41723.37414938718;58541.70729146327;58608;58891.41108589031;60395;61463.38536614755;8336.124706905688;8899.644014239359;8969.237614802814;9017.954910225408;9048.909510904807;10030.749231269278;13843.584692459242;13860.376283067488;13898.791518127438;14007.789883151558;8960.417572857743;12158.574449894211;12158.817617735918;12326.137170397986;12357.505699772268;11715.589954351557;11764.35296058725;11910.166288359731;12070.879291206975;12220.266783992633;12071.939640301742;12201.389930503261;12278.782611301813;12295.631131066082;13014.4143513544;8869.11308869108;9059.139381758723;9127.634894604142;9324.813503730024;9346.859797103185;12643.810342845049;12729.172603780724;12781;12878.291693956922;13082.084254102121 11:26:22 INFO - PROCESS | 16445 | |3;mootools.html;1411;1597.464849275493;1639.9668209028312;1847.8983655898928;1930.5945751392198;8447.746567602973;8825.117488251171;8860.601272942717;8867.423617464869;8887.73336799897;8459.280961118313;8605.827883442327;8626.698065567707;8630.827383452328;8648.0487146414;2145.313499680103;2413.891374888134;2456.7174774900845;2485.5028994201143;2489.751024897514;2434.330559096245;2448.375664205625;2461.396957745355;2461.655368248447;2462.91379801707;2417.516496700658;2421.4309637235237;2424.62418325159;2425.0663494554638;2428.987855060731;2123.203798575534;2440.9755902441016;2505;2514.823962322638;2514.9119780807673;2346.507233480971;2347.730011048734;2355.4111472131967;2356.3873392917794;2376.7147942247043;8785.956070219609;8814.162654547872;8830.69092581763;8852.380333376666;8867.512286824222;5473.124300112003;5619.943800562024;5650.830475085754;5657.8585535361535;5739.483446489794;3583.140046388848;3630.564332280117;3633.218857945528;3654.1230104774663;3680.3191409589044;1129.1813435259453;1147.5180424221764;1147.8507793986728;1160.7968605494088;1161.6050542815483;12706.87293127057;12719.872801271962;12743.426545805462;12753.489860405572;12763.234205947672;4963.188436220826;5021.221710634857;5097.209932460474;5107.208382700687;5164.225366195025;10729.731756706145;10759.462026898624;10772.192085593611;10776.245662803529;10782.838257426145;5006.574441172468;5639.238702775073;5665.405132461115;5671.347795003545;5676.574256930747;4968.925466118011;5051.722155281422;5083.8983220335385;5085.1355269604255;5088.669236499616;4221.324588065895;4236.724612900151;4282.850100246539;4298.634616057608;4336.869893903188;1389.451166789133;1392.8328600567795;1399.2094466626527;1407.176801571072;1408.845027047024;968.5302628225305;983.7835676151235;1022.7647641042602;1079.433297518793;1098.5001824169983;6141.539384546177;6169.105479705418;6274.498040156776;6283.560150789493;6405.135306733531;1054.5307338234566;1056.2236755984345;1074.6511098125006;1117.446863802423;1130.6438471881331;4508.774561271924;4522.3668686383935;4548;4561.29299958507;4563.657725670521;10853.837192442119;11368.886311136783;11400.201985860911;11402;11413.201075924606;10478.214133939984;10887.183461240438;11093.168012399103;11097.944510277397;11241;8328.208820162075;8358.707445239388;8366.07973122956;8456.06983231844;8460.788480288042;6322.652254126067;6338.587991780704;6392.808215753535;6440.935590644221;6457.806265812033;9995.300328976902;10316.48417579103;10400.427976461064;10485.633002845168;10584.682459526226;10446.843297350697;10453.216008799523;10596.31123976939;10628;10680.465976701289;7244.963775181091;7680.846383072419;7783.6108194588915;7831.725889593837;7956.283934445928;8666.220040196413;8678.262347700516;8767.824643506967;8768.298536117223;8782.077881822572;7756.108047574376;7808.453408261595;7877.133515313426;7908.920910791048;8027.558484283187;7680.692772289046;7749.380049595906;7818.843623127619;7932.286094251545;7939.2060793920145;7095.503314768123;7149.463790215858;7216.7113315466795;7216.855662886608;7227.530210536298;5527.226188333717;5533.972330138324;5601.719914004365;5623.156526521055;5678.0915053591225;5415.6479828811;5441.483059109379;5563.944360556343;5705.144228365778;5710.685912274865 11:26:22 INFO - PROCESS | 16445 | |4;prototype.html;361.5859840482647;362.4020366395447;363.6672444713088;364.7100555058728;366.49057809644614;5408.756605952732;5472.9179062314;5486.107292983924;5493.587980901439;5508.57622646036;5349.063913815086;5389.676619402839;5396.757145928433;5426.104692725706;5433.565314774818;4126.917461650765;4215.49414070312;4236.533981262059;4245.129748401586;4284.892877678052;4162.729422587538;4226.218149642311;4234.301340278866;4245.87262382129;4246.129543443602;4193.685473589478;4195.244855925932;4203.7809035379705;4205.915881682365;4232.3016702244095;4118.5263694675195;4207.368894665794;4212.873613791576;4217.704760666755;4224.197402493516;3706.6478684524927;3723.3298006358846;3724.2179142380132;3730.5896351401325;3730.9813450932843;5207.401148867891;5212.244224587414;5236.423993360727;5242.9213561796605;5264.894702105937;4746.315058154374;4820.662553621248;4823.879403014917;4840.797437166081;4857.417109946794;5599.244102046253;5648.152777083429;5649.9320489247675;5675.829725108253;5681.23303354046;4073;4080.367543030835;4084.4894388201474;4117.238310912461;4122.670186385082;5682.488576028178;5808.361080281124;5889.293284805851;5931.733072011727;5954.464098231137;4120.608542188487;4133.9793301033305;4135.234981528367;4136.8138433770555;4149.419081328617;4183.288840897055;4189.413482112506;4201.075763332062;4211.284081706117;4218.578142185757;4615.399998000238;4774.4430399352705;4796.616270698336;4810.542998415145;4826.131296366688;5641.266635337462;5642.153676948408;5643.238162848045;5660.632058916157;5667.574931880125;1521.246982743549;1538.569200623827;1540.1529158962526;1545.582692672972;1546.8143822741342;1018.7943103181677;1043.632840978321;1050.51151214684;1057.5611121384538;1067.9199060070525;5859.355470898197;5870.442307980735;5878.676672783038;5925.200097986716;5940.732667029994;6196.194494715658;6210.4410603045035;6211.254649442096;6251.937480625135;6254.562180647402;5265.368155821326;5589.35722391922;5646.20953066571;5671.334472797778;5924.20023296858;3346.682065203802;3359.126627076929;3363.1760218746563;3363.1928337198897;3364.8317584121187;6408.871822563523;6561.507886908405;6571.605703657796;6576.868462630816;6611.702473388709;5760.53915686744;5826.912596311059;6422.646754428458;6436.131122298523;6439;6068.5409316689065;6097.8475538111015;6107.938920610737;6112.816615501542;6131.570790044654;5598.244237028112;5711.714414279187;5818.836232753381;5849;5856.736446859816;5719.971400143139;5734.971325143348;5757.884842303214;5761.91357129635;5774.740136693775;5919.171316015847;6089.208402907594;6090;6144.293406258337;6158.076288556573;4306.720063196008;4336.696431249782;4365.847195348275;4372.497162826316;4373.322135069069;5843.181954526454;5845.766169353178;5894.764209431746;5899.793507227227;5910.438508341873;5434;5674.829755107354;5751.913721294268;5756.366799651951;5772.711364431846;5719.48524632785;5732.398098199796;5738.885222295614;5755.280589926259;5783.397471137921;5613.186088017296;5685.175649530877;5687.914681279702;5688.800891968761;5726.79956201531;5637.069883469182;5700.253454176129;5765.8558536036935;5772.393898640582;5773.884522309446;5610.270664813548;5613.438656134354;5616.6068375213345;5639.577031722555;5664.660120392789 11:26:22 INFO - PROCESS | 16445 | |5;yui.html;828.9958550207248;865.5672163918041;886.5655828643962;916.1296768070333;941.8775559177305;14705.70588588229;15156.696866062686;15165.241737913087;15267.541973740777;15362.462313819018;14514.201718905457;14552.781708274359;14646.26768661568;14657.120572765642;14687.706245875075;928.0580211085753;934.2666007184362;936.9906300937006;938.1509733690987;939.1641439119189;933.1648174883475;947.6683160893666;947.8436058050413;948.4498990585479;948.7770373962113;976.6874600127962;982.1062832822133;982.29274922056;982.4301904895179;982.459647194044;975.7170420578059;976.5459061536349;977.1352353167498;977.4086677560116;978.1001478639633;717.1788302393782;717.720089165226;717.8456631824183;718.4324383736841;719.4568101083648;14604;14620.049696769676;14627.268636568235;14641.560753177422;14728.705425891421;13037.282949437777;13377.398017089157;13451.260180690058;13463.326833658375;13465.798013029813;11170.832437513443;11307.773844523064;11366.033887119605;11548.884511154865;11585.18903676743;4089.9182016359505;4138.110306284163;4141.627253547165;4177.770222637754;4734.360861283752;44525;50624.24063639048;52920.47079529233;53473.46526534724;58455;10770.515326810313;10942.890571094347;10947.671569852917;11001.449927503752;11058.22592418539;18427.72358414625;18492.075396230135;18618.534536636693;18621.90689046546;18647.44057678272;7197.46019048563;8780.692675756318;8967.775805604782;9098.272138228926;9244.029376915461;4972.7513624318635;5064.215046667772;5190.558802501754;5278.81524146653;5385.407605163429;3558.3594952908206;3678.742488025866;3692.2061756722433;3692.2984632920197;3697.4268988306853;675.4225137507459;684.7466437418187;697.5605368617738;704.9224585295614;707.7310621963621;693.7225109956058;722.6242353975903;790.4032455496178;804.2279411764655;830.3855147191156;10194.235432342604;10284.537195826206;10545.156387489136;10623.84064239037;10836.29564078348;702.0872865275122;800.3597122302135;809.4778867630463;843.3464065349281;852.6376290076693;4925.876853078702;5252.474752524717;5323.387810401776;5332.866678333073;5352.384475785335;72320.63839680873;73914.63042684752;73962.6301868498;74199;74315.62842185862;59204.70397647984;61342.69328653417;61510.077348839804;63518;67189.32810671929;60080.699596502614;60688.69655651694;61395.69302153461;61684.69157654183;62996.05505917415;9953.900460995586;10306.227032972407;10323.122534584645;10378.169746420419;10430.42632655181;35417.64582354143;35741.82129089338;36175;36192.638073618924;37062.814685926394;48454.515454845;51495;52133.47866521438;52526.73736631445;52682;14180.220087895264;14282.928585357007;14338.641533961734;14360.497382591559;14670.926645366704;14204.522833141;14405.351759171072;14527.128372297697;14915.328810203784;15628.140452275235;13613.52352667652;13884.097533660684;13948.860511395162;14023.649408764455;15300.31148598338;13878.236696981763;14048.789268160781;14409;14431.567052988426;14627.268636568342;13770.65573360674;14293.64265893361;14336.856631433553;14397.568072957829;14516.927415362856;11924;11954.521819127138;12113.33376664292;12131.939340303243;12164.756704865677;11486.712832179262;11996.147889281712;12101;12107.213031152947;12471.376431178223 11:26:22 INFO - PROCESS | 16445 | __end_tp_report 11:26:22 INFO - PROCESS | 16445 | __start_cc_report 11:26:22 INFO - PROCESS | 16445 | _x_x_mozilla_cycle_collect,857 11:26:22 INFO - PROCESS | 16445 | __end_cc_report 11:26:22 INFO - PROCESS | 16445 | __startTimestamp1461867982289__endTimestamp 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | ------- Summary: start ------- 11:26:22 INFO - PROCESS | 16445 | Number of tests: 6 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | [#0] dojo.html Cycles:165 Average:5556.38 Median:5801.27 stddev:634.95 (10.9%) stddev-sans-first:610.66 11:26:22 INFO - PROCESS | 16445 | Values: 3253.7 3358.8 3367.8 3372.3 3402.0 5516.2 5534.5 5537.9 5549.4 5553.8 5517.9 5539.6 5556.7 5572.9 5578.4 4965.1 5006.4 5019.3 5084.0 5110.0 4946.5 5012.0 5027.6 5029.3 5035.7 5010.2 5033.2 5071.1 5092.1 5096.8 5107.7 5151.0 5163.1 5165.0 5195.1 4915.5 4964.1 5060.1 5067.4 5076.4 5395.4 5402.7 5461.3 5474.2 5480.2 5878.9 5879.8 5880.8 5884.5 5886.9 5913.2 5948.5 5991.4 6026.8 6034.9 5575.3 5575.7 5576.1 5594.6 5597.2 6016.8 6116.9 6118.6 6122.9 6132.9 5784.9 5874.9 5881.9 5896.7 5898.8 5985.3 6002.9 6003.5 6005.6 6010.3 5797.1 5800.9 5936.7 5952.8 5954.0 5949.3 5954.0 5961.2 5961.7 5998.7 4506.9 4520.6 4521.5 4522.5 4552.8 3933.8 3973.8 4028.5 4054.8 4101.5 5726.1 5743.1 5750.4 5750.9 5752.0 6047.0 6052.1 6060.0 6065.7 6066.5 5504.4 5685.7 5694.3 5753.4 5806.7 5177.1 5197.6 5202.5 5207.7 5207.8 6245.0 6249.7 6255.3 6257.8 6262.7 5908.0 5933.5 5992.1 6021.7 6029.9 6271.4 6277.2 6298.0 6302.4 6302.7 5801.6 5969.3 5972.7 5990.6 6022.5 6003.7 6032.3 6036.5 6039.9 6077.4 5822.1 5843.9 5864.6 5867.0 5870.3 5705.5 5777.2 5801.3 5819.6 5841.2 5799.5 5827.4 5834.4 5840.1 5867.0 5938.8 5939.1 5942.8 5949.8 5955.2 5596.7 5726.1 5807.9 5823.1 5825.7 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | [#1] ext.html Cycles:180 Average:62299.01 Median:213120.71 stddev:119801.55 (56.2%) stddev-sans-first:120048.22 11:26:22 INFO - PROCESS | 16445 | Values: 655.4 670.5 670.9 671.3 726.2 32354.4 42238.8 42837.8 43033.6 43175.0 45294.5 46168.3 46214.8 46253.8 46317.3 8029.8 8919.5 9160.1 10515.9 10747.2 10767.4 10973.6 10976.0 10977.9 10980.8 10891.5 11079.3 11090.4 11094.4 11097.7 8004.1 10723.7 10888.1 10890.4 10919.8 10878.1 11005.6 11009.1 11009.7 11015.0 42073.8 42810.6 42810.8 42901.6 42929.8 4098.5 4522.8 4564.3 4718.6 4731.2 34897.5 35328.8 35468.0 35546.3 36022.0 4740.8 4753.8 4782.3 4799.3 4825.6 381069.0 387426.1 387494.0 387630.0 387682.0 72687.6 74074.0 74100.0 74118.0 74166.3 67746.7 68216.3 68505.3 68560.0 68602.7 16801.0 19190.9 19425.6 19452.5 19467.5 13152.9 13438.1 13444.8 13445.2 13449.3 21760.2 23209.3 23411.6 23414.2 23435.2 8070.9 8387.8 8592.4 8645.9 8651.4 1180.2 1207.8 1207.8 1211.2 1219.3 35372.8 35470.0 35653.0 35803.8 35904.8 1298.7 1301.3 1301.5 1343.1 1375.2 18252.6 18706.0 18714.2 18985.0 19127.7 579442.0 585754.0 586781.0 587884.0 590466.0 66527.7 66992.7 67225.0 67263.3 67417.7 1435.0 1514.1 1514.1 1544.3 1655.8 30882.0 32101.8 33176.5 34978.3 35329.0 54394.5 54794.0 54847.0 54849.7 55006.4 346392.0 347277.0 347321.0 347591.0 348405.0 26681.0 29549.1 30017.7 30224.8 30380.2 46454.3 47366.5 47478.3 48179.0 48484.8 39534.0 40873.8 43166.8 44419.1 44940.0 41269.6 41748.2 42623.4 42706.4 43862.8 42493.6 44073.0 45349.1 46070.3 46251.8 34447.3 38747.4 39519.4 39643.8 40362.6 30089.8 30468.2 30557.5 30601.0 30611.2 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | [#2] jquery.html Cycles:180 Average:31073.29 Median:11223.34 stddev:91095.30 (811.7%) stddev-sans-first:91321.78 11:26:22 INFO - PROCESS | 16445 | Values: 426.3 431.1 435.9 440.1 448.2 18700.7 18994.3 19720.7 19879.0 19883.2 18419.6 18511.6 19298.5 19378.5 20404.9 5367.9 5487.5 5501.3 5517.4 5517.5 5345.2 5357.9 5387.2 5392.8 5433.2 5278.0 5348.8 5422.6 5434.1 5438.9 5340.1 5413.4 5421.7 5425.8 5433.6 5163.9 5193.1 5253.5 5286.0 5294.9 14010.4 14381.5 14382.1 14436.6 14487.7 2481.5 2532.5 2560.5 2948.0 3141.1 10134.0 10345.5 10653.7 10794.7 10964.4 2019.2 2041.8 2147.2 2172.8 2259.4 80690.0 84185.0 84453.0 85996.7 86549.0 10992.6 11378.4 11450.4 11467.7 11553.9 16474.8 16543.6 16594.6 16667.7 16673.9 8232.8 8371.6 8391.9 8609.4 8896.5 8320.4 8325.3 8341.8 8400.2 8417.9 4565.1 4585.7 4605.5 4660.6 4703.1 1803.2 2082.4 2103.6 2109.8 2149.7 1005.8 1132.8 1141.3 1179.2 1201.4 19574.0 19661.4 19764.2 19895.5 19903.5 1113.2 1117.6 1123.1 1131.4 1203.2 10756.6 11075.8 11116.4 11118.9 11195.2 541071.0 544384.0 553939.0 556693.0 566883.0 101626.0 102078.0 102188.0 103310.5 103333.5 1059.1 1078.2 1110.3 1112.1 1112.4 17435.5 17471.7 17495.8 17607.6 17785.0 39908.4 40434.8 40550.4 41160.4 41723.4 58541.7 58608.0 58891.4 60395.0 61463.4 8336.1 8899.6 8969.2 9018.0 9048.9 10030.7 13843.6 13860.4 13898.8 14007.8 8960.4 12158.6 12158.8 12326.1 12357.5 11715.6 11764.4 11910.2 12070.9 12220.3 12071.9 12201.4 12278.8 12295.6 13014.4 8869.1 9059.1 9127.6 9324.8 9346.9 12643.8 12729.2 12781.0 12878.3 13082.1 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | [#3] mootools.html Cycles:180 Average:6014.52 Median:4562.48 stddev:3332.73 (73.0%) stddev-sans-first:3324.12 11:26:22 INFO - PROCESS | 16445 | Values: 1411.0 1597.5 1640.0 1847.9 1930.6 8447.7 8825.1 8860.6 8867.4 8887.7 8459.3 8605.8 8626.7 8630.8 8648.0 2145.3 2413.9 2456.7 2485.5 2489.8 2434.3 2448.4 2461.4 2461.7 2462.9 2417.5 2421.4 2424.6 2425.1 2429.0 2123.2 2441.0 2505.0 2514.8 2514.9 2346.5 2347.7 2355.4 2356.4 2376.7 8786.0 8814.2 8830.7 8852.4 8867.5 5473.1 5619.9 5650.8 5657.9 5739.5 3583.1 3630.6 3633.2 3654.1 3680.3 1129.2 1147.5 1147.9 1160.8 1161.6 12706.9 12719.9 12743.4 12753.5 12763.2 4963.2 5021.2 5097.2 5107.2 5164.2 10729.7 10759.5 10772.2 10776.2 10782.8 5006.6 5639.2 5665.4 5671.3 5676.6 4968.9 5051.7 5083.9 5085.1 5088.7 4221.3 4236.7 4282.9 4298.6 4336.9 1389.5 1392.8 1399.2 1407.2 1408.8 968.5 983.8 1022.8 1079.4 1098.5 6141.5 6169.1 6274.5 6283.6 6405.1 1054.5 1056.2 1074.7 1117.4 1130.6 4508.8 4522.4 4548.0 4561.3 4563.7 10853.8 11368.9 11400.2 11402.0 11413.2 10478.2 10887.2 11093.2 11097.9 11241.0 8328.2 8358.7 8366.1 8456.1 8460.8 6322.7 6338.6 6392.8 6440.9 6457.8 9995.3 10316.5 10400.4 10485.6 10584.7 10446.8 10453.2 10596.3 10628.0 10680.5 7245.0 7680.8 7783.6 7831.7 7956.3 8666.2 8678.3 8767.8 8768.3 8782.1 7756.1 7808.5 7877.1 7908.9 8027.6 7680.7 7749.4 7818.8 7932.3 7939.2 7095.5 7149.5 7216.7 7216.9 7227.5 5527.2 5534.0 5601.7 5623.2 5678.1 5415.6 5441.5 5563.9 5705.1 5710.7 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | [#4] prototype.html Cycles:180 Average:4861.40 Median:5501.08 stddev:1431.24 (26.0%) stddev-sans-first:1394.83 11:26:22 INFO - PROCESS | 16445 | Values: 361.6 362.4 363.7 364.7 366.5 5408.8 5472.9 5486.1 5493.6 5508.6 5349.1 5389.7 5396.8 5426.1 5433.6 4126.9 4215.5 4236.5 4245.1 4284.9 4162.7 4226.2 4234.3 4245.9 4246.1 4193.7 4195.2 4203.8 4205.9 4232.3 4118.5 4207.4 4212.9 4217.7 4224.2 3706.6 3723.3 3724.2 3730.6 3731.0 5207.4 5212.2 5236.4 5242.9 5264.9 4746.3 4820.7 4823.9 4840.8 4857.4 5599.2 5648.2 5649.9 5675.8 5681.2 4073.0 4080.4 4084.5 4117.2 4122.7 5682.5 5808.4 5889.3 5931.7 5954.5 4120.6 4134.0 4135.2 4136.8 4149.4 4183.3 4189.4 4201.1 4211.3 4218.6 4615.4 4774.4 4796.6 4810.5 4826.1 5641.3 5642.2 5643.2 5660.6 5667.6 1521.2 1538.6 1540.2 1545.6 1546.8 1018.8 1043.6 1050.5 1057.6 1067.9 5859.4 5870.4 5878.7 5925.2 5940.7 6196.2 6210.4 6211.3 6251.9 6254.6 5265.4 5589.4 5646.2 5671.3 5924.2 3346.7 3359.1 3363.2 3363.2 3364.8 6408.9 6561.5 6571.6 6576.9 6611.7 5760.5 5826.9 6422.6 6436.1 6439.0 6068.5 6097.8 6107.9 6112.8 6131.6 5598.2 5711.7 5818.8 5849.0 5856.7 5720.0 5735.0 5757.9 5761.9 5774.7 5919.2 6089.2 6090.0 6144.3 6158.1 4306.7 4336.7 4365.8 4372.5 4373.3 5843.2 5845.8 5894.8 5899.8 5910.4 5434.0 5674.8 5751.9 5756.4 5772.7 5719.5 5732.4 5738.9 5755.3 5783.4 5613.2 5685.2 5687.9 5688.8 5726.8 5637.1 5700.3 5765.9 5772.4 5773.9 5610.3 5613.4 5616.6 5639.6 5664.7 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - PROCESS | 16445 | [#5] yui.html Cycles:180 Average:16312.64 Median:4139.87 stddev:19319.20 (466.7%) stddev-sans-first:19338.40 11:26:22 INFO - PROCESS | 16445 | Values: 829.0 865.6 886.6 916.1 941.9 14705.7 15156.7 15165.2 15267.5 15362.5 14514.2 14552.8 14646.3 14657.1 14687.7 928.1 934.3 937.0 938.2 939.2 933.2 947.7 947.8 948.4 948.8 976.7 982.1 982.3 982.4 982.5 975.7 976.5 977.1 977.4 978.1 717.2 717.7 717.8 718.4 719.5 14604.0 14620.0 14627.3 14641.6 14728.7 13037.3 13377.4 13451.3 13463.3 13465.8 11170.8 11307.8 11366.0 11548.9 11585.2 4089.9 4138.1 4141.6 4177.8 4734.4 44525.0 50624.2 52920.5 53473.5 58455.0 10770.5 10942.9 10947.7 11001.4 11058.2 18427.7 18492.1 18618.5 18621.9 18647.4 7197.5 8780.7 8967.8 9098.3 9244.0 4972.8 5064.2 5190.6 5278.8 5385.4 3558.4 3678.7 3692.2 3692.3 3697.4 675.4 684.7 697.6 704.9 707.7 693.7 722.6 790.4 804.2 830.4 10194.2 10284.5 10545.2 10623.8 10836.3 702.1 800.4 809.5 843.3 852.6 4925.9 5252.5 5323.4 5332.9 5352.4 72320.6 73914.6 73962.6 74199.0 74315.6 59204.7 61342.7 61510.1 63518.0 67189.3 60080.7 60688.7 61395.7 61684.7 62996.1 9953.9 10306.2 10323.1 10378.2 10430.4 35417.6 35741.8 36175.0 36192.6 37062.8 48454.5 51495.0 52133.5 52526.7 52682.0 14180.2 14282.9 14338.6 14360.5 14670.9 14204.5 14405.4 14527.1 14915.3 15628.1 13613.5 13884.1 13948.9 14023.6 15300.3 13878.2 14048.8 14409.0 14431.6 14627.3 13770.7 14293.6 14336.9 14397.6 14516.9 11924.0 11954.5 12113.3 12131.9 12164.8 11486.7 11996.1 12101.0 12107.2 12471.4 11:26:22 INFO - PROCESS | 16445 | -------- Summary: end -------- 11:26:22 INFO - PROCESS | 16445 | 11:26:22 INFO - TEST-INFO | 16445: exit 0 11:26:22 INFO - TEST-OK | dromaeo_css | took 1111084ms 11:26:22 INFO - TEST-START | kraken 11:26:22 INFO - operating with platform_type : linux_ 11:26:22 INFO - Initialising browser for kraken test... 11:26:22 INFO - TEST-INFO | started process 16635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqUsOY/profile http://localhost:52078/getInfo.html) 11:26:26 INFO - PROCESS | 16635 | __metrics Screen width/height:1600/1200 11:26:26 INFO - PROCESS | 16635 | colorDepth:24 11:26:26 INFO - PROCESS | 16635 | Browser inner width/height: 1024/697 11:26:26 INFO - PROCESS | 16635 | __metrics 11:26:27 ERROR - PROCESS | 16635 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:26:28 INFO - TEST-INFO | 16635: exit 0 11:26:28 INFO - Browser initialized. 11:26:28 INFO - Running cycle 1/1 for kraken test... 11:26:28 INFO - TEST-INFO | started process 16722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqUsOY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:40 INFO - PROCESS | 16722 | RSS: Main: 142548992 11:26:40 INFO - PROCESS | 16722 | 11:26:42 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52078/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:43 INFO - PROCESS | 16722 | RSS: Main: 190926848 11:26:43 INFO - PROCESS | 16722 | 11:26:46 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52078/tests/kraken/driver.html?testName=audio-dft) 11:26:46 INFO - PROCESS | 16722 | RSS: Main: 184360960 11:26:46 INFO - PROCESS | 16722 | 11:26:49 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52078/tests/kraken/driver.html?testName=audio-fft) 11:26:50 INFO - PROCESS | 16722 | RSS: Main: 273502208 11:26:50 INFO - PROCESS | 16722 | 11:26:52 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52078/tests/kraken/driver.html?testName=audio-oscillator) 11:26:52 INFO - PROCESS | 16722 | RSS: Main: 182177792 11:26:52 INFO - PROCESS | 16722 | 11:26:55 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:55 INFO - PROCESS | 16722 | RSS: Main: 180731904 11:26:55 INFO - PROCESS | 16722 | 11:26:58 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52078/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:59 INFO - PROCESS | 16722 | RSS: Main: 215658496 11:26:59 INFO - PROCESS | 16722 | 11:27:02 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52078/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:03 INFO - PROCESS | 16722 | RSS: Main: 215310336 11:27:03 INFO - PROCESS | 16722 | 11:27:06 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52078/tests/kraken/driver.html?testName=json-parse-financial) 11:27:06 INFO - PROCESS | 16722 | RSS: Main: 215060480 11:27:06 INFO - PROCESS | 16722 | 11:27:08 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:08 INFO - PROCESS | 16722 | RSS: Main: 193986560 11:27:08 INFO - PROCESS | 16722 | 11:27:10 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:11 INFO - PROCESS | 16722 | RSS: Main: 197025792 11:27:11 INFO - PROCESS | 16722 | 11:27:13 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:13 INFO - PROCESS | 16722 | RSS: Main: 206905344 11:27:13 INFO - PROCESS | 16722 | 11:27:16 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:16 INFO - PROCESS | 16722 | RSS: Main: 214331392 11:27:16 INFO - PROCESS | 16722 | 11:27:19 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:20 INFO - PROCESS | 16722 | RSS: Main: 211828736 11:27:20 INFO - PROCESS | 16722 | 11:27:21 INFO - PROCESS | 16722 | Cycle 1(1): loaded http://localhost:52078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52078/tests/kraken/driver.html?testName=ai-astar) 11:27:22 INFO - PROCESS | 16722 | RSS: Main: 275603456 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | __start_tp_report 11:27:22 INFO - PROCESS | 16722 | _x_x_mozilla_page_load 11:27:22 INFO - PROCESS | 16722 | _x_x_mozilla_page_load_details 11:27:22 INFO - PROCESS | 16722 | |i|pagename|runs| 11:27:22 INFO - PROCESS | 16722 | |0;ai-astar;108;109;105;109;109;109;99;110;109;109 11:27:22 INFO - PROCESS | 16722 | |1;audio-beat-detection;155;127;151;183;134;172;152;128;174;126 11:27:22 INFO - PROCESS | 16722 | |2;audio-dft;165;162;162;164;163;163;164;169;163;159 11:27:22 INFO - PROCESS | 16722 | |3;audio-fft;78;76;77;165;76;74;75;75;161;76 11:27:22 INFO - PROCESS | 16722 | |4;audio-oscillator;92;92;149;93;91;93;146;93;92;154 11:27:22 INFO - PROCESS | 16722 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 11:27:22 INFO - PROCESS | 16722 | |6;imaging-darkroom;145;145;153;144;145;145;145;146;146;149 11:27:22 INFO - PROCESS | 16722 | |7;imaging-desaturate;94;94;95;95;94;96;95;95;95;94 11:27:22 INFO - PROCESS | 16722 | |8;json-parse-financial;52;55;55;53;54;56;56;72;53;52 11:27:22 INFO - PROCESS | 16722 | |9;json-stringify-tinderbox;58;58;57;58;59;58;58;58;58;59 11:27:22 INFO - PROCESS | 16722 | |10;stanford-crypto-aes;82;72;73;74;73;74;72;72;73;73 11:27:22 INFO - PROCESS | 16722 | |11;stanford-crypto-ccm;118;127;117;120;117;117;118;120;150;124 11:27:22 INFO - PROCESS | 16722 | |12;stanford-crypto-pbkdf2;156;157;161;162;159;156;156;154;165;156 11:27:22 INFO - PROCESS | 16722 | |13;stanford-crypto-sha256-iterative;66;73;65;66;64;66;66;65;70;64 11:27:22 INFO - PROCESS | 16722 | __end_tp_report 11:27:22 INFO - PROCESS | 16722 | __start_cc_report 11:27:22 INFO - PROCESS | 16722 | _x_x_mozilla_cycle_collect,1605 11:27:22 INFO - PROCESS | 16722 | __end_cc_report 11:27:22 INFO - PROCESS | 16722 | __startTimestamp1461868042057__endTimestamp 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | ------- Summary: start ------- 11:27:22 INFO - PROCESS | 16722 | Number of tests: 14 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 11:27:22 INFO - PROCESS | 16722 | Values: 108.0 109.0 105.0 109.0 109.0 109.0 99.0 110.0 109.0 109.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:153.50 stddev:21.14 (13.8%) stddev-sans-first:22.36 11:27:22 INFO - PROCESS | 16722 | Values: 155.0 127.0 151.0 183.0 134.0 172.0 152.0 128.0 174.0 126.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.55 (1.6%) stddev-sans-first:2.64 11:27:22 INFO - PROCESS | 16722 | Values: 165.0 162.0 162.0 164.0 163.0 163.0 164.0 169.0 163.0 159.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.76 (48.4%) stddev-sans-first:38.57 11:27:22 INFO - PROCESS | 16722 | Values: 78.0 76.0 77.0 165.0 76.0 74.0 75.0 75.0 161.0 76.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.79 (30.2%) stddev-sans-first:28.75 11:27:22 INFO - PROCESS | 16722 | Values: 92.0 92.0 149.0 93.0 91.0 93.0 146.0 93.0 92.0 154.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:27:22 INFO - PROCESS | 16722 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:145.50 stddev:2.71 (1.9%) stddev-sans-first:2.83 11:27:22 INFO - PROCESS | 16722 | Values: 145.0 145.0 153.0 144.0 145.0 145.0 145.0 146.0 146.0 149.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 11:27:22 INFO - PROCESS | 16722 | Values: 94.0 94.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:5.88 (10.7%) stddev-sans-first:6.08 11:27:22 INFO - PROCESS | 16722 | Values: 52.0 55.0 55.0 53.0 54.0 56.0 56.0 72.0 53.0 52.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 11:27:22 INFO - PROCESS | 16722 | Values: 58.0 58.0 57.0 58.0 59.0 58.0 58.0 58.0 58.0 59.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.97 (4.1%) stddev-sans-first:0.78 11:27:22 INFO - PROCESS | 16722 | Values: 82.0 72.0 73.0 74.0 73.0 74.0 72.0 72.0 73.0 73.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:120.00 stddev:10.12 (8.4%) stddev-sans-first:10.58 11:27:22 INFO - PROCESS | 16722 | Values: 118.0 127.0 117.0 120.0 117.0 117.0 118.0 120.0 150.0 124.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:3.46 (2.2%) stddev-sans-first:3.57 11:27:22 INFO - PROCESS | 16722 | Values: 156.0 157.0 161.0 162.0 159.0 156.0 156.0 154.0 165.0 156.0 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - PROCESS | 16722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:2.84 (4.3%) stddev-sans-first:3.00 11:27:22 INFO - PROCESS | 16722 | Values: 66.0 73.0 65.0 66.0 64.0 66.0 66.0 65.0 70.0 64.0 11:27:22 INFO - PROCESS | 16722 | -------- Summary: end -------- 11:27:22 INFO - PROCESS | 16722 | 11:27:22 INFO - TEST-INFO | 16722: exit 0 11:27:23 INFO - TEST-OK | kraken | took 60055ms 11:27:23 INFO - SUITE-END | took 1171s 11:27:23 INFO - Completed test suite (00:19:31) 11:27:23 INFO - javascript benchmark 11:27:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.6583658715836, 3358.798472091676, 3367.7810942288734, 3372.2749608834097, 3401.996411058738, 5516.172574113875, 5534.501894829465, 5537.91693124603, 5549.445055494459, 5553.750081246343, 5517.889642207154, 5539.639923404976, 5556.749946252418, 5572.888542229153, 5578.44215578443, 4965.131102057144, 5006.374203224588, 5019.272205530196, 5084.0, 5110.0, 4946.505349465043, 5011.972545628156, 5027.648064635477, 5029.270755740416, 5035.723035233061, 5010.223415370623, 5033.169527028036, 5071.137906555894, 5092.134337162691, 5096.79612815487, 5107.668001579886, 5151.021305951857, 5163.096458119814, 5164.992826398854, 5195.142801437758, 4915.459299477055, 4964.081644895706, 5060.063888180698, 5067.39191297043, 5076.44159142494, 5395.352557693062, 5402.729863506809, 5461.290032295816, 5474.178873169057, 5480.232767412565, 5878.911816322759, 5879.79420720277, 5880.8235752927485, 5884.499817515516, 5886.941130588682, 5913.231279933624, 5948.524118070544, 5991.370906054889, 6026.8493287667725, 6034.909476357858, 5575.330960284751, 5575.69333686647, 5576.1356989666665, 5594.580406469531, 5597.216389705444, 6016.819495415145, 6116.908246376308, 6118.632882027093, 6122.908156377658, 6132.938670613326, 5784.884302314014, 5874.882502349929, 5881.882362352729, 5896.734646940898, 5898.76404943806, 5985.34161242263, 6002.939970600325, 6003.549733769984, 6005.6396616203165, 6010.308814486302, 5797.072468405035, 5800.854978625483, 5936.7031648417405, 5952.76188952437, 5954.047352423591, 5949.345571987078, 5953.970230148908, 5961.225040744675, 5961.701914904324, 5998.730057147439, 4506.887327816765, 4520.59314661682, 4521.480029796549, 4522.525134860858, 4552.817887284472, 3933.783641899723, 3973.7615743055508, 4028.5367182774357, 4054.8175332110127, 4101.52832424275, 5726.055200891889, 5743.052396354555, 5750.396208398141, 5750.88498230033, 5751.971240143773, 6047.0, 6052.12244224585, 6060.0, 6065.666388348595, 6066.545009124334, 5504.394516603171, 5685.658860468385, 5694.288213973254, 5753.395893431213, 5806.709664516758, 5177.145770947826, 5197.610179236497, 5202.531772140525, 5207.6875387476875, 5207.7916883325, 6245.000799871998, 6249.6875156242, 6255.280642726054, 6257.812265632038, 6262.718177682015, 5908.025175846109, 5933.465988061095, 5992.0712289595185, 6021.698915054318, 6029.909551356645, 6271.429213102002, 6277.15258440123, 6297.96851015742, 6302.432781049728, 6302.65335406557, 5801.564882633904, 5969.343372229138, 5972.671503067373, 5990.565803273761, 6022.548308876764, 6003.669798161143, 6032.336442991355, 6036.486898613667, 6039.879202416015, 6077.392260773887, 5822.097574875901, 5843.912341314799, 5864.618799778001, 5867.0, 5870.324912635102, 5705.515031222392, 5777.162311464898, 5801.274840644919, 5819.592628515963, 5841.211436456024, 5799.536037117105, 5827.3881242470625, 5834.416558344132, 5840.065589505659, 5867.031939729897, 5938.792142275, 5939.10913362999, 5942.7920022799, 5949.8215053548465, 5955.225820643289, 5596.720163991866, 5726.0838265877255, 5807.94192058074, 5823.126531020381, 5825.70871456434], "value": 5513.964451888269, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.3512023097132, 670.4770279182236, 670.9228438729548, 671.3219648155363, 726.2048057377172, 32354.352912941755, 42238.78880605596, 42837.7858110709, 43033.569664303344, 43175.0, 45294.547054529445, 46168.3074753879, 46214.768926155404, 46253.76873115638, 46317.30524042134, 8029.839403211932, 8919.509426981513, 9160.129787670161, 10515.947420262926, 10747.247692661516, 10767.407792571405, 10973.561057557728, 10976.0, 10977.945110274477, 10980.780384392347, 10891.509882055327, 11079.335239885593, 11090.390028548427, 11094.445277736122, 11097.72255693606, 8004.079530853939, 10723.731906702316, 10888.128949684085, 10890.401027943539, 10919.781604367869, 10878.075363594104, 11005.61480348184, 11009.119270458425, 11009.724756881062, 11015.0, 42073.78963105196, 42810.57189428097, 42810.785946070384, 42901.57098429038, 42929.785351073355, 4098.467199264106, 4522.751248681321, 4564.292534657134, 4718.622510199176, 4731.1720448921305, 34897.47653785195, 35328.823355883316, 35468.0, 35546.28907421837, 36022.0, 4740.786664600101, 4753.833615823464, 4782.258749893737, 4799.2801079837955, 4825.613950883921, 381069.0, 387426.0628696867, 387494.0, 387630.0, 387682.0, 72687.63656181685, 74074.0, 74100.0, 74118.0, 74166.25833741593, 67746.66126669434, 68216.31783682099, 68505.31494684989, 68560.0, 68602.65698671575, 16801.0, 19190.904045479685, 19425.611487770166, 19452.513687157934, 19467.513312167026, 13152.934235328954, 13438.126521776248, 13444.798328024892, 13445.193288402532, 13449.32753362328, 21760.238391656218, 23209.3037208884, 23411.648825267635, 23414.180503682288, 23435.179768708353, 8070.883849236814, 8387.783771353119, 8592.441491303045, 8645.874850538139, 8651.351148663874, 1180.1797750563449, 1207.7705236005306, 1207.8188271759132, 1211.1650848963827, 1219.2745316536646, 35372.82313588416, 35470.0, 35652.98860770857, 35803.82098089493, 35904.82047589745, 1298.69480672042, 1301.297299458282, 1301.537954026326, 1343.126967471132, 1375.1680233458615, 18252.63494730098, 18706.0, 18714.1578628962, 18985.0, 19127.713084303745, 579442.0, 585754.0, 586781.0, 587884.0, 590466.0, 66527.66736166288, 66992.66503667548, 67225.0, 67263.32736672669, 67417.66291168611, 1434.985650143506, 1514.0915450729694, 1514.1369419430819, 1544.2899157569368, 1655.8344165583346, 30882.0, 32101.839490802395, 33176.50235246425, 34978.30043399169, 35329.0, 54394.45605543894, 54794.0, 54847.0, 54849.725751370985, 55006.44993550013, 346392.0, 347277.0, 347321.0, 347591.0, 348405.0, 26681.0, 29549.113526594236, 30017.69982300149, 30224.84887575548, 30380.24049398783, 46454.30318545292, 47366.52633473759, 47478.28782568195, 48179.0, 48484.757576211894, 39534.011649708984, 40873.809155853036, 43166.78416608022, 44419.111617766815, 44940.0, 41269.58730412657, 41748.16503669849, 42623.36064958966, 42706.359404609575, 43862.78068609637, 42493.57506424896, 44073.0, 45349.09301814011, 46070.308945366516, 46251.76874115608, 34447.31105377928, 38747.41878871876, 39519.407208891316, 39643.80178099091, 40362.59637403706, 30089.849550752107, 30468.238294042825, 30557.54163687502, 30601.0, 30611.2347191322], "value": 22173.57984551205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.27107645925474, 431.07652095890137, 435.8627032484769, 440.08023231446276, 448.18877831125644, 18700.719489207673, 18994.335198268065, 19720.70418943715, 19879.0, 19883.204671813146, 18419.63160736788, 18511.629767404644, 19298.51753706158, 19378.51553711158, 20404.89797551014, 5367.919481207785, 5487.533559647435, 5501.339839219299, 5517.393086760453, 5517.531009864167, 5345.171498417732, 5357.866053348658, 5387.164989426626, 5392.838214853561, 5433.1578605316045, 5278.049951008817, 5348.839534813942, 5422.593305502083, 5434.076207044812, 5438.91841622376, 5340.118880384732, 5413.377461591928, 5421.701806400646, 5425.755840987165, 5433.646812957145, 5163.896722065575, 5193.117170081057, 5253.527182553588, 5285.973570132163, 5294.947050529484, 14010.36953337092, 14381.496647617389, 14382.065165764192, 14436.639084022878, 14487.71024579513, 2481.5285095831914, 2532.5061612985473, 2560.4751026039617, 2947.9705202948126, 3141.1361875484195, 10134.0, 10345.534450949724, 10653.733656658567, 10794.73013174669, 10964.396958167297, 2019.1721394228296, 2041.7856125106946, 2147.162606583434, 2172.7935846094597, 2259.401258666455, 80690.0, 84185.0, 84453.0, 85996.7100493493, 86549.0, 10992.560297588167, 11378.374189419495, 11450.37022963745, 11467.713307167387, 11553.942230288794, 16474.75287870683, 16543.586410339838, 16594.58513537171, 16667.749983750255, 16673.91663041677, 8232.753017409488, 8371.58142092893, 8391.874121888177, 8609.440386374865, 8896.510691911877, 8320.37597180214, 8325.333973282122, 8341.791455213668, 8400.243978042006, 8417.873731894026, 4565.086982603492, 4585.747783871852, 4605.470370907322, 4660.603848672901, 4703.129920964632, 1803.2313200025344, 2082.437741809703, 2103.589799989018, 2109.7784732603163, 2149.7420309562954, 1005.8290090684601, 1132.8300754886832, 1141.2581821815886, 1179.2217136689744, 1201.3718569918797, 19574.0, 19661.410157695293, 19764.20943162286, 19895.502612434804, 19903.502412439517, 1113.2429947635524, 1117.620009196877, 1123.084685980923, 1131.3664347965166, 1203.2058841164965, 10756.569737210424, 11075.778484430266, 11116.444177791078, 11118.944405277922, 11195.216334856483, 541071.0, 544384.0, 553939.0, 556693.0, 566883.0, 101626.0, 102078.0, 102188.0, 103310.48344758229, 103333.48333258285, 1059.0521483272428, 1078.218291738499, 1110.3171549497001, 1112.054753459553, 1112.449337577904, 17435.47693569195, 17471.737923931407, 17495.82504174942, 17607.647847042732, 17785.0, 39908.401373978835, 40434.79782601068, 40550.39174412445, 41160.41433370646, 41723.37414938718, 58541.70729146327, 58608.0, 58891.41108589031, 60395.0, 61463.38536614755, 8336.124706905688, 8899.644014239359, 8969.237614802814, 9017.954910225408, 9048.909510904807, 10030.749231269278, 13843.584692459242, 13860.376283067488, 13898.791518127438, 14007.789883151558, 8960.417572857743, 12158.574449894211, 12158.817617735918, 12326.137170397986, 12357.505699772268, 11715.589954351557, 11764.35296058725, 11910.166288359731, 12070.879291206975, 12220.266783992633, 12071.939640301742, 12201.389930503261, 12278.782611301813, 12295.631131066082, 13014.4143513544, 8869.11308869108, 9059.139381758723, 9127.634894604142, 9324.813503730024, 9346.859797103185, 12643.810342845049, 12729.172603780724, 12781.0, 12878.291693956922, 13082.084254102121], "value": 9429.781976648597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.0, 1597.464849275493, 1639.9668209028312, 1847.8983655898928, 1930.5945751392198, 8447.746567602973, 8825.117488251171, 8860.601272942717, 8867.423617464869, 8887.73336799897, 8459.280961118313, 8605.827883442327, 8626.698065567707, 8630.827383452328, 8648.0487146414, 2145.313499680103, 2413.891374888134, 2456.7174774900845, 2485.5028994201143, 2489.751024897514, 2434.330559096245, 2448.375664205625, 2461.396957745355, 2461.655368248447, 2462.91379801707, 2417.516496700658, 2421.4309637235237, 2424.62418325159, 2425.0663494554638, 2428.987855060731, 2123.203798575534, 2440.9755902441016, 2505.0, 2514.823962322638, 2514.9119780807673, 2346.507233480971, 2347.730011048734, 2355.4111472131967, 2356.3873392917794, 2376.7147942247043, 8785.956070219609, 8814.162654547872, 8830.69092581763, 8852.380333376666, 8867.512286824222, 5473.124300112003, 5619.943800562024, 5650.830475085754, 5657.8585535361535, 5739.483446489794, 3583.140046388848, 3630.564332280117, 3633.218857945528, 3654.1230104774663, 3680.3191409589044, 1129.1813435259453, 1147.5180424221764, 1147.8507793986728, 1160.7968605494088, 1161.6050542815483, 12706.87293127057, 12719.872801271962, 12743.426545805462, 12753.489860405572, 12763.234205947672, 4963.188436220826, 5021.221710634857, 5097.209932460474, 5107.208382700687, 5164.225366195025, 10729.731756706145, 10759.462026898624, 10772.192085593611, 10776.245662803529, 10782.838257426145, 5006.574441172468, 5639.238702775073, 5665.405132461115, 5671.347795003545, 5676.574256930747, 4968.925466118011, 5051.722155281422, 5083.8983220335385, 5085.1355269604255, 5088.669236499616, 4221.324588065895, 4236.724612900151, 4282.850100246539, 4298.634616057608, 4336.869893903188, 1389.451166789133, 1392.8328600567795, 1399.2094466626527, 1407.176801571072, 1408.845027047024, 968.5302628225305, 983.7835676151235, 1022.7647641042602, 1079.433297518793, 1098.5001824169983, 6141.539384546177, 6169.105479705418, 6274.498040156776, 6283.560150789493, 6405.135306733531, 1054.5307338234566, 1056.2236755984345, 1074.6511098125006, 1117.446863802423, 1130.6438471881331, 4508.774561271924, 4522.3668686383935, 4548.0, 4561.29299958507, 4563.657725670521, 10853.837192442119, 11368.886311136783, 11400.201985860911, 11402.0, 11413.201075924606, 10478.214133939984, 10887.183461240438, 11093.168012399103, 11097.944510277397, 11241.0, 8328.208820162075, 8358.707445239388, 8366.07973122956, 8456.06983231844, 8460.788480288042, 6322.652254126067, 6338.587991780704, 6392.808215753535, 6440.935590644221, 6457.806265812033, 9995.300328976902, 10316.48417579103, 10400.427976461064, 10485.633002845168, 10584.682459526226, 10446.843297350697, 10453.216008799523, 10596.31123976939, 10628.0, 10680.465976701289, 7244.963775181091, 7680.846383072419, 7783.6108194588915, 7831.725889593837, 7956.283934445928, 8666.220040196413, 8678.262347700516, 8767.824643506967, 8768.298536117223, 8782.077881822572, 7756.108047574376, 7808.453408261595, 7877.133515313426, 7908.920910791048, 8027.558484283187, 7680.692772289046, 7749.380049595906, 7818.843623127619, 7932.286094251545, 7939.2060793920145, 7095.503314768123, 7149.463790215858, 7216.7113315466795, 7216.855662886608, 7227.530210536298, 5527.226188333717, 5533.972330138324, 5601.719914004365, 5623.156526521055, 5678.0915053591225, 5415.6479828811, 5441.483059109379, 5563.944360556343, 5705.144228365778, 5710.685912274865], "value": 4863.119882243189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5859840482647, 362.4020366395447, 363.6672444713088, 364.7100555058728, 366.49057809644614, 5408.756605952732, 5472.9179062314, 5486.107292983924, 5493.587980901439, 5508.57622646036, 5349.063913815086, 5389.676619402839, 5396.757145928433, 5426.104692725706, 5433.565314774818, 4126.917461650765, 4215.49414070312, 4236.533981262059, 4245.129748401586, 4284.892877678052, 4162.729422587538, 4226.218149642311, 4234.301340278866, 4245.87262382129, 4246.129543443602, 4193.685473589478, 4195.244855925932, 4203.7809035379705, 4205.915881682365, 4232.3016702244095, 4118.5263694675195, 4207.368894665794, 4212.873613791576, 4217.704760666755, 4224.197402493516, 3706.6478684524927, 3723.3298006358846, 3724.2179142380132, 3730.5896351401325, 3730.9813450932843, 5207.401148867891, 5212.244224587414, 5236.423993360727, 5242.9213561796605, 5264.894702105937, 4746.315058154374, 4820.662553621248, 4823.879403014917, 4840.797437166081, 4857.417109946794, 5599.244102046253, 5648.152777083429, 5649.9320489247675, 5675.829725108253, 5681.23303354046, 4073.0, 4080.367543030835, 4084.4894388201474, 4117.238310912461, 4122.670186385082, 5682.488576028178, 5808.361080281124, 5889.293284805851, 5931.733072011727, 5954.464098231137, 4120.608542188487, 4133.9793301033305, 4135.234981528367, 4136.8138433770555, 4149.419081328617, 4183.288840897055, 4189.413482112506, 4201.075763332062, 4211.284081706117, 4218.578142185757, 4615.399998000238, 4774.4430399352705, 4796.616270698336, 4810.542998415145, 4826.131296366688, 5641.266635337462, 5642.153676948408, 5643.238162848045, 5660.632058916157, 5667.574931880125, 1521.246982743549, 1538.569200623827, 1540.1529158962526, 1545.582692672972, 1546.8143822741342, 1018.7943103181677, 1043.632840978321, 1050.51151214684, 1057.5611121384538, 1067.9199060070525, 5859.355470898197, 5870.442307980735, 5878.676672783038, 5925.200097986716, 5940.732667029994, 6196.194494715658, 6210.4410603045035, 6211.254649442096, 6251.937480625135, 6254.562180647402, 5265.368155821326, 5589.35722391922, 5646.20953066571, 5671.334472797778, 5924.20023296858, 3346.682065203802, 3359.126627076929, 3363.1760218746563, 3363.1928337198897, 3364.8317584121187, 6408.871822563523, 6561.507886908405, 6571.605703657796, 6576.868462630816, 6611.702473388709, 5760.53915686744, 5826.912596311059, 6422.646754428458, 6436.131122298523, 6439.0, 6068.5409316689065, 6097.8475538111015, 6107.938920610737, 6112.816615501542, 6131.570790044654, 5598.244237028112, 5711.714414279187, 5818.836232753381, 5849.0, 5856.736446859816, 5719.971400143139, 5734.971325143348, 5757.884842303214, 5761.91357129635, 5774.740136693775, 5919.171316015847, 6089.208402907594, 6090.0, 6144.293406258337, 6158.076288556573, 4306.720063196008, 4336.696431249782, 4365.847195348275, 4372.497162826316, 4373.322135069069, 5843.181954526454, 5845.766169353178, 5894.764209431746, 5899.793507227227, 5910.438508341873, 5434.0, 5674.829755107354, 5751.913721294268, 5756.366799651951, 5772.711364431846, 5719.48524632785, 5732.398098199796, 5738.885222295614, 5755.280589926259, 5783.397471137921, 5613.186088017296, 5685.175649530877, 5687.914681279702, 5688.800891968761, 5726.79956201531, 5637.069883469182, 5700.253454176129, 5765.8558536036935, 5772.393898640582, 5773.884522309446, 5610.270664813548, 5613.438656134354, 5616.6068375213345, 5639.577031722555, 5664.660120392789], "value": 4419.634771077575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.9958550207248, 865.5672163918041, 886.5655828643962, 916.1296768070333, 941.8775559177305, 14705.70588588229, 15156.696866062686, 15165.241737913087, 15267.541973740777, 15362.462313819018, 14514.201718905457, 14552.781708274359, 14646.26768661568, 14657.120572765642, 14687.706245875075, 928.0580211085753, 934.2666007184362, 936.9906300937006, 938.1509733690987, 939.1641439119189, 933.1648174883475, 947.6683160893666, 947.8436058050413, 948.4498990585479, 948.7770373962113, 976.6874600127962, 982.1062832822133, 982.29274922056, 982.4301904895179, 982.459647194044, 975.7170420578059, 976.5459061536349, 977.1352353167498, 977.4086677560116, 978.1001478639633, 717.1788302393782, 717.720089165226, 717.8456631824183, 718.4324383736841, 719.4568101083648, 14604.0, 14620.049696769676, 14627.268636568235, 14641.560753177422, 14728.705425891421, 13037.282949437777, 13377.398017089157, 13451.260180690058, 13463.326833658375, 13465.798013029813, 11170.832437513443, 11307.773844523064, 11366.033887119605, 11548.884511154865, 11585.18903676743, 4089.9182016359505, 4138.110306284163, 4141.627253547165, 4177.770222637754, 4734.360861283752, 44525.0, 50624.24063639048, 52920.47079529233, 53473.46526534724, 58455.0, 10770.515326810313, 10942.890571094347, 10947.671569852917, 11001.449927503752, 11058.22592418539, 18427.72358414625, 18492.075396230135, 18618.534536636693, 18621.90689046546, 18647.44057678272, 7197.46019048563, 8780.692675756318, 8967.775805604782, 9098.272138228926, 9244.029376915461, 4972.7513624318635, 5064.215046667772, 5190.558802501754, 5278.81524146653, 5385.407605163429, 3558.3594952908206, 3678.742488025866, 3692.2061756722433, 3692.2984632920197, 3697.4268988306853, 675.4225137507459, 684.7466437418187, 697.5605368617738, 704.9224585295614, 707.7310621963621, 693.7225109956058, 722.6242353975903, 790.4032455496178, 804.2279411764655, 830.3855147191156, 10194.235432342604, 10284.537195826206, 10545.156387489136, 10623.84064239037, 10836.29564078348, 702.0872865275122, 800.3597122302135, 809.4778867630463, 843.3464065349281, 852.6376290076693, 4925.876853078702, 5252.474752524717, 5323.387810401776, 5332.866678333073, 5352.384475785335, 72320.63839680873, 73914.63042684752, 73962.6301868498, 74199.0, 74315.62842185862, 59204.70397647984, 61342.69328653417, 61510.077348839804, 63518.0, 67189.32810671929, 60080.699596502614, 60688.69655651694, 61395.69302153461, 61684.69157654183, 62996.05505917415, 9953.900460995586, 10306.227032972407, 10323.122534584645, 10378.169746420419, 10430.42632655181, 35417.64582354143, 35741.82129089338, 36175.0, 36192.638073618924, 37062.814685926394, 48454.515454845, 51495.0, 52133.47866521438, 52526.73736631445, 52682.0, 14180.220087895264, 14282.928585357007, 14338.641533961734, 14360.497382591559, 14670.926645366704, 14204.522833141, 14405.351759171072, 14527.128372297697, 14915.328810203784, 15628.140452275235, 13613.52352667652, 13884.097533660684, 13948.860511395162, 14023.649408764455, 15300.31148598338, 13878.236696981763, 14048.789268160781, 14409.0, 14431.567052988426, 14627.268636568342, 13770.65573360674, 14293.64265893361, 14336.856631433553, 14397.568072957829, 14516.927415362856, 11924.0, 11954.521819127138, 12113.33376664292, 12131.939340303243, 12164.756704865677, 11486.712832179262, 11996.147889281712, 12101.0, 12107.213031152947, 12471.376431178223], "value": 7426.644210207037, "unit": "score"}], "name": "dromaeo_css", "value": 7542.061292567063, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 105.0, 109.0, 109.0, 109.0, 99.0, 110.0, 109.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 151.0, 183.0, 134.0, 172.0, 152.0, 128.0, 174.0, 126.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 164.0, 163.0, 163.0, 164.0, 169.0, 163.0, 159.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 165.0, 76.0, 74.0, 75.0, 75.0, 161.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 93.0, 91.0, 93.0, 146.0, 93.0, 92.0, 154.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 153.0, 144.0, 145.0, 145.0, 145.0, 146.0, 146.0, 149.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 55.0, 53.0, 54.0, 56.0, 56.0, 72.0, 53.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 73.0, 74.0, 73.0, 74.0, 72.0, 72.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 127.0, 117.0, 120.0, 117.0, 117.0, 118.0, 120.0, 150.0, 124.0], "value": 122.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 161.0, 162.0, 159.0, 156.0, 156.0, 154.0, 165.0, 156.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 65.0, 66.0, 64.0, 66.0, 66.0, 65.0, 70.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1516.9999999999998, "alertThreshold": 2.0}]} 11:27:23 INFO - Return code: 0 11:27:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:23 ERROR - # TBPL SUCCESS # 11:27:23 INFO - Running post-action listener: _resource_record_post_action 11:27:23 INFO - Running post-run listener: _resource_record_post_run 11:27:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 500391936; Read time: 0; Write time: 405736 11:27:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248197120; Read time: 0; Write time: 265476 11:27:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 251453440; Read time: 0; Write time: 140256 11:27:24 INFO - Running post-run listener: _upload_blobber_files 11:27:24 INFO - Blob upload gear active. 11:27:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:24 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 11:27:24 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'] 11:27:24 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 11:27:24 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:27:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:27:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:25 INFO - (blobuploader) - INFO - Done attempting. 11:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:26 INFO - (blobuploader) - INFO - Done attempting. 11:27:26 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:26 INFO - Return code: 0 11:27:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e262dd01564440a505d268c7281d89d67c74d183bfde6c51564d2877c5a799b1c07202b89d02ec711c734255b0915e671dc792453393575a51f30536d3edb626", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d7eb351f2564f9527ebe06ce754b383e59e1af4fdfa307d7243a35f3af19472a9d190d8961bf1bb50d1f451069f05a40dfc7a7b0280f0b8e485e8b0b0946398"} 11:27:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:26 INFO - Contents: 11:27:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e262dd01564440a505d268c7281d89d67c74d183bfde6c51564d2877c5a799b1c07202b89d02ec711c734255b0915e671dc792453393575a51f30536d3edb626", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d7eb351f2564f9527ebe06ce754b383e59e1af4fdfa307d7243a35f3af19472a9d190d8961bf1bb50d1f451069f05a40dfc7a7b0280f0b8e485e8b0b0946398"} 11:27:26 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:26 INFO - Copying logs to upload dir... 11:27:26 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.083710 ========= master_lag: 1.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-28 11:27:26.507574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:26.515141) ========= 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=82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219 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/e262dd01564440a505d268c7281d89d67c74d183bfde6c51564d2877c5a799b1c07202b89d02ec711c734255b0915e671dc792453393575a51f30536d3edb626", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d7eb351f2564f9527ebe06ce754b383e59e1af4fdfa307d7243a35f3af19472a9d190d8961bf1bb50d1f451069f05a40dfc7a7b0280f0b8e485e8b0b0946398"} build_url:https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/C8HSZgdAQnWl-9QYA_2fFw/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/e262dd01564440a505d268c7281d89d67c74d183bfde6c51564d2877c5a799b1c07202b89d02ec711c734255b0915e671dc792453393575a51f30536d3edb626", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d7eb351f2564f9527ebe06ce754b383e59e1af4fdfa307d7243a35f3af19472a9d190d8961bf1bb50d1f451069f05a40dfc7a7b0280f0b8e485e8b0b0946398"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:26.544043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:26.544392) ========= 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=82e07478c745e68b1fe4678a000001bc-1461865384.59805-1429321219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003318 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 11:27:26.774031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 11:27:26.774362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 11:27:26.777815) ========= ========= Total master_lag: 1.75 =========