builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1462967341.94 results: success (0) buildid: 20160511015516 builduid: 9cb641f9b87a4c24ad6e1f8c7a9f94e2 revision: 78248731d23f9b774ce650c67e6f0ebcb73cdbdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:01.937327) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:01.937764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:01.938033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:01.954860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:01.955126) ========= 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=00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 04:49:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-05-11 04:49:02 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:02.055014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:02.055322) ========= 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=00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019685 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:02.107881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:02.108220) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 78248731d23f9b774ce650c67e6f0ebcb73cdbdd --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 78248731d23f9b774ce650c67e6f0ebcb73cdbdd --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=00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 04:49:02,205 truncating revision to first 12 chars 2016-05-11 04:49:02,205 Setting DEBUG logging. 2016-05-11 04:49:02,205 attempt 1/10 2016-05-11 04:49:02,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/78248731d23f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 04:49:02,514 unpacking tar archive at: mozilla-aurora-78248731d23f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899622 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:03.022672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:03.023083) ========= script_repo_revision: 78248731d23f9b774ce650c67e6f0ebcb73cdbdd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:03.023539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:03.023842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:49:03.034014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-11 04:49:03.034335) ========= /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=00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:03 INFO - MultiFileLogger online at 20160511 04:49:03 in /builds/slave/test 04:49:03 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 04:49:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:03 INFO - {'append_to_log': False, 04:49:03 INFO - 'base_work_dir': '/builds/slave/test', 04:49:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:49:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:03 INFO - 'branch': 'Mozilla-Aurora', 04:49:03 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:03 INFO - 'config_files': ('talos/linux_config.py',), 04:49:03 INFO - 'default_actions': ('clobber', 04:49:03 INFO - 'read-buildbot-config', 04:49:03 INFO - 'download-and-extract', 04:49:03 INFO - 'populate-webroot', 04:49:03 INFO - 'create-virtualenv', 04:49:03 INFO - 'install', 04:49:03 INFO - 'run-tests'), 04:49:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:03 INFO - 'download_minidump_stackwalk': True, 04:49:03 INFO - 'download_symbols': 'ondemand', 04:49:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:03 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:03 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:03 INFO - 'installer_path': 'installer.exe', 04:49:03 INFO - 'log_level': 'info', 04:49:03 INFO - 'log_name': 'talos', 04:49:03 INFO - 'log_to_console': True, 04:49:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:03 INFO - 'opt_config_files': (), 04:49:03 INFO - 'pip_index': False, 04:49:03 INFO - 'sps_profile': False, 04:49:03 INFO - 'sps_profile_interval': 0, 04:49:03 INFO - 'suite': 'dromaeojs', 04:49:03 INFO - 'system_bits': '32', 04:49:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:03 INFO - 'title': 'talos-linux64-ix-016', 04:49:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:03 INFO - 'use_talos_json': True, 04:49:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:03 INFO - 'work_dir': 'build'} 04:49:03 INFO - ##### 04:49:03 INFO - ##### Running clobber step. 04:49:03 INFO - ##### 04:49:03 INFO - Running pre-action listener: _resource_record_pre_action 04:49:03 INFO - Running main action method: clobber 04:49:03 INFO - rmtree: /builds/slave/test/build 04:49:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:03 INFO - Running post-action listener: _resource_record_post_action 04:49:03 INFO - ##### 04:49:03 INFO - ##### Running read-buildbot-config step. 04:49:03 INFO - ##### 04:49:03 INFO - Running pre-action listener: _resource_record_pre_action 04:49:03 INFO - Running main action method: read_buildbot_config 04:49:03 INFO - Using buildbot properties: 04:49:03 INFO - { 04:49:03 INFO - "project": "", 04:49:03 INFO - "product": "firefox", 04:49:03 INFO - "script_repo_revision": "production", 04:49:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:49:03 INFO - "repository": "", 04:49:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:49:03 INFO - "buildid": "20160511015516", 04:49:03 INFO - "pgo_build": "True", 04:49:03 INFO - "basedir": "/builds/slave/test", 04:49:03 INFO - "buildnumber": 323, 04:49:03 INFO - "slavename": "talos-linux64-ix-016", 04:49:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:49:03 INFO - "platform": "ubuntu64_hw", 04:49:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:49:03 INFO - "branch": "mozilla-aurora", 04:49:03 INFO - "repo_path": "releases/mozilla-aurora", 04:49:03 INFO - "revision": "78248731d23f9b774ce650c67e6f0ebcb73cdbdd", 04:49:03 INFO - "stage_platform": "linux64-pgo", 04:49:03 INFO - "builduid": "9cb641f9b87a4c24ad6e1f8c7a9f94e2", 04:49:03 INFO - "slavebuilddir": "test" 04:49:03 INFO - } 04:49:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:49:03 INFO - Running post-action listener: _resource_record_post_action 04:49:03 INFO - ##### 04:49:03 INFO - ##### Running download-and-extract step. 04:49:03 INFO - ##### 04:49:03 INFO - Running pre-action listener: _resource_record_pre_action 04:49:03 INFO - Running main action method: download_and_extract 04:49:03 INFO - mkdir: /builds/slave/test/build/tests 04:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:03 INFO - https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:04 INFO - Downloaded 1361 bytes. 04:49:04 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:49:04 INFO - Using the following test package requirements: 04:49:04 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:49:04 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:49:04 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:49:04 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'jsshell-linux-x86_64.zip'], 04:49:04 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:49:04 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:49:04 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:49:04 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:49:04 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:49:04 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:04 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:49:04 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:04 INFO - https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:05 INFO - Downloaded 23799751 bytes. 04:49:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:49:06 INFO - Return code: 0 04:49:06 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 04:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:06 INFO - https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:49:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:49:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:08 INFO - Downloaded 23799751 bytes. 04:49:08 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'] 04:49:08 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 04:49:09 INFO - Return code: 0 04:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:09 INFO - https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:49:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:49:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:49:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:10 INFO - Downloaded 10840145 bytes. 04:49:10 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'] 04:49:10 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 04:49:10 INFO - Return code: 0 04:49: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')]} 04:49:10 INFO - https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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 04:49:12 INFO - Downloaded 62692724 bytes. 04:49:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:49:12 INFO - mkdir: /builds/slave/test/properties 04:49:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:12 INFO - Contents: 04:49:12 INFO - build_url:https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:49:12 INFO - Running post-action listener: _resource_record_post_action 04:49:12 INFO - Running post-action listener: set_extra_try_arguments 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running populate-webroot step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: populate_webroot 04:49:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:12 INFO - '--tppagecycles', 04:49:12 INFO - '7'], 04:49:12 INFO - 'tests': ['tsvgm']}}, 04:49:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['damp', 'tps']}, 04:49:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'tests': ['damp', 'tps']}, 04:49:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['dromaeo_dom']}, 04:49:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore', 04:49:12 INFO - 'tabpaint']}, 04:49:12 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore', 04:49:12 INFO - 'tabpaint']}, 04:49:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore', 04:49:12 INFO - 'tabpaint']}, 04:49:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore', 04:49:12 INFO - 'tabpaint']}, 04:49:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore', 04:49:12 INFO - 'tabpaint']}, 04:49:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['a11yr', 04:49:12 INFO - 'ts_paint', 04:49:12 INFO - 'tpaint', 04:49:12 INFO - 'sessionrestore', 04:49:12 INFO - 'sessionrestore_no_auto_restore', 04:49:12 INFO - 'tabpaint']}, 04:49:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['tsvgx', 04:49:12 INFO - 'tsvgr_opacity', 04:49:12 INFO - 'tart', 04:49:12 INFO - 'tscrollx', 04:49:12 INFO - 'cart']}, 04:49:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:12 INFO - 'tsvgr_opacity', 04:49:12 INFO - 'tart', 04:49:12 INFO - 'tscrollx', 04:49:12 INFO - 'cart']}, 04:49:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--disable-e10s'], 04:49:12 INFO - 'tests': ['tp5o']}, 04:49:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'tests': ['tp5o']}, 04:49:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--disable-e10s', 04:49:12 INFO - '--xperf_path', 04:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:12 INFO - 'tests': ['tp5n']}, 04:49:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:12 INFO - 'talos_options': ['--xperf_path', 04:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:12 INFO - 'tests': ['tp5n']}}, 04:49:12 INFO - 'talos.zip': {'path': '', 04:49:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:12 INFO - Running post-action listener: _resource_record_post_action 04:49:12 INFO - ##### 04:49:12 INFO - ##### Running create-virtualenv step. 04:49:12 INFO - ##### 04:49:12 INFO - Running pre-action listener: _resource_record_pre_action 04:49:12 INFO - Running main action method: create_virtualenv 04:49:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:12 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 04:49:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:12 INFO - Using real prefix '/usr' 04:49:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:15 INFO - Installing pip.................done. 04:49:15 INFO - Return code: 0 04:49:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:15 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')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 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')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:15 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 04:49:15 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 04:49:15 INFO - Using env: {'DISPLAY': ':0', 04:49:15 INFO - 'HOME': '/home/cltbld', 04:49:15 INFO - 'LANG': 'en_US.UTF-8', 04:49:15 INFO - 'LANGUAGE': 'en_US:en', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MAIL': '/var/mail/cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:15 INFO - 'NO_EM_RESTART': '1', 04:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:15 INFO - 'PWD': '/builds/slave/test', 04:49:15 INFO - 'SHELL': '/bin/bash', 04:49:15 INFO - 'SHLVL': '1', 04:49:15 INFO - 'TERM': 'linux', 04:49:15 INFO - 'TMOUT': '86400', 04:49:15 INFO - 'USER': 'cltbld', 04:49:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:15 INFO - '_': '/tools/buildbot/bin/python'} 04:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:15 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 04:49:15 INFO - Cleaning up... 04:49:15 INFO - Return code: 0 04:49:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:49:15 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')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 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')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:15 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 04:49:15 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 04:49:15 INFO - Using env: {'DISPLAY': ':0', 04:49:15 INFO - 'HOME': '/home/cltbld', 04:49:15 INFO - 'LANG': 'en_US.UTF-8', 04:49:15 INFO - 'LANGUAGE': 'en_US:en', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MAIL': '/var/mail/cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:15 INFO - 'NO_EM_RESTART': '1', 04:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:15 INFO - 'PWD': '/builds/slave/test', 04:49:15 INFO - 'SHELL': '/bin/bash', 04:49:15 INFO - 'SHLVL': '1', 04:49:15 INFO - 'TERM': 'linux', 04:49:15 INFO - 'TMOUT': '86400', 04:49:15 INFO - 'USER': 'cltbld', 04:49:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:15 INFO - '_': '/tools/buildbot/bin/python'} 04:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:15 INFO - Downloading/unpacking psutil>=0.7.1 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:17 INFO - Installing collected packages: psutil 04:49:17 INFO - Running setup.py install for psutil 04:49:18 INFO - building 'psutil._psutil_linux' extension 04:49:18 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 04:49:18 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 04:49:18 INFO - building 'psutil._psutil_posix' extension 04:49:18 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 04:49:18 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 04:49:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:18 INFO - Successfully installed psutil 04:49:18 INFO - Cleaning up... 04:49:18 INFO - Return code: 0 04:49:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:49:18 INFO - Using env: {'DISPLAY': ':0', 04:49:18 INFO - 'HOME': '/home/cltbld', 04:49:18 INFO - 'LANG': 'en_US.UTF-8', 04:49:18 INFO - 'LANGUAGE': 'en_US:en', 04:49:18 INFO - 'LOGNAME': 'cltbld', 04:49:18 INFO - 'MAIL': '/var/mail/cltbld', 04:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:18 INFO - 'MOZ_NO_REMOTE': '1', 04:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:18 INFO - 'NO_EM_RESTART': '1', 04:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:18 INFO - 'PWD': '/builds/slave/test', 04:49:18 INFO - 'SHELL': '/bin/bash', 04:49:18 INFO - 'SHLVL': '1', 04:49:18 INFO - 'TERM': 'linux', 04:49:18 INFO - 'TMOUT': '86400', 04:49:18 INFO - 'USER': 'cltbld', 04:49:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:18 INFO - '_': '/tools/buildbot/bin/python'} 04:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:49:20 INFO - Installing collected packages: mozsystemmonitor 04:49:20 INFO - Running setup.py install for mozsystemmonitor 04:49:20 INFO - Successfully installed mozsystemmonitor 04:49:20 INFO - Cleaning up... 04:49:20 INFO - Return code: 0 04:49:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', '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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49: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 blobuploader==1.2.4 04:49:20 INFO - Using env: {'DISPLAY': ':0', 04:49:20 INFO - 'HOME': '/home/cltbld', 04:49:20 INFO - 'LANG': 'en_US.UTF-8', 04:49:20 INFO - 'LANGUAGE': 'en_US:en', 04:49:20 INFO - 'LOGNAME': 'cltbld', 04:49:20 INFO - 'MAIL': '/var/mail/cltbld', 04:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:20 INFO - 'MOZ_NO_REMOTE': '1', 04:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:20 INFO - 'NO_EM_RESTART': '1', 04:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:20 INFO - 'PWD': '/builds/slave/test', 04:49:20 INFO - 'SHELL': '/bin/bash', 04:49:20 INFO - 'SHLVL': '1', 04:49:20 INFO - 'TERM': 'linux', 04:49:20 INFO - 'TMOUT': '86400', 04:49:20 INFO - 'USER': 'cltbld', 04:49:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:20 INFO - '_': '/tools/buildbot/bin/python'} 04:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:23 INFO - Downloading docopt-0.6.1.tar.gz 04:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:23 INFO - Running setup.py install for blobuploader 04:49:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:23 INFO - Running setup.py install for requests 04:49:24 INFO - Running setup.py install for docopt 04:49:24 INFO - Successfully installed blobuploader requests docopt 04:49:24 INFO - Cleaning up... 04:49:24 INFO - Return code: 0 04:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:24 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')]} 04:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:24 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')]} 04:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:24 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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:24 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 04:49:24 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 04:49:24 INFO - Using env: {'DISPLAY': ':0', 04:49:24 INFO - 'HOME': '/home/cltbld', 04:49:24 INFO - 'LANG': 'en_US.UTF-8', 04:49:24 INFO - 'LANGUAGE': 'en_US:en', 04:49:24 INFO - 'LOGNAME': 'cltbld', 04:49:24 INFO - 'MAIL': '/var/mail/cltbld', 04:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:24 INFO - 'MOZ_NO_REMOTE': '1', 04:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:24 INFO - 'NO_EM_RESTART': '1', 04:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:24 INFO - 'PWD': '/builds/slave/test', 04:49:24 INFO - 'SHELL': '/bin/bash', 04:49:24 INFO - 'SHLVL': '1', 04:49:24 INFO - 'TERM': 'linux', 04:49:24 INFO - 'TMOUT': '86400', 04:49:24 INFO - 'USER': 'cltbld', 04:49:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:24 INFO - '_': '/tools/buildbot/bin/python'} 04:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:24 INFO - Running setup.py (path:/tmp/pip-Mt_Qz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:24 INFO - Running setup.py (path:/tmp/pip-KAARMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:24 INFO - Running setup.py (path:/tmp/pip-0G4e8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:24 INFO - Running setup.py (path:/tmp/pip-jktFUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:24 INFO - Running setup.py (path:/tmp/pip-OQRs5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:24 INFO - Running setup.py (path:/tmp/pip-3e2r6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:24 INFO - Running setup.py (path:/tmp/pip-TxygDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:24 INFO - Running setup.py (path:/tmp/pip-hRG7qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:25 INFO - Running setup.py (path:/tmp/pip-_QlXTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:25 INFO - Running setup.py (path:/tmp/pip-3ybjtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:25 INFO - Running setup.py (path:/tmp/pip-DodICa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:25 INFO - Running setup.py (path:/tmp/pip-sYaKeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:25 INFO - Running setup.py (path:/tmp/pip-kNhtD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:25 INFO - Running setup.py (path:/tmp/pip-eWOCwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:25 INFO - Running setup.py (path:/tmp/pip-AgOLch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:25 INFO - Running setup.py (path:/tmp/pip-bJcLkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:25 INFO - Running setup.py (path:/tmp/pip-Yutw4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:25 INFO - Running setup.py install for manifestparser 04:49:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Running setup.py install for mozcrash 04:49:25 INFO - Running setup.py install for mozdebug 04:49:25 INFO - Running setup.py install for mozdevice 04:49:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozfile 04:49:26 INFO - Running setup.py install for mozhttpd 04:49:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozinfo 04:49:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozInstall 04:49:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozleak 04:49:26 INFO - Running setup.py install for mozlog 04:49:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for moznetwork 04:49:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozprocess 04:49:26 INFO - Running setup.py install for mozprofile 04:49:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:27 INFO - Running setup.py install for mozrunner 04:49:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:27 INFO - Running setup.py install for mozscreenshot 04:49:27 INFO - Running setup.py install for moztest 04:49:27 INFO - Running setup.py install for mozversion 04:49:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:27 INFO - Cleaning up... 04:49:27 INFO - Return code: 0 04:49:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:27 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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:27 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 04:49:27 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 04:49:27 INFO - Using env: {'DISPLAY': ':0', 04:49:27 INFO - 'HOME': '/home/cltbld', 04:49:27 INFO - 'LANG': 'en_US.UTF-8', 04:49:27 INFO - 'LANGUAGE': 'en_US:en', 04:49:27 INFO - 'LOGNAME': 'cltbld', 04:49:27 INFO - 'MAIL': '/var/mail/cltbld', 04:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:27 INFO - 'MOZ_NO_REMOTE': '1', 04:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:27 INFO - 'NO_EM_RESTART': '1', 04:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:27 INFO - 'PWD': '/builds/slave/test', 04:49:27 INFO - 'SHELL': '/bin/bash', 04:49:27 INFO - 'SHLVL': '1', 04:49:27 INFO - 'TERM': 'linux', 04:49:27 INFO - 'TMOUT': '86400', 04:49:27 INFO - 'USER': 'cltbld', 04:49:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:27 INFO - '_': '/tools/buildbot/bin/python'} 04:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:27 INFO - Running setup.py (path:/tmp/pip-zc3MUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:27 INFO - Running setup.py (path:/tmp/pip-KCWT3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:27 INFO - Running setup.py (path:/tmp/pip-lwbwX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:27 INFO - Running setup.py (path:/tmp/pip-yuRxjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:28 INFO - Running setup.py (path:/tmp/pip-u7HCny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:28 INFO - Running setup.py (path:/tmp/pip-h_6aXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:28 INFO - Running setup.py (path:/tmp/pip-Q3BIFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:28 INFO - Running setup.py (path:/tmp/pip-ga1qhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:28 INFO - Running setup.py (path:/tmp/pip-JtkfMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:28 INFO - Running setup.py (path:/tmp/pip-qTpGIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:28 INFO - Running setup.py (path:/tmp/pip-RCDmfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:28 INFO - Running setup.py (path:/tmp/pip-tkJLOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:28 INFO - Running setup.py (path:/tmp/pip-kNtWEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:28 INFO - Running setup.py (path:/tmp/pip-2VztBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:28 INFO - Running setup.py (path:/tmp/pip-ZeM_a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:28 INFO - Running setup.py (path:/tmp/pip-TbwErL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:28 INFO - Running setup.py (path:/tmp/pip-MqDkyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:30 INFO - Downloading blessings-1.6.tar.gz 04:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:30 INFO - Installing collected packages: blessings 04:49:30 INFO - Running setup.py install for blessings 04:49:31 INFO - Successfully installed blessings 04:49:31 INFO - Cleaning up... 04:49:31 INFO - Return code: 0 04:49:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:31 INFO - Reading from file tmpfile_stdout 04:49:31 INFO - Current package versions: 04:49:31 INFO - argparse == 1.2.1 04:49:31 INFO - blessings == 1.6 04:49:31 INFO - blobuploader == 1.2.4 04:49:31 INFO - docopt == 0.6.1 04:49:31 INFO - manifestparser == 1.1 04:49:31 INFO - mozInstall == 1.12 04:49:31 INFO - mozcrash == 0.17 04:49:31 INFO - mozdebug == 0.1 04:49:31 INFO - mozdevice == 0.48 04:49:31 INFO - mozfile == 1.2 04:49:31 INFO - mozhttpd == 0.7 04:49:31 INFO - mozinfo == 0.9 04:49:31 INFO - mozleak == 0.1 04:49:31 INFO - mozlog == 3.1 04:49:31 INFO - moznetwork == 0.27 04:49:31 INFO - mozprocess == 0.22 04:49:31 INFO - mozprofile == 0.28 04:49:31 INFO - mozrunner == 6.11 04:49:31 INFO - mozscreenshot == 0.1 04:49:31 INFO - mozsystemmonitor == 0.0 04:49:31 INFO - moztest == 0.7 04:49:31 INFO - mozversion == 1.4 04:49:31 INFO - psutil == 3.1.1 04:49:31 INFO - requests == 1.2.3 04:49:31 INFO - wsgiref == 0.1.2 04:49:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:31 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 04:49:31 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 04:49:31 INFO - Using env: {'DISPLAY': ':0', 04:49:31 INFO - 'HOME': '/home/cltbld', 04:49:31 INFO - 'LANG': 'en_US.UTF-8', 04:49:31 INFO - 'LANGUAGE': 'en_US:en', 04:49:31 INFO - 'LOGNAME': 'cltbld', 04:49:31 INFO - 'MAIL': '/var/mail/cltbld', 04:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:31 INFO - 'MOZ_NO_REMOTE': '1', 04:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:31 INFO - 'NO_EM_RESTART': '1', 04:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:31 INFO - 'PWD': '/builds/slave/test', 04:49:31 INFO - 'SHELL': '/bin/bash', 04:49:31 INFO - 'SHLVL': '1', 04:49:31 INFO - 'TERM': 'linux', 04:49:31 INFO - 'TMOUT': '86400', 04:49:31 INFO - 'USER': 'cltbld', 04:49:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:31 INFO - '_': '/tools/buildbot/bin/python'} 04:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 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)) 04:49:31 INFO - Cleaning up... 04:49:31 INFO - Return code: 0 04:49:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:49:31 INFO - Using env: {'DISPLAY': ':0', 04:49:31 INFO - 'HOME': '/home/cltbld', 04:49:31 INFO - 'LANG': 'en_US.UTF-8', 04:49:31 INFO - 'LANGUAGE': 'en_US:en', 04:49:31 INFO - 'LOGNAME': 'cltbld', 04:49:31 INFO - 'MAIL': '/var/mail/cltbld', 04:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:31 INFO - 'MOZ_NO_REMOTE': '1', 04:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:31 INFO - 'NO_EM_RESTART': '1', 04:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:31 INFO - 'PWD': '/builds/slave/test', 04:49:31 INFO - 'SHELL': '/bin/bash', 04:49:31 INFO - 'SHLVL': '1', 04:49:31 INFO - 'TERM': 'linux', 04:49:31 INFO - 'TMOUT': '86400', 04:49:31 INFO - 'USER': 'cltbld', 04:49:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:31 INFO - '_': '/tools/buildbot/bin/python'} 04:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:31 INFO - Downloading/unpacking jsonschema 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:33 INFO - Downloading/unpacking functools32 (from jsonschema) 04:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:33 INFO - warning: no files found matching '*.txt' 04:49:33 INFO - no previously-included directories found matching 'build' 04:49:33 INFO - no previously-included directories found matching 'dist' 04:49:33 INFO - no previously-included directories found matching '.git*' 04:49:33 INFO - Installing collected packages: jsonschema, functools32 04:49:33 INFO - Running setup.py install for functools32 04:49:33 INFO - warning: no files found matching '*.txt' 04:49:33 INFO - no previously-included directories found matching 'build' 04:49:33 INFO - no previously-included directories found matching 'dist' 04:49:33 INFO - no previously-included directories found matching '.git*' 04:49:34 INFO - Successfully installed jsonschema functools32 04:49:34 INFO - Cleaning up... 04:49:34 INFO - Return code: 0 04:49:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:34 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 0x7fd236cfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, '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': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', '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 04:49:34 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 04:49:34 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 04:49:34 INFO - Using env: {'DISPLAY': ':0', 04:49:34 INFO - 'HOME': '/home/cltbld', 04:49:34 INFO - 'LANG': 'en_US.UTF-8', 04:49:34 INFO - 'LANGUAGE': 'en_US:en', 04:49:34 INFO - 'LOGNAME': 'cltbld', 04:49:34 INFO - 'MAIL': '/var/mail/cltbld', 04:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:34 INFO - 'MOZ_NO_REMOTE': '1', 04:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:34 INFO - 'NO_EM_RESTART': '1', 04:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:34 INFO - 'PWD': '/builds/slave/test', 04:49:34 INFO - 'SHELL': '/bin/bash', 04:49:34 INFO - 'SHLVL': '1', 04:49:34 INFO - 'TERM': 'linux', 04:49:34 INFO - 'TMOUT': '86400', 04:49:34 INFO - 'USER': 'cltbld', 04:49:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:34 INFO - '_': '/tools/buildbot/bin/python'} 04:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:34 INFO - Downloading/unpacking flake8 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:49:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:49:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:49:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:36 INFO - no previously-included directories found matching 'docs/_build' 04:49:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:49:36 INFO - Running setup.py install for pep8 04:49:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:37 INFO - no previously-included directories found matching 'docs/_build' 04:49:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:49:37 INFO - Cleaning up... 04:49:37 INFO - Return code: 0 04:49:37 INFO - Running post-action listener: _resource_record_post_action 04:49:37 INFO - Running post-action listener: _start_resource_monitoring 04:49:37 INFO - Starting resource monitoring. 04:49:37 INFO - ##### 04:49:37 INFO - ##### Running install step. 04:49:37 INFO - ##### 04:49:37 INFO - Running pre-action listener: _resource_record_pre_action 04:49:37 INFO - Running main action method: install 04:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:37 INFO - Reading from file tmpfile_stdout 04:49:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:37 INFO - Reading from file tmpfile_stdout 04:49:37 INFO - Output received: 04:49:37 INFO - Usage: mozinstall [options] installer 04:49:37 INFO - Options: 04:49:37 INFO - -h, --help show this help message and exit 04:49:37 INFO - -d DEST, --destination=DEST 04:49:37 INFO - Directory to install application into. [default: 04:49:37 INFO - "/builds/slave/test"] 04:49:37 INFO - --app=APP Application being installed. [default: firefox] 04:49:37 INFO - mkdir: /builds/slave/test/build/application 04:49:37 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'] 04:49:37 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 04:49:53 INFO - Reading from file tmpfile_stdout 04:49:53 INFO - Output received: 04:49:53 INFO - /builds/slave/test/build/application/firefox/firefox 04:49:53 INFO - Running post-action listener: _resource_record_post_action 04:49:53 INFO - ##### 04:49:53 INFO - ##### Running run-tests step. 04:49:53 INFO - ##### 04:49:53 INFO - Running pre-action listener: _resource_record_pre_action 04:49:53 INFO - Running main action method: run_tests 04:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:53 INFO - Python 2.7.3 04:49:53 INFO - Return code: 0 04:49:53 INFO - grabbing minidump binary from tooltool 04:49:53 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')]} 04:49:53 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 0x15ce410>, '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 0x15cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:53 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 04:49:53 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 04:49:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:53 INFO - Return code: 0 04:49:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:49:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:49:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:49:54 INFO - Return code: 0 04:49:54 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/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 04:49:54 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/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 04:49:54 INFO - Using env: {'DISPLAY': ':0', 04:49:54 INFO - 'HOME': '/home/cltbld', 04:49:54 INFO - 'LANG': 'en_US.UTF-8', 04:49:54 INFO - 'LANGUAGE': 'en_US:en', 04:49:54 INFO - 'LOGNAME': 'cltbld', 04:49:54 INFO - 'MAIL': '/var/mail/cltbld', 04:49:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:54 INFO - 'MOZ_NO_REMOTE': '1', 04:49:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:54 INFO - 'NO_EM_RESTART': '1', 04:49:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:54 INFO - 'PWD': '/builds/slave/test', 04:49:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:54 INFO - 'SHELL': '/bin/bash', 04:49:54 INFO - 'SHLVL': '1', 04:49:54 INFO - 'TERM': 'linux', 04:49:54 INFO - 'TMOUT': '86400', 04:49:54 INFO - 'USER': 'cltbld', 04:49:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069', 04:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:54 INFO - '_': '/tools/buildbot/bin/python'} 04:49:54 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/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 04:49:54 INFO - mozversion application_buildid: 20160511015516 04:49:54 INFO - mozversion application_changeset: 78248731d23f9b774ce650c67e6f0ebcb73cdbdd 04:49:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:49:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:54 INFO - mozversion application_name: Firefox 04:49:54 INFO - mozversion application_remotingname: firefox-dev 04:49:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:49:54 INFO - mozversion application_vendor: Mozilla 04:49:54 INFO - mozversion application_version: 48.0a2 04:49:54 INFO - mozversion platform_buildid: 20160511015516 04:49:54 INFO - mozversion platform_changeset: 78248731d23f9b774ce650c67e6f0ebcb73cdbdd 04:49:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:49:54 INFO - mozversion platform_version: 48.0a2 04:49:54 INFO - using testdate: 1462967394 04:49:54 INFO - actual date: 1462967394 04:49:54 INFO - starting webserver on 'localhost:51785' 04:49:54 INFO - SUITE-START | Running 2 tests 04:49:54 INFO - TEST-START | dromaeo_css 04:49:54 INFO - operating with platform_type : linux_ 04:49:54 INFO - Initialising browser for dromaeo_css test... 04:49:54 INFO - TEST-INFO | started process 21956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKdFsM/profile http://localhost:51785/getInfo.html) 04:49:58 INFO - PROCESS | 21956 | __metrics Screen width/height:1600/1200 04:49:58 INFO - PROCESS | 21956 | colorDepth:24 04:49:58 INFO - PROCESS | 21956 | Browser inner width/height: 1024/697 04:49:58 INFO - PROCESS | 21956 | __metrics 04:49:59 ERROR - PROCESS | 21956 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:49:59 INFO - TEST-INFO | 21956: exit 0 04:49:59 INFO - Browser initialized. 04:49:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:49:59 INFO - TEST-INFO | started process 22049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKdFsM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:11 INFO - PROCESS | 22049 | RSS: Main: 142278656 04:50:11 INFO - PROCESS | 22049 | 04:51:02 INFO - PROCESS | 22049 | 1462967462757 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] 04:53:10 INFO - PROCESS | 22049 | Cycle 1(1): loaded http://localhost:51785/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51785/tests/dromaeo/cssquery-ext.html) 04:53:11 INFO - PROCESS | 22049 | RSS: Main: 252104704 04:53:11 INFO - PROCESS | 22049 | 04:56:13 INFO - PROCESS | 22049 | Cycle 1(1): loaded http://localhost:51785/tests/dromaeo/cssquery-ext.html (next: http://localhost:51785/tests/dromaeo/cssquery-jquery.html) 04:56:14 INFO - PROCESS | 22049 | RSS: Main: 223371264 04:56:14 INFO - PROCESS | 22049 | 04:59:16 INFO - PROCESS | 22049 | Cycle 1(1): loaded http://localhost:51785/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51785/tests/dromaeo/cssquery-mootools.html) 04:59:16 INFO - PROCESS | 22049 | RSS: Main: 221888512 04:59:16 INFO - PROCESS | 22049 | 05:02:18 INFO - PROCESS | 22049 | Cycle 1(1): loaded http://localhost:51785/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51785/tests/dromaeo/cssquery-prototype.html) 05:02:19 INFO - PROCESS | 22049 | RSS: Main: 219340800 05:02:19 INFO - PROCESS | 22049 | 05:05:21 INFO - PROCESS | 22049 | Cycle 1(1): loaded http://localhost:51785/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51785/tests/dromaeo/cssquery-yui.html) 05:05:22 INFO - PROCESS | 22049 | RSS: Main: 213663744 05:05:22 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | Cycle 1(1): loaded http://localhost:51785/tests/dromaeo/cssquery-yui.html (next: http://localhost:51785/tests/dromaeo/cssquery-dojo.html) 05:08:24 INFO - PROCESS | 22049 | RSS: Main: 255193088 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | __start_tp_report 05:08:24 INFO - PROCESS | 22049 | _x_x_mozilla_page_load 05:08:24 INFO - PROCESS | 22049 | _x_x_mozilla_page_load_details 05:08:24 INFO - PROCESS | 22049 | |i|pagename|runs| 05:08:24 INFO - PROCESS | 22049 | |0;dojo.html;3276.9672303276966;3371.9662803371975;3373.1061268763774;3390.457526795713;3413.2661477782285;5549.972250138749;5560.805371811983;5573.136163894603;5611.887762244753;5612.41069687683;5550.639208451458;5583.302087239095;5601.439856014396;5605.971970140154;5645.520130788877;4904.141775189328;4967.726775027372;5035.974820125894;5113.207452844815;5129.307543481638;4895.755212239392;4977.477364876672;4980.053789779949;4980.103581355354;4982.800687972477;4990.575801056914;4997.225430058346;5051.242313652963;5077.263796749469;5078.898422031557;5048.394192696863;5056.216286475602;5084.084864724348;5090.211017292326;5109.795608175687;4859.271109333593;4908.901821963576;4910.1898186799135;4988.201887697987;5003.224500202475;5299.8410047698635;5354.14333706609;5398.838034858961;5401.918971215435;5422.728863556807;5839.153322768175;5889.734961926681;5899.970500147472;5900.085486749561;5951.553633477506;5846.41535846412;5962.940370596282;6003.7898673546215;6022.969885150546;6032.185654936571;5534.833954981357;5555.416681248492;5569.582281328917;5626.9437305626825;5638.6052976292085;5860.3260625027815;6128.846778830565;6142.170806941095;6144.293406258337;6148.631082135086;5847.38602446737;5888.558358123158;5903.675297858573;5906.084556893688;5915.704214789243;5959.582829201914;5965.821025369246;5968.343482216953;5968.432998865101;5978.491828194652;5817.185594016841;5817.331006934257;5931.406859314034;5932.228810254725;5941.287045554561;5844.766209351664;5852.912206316909;5857.531397488191;5860.970695146497;5897.351291357947;4486.887827804331;4490.977545112319;4493.6854420190275;4501.144782491317;4516;4001.15975645112;4006.2988976928923;4033.9193216135513;4053.2096241232675;4065.3698676705158;5594.86012849682;5610.579206559442;5614.129809879475;5614.242077319591;5649.887002260014;5889.617174883619;5895.911561326584;5899.115132730125;5900.64596124234;5916.437938395846;5448.782048718007;5624.746886390122;5638.492535671728;5687.203791469197;5698.914516282259;4859.392575928009;4878.634102442331;4882.853514394574;4893.510648935078;4915.0415668944215;6079.240094988127;6081.75672973085;6083.026715725463;6085.847853803691;6093.573449858467;5795.565332599987;5979.820605381846;6022.668753218615;6024.819255422344;6044.184035155197;6092.695365231632;6096.542759292982;6096.573239873166;6097.2683278006925;6102.938970610237;5738.053221218453;5803.042497987784;5809.157672137601;5812.854678632899;5825.242718446575;5967.164596956516;6001.189839371629;6007.068904319837;6008.789692360747;6037.15479832815;5838.211841401527;5842.795502157404;5843.2695913010875;5843.620164689281;5845.3277873045145;5656.943430565641;5759.827205183851;5815.5929084963645;5819.621724587888;5819.76720931158;5726.4273572642405;5733.397993210653;5759.193712880116;5767.625104368202;5794.594378393472;5855.268091488564;5860.150278209721;5868.823935281948;5877.089051197071;5883.882322353615;5593.9440605595055;5646.322441307069;5721.141828725725;5730;5762.683052432157 05:08:24 INFO - PROCESS | 22049 | |1;ext.html;674.9392554670079;676.3000294694991;678.6776281266395;737.4174402222245;753.581762122022;32297.19257018573;39022.41466378003;39125.217495650104;39547.60452395475;39604.60395396045;42028;42550.14899702012;42577.14845703084;42585.148297034044;42648;8003.199680031979;8579.91420085799;8780.780480487974;8786;10422.63520776773;10460.633877814278;10593.947030264839;10597.152227821794;10598.841017384746;10602.310849794778;10592.470376481184;10647.680569582886;10652.360858348524;10664.62673806417;10674.679759607185;8258.958705206436;10526.42104684242;10572.365658060502;10585.417802020886;10763.677089687322;10597.62908298206;10715.571377144905;10716.089132423753;10722;10730;40441.79779101115;40809.387859182134;40820;40899.7955010226;40921.38617920734;3806.6764325032404;3914.197589494147;3987.5613682494904;4144.5233798113;4392.099619577979;33948.83025584881;34631.480527792104;34650;34683.6531634683;34713.652863471296;4523.977380113111;4556.794944227485;4637.420322459692;4649.279361698942;4669.696469729491;339918;343718;343796.9999999975;344158;344639;42886;69451;70935.64532177306;70967.29032709607;70987.29012709807;41608;41886.79056604698;41983.370249446285;41984.16031679411;42035.36946945798;16229.431969881234;16355.83644163543;16422.507324780276;16442.177891105395;16467.094309812837;13235.073544851768;13656.726865462833;13863.584092477242;13892.16647001183;13895.444182232597;9535.952320238355;9572.664956726481;9638.710838674851;9683.564239609235;9711.465869377253;3651.744377893522;3734.57052438973;3751.456038874348;3790.9431358529646;3800.3729384651774;1115.0243536905207;1164.9941750291364;1198.7063169523349;1241.714405686697;1285.0233822295122;33291.66708332934;33816.32367352688;33899.661003390145;34218;35027.12432189165;1229.434460148324;1252.0859772366223;1282.294737894173;1318.136620513565;1321.4846209978116;17961.461156165336;18629.674402805522;19545.609087818164;19620.509487262934;19754.60490790176;538228;545000;548255;549025;549656;64350;65059;65143.34856651373;65559.34440655628;65692.34307656958;1443.4803470750521;1451.042312074026;1522.3834347089446;1526;1567.6061327226655;30746.231344216572;32805;32940.67059329376;33931;34077;53337.19994200012;53891;53925.73037134789;53935.73032134814;54066;383481;384674;385008;387952;388747;27775;30715.2321191972;31014.379712406077;31367;31755;48311.27533087077;48701.512984869696;48882.26676599925;49211.261831071846;49375.50624493709;37040.444393333586;40138.79930600328;40265.59734402619;40329;40527;39298.80350598229;40675.1864962705;41321;41409;41499;40824;41612.79193604013;41782.79108604437;42282.36576451294;42976.35535466908;34872;35907;36046;36829.815850920575;36842.63157368392;27777;27864.442711146068;28201.57697634496;28224.85887570549;28318.575221371284 05:08:24 INFO - PROCESS | 22049 | |2;jquery.html;385.82059342405785;397.1401914854339;398.95212574491063;403.9333509970855;411.8290909272652;15863.286152123153;16816.74774878378;18980;19546.902265488672;19566.90216548915;15572.6763225126;18765.906170469163;19428.805711942878;20250.797492025074;20469.38591842247;5534.08687566551;5619.719014049301;5644.74598643062;5653.9151912721345;5688.488036076752;4180.916381672365;5663.405342439047;5970.1940238067955;6224.502039836802;6224.719887605046;6142.140100385949;6142.508599312045;6157.353477884825;6173.259208894939;6192;6034.487068599153;6057.30341010785;6060.818175454721;6062.42406971337;6208.348123447018;5483.75323110461;5488.25908502355;5492.890142197173;5495.065838807413;5495.313085864267;22510.549789004293;22519.324420267418;23350.883245583835;23424.882875585514;23443.296701098996;2565.102214225025;2599.181257903754;2611.569091099966;2614.9215523534326;2780.4439112177647;14583.854161458356;14660;14689;14854;15092.320845561977;1996.1516355548833;2029;2058.783827698085;2089.2896415218747;2098.6012657595006;80612.89147669708;81975.590122049;82010.58994705048;82878;83700.16299837045;9959.302848800515;10097.798044039226;10107.69676909694;10539.314944528734;10687.679369618923;14283.143011419348;14389.208593527248;14393.208373539346;14400.639984000483;14415.063020903608;7954.284114429729;8105.230003149809;8109.716159934492;8128.512289262663;8172.6730930762105;7519.248075192437;7818.843623127619;8204.8359032819;8550.27322677567;8840.178487413259;6339.703354255761;6349.2698339690605;6357.8728425432155;6648.16897887764;6716.899246511306;1872.8408085312901;1909.9140538675515;1927.38323736403;1946.3771593090075;1951.756030496188;1034.1674951663983;1071.2233630617895;1100.6037826382496;1121.8373335866254;1193.1826698711411;17938.730919036225;18041.909790450965;18446.813786263327;18705.532361690795;19908.90045549792;1056.5984925728173;1129.717570607348;1179.9056075513938;1198.43074539593;1254.4507533196677;10189;10343.4311112888;10471.528781204865;10487.265891387682;10561.788764224673;516128;529095;536185;539729;548163;95832.52083739536;96906.51546742221;99104.5044774786;100443;102570;1159.8724140344555;1161.5876363890866;1170.5551890281808;1177.0054304113182;1179.722765150189;16467.917660411622;16671.666566668842;16923.407680731114;16974.151292435577;17068.061256631005;40067.59932400638;40244.79877600593;40444.1911161781;40763.79618101891;41209;60957;61730.69134654298;61814.69092654508;62341.37658623356;62371;8153.388495862715;8516.829663406821;8580.099089595502;8619.65521379163;8656.091110433314;7859.803504912423;9956.601735930482;12225.410696609384;12278.693032674255;12888.355582221038;12174.208676436003;12273;12330.136890417585;12464.875351246372;12670.176438531465;11307.830382544103;11840.052795776144;12130.33283169434;12379.381030948596;12642.30467324306;12176.452059657513;12327.630171094881;12332.568360107352;12510.687232819253;12682.87317126817;8287.709930152416;8611.95694021526;8799.384043116921;8878.644854205759;8997.865032024394;11767.23512971654;11874.703132421759;12261.816072758736;12304.630861074182;12402.069844761498 05:08:24 INFO - PROCESS | 22049 | |3;mootools.html;1458;1589.5549246211062;1604.7432410814267;1851.2965073272155;1932.9130189141488;8050.355971522279;8181.181881811815;8185.222403871638;8195.098539160696;8204.712835050774;7769.300762931335;7914.2481464260945;7929.207079292068;7930.7620771376805;7934.047914250298;2012.617602655498;2295.391721193885;2320.9883950580224;2336.6495025746103;2398.772116648924;2373.0389192377115;2374.382660508272;2383.4398916254668;2395.197608801054;2396.3290278721984;2287.176616418088;2357.8113750899975;2368.7275963264187;2371.2293504610984;2372.881355932205;1998.7301714268606;2292.5758734634064;2339.263132113379;2339.7894189523026;2344.23812261015;2286.3941055620276;2288.8168946484243;2295.1622657729977;2297.655351697242;2366.8461549999197;8318.958405207935;8371;8372.665093396257;8379.664813407457;8382.07797142314;4936.420345489445;5129.05112554175;5137.871553211162;5142.74286285688;5175.456577059392;3331.68349006844;3340.2484441000825;3390.610079840825;3413.300273443938;3455.5335029771163;1071.12703146935;1075.4031512510553;1094.9890501095047;1111.4776055254017;1130.2596799096523;11547.191696581243;11568.190226684135;11594.76810463786;11609.07127429812;11626.825597616042;4433.866983990485;4439.378487011821;4517.570830771071;4518.186726389215;4521.367008618796;9954.153896918842;9971.102600765966;9977;9988.600455981825;10002.199824014207;4560.954390456053;5202.167653175474;5221.242919776687;5223.164293712987;5225.634205605571;4188.832446702158;4701.177293973541;4754.310624959361;4764.785584648699;4779.904401911942;4012.237674841829;4048.5951404859866;4058.0463591056077;4060.7614677523047;4116.814743336557;1285.4665313894816;1301.3103055380664;1306.1053178572708;1311.5999620115956;1315.8486774020919;931.2922179143764;1035.9689209323733;1065.1425602389995;1083.111848284415;1088.482970588964;6025.701809107923;6059.48494377974;6075.726592303268;6083.087536869417;6192.071189321638;951.7681037965958;981.2003217377815;1031.1544533482472;1055.8891316411666;1080.935143891369;4123.8969025773995;4132.132252227066;4142.233686767958;4145.8963525912095;4150.501939767248;10306.690799276033;10726.624568140078;10729.785404292026;10745.570177192982;10750.78498430027;10586.258961872594;10588.10001149911;10604.522796474177;10638.68083957467;10644.520996555173;7751.418643601753;8050.516968981763;8085.5957202140835;8101.878471822927;8197;5804.34230889802;5844.386339434298;5972.014617588049;6014.548908831767;6110.083487476914;9027.14242146995;9034.2320902724;9191.21874640663;9291.303152263743;9297.581608827484;9279.860802087838;9307.348485605942;9321.673741419288;9468.14786669203;9524;6713.12729345182;7251.637418129178;7427.294407031323;7550.5469671819865;7713.19011503784;8226.753197404087;8249.381296402913;8259.174082591693;8267.83464330722;8316.251537361666;7247.166575843846;7311.707531698672;7518.924810752042;7618.885716714364;7646.273604007611;7101.147862256562;7143;7179.497435179487;7246.202917678946;7411.1477180124975;6564.934350656432;6597.406233439014;6608.603483790988;6634.436072933661;6646.501512386493;4906.141425250496;5109.591232701449;5145.305383773292;5155.510226528474;5161.81933632321;5379.704116273642;5416.431274716098;5424.81844517644;5563.415841336601;5569.443055694398 05:08:24 INFO - PROCESS | 22049 | |4;prototype.html;317.4935977116499;318.9872405103796;319.58134843355197;321.63976346491916;322.1061554187129;6227.1282020517165;6230.875382492353;6234.220722409699;6255.906161407577;6284.780032698856;6156.56904016719;6172.043333283337;6213.409726076027;6243.594166379194;6245.531585131122;4378;4527.569880861313;4643.628509719231;4660.4174478190225;4660.627149828023;4617.699849509788;4642.396488456496;4651.465081515618;4654.604358629521;4655.4180727409075;4407.382966384709;4606.838760643378;4616;4616.8153273869175;4621.353010578522;4492.775361231958;4501.7974191161475;4600.631949444037;4617.376654151713;4620.330052142421;4006.4791577094793;4017.578154293786;4022.4770779798437;4029.254587901218;4038.474998250238;5989.670568118795;5995.430434108753;5996.880062398771;6000.399960004008;6012.879742405127;5410.242566040757;5416.539594134503;5419.701916394597;5435.755391007414;5436.157395603648;6582.17722784652;6584.86830263392;6594.604323740591;6599.307072757388;6601.075849381091;4260.744355338689;4393.692441529094;4404.4934832494355;4406.1187762447635;4407.515173330931;6793.252742198354;6899.586024838475;6909.550879192836;6913.20498142715;6915.75794847183;4463.218936686132;4463.330500424962;4474.306482495218;4475.977620111944;4480;4512.661550383735;4512.909741805145;4513.729176249435;4519.932201016922;4520.050789334211;5345.33183352081;5348.224507446398;5351.57187425005;5354.544863686552;5361.437049109865;6501.642409667514;6648.803215421174;6673.899891501631;6681.398674119353;6693.497987650946;1556.4785796757985;1559.376249500209;1571.8899677022498;1572.5675439254296;1573.6931298396703;942.3356533643902;966.9073946440477;1000.8398656215116;1002.6791426743372;1003.6236411345745;6374;6397.232332120176;6411.942029565163;6419.775307864203;6420;6784.321567843176;6840.828979275459;6861.005154252605;6873.20958089816;6901.068355772007;6426.260979987268;6429.517786166056;6433.1636887205295;6434.485241180694;6442.774502892376;3626.165981824195;3658.506101676293;3661.0847288177956;3663.46879702447;3665.52348194733;6909.827254318682;7002.159740831133;7047.119110111236;7066.787996360117;7069.646517674199;6882.139732533434;6888.655567221619;6891.827704307332;6898.965505172442;6926.376626103674;7041.929580704127;7044.084269045094;7044.542104763174;7048.365647091787;7049.259827718119;6765.594064356154;6766.8646627068165;6774.356436138559;6776.254611992776;6786.3892249697765;6572.4084832363405;6694.263631000684;6822.829429264308;6835.897461537981;6846.246912839683;7183.102112235971;7193.100862392201;7196.316349946746;7208.639568021473;7212.278772122956;4467.329900514948;4499.955000449953;4500.3249512573375;4504.684672073055;4508.887277817949;6892.345227203407;6897.137857767779;6901.723931042702;6902.413294869993;6904.171499420102;6525.477961762953;6745.730170793114;6747.392734653905;6749.055132281386;6779.830504237433;6700.162479690039;6713.429358504582;6718.361755633207;6719.227288861844;6733.225679046972;6613.10723052401;6623.072769812134;6623.304553022056;6627.701753421011;6637.070810086689;6773.119494465688;6785.457163427012;6786.321367863175;6789.72841086351;6792.0830687856505;6459.580127291711;6586.901196482152;6587.835304117244;6592.967035164794;6609 05:08:24 INFO - PROCESS | 22049 | |5;yui.html;917.9770505737358;919.2829592917523;925.8611208318754;942.4863449420066;956.5312996631649;14106.57680269591;14107.294635268234;14183.149011059319;14202.07686500378;14641.633959151026;13214.339283035833;13281.867181328184;13285.33573321335;13298.069135160542;13312.800307995363;737.2774680812806;906.112010229975;926.9304802139867;927.5176908007832;931.4318265857821;919.9356045076847;925.791696868206;928.2944961829024;928.8049509602992;929.7396728915915;969.05517120807;982.0326977926736;985.2167526816163;985.3348989432141;986.3292960786662;786.8072322281021;961.7114865540345;978.0512902484578;981.1464026297095;981.3817295104075;715.6922523314972;719.237608135373;720.0135813934891;721.5129787393488;721.6103304215717;14063.789043164361;14193.07744996572;14265.57203283903;14271.928640356835;14280.857191428056;13702.38339274735;14094.083884547472;14197.716045679132;14211.289435528286;14423.711525769531;12023.338716370596;12069.879301207051;12223.511059557606;12294.877051229463;12385.690357741038;3802.6007269236884;3858.2862170498547;3868.6905047596124;3892.2410130024655;3902.2975864344407;57780.422195778345;57856;58121.41878581202;58982.41017589855;59561;11606.366864492958;11634.127440442;11692.857749214787;11795.469203885847;12055.035597152208;20305.593888122155;20390.388288351372;20572.897135514526;20595.58808823815;20611.58776824485;7809.726659566888;7869.724559640385;8043.839123217503;8675.91324086751;8827.955860220787;4877.878053048702;4981.750912454435;5009.5491405773655;5073.720945347967;5234.92147617786;3464.72282217422;3501.3172431375638;3507.0881570791776;3511.0169152637304;3515.789052656849;536.9650972686841;610.71906922816;618.9907151392732;651.4755621724557;654.2802916791492;668.759246671198;706.3642721550646;747.7644541969262;755.1994885421361;787.016717870962;9083.36416450842;9436.811263774685;9508.90491095094;9570.760730981641;9683.951580242054;636.38270877249;699.9580025198504;708.5783958544657;711.3100292716057;743.7805847275067;4344.782760861945;4458.197524445631;4657.464391594942;4682.461516925529;4706.647001474903;67906.32093679;68217.31782682109;68258.31741682619;68610.3138968614;68610.65694671495;56018.439815602134;58456;58724.706376467846;59232.70383648054;59478.40521594815;51735.74132129315;52202;53339.19991200058;53449.73275133599;53935.190972135446;9275.76810579741;9297.349185556946;9325.626974921199;9336.906630933603;9435.811283774423;38919.22161556697;39415.40876886906;40098.79950600228;40318.79840600778;40377.79811100926;44825;49752.25371619501;50313;50444.74777626088;51612.48387516077;11709.355985420543;11749;11940.880591193976;11952.223105498115;12326.568570100004;12457.626271211879;12697.87302127004;12875.291858947849;12993.870061299265;13003.934980325037;11943.641690749291;12214.75570488603;12223.816642750187;12272.325022123869;12364.134510584172;11158.776824463628;11657.300561966309;13411.463541458232;13617.31913404306;13946.58160255194;12268.141230113806;12824.487020519075;13089.541866035024;13198.14212076212;13402.262875541548;9761.463119528495;10160.288779785344;11158.163137764863;11255.943720281673;11516.712082198012;10632;11255.437228138397;11321.490532925873;11392.316461012366;11632.12759043092 05:08:24 INFO - PROCESS | 22049 | __end_tp_report 05:08:24 INFO - PROCESS | 22049 | __start_cc_report 05:08:24 INFO - PROCESS | 22049 | _x_x_mozilla_cycle_collect,876 05:08:24 INFO - PROCESS | 22049 | __end_cc_report 05:08:24 INFO - PROCESS | 22049 | __startTimestamp1462968504673__endTimestamp 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | ------- Summary: start ------- 05:08:24 INFO - PROCESS | 22049 | Number of tests: 6 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | [#0] dojo.html Cycles:165 Average:5501.73 Median:5738.05 stddev:621.95 (10.8%) stddev-sans-first:598.87 05:08:24 INFO - PROCESS | 22049 | Values: 3277.0 3372.0 3373.1 3390.5 3413.3 5550.0 5560.8 5573.1 5611.9 5612.4 5550.6 5583.3 5601.4 5606.0 5645.5 4904.1 4967.7 5036.0 5113.2 5129.3 4895.8 4977.5 4980.1 4980.1 4982.8 4990.6 4997.2 5051.2 5077.3 5078.9 5048.4 5056.2 5084.1 5090.2 5109.8 4859.3 4908.9 4910.2 4988.2 5003.2 5299.8 5354.1 5398.8 5401.9 5422.7 5839.2 5889.7 5900.0 5900.1 5951.6 5846.4 5962.9 6003.8 6023.0 6032.2 5534.8 5555.4 5569.6 5626.9 5638.6 5860.3 6128.8 6142.2 6144.3 6148.6 5847.4 5888.6 5903.7 5906.1 5915.7 5959.6 5965.8 5968.3 5968.4 5978.5 5817.2 5817.3 5931.4 5932.2 5941.3 5844.8 5852.9 5857.5 5861.0 5897.4 4486.9 4491.0 4493.7 4501.1 4516.0 4001.2 4006.3 4033.9 4053.2 4065.4 5594.9 5610.6 5614.1 5614.2 5649.9 5889.6 5895.9 5899.1 5900.6 5916.4 5448.8 5624.7 5638.5 5687.2 5698.9 4859.4 4878.6 4882.9 4893.5 4915.0 6079.2 6081.8 6083.0 6085.8 6093.6 5795.6 5979.8 6022.7 6024.8 6044.2 6092.7 6096.5 6096.6 6097.3 6102.9 5738.1 5803.0 5809.2 5812.9 5825.2 5967.2 6001.2 6007.1 6008.8 6037.2 5838.2 5842.8 5843.3 5843.6 5845.3 5656.9 5759.8 5815.6 5819.6 5819.8 5726.4 5733.4 5759.2 5767.6 5794.6 5855.3 5860.2 5868.8 5877.1 5883.9 5593.9 5646.3 5721.1 5730.0 5762.7 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | [#1] ext.html Cycles:180 Average:58797.69 Median:3795.66 stddev:115069.18 (3031.6%) stddev-sans-first:115309.23 05:08:24 INFO - PROCESS | 22049 | Values: 674.9 676.3 678.7 737.4 753.6 32297.2 39022.4 39125.2 39547.6 39604.6 42028.0 42550.1 42577.1 42585.1 42648.0 8003.2 8579.9 8780.8 8786.0 10422.6 10460.6 10593.9 10597.2 10598.8 10602.3 10592.5 10647.7 10652.4 10664.6 10674.7 8259.0 10526.4 10572.4 10585.4 10763.7 10597.6 10715.6 10716.1 10722.0 10730.0 40441.8 40809.4 40820.0 40899.8 40921.4 3806.7 3914.2 3987.6 4144.5 4392.1 33948.8 34631.5 34650.0 34683.7 34713.7 4524.0 4556.8 4637.4 4649.3 4669.7 339918.0 343718.0 343797.0 344158.0 344639.0 42886.0 69451.0 70935.6 70967.3 70987.3 41608.0 41886.8 41983.4 41984.2 42035.4 16229.4 16355.8 16422.5 16442.2 16467.1 13235.1 13656.7 13863.6 13892.2 13895.4 9536.0 9572.7 9638.7 9683.6 9711.5 3651.7 3734.6 3751.5 3790.9 3800.4 1115.0 1165.0 1198.7 1241.7 1285.0 33291.7 33816.3 33899.7 34218.0 35027.1 1229.4 1252.1 1282.3 1318.1 1321.5 17961.5 18629.7 19545.6 19620.5 19754.6 538228.0 545000.0 548255.0 549025.0 549656.0 64350.0 65059.0 65143.3 65559.3 65692.3 1443.5 1451.0 1522.4 1526.0 1567.6 30746.2 32805.0 32940.7 33931.0 34077.0 53337.2 53891.0 53925.7 53935.7 54066.0 383481.0 384674.0 385008.0 387952.0 388747.0 27775.0 30715.2 31014.4 31367.0 31755.0 48311.3 48701.5 48882.3 49211.3 49375.5 37040.4 40138.8 40265.6 40329.0 40527.0 39298.8 40675.2 41321.0 41409.0 41499.0 40824.0 41612.8 41782.8 42282.4 42976.4 34872.0 35907.0 36046.0 36829.8 36842.6 27777.0 27864.4 28201.6 28224.9 28318.6 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | [#2] jquery.html Cycles:180 Average:30619.16 Median:22935.10 stddev:87984.10 (383.6%) stddev-sans-first:88201.63 05:08:24 INFO - PROCESS | 22049 | Values: 385.8 397.1 399.0 403.9 411.8 15863.3 16816.7 18980.0 19546.9 19566.9 15572.7 18765.9 19428.8 20250.8 20469.4 5534.1 5619.7 5644.7 5653.9 5688.5 4180.9 5663.4 5970.2 6224.5 6224.7 6142.1 6142.5 6157.4 6173.3 6192.0 6034.5 6057.3 6060.8 6062.4 6208.3 5483.8 5488.3 5492.9 5495.1 5495.3 22510.5 22519.3 23350.9 23424.9 23443.3 2565.1 2599.2 2611.6 2614.9 2780.4 14583.9 14660.0 14689.0 14854.0 15092.3 1996.2 2029.0 2058.8 2089.3 2098.6 80612.9 81975.6 82010.6 82878.0 83700.2 9959.3 10097.8 10107.7 10539.3 10687.7 14283.1 14389.2 14393.2 14400.6 14415.1 7954.3 8105.2 8109.7 8128.5 8172.7 7519.2 7818.8 8204.8 8550.3 8840.2 6339.7 6349.3 6357.9 6648.2 6716.9 1872.8 1909.9 1927.4 1946.4 1951.8 1034.2 1071.2 1100.6 1121.8 1193.2 17938.7 18041.9 18446.8 18705.5 19908.9 1056.6 1129.7 1179.9 1198.4 1254.5 10189.0 10343.4 10471.5 10487.3 10561.8 516128.0 529095.0 536185.0 539729.0 548163.0 95832.5 96906.5 99104.5 100443.0 102570.0 1159.9 1161.6 1170.6 1177.0 1179.7 16467.9 16671.7 16923.4 16974.2 17068.1 40067.6 40244.8 40444.2 40763.8 41209.0 60957.0 61730.7 61814.7 62341.4 62371.0 8153.4 8516.8 8580.1 8619.7 8656.1 7859.8 9956.6 12225.4 12278.7 12888.4 12174.2 12273.0 12330.1 12464.9 12670.2 11307.8 11840.1 12130.3 12379.4 12642.3 12176.5 12327.6 12332.6 12510.7 12682.9 8287.7 8612.0 8799.4 8878.6 8997.9 11767.2 11874.7 12261.8 12304.6 12402.1 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | [#3] mootools.html Cycles:180 Average:5610.05 Median:5023.01 stddev:3074.02 (61.2%) stddev-sans-first:3066.80 05:08:24 INFO - PROCESS | 22049 | Values: 1458.0 1589.6 1604.7 1851.3 1932.9 8050.4 8181.2 8185.2 8195.1 8204.7 7769.3 7914.2 7929.2 7930.8 7934.0 2012.6 2295.4 2321.0 2336.6 2398.8 2373.0 2374.4 2383.4 2395.2 2396.3 2287.2 2357.8 2368.7 2371.2 2372.9 1998.7 2292.6 2339.3 2339.8 2344.2 2286.4 2288.8 2295.2 2297.7 2366.8 8319.0 8371.0 8372.7 8379.7 8382.1 4936.4 5129.1 5137.9 5142.7 5175.5 3331.7 3340.2 3390.6 3413.3 3455.5 1071.1 1075.4 1095.0 1111.5 1130.3 11547.2 11568.2 11594.8 11609.1 11626.8 4433.9 4439.4 4517.6 4518.2 4521.4 9954.2 9971.1 9977.0 9988.6 10002.2 4561.0 5202.2 5221.2 5223.2 5225.6 4188.8 4701.2 4754.3 4764.8 4779.9 4012.2 4048.6 4058.0 4060.8 4116.8 1285.5 1301.3 1306.1 1311.6 1315.8 931.3 1036.0 1065.1 1083.1 1088.5 6025.7 6059.5 6075.7 6083.1 6192.1 951.8 981.2 1031.2 1055.9 1080.9 4123.9 4132.1 4142.2 4145.9 4150.5 10306.7 10726.6 10729.8 10745.6 10750.8 10586.3 10588.1 10604.5 10638.7 10644.5 7751.4 8050.5 8085.6 8101.9 8197.0 5804.3 5844.4 5972.0 6014.5 6110.1 9027.1 9034.2 9191.2 9291.3 9297.6 9279.9 9307.3 9321.7 9468.1 9524.0 6713.1 7251.6 7427.3 7550.5 7713.2 8226.8 8249.4 8259.2 8267.8 8316.3 7247.2 7311.7 7518.9 7618.9 7646.3 7101.1 7143.0 7179.5 7246.2 7411.1 6564.9 6597.4 6608.6 6634.4 6646.5 4906.1 5109.6 5145.3 5155.5 5161.8 5379.7 5416.4 5424.8 5563.4 5569.4 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | [#4] prototype.html Cycles:180 Average:5494.26 Median:6415.86 stddev:1728.25 (26.9%) stddev-sans-first:1688.85 05:08:24 INFO - PROCESS | 22049 | Values: 317.5 319.0 319.6 321.6 322.1 6227.1 6230.9 6234.2 6255.9 6284.8 6156.6 6172.0 6213.4 6243.6 6245.5 4378.0 4527.6 4643.6 4660.4 4660.6 4617.7 4642.4 4651.5 4654.6 4655.4 4407.4 4606.8 4616.0 4616.8 4621.4 4492.8 4501.8 4600.6 4617.4 4620.3 4006.5 4017.6 4022.5 4029.3 4038.5 5989.7 5995.4 5996.9 6000.4 6012.9 5410.2 5416.5 5419.7 5435.8 5436.2 6582.2 6584.9 6594.6 6599.3 6601.1 4260.7 4393.7 4404.5 4406.1 4407.5 6793.3 6899.6 6909.6 6913.2 6915.8 4463.2 4463.3 4474.3 4476.0 4480.0 4512.7 4512.9 4513.7 4519.9 4520.1 5345.3 5348.2 5351.6 5354.5 5361.4 6501.6 6648.8 6673.9 6681.4 6693.5 1556.5 1559.4 1571.9 1572.6 1573.7 942.3 966.9 1000.8 1002.7 1003.6 6374.0 6397.2 6411.9 6419.8 6420.0 6784.3 6840.8 6861.0 6873.2 6901.1 6426.3 6429.5 6433.2 6434.5 6442.8 3626.2 3658.5 3661.1 3663.5 3665.5 6909.8 7002.2 7047.1 7066.8 7069.6 6882.1 6888.7 6891.8 6899.0 6926.4 7041.9 7044.1 7044.5 7048.4 7049.3 6765.6 6766.9 6774.4 6776.3 6786.4 6572.4 6694.3 6822.8 6835.9 6846.2 7183.1 7193.1 7196.3 7208.6 7212.3 4467.3 4500.0 4500.3 4504.7 4508.9 6892.3 6897.1 6901.7 6902.4 6904.2 6525.5 6745.7 6747.4 6749.1 6779.8 6700.2 6713.4 6718.4 6719.2 6733.2 6613.1 6623.1 6623.3 6627.7 6637.1 6773.1 6785.5 6786.3 6789.7 6792.1 6459.6 6586.9 6587.8 6593.0 6609.0 05:08:24 INFO - PROCESS | 22049 | 05:08:24 INFO - PROCESS | 22049 | [#5] yui.html Cycles:180 Average:15659.58 Median:27315.07 stddev:18569.70 (68.0%) stddev-sans-first:18588.79 05:08:24 INFO - PROCESS | 22049 | Values: 918.0 919.3 925.9 942.5 956.5 14106.6 14107.3 14183.1 14202.1 14641.6 13214.3 13281.9 13285.3 13298.1 13312.8 737.3 906.1 926.9 927.5 931.4 919.9 925.8 928.3 928.8 929.7 969.1 982.0 985.2 985.3 986.3 786.8 961.7 978.1 981.1 981.4 715.7 719.2 720.0 721.5 721.6 14063.8 14193.1 14265.6 14271.9 14280.9 13702.4 14094.1 14197.7 14211.3 14423.7 12023.3 12069.9 12223.5 12294.9 12385.7 3802.6 3858.3 3868.7 3892.2 3902.3 57780.4 57856.0 58121.4 58982.4 59561.0 11606.4 11634.1 11692.9 11795.5 12055.0 20305.6 20390.4 20572.9 20595.6 20611.6 7809.7 7869.7 8043.8 8675.9 8828.0 4877.9 4981.8 5009.5 5073.7 5234.9 3464.7 3501.3 3507.1 3511.0 3515.8 537.0 610.7 619.0 651.5 654.3 668.8 706.4 747.8 755.2 787.0 9083.4 9436.8 9508.9 9570.8 9684.0 636.4 700.0 708.6 711.3 743.8 4344.8 4458.2 4657.5 4682.5 4706.6 67906.3 68217.3 68258.3 68610.3 68610.7 56018.4 58456.0 58724.7 59232.7 59478.4 51735.7 52202.0 53339.2 53449.7 53935.2 9275.8 9297.3 9325.6 9336.9 9435.8 38919.2 39415.4 40098.8 40318.8 40377.8 44825.0 49752.3 50313.0 50444.7 51612.5 11709.4 11749.0 11940.9 11952.2 12326.6 12457.6 12697.9 12875.3 12993.9 13003.9 11943.6 12214.8 12223.8 12272.3 12364.1 11158.8 11657.3 13411.5 13617.3 13946.6 12268.1 12824.5 13089.5 13198.1 13402.3 9761.5 10160.3 11158.2 11255.9 11516.7 10632.0 11255.4 11321.5 11392.3 11632.1 05:08:24 INFO - PROCESS | 22049 | -------- Summary: end -------- 05:08:24 INFO - PROCESS | 22049 | 05:08:25 INFO - TEST-INFO | 22049: exit 0 05:08:25 INFO - TEST-OK | dromaeo_css | took 1111189ms 05:08:25 INFO - TEST-START | kraken 05:08:25 INFO - operating with platform_type : linux_ 05:08:25 INFO - Initialising browser for kraken test... 05:08:25 INFO - TEST-INFO | started process 22239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIMPtW/profile http://localhost:51785/getInfo.html) 05:08:29 INFO - PROCESS | 22239 | __metrics Screen width/height:1600/1200 05:08:29 INFO - PROCESS | 22239 | colorDepth:24 05:08:29 INFO - PROCESS | 22239 | Browser inner width/height: 1024/697 05:08:29 INFO - PROCESS | 22239 | __metrics 05:08:30 ERROR - PROCESS | 22239 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:08:31 INFO - TEST-INFO | 22239: exit 0 05:08:31 INFO - Browser initialized. 05:08:31 INFO - Running cycle 1/1 for kraken test... 05:08:31 INFO - TEST-INFO | started process 22331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIMPtW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:42 INFO - PROCESS | 22331 | RSS: Main: 142016512 05:08:42 INFO - PROCESS | 22331 | 05:08:45 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51785/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:46 INFO - PROCESS | 22331 | RSS: Main: 196956160 05:08:46 INFO - PROCESS | 22331 | 05:08:48 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51785/tests/kraken/driver.html?testName=audio-dft) 05:08:49 INFO - PROCESS | 22331 | RSS: Main: 182476800 05:08:49 INFO - PROCESS | 22331 | 05:08:52 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51785/tests/kraken/driver.html?testName=audio-fft) 05:08:52 INFO - PROCESS | 22331 | RSS: Main: 272904192 05:08:52 INFO - PROCESS | 22331 | 05:08:54 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51785/tests/kraken/driver.html?testName=audio-oscillator) 05:08:55 INFO - PROCESS | 22331 | RSS: Main: 178438144 05:08:55 INFO - PROCESS | 22331 | 05:08:57 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51785/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:58 INFO - PROCESS | 22331 | RSS: Main: 177147904 05:08:58 INFO - PROCESS | 22331 | 05:09:01 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51785/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:01 INFO - PROCESS | 22331 | RSS: Main: 211513344 05:09:01 INFO - PROCESS | 22331 | 05:09:04 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51785/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:05 INFO - PROCESS | 22331 | RSS: Main: 212398080 05:09:05 INFO - PROCESS | 22331 | 05:09:08 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51785/tests/kraken/driver.html?testName=json-parse-financial) 05:09:08 INFO - PROCESS | 22331 | RSS: Main: 212221952 05:09:08 INFO - PROCESS | 22331 | 05:09:10 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51785/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:10 INFO - PROCESS | 22331 | RSS: Main: 192434176 05:09:10 INFO - PROCESS | 22331 | 05:09:12 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:13 INFO - PROCESS | 22331 | RSS: Main: 195694592 05:09:13 INFO - PROCESS | 22331 | 05:09:15 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:15 INFO - PROCESS | 22331 | RSS: Main: 209506304 05:09:15 INFO - PROCESS | 22331 | 05:09:18 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:18 INFO - PROCESS | 22331 | RSS: Main: 214958080 05:09:18 INFO - PROCESS | 22331 | 05:09:21 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:22 INFO - PROCESS | 22331 | RSS: Main: 211587072 05:09:22 INFO - PROCESS | 22331 | 05:09:23 INFO - PROCESS | 22331 | Cycle 1(1): loaded http://localhost:51785/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51785/tests/kraken/driver.html?testName=ai-astar) 05:09:24 INFO - PROCESS | 22331 | RSS: Main: 275357696 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | __start_tp_report 05:09:24 INFO - PROCESS | 22331 | _x_x_mozilla_page_load 05:09:24 INFO - PROCESS | 22331 | _x_x_mozilla_page_load_details 05:09:24 INFO - PROCESS | 22331 | |i|pagename|runs| 05:09:24 INFO - PROCESS | 22331 | |0;ai-astar;109;109;111;112;109;111;106;110;109;110 05:09:24 INFO - PROCESS | 22331 | |1;audio-beat-detection;161;127;157;174;124;149;160;127;190;127 05:09:24 INFO - PROCESS | 22331 | |2;audio-dft;160;161;159;159;162;160;161;161;161;159 05:09:24 INFO - PROCESS | 22331 | |3;audio-fft;74;76;74;173;76;76;77;76;170;76 05:09:24 INFO - PROCESS | 22331 | |4;audio-oscillator;92;92;146;93;92;92;153;92;92;152 05:09:24 INFO - PROCESS | 22331 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 05:09:24 INFO - PROCESS | 22331 | |6;imaging-darkroom;146;146;146;146;146;144;146;146;146;145 05:09:24 INFO - PROCESS | 22331 | |7;imaging-desaturate;94;94;95;94;95;94;94;94;95;95 05:09:24 INFO - PROCESS | 22331 | |8;json-parse-financial;54;56;54;55;55;55;57;73;53;53 05:09:24 INFO - PROCESS | 22331 | |9;json-stringify-tinderbox;59;61;59;59;60;59;58;61;58;59 05:09:24 INFO - PROCESS | 22331 | |10;stanford-crypto-aes;73;73;72;73;76;75;74;74;74;73 05:09:24 INFO - PROCESS | 22331 | |11;stanford-crypto-ccm;117;123;113;116;112;112;111;112;137;126 05:09:24 INFO - PROCESS | 22331 | |12;stanford-crypto-pbkdf2;162;158;161;161;160;166;162;157;160;159 05:09:24 INFO - PROCESS | 22331 | |13;stanford-crypto-sha256-iterative;65;65;66;66;66;65;66;65;66;66 05:09:24 INFO - PROCESS | 22331 | __end_tp_report 05:09:24 INFO - PROCESS | 22331 | __start_cc_report 05:09:24 INFO - PROCESS | 22331 | _x_x_mozilla_cycle_collect,1582 05:09:24 INFO - PROCESS | 22331 | __end_cc_report 05:09:24 INFO - PROCESS | 22331 | __startTimestamp1462968564172__endTimestamp 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | ------- Summary: start ------- 05:09:24 INFO - PROCESS | 22331 | Number of tests: 14 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 05:09:24 INFO - PROCESS | 22331 | Values: 109.0 109.0 111.0 112.0 109.0 111.0 106.0 110.0 109.0 110.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:158.50 stddev:22.87 (14.4%) stddev-sans-first:23.89 05:09:24 INFO - PROCESS | 22331 | Values: 161.0 127.0 157.0 174.0 124.0 149.0 160.0 127.0 190.0 127.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 05:09:24 INFO - PROCESS | 22331 | Values: 160.0 161.0 159.0 159.0 162.0 160.0 161.0 161.0 161.0 159.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:40.44 (53.2%) stddev-sans-first:42.19 05:09:24 INFO - PROCESS | 22331 | Values: 74.0 76.0 74.0 173.0 76.0 76.0 77.0 76.0 170.0 76.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:28.17 (30.6%) stddev-sans-first:29.15 05:09:24 INFO - PROCESS | 22331 | Values: 92.0 92.0 146.0 93.0 92.0 92.0 153.0 92.0 92.0 152.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:09:24 INFO - PROCESS | 22331 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:09:24 INFO - PROCESS | 22331 | Values: 146.0 146.0 146.0 146.0 146.0 144.0 146.0 146.0 146.0 145.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:09:24 INFO - PROCESS | 22331 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:5.93 (10.8%) stddev-sans-first:6.22 05:09:24 INFO - PROCESS | 22331 | Values: 54.0 56.0 54.0 55.0 55.0 55.0 57.0 73.0 53.0 53.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:1.06 (1.8%) stddev-sans-first:1.12 05:09:24 INFO - PROCESS | 22331 | Values: 59.0 61.0 59.0 59.0 60.0 59.0 58.0 61.0 58.0 59.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 05:09:24 INFO - PROCESS | 22331 | Values: 73.0 73.0 72.0 73.0 76.0 75.0 74.0 74.0 74.0 73.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:116.50 stddev:8.41 (7.2%) stddev-sans-first:8.92 05:09:24 INFO - PROCESS | 22331 | Values: 117.0 123.0 113.0 116.0 112.0 112.0 111.0 112.0 137.0 126.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.50 (1.6%) stddev-sans-first:2.60 05:09:24 INFO - PROCESS | 22331 | Values: 162.0 158.0 161.0 161.0 160.0 166.0 162.0 157.0 160.0 159.0 05:09:24 INFO - PROCESS | 22331 | 05:09:24 INFO - PROCESS | 22331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:09:24 INFO - PROCESS | 22331 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 05:09:24 INFO - PROCESS | 22331 | -------- Summary: end -------- 05:09:24 INFO - PROCESS | 22331 | 05:09:25 INFO - TEST-INFO | 22331: exit 0 05:09:25 INFO - TEST-OK | kraken | took 59847ms 05:09:25 INFO - SUITE-END | took 1171s 05:09:25 INFO - Completed test suite (00:19:31) 05:09:25 INFO - javascript benchmark 05:09:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.9672303276966, 3371.9662803371975, 3373.1061268763774, 3390.457526795713, 3413.2661477782285, 5549.972250138749, 5560.805371811983, 5573.136163894603, 5611.887762244753, 5612.41069687683, 5550.639208451458, 5583.302087239095, 5601.439856014396, 5605.971970140154, 5645.520130788877, 4904.141775189328, 4967.726775027372, 5035.974820125894, 5113.207452844815, 5129.307543481638, 4895.755212239392, 4977.477364876672, 4980.053789779949, 4980.103581355354, 4982.800687972477, 4990.575801056914, 4997.225430058346, 5051.242313652963, 5077.263796749469, 5078.898422031557, 5048.394192696863, 5056.216286475602, 5084.084864724348, 5090.211017292326, 5109.795608175687, 4859.271109333593, 4908.901821963576, 4910.1898186799135, 4988.201887697987, 5003.224500202475, 5299.8410047698635, 5354.14333706609, 5398.838034858961, 5401.918971215435, 5422.728863556807, 5839.153322768175, 5889.734961926681, 5899.970500147472, 5900.085486749561, 5951.553633477506, 5846.41535846412, 5962.940370596282, 6003.7898673546215, 6022.969885150546, 6032.185654936571, 5534.833954981357, 5555.416681248492, 5569.582281328917, 5626.9437305626825, 5638.6052976292085, 5860.3260625027815, 6128.846778830565, 6142.170806941095, 6144.293406258337, 6148.631082135086, 5847.38602446737, 5888.558358123158, 5903.675297858573, 5906.084556893688, 5915.704214789243, 5959.582829201914, 5965.821025369246, 5968.343482216953, 5968.432998865101, 5978.491828194652, 5817.185594016841, 5817.331006934257, 5931.406859314034, 5932.228810254725, 5941.287045554561, 5844.766209351664, 5852.912206316909, 5857.531397488191, 5860.970695146497, 5897.351291357947, 4486.887827804331, 4490.977545112319, 4493.6854420190275, 4501.144782491317, 4516.0, 4001.15975645112, 4006.2988976928923, 4033.9193216135513, 4053.2096241232675, 4065.3698676705158, 5594.86012849682, 5610.579206559442, 5614.129809879475, 5614.242077319591, 5649.887002260014, 5889.617174883619, 5895.911561326584, 5899.115132730125, 5900.64596124234, 5916.437938395846, 5448.782048718007, 5624.746886390122, 5638.492535671728, 5687.203791469197, 5698.914516282259, 4859.392575928009, 4878.634102442331, 4882.853514394574, 4893.510648935078, 4915.0415668944215, 6079.240094988127, 6081.75672973085, 6083.026715725463, 6085.847853803691, 6093.573449858467, 5795.565332599987, 5979.820605381846, 6022.668753218615, 6024.819255422344, 6044.184035155197, 6092.695365231632, 6096.542759292982, 6096.573239873166, 6097.2683278006925, 6102.938970610237, 5738.053221218453, 5803.042497987784, 5809.157672137601, 5812.854678632899, 5825.242718446575, 5967.164596956516, 6001.189839371629, 6007.068904319837, 6008.789692360747, 6037.15479832815, 5838.211841401527, 5842.795502157404, 5843.2695913010875, 5843.620164689281, 5845.3277873045145, 5656.943430565641, 5759.827205183851, 5815.5929084963645, 5819.621724587888, 5819.76720931158, 5726.4273572642405, 5733.397993210653, 5759.193712880116, 5767.625104368202, 5794.594378393472, 5855.268091488564, 5860.150278209721, 5868.823935281948, 5877.089051197071, 5883.882322353615, 5593.9440605595055, 5646.322441307069, 5721.141828725725, 5730.0, 5762.683052432157], "value": 5460.944663081779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.9392554670079, 676.3000294694991, 678.6776281266395, 737.4174402222245, 753.581762122022, 32297.19257018573, 39022.41466378003, 39125.217495650104, 39547.60452395475, 39604.60395396045, 42028.0, 42550.14899702012, 42577.14845703084, 42585.148297034044, 42648.0, 8003.199680031979, 8579.91420085799, 8780.780480487974, 8786.0, 10422.63520776773, 10460.633877814278, 10593.947030264839, 10597.152227821794, 10598.841017384746, 10602.310849794778, 10592.470376481184, 10647.680569582886, 10652.360858348524, 10664.62673806417, 10674.679759607185, 8258.958705206436, 10526.42104684242, 10572.365658060502, 10585.417802020886, 10763.677089687322, 10597.62908298206, 10715.571377144905, 10716.089132423753, 10722.0, 10730.0, 40441.79779101115, 40809.387859182134, 40820.0, 40899.7955010226, 40921.38617920734, 3806.6764325032404, 3914.197589494147, 3987.5613682494904, 4144.5233798113, 4392.099619577979, 33948.83025584881, 34631.480527792104, 34650.0, 34683.6531634683, 34713.652863471296, 4523.977380113111, 4556.794944227485, 4637.420322459692, 4649.279361698942, 4669.696469729491, 339918.0, 343718.0, 343796.9999999975, 344158.0, 344639.0, 42886.0, 69451.0, 70935.64532177306, 70967.29032709607, 70987.29012709807, 41608.0, 41886.79056604698, 41983.370249446285, 41984.16031679411, 42035.36946945798, 16229.431969881234, 16355.83644163543, 16422.507324780276, 16442.177891105395, 16467.094309812837, 13235.073544851768, 13656.726865462833, 13863.584092477242, 13892.16647001183, 13895.444182232597, 9535.952320238355, 9572.664956726481, 9638.710838674851, 9683.564239609235, 9711.465869377253, 3651.744377893522, 3734.57052438973, 3751.456038874348, 3790.9431358529646, 3800.3729384651774, 1115.0243536905207, 1164.9941750291364, 1198.7063169523349, 1241.714405686697, 1285.0233822295122, 33291.66708332934, 33816.32367352688, 33899.661003390145, 34218.0, 35027.12432189165, 1229.434460148324, 1252.0859772366223, 1282.294737894173, 1318.136620513565, 1321.4846209978116, 17961.461156165336, 18629.674402805522, 19545.609087818164, 19620.509487262934, 19754.60490790176, 538228.0, 545000.0, 548255.0, 549025.0, 549656.0, 64350.0, 65059.0, 65143.34856651373, 65559.34440655628, 65692.34307656958, 1443.4803470750521, 1451.042312074026, 1522.3834347089446, 1526.0, 1567.6061327226655, 30746.231344216572, 32805.0, 32940.67059329376, 33931.0, 34077.0, 53337.19994200012, 53891.0, 53925.73037134789, 53935.73032134814, 54066.0, 383481.0, 384674.0, 385008.0, 387952.0, 388747.0, 27775.0, 30715.2321191972, 31014.379712406077, 31367.0, 31755.0, 48311.27533087077, 48701.512984869696, 48882.26676599925, 49211.261831071846, 49375.50624493709, 37040.444393333586, 40138.79930600328, 40265.59734402619, 40329.0, 40527.0, 39298.80350598229, 40675.1864962705, 41321.0, 41409.0, 41499.0, 40824.0, 41612.79193604013, 41782.79108604437, 42282.36576451294, 42976.35535466908, 34872.0, 35907.0, 36046.0, 36829.815850920575, 36842.63157368392, 27777.0, 27864.442711146068, 28201.57697634496, 28224.85887570549, 28318.575221371284], "value": 20166.052714180794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.82059342405785, 397.1401914854339, 398.95212574491063, 403.9333509970855, 411.8290909272652, 15863.286152123153, 16816.74774878378, 18980.0, 19546.902265488672, 19566.90216548915, 15572.6763225126, 18765.906170469163, 19428.805711942878, 20250.797492025074, 20469.38591842247, 5534.08687566551, 5619.719014049301, 5644.74598643062, 5653.9151912721345, 5688.488036076752, 4180.916381672365, 5663.405342439047, 5970.1940238067955, 6224.502039836802, 6224.719887605046, 6142.140100385949, 6142.508599312045, 6157.353477884825, 6173.259208894939, 6192.0, 6034.487068599153, 6057.30341010785, 6060.818175454721, 6062.42406971337, 6208.348123447018, 5483.75323110461, 5488.25908502355, 5492.890142197173, 5495.065838807413, 5495.313085864267, 22510.549789004293, 22519.324420267418, 23350.883245583835, 23424.882875585514, 23443.296701098996, 2565.102214225025, 2599.181257903754, 2611.569091099966, 2614.9215523534326, 2780.4439112177647, 14583.854161458356, 14660.0, 14689.0, 14854.0, 15092.320845561977, 1996.1516355548833, 2029.0, 2058.783827698085, 2089.2896415218747, 2098.6012657595006, 80612.89147669708, 81975.590122049, 82010.58994705048, 82878.0, 83700.16299837045, 9959.302848800515, 10097.798044039226, 10107.69676909694, 10539.314944528734, 10687.679369618923, 14283.143011419348, 14389.208593527248, 14393.208373539346, 14400.639984000483, 14415.063020903608, 7954.284114429729, 8105.230003149809, 8109.716159934492, 8128.512289262663, 8172.6730930762105, 7519.248075192437, 7818.843623127619, 8204.8359032819, 8550.27322677567, 8840.178487413259, 6339.703354255761, 6349.2698339690605, 6357.8728425432155, 6648.16897887764, 6716.899246511306, 1872.8408085312901, 1909.9140538675515, 1927.38323736403, 1946.3771593090075, 1951.756030496188, 1034.1674951663983, 1071.2233630617895, 1100.6037826382496, 1121.8373335866254, 1193.1826698711411, 17938.730919036225, 18041.909790450965, 18446.813786263327, 18705.532361690795, 19908.90045549792, 1056.5984925728173, 1129.717570607348, 1179.9056075513938, 1198.43074539593, 1254.4507533196677, 10189.0, 10343.4311112888, 10471.528781204865, 10487.265891387682, 10561.788764224673, 516128.0, 529095.0, 536185.0, 539729.0, 548163.0, 95832.52083739536, 96906.51546742221, 99104.5044774786, 100443.0, 102570.0, 1159.8724140344555, 1161.5876363890866, 1170.5551890281808, 1177.0054304113182, 1179.722765150189, 16467.917660411622, 16671.666566668842, 16923.407680731114, 16974.151292435577, 17068.061256631005, 40067.59932400638, 40244.79877600593, 40444.1911161781, 40763.79618101891, 41209.0, 60957.0, 61730.69134654298, 61814.69092654508, 62341.37658623356, 62371.0, 8153.388495862715, 8516.829663406821, 8580.099089595502, 8619.65521379163, 8656.091110433314, 7859.803504912423, 9956.601735930482, 12225.410696609384, 12278.693032674255, 12888.355582221038, 12174.208676436003, 12273.0, 12330.136890417585, 12464.875351246372, 12670.176438531465, 11307.830382544103, 11840.052795776144, 12130.33283169434, 12379.381030948596, 12642.30467324306, 12176.452059657513, 12327.630171094881, 12332.568360107352, 12510.687232819253, 12682.87317126817, 8287.709930152416, 8611.95694021526, 8799.384043116921, 8878.644854205759, 8997.865032024394, 11767.23512971654, 11874.703132421759, 12261.816072758736, 12304.630861074182, 12402.069844761498], "value": 9561.495141127616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.0, 1589.5549246211062, 1604.7432410814267, 1851.2965073272155, 1932.9130189141488, 8050.355971522279, 8181.181881811815, 8185.222403871638, 8195.098539160696, 8204.712835050774, 7769.300762931335, 7914.2481464260945, 7929.207079292068, 7930.7620771376805, 7934.047914250298, 2012.617602655498, 2295.391721193885, 2320.9883950580224, 2336.6495025746103, 2398.772116648924, 2373.0389192377115, 2374.382660508272, 2383.4398916254668, 2395.197608801054, 2396.3290278721984, 2287.176616418088, 2357.8113750899975, 2368.7275963264187, 2371.2293504610984, 2372.881355932205, 1998.7301714268606, 2292.5758734634064, 2339.263132113379, 2339.7894189523026, 2344.23812261015, 2286.3941055620276, 2288.8168946484243, 2295.1622657729977, 2297.655351697242, 2366.8461549999197, 8318.958405207935, 8371.0, 8372.665093396257, 8379.664813407457, 8382.07797142314, 4936.420345489445, 5129.05112554175, 5137.871553211162, 5142.74286285688, 5175.456577059392, 3331.68349006844, 3340.2484441000825, 3390.610079840825, 3413.300273443938, 3455.5335029771163, 1071.12703146935, 1075.4031512510553, 1094.9890501095047, 1111.4776055254017, 1130.2596799096523, 11547.191696581243, 11568.190226684135, 11594.76810463786, 11609.07127429812, 11626.825597616042, 4433.866983990485, 4439.378487011821, 4517.570830771071, 4518.186726389215, 4521.367008618796, 9954.153896918842, 9971.102600765966, 9977.0, 9988.600455981825, 10002.199824014207, 4560.954390456053, 5202.167653175474, 5221.242919776687, 5223.164293712987, 5225.634205605571, 4188.832446702158, 4701.177293973541, 4754.310624959361, 4764.785584648699, 4779.904401911942, 4012.237674841829, 4048.5951404859866, 4058.0463591056077, 4060.7614677523047, 4116.814743336557, 1285.4665313894816, 1301.3103055380664, 1306.1053178572708, 1311.5999620115956, 1315.8486774020919, 931.2922179143764, 1035.9689209323733, 1065.1425602389995, 1083.111848284415, 1088.482970588964, 6025.701809107923, 6059.48494377974, 6075.726592303268, 6083.087536869417, 6192.071189321638, 951.7681037965958, 981.2003217377815, 1031.1544533482472, 1055.8891316411666, 1080.935143891369, 4123.8969025773995, 4132.132252227066, 4142.233686767958, 4145.8963525912095, 4150.501939767248, 10306.690799276033, 10726.624568140078, 10729.785404292026, 10745.570177192982, 10750.78498430027, 10586.258961872594, 10588.10001149911, 10604.522796474177, 10638.68083957467, 10644.520996555173, 7751.418643601753, 8050.516968981763, 8085.5957202140835, 8101.878471822927, 8197.0, 5804.34230889802, 5844.386339434298, 5972.014617588049, 6014.548908831767, 6110.083487476914, 9027.14242146995, 9034.2320902724, 9191.21874640663, 9291.303152263743, 9297.581608827484, 9279.860802087838, 9307.348485605942, 9321.673741419288, 9468.14786669203, 9524.0, 6713.12729345182, 7251.637418129178, 7427.294407031323, 7550.5469671819865, 7713.19011503784, 8226.753197404087, 8249.381296402913, 8259.174082591693, 8267.83464330722, 8316.251537361666, 7247.166575843846, 7311.707531698672, 7518.924810752042, 7618.885716714364, 7646.273604007611, 7101.147862256562, 7143.0, 7179.497435179487, 7246.202917678946, 7411.1477180124975, 6564.934350656432, 6597.406233439014, 6608.603483790988, 6634.436072933661, 6646.501512386493, 4906.141425250496, 5109.591232701449, 5145.305383773292, 5155.510226528474, 5161.81933632321, 5379.704116273642, 5416.431274716098, 5424.81844517644, 5563.415841336601, 5569.443055694398], "value": 4566.879400848071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.4935977116499, 318.9872405103796, 319.58134843355197, 321.63976346491916, 322.1061554187129, 6227.1282020517165, 6230.875382492353, 6234.220722409699, 6255.906161407577, 6284.780032698856, 6156.56904016719, 6172.043333283337, 6213.409726076027, 6243.594166379194, 6245.531585131122, 4378.0, 4527.569880861313, 4643.628509719231, 4660.4174478190225, 4660.627149828023, 4617.699849509788, 4642.396488456496, 4651.465081515618, 4654.604358629521, 4655.4180727409075, 4407.382966384709, 4606.838760643378, 4616.0, 4616.8153273869175, 4621.353010578522, 4492.775361231958, 4501.7974191161475, 4600.631949444037, 4617.376654151713, 4620.330052142421, 4006.4791577094793, 4017.578154293786, 4022.4770779798437, 4029.254587901218, 4038.474998250238, 5989.670568118795, 5995.430434108753, 5996.880062398771, 6000.399960004008, 6012.879742405127, 5410.242566040757, 5416.539594134503, 5419.701916394597, 5435.755391007414, 5436.157395603648, 6582.17722784652, 6584.86830263392, 6594.604323740591, 6599.307072757388, 6601.075849381091, 4260.744355338689, 4393.692441529094, 4404.4934832494355, 4406.1187762447635, 4407.515173330931, 6793.252742198354, 6899.586024838475, 6909.550879192836, 6913.20498142715, 6915.75794847183, 4463.218936686132, 4463.330500424962, 4474.306482495218, 4475.977620111944, 4480.0, 4512.661550383735, 4512.909741805145, 4513.729176249435, 4519.932201016922, 4520.050789334211, 5345.33183352081, 5348.224507446398, 5351.57187425005, 5354.544863686552, 5361.437049109865, 6501.642409667514, 6648.803215421174, 6673.899891501631, 6681.398674119353, 6693.497987650946, 1556.4785796757985, 1559.376249500209, 1571.8899677022498, 1572.5675439254296, 1573.6931298396703, 942.3356533643902, 966.9073946440477, 1000.8398656215116, 1002.6791426743372, 1003.6236411345745, 6374.0, 6397.232332120176, 6411.942029565163, 6419.775307864203, 6420.0, 6784.321567843176, 6840.828979275459, 6861.005154252605, 6873.20958089816, 6901.068355772007, 6426.260979987268, 6429.517786166056, 6433.1636887205295, 6434.485241180694, 6442.774502892376, 3626.165981824195, 3658.506101676293, 3661.0847288177956, 3663.46879702447, 3665.52348194733, 6909.827254318682, 7002.159740831133, 7047.119110111236, 7066.787996360117, 7069.646517674199, 6882.139732533434, 6888.655567221619, 6891.827704307332, 6898.965505172442, 6926.376626103674, 7041.929580704127, 7044.084269045094, 7044.542104763174, 7048.365647091787, 7049.259827718119, 6765.594064356154, 6766.8646627068165, 6774.356436138559, 6776.254611992776, 6786.3892249697765, 6572.4084832363405, 6694.263631000684, 6822.829429264308, 6835.897461537981, 6846.246912839683, 7183.102112235971, 7193.100862392201, 7196.316349946746, 7208.639568021473, 7212.278772122956, 4467.329900514948, 4499.955000449953, 4500.3249512573375, 4504.684672073055, 4508.887277817949, 6892.345227203407, 6897.137857767779, 6901.723931042702, 6902.413294869993, 6904.171499420102, 6525.477961762953, 6745.730170793114, 6747.392734653905, 6749.055132281386, 6779.830504237433, 6700.162479690039, 6713.429358504582, 6718.361755633207, 6719.227288861844, 6733.225679046972, 6613.10723052401, 6623.072769812134, 6623.304553022056, 6627.701753421011, 6637.070810086689, 6773.119494465688, 6785.457163427012, 6786.321367863175, 6789.72841086351, 6792.0830687856505, 6459.580127291711, 6586.901196482152, 6587.835304117244, 6592.967035164794, 6609.0], "value": 4910.445232886577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.9770505737358, 919.2829592917523, 925.8611208318754, 942.4863449420066, 956.5312996631649, 14106.57680269591, 14107.294635268234, 14183.149011059319, 14202.07686500378, 14641.633959151026, 13214.339283035833, 13281.867181328184, 13285.33573321335, 13298.069135160542, 13312.800307995363, 737.2774680812806, 906.112010229975, 926.9304802139867, 927.5176908007832, 931.4318265857821, 919.9356045076847, 925.791696868206, 928.2944961829024, 928.8049509602992, 929.7396728915915, 969.05517120807, 982.0326977926736, 985.2167526816163, 985.3348989432141, 986.3292960786662, 786.8072322281021, 961.7114865540345, 978.0512902484578, 981.1464026297095, 981.3817295104075, 715.6922523314972, 719.237608135373, 720.0135813934891, 721.5129787393488, 721.6103304215717, 14063.789043164361, 14193.07744996572, 14265.57203283903, 14271.928640356835, 14280.857191428056, 13702.38339274735, 14094.083884547472, 14197.716045679132, 14211.289435528286, 14423.711525769531, 12023.338716370596, 12069.879301207051, 12223.511059557606, 12294.877051229463, 12385.690357741038, 3802.6007269236884, 3858.2862170498547, 3868.6905047596124, 3892.2410130024655, 3902.2975864344407, 57780.422195778345, 57856.0, 58121.41878581202, 58982.41017589855, 59561.0, 11606.366864492958, 11634.127440442, 11692.857749214787, 11795.469203885847, 12055.035597152208, 20305.593888122155, 20390.388288351372, 20572.897135514526, 20595.58808823815, 20611.58776824485, 7809.726659566888, 7869.724559640385, 8043.839123217503, 8675.91324086751, 8827.955860220787, 4877.878053048702, 4981.750912454435, 5009.5491405773655, 5073.720945347967, 5234.92147617786, 3464.72282217422, 3501.3172431375638, 3507.0881570791776, 3511.0169152637304, 3515.789052656849, 536.9650972686841, 610.71906922816, 618.9907151392732, 651.4755621724557, 654.2802916791492, 668.759246671198, 706.3642721550646, 747.7644541969262, 755.1994885421361, 787.016717870962, 9083.36416450842, 9436.811263774685, 9508.90491095094, 9570.760730981641, 9683.951580242054, 636.38270877249, 699.9580025198504, 708.5783958544657, 711.3100292716057, 743.7805847275067, 4344.782760861945, 4458.197524445631, 4657.464391594942, 4682.461516925529, 4706.647001474903, 67906.32093679, 68217.31782682109, 68258.31741682619, 68610.3138968614, 68610.65694671495, 56018.439815602134, 58456.0, 58724.706376467846, 59232.70383648054, 59478.40521594815, 51735.74132129315, 52202.0, 53339.19991200058, 53449.73275133599, 53935.190972135446, 9275.76810579741, 9297.349185556946, 9325.626974921199, 9336.906630933603, 9435.811283774423, 38919.22161556697, 39415.40876886906, 40098.79950600228, 40318.79840600778, 40377.79811100926, 44825.0, 49752.25371619501, 50313.0, 50444.74777626088, 51612.48387516077, 11709.355985420543, 11749.0, 11940.880591193976, 11952.223105498115, 12326.568570100004, 12457.626271211879, 12697.87302127004, 12875.291858947849, 12993.870061299265, 13003.934980325037, 11943.641690749291, 12214.75570488603, 12223.816642750187, 12272.325022123869, 12364.134510584172, 11158.776824463628, 11657.300561966309, 13411.463541458232, 13617.31913404306, 13946.58160255194, 12268.141230113806, 12824.487020519075, 13089.541866035024, 13198.14212076212, 13402.262875541548, 9761.463119528495, 10160.288779785344, 11158.163137764863, 11255.943720281673, 11516.712082198012, 10632.0, 11255.437228138397, 11321.490532925873, 11392.316461012366, 11632.12759043092], "value": 7065.011274937535, "unit": "score"}], "name": "dromaeo_css", "value": 7419.6714386698795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 111.0, 112.0, 109.0, 111.0, 106.0, 110.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 157.0, 174.0, 124.0, 149.0, 160.0, 127.0, 190.0, 127.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 159.0, 162.0, 160.0, 161.0, 161.0, 161.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 173.0, 76.0, 76.0, 77.0, 76.0, 170.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 93.0, 92.0, 92.0, 153.0, 92.0, 92.0, 152.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 144.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 55.0, 55.0, 57.0, 73.0, 53.0, 53.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 59.0, 58.0, 61.0, 58.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 76.0, 75.0, 74.0, 74.0, 74.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 123.0, 113.0, 116.0, 112.0, 112.0, 111.0, 112.0, 137.0, 126.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 161.0, 161.0, 160.0, 166.0, 162.0, 157.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1514.3999999999996, "alertThreshold": 2.0}]} 05:09:25 INFO - Return code: 0 05:09:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:09:25 ERROR - # TBPL SUCCESS # 05:09:25 INFO - Running post-action listener: _resource_record_post_action 05:09:25 INFO - Running post-run listener: _resource_record_post_run 05:09:26 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500260864; Read time: 12; Write time: 316096 05:09:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 248832000; Read time: 0; Write time: 200800 05:09:26 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251428864; Read time: 12; Write time: 115296 05:09:26 INFO - Running post-run listener: _upload_blobber_files 05:09:26 INFO - Blob upload gear active. 05:09:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:26 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:09:26 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:09:26 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:09:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:09:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:27 INFO - (blobuploader) - INFO - Done attempting. 05:09:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:28 INFO - (blobuploader) - INFO - Done attempting. 05:09:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:28 INFO - Return code: 0 05:09:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c209b9c5019f3d401d9a485b12c95adf4179e0a32e29e4995ad54dd8813ca1e8e65daecb789f541dd4fb7e431026d5506799c56482fe7df0836014674fb4c99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88424f668e5d5f0032e19525d3fa8e7a0aae1ccc20b85ba2e5d732c68c7a78c007c9e9cbcc6c73fb02393970520a13491c9a28b330017a0543655bf74a4f6cc9"} 05:09:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:28 INFO - Contents: 05:09:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c209b9c5019f3d401d9a485b12c95adf4179e0a32e29e4995ad54dd8813ca1e8e65daecb789f541dd4fb7e431026d5506799c56482fe7df0836014674fb4c99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88424f668e5d5f0032e19525d3fa8e7a0aae1ccc20b85ba2e5d732c68c7a78c007c9e9cbcc6c73fb02393970520a13491c9a28b330017a0543655bf74a4f6cc9"} 05:09:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:28 INFO - Copying logs to upload dir... 05:09:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.483473 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-11 05:09:28.671209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 05:09:28.676896) ========= 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=00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069 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/0c209b9c5019f3d401d9a485b12c95adf4179e0a32e29e4995ad54dd8813ca1e8e65daecb789f541dd4fb7e431026d5506799c56482fe7df0836014674fb4c99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88424f668e5d5f0032e19525d3fa8e7a0aae1ccc20b85ba2e5d732c68c7a78c007c9e9cbcc6c73fb02393970520a13491c9a28b330017a0543655bf74a4f6cc9"} build_url:https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/COE0lbfsS7iQnyf0jkVxuQ/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/0c209b9c5019f3d401d9a485b12c95adf4179e0a32e29e4995ad54dd8813ca1e8e65daecb789f541dd4fb7e431026d5506799c56482fe7df0836014674fb4c99", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88424f668e5d5f0032e19525d3fa8e7a0aae1ccc20b85ba2e5d732c68c7a78c007c9e9cbcc6c73fb02393970520a13491c9a28b330017a0543655bf74a4f6cc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 05:09:28.709727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 05:09:28.710133) ========= 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=00204705a9daa57ed339a427000001b9-1462967341.124930-1732890069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 1.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 05:09:30.080076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 05:09:30.080410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 05:09:30.085597) ========= ========= Total master_lag: 1.60 =========