builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1461615965.84 results: success (0) buildid: 20160425103006 builduid: 1a87fa8d522747ab8b0da4138352f4b4 revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.845313) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.846079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.846590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.872193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.872647) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 13:26:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-04-25 13:26:06 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077632 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.966132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:05.966567) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016330 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:06.018768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:26:06.019082) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --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 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --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=6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 13:26:07,114 truncating revision to first 12 chars 2016-04-25 13:26:07,114 Setting DEBUG logging. 2016-04-25 13:26:07,114 attempt 1/10 2016-04-25 13:26:07,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d6a91c76a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:26:08,433 unpacking tar archive at: mozilla-aurora-0d6a91c76a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.627071 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:26:07.659079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:07.659383) ========= script_repo_revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:07.659836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:07.660111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:26:07.670133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-25 13:26:07.670421) ========= /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=6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:26:08 INFO - MultiFileLogger online at 20160425 13:26:08 in /builds/slave/test 13:26:08 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 13:26:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:08 INFO - {'append_to_log': False, 13:26:08 INFO - 'base_work_dir': '/builds/slave/test', 13:26:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:26:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:08 INFO - 'branch': 'Mozilla-Aurora', 13:26:08 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:08 INFO - 'config_files': ('talos/linux_config.py',), 13:26:08 INFO - 'default_actions': ('clobber', 13:26:08 INFO - 'read-buildbot-config', 13:26:08 INFO - 'download-and-extract', 13:26:08 INFO - 'populate-webroot', 13:26:08 INFO - 'create-virtualenv', 13:26:08 INFO - 'install', 13:26:08 INFO - 'run-tests'), 13:26:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:08 INFO - 'download_minidump_stackwalk': True, 13:26:08 INFO - 'download_symbols': 'ondemand', 13:26:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:08 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:08 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:08 INFO - 'installer_path': 'installer.exe', 13:26:08 INFO - 'log_level': 'info', 13:26:08 INFO - 'log_name': 'talos', 13:26:08 INFO - 'log_to_console': True, 13:26:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:26:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:26:08 INFO - 'opt_config_files': (), 13:26:08 INFO - 'pip_index': False, 13:26:08 INFO - 'sps_profile': False, 13:26:08 INFO - 'sps_profile_interval': 0, 13:26:08 INFO - 'suite': 'dromaeojs', 13:26:08 INFO - 'system_bits': '32', 13:26:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:08 INFO - 'title': 'talos-linux64-ix-023', 13:26:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:08 INFO - 'use_talos_json': True, 13:26:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:08 INFO - 'work_dir': 'build'} 13:26:08 INFO - ##### 13:26:08 INFO - ##### Running clobber step. 13:26:08 INFO - ##### 13:26:08 INFO - Running pre-action listener: _resource_record_pre_action 13:26:08 INFO - Running main action method: clobber 13:26:08 INFO - rmtree: /builds/slave/test/build 13:26:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:09 INFO - Running post-action listener: _resource_record_post_action 13:26:09 INFO - ##### 13:26:09 INFO - ##### Running read-buildbot-config step. 13:26:09 INFO - ##### 13:26:09 INFO - Running pre-action listener: _resource_record_pre_action 13:26:09 INFO - Running main action method: read_buildbot_config 13:26:09 INFO - Using buildbot properties: 13:26:09 INFO - { 13:26:09 INFO - "project": "", 13:26:09 INFO - "product": "firefox", 13:26:09 INFO - "script_repo_revision": "production", 13:26:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:26:09 INFO - "repository": "", 13:26:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:26:09 INFO - "buildid": "20160425103006", 13:26:09 INFO - "pgo_build": "True", 13:26:09 INFO - "basedir": "/builds/slave/test", 13:26:09 INFO - "buildnumber": 189, 13:26:09 INFO - "slavename": "talos-linux64-ix-023", 13:26:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:26:09 INFO - "platform": "ubuntu64_hw", 13:26:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:26:09 INFO - "branch": "mozilla-aurora", 13:26:09 INFO - "repo_path": "releases/mozilla-aurora", 13:26:09 INFO - "revision": "0d6a91c76a9eddf2219caf028dea130f2d683ec2", 13:26:09 INFO - "stage_platform": "linux64-pgo", 13:26:09 INFO - "builduid": "1a87fa8d522747ab8b0da4138352f4b4", 13:26:09 INFO - "slavebuilddir": "test" 13:26:09 INFO - } 13:26:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:26:09 INFO - Running post-action listener: _resource_record_post_action 13:26:09 INFO - ##### 13:26:09 INFO - ##### Running download-and-extract step. 13:26:09 INFO - ##### 13:26:09 INFO - Running pre-action listener: _resource_record_pre_action 13:26:09 INFO - Running main action method: download_and_extract 13:26:09 INFO - mkdir: /builds/slave/test/build/tests 13:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:09 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:26:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:26:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:26:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:12 INFO - Downloaded 1361 bytes. 13:26:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:26:12 INFO - Using the following test package requirements: 13:26:12 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:26:12 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:26:12 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:26:12 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'jsshell-linux-x86_64.zip'], 13:26:12 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:26:12 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:26:12 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:26:12 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:26:12 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:26:12 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:26:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:26:12 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:12 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:26:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:26:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:26:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:16 INFO - Downloaded 23819986 bytes. 13:26:16 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'] 13:26:16 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 13:26:17 INFO - Return code: 0 13:26:17 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 13:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:17 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:26:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:26:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:26:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:19 INFO - Downloaded 23819986 bytes. 13:26:19 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'] 13:26:19 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 13:26:20 INFO - Return code: 0 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:20 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:21 INFO - Downloaded 10840145 bytes. 13:26:21 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'] 13:26:21 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 13:26:21 INFO - Return code: 0 13:26: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')]} 13:26:21 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:26:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:26:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:26:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:26:23 INFO - Downloaded 62670906 bytes. 13:26:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:26:23 INFO - mkdir: /builds/slave/test/properties 13:26:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:23 INFO - Contents: 13:26:23 INFO - build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:26:24 INFO - Running post-action listener: _resource_record_post_action 13:26:24 INFO - Running post-action listener: set_extra_try_arguments 13:26:24 INFO - ##### 13:26:24 INFO - ##### Running populate-webroot step. 13:26:24 INFO - ##### 13:26:24 INFO - Running pre-action listener: _resource_record_pre_action 13:26:24 INFO - Running main action method: populate_webroot 13:26:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:24 INFO - '--tppagecycles', 13:26:24 INFO - '7'], 13:26:24 INFO - 'tests': ['tsvgm']}}, 13:26:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['damp', 'tps']}, 13:26:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'tests': ['damp', 'tps']}, 13:26:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['dromaeo_dom']}, 13:26:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['a11yr', 13:26:24 INFO - 'ts_paint', 13:26:24 INFO - 'tpaint', 13:26:24 INFO - 'sessionrestore', 13:26:24 INFO - 'sessionrestore_no_auto_restore', 13:26:24 INFO - 'tabpaint']}, 13:26:24 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:24 INFO - 'ts_paint', 13:26:24 INFO - 'tpaint', 13:26:24 INFO - 'sessionrestore', 13:26:24 INFO - 'sessionrestore_no_auto_restore', 13:26:24 INFO - 'tabpaint']}, 13:26:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:24 INFO - 'ts_paint', 13:26:24 INFO - 'tpaint', 13:26:24 INFO - 'sessionrestore', 13:26:24 INFO - 'sessionrestore_no_auto_restore', 13:26:24 INFO - 'tabpaint']}, 13:26:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:24 INFO - 'ts_paint', 13:26:24 INFO - 'tpaint', 13:26:24 INFO - 'sessionrestore', 13:26:24 INFO - 'sessionrestore_no_auto_restore', 13:26:24 INFO - 'tabpaint']}, 13:26:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['a11yr', 13:26:24 INFO - 'ts_paint', 13:26:24 INFO - 'tpaint', 13:26:24 INFO - 'sessionrestore', 13:26:24 INFO - 'sessionrestore_no_auto_restore', 13:26:24 INFO - 'tabpaint']}, 13:26:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['a11yr', 13:26:24 INFO - 'ts_paint', 13:26:24 INFO - 'tpaint', 13:26:24 INFO - 'sessionrestore', 13:26:24 INFO - 'sessionrestore_no_auto_restore', 13:26:24 INFO - 'tabpaint']}, 13:26:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['tsvgx', 13:26:24 INFO - 'tsvgr_opacity', 13:26:24 INFO - 'tart', 13:26:24 INFO - 'tscrollx', 13:26:24 INFO - 'cart']}, 13:26:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:24 INFO - 'tsvgr_opacity', 13:26:24 INFO - 'tart', 13:26:24 INFO - 'tscrollx', 13:26:24 INFO - 'cart']}, 13:26:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'talos_options': ['--disable-e10s'], 13:26:24 INFO - 'tests': ['tp5o']}, 13:26:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'tests': ['tp5o']}, 13:26:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'talos_options': ['--disable-e10s', 13:26:24 INFO - '--xperf_path', 13:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:24 INFO - 'tests': ['tp5n']}, 13:26:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:24 INFO - 'talos_options': ['--xperf_path', 13:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:24 INFO - 'tests': ['tp5n']}}, 13:26:24 INFO - 'talos.zip': {'path': '', 13:26:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:24 INFO - Running post-action listener: _resource_record_post_action 13:26:24 INFO - ##### 13:26:24 INFO - ##### Running create-virtualenv step. 13:26:24 INFO - ##### 13:26:24 INFO - Running pre-action listener: _resource_record_pre_action 13:26:24 INFO - Running main action method: create_virtualenv 13:26:24 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:24 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 13:26:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:24 INFO - Using real prefix '/usr' 13:26:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:27 INFO - Installing pip.................done. 13:26:27 INFO - Return code: 0 13:26:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:27 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')]} 13:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 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')]} 13:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:27 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 13:26:27 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 13:26:27 INFO - Using env: {'DISPLAY': ':0', 13:26:27 INFO - 'HOME': '/home/cltbld', 13:26:27 INFO - 'LANG': 'en_US.UTF-8', 13:26:27 INFO - 'LANGUAGE': 'en_US:en', 13:26:27 INFO - 'LOGNAME': 'cltbld', 13:26:27 INFO - 'MAIL': '/var/mail/cltbld', 13:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:27 INFO - 'MOZ_NO_REMOTE': '1', 13:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:27 INFO - 'NO_EM_RESTART': '1', 13:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:27 INFO - 'PWD': '/builds/slave/test', 13:26:27 INFO - 'SHELL': '/bin/bash', 13:26:27 INFO - 'SHLVL': '1', 13:26:27 INFO - 'TERM': 'linux', 13:26:27 INFO - 'TMOUT': '86400', 13:26:27 INFO - 'USER': 'cltbld', 13:26:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:27 INFO - '_': '/tools/buildbot/bin/python'} 13:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:27 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 13:26:27 INFO - Cleaning up... 13:26:27 INFO - Return code: 0 13:26:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:26:27 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')]} 13:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 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')]} 13:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:27 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 13:26:27 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 13:26:27 INFO - Using env: {'DISPLAY': ':0', 13:26:27 INFO - 'HOME': '/home/cltbld', 13:26:27 INFO - 'LANG': 'en_US.UTF-8', 13:26:27 INFO - 'LANGUAGE': 'en_US:en', 13:26:27 INFO - 'LOGNAME': 'cltbld', 13:26:27 INFO - 'MAIL': '/var/mail/cltbld', 13:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:27 INFO - 'MOZ_NO_REMOTE': '1', 13:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:27 INFO - 'NO_EM_RESTART': '1', 13:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:27 INFO - 'PWD': '/builds/slave/test', 13:26:27 INFO - 'SHELL': '/bin/bash', 13:26:27 INFO - 'SHLVL': '1', 13:26:27 INFO - 'TERM': 'linux', 13:26:27 INFO - 'TMOUT': '86400', 13:26:27 INFO - 'USER': 'cltbld', 13:26:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:27 INFO - '_': '/tools/buildbot/bin/python'} 13:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:27 INFO - Downloading/unpacking psutil>=0.7.1 13:26:27 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 13:26:27 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 13:26:27 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 13:26:27 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 13:26:27 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 13:26:27 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 13:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:29 INFO - Installing collected packages: psutil 13:26:29 INFO - Running setup.py install for psutil 13:26:29 INFO - building 'psutil._psutil_linux' extension 13:26:29 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 13:26:30 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 13:26:30 INFO - building 'psutil._psutil_posix' extension 13:26:30 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 13:26:30 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 13:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:30 INFO - Successfully installed psutil 13:26:30 INFO - Cleaning up... 13:26:30 INFO - Return code: 0 13:26:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:26:30 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')]} 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:30 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')]} 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:30 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:30 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 13:26:30 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 13:26:30 INFO - Using env: {'DISPLAY': ':0', 13:26:30 INFO - 'HOME': '/home/cltbld', 13:26:30 INFO - 'LANG': 'en_US.UTF-8', 13:26:30 INFO - 'LANGUAGE': 'en_US:en', 13:26:30 INFO - 'LOGNAME': 'cltbld', 13:26:30 INFO - 'MAIL': '/var/mail/cltbld', 13:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:30 INFO - 'MOZ_NO_REMOTE': '1', 13:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:30 INFO - 'NO_EM_RESTART': '1', 13:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:30 INFO - 'PWD': '/builds/slave/test', 13:26:30 INFO - 'SHELL': '/bin/bash', 13:26:30 INFO - 'SHLVL': '1', 13:26:30 INFO - 'TERM': 'linux', 13:26:30 INFO - 'TMOUT': '86400', 13:26:30 INFO - 'USER': 'cltbld', 13:26:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:30 INFO - '_': '/tools/buildbot/bin/python'} 13:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:26:32 INFO - Installing collected packages: mozsystemmonitor 13:26:32 INFO - Running setup.py install for mozsystemmonitor 13:26:32 INFO - Successfully installed mozsystemmonitor 13:26:32 INFO - Cleaning up... 13:26:32 INFO - Return code: 0 13:26:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:32 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')]} 13:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:32 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')]} 13:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:32 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:32 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 13:26:32 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 13:26:32 INFO - Using env: {'DISPLAY': ':0', 13:26:32 INFO - 'HOME': '/home/cltbld', 13:26:32 INFO - 'LANG': 'en_US.UTF-8', 13:26:32 INFO - 'LANGUAGE': 'en_US:en', 13:26:32 INFO - 'LOGNAME': 'cltbld', 13:26:32 INFO - 'MAIL': '/var/mail/cltbld', 13:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:32 INFO - 'MOZ_NO_REMOTE': '1', 13:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:32 INFO - 'NO_EM_RESTART': '1', 13:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:32 INFO - 'PWD': '/builds/slave/test', 13:26:32 INFO - 'SHELL': '/bin/bash', 13:26:32 INFO - 'SHLVL': '1', 13:26:32 INFO - 'TERM': 'linux', 13:26:32 INFO - 'TMOUT': '86400', 13:26:32 INFO - 'USER': 'cltbld', 13:26:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:32 INFO - '_': '/tools/buildbot/bin/python'} 13:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:32 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:34 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26: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 13:26: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 13:26: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 13:26: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 13:26: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 13:26: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 13:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:35 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 13:26:35 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 13:26:35 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 13:26:35 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 13:26:35 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 13:26:35 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 13:26:35 INFO - Downloading docopt-0.6.1.tar.gz 13:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:35 INFO - Running setup.py install for blobuploader 13:26:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:35 INFO - Running setup.py install for requests 13:26:35 INFO - Running setup.py install for docopt 13:26:36 INFO - Successfully installed blobuploader requests docopt 13:26:36 INFO - Cleaning up... 13:26:36 INFO - Return code: 0 13:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:36 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:36 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 13:26:36 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 13:26:36 INFO - Using env: {'DISPLAY': ':0', 13:26:36 INFO - 'HOME': '/home/cltbld', 13:26:36 INFO - 'LANG': 'en_US.UTF-8', 13:26:36 INFO - 'LANGUAGE': 'en_US:en', 13:26:36 INFO - 'LOGNAME': 'cltbld', 13:26:36 INFO - 'MAIL': '/var/mail/cltbld', 13:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:36 INFO - 'MOZ_NO_REMOTE': '1', 13:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:36 INFO - 'NO_EM_RESTART': '1', 13:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:36 INFO - 'PWD': '/builds/slave/test', 13:26:36 INFO - 'SHELL': '/bin/bash', 13:26:36 INFO - 'SHLVL': '1', 13:26:36 INFO - 'TERM': 'linux', 13:26:36 INFO - 'TMOUT': '86400', 13:26:36 INFO - 'USER': 'cltbld', 13:26:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:36 INFO - '_': '/tools/buildbot/bin/python'} 13:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:36 INFO - Running setup.py (path:/tmp/pip-s3gCty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:36 INFO - Running setup.py (path:/tmp/pip-DGSRsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:36 INFO - Running setup.py (path:/tmp/pip-plS4Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:36 INFO - Running setup.py (path:/tmp/pip-lCScBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:36 INFO - Running setup.py (path:/tmp/pip-CYbtED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:36 INFO - Running setup.py (path:/tmp/pip-B6Dl18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:36 INFO - Running setup.py (path:/tmp/pip-kg09BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:36 INFO - Running setup.py (path:/tmp/pip-0na9w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:36 INFO - Running setup.py (path:/tmp/pip-5ELtg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:37 INFO - Running setup.py (path:/tmp/pip-6cUhKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:37 INFO - Running setup.py (path:/tmp/pip-ijiGI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:37 INFO - Running setup.py (path:/tmp/pip-IoSTtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:37 INFO - Running setup.py (path:/tmp/pip-WO9cCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:37 INFO - Running setup.py (path:/tmp/pip-5n1Jzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:37 INFO - Running setup.py (path:/tmp/pip-2PrURm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:37 INFO - Running setup.py (path:/tmp/pip-0kk95E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:37 INFO - Running setup.py (path:/tmp/pip-kSry1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:37 INFO - Running setup.py install for manifestparser 13:26:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Running setup.py install for mozcrash 13:26:37 INFO - Running setup.py install for mozdebug 13:26:37 INFO - Running setup.py install for mozdevice 13:26:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for mozfile 13:26:38 INFO - Running setup.py install for mozhttpd 13:26:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for mozinfo 13:26:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for mozInstall 13:26:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for mozleak 13:26:38 INFO - Running setup.py install for mozlog 13:26:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for moznetwork 13:26:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for mozprocess 13:26:38 INFO - Running setup.py install for mozprofile 13:26:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Running setup.py install for mozrunner 13:26:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:39 INFO - Running setup.py install for mozscreenshot 13:26:39 INFO - Running setup.py install for moztest 13:26:39 INFO - Running setup.py install for mozversion 13:26:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:39 INFO - Cleaning up... 13:26:39 INFO - Return code: 0 13:26:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:39 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:39 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 13:26:39 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 13:26:39 INFO - Using env: {'DISPLAY': ':0', 13:26:39 INFO - 'HOME': '/home/cltbld', 13:26:39 INFO - 'LANG': 'en_US.UTF-8', 13:26:39 INFO - 'LANGUAGE': 'en_US:en', 13:26:39 INFO - 'LOGNAME': 'cltbld', 13:26:39 INFO - 'MAIL': '/var/mail/cltbld', 13:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:39 INFO - 'MOZ_NO_REMOTE': '1', 13:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:39 INFO - 'NO_EM_RESTART': '1', 13:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:39 INFO - 'PWD': '/builds/slave/test', 13:26:39 INFO - 'SHELL': '/bin/bash', 13:26:39 INFO - 'SHLVL': '1', 13:26:39 INFO - 'TERM': 'linux', 13:26:39 INFO - 'TMOUT': '86400', 13:26:39 INFO - 'USER': 'cltbld', 13:26:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:39 INFO - '_': '/tools/buildbot/bin/python'} 13:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:39 INFO - Running setup.py (path:/tmp/pip-gge7Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:39 INFO - Running setup.py (path:/tmp/pip-rCj30A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:39 INFO - Running setup.py (path:/tmp/pip-7PSP1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:39 INFO - Running setup.py (path:/tmp/pip-loW7Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:39 INFO - Running setup.py (path:/tmp/pip-FW7K2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:39 INFO - Running setup.py (path:/tmp/pip-Drcbig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:40 INFO - Running setup.py (path:/tmp/pip-4ApiC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:40 INFO - Running setup.py (path:/tmp/pip-Eeo1Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:40 INFO - Running setup.py (path:/tmp/pip-PBNMXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:40 INFO - Running setup.py (path:/tmp/pip-ZU7CZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:40 INFO - Running setup.py (path:/tmp/pip-uHpY40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:40 INFO - Running setup.py (path:/tmp/pip-gyax6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:40 INFO - Running setup.py (path:/tmp/pip-jaJQgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:40 INFO - Running setup.py (path:/tmp/pip-pMXyaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:40 INFO - Running setup.py (path:/tmp/pip-mnURo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:40 INFO - Running setup.py (path:/tmp/pip-KXWH2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:40 INFO - Running setup.py (path:/tmp/pip-F27WGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:40 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)) 13:26:40 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)) 13:26:40 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)) 13:26:40 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)) 13:26:40 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)) 13:26:40 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)) 13:26:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:40 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 13:26:40 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 13:26:40 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 13:26:40 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 13:26:40 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 13:26:40 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 13:26:42 INFO - Downloading blessings-1.6.tar.gz 13:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:42 INFO - Installing collected packages: blessings 13:26:42 INFO - Running setup.py install for blessings 13:26:42 INFO - Successfully installed blessings 13:26:42 INFO - Cleaning up... 13:26:42 INFO - Return code: 0 13:26:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:43 INFO - Reading from file tmpfile_stdout 13:26:43 INFO - Current package versions: 13:26:43 INFO - argparse == 1.2.1 13:26:43 INFO - blessings == 1.6 13:26:43 INFO - blobuploader == 1.2.4 13:26:43 INFO - docopt == 0.6.1 13:26:43 INFO - manifestparser == 1.1 13:26:43 INFO - mozInstall == 1.12 13:26:43 INFO - mozcrash == 0.17 13:26:43 INFO - mozdebug == 0.1 13:26:43 INFO - mozdevice == 0.48 13:26:43 INFO - mozfile == 1.2 13:26:43 INFO - mozhttpd == 0.7 13:26:43 INFO - mozinfo == 0.9 13:26:43 INFO - mozleak == 0.1 13:26:43 INFO - mozlog == 3.1 13:26:43 INFO - moznetwork == 0.27 13:26:43 INFO - mozprocess == 0.22 13:26:43 INFO - mozprofile == 0.28 13:26:43 INFO - mozrunner == 6.11 13:26:43 INFO - mozscreenshot == 0.1 13:26:43 INFO - mozsystemmonitor == 0.0 13:26:43 INFO - moztest == 0.7 13:26:43 INFO - mozversion == 1.4 13:26:43 INFO - psutil == 3.1.1 13:26:43 INFO - requests == 1.2.3 13:26:43 INFO - wsgiref == 0.1.2 13:26:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:43 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 13:26:43 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 13:26:43 INFO - Using env: {'DISPLAY': ':0', 13:26:43 INFO - 'HOME': '/home/cltbld', 13:26:43 INFO - 'LANG': 'en_US.UTF-8', 13:26:43 INFO - 'LANGUAGE': 'en_US:en', 13:26:43 INFO - 'LOGNAME': 'cltbld', 13:26:43 INFO - 'MAIL': '/var/mail/cltbld', 13:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:43 INFO - 'MOZ_NO_REMOTE': '1', 13:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:43 INFO - 'NO_EM_RESTART': '1', 13:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:43 INFO - 'PWD': '/builds/slave/test', 13:26:43 INFO - 'SHELL': '/bin/bash', 13:26:43 INFO - 'SHLVL': '1', 13:26:43 INFO - 'TERM': 'linux', 13:26:43 INFO - 'TMOUT': '86400', 13:26:43 INFO - 'USER': 'cltbld', 13:26:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:43 INFO - '_': '/tools/buildbot/bin/python'} 13:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 INFO - Cleaning up... 13:26:43 INFO - Return code: 0 13:26:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:43 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 13:26:43 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 13:26:43 INFO - Using env: {'DISPLAY': ':0', 13:26:43 INFO - 'HOME': '/home/cltbld', 13:26:43 INFO - 'LANG': 'en_US.UTF-8', 13:26:43 INFO - 'LANGUAGE': 'en_US:en', 13:26:43 INFO - 'LOGNAME': 'cltbld', 13:26:43 INFO - 'MAIL': '/var/mail/cltbld', 13:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:43 INFO - 'MOZ_NO_REMOTE': '1', 13:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:43 INFO - 'NO_EM_RESTART': '1', 13:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:43 INFO - 'PWD': '/builds/slave/test', 13:26:43 INFO - 'SHELL': '/bin/bash', 13:26:43 INFO - 'SHLVL': '1', 13:26:43 INFO - 'TERM': 'linux', 13:26:43 INFO - 'TMOUT': '86400', 13:26:43 INFO - 'USER': 'cltbld', 13:26:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:43 INFO - '_': '/tools/buildbot/bin/python'} 13:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:43 INFO - Downloading/unpacking jsonschema 13:26:43 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 13:26:43 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 13:26:43 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 13:26:43 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 13:26:43 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 13:26:43 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 13:26:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:45 INFO - Downloading/unpacking functools32 (from jsonschema) 13:26:45 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 13:26:45 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 13:26:45 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 13:26:45 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 13:26:45 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 13:26:45 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 13:26:45 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:45 INFO - warning: no files found matching '*.txt' 13:26:45 INFO - no previously-included directories found matching 'build' 13:26:45 INFO - no previously-included directories found matching 'dist' 13:26:45 INFO - no previously-included directories found matching '.git*' 13:26:45 INFO - Installing collected packages: jsonschema, functools32 13:26:45 INFO - Running setup.py install for functools32 13:26:45 INFO - warning: no files found matching '*.txt' 13:26:45 INFO - no previously-included directories found matching 'build' 13:26:45 INFO - no previously-included directories found matching 'dist' 13:26:45 INFO - no previously-included directories found matching '.git*' 13:26:45 INFO - Successfully installed jsonschema functools32 13:26:45 INFO - Cleaning up... 13:26:45 INFO - Return code: 0 13:26:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:45 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 0x7fa34d111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', '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 13:26:45 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 13:26:45 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 13:26:45 INFO - Using env: {'DISPLAY': ':0', 13:26:45 INFO - 'HOME': '/home/cltbld', 13:26:45 INFO - 'LANG': 'en_US.UTF-8', 13:26:45 INFO - 'LANGUAGE': 'en_US:en', 13:26:45 INFO - 'LOGNAME': 'cltbld', 13:26:45 INFO - 'MAIL': '/var/mail/cltbld', 13:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:45 INFO - 'MOZ_NO_REMOTE': '1', 13:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:45 INFO - 'NO_EM_RESTART': '1', 13:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:45 INFO - 'PWD': '/builds/slave/test', 13:26:45 INFO - 'SHELL': '/bin/bash', 13:26:45 INFO - 'SHLVL': '1', 13:26:45 INFO - 'TERM': 'linux', 13:26:45 INFO - 'TMOUT': '86400', 13:26:45 INFO - 'USER': 'cltbld', 13:26:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:45 INFO - '_': '/tools/buildbot/bin/python'} 13:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:46 INFO - Downloading/unpacking flake8 13:26:46 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 13:26:46 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 13:26:46 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 13:26:46 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 13:26:46 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 13:26:46 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 13:26:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:26:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:26:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:48 INFO - no previously-included directories found matching 'docs/_build' 13:26:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:26:48 INFO - Running setup.py install for pep8 13:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:48 INFO - no previously-included directories found matching 'docs/_build' 13:26:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:26:48 INFO - Cleaning up... 13:26:48 INFO - Return code: 0 13:26:48 INFO - Running post-action listener: _resource_record_post_action 13:26:48 INFO - Running post-action listener: _start_resource_monitoring 13:26:49 INFO - Starting resource monitoring. 13:26:49 INFO - ##### 13:26:49 INFO - ##### Running install step. 13:26:49 INFO - ##### 13:26:49 INFO - Running pre-action listener: _resource_record_pre_action 13:26:49 INFO - Running main action method: install 13:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:49 INFO - Reading from file tmpfile_stdout 13:26:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:49 INFO - Reading from file tmpfile_stdout 13:26:49 INFO - Output received: 13:26:49 INFO - Usage: mozinstall [options] installer 13:26:49 INFO - Options: 13:26:49 INFO - -h, --help show this help message and exit 13:26:49 INFO - -d DEST, --destination=DEST 13:26:49 INFO - Directory to install application into. [default: 13:26:49 INFO - "/builds/slave/test"] 13:26:49 INFO - --app=APP Application being installed. [default: firefox] 13:26:49 INFO - mkdir: /builds/slave/test/build/application 13:26:49 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'] 13:26:49 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 13:27:04 INFO - Reading from file tmpfile_stdout 13:27:04 INFO - Output received: 13:27:04 INFO - /builds/slave/test/build/application/firefox/firefox 13:27:04 INFO - Running post-action listener: _resource_record_post_action 13:27:04 INFO - ##### 13:27:04 INFO - ##### Running run-tests step. 13:27:04 INFO - ##### 13:27:04 INFO - Running pre-action listener: _resource_record_pre_action 13:27:04 INFO - Running main action method: run_tests 13:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:04 INFO - Python 2.7.3 13:27:04 INFO - Return code: 0 13:27:04 INFO - grabbing minidump binary from tooltool 13:27:04 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')]} 13:27:04 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 0x1724410>, '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 0x1725310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17257a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:04 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 13:27:04 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 13:27:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:04 INFO - Return code: 0 13:27:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:27:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:27:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:27:05 INFO - Return code: 0 13:27:05 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:27:05 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 13:27:05 INFO - Using env: {'DISPLAY': ':0', 13:27:05 INFO - 'HOME': '/home/cltbld', 13:27:05 INFO - 'LANG': 'en_US.UTF-8', 13:27:05 INFO - 'LANGUAGE': 'en_US:en', 13:27:05 INFO - 'LOGNAME': 'cltbld', 13:27:05 INFO - 'MAIL': '/var/mail/cltbld', 13:27:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:05 INFO - 'MOZ_NO_REMOTE': '1', 13:27:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:05 INFO - 'NO_EM_RESTART': '1', 13:27:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:05 INFO - 'PWD': '/builds/slave/test', 13:27:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:05 INFO - 'SHELL': '/bin/bash', 13:27:05 INFO - 'SHLVL': '1', 13:27:05 INFO - 'TERM': 'linux', 13:27:05 INFO - 'TMOUT': '86400', 13:27:05 INFO - 'USER': 'cltbld', 13:27:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454', 13:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:05 INFO - '_': '/tools/buildbot/bin/python'} 13:27:05 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:27:06 INFO - mozversion application_buildid: 20160425103006 13:27:06 INFO - mozversion application_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:27:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:27:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:27:06 INFO - mozversion application_name: Firefox 13:27:06 INFO - mozversion application_remotingname: firefox-dev 13:27:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:27:06 INFO - mozversion application_vendor: Mozilla 13:27:06 INFO - mozversion application_version: 48.0a2 13:27:06 INFO - mozversion platform_buildid: 20160425103006 13:27:06 INFO - mozversion platform_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:27:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:27:06 INFO - mozversion platform_version: 48.0a2 13:27:06 INFO - using testdate: 1461616026 13:27:06 INFO - actual date: 1461616026 13:27:06 INFO - starting webserver on 'localhost:58007' 13:27:06 INFO - SUITE-START | Running 2 tests 13:27:06 INFO - TEST-START | dromaeo_css 13:27:06 INFO - operating with platform_type : linux_ 13:27:06 INFO - Initialising browser for dromaeo_css test... 13:27:06 INFO - TEST-INFO | started process 15572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LDK5e/profile http://localhost:58007/getInfo.html) 13:27:09 INFO - PROCESS | 15572 | __metrics Screen width/height:1600/1200 13:27:09 INFO - PROCESS | 15572 | colorDepth:24 13:27:09 INFO - PROCESS | 15572 | Browser inner width/height: 1024/697 13:27:09 INFO - PROCESS | 15572 | __metrics 13:27:10 ERROR - PROCESS | 15572 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:27:11 INFO - TEST-INFO | 15572: exit 0 13:27:11 INFO - Browser initialized. 13:27:11 INFO - Running cycle 1/1 for dromaeo_css test... 13:27:11 INFO - TEST-INFO | started process 15663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LDK5e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:23 INFO - PROCESS | 15663 | RSS: Main: 142639104 13:27:23 INFO - PROCESS | 15663 | 13:28:14 INFO - PROCESS | 15663 | 1461616094442 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] 13:30:21 INFO - PROCESS | 15663 | Cycle 1(1): loaded http://localhost:58007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58007/tests/dromaeo/cssquery-ext.html) 13:30:22 INFO - PROCESS | 15663 | RSS: Main: 256868352 13:30:22 INFO - PROCESS | 15663 | 13:33:25 INFO - PROCESS | 15663 | Cycle 1(1): loaded http://localhost:58007/tests/dromaeo/cssquery-ext.html (next: http://localhost:58007/tests/dromaeo/cssquery-jquery.html) 13:33:25 INFO - PROCESS | 15663 | RSS: Main: 226123776 13:33:25 INFO - PROCESS | 15663 | 13:36:27 INFO - PROCESS | 15663 | Cycle 1(1): loaded http://localhost:58007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58007/tests/dromaeo/cssquery-mootools.html) 13:36:28 INFO - PROCESS | 15663 | RSS: Main: 224821248 13:36:28 INFO - PROCESS | 15663 | 13:39:30 INFO - PROCESS | 15663 | Cycle 1(1): loaded http://localhost:58007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58007/tests/dromaeo/cssquery-prototype.html) 13:39:30 INFO - PROCESS | 15663 | RSS: Main: 219205632 13:39:30 INFO - PROCESS | 15663 | 13:42:33 INFO - PROCESS | 15663 | Cycle 1(1): loaded http://localhost:58007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58007/tests/dromaeo/cssquery-yui.html) 13:42:33 INFO - PROCESS | 15663 | RSS: Main: 214376448 13:42:33 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | Cycle 1(1): loaded http://localhost:58007/tests/dromaeo/cssquery-yui.html (next: http://localhost:58007/tests/dromaeo/cssquery-dojo.html) 13:45:36 INFO - PROCESS | 15663 | RSS: Main: 258871296 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | __start_tp_report 13:45:36 INFO - PROCESS | 15663 | _x_x_mozilla_page_load 13:45:36 INFO - PROCESS | 15663 | _x_x_mozilla_page_load_details 13:45:36 INFO - PROCESS | 15663 | |i|pagename|runs| 13:45:36 INFO - PROCESS | 15663 | |0;dojo.html;3329.1510664780476;3385.6445073267323;3414.9487757683637;3422.401079811034;3458.2391873787774;5629.40891206423;5633.183188437674;5643;5666.575006874491;5687.516561092307;5636.535495746484;5675.035244008518;5678.943210567893;5682.289713785777;5690.2033715279895;4946.802127914897;5114.948850511494;5128.589712822965;5172.767225474844;5205.583553315726;5143;5208.192730126836;5209.791608335681;5210.9218361724415;5214.895702085956;5127.051495473349;5181.792728290864;5183.611229157809;5191.4548972357925;5195.298634684326;5180.792768289282;5183.818566350197;5203.9219411708855;5213;5241.973790131063;5012.172991456406;5074.13739664258;5102.6428150029515;5121.129408000649;5144.408393034774;5526.088195447746;5545.584081193927;5567.582431317667;5588.385277619459;5601.29983752031;6004.639721616673;6025.698715064229;6026.186464827236;6028.4272994065495;6032.547558933097;6008.7896923607905;6061.969690151521;6078.300995385543;6105.389461053859;6114.602550834226;5626.521745651625;5676.375598684142;5679.091345384719;5685.289338832646;5687.374388817227;6008.819735407945;6177.135201071764;6190.969045154746;6192.59748116371;6198.2871969723155;5846.912296315473;5910.852228694317;5914.822555323347;5931.6441013539325;5933.3473317934995;5990.101484777231;5996.760129594767;5996.9805133127475;6013.819585412444;6030.396960303934;5865.706714664249;5956.493698035629;5973.940260597338;5992.700364981733;6002.129691194752;5994.610350327215;5997.310309314397;6018.337982821886;6032.125341825411;6065.4541091302;4553.066621342617;4562.8631141065825;4567.725936443758;4569.200389931749;4589.655775816827;4036.253293140778;4045.211183819127;4089.3252613319064;4120.979395103005;4124.422580838685;5748.856278593069;5758.596898217084;5773.39379365169;5783;5792.855178620568;6020.969895150583;6040.818775436744;6072.726727297282;6073.423024812636;6075.544334174954;5571.220029195916;5631.465010823965;5709.05800542914;5721.942780572141;5741.052726300114;5185.144451165591;5209.6874187548865;5210.557102646242;5211.973940130275;5214.765335559833;6250.218722659668;6305.085762564402;6308.337624549356;6311.526635502356;6316.368363163647;5936.525077993664;5991.970040149771;6053.636781793107;6083.908741368795;6093.238345206849;6252.7026288191155;6301.905471417841;6308.684565771601;6310.400511951358;6313.842153946188;5793.623414478214;5953.226080609493;5967.433093856077;5977.013792724326;6001.339852616296;6020.638761674313;6076.54425918049;6082.635041897501;6098.054801505774;6124.234470691164;5790.536757059509;5839.416058394127;5849.444302791228;5853.736581853742;5879.764809407576;5742.741576629145;5805.593608447368;5850.502707269759;5859.531237501075;5879.412058794086;5809.622374545641;5810.1575271586225;5815.912761308499;5817.970910145422;5853.795117171049;5934.465898069195;5948.256467941507;5949.434803693643;5951.702414879325;5969.074793407029;5684.573656975661;5778.27771528559;5780.132980053026;5827.184194212899;5862.794802181903 13:45:36 INFO - PROCESS | 15663 | |1;ext.html;618.3630860213979;644.8001119652911;656.8259411256017;667.7429189761943;672.0792514255471;29573.704262957363;40015.599844001554;40956.18087638253;41054.794726026405;41061.794691026575;43796;44834;44894;44947.77526112373;44951.775241123745;8243.464174828618;8745.956270218656;8982.955085224565;10260.384376937407;10491;10426.218033647468;10615.256932014761;10617.681469555888;10621.78756424871;10626.096781773558;10605.310654807452;10746.086582640484;10748.892511074906;10750.892491075107;10751.086157676607;7976.920230797676;10439.895601043969;10646.414447205401;10683.198760093024;10684.198685098649;10442.373457592568;10711.089557387631;10732.839007414896;10735.62425315118;10746.516406761637;40713.38929916054;41297.793511032556;41344;41575.58424415747;41613;3629.4374371972385;3665.2303016366595;3795.8291876865333;3953.1698343347643;3989.5412027616903;34322.65677343245;35664.108397290016;35730.821345893106;35795.28409431823;35858;4622.6070783983405;4660.254359302529;4711.740854253015;4737.336772851769;4774.64190185734;358926;363335;363880;364049;364231;37021.81489092537;71472.64263678648;71489.2851071493;71949.64025179841;72176.63911680409;38568.6143138565;38648.22703545913;38736.22527549433;38770.80614596909;38891.80554097211;14239.430422782973;15169.469068582546;15394.846051539342;15415.229238538028;15419;11966.461509232106;12214.145009849402;12234.510619575118;12244.265344079384;12249.081318901119;9348.626054957862;9417.434953902652;9419.24646028316;9465.66870159541;9511.524423778921;3578.1054736315923;3643.216708407705;3654.835532401048;3669.8806863906766;3670.33933891902;1030.7577719235974;1104.166354402437;1142.2632402100764;1158.2760774515928;1178.3577950017261;34809;34940;35062.47406288908;35088.298234035174;35274.11814704653;1184.4847491341295;1191.6544202181444;1214.2107630040368;1221.82283568882;1295.9481620735064;17777.46667599974;18293.451196464128;18358.265669373075;18363.08184590792;18366.90816545909;530607;536272;536302;536421;537185;63718.681406592674;64604;64624.67687661532;64668.353316467175;64679.67660161763;1452.8837692984537;1465.3039806092022;1495.1178804505394;1505.5558610210014;1581.5887869153873;32425.837870810494;33643.83178084094;34060;34705;35134.297314054085;50744;50758.23862642137;50997.49002509927;51011;51221.23168152406;263573;264740;267212;267569;267772;25776.742232577435;28882.566761499016;29281.707182927898;31860.203494912814;41350.586494135874;45478.73004147748;45585.544144559455;45690.54309456863;45803.54196457993;46405.53594464012;42159.36760948649;42583;42734.78632606817;43755;44335.334969976124;41652.16695666009;42365.576344236164;42759.144817104105;42974;43602;42542;42964.35553466763;43059.784701077544;43144.56855431531;43347.133057339306;36308;36993.81503092467;37647.24705505929;38022.8098859515;38574.80712596419;27190.456190876466;28936;29224.70775292305;29259.7074029257;29645.703542964293 13:45:36 INFO - PROCESS | 15663 | |2;jquery.html;403.2117210852782;409.844259181511;410.1366623258042;414.6330497509705;417.7660510114336;15202;18921.810781892178;19623.705644415346;19653.50866228345;20299.898500507512;14324.212168330763;15965.760513592306;16093.517194484155;16819.243134058965;17292.394766183184;5598.216249725042;5732.197492351074;5760.8271751847515;5785.334686511042;5789.131630255474;5718.914216286759;5749.913751293734;5787.450192231752;5793.5365170786445;5795.565332600051;4244.214820258262;6155.199824022893;6399.936000640004;6459.192600924885;6463.612183269019;6323.146375239376;6382.042693595951;6392.16901802765;6412.454941329993;6438.066480360345;5487.506124448819;5626.127950167731;5652.265205523297;5671.914921276184;5672.659640421588;22472.32583022512;23642.527149457088;23700.881495592585;24576.139835105685;24677.136300229584;2578.6003169508567;2674.8261363011343;2717.6467059282363;2966.4067186562556;2972.959464187517;14838.809501230337;15137.772933406008;15258.08451492914;15448.922755386264;15779.447719329768;2020.8686435381653;2101.2645574049116;2149.4518897681146;2202.196198387593;2236.31226942995;79434;83559.5822020886;85228.57385713032;85331;86931.56534217352;10882.891171088346;11034.117270618332;11095.722606934729;11136.164787640959;11232.719182020352;15438;15479.767803482957;15555.844441555666;15560.066396016275;15594.376224951102;8104.918950810535;8304.70933517324;8404.453710508797;8440.788980275542;8454.957725211458;7996.32031277348;8016.238457346542;8031.678732850737;8137.511749295061;8144.83710325802;4371.628411584988;4470.547072201548;4558.33904083906;4748.621472591604;4829.541193586604;1908.551490399755;1923.9326623568109;1929.305450037985;1939.3406241877829;1964.204497178645;1047.5495536919045;1076.0701085012495;1080.6271836216492;1120.4285814234636;1196.4795314038247;19782.20871165166;19937;20175.39473815788;20181.697274540893;20584.794152058286;1078.978420431587;1080.3247970018738;1100.372787511111;1103.757173421846;1107.9612213572648;11064.391458469701;11485.310881347146;11569.363684997406;11647.59233426826;11666.88333116675;549215;554821;571887;573450;573551;97306.5134674322;98598.7846805791;98796.50601747089;100761.49619251856;100965;1080.0441609175937;1110.5280255891214;1124.8368986496912;1141.560499207811;1147.1109889835445;17928.551786204927;17940.102994850466;17970.10149492494;18045.368412105512;18326.81673183251;31858.68141318557;40723;40861.795691021354;41078.1784364317;42262.788686056374;59395;60515;61002;61669.691651541456;61800.38199618126;8282.585870706562;8299.543525105935;8457.746267611981;8572.05707372176;8615.052344242255;10377.740556486147;13389.799153012518;13491.460341586619;13536.187828730308;13578.592642220749;11214.943925280322;11905.702357441134;12081.093917956365;12280.692982675504;12938.482460701467;12413.131080824256;12505.499780008699;12581.622551323475;12608.621741347773;12640.620781376574;12711.872881271069;12725.745485090432;12892.29092399927;13134.40895159701;13283.070185086952;8178.754637360888;8203;8226.177382261725;8289.875651865106;8888.288936884905;12026.639200823989;12548.24710517372;12610.936945315214;13005.869941300843;13038.869611304144 13:45:36 INFO - PROCESS | 15663 | |3;mootools.html;1401.2433286025546;1564.9608759781008;1595.3937503748575;1768.8584913206944;1919.0884329943278;7581.431392645553;8372.41393102483;8554.059053504125;8560.229579337858;8578.270846978014;8223.383246256524;8437.282830959375;8452.577371131449;8460.450070745397;8475.110113438093;2363.7163540375136;2396.317049640853;2398.9760102398927;2399.448126930798;2403.062805505854;2346.718393792747;2363.61000434928;2392.1149174805346;2395.7604239576076;2415.0943396226417;2312.3063081075693;2337.1819863047967;2342.8711420871846;2343.320437073255;2345.9296221113395;2305.250793492122;2322.837401381904;2334.4630734930975;2337.9064837406568;2355.081518207883;2289.5764283607587;2312.190733243368;2315.9421014474606;2321.0599707118645;2323.4772176260376;8410.621522031523;8582.098879617613;8633.784155396103;8650.524221167832;8654.394192406535;4906.460289368202;5064.3163172971545;5098.464661210556;5100.2349647553165;5102.923456148161;3460.636633153508;3494.5457090578316;3550.6271841456532;3570.4465807799834;3571.607123216444;1177.4348312809814;1198.592478557286;1211.6789050901518;1235.4810979388678;1258.0753146437362;11643.476043578059;11773.058155347637;12048.759024819454;12119.757604847853;12121.45453454588;4430.357598148251;4479.61923236522;4499.752513611717;4501.077279157765;4627.722336659744;9620.71137865865;9685.079917407835;9685.225181985565;9716.61133554664;9744.853827192597;4931.161702510582;4950.9009819803405;4957.380327459067;4961.479044700254;4966.279889416014;4246;4476.865694029184;4520.16376970255;4623.098495793288;4630.32860235264;3936.252112098692;3939.7242193046786;4023.5574086850424;4042.110735638155;4063.4920634920636;1170.4440390814466;1185.5909711149638;1188.744419949715;1211.8485189351331;1235.437875766524;784.835184611238;888.7733627924968;990.9752256193652;1008.5159123620557;1017.4048181813722;5748.770049197985;5855.619384739978;5875.118732190205;5904.291485021739;5927.229460170151;970.3595626886221;988.8121256961155;1039.4387031003173;1045.896579109032;1093.6117678224116;4006.659433948147;4219.873403797891;4267.594578515036;4270.7864606769535;4320.373545835836;10376.948115259376;10809.67570972872;10813.243072984815;10828.945855270673;10847.349159050482;10164.186865050926;10652.094571961316;10724.088452481627;10771.83842242367;10859.565617375374;7746.651400686983;7821.882671759929;7826.882596761167;7934.563599001995;7938.285554300141;5723.313202415737;5840.853978650568;5847.94152058474;5899.439553242435;5955.017422125474;9791.167750741266;9861.506924653882;10074.899251007397;10146.239032072477;10211.7447063824;10168.49157542105;10212.489375531046;10257.333273337508;10327.32872363294;10489.685309440729;7714;7787.338076263581;7864.213578642319;7898.723544675909;7906.327962123284;8330.333573314241;8519.148085191679;8552.529610871461;8555.31557475388;8563.82872342562;6534.379233972955;7626.580538070238;7653.808654783452;7753.573553454614;7808.258215469521;7434.925650743423;7448.702051917862;7575.280348366897;7582.241775822595;7674.309312161932;6627.436667883284;6707.1616047994;6710.094137291403;6719.529632925648;6725.361090696376;4956.578690811177;5010.398752149766;5166.147585648326;5186.792528298825;5197.584193264605;5271.736413179402;5342;5369.677819330853;5457.508824205682;5483.095289277225 13:45:36 INFO - PROCESS | 15663 | |4;prototype.html;336.95619569455965;338.57677902621725;341.8718229841523;347.56380742168574;348.1071052749695;5399.89200215996;5433.750237445385;5441.2654291670615;5475.561955043602;5481.945180548193;5353.892922141555;5361.82845947391;5402.405735369116;5412.972935135319;5424.701641409731;4017.5781542937934;4075.714699971003;4233.513145988205;4239.703220774547;4249.46881639795;4189.560096189902;4226.936595951063;4240.787960601973;4255.276602977486;4273.1240095780295;4004.679625629957;4209.873703788876;4210.863066971916;4218.114196018824;4232.661387089025;4073.87778366648;4196.684619150868;4203.91592168155;4220.936685949682;4224.134052519226;3719.047500062489;3728.45937339087;3741.8877433677035;3744.8876533704033;3754.0614846288427;5212.921806172911;5238.659487133325;5254.290670759475;5256.160343879612;5264.499872512105;4540.6594505411895;4762.452317983407;4775.880602984953;4782.306565547976;4785.641076919245;5652.236948012048;5658.207850900877;5663.716814159276;5681.204631351614;5697.259356283698;4053.493313335833;4058.898527536806;4086.2440448516822;4093.2222877653153;4094.28350038745;5643.181738647873;5912.645241285493;5937.732802023919;5951.107333899907;5952.851178720567;4081.3061779497557;4103.4460347852655;4105.67154627629;4112.814923328458;4123.958760412417;4155.8337666493;4163.791810409528;4169.895752606149;4177.8328866845595;4178.704601573522;4678.689966809299;4679.742614156254;4708.340832283483;4730.503297153749;4732.195526760459;5655.660660360391;5659.5755318351285;5686.545076393879;5707.514861236758;5733.369329373765;1499.7525408307506;1517;1517.3399571186349;1519.9088054716754;1521.9010764300285;926.9571731801723;936.2089034765612;970.5195928015678;988.9653862114792;1019.0726438940677;5840.8247752567495;5862.915360658292;5893.882122357614;5895.941040589625;5909.29088509373;6228.22147231596;6232.532560058014;6258.655773932386;6265.248170219603;6272.6236425814595;5728.455796699307;5827.417258274223;5869.383714709979;5888.882222355529;5894.705264736832;3277.295381492943;3308.6195087564756;3310.1062713067336;3321.8671253149605;3333.9833300833825;6257.405546473078;6381.585196962275;6434.871302574016;6476.449501792306;6498.707558159894;6318.589291696117;6320.55756097078;6322.968385158137;6372.502461921445;6375.489960803125;6293.748250070037;6398.392152745575;6417.775377861846;6434.812163864309;6437.871242575122;6162.599431036968;6195.287541932736;6205.03821907605;6209.192804935329;6212.565120441706;6095.329513753572;6100.633961962297;6106.816795496142;6130.264368275835;6139.723712432862;6196.690165491617;6393.776217832354;6408.9038664421005;6426.871462570816;6442.065900444503;4273.18809426208;4294.506131794758;4310.719803212781;4313.568643135662;4314.331278651814;6034.306054803754;6147.415995480422;6187.597806142587;6196.256449226122;6221.035739460391;5974.880502390015;5977.193078934288;5999.970000149971;6002.189704389852;6026.668533230714;5981.641101533922;5985.491233245223;6002.579819412774;6003.6998150093195;6014.097885317237;5278.498542638443;5376.596755243294;5611.943880561143;5745.2818397700285;5914.763409463573;5620.606557541097;5698.80325131727;5743.707665775167;5752.741126649227;5813.534917206698;5477.233187353853;5618;5624.353199382123;5654.3497497788285;5656.151577263443 13:45:36 INFO - PROCESS | 15663 | |5;yui.html;899.9640014399424;902.634433054613;903.119458527935;919.5907821019645;925.9166674999249;14580.70838583229;14973.251337433112;15045.924770376147;16032.75950860735;16562.254698538563;15599;15699.058056516616;15774.605634859134;15784.763228551581;15803;728.8979542864004;872.8036191856845;890.5280201493202;903.3902116071658;908.5638893331205;884.0717246890771;887.5118684723409;891.5765011619494;892.0054139634293;892.6920212526668;945.8533927241289;951.0204489375953;952.5808644196532;954.3128947158035;954.89973552777;773.8916551682769;788.0976282156898;790.9129995700468;909.895362033368;947.6777895515523;690.0305071374727;690.2372877969822;691.3294104718415;691.498663468986;691.5297597633607;15929.04425734448;15985.280662370222;15998.280077396545;16018.279177437043;16048.75926861098;14468.27658617065;14748.336324865406;14873.346727355247;14891.47879824201;14979.251037448084;12494.500219991189;12611.93694031524;12645.936770316182;12665.05012124085;12809.679758006032;4069.165821006716;4101.487314085739;4106.568810274938;4148.43996060531;4208.9789551052045;65082.67458662677;66962.66518667375;67132;67250.66374668095;67471.28907910064;11329.660110196708;11396.008555232554;11416.143789215675;11565.710857228469;12050.819237711441;20663.17347306121;20928.16287348489;20966.16135354569;20978.475538111365;20997.580048398948;8327.708530201535;8380.455270407405;8449.36629752771;8516.74449766508;8735.1701588349;4884.633652476078;5025.195968644999;5037.798488060436;5052.216906379444;5178.585713142939;3818.5417749870194;3966.861159859391;3967.742096763759;3972.741771784825;3979.9204015919518;695.8051745511265;702.8734827731057;713.0587624335827;714.9642517874189;715;678.0338018323869;701.8140192848899;759.5860256160406;778.381186956371;814.0516298512285;9981.950090249502;10118.08937195656;10235.948820255851;10353.171746260281;10428.530716117793;782.776908581063;783.8941742864754;806.5040000399712;810.8824220487996;821.219841150909;4735.83424580138;4985.675931064469;5018.84943451697;5041.319421878073;5042;69990.65004674943;71623;72086.279137209;72313;73316;62410.37589624045;62492;62678;64510;65827.01259481111;56866.14700779492;57066;57076.143857842166;57112;57629.99999999916;8558.914410856061;8631.611577478903;8733.78165545841;8786.824263514822;8849.734507964771;36180;36986.260274793814;37363.252734945694;37917;38196.42705359366;47744.2838357418;50854;51694;51859.2221116676;52219.73890130677;12063.879361206627;12088;12248.142630015813;12318.81521777192;12531.686707832378;13126.278054706701;13707.725845483234;13836.239006854317;14252.287385630885;14320.06919550226;10338.896611033793;13338.93330533341;14115.647108822362;14534.781978270123;14590.927045364706;13649.522266720616;13779.104358216684;14077.859221408065;14867.330970106155;14871;13349.532766353132;13371.732565348833;13419.731605368033;14089.295535222993;14093.224872631694;11638.88361116412;11908.464119114833;12205.267683938991;12215.75568488643;12531.122821402414;11246.662600121683;11876.80452449707;11895;11916.642500724993;12030.27818330868 13:45:36 INFO - PROCESS | 15663 | __end_tp_report 13:45:36 INFO - PROCESS | 15663 | __start_cc_report 13:45:36 INFO - PROCESS | 15663 | _x_x_mozilla_cycle_collect,904 13:45:36 INFO - PROCESS | 15663 | __end_cc_report 13:45:36 INFO - PROCESS | 15663 | __startTimestamp1461617136392__endTimestamp 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | ------- Summary: start ------- 13:45:36 INFO - PROCESS | 15663 | Number of tests: 6 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | [#0] dojo.html Cycles:165 Average:5609.89 Median:5809.62 stddev:623.46 (10.7%) stddev-sans-first:599.15 13:45:36 INFO - PROCESS | 15663 | Values: 3329.2 3385.6 3414.9 3422.4 3458.2 5629.4 5633.2 5643.0 5666.6 5687.5 5636.5 5675.0 5678.9 5682.3 5690.2 4946.8 5114.9 5128.6 5172.8 5205.6 5143.0 5208.2 5209.8 5210.9 5214.9 5127.1 5181.8 5183.6 5191.5 5195.3 5180.8 5183.8 5203.9 5213.0 5242.0 5012.2 5074.1 5102.6 5121.1 5144.4 5526.1 5545.6 5567.6 5588.4 5601.3 6004.6 6025.7 6026.2 6028.4 6032.5 6008.8 6062.0 6078.3 6105.4 6114.6 5626.5 5676.4 5679.1 5685.3 5687.4 6008.8 6177.1 6191.0 6192.6 6198.3 5846.9 5910.9 5914.8 5931.6 5933.3 5990.1 5996.8 5997.0 6013.8 6030.4 5865.7 5956.5 5973.9 5992.7 6002.1 5994.6 5997.3 6018.3 6032.1 6065.5 4553.1 4562.9 4567.7 4569.2 4589.7 4036.3 4045.2 4089.3 4121.0 4124.4 5748.9 5758.6 5773.4 5783.0 5792.9 6021.0 6040.8 6072.7 6073.4 6075.5 5571.2 5631.5 5709.1 5721.9 5741.1 5185.1 5209.7 5210.6 5212.0 5214.8 6250.2 6305.1 6308.3 6311.5 6316.4 5936.5 5992.0 6053.6 6083.9 6093.2 6252.7 6301.9 6308.7 6310.4 6313.8 5793.6 5953.2 5967.4 5977.0 6001.3 6020.6 6076.5 6082.6 6098.1 6124.2 5790.5 5839.4 5849.4 5853.7 5879.8 5742.7 5805.6 5850.5 5859.5 5879.4 5809.6 5810.2 5815.9 5818.0 5853.8 5934.5 5948.3 5949.4 5951.7 5969.1 5684.6 5778.3 5780.1 5827.2 5862.8 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | [#1] ext.html Cycles:180 Average:55772.26 Median:3660.03 stddev:107139.13 (2927.3%) stddev-sans-first:107359.66 13:45:36 INFO - PROCESS | 15663 | Values: 618.4 644.8 656.8 667.7 672.1 29573.7 40015.6 40956.2 41054.8 41061.8 43796.0 44834.0 44894.0 44947.8 44951.8 8243.5 8746.0 8983.0 10260.4 10491.0 10426.2 10615.3 10617.7 10621.8 10626.1 10605.3 10746.1 10748.9 10750.9 10751.1 7976.9 10439.9 10646.4 10683.2 10684.2 10442.4 10711.1 10732.8 10735.6 10746.5 40713.4 41297.8 41344.0 41575.6 41613.0 3629.4 3665.2 3795.8 3953.2 3989.5 34322.7 35664.1 35730.8 35795.3 35858.0 4622.6 4660.3 4711.7 4737.3 4774.6 358926.0 363335.0 363880.0 364049.0 364231.0 37021.8 71472.6 71489.3 71949.6 72176.6 38568.6 38648.2 38736.2 38770.8 38891.8 14239.4 15169.5 15394.8 15415.2 15419.0 11966.5 12214.1 12234.5 12244.3 12249.1 9348.6 9417.4 9419.2 9465.7 9511.5 3578.1 3643.2 3654.8 3669.9 3670.3 1030.8 1104.2 1142.3 1158.3 1178.4 34809.0 34940.0 35062.5 35088.3 35274.1 1184.5 1191.7 1214.2 1221.8 1295.9 17777.5 18293.5 18358.3 18363.1 18366.9 530607.0 536272.0 536302.0 536421.0 537185.0 63718.7 64604.0 64624.7 64668.4 64679.7 1452.9 1465.3 1495.1 1505.6 1581.6 32425.8 33643.8 34060.0 34705.0 35134.3 50744.0 50758.2 50997.5 51011.0 51221.2 263573.0 264740.0 267212.0 267569.0 267772.0 25776.7 28882.6 29281.7 31860.2 41350.6 45478.7 45585.5 45690.5 45803.5 46405.5 42159.4 42583.0 42734.8 43755.0 44335.3 41652.2 42365.6 42759.1 42974.0 43602.0 42542.0 42964.4 43059.8 43144.6 43347.1 36308.0 36993.8 37647.2 38022.8 38574.8 27190.5 28936.0 29224.7 29259.7 29645.7 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | [#2] jquery.html Cycles:180 Average:31649.04 Median:2219.25 stddev:92896.76 (4185.9%) stddev-sans-first:93127.73 13:45:36 INFO - PROCESS | 15663 | Values: 403.2 409.8 410.1 414.6 417.8 15202.0 18921.8 19623.7 19653.5 20299.9 14324.2 15965.8 16093.5 16819.2 17292.4 5598.2 5732.2 5760.8 5785.3 5789.1 5718.9 5749.9 5787.5 5793.5 5795.6 4244.2 6155.2 6399.9 6459.2 6463.6 6323.1 6382.0 6392.2 6412.5 6438.1 5487.5 5626.1 5652.3 5671.9 5672.7 22472.3 23642.5 23700.9 24576.1 24677.1 2578.6 2674.8 2717.6 2966.4 2973.0 14838.8 15137.8 15258.1 15448.9 15779.4 2020.9 2101.3 2149.5 2202.2 2236.3 79434.0 83559.6 85228.6 85331.0 86931.6 10882.9 11034.1 11095.7 11136.2 11232.7 15438.0 15479.8 15555.8 15560.1 15594.4 8104.9 8304.7 8404.5 8440.8 8455.0 7996.3 8016.2 8031.7 8137.5 8144.8 4371.6 4470.5 4558.3 4748.6 4829.5 1908.6 1923.9 1929.3 1939.3 1964.2 1047.5 1076.1 1080.6 1120.4 1196.5 19782.2 19937.0 20175.4 20181.7 20584.8 1079.0 1080.3 1100.4 1103.8 1108.0 11064.4 11485.3 11569.4 11647.6 11666.9 549215.0 554821.0 571887.0 573450.0 573551.0 97306.5 98598.8 98796.5 100761.5 100965.0 1080.0 1110.5 1124.8 1141.6 1147.1 17928.6 17940.1 17970.1 18045.4 18326.8 31858.7 40723.0 40861.8 41078.2 42262.8 59395.0 60515.0 61002.0 61669.7 61800.4 8282.6 8299.5 8457.7 8572.1 8615.1 10377.7 13389.8 13491.5 13536.2 13578.6 11214.9 11905.7 12081.1 12280.7 12938.5 12413.1 12505.5 12581.6 12608.6 12640.6 12711.9 12725.7 12892.3 13134.4 13283.1 8178.8 8203.0 8226.2 8289.9 8888.3 12026.6 12548.2 12610.9 13005.9 13038.9 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | [#3] mootools.html Cycles:180 Average:5702.63 Median:4625.41 stddev:3187.30 (68.9%) stddev-sans-first:3179.85 13:45:36 INFO - PROCESS | 15663 | Values: 1401.2 1565.0 1595.4 1768.9 1919.1 7581.4 8372.4 8554.1 8560.2 8578.3 8223.4 8437.3 8452.6 8460.5 8475.1 2363.7 2396.3 2399.0 2399.4 2403.1 2346.7 2363.6 2392.1 2395.8 2415.1 2312.3 2337.2 2342.9 2343.3 2345.9 2305.3 2322.8 2334.5 2337.9 2355.1 2289.6 2312.2 2315.9 2321.1 2323.5 8410.6 8582.1 8633.8 8650.5 8654.4 4906.5 5064.3 5098.5 5100.2 5102.9 3460.6 3494.5 3550.6 3570.4 3571.6 1177.4 1198.6 1211.7 1235.5 1258.1 11643.5 11773.1 12048.8 12119.8 12121.5 4430.4 4479.6 4499.8 4501.1 4627.7 9620.7 9685.1 9685.2 9716.6 9744.9 4931.2 4950.9 4957.4 4961.5 4966.3 4246.0 4476.9 4520.2 4623.1 4630.3 3936.3 3939.7 4023.6 4042.1 4063.5 1170.4 1185.6 1188.7 1211.8 1235.4 784.8 888.8 991.0 1008.5 1017.4 5748.8 5855.6 5875.1 5904.3 5927.2 970.4 988.8 1039.4 1045.9 1093.6 4006.7 4219.9 4267.6 4270.8 4320.4 10376.9 10809.7 10813.2 10828.9 10847.3 10164.2 10652.1 10724.1 10771.8 10859.6 7746.7 7821.9 7826.9 7934.6 7938.3 5723.3 5840.9 5847.9 5899.4 5955.0 9791.2 9861.5 10074.9 10146.2 10211.7 10168.5 10212.5 10257.3 10327.3 10489.7 7714.0 7787.3 7864.2 7898.7 7906.3 8330.3 8519.1 8552.5 8555.3 8563.8 6534.4 7626.6 7653.8 7753.6 7808.3 7434.9 7448.7 7575.3 7582.2 7674.3 6627.4 6707.2 6710.1 6719.5 6725.4 4956.6 5010.4 5166.1 5186.8 5197.6 5271.7 5342.0 5369.7 5457.5 5483.1 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | [#4] prototype.html Cycles:180 Average:4914.42 Median:5619.30 stddev:1495.42 (26.6%) stddev-sans-first:1459.61 13:45:36 INFO - PROCESS | 15663 | Values: 337.0 338.6 341.9 347.6 348.1 5399.9 5433.8 5441.3 5475.6 5481.9 5353.9 5361.8 5402.4 5413.0 5424.7 4017.6 4075.7 4233.5 4239.7 4249.5 4189.6 4226.9 4240.8 4255.3 4273.1 4004.7 4209.9 4210.9 4218.1 4232.7 4073.9 4196.7 4203.9 4220.9 4224.1 3719.0 3728.5 3741.9 3744.9 3754.1 5212.9 5238.7 5254.3 5256.2 5264.5 4540.7 4762.5 4775.9 4782.3 4785.6 5652.2 5658.2 5663.7 5681.2 5697.3 4053.5 4058.9 4086.2 4093.2 4094.3 5643.2 5912.6 5937.7 5951.1 5952.9 4081.3 4103.4 4105.7 4112.8 4124.0 4155.8 4163.8 4169.9 4177.8 4178.7 4678.7 4679.7 4708.3 4730.5 4732.2 5655.7 5659.6 5686.5 5707.5 5733.4 1499.8 1517.0 1517.3 1519.9 1521.9 927.0 936.2 970.5 989.0 1019.1 5840.8 5862.9 5893.9 5895.9 5909.3 6228.2 6232.5 6258.7 6265.2 6272.6 5728.5 5827.4 5869.4 5888.9 5894.7 3277.3 3308.6 3310.1 3321.9 3334.0 6257.4 6381.6 6434.9 6476.4 6498.7 6318.6 6320.6 6323.0 6372.5 6375.5 6293.7 6398.4 6417.8 6434.8 6437.9 6162.6 6195.3 6205.0 6209.2 6212.6 6095.3 6100.6 6106.8 6130.3 6139.7 6196.7 6393.8 6408.9 6426.9 6442.1 4273.2 4294.5 4310.7 4313.6 4314.3 6034.3 6147.4 6187.6 6196.3 6221.0 5974.9 5977.2 6000.0 6002.2 6026.7 5981.6 5985.5 6002.6 6003.7 6014.1 5278.5 5376.6 5611.9 5745.3 5914.8 5620.6 5698.8 5743.7 5752.7 5813.5 5477.2 5618.0 5624.4 5654.3 5656.2 13:45:36 INFO - PROCESS | 15663 | 13:45:36 INFO - PROCESS | 15663 | [#5] yui.html Cycles:180 Average:16633.93 Median:26314.46 stddev:19911.44 (75.7%) stddev-sans-first:19932.24 13:45:36 INFO - PROCESS | 15663 | Values: 900.0 902.6 903.1 919.6 925.9 14580.7 14973.3 15045.9 16032.8 16562.3 15599.0 15699.1 15774.6 15784.8 15803.0 728.9 872.8 890.5 903.4 908.6 884.1 887.5 891.6 892.0 892.7 945.9 951.0 952.6 954.3 954.9 773.9 788.1 790.9 909.9 947.7 690.0 690.2 691.3 691.5 691.5 15929.0 15985.3 15998.3 16018.3 16048.8 14468.3 14748.3 14873.3 14891.5 14979.3 12494.5 12611.9 12645.9 12665.1 12809.7 4069.2 4101.5 4106.6 4148.4 4209.0 65082.7 66962.7 67132.0 67250.7 67471.3 11329.7 11396.0 11416.1 11565.7 12050.8 20663.2 20928.2 20966.2 20978.5 20997.6 8327.7 8380.5 8449.4 8516.7 8735.2 4884.6 5025.2 5037.8 5052.2 5178.6 3818.5 3966.9 3967.7 3972.7 3979.9 695.8 702.9 713.1 715.0 715.0 678.0 701.8 759.6 778.4 814.1 9982.0 10118.1 10235.9 10353.2 10428.5 782.8 783.9 806.5 810.9 821.2 4735.8 4985.7 5018.8 5041.3 5042.0 69990.7 71623.0 72086.3 72313.0 73316.0 62410.4 62492.0 62678.0 64510.0 65827.0 56866.1 57066.0 57076.1 57112.0 57630.0 8558.9 8631.6 8733.8 8786.8 8849.7 36180.0 36986.3 37363.3 37917.0 38196.4 47744.3 50854.0 51694.0 51859.2 52219.7 12063.9 12088.0 12248.1 12318.8 12531.7 13126.3 13707.7 13836.2 14252.3 14320.1 10338.9 13338.9 14115.6 14534.8 14590.9 13649.5 13779.1 14077.9 14867.3 14871.0 13349.5 13371.7 13419.7 14089.3 14093.2 11638.9 11908.5 12205.3 12215.8 12531.1 11246.7 11876.8 11895.0 11916.6 12030.3 13:45:36 INFO - PROCESS | 15663 | -------- Summary: end -------- 13:45:36 INFO - PROCESS | 15663 | 13:45:37 INFO - TEST-INFO | 15663: exit 0 13:45:37 INFO - TEST-OK | dromaeo_css | took 1110966ms 13:45:37 INFO - TEST-START | kraken 13:45:37 INFO - operating with platform_type : linux_ 13:45:37 INFO - Initialising browser for kraken test... 13:45:37 INFO - TEST-INFO | started process 15856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16Sn0x/profile http://localhost:58007/getInfo.html) 13:45:40 INFO - PROCESS | 15856 | __metrics Screen width/height:1600/1200 13:45:40 INFO - PROCESS | 15856 | colorDepth:24 13:45:40 INFO - PROCESS | 15856 | Browser inner width/height: 1024/697 13:45:40 INFO - PROCESS | 15856 | __metrics 13:45:41 ERROR - PROCESS | 15856 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:45:42 INFO - TEST-INFO | 15856: exit 0 13:45:42 INFO - Browser initialized. 13:45:42 INFO - Running cycle 1/1 for kraken test... 13:45:42 INFO - TEST-INFO | started process 15947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16Sn0x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:54 INFO - PROCESS | 15947 | RSS: Main: 142647296 13:45:54 INFO - PROCESS | 15947 | 13:45:56 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58007/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:57 INFO - PROCESS | 15947 | RSS: Main: 191229952 13:45:57 INFO - PROCESS | 15947 | 13:46:00 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58007/tests/kraken/driver.html?testName=audio-dft) 13:46:00 INFO - PROCESS | 15947 | RSS: Main: 184279040 13:46:00 INFO - PROCESS | 15947 | 13:46:03 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58007/tests/kraken/driver.html?testName=audio-fft) 13:46:04 INFO - PROCESS | 15947 | RSS: Main: 273313792 13:46:04 INFO - PROCESS | 15947 | 13:46:06 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58007/tests/kraken/driver.html?testName=audio-oscillator) 13:46:06 INFO - PROCESS | 15947 | RSS: Main: 182624256 13:46:06 INFO - PROCESS | 15947 | 13:46:09 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:46:09 INFO - PROCESS | 15947 | RSS: Main: 181182464 13:46:09 INFO - PROCESS | 15947 | 13:46:12 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58007/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:13 INFO - PROCESS | 15947 | RSS: Main: 215838720 13:46:13 INFO - PROCESS | 15947 | 13:46:16 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58007/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:17 INFO - PROCESS | 15947 | RSS: Main: 215863296 13:46:17 INFO - PROCESS | 15947 | 13:46:19 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58007/tests/kraken/driver.html?testName=json-parse-financial) 13:46:20 INFO - PROCESS | 15947 | RSS: Main: 215449600 13:46:20 INFO - PROCESS | 15947 | 13:46:22 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:22 INFO - PROCESS | 15947 | RSS: Main: 197218304 13:46:22 INFO - PROCESS | 15947 | 13:46:24 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:25 INFO - PROCESS | 15947 | RSS: Main: 198217728 13:46:25 INFO - PROCESS | 15947 | 13:46:26 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:27 INFO - PROCESS | 15947 | RSS: Main: 207355904 13:46:27 INFO - PROCESS | 15947 | 13:46:30 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:30 INFO - PROCESS | 15947 | RSS: Main: 214863872 13:46:30 INFO - PROCESS | 15947 | 13:46:33 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:33 INFO - PROCESS | 15947 | RSS: Main: 211673088 13:46:33 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | Cycle 1(1): loaded http://localhost:58007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58007/tests/kraken/driver.html?testName=ai-astar) 13:46:35 INFO - PROCESS | 15947 | RSS: Main: 275939328 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | __start_tp_report 13:46:35 INFO - PROCESS | 15947 | _x_x_mozilla_page_load 13:46:35 INFO - PROCESS | 15947 | _x_x_mozilla_page_load_details 13:46:35 INFO - PROCESS | 15947 | |i|pagename|runs| 13:46:35 INFO - PROCESS | 15947 | |0;ai-astar;110;112;105;112;111;111;99;110;110;109 13:46:35 INFO - PROCESS | 15947 | |1;audio-beat-detection;151;125;153;181;128;165;161;127;197;126 13:46:35 INFO - PROCESS | 15947 | |2;audio-dft;163;164;161;161;161;162;162;163;161;160 13:46:35 INFO - PROCESS | 15947 | |3;audio-fft;72;75;75;175;73;75;76;77;168;77 13:46:35 INFO - PROCESS | 15947 | |4;audio-oscillator;92;92;150;92;91;92;147;93;92;147 13:46:35 INFO - PROCESS | 15947 | |5;imaging-gaussian-blur;116;116;124;117;117;116;117;117;116;116 13:46:35 INFO - PROCESS | 15947 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;145 13:46:35 INFO - PROCESS | 15947 | |7;imaging-desaturate;94;94;94;94;95;95;94;95;94;95 13:46:35 INFO - PROCESS | 15947 | |8;json-parse-financial;59;62;62;63;64;63;62;83;61;61 13:46:35 INFO - PROCESS | 15947 | |9;json-stringify-tinderbox;57;58;58;57;57;58;57;59;58;58 13:46:35 INFO - PROCESS | 15947 | |10;stanford-crypto-aes;80;71;72;73;73;72;74;74;74;74 13:46:35 INFO - PROCESS | 15947 | |11;stanford-crypto-ccm;121;118;115;116;116;116;117;117;151;124 13:46:35 INFO - PROCESS | 15947 | |12;stanford-crypto-pbkdf2;162;156;158;158;158;165;159;158;162;168 13:46:35 INFO - PROCESS | 15947 | |13;stanford-crypto-sha256-iterative;65;67;66;65;65;65;67;65;66;66 13:46:35 INFO - PROCESS | 15947 | __end_tp_report 13:46:35 INFO - PROCESS | 15947 | __start_cc_report 13:46:35 INFO - PROCESS | 15947 | _x_x_mozilla_cycle_collect,1618 13:46:35 INFO - PROCESS | 15947 | __end_cc_report 13:46:35 INFO - PROCESS | 15947 | __startTimestamp1461617195858__endTimestamp 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | ------- Summary: start ------- 13:46:35 INFO - PROCESS | 15947 | Number of tests: 14 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.01 (3.6%) stddev-sans-first:4.24 13:46:35 INFO - PROCESS | 15947 | Values: 110.0 112.0 105.0 112.0 111.0 111.0 99.0 110.0 110.0 109.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:157.00 stddev:25.21 (16.1%) stddev-sans-first:26.74 13:46:35 INFO - PROCESS | 15947 | Values: 151.0 125.0 153.0 181.0 128.0 165.0 161.0 127.0 197.0 126.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 13:46:35 INFO - PROCESS | 15947 | Values: 163.0 164.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 160.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.00 stddev:40.75 (54.3%) stddev-sans-first:42.42 13:46:35 INFO - PROCESS | 15947 | Values: 72.0 75.0 75.0 175.0 73.0 75.0 76.0 77.0 168.0 77.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:27.07 (29.4%) stddev-sans-first:28.02 13:46:35 INFO - PROCESS | 15947 | Values: 92.0 92.0 150.0 92.0 91.0 92.0 147.0 93.0 92.0 147.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:2.44 (2.1%) stddev-sans-first:2.55 13:46:35 INFO - PROCESS | 15947 | Values: 116.0 116.0 124.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 13:46:35 INFO - PROCESS | 15947 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:46:35 INFO - PROCESS | 15947 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:62.50 stddev:6.82 (10.9%) stddev-sans-first:6.98 13:46:35 INFO - PROCESS | 15947 | Values: 59.0 62.0 62.0 63.0 64.0 63.0 62.0 83.0 61.0 61.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 13:46:35 INFO - PROCESS | 15947 | Values: 57.0 58.0 58.0 57.0 57.0 58.0 57.0 59.0 58.0 58.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:2.45 (3.3%) stddev-sans-first:1.12 13:46:35 INFO - PROCESS | 15947 | Values: 80.0 71.0 72.0 73.0 73.0 72.0 74.0 74.0 74.0 74.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:117.50 stddev:10.86 (9.2%) stddev-sans-first:11.52 13:46:35 INFO - PROCESS | 15947 | Values: 121.0 118.0 115.0 116.0 116.0 116.0 117.0 117.0 151.0 124.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:3.78 (2.4%) stddev-sans-first:3.96 13:46:35 INFO - PROCESS | 15947 | Values: 162.0 156.0 158.0 158.0 158.0 165.0 159.0 158.0 162.0 168.0 13:46:35 INFO - PROCESS | 15947 | 13:46:35 INFO - PROCESS | 15947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 13:46:35 INFO - PROCESS | 15947 | Values: 65.0 67.0 66.0 65.0 65.0 65.0 67.0 65.0 66.0 66.0 13:46:35 INFO - PROCESS | 15947 | -------- Summary: end -------- 13:46:35 INFO - PROCESS | 15947 | 13:46:36 INFO - TEST-INFO | 15947: exit 0 13:46:37 INFO - TEST-OK | kraken | took 59973ms 13:46:37 INFO - SUITE-END | took 1170s 13:46:37 INFO - Completed test suite (00:19:30) 13:46:37 INFO - javascript benchmark 13:46:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.1510664780476, 3385.6445073267323, 3414.9487757683637, 3422.401079811034, 3458.2391873787774, 5629.40891206423, 5633.183188437674, 5643.0, 5666.575006874491, 5687.516561092307, 5636.535495746484, 5675.035244008518, 5678.943210567893, 5682.289713785777, 5690.2033715279895, 4946.802127914897, 5114.948850511494, 5128.589712822965, 5172.767225474844, 5205.583553315726, 5143.0, 5208.192730126836, 5209.791608335681, 5210.9218361724415, 5214.895702085956, 5127.051495473349, 5181.792728290864, 5183.611229157809, 5191.4548972357925, 5195.298634684326, 5180.792768289282, 5183.818566350197, 5203.9219411708855, 5213.0, 5241.973790131063, 5012.172991456406, 5074.13739664258, 5102.6428150029515, 5121.129408000649, 5144.408393034774, 5526.088195447746, 5545.584081193927, 5567.582431317667, 5588.385277619459, 5601.29983752031, 6004.639721616673, 6025.698715064229, 6026.186464827236, 6028.4272994065495, 6032.547558933097, 6008.7896923607905, 6061.969690151521, 6078.300995385543, 6105.389461053859, 6114.602550834226, 5626.521745651625, 5676.375598684142, 5679.091345384719, 5685.289338832646, 5687.374388817227, 6008.819735407945, 6177.135201071764, 6190.969045154746, 6192.59748116371, 6198.2871969723155, 5846.912296315473, 5910.852228694317, 5914.822555323347, 5931.6441013539325, 5933.3473317934995, 5990.101484777231, 5996.760129594767, 5996.9805133127475, 6013.819585412444, 6030.396960303934, 5865.706714664249, 5956.493698035629, 5973.940260597338, 5992.700364981733, 6002.129691194752, 5994.610350327215, 5997.310309314397, 6018.337982821886, 6032.125341825411, 6065.4541091302, 4553.066621342617, 4562.8631141065825, 4567.725936443758, 4569.200389931749, 4589.655775816827, 4036.253293140778, 4045.211183819127, 4089.3252613319064, 4120.979395103005, 4124.422580838685, 5748.856278593069, 5758.596898217084, 5773.39379365169, 5783.0, 5792.855178620568, 6020.969895150583, 6040.818775436744, 6072.726727297282, 6073.423024812636, 6075.544334174954, 5571.220029195916, 5631.465010823965, 5709.05800542914, 5721.942780572141, 5741.052726300114, 5185.144451165591, 5209.6874187548865, 5210.557102646242, 5211.973940130275, 5214.765335559833, 6250.218722659668, 6305.085762564402, 6308.337624549356, 6311.526635502356, 6316.368363163647, 5936.525077993664, 5991.970040149771, 6053.636781793107, 6083.908741368795, 6093.238345206849, 6252.7026288191155, 6301.905471417841, 6308.684565771601, 6310.400511951358, 6313.842153946188, 5793.623414478214, 5953.226080609493, 5967.433093856077, 5977.013792724326, 6001.339852616296, 6020.638761674313, 6076.54425918049, 6082.635041897501, 6098.054801505774, 6124.234470691164, 5790.536757059509, 5839.416058394127, 5849.444302791228, 5853.736581853742, 5879.764809407576, 5742.741576629145, 5805.593608447368, 5850.502707269759, 5859.531237501075, 5879.412058794086, 5809.622374545641, 5810.1575271586225, 5815.912761308499, 5817.970910145422, 5853.795117171049, 5934.465898069195, 5948.256467941507, 5949.434803693643, 5951.702414879325, 5969.074793407029, 5684.573656975661, 5778.27771528559, 5780.132980053026, 5827.184194212899, 5862.794802181903], "value": 5569.214299170733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3630860213979, 644.8001119652911, 656.8259411256017, 667.7429189761943, 672.0792514255471, 29573.704262957363, 40015.599844001554, 40956.18087638253, 41054.794726026405, 41061.794691026575, 43796.0, 44834.0, 44894.0, 44947.77526112373, 44951.775241123745, 8243.464174828618, 8745.956270218656, 8982.955085224565, 10260.384376937407, 10491.0, 10426.218033647468, 10615.256932014761, 10617.681469555888, 10621.78756424871, 10626.096781773558, 10605.310654807452, 10746.086582640484, 10748.892511074906, 10750.892491075107, 10751.086157676607, 7976.920230797676, 10439.895601043969, 10646.414447205401, 10683.198760093024, 10684.198685098649, 10442.373457592568, 10711.089557387631, 10732.839007414896, 10735.62425315118, 10746.516406761637, 40713.38929916054, 41297.793511032556, 41344.0, 41575.58424415747, 41613.0, 3629.4374371972385, 3665.2303016366595, 3795.8291876865333, 3953.1698343347643, 3989.5412027616903, 34322.65677343245, 35664.108397290016, 35730.821345893106, 35795.28409431823, 35858.0, 4622.6070783983405, 4660.254359302529, 4711.740854253015, 4737.336772851769, 4774.64190185734, 358926.0, 363335.0, 363880.0, 364049.0, 364231.0, 37021.81489092537, 71472.64263678648, 71489.2851071493, 71949.64025179841, 72176.63911680409, 38568.6143138565, 38648.22703545913, 38736.22527549433, 38770.80614596909, 38891.80554097211, 14239.430422782973, 15169.469068582546, 15394.846051539342, 15415.229238538028, 15419.0, 11966.461509232106, 12214.145009849402, 12234.510619575118, 12244.265344079384, 12249.081318901119, 9348.626054957862, 9417.434953902652, 9419.24646028316, 9465.66870159541, 9511.524423778921, 3578.1054736315923, 3643.216708407705, 3654.835532401048, 3669.8806863906766, 3670.33933891902, 1030.7577719235974, 1104.166354402437, 1142.2632402100764, 1158.2760774515928, 1178.3577950017261, 34809.0, 34940.0, 35062.47406288908, 35088.298234035174, 35274.11814704653, 1184.4847491341295, 1191.6544202181444, 1214.2107630040368, 1221.82283568882, 1295.9481620735064, 17777.46667599974, 18293.451196464128, 18358.265669373075, 18363.08184590792, 18366.90816545909, 530607.0, 536272.0, 536302.0, 536421.0, 537185.0, 63718.681406592674, 64604.0, 64624.67687661532, 64668.353316467175, 64679.67660161763, 1452.8837692984537, 1465.3039806092022, 1495.1178804505394, 1505.5558610210014, 1581.5887869153873, 32425.837870810494, 33643.83178084094, 34060.0, 34705.0, 35134.297314054085, 50744.0, 50758.23862642137, 50997.49002509927, 51011.0, 51221.23168152406, 263573.0, 264740.0, 267212.0, 267569.0, 267772.0, 25776.742232577435, 28882.566761499016, 29281.707182927898, 31860.203494912814, 41350.586494135874, 45478.73004147748, 45585.544144559455, 45690.54309456863, 45803.54196457993, 46405.53594464012, 42159.36760948649, 42583.0, 42734.78632606817, 43755.0, 44335.334969976124, 41652.16695666009, 42365.576344236164, 42759.144817104105, 42974.0, 43602.0, 42542.0, 42964.35553466763, 43059.784701077544, 43144.56855431531, 43347.133057339306, 36308.0, 36993.81503092467, 37647.24705505929, 38022.8098859515, 38574.80712596419, 27190.456190876466, 28936.0, 29224.70775292305, 29259.7074029257, 29645.703542964293], "value": 19825.624091824036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.2117210852782, 409.844259181511, 410.1366623258042, 414.6330497509705, 417.7660510114336, 15202.0, 18921.810781892178, 19623.705644415346, 19653.50866228345, 20299.898500507512, 14324.212168330763, 15965.760513592306, 16093.517194484155, 16819.243134058965, 17292.394766183184, 5598.216249725042, 5732.197492351074, 5760.8271751847515, 5785.334686511042, 5789.131630255474, 5718.914216286759, 5749.913751293734, 5787.450192231752, 5793.5365170786445, 5795.565332600051, 4244.214820258262, 6155.199824022893, 6399.936000640004, 6459.192600924885, 6463.612183269019, 6323.146375239376, 6382.042693595951, 6392.16901802765, 6412.454941329993, 6438.066480360345, 5487.506124448819, 5626.127950167731, 5652.265205523297, 5671.914921276184, 5672.659640421588, 22472.32583022512, 23642.527149457088, 23700.881495592585, 24576.139835105685, 24677.136300229584, 2578.6003169508567, 2674.8261363011343, 2717.6467059282363, 2966.4067186562556, 2972.959464187517, 14838.809501230337, 15137.772933406008, 15258.08451492914, 15448.922755386264, 15779.447719329768, 2020.8686435381653, 2101.2645574049116, 2149.4518897681146, 2202.196198387593, 2236.31226942995, 79434.0, 83559.5822020886, 85228.57385713032, 85331.0, 86931.56534217352, 10882.891171088346, 11034.117270618332, 11095.722606934729, 11136.164787640959, 11232.719182020352, 15438.0, 15479.767803482957, 15555.844441555666, 15560.066396016275, 15594.376224951102, 8104.918950810535, 8304.70933517324, 8404.453710508797, 8440.788980275542, 8454.957725211458, 7996.32031277348, 8016.238457346542, 8031.678732850737, 8137.511749295061, 8144.83710325802, 4371.628411584988, 4470.547072201548, 4558.33904083906, 4748.621472591604, 4829.541193586604, 1908.551490399755, 1923.9326623568109, 1929.305450037985, 1939.3406241877829, 1964.204497178645, 1047.5495536919045, 1076.0701085012495, 1080.6271836216492, 1120.4285814234636, 1196.4795314038247, 19782.20871165166, 19937.0, 20175.39473815788, 20181.697274540893, 20584.794152058286, 1078.978420431587, 1080.3247970018738, 1100.372787511111, 1103.757173421846, 1107.9612213572648, 11064.391458469701, 11485.310881347146, 11569.363684997406, 11647.59233426826, 11666.88333116675, 549215.0, 554821.0, 571887.0, 573450.0, 573551.0, 97306.5134674322, 98598.7846805791, 98796.50601747089, 100761.49619251856, 100965.0, 1080.0441609175937, 1110.5280255891214, 1124.8368986496912, 1141.560499207811, 1147.1109889835445, 17928.551786204927, 17940.102994850466, 17970.10149492494, 18045.368412105512, 18326.81673183251, 31858.68141318557, 40723.0, 40861.795691021354, 41078.1784364317, 42262.788686056374, 59395.0, 60515.0, 61002.0, 61669.691651541456, 61800.38199618126, 8282.585870706562, 8299.543525105935, 8457.746267611981, 8572.05707372176, 8615.052344242255, 10377.740556486147, 13389.799153012518, 13491.460341586619, 13536.187828730308, 13578.592642220749, 11214.943925280322, 11905.702357441134, 12081.093917956365, 12280.692982675504, 12938.482460701467, 12413.131080824256, 12505.499780008699, 12581.622551323475, 12608.621741347773, 12640.620781376574, 12711.872881271069, 12725.745485090432, 12892.29092399927, 13134.40895159701, 13283.070185086952, 8178.754637360888, 8203.0, 8226.177382261725, 8289.875651865106, 8888.288936884905, 12026.639200823989, 12548.24710517372, 12610.936945315214, 13005.869941300843, 13038.869611304144], "value": 9655.400130942862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.2433286025546, 1564.9608759781008, 1595.3937503748575, 1768.8584913206944, 1919.0884329943278, 7581.431392645553, 8372.41393102483, 8554.059053504125, 8560.229579337858, 8578.270846978014, 8223.383246256524, 8437.282830959375, 8452.577371131449, 8460.450070745397, 8475.110113438093, 2363.7163540375136, 2396.317049640853, 2398.9760102398927, 2399.448126930798, 2403.062805505854, 2346.718393792747, 2363.61000434928, 2392.1149174805346, 2395.7604239576076, 2415.0943396226417, 2312.3063081075693, 2337.1819863047967, 2342.8711420871846, 2343.320437073255, 2345.9296221113395, 2305.250793492122, 2322.837401381904, 2334.4630734930975, 2337.9064837406568, 2355.081518207883, 2289.5764283607587, 2312.190733243368, 2315.9421014474606, 2321.0599707118645, 2323.4772176260376, 8410.621522031523, 8582.098879617613, 8633.784155396103, 8650.524221167832, 8654.394192406535, 4906.460289368202, 5064.3163172971545, 5098.464661210556, 5100.2349647553165, 5102.923456148161, 3460.636633153508, 3494.5457090578316, 3550.6271841456532, 3570.4465807799834, 3571.607123216444, 1177.4348312809814, 1198.592478557286, 1211.6789050901518, 1235.4810979388678, 1258.0753146437362, 11643.476043578059, 11773.058155347637, 12048.759024819454, 12119.757604847853, 12121.45453454588, 4430.357598148251, 4479.61923236522, 4499.752513611717, 4501.077279157765, 4627.722336659744, 9620.71137865865, 9685.079917407835, 9685.225181985565, 9716.61133554664, 9744.853827192597, 4931.161702510582, 4950.9009819803405, 4957.380327459067, 4961.479044700254, 4966.279889416014, 4246.0, 4476.865694029184, 4520.16376970255, 4623.098495793288, 4630.32860235264, 3936.252112098692, 3939.7242193046786, 4023.5574086850424, 4042.110735638155, 4063.4920634920636, 1170.4440390814466, 1185.5909711149638, 1188.744419949715, 1211.8485189351331, 1235.437875766524, 784.835184611238, 888.7733627924968, 990.9752256193652, 1008.5159123620557, 1017.4048181813722, 5748.770049197985, 5855.619384739978, 5875.118732190205, 5904.291485021739, 5927.229460170151, 970.3595626886221, 988.8121256961155, 1039.4387031003173, 1045.896579109032, 1093.6117678224116, 4006.659433948147, 4219.873403797891, 4267.594578515036, 4270.7864606769535, 4320.373545835836, 10376.948115259376, 10809.67570972872, 10813.243072984815, 10828.945855270673, 10847.349159050482, 10164.186865050926, 10652.094571961316, 10724.088452481627, 10771.83842242367, 10859.565617375374, 7746.651400686983, 7821.882671759929, 7826.882596761167, 7934.563599001995, 7938.285554300141, 5723.313202415737, 5840.853978650568, 5847.94152058474, 5899.439553242435, 5955.017422125474, 9791.167750741266, 9861.506924653882, 10074.899251007397, 10146.239032072477, 10211.7447063824, 10168.49157542105, 10212.489375531046, 10257.333273337508, 10327.32872363294, 10489.685309440729, 7714.0, 7787.338076263581, 7864.213578642319, 7898.723544675909, 7906.327962123284, 8330.333573314241, 8519.148085191679, 8552.529610871461, 8555.31557475388, 8563.82872342562, 6534.379233972955, 7626.580538070238, 7653.808654783452, 7753.573553454614, 7808.258215469521, 7434.925650743423, 7448.702051917862, 7575.280348366897, 7582.241775822595, 7674.309312161932, 6627.436667883284, 6707.1616047994, 6710.094137291403, 6719.529632925648, 6725.361090696376, 4956.578690811177, 5010.398752149766, 5166.147585648326, 5186.792528298825, 5197.584193264605, 5271.736413179402, 5342.0, 5369.677819330853, 5457.508824205682, 5483.095289277225], "value": 4608.044641458013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.95619569455965, 338.57677902621725, 341.8718229841523, 347.56380742168574, 348.1071052749695, 5399.89200215996, 5433.750237445385, 5441.2654291670615, 5475.561955043602, 5481.945180548193, 5353.892922141555, 5361.82845947391, 5402.405735369116, 5412.972935135319, 5424.701641409731, 4017.5781542937934, 4075.714699971003, 4233.513145988205, 4239.703220774547, 4249.46881639795, 4189.560096189902, 4226.936595951063, 4240.787960601973, 4255.276602977486, 4273.1240095780295, 4004.679625629957, 4209.873703788876, 4210.863066971916, 4218.114196018824, 4232.661387089025, 4073.87778366648, 4196.684619150868, 4203.91592168155, 4220.936685949682, 4224.134052519226, 3719.047500062489, 3728.45937339087, 3741.8877433677035, 3744.8876533704033, 3754.0614846288427, 5212.921806172911, 5238.659487133325, 5254.290670759475, 5256.160343879612, 5264.499872512105, 4540.6594505411895, 4762.452317983407, 4775.880602984953, 4782.306565547976, 4785.641076919245, 5652.236948012048, 5658.207850900877, 5663.716814159276, 5681.204631351614, 5697.259356283698, 4053.493313335833, 4058.898527536806, 4086.2440448516822, 4093.2222877653153, 4094.28350038745, 5643.181738647873, 5912.645241285493, 5937.732802023919, 5951.107333899907, 5952.851178720567, 4081.3061779497557, 4103.4460347852655, 4105.67154627629, 4112.814923328458, 4123.958760412417, 4155.8337666493, 4163.791810409528, 4169.895752606149, 4177.8328866845595, 4178.704601573522, 4678.689966809299, 4679.742614156254, 4708.340832283483, 4730.503297153749, 4732.195526760459, 5655.660660360391, 5659.5755318351285, 5686.545076393879, 5707.514861236758, 5733.369329373765, 1499.7525408307506, 1517.0, 1517.3399571186349, 1519.9088054716754, 1521.9010764300285, 926.9571731801723, 936.2089034765612, 970.5195928015678, 988.9653862114792, 1019.0726438940677, 5840.8247752567495, 5862.915360658292, 5893.882122357614, 5895.941040589625, 5909.29088509373, 6228.22147231596, 6232.532560058014, 6258.655773932386, 6265.248170219603, 6272.6236425814595, 5728.455796699307, 5827.417258274223, 5869.383714709979, 5888.882222355529, 5894.705264736832, 3277.295381492943, 3308.6195087564756, 3310.1062713067336, 3321.8671253149605, 3333.9833300833825, 6257.405546473078, 6381.585196962275, 6434.871302574016, 6476.449501792306, 6498.707558159894, 6318.589291696117, 6320.55756097078, 6322.968385158137, 6372.502461921445, 6375.489960803125, 6293.748250070037, 6398.392152745575, 6417.775377861846, 6434.812163864309, 6437.871242575122, 6162.599431036968, 6195.287541932736, 6205.03821907605, 6209.192804935329, 6212.565120441706, 6095.329513753572, 6100.633961962297, 6106.816795496142, 6130.264368275835, 6139.723712432862, 6196.690165491617, 6393.776217832354, 6408.9038664421005, 6426.871462570816, 6442.065900444503, 4273.18809426208, 4294.506131794758, 4310.719803212781, 4313.568643135662, 4314.331278651814, 6034.306054803754, 6147.415995480422, 6187.597806142587, 6196.256449226122, 6221.035739460391, 5974.880502390015, 5977.193078934288, 5999.970000149971, 6002.189704389852, 6026.668533230714, 5981.641101533922, 5985.491233245223, 6002.579819412774, 6003.6998150093195, 6014.097885317237, 5278.498542638443, 5376.596755243294, 5611.943880561143, 5745.2818397700285, 5914.763409463573, 5620.606557541097, 5698.80325131727, 5743.707665775167, 5752.741126649227, 5813.534917206698, 5477.233187353853, 5618.0, 5624.353199382123, 5654.3497497788285, 5656.151577263443], "value": 4439.171108334126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.9640014399424, 902.634433054613, 903.119458527935, 919.5907821019645, 925.9166674999249, 14580.70838583229, 14973.251337433112, 15045.924770376147, 16032.75950860735, 16562.254698538563, 15599.0, 15699.058056516616, 15774.605634859134, 15784.763228551581, 15803.0, 728.8979542864004, 872.8036191856845, 890.5280201493202, 903.3902116071658, 908.5638893331205, 884.0717246890771, 887.5118684723409, 891.5765011619494, 892.0054139634293, 892.6920212526668, 945.8533927241289, 951.0204489375953, 952.5808644196532, 954.3128947158035, 954.89973552777, 773.8916551682769, 788.0976282156898, 790.9129995700468, 909.895362033368, 947.6777895515523, 690.0305071374727, 690.2372877969822, 691.3294104718415, 691.498663468986, 691.5297597633607, 15929.04425734448, 15985.280662370222, 15998.280077396545, 16018.279177437043, 16048.75926861098, 14468.27658617065, 14748.336324865406, 14873.346727355247, 14891.47879824201, 14979.251037448084, 12494.500219991189, 12611.93694031524, 12645.936770316182, 12665.05012124085, 12809.679758006032, 4069.165821006716, 4101.487314085739, 4106.568810274938, 4148.43996060531, 4208.9789551052045, 65082.67458662677, 66962.66518667375, 67132.0, 67250.66374668095, 67471.28907910064, 11329.660110196708, 11396.008555232554, 11416.143789215675, 11565.710857228469, 12050.819237711441, 20663.17347306121, 20928.16287348489, 20966.16135354569, 20978.475538111365, 20997.580048398948, 8327.708530201535, 8380.455270407405, 8449.36629752771, 8516.74449766508, 8735.1701588349, 4884.633652476078, 5025.195968644999, 5037.798488060436, 5052.216906379444, 5178.585713142939, 3818.5417749870194, 3966.861159859391, 3967.742096763759, 3972.741771784825, 3979.9204015919518, 695.8051745511265, 702.8734827731057, 713.0587624335827, 714.9642517874189, 715.0, 678.0338018323869, 701.8140192848899, 759.5860256160406, 778.381186956371, 814.0516298512285, 9981.950090249502, 10118.08937195656, 10235.948820255851, 10353.171746260281, 10428.530716117793, 782.776908581063, 783.8941742864754, 806.5040000399712, 810.8824220487996, 821.219841150909, 4735.83424580138, 4985.675931064469, 5018.84943451697, 5041.319421878073, 5042.0, 69990.65004674943, 71623.0, 72086.279137209, 72313.0, 73316.0, 62410.37589624045, 62492.0, 62678.0, 64510.0, 65827.01259481111, 56866.14700779492, 57066.0, 57076.143857842166, 57112.0, 57629.99999999916, 8558.914410856061, 8631.611577478903, 8733.78165545841, 8786.824263514822, 8849.734507964771, 36180.0, 36986.260274793814, 37363.252734945694, 37917.0, 38196.42705359366, 47744.2838357418, 50854.0, 51694.0, 51859.2221116676, 52219.73890130677, 12063.879361206627, 12088.0, 12248.142630015813, 12318.81521777192, 12531.686707832378, 13126.278054706701, 13707.725845483234, 13836.239006854317, 14252.287385630885, 14320.06919550226, 10338.896611033793, 13338.93330533341, 14115.647108822362, 14534.781978270123, 14590.927045364706, 13649.522266720616, 13779.104358216684, 14077.859221408065, 14867.330970106155, 14871.0, 13349.532766353132, 13371.732565348833, 13419.731605368033, 14089.295535222993, 14093.224872631694, 11638.88361116412, 11908.464119114833, 12205.267683938991, 12215.75568488643, 12531.122821402414, 11246.662600121683, 11876.80452449707, 11895.0, 11916.642500724993, 12030.27818330868], "value": 7388.892014510257, "unit": "score"}], "name": "dromaeo_css", "value": 7376.866182187573, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 105.0, 112.0, 111.0, 111.0, 99.0, 110.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 153.0, 181.0, 128.0, 165.0, 161.0, 127.0, 197.0, 126.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 75.0, 175.0, 73.0, 75.0, 76.0, 77.0, 168.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 92.0, 91.0, 92.0, 147.0, 93.0, 92.0, 147.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 124.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 62.0, 63.0, 64.0, 63.0, 62.0, 83.0, 61.0, 61.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 59.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 71.0, 72.0, 73.0, 73.0, 72.0, 74.0, 74.0, 74.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 115.0, 116.0, 116.0, 116.0, 117.0, 117.0, 151.0, 124.0], "value": 121.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 158.0, 158.0, 158.0, 165.0, 159.0, 158.0, 162.0, 168.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1524.5000000000002, "alertThreshold": 2.0}]} 13:46:37 INFO - Return code: 0 13:46:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:46:37 ERROR - # TBPL SUCCESS # 13:46:37 INFO - Running post-action listener: _resource_record_post_action 13:46:37 INFO - Running post-run listener: _resource_record_post_run 13:46:38 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 499929088; Read time: 0; Write time: 393152 13:46:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 248827904; Read time: 0; Write time: 243136 13:46:38 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 251101184; Read time: 0; Write time: 150016 13:46:38 INFO - Running post-run listener: _upload_blobber_files 13:46:38 INFO - Blob upload gear active. 13:46:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:38 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 13:46:38 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'] 13:46:38 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 13:46:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:39 INFO - (blobuploader) - INFO - Done attempting. 13:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:40 INFO - (blobuploader) - INFO - Done attempting. 13:46:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:40 INFO - Return code: 0 13:46:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa30a54e4f62e84fdea2e38a74df0bcbaea05b6e7ac9d59d178770d33373098713cba120f4446bc43c101307a45fe86dd193864bc70f95b82fcae587857a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699664b30ee98242f9fe312ff67c6a977c6f63f0da4b869ccf3861eb0169a638200ae5b980f7eccd5e72c3262ccd5dfc5d5bf48da05d5b6c8cdc35f559d997e1"} 13:46:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:40 INFO - Contents: 13:46:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa30a54e4f62e84fdea2e38a74df0bcbaea05b6e7ac9d59d178770d33373098713cba120f4446bc43c101307a45fe86dd193864bc70f95b82fcae587857a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699664b30ee98242f9fe312ff67c6a977c6f63f0da4b869ccf3861eb0169a638200ae5b980f7eccd5e72c3262ccd5dfc5d5bf48da05d5b6c8cdc35f559d997e1"} 13:46:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:40 INFO - Copying logs to upload dir... 13:46:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.557741 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-25 13:46:39.233425) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:46:39.237138) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454 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/aaa30a54e4f62e84fdea2e38a74df0bcbaea05b6e7ac9d59d178770d33373098713cba120f4446bc43c101307a45fe86dd193864bc70f95b82fcae587857a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699664b30ee98242f9fe312ff67c6a977c6f63f0da4b869ccf3861eb0169a638200ae5b980f7eccd5e72c3262ccd5dfc5d5bf48da05d5b6c8cdc35f559d997e1"} build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/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/aaa30a54e4f62e84fdea2e38a74df0bcbaea05b6e7ac9d59d178770d33373098713cba120f4446bc43c101307a45fe86dd193864bc70f95b82fcae587857a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699664b30ee98242f9fe312ff67c6a977c6f63f0da4b869ccf3861eb0169a638200ae5b980f7eccd5e72c3262ccd5dfc5d5bf48da05d5b6c8cdc35f559d997e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:46:39.262613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:46:39.262970) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461607565.270567-973961454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:46:39.345433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:46:39.345770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:46:39.346053) ========= ========= Total master_lag: 0.16 =========