builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1464783057.45 results: success (0) buildid: 20160601021650 builduid: 1548571e00b64466a2baddee8cc67cdc revision: b73cfa00dab309c8b999550363df0c0456128b90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.446643) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.447120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.447402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.462008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.462299) ========= 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=826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 05:10:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.2M=0s 2016-06-01 05:10:57 (73.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.591562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.591930) ========= 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=826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013733 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:57.641922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 05:10:57.642311) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b73cfa00dab309c8b999550363df0c0456128b90 --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 b73cfa00dab309c8b999550363df0c0456128b90 --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=826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 05:10:57,907 truncating revision to first 12 chars 2016-06-01 05:10:57,907 Setting DEBUG logging. 2016-06-01 05:10:57,907 attempt 1/10 2016-06-01 05:10:57,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b73cfa00dab3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 05:10:59,013 unpacking tar archive at: mozilla-aurora-b73cfa00dab3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 05:10:59.090899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:59.091229) ========= script_repo_revision: b73cfa00dab309c8b999550363df0c0456128b90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:59.091629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:59.095980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 05:10:59.106254) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-01 05:10:59.106580) ========= /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=826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:59 INFO - MultiFileLogger online at 20160601 05:10:59 in /builds/slave/test 05:10:59 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 05:10:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:59 INFO - {'append_to_log': False, 05:10:59 INFO - 'base_work_dir': '/builds/slave/test', 05:10:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:10:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:59 INFO - 'branch': 'Mozilla-Aurora', 05:10:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:59 INFO - 'config_files': ('talos/linux_config.py',), 05:10:59 INFO - 'default_actions': ('clobber', 05:10:59 INFO - 'read-buildbot-config', 05:10:59 INFO - 'download-and-extract', 05:10:59 INFO - 'populate-webroot', 05:10:59 INFO - 'create-virtualenv', 05:10:59 INFO - 'install', 05:10:59 INFO - 'run-tests'), 05:10:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:59 INFO - 'download_minidump_stackwalk': True, 05:10:59 INFO - 'download_symbols': 'ondemand', 05:10:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:59 INFO - 'installer_path': 'installer.exe', 05:10:59 INFO - 'log_level': 'info', 05:10:59 INFO - 'log_name': 'talos', 05:10:59 INFO - 'log_to_console': True, 05:10:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:59 INFO - 'opt_config_files': (), 05:10:59 INFO - 'pip_index': False, 05:10:59 INFO - 'sps_profile': False, 05:10:59 INFO - 'sps_profile_interval': 0, 05:10:59 INFO - 'suite': 'dromaeojs', 05:10:59 INFO - 'system_bits': '32', 05:10:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:59 INFO - 'title': 'talos-linux64-ix-052', 05:10:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:59 INFO - 'use_talos_json': True, 05:10:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:59 INFO - 'work_dir': 'build'} 05:10:59 INFO - ##### 05:10:59 INFO - ##### Running clobber step. 05:10:59 INFO - ##### 05:10:59 INFO - Running pre-action listener: _resource_record_pre_action 05:10:59 INFO - Running main action method: clobber 05:10:59 INFO - rmtree: /builds/slave/test/build 05:10:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:59 INFO - Running post-action listener: _resource_record_post_action 05:10:59 INFO - ##### 05:10:59 INFO - ##### Running read-buildbot-config step. 05:10:59 INFO - ##### 05:10:59 INFO - Running pre-action listener: _resource_record_pre_action 05:10:59 INFO - Running main action method: read_buildbot_config 05:10:59 INFO - Using buildbot properties: 05:10:59 INFO - { 05:10:59 INFO - "project": "", 05:10:59 INFO - "product": "firefox", 05:10:59 INFO - "script_repo_revision": "production", 05:10:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:10:59 INFO - "repository": "", 05:10:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:10:59 INFO - "buildid": "20160601021650", 05:10:59 INFO - "pgo_build": "True", 05:10:59 INFO - "basedir": "/builds/slave/test", 05:10:59 INFO - "buildnumber": 542, 05:10:59 INFO - "slavename": "talos-linux64-ix-052", 05:10:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:10:59 INFO - "platform": "ubuntu64_hw", 05:10:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:10:59 INFO - "branch": "mozilla-aurora", 05:10:59 INFO - "repo_path": "releases/mozilla-aurora", 05:10:59 INFO - "revision": "b73cfa00dab309c8b999550363df0c0456128b90", 05:10:59 INFO - "stage_platform": "linux64-pgo", 05:10:59 INFO - "builduid": "1548571e00b64466a2baddee8cc67cdc", 05:10:59 INFO - "slavebuilddir": "test" 05:10:59 INFO - } 05:10:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:10:59 INFO - Running post-action listener: _resource_record_post_action 05:10:59 INFO - ##### 05:10:59 INFO - ##### Running download-and-extract step. 05:10:59 INFO - ##### 05:10:59 INFO - Running pre-action listener: _resource_record_pre_action 05:10:59 INFO - Running main action method: download_and_extract 05:10:59 INFO - mkdir: /builds/slave/test/build/tests 05:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:59 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:00 INFO - Downloaded 1361 bytes. 05:11:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:11:00 INFO - Using the following test package requirements: 05:11:00 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:11:00 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:00 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:11:00 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'jsshell-linux-x86_64.zip'], 05:11:00 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:00 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:11:00 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:11:00 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:11:00 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:00 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:11:00 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:00 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:00 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:01 INFO - Downloaded 24174964 bytes. 05:11:01 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'] 05:11:01 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 05:11:02 INFO - Return code: 0 05:11:02 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 05:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:02 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:09 INFO - Downloaded 24174964 bytes. 05:11:09 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'] 05:11:09 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 05:11:10 INFO - Return code: 0 05:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:10 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:12 INFO - Downloaded 10840145 bytes. 05:11:12 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'] 05:11:12 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 05:11:12 INFO - Return code: 0 05:11: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')]} 05:11:12 INFO - https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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 05:11:17 INFO - Downloaded 62804746 bytes. 05:11:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:17 INFO - mkdir: /builds/slave/test/properties 05:11:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:17 INFO - Contents: 05:11:17 INFO - build_url:https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:11:18 INFO - Running post-action listener: _resource_record_post_action 05:11:18 INFO - Running post-action listener: set_extra_try_arguments 05:11:18 INFO - ##### 05:11:18 INFO - ##### Running populate-webroot step. 05:11:18 INFO - ##### 05:11:18 INFO - Running pre-action listener: _resource_record_pre_action 05:11:18 INFO - Running main action method: populate_webroot 05:11:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:18 INFO - '--tppagecycles', 05:11:18 INFO - '7'], 05:11:18 INFO - 'tests': ['tsvgm']}}, 05:11:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['damp', 'tps']}, 05:11:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'tests': ['damp', 'tps']}, 05:11:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['dromaeo_dom']}, 05:11:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['a11yr', 05:11:18 INFO - 'ts_paint', 05:11:18 INFO - 'tpaint', 05:11:18 INFO - 'sessionrestore', 05:11:18 INFO - 'sessionrestore_no_auto_restore', 05:11:18 INFO - 'tabpaint']}, 05:11:18 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:18 INFO - 'ts_paint', 05:11:18 INFO - 'tpaint', 05:11:18 INFO - 'sessionrestore', 05:11:18 INFO - 'sessionrestore_no_auto_restore', 05:11:18 INFO - 'tabpaint']}, 05:11:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:18 INFO - 'ts_paint', 05:11:18 INFO - 'tpaint', 05:11:18 INFO - 'sessionrestore', 05:11:18 INFO - 'sessionrestore_no_auto_restore', 05:11:18 INFO - 'tabpaint']}, 05:11:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:18 INFO - 'ts_paint', 05:11:18 INFO - 'tpaint', 05:11:18 INFO - 'sessionrestore', 05:11:18 INFO - 'sessionrestore_no_auto_restore', 05:11:18 INFO - 'tabpaint']}, 05:11:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['a11yr', 05:11:18 INFO - 'ts_paint', 05:11:18 INFO - 'tpaint', 05:11:18 INFO - 'sessionrestore', 05:11:18 INFO - 'sessionrestore_no_auto_restore', 05:11:18 INFO - 'tabpaint']}, 05:11:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['a11yr', 05:11:18 INFO - 'ts_paint', 05:11:18 INFO - 'tpaint', 05:11:18 INFO - 'sessionrestore', 05:11:18 INFO - 'sessionrestore_no_auto_restore', 05:11:18 INFO - 'tabpaint']}, 05:11:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['tsvgx', 05:11:18 INFO - 'tsvgr_opacity', 05:11:18 INFO - 'tart', 05:11:18 INFO - 'tscrollx', 05:11:18 INFO - 'cart']}, 05:11:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:18 INFO - 'tsvgr_opacity', 05:11:18 INFO - 'tart', 05:11:18 INFO - 'tscrollx', 05:11:18 INFO - 'cart']}, 05:11:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'talos_options': ['--disable-e10s'], 05:11:18 INFO - 'tests': ['tp5o']}, 05:11:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'tests': ['tp5o']}, 05:11:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'talos_options': ['--disable-e10s', 05:11:18 INFO - '--xperf_path', 05:11:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:18 INFO - 'tests': ['tp5n']}, 05:11:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:18 INFO - 'talos_options': ['--xperf_path', 05:11:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:18 INFO - 'tests': ['tp5n']}}, 05:11:18 INFO - 'talos.zip': {'path': '', 05:11:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:18 INFO - Running post-action listener: _resource_record_post_action 05:11:18 INFO - ##### 05:11:18 INFO - ##### Running create-virtualenv step. 05:11:18 INFO - ##### 05:11:18 INFO - Running pre-action listener: _resource_record_pre_action 05:11:18 INFO - Running main action method: create_virtualenv 05:11:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:18 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 05:11:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:18 INFO - Using real prefix '/usr' 05:11:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:20 INFO - Installing pip.................done. 05:11:20 INFO - Return code: 0 05:11:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:20 INFO - Using env: {'DISPLAY': ':0', 05:11:20 INFO - 'HOME': '/home/cltbld', 05:11:20 INFO - 'LANG': 'en_US.UTF-8', 05:11:20 INFO - 'LANGUAGE': 'en_US:en', 05:11:20 INFO - 'LOGNAME': 'cltbld', 05:11:20 INFO - 'MAIL': '/var/mail/cltbld', 05:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:20 INFO - 'MOZ_NO_REMOTE': '1', 05:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:20 INFO - 'NO_EM_RESTART': '1', 05:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:20 INFO - 'PWD': '/builds/slave/test', 05:11:20 INFO - 'SHELL': '/bin/bash', 05:11:20 INFO - 'SHLVL': '1', 05:11:20 INFO - 'TERM': 'linux', 05:11:20 INFO - 'TMOUT': '86400', 05:11:20 INFO - 'USER': 'cltbld', 05:11:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:20 INFO - '_': '/tools/buildbot/bin/python'} 05:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:20 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 05:11:20 INFO - Cleaning up... 05:11:20 INFO - Return code: 0 05:11:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:11:20 INFO - Using env: {'DISPLAY': ':0', 05:11:20 INFO - 'HOME': '/home/cltbld', 05:11:20 INFO - 'LANG': 'en_US.UTF-8', 05:11:20 INFO - 'LANGUAGE': 'en_US:en', 05:11:20 INFO - 'LOGNAME': 'cltbld', 05:11:20 INFO - 'MAIL': '/var/mail/cltbld', 05:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:20 INFO - 'MOZ_NO_REMOTE': '1', 05:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:20 INFO - 'NO_EM_RESTART': '1', 05:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:20 INFO - 'PWD': '/builds/slave/test', 05:11:20 INFO - 'SHELL': '/bin/bash', 05:11:20 INFO - 'SHLVL': '1', 05:11:20 INFO - 'TERM': 'linux', 05:11:20 INFO - 'TMOUT': '86400', 05:11:20 INFO - 'USER': 'cltbld', 05:11:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:20 INFO - '_': '/tools/buildbot/bin/python'} 05:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:21 INFO - Downloading/unpacking psutil>=0.7.1 05:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:23 INFO - Installing collected packages: psutil 05:11:23 INFO - Running setup.py install for psutil 05:11:23 INFO - building 'psutil._psutil_linux' extension 05:11:23 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 05:11:23 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 05:11:23 INFO - building 'psutil._psutil_posix' extension 05:11:23 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 05:11:23 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 05:11:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:23 INFO - Successfully installed psutil 05:11:23 INFO - Cleaning up... 05:11:23 INFO - Return code: 0 05:11:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:11:23 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')]} 05:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:23 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')]} 05:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:23 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:23 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 05:11:23 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 05:11:23 INFO - Using env: {'DISPLAY': ':0', 05:11:23 INFO - 'HOME': '/home/cltbld', 05:11:23 INFO - 'LANG': 'en_US.UTF-8', 05:11:23 INFO - 'LANGUAGE': 'en_US:en', 05:11:23 INFO - 'LOGNAME': 'cltbld', 05:11:23 INFO - 'MAIL': '/var/mail/cltbld', 05:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:23 INFO - 'MOZ_NO_REMOTE': '1', 05:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:23 INFO - 'NO_EM_RESTART': '1', 05:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:23 INFO - 'PWD': '/builds/slave/test', 05:11:23 INFO - 'SHELL': '/bin/bash', 05:11:23 INFO - 'SHLVL': '1', 05:11:23 INFO - 'TERM': 'linux', 05:11:23 INFO - 'TMOUT': '86400', 05:11:23 INFO - 'USER': 'cltbld', 05:11:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:23 INFO - '_': '/tools/buildbot/bin/python'} 05:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:11:25 INFO - Installing collected packages: mozsystemmonitor 05:11:25 INFO - Running setup.py install for mozsystemmonitor 05:11:25 INFO - Successfully installed mozsystemmonitor 05:11:25 INFO - Cleaning up... 05:11:25 INFO - Return code: 0 05:11:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:25 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:25 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 05:11:25 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 05:11:25 INFO - Using env: {'DISPLAY': ':0', 05:11:25 INFO - 'HOME': '/home/cltbld', 05:11:25 INFO - 'LANG': 'en_US.UTF-8', 05:11:25 INFO - 'LANGUAGE': 'en_US:en', 05:11:25 INFO - 'LOGNAME': 'cltbld', 05:11:25 INFO - 'MAIL': '/var/mail/cltbld', 05:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:25 INFO - 'MOZ_NO_REMOTE': '1', 05:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:25 INFO - 'NO_EM_RESTART': '1', 05:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:25 INFO - 'PWD': '/builds/slave/test', 05:11:25 INFO - 'SHELL': '/bin/bash', 05:11:25 INFO - 'SHLVL': '1', 05:11:25 INFO - 'TERM': 'linux', 05:11:25 INFO - 'TMOUT': '86400', 05:11:25 INFO - 'USER': 'cltbld', 05:11:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:25 INFO - '_': '/tools/buildbot/bin/python'} 05:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - Downloading docopt-0.6.1.tar.gz 05:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:28 INFO - Running setup.py install for blobuploader 05:11:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:28 INFO - Running setup.py install for requests 05:11:29 INFO - Running setup.py install for docopt 05:11:29 INFO - Successfully installed blobuploader requests docopt 05:11:29 INFO - Cleaning up... 05:11:29 INFO - Return code: 0 05:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:29 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:29 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 05:11:29 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 05:11:29 INFO - Using env: {'DISPLAY': ':0', 05:11:29 INFO - 'HOME': '/home/cltbld', 05:11:29 INFO - 'LANG': 'en_US.UTF-8', 05:11:29 INFO - 'LANGUAGE': 'en_US:en', 05:11:29 INFO - 'LOGNAME': 'cltbld', 05:11:29 INFO - 'MAIL': '/var/mail/cltbld', 05:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:29 INFO - 'MOZ_NO_REMOTE': '1', 05:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:29 INFO - 'NO_EM_RESTART': '1', 05:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:29 INFO - 'PWD': '/builds/slave/test', 05:11:29 INFO - 'SHELL': '/bin/bash', 05:11:29 INFO - 'SHLVL': '1', 05:11:29 INFO - 'TERM': 'linux', 05:11:29 INFO - 'TMOUT': '86400', 05:11:29 INFO - 'USER': 'cltbld', 05:11:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:29 INFO - '_': '/tools/buildbot/bin/python'} 05:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:29 INFO - Running setup.py (path:/tmp/pip-Eah5Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:29 INFO - Running setup.py (path:/tmp/pip-PZcUIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:29 INFO - Running setup.py (path:/tmp/pip-HSPnyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:29 INFO - Running setup.py (path:/tmp/pip-kDnRQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:29 INFO - Running setup.py (path:/tmp/pip-xpZex1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:29 INFO - Running setup.py (path:/tmp/pip-Rtqjuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:29 INFO - Running setup.py (path:/tmp/pip-ZtaAsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:30 INFO - Running setup.py (path:/tmp/pip-js28aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:30 INFO - Running setup.py (path:/tmp/pip-HRpFrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:30 INFO - Running setup.py (path:/tmp/pip-e8Tx6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:30 INFO - Running setup.py (path:/tmp/pip-3bUQ3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:30 INFO - Running setup.py (path:/tmp/pip-EniRry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:30 INFO - Running setup.py (path:/tmp/pip-2TVlWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:30 INFO - Running setup.py (path:/tmp/pip-b_XK2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:30 INFO - Running setup.py (path:/tmp/pip-hdaFEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:30 INFO - Running setup.py (path:/tmp/pip-x3Amwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:30 INFO - Running setup.py (path:/tmp/pip-cKI3HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:30 INFO - Running setup.py install for manifestparser 05:11:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:30 INFO - Running setup.py install for mozcrash 05:11:30 INFO - Running setup.py install for mozdebug 05:11:31 INFO - Running setup.py install for mozdevice 05:11:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Running setup.py install for mozfile 05:11:31 INFO - Running setup.py install for mozhttpd 05:11:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Running setup.py install for mozinfo 05:11:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Running setup.py install for mozInstall 05:11:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Running setup.py install for mozleak 05:11:31 INFO - Running setup.py install for mozlog 05:11:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Running setup.py install for moznetwork 05:11:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:31 INFO - Running setup.py install for mozprocess 05:11:31 INFO - Running setup.py install for mozprofile 05:11:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:32 INFO - Running setup.py install for mozrunner 05:11:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:32 INFO - Running setup.py install for mozscreenshot 05:11:32 INFO - Running setup.py install for moztest 05:11:32 INFO - Running setup.py install for mozversion 05:11:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:32 INFO - Cleaning up... 05:11:32 INFO - Return code: 0 05:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:32 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:32 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 05:11:32 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 05:11:32 INFO - Using env: {'DISPLAY': ':0', 05:11:32 INFO - 'HOME': '/home/cltbld', 05:11:32 INFO - 'LANG': 'en_US.UTF-8', 05:11:32 INFO - 'LANGUAGE': 'en_US:en', 05:11:32 INFO - 'LOGNAME': 'cltbld', 05:11:32 INFO - 'MAIL': '/var/mail/cltbld', 05:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:32 INFO - 'MOZ_NO_REMOTE': '1', 05:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:32 INFO - 'NO_EM_RESTART': '1', 05:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:32 INFO - 'PWD': '/builds/slave/test', 05:11:32 INFO - 'SHELL': '/bin/bash', 05:11:32 INFO - 'SHLVL': '1', 05:11:32 INFO - 'TERM': 'linux', 05:11:32 INFO - 'TMOUT': '86400', 05:11:32 INFO - 'USER': 'cltbld', 05:11:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:32 INFO - '_': '/tools/buildbot/bin/python'} 05:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:32 INFO - Running setup.py (path:/tmp/pip-2H_RRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:32 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)) 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:32 INFO - Running setup.py (path:/tmp/pip-yqdacP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:32 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)) 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:32 INFO - Running setup.py (path:/tmp/pip-7smmkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:33 INFO - Running setup.py (path:/tmp/pip-3UpBiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:33 INFO - Running setup.py (path:/tmp/pip-jko5gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:33 INFO - Running setup.py (path:/tmp/pip-UTxAYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:33 INFO - Running setup.py (path:/tmp/pip-CyWqKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:33 INFO - Running setup.py (path:/tmp/pip-C1GL0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:33 INFO - Running setup.py (path:/tmp/pip-w7JW7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:33 INFO - Running setup.py (path:/tmp/pip-xZeD3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:33 INFO - Running setup.py (path:/tmp/pip-6nW5eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:33 INFO - Running setup.py (path:/tmp/pip-CURAUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:33 INFO - Running setup.py (path:/tmp/pip-N7usgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:33 INFO - Running setup.py (path:/tmp/pip-6aUgIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:33 INFO - Running setup.py (path:/tmp/pip-gS3uLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:33 INFO - Running setup.py (path:/tmp/pip-TfH6FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:33 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)) 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:33 INFO - Running setup.py (path:/tmp/pip-p6pgC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:34 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)) 05:11:34 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)) 05:11:34 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)) 05:11:34 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)) 05:11:34 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)) 05:11:34 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)) 05:11:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:35 INFO - Downloading blessings-1.6.tar.gz 05:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:35 INFO - Installing collected packages: blessings 05:11:35 INFO - Running setup.py install for blessings 05:11:36 INFO - Successfully installed blessings 05:11:36 INFO - Cleaning up... 05:11:36 INFO - Return code: 0 05:11:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:36 INFO - Reading from file tmpfile_stdout 05:11:36 INFO - Current package versions: 05:11:36 INFO - argparse == 1.2.1 05:11:36 INFO - blessings == 1.6 05:11:36 INFO - blobuploader == 1.2.4 05:11:36 INFO - docopt == 0.6.1 05:11:36 INFO - manifestparser == 1.1 05:11:36 INFO - mozInstall == 1.12 05:11:36 INFO - mozcrash == 0.17 05:11:36 INFO - mozdebug == 0.1 05:11:36 INFO - mozdevice == 0.48 05:11:36 INFO - mozfile == 1.2 05:11:36 INFO - mozhttpd == 0.7 05:11:36 INFO - mozinfo == 0.9 05:11:36 INFO - mozleak == 0.1 05:11:36 INFO - mozlog == 3.1 05:11:36 INFO - moznetwork == 0.27 05:11:36 INFO - mozprocess == 0.22 05:11:36 INFO - mozprofile == 0.28 05:11:36 INFO - mozrunner == 6.11 05:11:36 INFO - mozscreenshot == 0.1 05:11:36 INFO - mozsystemmonitor == 0.0 05:11:36 INFO - moztest == 0.7 05:11:36 INFO - mozversion == 1.4 05:11:36 INFO - psutil == 3.1.1 05:11:36 INFO - requests == 1.2.3 05:11:36 INFO - wsgiref == 0.1.2 05:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:36 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:36 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 05:11:36 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 05:11:36 INFO - Using env: {'DISPLAY': ':0', 05:11:36 INFO - 'HOME': '/home/cltbld', 05:11:36 INFO - 'LANG': 'en_US.UTF-8', 05:11:36 INFO - 'LANGUAGE': 'en_US:en', 05:11:36 INFO - 'LOGNAME': 'cltbld', 05:11:36 INFO - 'MAIL': '/var/mail/cltbld', 05:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:36 INFO - 'MOZ_NO_REMOTE': '1', 05:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:36 INFO - 'NO_EM_RESTART': '1', 05:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:36 INFO - 'PWD': '/builds/slave/test', 05:11:36 INFO - 'SHELL': '/bin/bash', 05:11:36 INFO - 'SHLVL': '1', 05:11:36 INFO - 'TERM': 'linux', 05:11:36 INFO - 'TMOUT': '86400', 05:11:36 INFO - 'USER': 'cltbld', 05:11:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:36 INFO - '_': '/tools/buildbot/bin/python'} 05:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 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)) 05:11:36 INFO - Cleaning up... 05:11:36 INFO - Return code: 0 05:11:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:36 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:36 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 05:11:36 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 05:11:36 INFO - Using env: {'DISPLAY': ':0', 05:11:36 INFO - 'HOME': '/home/cltbld', 05:11:36 INFO - 'LANG': 'en_US.UTF-8', 05:11:36 INFO - 'LANGUAGE': 'en_US:en', 05:11:36 INFO - 'LOGNAME': 'cltbld', 05:11:36 INFO - 'MAIL': '/var/mail/cltbld', 05:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:36 INFO - 'MOZ_NO_REMOTE': '1', 05:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:36 INFO - 'NO_EM_RESTART': '1', 05:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:36 INFO - 'PWD': '/builds/slave/test', 05:11:36 INFO - 'SHELL': '/bin/bash', 05:11:36 INFO - 'SHLVL': '1', 05:11:36 INFO - 'TERM': 'linux', 05:11:36 INFO - 'TMOUT': '86400', 05:11:36 INFO - 'USER': 'cltbld', 05:11:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:36 INFO - '_': '/tools/buildbot/bin/python'} 05:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:36 INFO - Downloading/unpacking jsonschema 05:11:36 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 05:11:36 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 05:11:36 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 05:11:36 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 05:11:36 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 05:11:36 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 05:11:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:38 INFO - Downloading/unpacking functools32 (from jsonschema) 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:38 INFO - warning: no files found matching '*.txt' 05:11:38 INFO - no previously-included directories found matching 'build' 05:11:38 INFO - no previously-included directories found matching 'dist' 05:11:38 INFO - no previously-included directories found matching '.git*' 05:11:38 INFO - Installing collected packages: jsonschema, functools32 05:11:39 INFO - Running setup.py install for functools32 05:11:39 INFO - warning: no files found matching '*.txt' 05:11:39 INFO - no previously-included directories found matching 'build' 05:11:39 INFO - no previously-included directories found matching 'dist' 05:11:39 INFO - no previously-included directories found matching '.git*' 05:11:39 INFO - Successfully installed jsonschema functools32 05:11:39 INFO - Cleaning up... 05:11:39 INFO - Return code: 0 05:11:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:39 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 0x7f942aa67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, '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': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', '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 05:11:39 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 05:11:39 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 05:11:39 INFO - Using env: {'DISPLAY': ':0', 05:11:39 INFO - 'HOME': '/home/cltbld', 05:11:39 INFO - 'LANG': 'en_US.UTF-8', 05:11:39 INFO - 'LANGUAGE': 'en_US:en', 05:11:39 INFO - 'LOGNAME': 'cltbld', 05:11:39 INFO - 'MAIL': '/var/mail/cltbld', 05:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:39 INFO - 'MOZ_NO_REMOTE': '1', 05:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:39 INFO - 'NO_EM_RESTART': '1', 05:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:39 INFO - 'PWD': '/builds/slave/test', 05:11:39 INFO - 'SHELL': '/bin/bash', 05:11:39 INFO - 'SHLVL': '1', 05:11:39 INFO - 'TERM': 'linux', 05:11:39 INFO - 'TMOUT': '86400', 05:11:39 INFO - 'USER': 'cltbld', 05:11:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:39 INFO - '_': '/tools/buildbot/bin/python'} 05:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:39 INFO - Downloading/unpacking flake8 05:11:39 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 05:11:39 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 05:11:39 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 05:11:39 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 05:11:39 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 05:11:39 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 05:11:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:41 INFO - no previously-included directories found matching 'docs/_build' 05:11:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:42 INFO - Running setup.py install for pep8 05:11:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:42 INFO - no previously-included directories found matching 'docs/_build' 05:11:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:42 INFO - Cleaning up... 05:11:42 INFO - Return code: 0 05:11:42 INFO - Running post-action listener: _resource_record_post_action 05:11:42 INFO - Running post-action listener: _start_resource_monitoring 05:11:42 INFO - Starting resource monitoring. 05:11:42 INFO - ##### 05:11:42 INFO - ##### Running install step. 05:11:42 INFO - ##### 05:11:42 INFO - Running pre-action listener: _resource_record_pre_action 05:11:42 INFO - Running main action method: install 05:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:43 INFO - Reading from file tmpfile_stdout 05:11:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:43 INFO - Reading from file tmpfile_stdout 05:11:43 INFO - Output received: 05:11:43 INFO - Usage: mozinstall [options] installer 05:11:43 INFO - Options: 05:11:43 INFO - -h, --help show this help message and exit 05:11:43 INFO - -d DEST, --destination=DEST 05:11:43 INFO - Directory to install application into. [default: 05:11:43 INFO - "/builds/slave/test"] 05:11:43 INFO - --app=APP Application being installed. [default: firefox] 05:11:43 INFO - mkdir: /builds/slave/test/build/application 05:11:43 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'] 05:11:43 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 05:11:58 INFO - Reading from file tmpfile_stdout 05:11:58 INFO - Output received: 05:11:58 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:58 INFO - Running post-action listener: _resource_record_post_action 05:11:58 INFO - ##### 05:11:58 INFO - ##### Running run-tests step. 05:11:58 INFO - ##### 05:11:58 INFO - Running pre-action listener: _resource_record_pre_action 05:11:58 INFO - Running main action method: run_tests 05:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:58 INFO - Python 2.7.3 05:11:58 INFO - Return code: 0 05:11:58 INFO - grabbing minidump binary from tooltool 05:11:58 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')]} 05:11:58 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 0x1a7b640>, '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 0x1a7c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:58 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 05:11:58 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 05:11:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:58 INFO - Return code: 0 05:11:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:59 INFO - Return code: 0 05:11:59 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/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 05:11:59 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/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 05:11:59 INFO - Using env: {'DISPLAY': ':0', 05:11:59 INFO - 'HOME': '/home/cltbld', 05:11:59 INFO - 'LANG': 'en_US.UTF-8', 05:11:59 INFO - 'LANGUAGE': 'en_US:en', 05:11:59 INFO - 'LOGNAME': 'cltbld', 05:11:59 INFO - 'MAIL': '/var/mail/cltbld', 05:11:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:59 INFO - 'MOZ_NO_REMOTE': '1', 05:11:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:59 INFO - 'NO_EM_RESTART': '1', 05:11:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:59 INFO - 'PWD': '/builds/slave/test', 05:11:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:59 INFO - 'SHELL': '/bin/bash', 05:11:59 INFO - 'SHLVL': '1', 05:11:59 INFO - 'TERM': 'linux', 05:11:59 INFO - 'TMOUT': '86400', 05:11:59 INFO - 'USER': 'cltbld', 05:11:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828', 05:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:59 INFO - '_': '/tools/buildbot/bin/python'} 05:11:59 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/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 05:11:59 INFO - mozversion application_buildid: 20160601021650 05:11:59 INFO - mozversion application_changeset: b73cfa00dab309c8b999550363df0c0456128b90 05:11:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:11:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:59 INFO - mozversion application_name: Firefox 05:11:59 INFO - mozversion application_remotingname: firefox-dev 05:11:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:11:59 INFO - mozversion application_vendor: Mozilla 05:11:59 INFO - mozversion application_version: 48.0a2 05:11:59 INFO - mozversion platform_buildid: 20160601021650 05:11:59 INFO - mozversion platform_changeset: b73cfa00dab309c8b999550363df0c0456128b90 05:11:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:11:59 INFO - mozversion platform_version: 48.0a2 05:11:59 INFO - using testdate: 1464783119 05:11:59 INFO - actual date: 1464783119 05:11:59 INFO - starting webserver on 'localhost:41837' 05:11:59 INFO - SUITE-START | Running 2 tests 05:11:59 INFO - TEST-START | dromaeo_css 05:11:59 INFO - operating with platform_type : linux_ 05:11:59 INFO - Initialising browser for dromaeo_css test... 05:11:59 INFO - TEST-INFO | started process 9897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnp_5v/profile http://localhost:41837/getInfo.html) 05:12:03 INFO - PROCESS | 9897 | __metrics Screen width/height:1600/1200 05:12:03 INFO - PROCESS | 9897 | colorDepth:24 05:12:03 INFO - PROCESS | 9897 | Browser inner width/height: 1024/697 05:12:03 INFO - PROCESS | 9897 | __metrics 05:12:04 ERROR - PROCESS | 9897 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:12:05 INFO - TEST-INFO | 9897: exit 0 05:12:05 INFO - Browser initialized. 05:12:05 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:05 INFO - TEST-INFO | started process 9985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnp_5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:17 INFO - PROCESS | 9985 | RSS: Main: 141283328 05:12:17 INFO - PROCESS | 9985 | 05:13:08 INFO - PROCESS | 9985 | 1464783188480 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] 05:15:15 INFO - PROCESS | 9985 | Cycle 1(1): loaded http://localhost:41837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41837/tests/dromaeo/cssquery-ext.html) 05:15:16 INFO - PROCESS | 9985 | RSS: Main: 244338688 05:15:16 INFO - PROCESS | 9985 | 05:18:18 INFO - PROCESS | 9985 | Cycle 1(1): loaded http://localhost:41837/tests/dromaeo/cssquery-ext.html (next: http://localhost:41837/tests/dromaeo/cssquery-jquery.html) 05:18:19 INFO - PROCESS | 9985 | RSS: Main: 227692544 05:18:19 INFO - PROCESS | 9985 | 05:21:20 INFO - PROCESS | 9985 | Cycle 1(1): loaded http://localhost:41837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41837/tests/dromaeo/cssquery-mootools.html) 05:21:21 INFO - PROCESS | 9985 | RSS: Main: 215265280 05:21:21 INFO - PROCESS | 9985 | 05:24:23 INFO - PROCESS | 9985 | Cycle 1(1): loaded http://localhost:41837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41837/tests/dromaeo/cssquery-prototype.html) 05:24:23 INFO - PROCESS | 9985 | RSS: Main: 221351936 05:24:23 INFO - PROCESS | 9985 | 05:27:26 INFO - PROCESS | 9985 | Cycle 1(1): loaded http://localhost:41837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41837/tests/dromaeo/cssquery-yui.html) 05:27:27 INFO - PROCESS | 9985 | RSS: Main: 185913344 05:27:27 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | Cycle 1(1): loaded http://localhost:41837/tests/dromaeo/cssquery-yui.html (next: http://localhost:41837/tests/dromaeo/cssquery-dojo.html) 05:30:29 INFO - PROCESS | 9985 | RSS: Main: 255934464 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | __start_tp_report 05:30:29 INFO - PROCESS | 9985 | _x_x_mozilla_page_load 05:30:29 INFO - PROCESS | 9985 | _x_x_mozilla_page_load_details 05:30:29 INFO - PROCESS | 9985 | |i|pagename|runs| 05:30:29 INFO - PROCESS | 9985 | |0;dojo.html;3294.670532946705;3321.2693207494344;3329.7835640683347;3351.966480335196;3366.32673465307;5366.141417373216;5371.167469042295;5374.247605335251;5388.649737767042;5393.865153371158;5353.464653534645;5356.946430535693;5399.460053994609;5404.945950540494;5407.324084489439;4858.587020103296;4872.999999999991;4980.352554167953;5012.774425150858;5076.111680455924;4966.553010229079;4970.950290497103;5023.673461225008;5048.596112311025;5051.368578927634;5093.083245015896;5095.159298715707;5116.923246151311;5123.820666276681;5132.615053870956;5110.514501122425;5123.820666276662;5129.358830146231;5130.948690513084;5149.304843846089;4910.656254062217;4921.532454416861;4998.875028124289;5040.344755181803;5076.670016448919;5382.730863456812;5404.270423492818;5414.377346605152;5426.62013659044;5444.265024221719;5892.911606325909;5897.351291357947;5902.704864756745;5907.350191478934;5919.112133180014;5679.858003549903;5864.179014937912;5908.793192238294;5976.8505787355225;5989.011813050842;5495.203195536625;5501.807436739695;5501.889962200774;5504.559635229132;5504.80733174341;5900.64596124234;5931.614445061057;5975.4323339283565;5981.222441082631;5988.401159883977;5699.686517241592;5753.88492230153;5788.218590490314;5789.305283366023;5789.8263052108505;5841.41585841421;5860.619059761102;5861.062230043258;5868.618539794899;5871.178035075093;5720.628159169641;5809.7095145242565;5831.591788574844;5832.24180856486;5834.941650583524;5838.824835254949;5892.027815410409;5897.882042359129;5930.525557955353;5931.555133365015;4404.647628189737;4429.2913133899065;4434.933475997863;4444.1333939881415;4465.37484752135;3992.041909941593;4019.1559772448113;4023.657989070903;4029.15387768566;4046.9392959105635;5596.076647353141;5619.719014049281;5622.465865742748;5627.6904770237215;5645.491905728422;5870.471657550841;5871.3541510433815;5871.647701137946;5874.412558744177;5877.206577112035;5478.287822583039;5602.747876345574;5607.41122182165;5608.242887210256;5681.857953551194;5047.192449208183;5056.266841308064;5064.518870707277;5065.366829146356;5078.492150784966;6081.57428979976;6099.3900609938655;6111.938880611226;6127.571070025056;6137.140800287963;5773.076307790733;5900.852478687895;5910.261217347917;5989.670568118795;5996.70016499182;6110.572259941761;6122;6134.294556126102;6134.478569321657;6136.048912418582;5778.8844223114465;5790.363060063305;5790.652560846194;5791;5791.82624521265;5752.942470575241;5869.706514674163;5949.583529152917;5965.403459654;5970.104484327212;5718.914216286676;5724.4561766632105;5746.195532625519;5748.48263656273;5755.482006619424;5735.197072409949;5751.798687045934;5753.165790960204;5753.482186603226;5755.3381361144;5451.155070964007;5637.8590535236945;5697.686627235376;5703.429657034263;5709.971450142889;5754.136879468113;5764.452377024344;5776.508996735324;5782.797602083907;5790.710464476675;5569.582281328998;5603.831885043455;5637.57718171147;5649.54803615718;5695.971520142372 05:30:29 INFO - PROCESS | 9985 | |1;ext.html;613.907913812928;659.8944168932971;668.7325069972007;670.3028849996006;671.0002096875654;34167.658323416756;40233;40776;40798.38802417962;40870.59129408713;44187.55812441875;44738.7763061185;44786;44797.77601111998;44847.77576112115;8197;8807.779805504882;8968.417052891573;8970.192682658559;10404.323718958281;10374.740631484236;10480;10488.056074953252;10494.37033777972;10497.37015779052;10511;10514.211434142431;10553;10577.471126443685;10581.153507719364;10457.738556536071;10503.52734126966;10514.316569422963;10516.474176291193;10522.105621022223;10341.586336546528;10449.268551201343;10463.738406539822;10788.244822862323;10816.351018938889;44103.117937641066;44518.55481445177;44598.33102503465;44629;44654.33018504693;3969.861054863066;3995.3407687731487;4110.506739191316;4149.419081328617;4344.587264209895;33653.32693346144;33876.072601521315;34016.48975265373;34670.09314487702;35697;4471.374007638933;4566.703164294344;4576.54234576543;4590.517995610447;4599.31010348447;338823;341510;341703;342009;342508;39971.20057598832;64250;65242.67378663076;65244.673776630814;65284;38199.090045497614;38291;38367.232655347296;38410.231795363936;38442.615573843905;16616.916915415586;16801.07594082337;16820.57948551296;16824.579385515215;16827.495175144766;13616.93191534036;14423.134611923319;14747.631309217355;14751.63120921964;14856.554303370916;9232.261419086457;9247.861282080774;9249.768755781024;9272.165505104438;9301.860472092923;3550.1302180965313;3607.9278414431565;3609.8375573098747;3652.579953305351;3653.378925582604;1153.9192256542128;1154.468944285638;1188.7681902029021;1190.8451901252781;1285.2802430638872;34450.483242751376;34686.65313346834;34802.47796283058;35305.82347088299;35483.290334193174;1186.6262127429832;1242.9502819887284;1259.4206664934234;1300.0964329790893;1314.5859054397833;17836.821631783518;18354.724679129824;18386.540336491427;18460.35388761414;18488.260469581335;513658;519048;520511;521935;522747;64025.67987160035;64703.35296647067;64783.67608162023;64853;64899.67550162219;1381.109184575943;1451.8402975672668;1523.070926734691;1561.7423125184444;1562.1174036669472;32396.514052288763;34083;34384.48423273603;34685.47971780375;34967;53700;53984.460155397945;54253.72873135609;54254;54278.45721542892;318257;323186;324220;325624;329905;27726.168214953585;30456.84771576128;30779.84610076935;31060;31387;47393.763031186005;50208.748956256444;50452.49547504478;51423.742881285354;52216;41523;41669;41957.58042419537;42150.36774448447;42963.3555496674;40392.79803600963;40698.79650601728;41192.24710363075;41572.3764143532;41782;43107.568924310355;43363.78318108389;43660.78169609132;43845.12309753851;43914;35539.11152221215;36247.45628815622;37118.44322335113;37836;37847.43228851625;29022.709772902002;29104.7089529102;29156.7084329154;29502;29589 05:30:29 INFO - PROCESS | 9985 | |2;jquery.html;421.38267438203025;425.31099618617844;425.4299239019713;425.44904348868215;431.73448329277494;19056.90471547642;19457.805421945795;19496.122674479648;19661.606767864636;20223.59552808943;19627.411177664657;20131.29540466084;20154.496137596532;20210.19159233629;20253.189872405124;5397.568194544427;5706.315242170946;5716.542676585863;5870;5939.346671866091;4038.919221615566;5690.118031705092;5862.912056319158;5863.912041319383;5961.195238642771;5952.434518720715;5988.041913293852;5991.400859913995;5995.61028533144;5999.880002399949;5940.88118237635;6065.7573697052285;6311.400416960381;6476.158099447089;6529.1512103426485;3965.960340396588;5617.775288988436;5811.6803575803315;5838.766449342063;5856.736446859902;13566.59300220995;13998.790018149735;14015.509457169052;14051.367688453942;14133.717325653532;2516.8993240270365;2553.0553695132735;3043.5148389906385;3080.091373044957;3183.649798522161;10341.896581034169;10475.79048419035;10497.737556561071;10617.362958222455;13853.584392468241;2015.2543558883308;2018.697195420684;2046.2940285601444;2087.0608226298073;2165.4802847316687;80861.59569202116;84422.57788711079;84431.57784211039;85016.14983850144;87152.12847871504;11084.279521831055;11422.828657570142;11650.475728592233;11673.649790506299;11844.28934263947;16718.665626687398;16813.075280859426;16839.242234099496;16877.32490700358;16892.15539223034;9030.32272579546;9071.183593476619;9156.450612963243;9175.357724959322;9211.447313161098;8790.373780850563;8939.642414303355;8946.926368835651;9065.68270110543;9098.681546145854;5037.974810125926;5050.141475949097;5125.1287281162295;5126.128558145124;5152.510511501401;1825.8907540105467;1973.7730161031666;2054.209129485159;2070.3478404302596;2133.2746866065613;1021.5045702834119;1069.417167643636;1110.2616759854607;1114.420501339299;1140.6749076513154;18606.627867442574;19376.2249510018;19541.902290488742;19684.409467715992;19694.31069912546;1068.7114479090758;1096.221682605359;1107.4739498738195;1155.7341811383428;1158.8435561199299;11048.226624136394;11084.445777711082;11100.11199104086;11117.72205694848;11119.44402779874;375989;377238;377888;379893;538579;90043.54978225067;93320.53339733394;93558;93611.53194233985;94635.52682236544;1113.5935383585095;1130.496928866663;1139.2139423797553;1166.084623570493;1173.9706507337385;17508;17877.73183402276;17879.19543620514;17897.19462624211;18344.082795859886;36452.27095458023;36983.445248321834;37214.06964825793;38247.42628860625;40096.39855402113;47884;49303;49819.25271120864;50065;50539;8394.790130246793;8453.196946290092;8460.111688272642;8491.108433614381;8650.307975362082;9951;13480.258585777876;13734.725305494034;13762.311884405939;13785.655358616115;12096;12118.939405302917;12199.451024704087;12306.692332691755;12365.629031129081;11526.88473115258;11572.94213528927;11893.108016898941;11944.64166075019;12043.698907527381;12228;12264.632061038183;12361.62915112548;12362.567310144103;13047.478100875858;8206;8424.241818236143;8937.06160853101;9020.05289444599;9080.137386948229;11402.429878505876;12076.577319793765;12242.938785306373;12303.200291980993;12457.937710311391 05:30:29 INFO - PROCESS | 9985 | |3;mootools.html;1462.9926850365746;1549.2099029494957;1579.5103517909452;1758.6922288599492;1895.5166432559695;8086.878696819553;8165;8189;8265.54539500328;8270.172982701726;8061.113277539466;8159.959200203991;8217.876731849026;8227.17728227177;8229.259366657;2117.4600476878372;2360.114956891166;2369.763023697634;2391.9162829300976;2411.071737381112;2444.535538247736;2444.6577479152934;2453.288546321565;2453.6932883389577;2456.778889899909;2322.1756276521846;2375.4180225844693;2388.5103553771437;2393.7127544694663;2398.4843258699375;2121.840861935353;2393.3418309964727;2436.50051739393;2436.9878150609134;2441.56051910656;2323.500447403799;2350.17743789674;2350.21267875262;2360.138549429463;2383.833131680783;8198.303144232746;8260.628271727786;8277.296429803473;8278.089410164877;8311.916880831235;5121.897562048738;5179.896402071975;5214.322138122057;5215.243789650517;5316.6544174628525;3418.1454636340914;3453.827308634558;3518.0677120562814;3527.5414196154593;3593;1182.6274723462082;1206.7586482703493;1208.6072026591394;1212.563477148226;1214.7570485902854;11800.468978895884;11832.585859494877;11858.40707964607;11862;11863.52545898163;4489;4503.639708823286;4634.513376095529;4655.045715628288;4664.556867097688;9905.306628536078;9915.702528924145;9932.851007234898;9940.552675129637;9949.452780097019;4752.477227504972;5312.946870531246;5324.840254792362;5329.333833270841;5330.893382132335;4812.975935120372;4825.396825396825;4868.099401610642;4896.6572339935865;4909.0672772173175;4067.186562687474;4077.531083925327;4142.979285103555;4283.293256612624;4287.614114729689;1311.2919023727272;1375.0374737683662;1384.6538365408649;1393.6306878677158;1400.509821562445;967.1440774914252;1094.8905109488987;1099.9419778127117;1114.9777004459866;1143.3082984794246;6065.727042283108;6157.784477543264;6191.81424557264;6202.100695399142;6272.937270627326;450.2008934141924;472.3269341188792;472.8652334084769;479.9208130658472;481.069131231069;4250.447441832542;4259.510156332061;4286.099919016979;4295.72077814941;4296.2266791977745;10118.848217276747;10378;10517.211209159344;10521.368717876952;10565.049145576935;10270.281080324306;10277.486125693686;10288.434136122585;10290.742731431774;10334.741631459123;8088.352931765445;8148.307393871587;8153.95923020393;8162.510249385056;8163.632636531371;5900.675462849585;5941.940580594139;5942.910856337245;5975.581709280309;6188.876222475616;8890.244329232088;8924.598393072198;8950.015498295312;9149.405288656217;9158.67944621935;9019.278457723498;9091.045440228945;9233.538323083685;9234.538273086453;9236.030216827405;7252.456065795192;7324.63376831167;7390.630468476447;7414.480986331121;7490.438217133627;7917.366610671017;7964.323032542299;7972.720954766555;8003;8017.679292828221;6809.250982392032;7105.538140020882;7146;7147.428205743632;7259.854802903807;6911.7926462206215;6975.128108986377;7072.823179420556;7073.0097786308925;7212.963935180501;6698.933010670026;6879.7248110077035;6883.346082122191;6891.75878844238;6916.066331045245;5060.2156665716875;5119.87200319995;5171.612129090408;5203.219517072469;5245.632805703564;5123.87190320245;5131.435542090292;5171.534561889448;5189.818356357509;5313.814016509404 05:30:29 INFO - PROCESS | 9985 | |4;prototype.html;331.67164507137943;331.9668033196681;337.84459148791564;340.44677399226254;349.64336376895585;6124.5406594505475;6179.258488981323;6245.125682404456;6257.186565746458;6260.561760676749;6206.968965155179;6235.469985051276;6262.812115636538;6318.652474113922;6342.556021078526;4787.1622466068475;4799.352087468182;4801.303810947411;4803.231482962727;4810.591099756525;4569.565891240343;4624.514425985273;4726.976365118169;4801.975990120062;4807.975960120195;4705.623550116;4717.716936983792;4719.174144524712;4726.66913316068;4733.763311834395;4698.600618947394;4719.834805781781;4720.55154760299;4728.030753695484;4738.4550776660435;4110.815013324408;4124.1133156371225;4127.731697439687;4131.814068366931;4135.6898232632675;6036.758529658809;6055.545834062463;6063.969680151571;6070.605410648293;6087.2086628738425;5299.4435584263865;5491.395946445888;5492.505674489275;5497.103499292738;5515.779368825242;6602.504812139109;6618.503612229054;6621.569597976116;6632.966835165793;6643.833904152387;4509.842155524541;4510.729356238636;4521.1409832131785;4522.7060241084555;4524.29873369625;6856.41720453762;6928.307169283082;6934.4452443804375;6939.306069393071;6950.061741664861;4535.387722657399;4539.659525535598;4541.43232095988;4542.432195975503;4543.886402839889;4595.977020114878;4596.632269418438;4601.700889442175;4605.240135377625;4605.562471565196;5248.921266181011;5440.972795135999;5442.265294185314;5448.210009548593;5459.2902922619805;6608.372204640552;6646.202455705346;6659.700313485905;6662.067310576524;6666.933330666631;1552.5808031831343;1576.282791329942;1624.7969003874516;1628.9818863210494;1630.1115891838976;1043.1081425381342;1050.5482642463814;1054.8628678271775;1066.2802608239563;1067.658349328223;6401;6409.391107844747;6452.354764523604;6469.320721324288;6469.547131700736;6809.897851532231;6811.897821532681;6818.829529261709;6831.385175334144;6838.48711346651;6441.774537891151;6462.192225971754;6466.708998095097;6469.385408386196;6476.31998640136;3628.963710362915;3659.9817000914827;3671.632836716307;3673.2837096766407;3676.0442285005556;6936.722531098801;7038.577685338896;7103.254158313406;7109.75115870942;7138.393236574845;6938.202106757686;6951.443884489228;6952.505211379577;6968.442524598121;6977.51157418986;7061;7067.187273463617;7083.681234344467;7084.92915070853;7140.999999999896;6786.253512113565;6803.795886123424;6807.5575087619145;6810.693518791765;6824.522283440111;6605.438537724155;6702.530822842355;6844.5208835381045;6844.726210951705;6862.107925969792;7195.640217989185;7218;7218.242084581043;7233.240509746401;7233.710651573878;4588.88527786808;4636.744979026186;4639.30410438437;4640.535946405467;4643.326717625993;6574.112494813139;6680.732770689118;6929.064576282339;6971.233164352018;6974.37230649244;6676.532642714963;6680.532362734756;6682;6683.532152749455;6685.09751183584;6669.433098186709;6676;6689.565178263398;6691.899621505779;6697.732090716511;6574.868502629825;6575.145231120116;6580.309067547839;6583.44040756541;6596.241432235354;6556.311587283267;6696.866062678621;6701.32986701326;6706.932930670826;6734.259231484435;6540.901886471802;6543.738250469928;6567.146270984933;6568.080468734285;6573.57271777333 05:30:29 INFO - PROCESS | 9985 | |5;yui.html;873.5632183908046;907.9273658107352;916.9816603667927;930.4882314726899;960.5149399553225;14101.858981410183;14274.143551386898;14322.713545729079;14473.565793026213;14491.202983835898;13105.410256538455;14195.645108872257;14201.076929999543;14203.78694319586;14221.217833019206;773.8374941262342;898.2454738020078;898.4025622960723;907.0476000199797;913.7487191022456;910.2490445382552;922.2667978956712;922.4972390047441;922.7093465558361;922.898481167071;962.6534447598859;968.2157452463528;968.3802366485455;968.5205823117532;969.321474967522;807.995960020199;934.2712684106408;953.7186529973606;961.1733908838394;961.725908116187;702.0697575712151;707.1302298173275;707.9185893622248;708.2987842036398;709.2411120101493;14133.575992720234;14154;14190.50333238342;14197.645058873612;14209.644758881008;14959.476418325306;15250.161241131733;15330.463433779763;15340.693186136326;15416.152111633855;12416.441260143316;12439.875601244054;12447.813282800766;12488.50045998159;12674.619761407173;4050.129222217208;4077.6533994610195;4117.094239267356;4126.360414135814;4209.010882442623;59097.99999999957;59319.40680593182;59461;59585.40414595842;59681.40318596802;11928.403579820973;11980;12020.655972085535;12067.517299308105;12286.906417643659;21617.24339648136;21764.673529897063;21810.781892181192;21837.126514939224;21866.344009679735;8513.574321283912;8809.515476648718;8812.691555795516;8873.334499912533;9099.908011038586;5091.439941606421;5155.948440515622;5156.097682905476;5161.2516185152945;5219.973900130551;3713.7400381973544;3759.9436008459893;3766.1902690921584;3772.1701225730294;3778.3765678663262;658.3811217455576;660.425429876011;662.5130529061137;665.8701553197177;689.290031267795;665.7902760630483;712.0316369737153;750.2534977697226;815.4454970620035;828.0684230240979;9149.862752058725;9327;9364.95317523408;9707.174890134418;9765.853512197322;657.4346062386344;660.4122331125302;723.1755798389839;755.5919803306263;798.876174193001;4340.348947657877;4361.9127617447475;4423.5576442355505;4542.432195975503;4698.506656800987;72383.63808180926;73180;74573;76082.23917760863;76174;60614;60686.69656651688;61113.69443152756;62102.68948655318;63597;56190;56431.15353269704;57259.427405726245;57591.712041439525;58073.128903066485;10085.345959495415;10117.544710487899;10211.776911029745;10248.590056397661;10259.640912568024;39142.608573913894;39788.403173953;40352;41246.793766030976;42343.36484952667;48600.78498037436;49304.26043609277;49642.25536617026;49691.254631181284;50274.245886311;12650;12715.491380345053;12748.171368860994;13004.154729942524;13058;13722.862771372158;14089.577312680636;14276;14434.133951962916;14620.634484137556;10866.293690910066;13211.801822972471;13337.599872003855;13395.732085358433;13520.18878867271;13498;13668.52160174389;13727;13825.446982120602;13962.371693273624;13196.60410187696;13283.933580332037;13635.045546811629;13696.246706430844;13708;11102.2783519071;11238.606648767254;11301.491432885376;11696.70758231051;12023;11317.773644527228;11449;11704.017082077773;11756.118291128028;11773.17587768848 05:30:29 INFO - PROCESS | 9985 | __end_tp_report 05:30:29 INFO - PROCESS | 9985 | __start_cc_report 05:30:29 INFO - PROCESS | 9985 | _x_x_mozilla_cycle_collect,787 05:30:29 INFO - PROCESS | 9985 | __end_cc_report 05:30:29 INFO - PROCESS | 9985 | __startTimestamp1464784229832__endTimestamp 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | ------- Summary: start ------- 05:30:29 INFO - PROCESS | 9985 | Number of tests: 6 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | [#0] dojo.html Cycles:165 Average:5462.88 Median:5695.97 stddev:601.94 (10.6%) stddev-sans-first:579.25 05:30:29 INFO - PROCESS | 9985 | Values: 3294.7 3321.3 3329.8 3352.0 3366.3 5366.1 5371.2 5374.2 5388.6 5393.9 5353.5 5356.9 5399.5 5404.9 5407.3 4858.6 4873.0 4980.4 5012.8 5076.1 4966.6 4971.0 5023.7 5048.6 5051.4 5093.1 5095.2 5116.9 5123.8 5132.6 5110.5 5123.8 5129.4 5130.9 5149.3 4910.7 4921.5 4998.9 5040.3 5076.7 5382.7 5404.3 5414.4 5426.6 5444.3 5892.9 5897.4 5902.7 5907.4 5919.1 5679.9 5864.2 5908.8 5976.9 5989.0 5495.2 5501.8 5501.9 5504.6 5504.8 5900.6 5931.6 5975.4 5981.2 5988.4 5699.7 5753.9 5788.2 5789.3 5789.8 5841.4 5860.6 5861.1 5868.6 5871.2 5720.6 5809.7 5831.6 5832.2 5834.9 5838.8 5892.0 5897.9 5930.5 5931.6 4404.6 4429.3 4434.9 4444.1 4465.4 3992.0 4019.2 4023.7 4029.2 4046.9 5596.1 5619.7 5622.5 5627.7 5645.5 5870.5 5871.4 5871.6 5874.4 5877.2 5478.3 5602.7 5607.4 5608.2 5681.9 5047.2 5056.3 5064.5 5065.4 5078.5 6081.6 6099.4 6111.9 6127.6 6137.1 5773.1 5900.9 5910.3 5989.7 5996.7 6110.6 6122.0 6134.3 6134.5 6136.0 5778.9 5790.4 5790.7 5791.0 5791.8 5752.9 5869.7 5949.6 5965.4 5970.1 5718.9 5724.5 5746.2 5748.5 5755.5 5735.2 5751.8 5753.2 5753.5 5755.3 5451.2 5637.9 5697.7 5703.4 5710.0 5754.1 5764.5 5776.5 5782.8 5790.7 5569.6 5603.8 5637.6 5649.5 5696.0 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | [#1] ext.html Cycles:180 Average:56517.82 Median:19928.65 stddev:107085.17 (537.3%) stddev-sans-first:107303.31 05:30:29 INFO - PROCESS | 9985 | Values: 613.9 659.9 668.7 670.3 671.0 34167.7 40233.0 40776.0 40798.4 40870.6 44187.6 44738.8 44786.0 44797.8 44847.8 8197.0 8807.8 8968.4 8970.2 10404.3 10374.7 10480.0 10488.1 10494.4 10497.4 10511.0 10514.2 10553.0 10577.5 10581.2 10457.7 10503.5 10514.3 10516.5 10522.1 10341.6 10449.3 10463.7 10788.2 10816.4 44103.1 44518.6 44598.3 44629.0 44654.3 3969.9 3995.3 4110.5 4149.4 4344.6 33653.3 33876.1 34016.5 34670.1 35697.0 4471.4 4566.7 4576.5 4590.5 4599.3 338823.0 341510.0 341703.0 342009.0 342508.0 39971.2 64250.0 65242.7 65244.7 65284.0 38199.1 38291.0 38367.2 38410.2 38442.6 16616.9 16801.1 16820.6 16824.6 16827.5 13616.9 14423.1 14747.6 14751.6 14856.6 9232.3 9247.9 9249.8 9272.2 9301.9 3550.1 3607.9 3609.8 3652.6 3653.4 1153.9 1154.5 1188.8 1190.8 1285.3 34450.5 34686.7 34802.5 35305.8 35483.3 1186.6 1243.0 1259.4 1300.1 1314.6 17836.8 18354.7 18386.5 18460.4 18488.3 513658.0 519048.0 520511.0 521935.0 522747.0 64025.7 64703.4 64783.7 64853.0 64899.7 1381.1 1451.8 1523.1 1561.7 1562.1 32396.5 34083.0 34384.5 34685.5 34967.0 53700.0 53984.5 54253.7 54254.0 54278.5 318257.0 323186.0 324220.0 325624.0 329905.0 27726.2 30456.8 30779.8 31060.0 31387.0 47393.8 50208.7 50452.5 51423.7 52216.0 41523.0 41669.0 41957.6 42150.4 42963.4 40392.8 40698.8 41192.2 41572.4 41782.0 43107.6 43363.8 43660.8 43845.1 43914.0 35539.1 36247.5 37118.4 37836.0 37847.4 29022.7 29104.7 29156.7 29502.0 29589.0 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | [#2] jquery.html Cycles:180 Average:26602.45 Median:2078.70 stddev:68908.26 (3315.0%) stddev-sans-first:69073.53 05:30:29 INFO - PROCESS | 9985 | Values: 421.4 425.3 425.4 425.4 431.7 19056.9 19457.8 19496.1 19661.6 20223.6 19627.4 20131.3 20154.5 20210.2 20253.2 5397.6 5706.3 5716.5 5870.0 5939.3 4038.9 5690.1 5862.9 5863.9 5961.2 5952.4 5988.0 5991.4 5995.6 5999.9 5940.9 6065.8 6311.4 6476.2 6529.2 3966.0 5617.8 5811.7 5838.8 5856.7 13566.6 13998.8 14015.5 14051.4 14133.7 2516.9 2553.1 3043.5 3080.1 3183.6 10341.9 10475.8 10497.7 10617.4 13853.6 2015.3 2018.7 2046.3 2087.1 2165.5 80861.6 84422.6 84431.6 85016.1 87152.1 11084.3 11422.8 11650.5 11673.6 11844.3 16718.7 16813.1 16839.2 16877.3 16892.2 9030.3 9071.2 9156.5 9175.4 9211.4 8790.4 8939.6 8946.9 9065.7 9098.7 5038.0 5050.1 5125.1 5126.1 5152.5 1825.9 1973.8 2054.2 2070.3 2133.3 1021.5 1069.4 1110.3 1114.4 1140.7 18606.6 19376.2 19541.9 19684.4 19694.3 1068.7 1096.2 1107.5 1155.7 1158.8 11048.2 11084.4 11100.1 11117.7 11119.4 375989.0 377238.0 377888.0 379893.0 538579.0 90043.5 93320.5 93558.0 93611.5 94635.5 1113.6 1130.5 1139.2 1166.1 1174.0 17508.0 17877.7 17879.2 17897.2 18344.1 36452.3 36983.4 37214.1 38247.4 40096.4 47884.0 49303.0 49819.3 50065.0 50539.0 8394.8 8453.2 8460.1 8491.1 8650.3 9951.0 13480.3 13734.7 13762.3 13785.7 12096.0 12118.9 12199.5 12306.7 12365.6 11526.9 11572.9 11893.1 11944.6 12043.7 12228.0 12264.6 12361.6 12362.6 13047.5 8206.0 8424.2 8937.1 9020.1 9080.1 11402.4 12076.6 12242.9 12303.2 12457.9 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | [#3] mootools.html Cycles:180 Average:5605.20 Median:5090.04 stddev:3043.66 (59.8%) stddev-sans-first:3036.28 05:30:29 INFO - PROCESS | 9985 | Values: 1463.0 1549.2 1579.5 1758.7 1895.5 8086.9 8165.0 8189.0 8265.5 8270.2 8061.1 8160.0 8217.9 8227.2 8229.3 2117.5 2360.1 2369.8 2391.9 2411.1 2444.5 2444.7 2453.3 2453.7 2456.8 2322.2 2375.4 2388.5 2393.7 2398.5 2121.8 2393.3 2436.5 2437.0 2441.6 2323.5 2350.2 2350.2 2360.1 2383.8 8198.3 8260.6 8277.3 8278.1 8311.9 5121.9 5179.9 5214.3 5215.2 5316.7 3418.1 3453.8 3518.1 3527.5 3593.0 1182.6 1206.8 1208.6 1212.6 1214.8 11800.5 11832.6 11858.4 11862.0 11863.5 4489.0 4503.6 4634.5 4655.0 4664.6 9905.3 9915.7 9932.9 9940.6 9949.5 4752.5 5312.9 5324.8 5329.3 5330.9 4813.0 4825.4 4868.1 4896.7 4909.1 4067.2 4077.5 4143.0 4283.3 4287.6 1311.3 1375.0 1384.7 1393.6 1400.5 967.1 1094.9 1099.9 1115.0 1143.3 6065.7 6157.8 6191.8 6202.1 6272.9 450.2 472.3 472.9 479.9 481.1 4250.4 4259.5 4286.1 4295.7 4296.2 10118.8 10378.0 10517.2 10521.4 10565.0 10270.3 10277.5 10288.4 10290.7 10334.7 8088.4 8148.3 8154.0 8162.5 8163.6 5900.7 5941.9 5942.9 5975.6 6188.9 8890.2 8924.6 8950.0 9149.4 9158.7 9019.3 9091.0 9233.5 9234.5 9236.0 7252.5 7324.6 7390.6 7414.5 7490.4 7917.4 7964.3 7972.7 8003.0 8017.7 6809.3 7105.5 7146.0 7147.4 7259.9 6911.8 6975.1 7072.8 7073.0 7213.0 6698.9 6879.7 6883.3 6891.8 6916.1 5060.2 5119.9 5171.6 5203.2 5245.6 5123.9 5131.4 5171.5 5189.8 5313.8 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | [#4] prototype.html Cycles:180 Average:5535.56 Median:6405.20 stddev:1703.43 (26.6%) stddev-sans-first:1662.82 05:30:29 INFO - PROCESS | 9985 | Values: 331.7 332.0 337.8 340.4 349.6 6124.5 6179.3 6245.1 6257.2 6260.6 6207.0 6235.5 6262.8 6318.7 6342.6 4787.2 4799.4 4801.3 4803.2 4810.6 4569.6 4624.5 4727.0 4802.0 4808.0 4705.6 4717.7 4719.2 4726.7 4733.8 4698.6 4719.8 4720.6 4728.0 4738.5 4110.8 4124.1 4127.7 4131.8 4135.7 6036.8 6055.5 6064.0 6070.6 6087.2 5299.4 5491.4 5492.5 5497.1 5515.8 6602.5 6618.5 6621.6 6633.0 6643.8 4509.8 4510.7 4521.1 4522.7 4524.3 6856.4 6928.3 6934.4 6939.3 6950.1 4535.4 4539.7 4541.4 4542.4 4543.9 4596.0 4596.6 4601.7 4605.2 4605.6 5248.9 5441.0 5442.3 5448.2 5459.3 6608.4 6646.2 6659.7 6662.1 6666.9 1552.6 1576.3 1624.8 1629.0 1630.1 1043.1 1050.5 1054.9 1066.3 1067.7 6401.0 6409.4 6452.4 6469.3 6469.5 6809.9 6811.9 6818.8 6831.4 6838.5 6441.8 6462.2 6466.7 6469.4 6476.3 3629.0 3660.0 3671.6 3673.3 3676.0 6936.7 7038.6 7103.3 7109.8 7138.4 6938.2 6951.4 6952.5 6968.4 6977.5 7061.0 7067.2 7083.7 7084.9 7141.0 6786.3 6803.8 6807.6 6810.7 6824.5 6605.4 6702.5 6844.5 6844.7 6862.1 7195.6 7218.0 7218.2 7233.2 7233.7 4588.9 4636.7 4639.3 4640.5 4643.3 6574.1 6680.7 6929.1 6971.2 6974.4 6676.5 6680.5 6682.0 6683.5 6685.1 6669.4 6676.0 6689.6 6691.9 6697.7 6574.9 6575.1 6580.3 6583.4 6596.2 6556.3 6696.9 6701.3 6706.9 6734.3 6540.9 6543.7 6567.1 6568.1 6573.6 05:30:29 INFO - PROCESS | 9985 | 05:30:29 INFO - PROCESS | 9985 | [#5] yui.html Cycles:180 Average:16402.01 Median:4351.13 stddev:19556.98 (449.5%) stddev-sans-first:19577.08 05:30:29 INFO - PROCESS | 9985 | Values: 873.6 907.9 917.0 930.5 960.5 14101.9 14274.1 14322.7 14473.6 14491.2 13105.4 14195.6 14201.1 14203.8 14221.2 773.8 898.2 898.4 907.0 913.7 910.2 922.3 922.5 922.7 922.9 962.7 968.2 968.4 968.5 969.3 808.0 934.3 953.7 961.2 961.7 702.1 707.1 707.9 708.3 709.2 14133.6 14154.0 14190.5 14197.6 14209.6 14959.5 15250.2 15330.5 15340.7 15416.2 12416.4 12439.9 12447.8 12488.5 12674.6 4050.1 4077.7 4117.1 4126.4 4209.0 59098.0 59319.4 59461.0 59585.4 59681.4 11928.4 11980.0 12020.7 12067.5 12286.9 21617.2 21764.7 21810.8 21837.1 21866.3 8513.6 8809.5 8812.7 8873.3 9099.9 5091.4 5155.9 5156.1 5161.3 5220.0 3713.7 3759.9 3766.2 3772.2 3778.4 658.4 660.4 662.5 665.9 689.3 665.8 712.0 750.3 815.4 828.1 9149.9 9327.0 9365.0 9707.2 9765.9 657.4 660.4 723.2 755.6 798.9 4340.3 4361.9 4423.6 4542.4 4698.5 72383.6 73180.0 74573.0 76082.2 76174.0 60614.0 60686.7 61113.7 62102.7 63597.0 56190.0 56431.2 57259.4 57591.7 58073.1 10085.3 10117.5 10211.8 10248.6 10259.6 39142.6 39788.4 40352.0 41246.8 42343.4 48600.8 49304.3 49642.3 49691.3 50274.2 12650.0 12715.5 12748.2 13004.2 13058.0 13722.9 14089.6 14276.0 14434.1 14620.6 10866.3 13211.8 13337.6 13395.7 13520.2 13498.0 13668.5 13727.0 13825.4 13962.4 13196.6 13283.9 13635.0 13696.2 13708.0 11102.3 11238.6 11301.5 11696.7 12023.0 11317.8 11449.0 11704.0 11756.1 11773.2 05:30:29 INFO - PROCESS | 9985 | -------- Summary: end -------- 05:30:29 INFO - PROCESS | 9985 | 05:30:30 INFO - TEST-INFO | 9985: exit 0 05:30:30 INFO - TEST-OK | dromaeo_css | took 1110531ms 05:30:30 INFO - TEST-START | kraken 05:30:30 INFO - operating with platform_type : linux_ 05:30:30 INFO - Initialising browser for kraken test... 05:30:30 INFO - TEST-INFO | started process 10183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfeiTwk/profile http://localhost:41837/getInfo.html) 05:30:33 INFO - PROCESS | 10183 | __metrics Screen width/height:1600/1200 05:30:33 INFO - PROCESS | 10183 | colorDepth:24 05:30:33 INFO - PROCESS | 10183 | Browser inner width/height: 1024/697 05:30:33 INFO - PROCESS | 10183 | __metrics 05:30:34 ERROR - PROCESS | 10183 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:30:35 INFO - TEST-INFO | 10183: exit 0 05:30:35 INFO - Browser initialized. 05:30:35 INFO - Running cycle 1/1 for kraken test... 05:30:35 INFO - TEST-INFO | started process 10274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfeiTwk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:47 INFO - PROCESS | 10274 | RSS: Main: 141660160 05:30:47 INFO - PROCESS | 10274 | 05:30:50 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41837/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:50 INFO - PROCESS | 10274 | RSS: Main: 197001216 05:30:50 INFO - PROCESS | 10274 | 05:30:53 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41837/tests/kraken/driver.html?testName=audio-dft) 05:30:54 INFO - PROCESS | 10274 | RSS: Main: 181411840 05:30:54 INFO - PROCESS | 10274 | 05:30:56 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41837/tests/kraken/driver.html?testName=audio-fft) 05:30:57 INFO - PROCESS | 10274 | RSS: Main: 272408576 05:30:57 INFO - PROCESS | 10274 | 05:30:59 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41837/tests/kraken/driver.html?testName=audio-oscillator) 05:31:00 INFO - PROCESS | 10274 | RSS: Main: 178053120 05:31:00 INFO - PROCESS | 10274 | 05:31:02 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:02 INFO - PROCESS | 10274 | RSS: Main: 176766976 05:31:02 INFO - PROCESS | 10274 | 05:31:05 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41837/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:06 INFO - PROCESS | 10274 | RSS: Main: 211480576 05:31:06 INFO - PROCESS | 10274 | 05:31:09 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41837/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:10 INFO - PROCESS | 10274 | RSS: Main: 211324928 05:31:10 INFO - PROCESS | 10274 | 05:31:13 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41837/tests/kraken/driver.html?testName=json-parse-financial) 05:31:13 INFO - PROCESS | 10274 | RSS: Main: 212103168 05:31:13 INFO - PROCESS | 10274 | 05:31:15 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:15 INFO - PROCESS | 10274 | RSS: Main: 191029248 05:31:15 INFO - PROCESS | 10274 | 05:31:17 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:18 INFO - PROCESS | 10274 | RSS: Main: 196136960 05:31:18 INFO - PROCESS | 10274 | 05:31:20 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:20 INFO - PROCESS | 10274 | RSS: Main: 207589376 05:31:20 INFO - PROCESS | 10274 | 05:31:23 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:23 INFO - PROCESS | 10274 | RSS: Main: 214212608 05:31:23 INFO - PROCESS | 10274 | 05:31:26 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:27 INFO - PROCESS | 10274 | RSS: Main: 210300928 05:31:27 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | Cycle 1(1): loaded http://localhost:41837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41837/tests/kraken/driver.html?testName=ai-astar) 05:31:28 INFO - PROCESS | 10274 | RSS: Main: 274096128 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | __start_tp_report 05:31:28 INFO - PROCESS | 10274 | _x_x_mozilla_page_load 05:31:28 INFO - PROCESS | 10274 | _x_x_mozilla_page_load_details 05:31:28 INFO - PROCESS | 10274 | |i|pagename|runs| 05:31:28 INFO - PROCESS | 10274 | |0;ai-astar;110;109;108;109;109;109;103;111;109;111 05:31:28 INFO - PROCESS | 10274 | |1;audio-beat-detection;165;126;155;176;133;156;158;129;209;125 05:31:28 INFO - PROCESS | 10274 | |2;audio-dft;163;163;161;162;161;161;163;162;160;161 05:31:28 INFO - PROCESS | 10274 | |3;audio-fft;75;75;76;179;73;76;74;76;166;72 05:31:28 INFO - PROCESS | 10274 | |4;audio-oscillator;91;93;153;91;92;94;144;92;92;153 05:31:28 INFO - PROCESS | 10274 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;117;117 05:31:28 INFO - PROCESS | 10274 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;146 05:31:28 INFO - PROCESS | 10274 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 05:31:28 INFO - PROCESS | 10274 | |8;json-parse-financial;53;55;54;53;55;53;58;71;53;53 05:31:28 INFO - PROCESS | 10274 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;60;58;60 05:31:28 INFO - PROCESS | 10274 | |10;stanford-crypto-aes;72;73;72;73;81;74;73;81;74;73 05:31:28 INFO - PROCESS | 10274 | |11;stanford-crypto-ccm;115;120;111;112;110;113;119;111;129;129 05:31:28 INFO - PROCESS | 10274 | |12;stanford-crypto-pbkdf2;154;155;159;154;159;158;155;153;154;155 05:31:28 INFO - PROCESS | 10274 | |13;stanford-crypto-sha256-iterative;65;65;67;65;63;63;65;66;64;63 05:31:28 INFO - PROCESS | 10274 | __end_tp_report 05:31:28 INFO - PROCESS | 10274 | __start_cc_report 05:31:28 INFO - PROCESS | 10274 | _x_x_mozilla_cycle_collect,1592 05:31:28 INFO - PROCESS | 10274 | __end_cc_report 05:31:28 INFO - PROCESS | 10274 | __startTimestamp1464784288964__endTimestamp 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | ------- Summary: start ------- 05:31:28 INFO - PROCESS | 10274 | Number of tests: 14 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:2.25 (2.1%) stddev-sans-first:2.35 05:31:28 INFO - PROCESS | 10274 | Values: 110.0 109.0 108.0 109.0 109.0 109.0 103.0 111.0 109.0 111.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:157.00 stddev:26.53 (16.9%) stddev-sans-first:27.80 05:31:28 INFO - PROCESS | 10274 | Values: 165.0 126.0 155.0 176.0 133.0 156.0 158.0 129.0 209.0 125.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 05:31:28 INFO - PROCESS | 10274 | Values: 163.0 163.0 161.0 162.0 161.0 161.0 163.0 162.0 160.0 161.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:41.40 (55.2%) stddev-sans-first:43.33 05:31:28 INFO - PROCESS | 10274 | Values: 75.0 75.0 76.0 179.0 73.0 76.0 74.0 76.0 166.0 72.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:28.07 (30.5%) stddev-sans-first:28.96 05:31:28 INFO - PROCESS | 10274 | Values: 91.0 93.0 153.0 91.0 92.0 94.0 144.0 92.0 92.0 153.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:31:28 INFO - PROCESS | 10274 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:31:28 INFO - PROCESS | 10274 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:31:28 INFO - PROCESS | 10274 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.50 stddev:5.57 (10.2%) stddev-sans-first:5.82 05:31:28 INFO - PROCESS | 10274 | Values: 53.0 55.0 54.0 53.0 55.0 53.0 58.0 71.0 53.0 53.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 05:31:28 INFO - PROCESS | 10274 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 58.0 60.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:73.50 stddev:3.44 (4.7%) stddev-sans-first:3.52 05:31:28 INFO - PROCESS | 10274 | Values: 72.0 73.0 72.0 73.0 81.0 74.0 73.0 81.0 74.0 73.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:117.00 stddev:7.20 (6.2%) stddev-sans-first:7.61 05:31:28 INFO - PROCESS | 10274 | Values: 115.0 120.0 111.0 112.0 110.0 113.0 119.0 111.0 129.0 129.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 05:31:28 INFO - PROCESS | 10274 | Values: 154.0 155.0 159.0 154.0 159.0 158.0 155.0 153.0 154.0 155.0 05:31:28 INFO - PROCESS | 10274 | 05:31:28 INFO - PROCESS | 10274 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 05:31:28 INFO - PROCESS | 10274 | Values: 65.0 65.0 67.0 65.0 63.0 63.0 65.0 66.0 64.0 63.0 05:31:28 INFO - PROCESS | 10274 | -------- Summary: end -------- 05:31:28 INFO - PROCESS | 10274 | 05:31:29 INFO - TEST-INFO | 10274: exit 0 05:31:29 INFO - TEST-OK | kraken | took 59383ms 05:31:29 INFO - SUITE-END | took 1169s 05:31:30 INFO - Completed test suite (00:19:30) 05:31:30 INFO - javascript benchmark 05:31:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.670532946705, 3321.2693207494344, 3329.7835640683347, 3351.966480335196, 3366.32673465307, 5366.141417373216, 5371.167469042295, 5374.247605335251, 5388.649737767042, 5393.865153371158, 5353.464653534645, 5356.946430535693, 5399.460053994609, 5404.945950540494, 5407.324084489439, 4858.587020103296, 4872.999999999991, 4980.352554167953, 5012.774425150858, 5076.111680455924, 4966.553010229079, 4970.950290497103, 5023.673461225008, 5048.596112311025, 5051.368578927634, 5093.083245015896, 5095.159298715707, 5116.923246151311, 5123.820666276681, 5132.615053870956, 5110.514501122425, 5123.820666276662, 5129.358830146231, 5130.948690513084, 5149.304843846089, 4910.656254062217, 4921.532454416861, 4998.875028124289, 5040.344755181803, 5076.670016448919, 5382.730863456812, 5404.270423492818, 5414.377346605152, 5426.62013659044, 5444.265024221719, 5892.911606325909, 5897.351291357947, 5902.704864756745, 5907.350191478934, 5919.112133180014, 5679.858003549903, 5864.179014937912, 5908.793192238294, 5976.8505787355225, 5989.011813050842, 5495.203195536625, 5501.807436739695, 5501.889962200774, 5504.559635229132, 5504.80733174341, 5900.64596124234, 5931.614445061057, 5975.4323339283565, 5981.222441082631, 5988.401159883977, 5699.686517241592, 5753.88492230153, 5788.218590490314, 5789.305283366023, 5789.8263052108505, 5841.41585841421, 5860.619059761102, 5861.062230043258, 5868.618539794899, 5871.178035075093, 5720.628159169641, 5809.7095145242565, 5831.591788574844, 5832.24180856486, 5834.941650583524, 5838.824835254949, 5892.027815410409, 5897.882042359129, 5930.525557955353, 5931.555133365015, 4404.647628189737, 4429.2913133899065, 4434.933475997863, 4444.1333939881415, 4465.37484752135, 3992.041909941593, 4019.1559772448113, 4023.657989070903, 4029.15387768566, 4046.9392959105635, 5596.076647353141, 5619.719014049281, 5622.465865742748, 5627.6904770237215, 5645.491905728422, 5870.471657550841, 5871.3541510433815, 5871.647701137946, 5874.412558744177, 5877.206577112035, 5478.287822583039, 5602.747876345574, 5607.41122182165, 5608.242887210256, 5681.857953551194, 5047.192449208183, 5056.266841308064, 5064.518870707277, 5065.366829146356, 5078.492150784966, 6081.57428979976, 6099.3900609938655, 6111.938880611226, 6127.571070025056, 6137.140800287963, 5773.076307790733, 5900.852478687895, 5910.261217347917, 5989.670568118795, 5996.70016499182, 6110.572259941761, 6122.0, 6134.294556126102, 6134.478569321657, 6136.048912418582, 5778.8844223114465, 5790.363060063305, 5790.652560846194, 5791.0, 5791.82624521265, 5752.942470575241, 5869.706514674163, 5949.583529152917, 5965.403459654, 5970.104484327212, 5718.914216286676, 5724.4561766632105, 5746.195532625519, 5748.48263656273, 5755.482006619424, 5735.197072409949, 5751.798687045934, 5753.165790960204, 5753.482186603226, 5755.3381361144, 5451.155070964007, 5637.8590535236945, 5697.686627235376, 5703.429657034263, 5709.971450142889, 5754.136879468113, 5764.452377024344, 5776.508996735324, 5782.797602083907, 5790.710464476675, 5569.582281328998, 5603.831885043455, 5637.57718171147, 5649.54803615718, 5695.971520142372], "value": 5424.160238967717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.907913812928, 659.8944168932971, 668.7325069972007, 670.3028849996006, 671.0002096875654, 34167.658323416756, 40233.0, 40776.0, 40798.38802417962, 40870.59129408713, 44187.55812441875, 44738.7763061185, 44786.0, 44797.77601111998, 44847.77576112115, 8197.0, 8807.779805504882, 8968.417052891573, 8970.192682658559, 10404.323718958281, 10374.740631484236, 10480.0, 10488.056074953252, 10494.37033777972, 10497.37015779052, 10511.0, 10514.211434142431, 10553.0, 10577.471126443685, 10581.153507719364, 10457.738556536071, 10503.52734126966, 10514.316569422963, 10516.474176291193, 10522.105621022223, 10341.586336546528, 10449.268551201343, 10463.738406539822, 10788.244822862323, 10816.351018938889, 44103.117937641066, 44518.55481445177, 44598.33102503465, 44629.0, 44654.33018504693, 3969.861054863066, 3995.3407687731487, 4110.506739191316, 4149.419081328617, 4344.587264209895, 33653.32693346144, 33876.072601521315, 34016.48975265373, 34670.09314487702, 35697.0, 4471.374007638933, 4566.703164294344, 4576.54234576543, 4590.517995610447, 4599.31010348447, 338823.0, 341510.0, 341703.0, 342009.0, 342508.0, 39971.20057598832, 64250.0, 65242.67378663076, 65244.673776630814, 65284.0, 38199.090045497614, 38291.0, 38367.232655347296, 38410.231795363936, 38442.615573843905, 16616.916915415586, 16801.07594082337, 16820.57948551296, 16824.579385515215, 16827.495175144766, 13616.93191534036, 14423.134611923319, 14747.631309217355, 14751.63120921964, 14856.554303370916, 9232.261419086457, 9247.861282080774, 9249.768755781024, 9272.165505104438, 9301.860472092923, 3550.1302180965313, 3607.9278414431565, 3609.8375573098747, 3652.579953305351, 3653.378925582604, 1153.9192256542128, 1154.468944285638, 1188.7681902029021, 1190.8451901252781, 1285.2802430638872, 34450.483242751376, 34686.65313346834, 34802.47796283058, 35305.82347088299, 35483.290334193174, 1186.6262127429832, 1242.9502819887284, 1259.4206664934234, 1300.0964329790893, 1314.5859054397833, 17836.821631783518, 18354.724679129824, 18386.540336491427, 18460.35388761414, 18488.260469581335, 513658.0, 519048.0, 520511.0, 521935.0, 522747.0, 64025.67987160035, 64703.35296647067, 64783.67608162023, 64853.0, 64899.67550162219, 1381.109184575943, 1451.8402975672668, 1523.070926734691, 1561.7423125184444, 1562.1174036669472, 32396.514052288763, 34083.0, 34384.48423273603, 34685.47971780375, 34967.0, 53700.0, 53984.460155397945, 54253.72873135609, 54254.0, 54278.45721542892, 318257.0, 323186.0, 324220.0, 325624.0, 329905.0, 27726.168214953585, 30456.84771576128, 30779.84610076935, 31060.0, 31387.0, 47393.763031186005, 50208.748956256444, 50452.49547504478, 51423.742881285354, 52216.0, 41523.0, 41669.0, 41957.58042419537, 42150.36774448447, 42963.3555496674, 40392.79803600963, 40698.79650601728, 41192.24710363075, 41572.3764143532, 41782.0, 43107.568924310355, 43363.78318108389, 43660.78169609132, 43845.12309753851, 43914.0, 35539.11152221215, 36247.45628815622, 37118.44322335113, 37836.0, 37847.43228851625, 29022.709772902002, 29104.7089529102, 29156.7084329154, 29502.0, 29589.0], "value": 20118.39350818226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.38267438203025, 425.31099618617844, 425.4299239019713, 425.44904348868215, 431.73448329277494, 19056.90471547642, 19457.805421945795, 19496.122674479648, 19661.606767864636, 20223.59552808943, 19627.411177664657, 20131.29540466084, 20154.496137596532, 20210.19159233629, 20253.189872405124, 5397.568194544427, 5706.315242170946, 5716.542676585863, 5870.0, 5939.346671866091, 4038.919221615566, 5690.118031705092, 5862.912056319158, 5863.912041319383, 5961.195238642771, 5952.434518720715, 5988.041913293852, 5991.400859913995, 5995.61028533144, 5999.880002399949, 5940.88118237635, 6065.7573697052285, 6311.400416960381, 6476.158099447089, 6529.1512103426485, 3965.960340396588, 5617.775288988436, 5811.6803575803315, 5838.766449342063, 5856.736446859902, 13566.59300220995, 13998.790018149735, 14015.509457169052, 14051.367688453942, 14133.717325653532, 2516.8993240270365, 2553.0553695132735, 3043.5148389906385, 3080.091373044957, 3183.649798522161, 10341.896581034169, 10475.79048419035, 10497.737556561071, 10617.362958222455, 13853.584392468241, 2015.2543558883308, 2018.697195420684, 2046.2940285601444, 2087.0608226298073, 2165.4802847316687, 80861.59569202116, 84422.57788711079, 84431.57784211039, 85016.14983850144, 87152.12847871504, 11084.279521831055, 11422.828657570142, 11650.475728592233, 11673.649790506299, 11844.28934263947, 16718.665626687398, 16813.075280859426, 16839.242234099496, 16877.32490700358, 16892.15539223034, 9030.32272579546, 9071.183593476619, 9156.450612963243, 9175.357724959322, 9211.447313161098, 8790.373780850563, 8939.642414303355, 8946.926368835651, 9065.68270110543, 9098.681546145854, 5037.974810125926, 5050.141475949097, 5125.1287281162295, 5126.128558145124, 5152.510511501401, 1825.8907540105467, 1973.7730161031666, 2054.209129485159, 2070.3478404302596, 2133.2746866065613, 1021.5045702834119, 1069.417167643636, 1110.2616759854607, 1114.420501339299, 1140.6749076513154, 18606.627867442574, 19376.2249510018, 19541.902290488742, 19684.409467715992, 19694.31069912546, 1068.7114479090758, 1096.221682605359, 1107.4739498738195, 1155.7341811383428, 1158.8435561199299, 11048.226624136394, 11084.445777711082, 11100.11199104086, 11117.72205694848, 11119.44402779874, 375989.0, 377238.0, 377888.0, 379893.0, 538579.0, 90043.54978225067, 93320.53339733394, 93558.0, 93611.53194233985, 94635.52682236544, 1113.5935383585095, 1130.496928866663, 1139.2139423797553, 1166.084623570493, 1173.9706507337385, 17508.0, 17877.73183402276, 17879.19543620514, 17897.19462624211, 18344.082795859886, 36452.27095458023, 36983.445248321834, 37214.06964825793, 38247.42628860625, 40096.39855402113, 47884.0, 49303.0, 49819.25271120864, 50065.0, 50539.0, 8394.790130246793, 8453.196946290092, 8460.111688272642, 8491.108433614381, 8650.307975362082, 9951.0, 13480.258585777876, 13734.725305494034, 13762.311884405939, 13785.655358616115, 12096.0, 12118.939405302917, 12199.451024704087, 12306.692332691755, 12365.629031129081, 11526.88473115258, 11572.94213528927, 11893.108016898941, 11944.64166075019, 12043.698907527381, 12228.0, 12264.632061038183, 12361.62915112548, 12362.567310144103, 13047.478100875858, 8206.0, 8424.241818236143, 8937.06160853101, 9020.05289444599, 9080.137386948229, 11402.429878505876, 12076.577319793765, 12242.938785306373, 12303.200291980993, 12457.937710311391], "value": 9403.118688213239, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.9926850365746, 1549.2099029494957, 1579.5103517909452, 1758.6922288599492, 1895.5166432559695, 8086.878696819553, 8165.0, 8189.0, 8265.54539500328, 8270.172982701726, 8061.113277539466, 8159.959200203991, 8217.876731849026, 8227.17728227177, 8229.259366657, 2117.4600476878372, 2360.114956891166, 2369.763023697634, 2391.9162829300976, 2411.071737381112, 2444.535538247736, 2444.6577479152934, 2453.288546321565, 2453.6932883389577, 2456.778889899909, 2322.1756276521846, 2375.4180225844693, 2388.5103553771437, 2393.7127544694663, 2398.4843258699375, 2121.840861935353, 2393.3418309964727, 2436.50051739393, 2436.9878150609134, 2441.56051910656, 2323.500447403799, 2350.17743789674, 2350.21267875262, 2360.138549429463, 2383.833131680783, 8198.303144232746, 8260.628271727786, 8277.296429803473, 8278.089410164877, 8311.916880831235, 5121.897562048738, 5179.896402071975, 5214.322138122057, 5215.243789650517, 5316.6544174628525, 3418.1454636340914, 3453.827308634558, 3518.0677120562814, 3527.5414196154593, 3593.0, 1182.6274723462082, 1206.7586482703493, 1208.6072026591394, 1212.563477148226, 1214.7570485902854, 11800.468978895884, 11832.585859494877, 11858.40707964607, 11862.0, 11863.52545898163, 4489.0, 4503.639708823286, 4634.513376095529, 4655.045715628288, 4664.556867097688, 9905.306628536078, 9915.702528924145, 9932.851007234898, 9940.552675129637, 9949.452780097019, 4752.477227504972, 5312.946870531246, 5324.840254792362, 5329.333833270841, 5330.893382132335, 4812.975935120372, 4825.396825396825, 4868.099401610642, 4896.6572339935865, 4909.0672772173175, 4067.186562687474, 4077.531083925327, 4142.979285103555, 4283.293256612624, 4287.614114729689, 1311.2919023727272, 1375.0374737683662, 1384.6538365408649, 1393.6306878677158, 1400.509821562445, 967.1440774914252, 1094.8905109488987, 1099.9419778127117, 1114.9777004459866, 1143.3082984794246, 6065.727042283108, 6157.784477543264, 6191.81424557264, 6202.100695399142, 6272.937270627326, 450.2008934141924, 472.3269341188792, 472.8652334084769, 479.9208130658472, 481.069131231069, 4250.447441832542, 4259.510156332061, 4286.099919016979, 4295.72077814941, 4296.2266791977745, 10118.848217276747, 10378.0, 10517.211209159344, 10521.368717876952, 10565.049145576935, 10270.281080324306, 10277.486125693686, 10288.434136122585, 10290.742731431774, 10334.741631459123, 8088.352931765445, 8148.307393871587, 8153.95923020393, 8162.510249385056, 8163.632636531371, 5900.675462849585, 5941.940580594139, 5942.910856337245, 5975.581709280309, 6188.876222475616, 8890.244329232088, 8924.598393072198, 8950.015498295312, 9149.405288656217, 9158.67944621935, 9019.278457723498, 9091.045440228945, 9233.538323083685, 9234.538273086453, 9236.030216827405, 7252.456065795192, 7324.63376831167, 7390.630468476447, 7414.480986331121, 7490.438217133627, 7917.366610671017, 7964.323032542299, 7972.720954766555, 8003.0, 8017.679292828221, 6809.250982392032, 7105.538140020882, 7146.0, 7147.428205743632, 7259.854802903807, 6911.7926462206215, 6975.128108986377, 7072.823179420556, 7073.0097786308925, 7212.963935180501, 6698.933010670026, 6879.7248110077035, 6883.346082122191, 6891.75878844238, 6916.066331045245, 5060.2156665716875, 5119.87200319995, 5171.612129090408, 5203.219517072469, 5245.632805703564, 5123.87190320245, 5131.435542090292, 5171.534561889448, 5189.818356357509, 5313.814016509404], "value": 4516.90998399975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.67164507137943, 331.9668033196681, 337.84459148791564, 340.44677399226254, 349.64336376895585, 6124.5406594505475, 6179.258488981323, 6245.125682404456, 6257.186565746458, 6260.561760676749, 6206.968965155179, 6235.469985051276, 6262.812115636538, 6318.652474113922, 6342.556021078526, 4787.1622466068475, 4799.352087468182, 4801.303810947411, 4803.231482962727, 4810.591099756525, 4569.565891240343, 4624.514425985273, 4726.976365118169, 4801.975990120062, 4807.975960120195, 4705.623550116, 4717.716936983792, 4719.174144524712, 4726.66913316068, 4733.763311834395, 4698.600618947394, 4719.834805781781, 4720.55154760299, 4728.030753695484, 4738.4550776660435, 4110.815013324408, 4124.1133156371225, 4127.731697439687, 4131.814068366931, 4135.6898232632675, 6036.758529658809, 6055.545834062463, 6063.969680151571, 6070.605410648293, 6087.2086628738425, 5299.4435584263865, 5491.395946445888, 5492.505674489275, 5497.103499292738, 5515.779368825242, 6602.504812139109, 6618.503612229054, 6621.569597976116, 6632.966835165793, 6643.833904152387, 4509.842155524541, 4510.729356238636, 4521.1409832131785, 4522.7060241084555, 4524.29873369625, 6856.41720453762, 6928.307169283082, 6934.4452443804375, 6939.306069393071, 6950.061741664861, 4535.387722657399, 4539.659525535598, 4541.43232095988, 4542.432195975503, 4543.886402839889, 4595.977020114878, 4596.632269418438, 4601.700889442175, 4605.240135377625, 4605.562471565196, 5248.921266181011, 5440.972795135999, 5442.265294185314, 5448.210009548593, 5459.2902922619805, 6608.372204640552, 6646.202455705346, 6659.700313485905, 6662.067310576524, 6666.933330666631, 1552.5808031831343, 1576.282791329942, 1624.7969003874516, 1628.9818863210494, 1630.1115891838976, 1043.1081425381342, 1050.5482642463814, 1054.8628678271775, 1066.2802608239563, 1067.658349328223, 6401.0, 6409.391107844747, 6452.354764523604, 6469.320721324288, 6469.547131700736, 6809.897851532231, 6811.897821532681, 6818.829529261709, 6831.385175334144, 6838.48711346651, 6441.774537891151, 6462.192225971754, 6466.708998095097, 6469.385408386196, 6476.31998640136, 3628.963710362915, 3659.9817000914827, 3671.632836716307, 3673.2837096766407, 3676.0442285005556, 6936.722531098801, 7038.577685338896, 7103.254158313406, 7109.75115870942, 7138.393236574845, 6938.202106757686, 6951.443884489228, 6952.505211379577, 6968.442524598121, 6977.51157418986, 7061.0, 7067.187273463617, 7083.681234344467, 7084.92915070853, 7140.999999999896, 6786.253512113565, 6803.795886123424, 6807.5575087619145, 6810.693518791765, 6824.522283440111, 6605.438537724155, 6702.530822842355, 6844.5208835381045, 6844.726210951705, 6862.107925969792, 7195.640217989185, 7218.0, 7218.242084581043, 7233.240509746401, 7233.710651573878, 4588.88527786808, 4636.744979026186, 4639.30410438437, 4640.535946405467, 4643.326717625993, 6574.112494813139, 6680.732770689118, 6929.064576282339, 6971.233164352018, 6974.37230649244, 6676.532642714963, 6680.532362734756, 6682.0, 6683.532152749455, 6685.09751183584, 6669.433098186709, 6676.0, 6689.565178263398, 6691.899621505779, 6697.732090716511, 6574.868502629825, 6575.145231120116, 6580.309067547839, 6583.44040756541, 6596.241432235354, 6556.311587283267, 6696.866062678621, 6701.32986701326, 6706.932930670826, 6734.259231484435, 6540.901886471802, 6543.738250469928, 6567.146270984933, 6568.080468734285, 6573.57271777333], "value": 4970.455153362051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.5632183908046, 907.9273658107352, 916.9816603667927, 930.4882314726899, 960.5149399553225, 14101.858981410183, 14274.143551386898, 14322.713545729079, 14473.565793026213, 14491.202983835898, 13105.410256538455, 14195.645108872257, 14201.076929999543, 14203.78694319586, 14221.217833019206, 773.8374941262342, 898.2454738020078, 898.4025622960723, 907.0476000199797, 913.7487191022456, 910.2490445382552, 922.2667978956712, 922.4972390047441, 922.7093465558361, 922.898481167071, 962.6534447598859, 968.2157452463528, 968.3802366485455, 968.5205823117532, 969.321474967522, 807.995960020199, 934.2712684106408, 953.7186529973606, 961.1733908838394, 961.725908116187, 702.0697575712151, 707.1302298173275, 707.9185893622248, 708.2987842036398, 709.2411120101493, 14133.575992720234, 14154.0, 14190.50333238342, 14197.645058873612, 14209.644758881008, 14959.476418325306, 15250.161241131733, 15330.463433779763, 15340.693186136326, 15416.152111633855, 12416.441260143316, 12439.875601244054, 12447.813282800766, 12488.50045998159, 12674.619761407173, 4050.129222217208, 4077.6533994610195, 4117.094239267356, 4126.360414135814, 4209.010882442623, 59097.99999999957, 59319.40680593182, 59461.0, 59585.40414595842, 59681.40318596802, 11928.403579820973, 11980.0, 12020.655972085535, 12067.517299308105, 12286.906417643659, 21617.24339648136, 21764.673529897063, 21810.781892181192, 21837.126514939224, 21866.344009679735, 8513.574321283912, 8809.515476648718, 8812.691555795516, 8873.334499912533, 9099.908011038586, 5091.439941606421, 5155.948440515622, 5156.097682905476, 5161.2516185152945, 5219.973900130551, 3713.7400381973544, 3759.9436008459893, 3766.1902690921584, 3772.1701225730294, 3778.3765678663262, 658.3811217455576, 660.425429876011, 662.5130529061137, 665.8701553197177, 689.290031267795, 665.7902760630483, 712.0316369737153, 750.2534977697226, 815.4454970620035, 828.0684230240979, 9149.862752058725, 9327.0, 9364.95317523408, 9707.174890134418, 9765.853512197322, 657.4346062386344, 660.4122331125302, 723.1755798389839, 755.5919803306263, 798.876174193001, 4340.348947657877, 4361.9127617447475, 4423.5576442355505, 4542.432195975503, 4698.506656800987, 72383.63808180926, 73180.0, 74573.0, 76082.23917760863, 76174.0, 60614.0, 60686.69656651688, 61113.69443152756, 62102.68948655318, 63597.0, 56190.0, 56431.15353269704, 57259.427405726245, 57591.712041439525, 58073.128903066485, 10085.345959495415, 10117.544710487899, 10211.776911029745, 10248.590056397661, 10259.640912568024, 39142.608573913894, 39788.403173953, 40352.0, 41246.793766030976, 42343.36484952667, 48600.78498037436, 49304.26043609277, 49642.25536617026, 49691.254631181284, 50274.245886311, 12650.0, 12715.491380345053, 12748.171368860994, 13004.154729942524, 13058.0, 13722.862771372158, 14089.577312680636, 14276.0, 14434.133951962916, 14620.634484137556, 10866.293690910066, 13211.801822972471, 13337.599872003855, 13395.732085358433, 13520.18878867271, 13498.0, 13668.52160174389, 13727.0, 13825.446982120602, 13962.371693273624, 13196.60410187696, 13283.933580332037, 13635.045546811629, 13696.246706430844, 13708.0, 11102.2783519071, 11238.606648767254, 11301.491432885376, 11696.70758231051, 12023.0, 11317.773644527228, 11449.0, 11704.017082077773, 11756.118291128028, 11773.17587768848], "value": 7322.19433864929, "unit": "score"}], "name": "dromaeo_css", "value": 7433.376236880542, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 108.0, 109.0, 109.0, 109.0, 103.0, 111.0, 109.0, 111.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 126.0, 155.0, 176.0, 133.0, 156.0, 158.0, 129.0, 209.0, 125.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 161.0, 161.0, 163.0, 162.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 179.0, 73.0, 76.0, 74.0, 76.0, 166.0, 72.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 153.0, 91.0, 92.0, 94.0, 144.0, 92.0, 92.0, 153.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "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, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 55.0, 53.0, 58.0, 71.0, 53.0, 53.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 81.0, 74.0, 73.0, 81.0, 74.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 111.0, 112.0, 110.0, 113.0, 119.0, 111.0, 129.0, 129.0], "value": 116.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 159.0, 154.0, 159.0, 158.0, 155.0, 153.0, 154.0, 155.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 63.0, 63.0, 65.0, 66.0, 64.0, 63.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1510.5999999999997, "alertThreshold": 2.0}]} 05:31:30 INFO - Return code: 0 05:31:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:30 ERROR - # TBPL SUCCESS # 05:31:30 INFO - Running post-action listener: _resource_record_post_action 05:31:30 INFO - Running post-run listener: _resource_record_post_run 05:31:31 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 262144; Write bytes: 391958528; Read time: 20; Write time: 273516 05:31:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117817344; Read time: 0; Write time: 108856 05:31:31 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252809216; Read time: 20; Write time: 143016 05:31:31 INFO - Running post-run listener: _upload_blobber_files 05:31:31 INFO - Blob upload gear active. 05:31:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:31 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 05:31:31 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'] 05:31:31 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 05:31:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:32 INFO - (blobuploader) - INFO - Done attempting. 05:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:33 INFO - (blobuploader) - INFO - Done attempting. 05:31:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:33 INFO - Return code: 0 05:31:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93e569cd51e5360ef651cedcc33d53879657d6d52a1df1cafcbc6a869df03c54d07f5a4b2c1bff4a158a06e448fe23db4afda1cb266a29f1acd12a6cb4ee42f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be642fb844f90d9b7c9d92fd3babdec20eea03e5da1630a34d3d7dcbe358fedadda642ea1549ac27c32963fa8fcca99100687d056d1f70817471307dfa39ec8"} 05:31:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:33 INFO - Contents: 05:31:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93e569cd51e5360ef651cedcc33d53879657d6d52a1df1cafcbc6a869df03c54d07f5a4b2c1bff4a158a06e448fe23db4afda1cb266a29f1acd12a6cb4ee42f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be642fb844f90d9b7c9d92fd3babdec20eea03e5da1630a34d3d7dcbe358fedadda642ea1549ac27c32963fa8fcca99100687d056d1f70817471307dfa39ec8"} 05:31:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:33 INFO - Copying logs to upload dir... 05:31:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.556002 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-01 05:31:33.670797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:33.674111) ========= 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=826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828 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/93e569cd51e5360ef651cedcc33d53879657d6d52a1df1cafcbc6a869df03c54d07f5a4b2c1bff4a158a06e448fe23db4afda1cb266a29f1acd12a6cb4ee42f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be642fb844f90d9b7c9d92fd3babdec20eea03e5da1630a34d3d7dcbe358fedadda642ea1549ac27c32963fa8fcca99100687d056d1f70817471307dfa39ec8"} build_url:https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/ERN1Yn6ITHyyQBFQTaiReg/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/93e569cd51e5360ef651cedcc33d53879657d6d52a1df1cafcbc6a869df03c54d07f5a4b2c1bff4a158a06e448fe23db4afda1cb266a29f1acd12a6cb4ee42f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be642fb844f90d9b7c9d92fd3babdec20eea03e5da1630a34d3d7dcbe358fedadda642ea1549ac27c32963fa8fcca99100687d056d1f70817471307dfa39ec8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:33.700784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:33.701121) ========= 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=826874ccc97bd7bf541b4875000001d5-1464783057.5677-60599828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 05:31:33.954262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 05:31:33.954937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 05:31:33.955291) ========= ========= Total master_lag: 0.34 =========