builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1462889288.95 results: success (0) buildid: 20160510043041 builduid: df7528089a5e4323a34864d63c8f5534 revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.954427) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.955099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.955635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.998502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.998843) ========= 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=232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 07:08:09-- 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% 223M=0s 2016-05-10 07:08:09 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149198 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.174614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.174933) ========= 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=232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.090620 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.277133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.277926) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --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=232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 07:08:09,363 truncating revision to first 12 chars 2016-05-10 07:08:09,363 Setting DEBUG logging. 2016-05-10 07:08:09,363 attempt 1/10 2016-05-10 07:08:09,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1579b9e2e50f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 07:08:09,630 unpacking tar archive at: mozilla-central-1579b9e2e50f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.861030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.861397) ========= script_repo_revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.861873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.862214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.873299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-10 07:08:09.873629) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:10 INFO - MultiFileLogger online at 20160510 07:08:10 in /builds/slave/test 07:08:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:08:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:10 INFO - {'append_to_log': False, 07:08:10 INFO - 'base_work_dir': '/builds/slave/test', 07:08:10 INFO - 'blob_upload_branch': 'Firefox', 07:08:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:10 INFO - 'branch': 'Firefox', 07:08:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:10 INFO - 'config_files': ('talos/linux_config.py',), 07:08:10 INFO - 'default_actions': ('clobber', 07:08:10 INFO - 'read-buildbot-config', 07:08:10 INFO - 'download-and-extract', 07:08:10 INFO - 'populate-webroot', 07:08:10 INFO - 'create-virtualenv', 07:08:10 INFO - 'install', 07:08:10 INFO - 'run-tests'), 07:08:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:10 INFO - 'download_minidump_stackwalk': True, 07:08:10 INFO - 'download_symbols': 'ondemand', 07:08:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:10 INFO - 'installer_path': 'installer.exe', 07:08:10 INFO - 'log_level': 'info', 07:08:10 INFO - 'log_name': 'talos', 07:08:10 INFO - 'log_to_console': True, 07:08:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:10 INFO - 'opt_config_files': (), 07:08:10 INFO - 'pip_index': False, 07:08:10 INFO - 'sps_profile': False, 07:08:10 INFO - 'sps_profile_interval': 0, 07:08:10 INFO - 'suite': 'dromaeojs', 07:08:10 INFO - 'system_bits': '32', 07:08:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:10 INFO - 'title': 'talos-linux64-ix-025', 07:08:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:10 INFO - 'use_talos_json': True, 07:08:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:10 INFO - 'work_dir': 'build'} 07:08:10 INFO - ##### 07:08:10 INFO - ##### Running clobber step. 07:08:10 INFO - ##### 07:08:10 INFO - Running pre-action listener: _resource_record_pre_action 07:08:10 INFO - Running main action method: clobber 07:08:10 INFO - rmtree: /builds/slave/test/build 07:08:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:11 INFO - Running post-action listener: _resource_record_post_action 07:08:11 INFO - ##### 07:08:11 INFO - ##### Finished clobber step (success) 07:08:11 INFO - ##### 07:08:11 INFO - ##### 07:08:11 INFO - ##### Running read-buildbot-config step. 07:08:11 INFO - ##### 07:08:11 INFO - Running pre-action listener: _resource_record_pre_action 07:08:11 INFO - Running main action method: read_buildbot_config 07:08:11 INFO - Using buildbot properties: 07:08:11 INFO - { 07:08:11 INFO - "project": "", 07:08:11 INFO - "product": "firefox", 07:08:11 INFO - "script_repo_revision": "production", 07:08:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:08:11 INFO - "repository": "", 07:08:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:08:11 INFO - "buildid": "20160510043041", 07:08:11 INFO - "pgo_build": "True", 07:08:11 INFO - "basedir": "/builds/slave/test", 07:08:11 INFO - "buildnumber": 280, 07:08:11 INFO - "slavename": "talos-linux64-ix-025", 07:08:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:08:11 INFO - "platform": "ubuntu64_hw", 07:08:11 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:11 INFO - "branch": "mozilla-central", 07:08:11 INFO - "repo_path": "mozilla-central", 07:08:11 INFO - "revision": "1579b9e2e50f3a27ad02d58cc9170c91e0973fec", 07:08:11 INFO - "stage_platform": "linux64-pgo", 07:08:11 INFO - "builduid": "df7528089a5e4323a34864d63c8f5534", 07:08:11 INFO - "slavebuilddir": "test" 07:08:11 INFO - } 07:08:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:08:11 INFO - Running post-action listener: _resource_record_post_action 07:08:11 INFO - ##### 07:08:11 INFO - ##### Finished read-buildbot-config step (success) 07:08:11 INFO - ##### 07:08:11 INFO - ##### 07:08:11 INFO - ##### Running download-and-extract step. 07:08:11 INFO - ##### 07:08:11 INFO - Running pre-action listener: _resource_record_pre_action 07:08:11 INFO - Running main action method: download_and_extract 07:08:11 INFO - mkdir: /builds/slave/test/build/tests 07:08:11 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')]} 07:08:11 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:08:14 INFO - Downloaded 1361 bytes. 07:08:14 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:14 INFO - Using the following test package requirements: 07:08:14 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:14 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:14 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:14 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'jsshell-linux-x86_64.zip'], 07:08:14 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:14 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:14 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:14 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:14 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:14 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:14 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')]} 07:08:14 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:20 INFO - Downloaded 23898987 bytes. 07:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:22 INFO - Return code: 0 07:08:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:08:22 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')]} 07:08:22 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:25 INFO - Downloaded 23898987 bytes. 07:08:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:27 INFO - Return code: 0 07:08: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')]} 07:08:27 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:08:28 INFO - Downloaded 10840152 bytes. 07:08:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:08:28 INFO - Return code: 0 07:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:28 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:08:29 INFO - Downloaded 58344040 bytes. 07:08:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:29 INFO - mkdir: /builds/slave/test/properties 07:08:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:08:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:08:29 INFO - Contents: 07:08:29 INFO - build_url:https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:30 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - Running post-action listener: set_extra_try_arguments 07:08:31 INFO - ##### 07:08:31 INFO - ##### Finished download-and-extract step (success) 07:08:31 INFO - ##### 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running populate-webroot step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: populate_webroot 07:08:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:31 INFO - '--tppagecycles', 07:08:31 INFO - '7'], 07:08:31 INFO - 'tests': ['tsvgm']}}, 07:08:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:08:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:08:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:08:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['damp', 'tps']}, 07:08:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'tests': ['damp', 'tps']}, 07:08:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['dromaeo_dom']}, 07:08:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore', 07:08:31 INFO - 'tabpaint']}, 07:08:31 INFO - 'other-e10s': {'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore', 07:08:31 INFO - 'tabpaint']}, 07:08:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore', 07:08:31 INFO - 'tabpaint']}, 07:08:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore', 07:08:31 INFO - 'tabpaint']}, 07:08:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore', 07:08:31 INFO - 'tabpaint']}, 07:08:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['a11yr', 07:08:31 INFO - 'ts_paint', 07:08:31 INFO - 'tpaint', 07:08:31 INFO - 'sessionrestore', 07:08:31 INFO - 'sessionrestore_no_auto_restore', 07:08:31 INFO - 'tabpaint']}, 07:08:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['tsvgx', 07:08:31 INFO - 'tsvgr_opacity', 07:08:31 INFO - 'tart', 07:08:31 INFO - 'tscrollx', 07:08:31 INFO - 'cart']}, 07:08:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:08:31 INFO - 'tsvgr_opacity', 07:08:31 INFO - 'tart', 07:08:31 INFO - 'tscrollx', 07:08:31 INFO - 'cart']}, 07:08:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--disable-e10s'], 07:08:31 INFO - 'tests': ['tp5o']}, 07:08:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'tests': ['tp5o']}, 07:08:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--disable-e10s', 07:08:31 INFO - '--xperf_path', 07:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:31 INFO - 'tests': ['tp5n']}, 07:08:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:31 INFO - 'talos_options': ['--xperf_path', 07:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:31 INFO - 'tests': ['tp5n']}}, 07:08:31 INFO - 'talos.zip': {'path': '', 07:08:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:31 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - ##### 07:08:31 INFO - ##### Finished populate-webroot step (success) 07:08:31 INFO - ##### 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running create-virtualenv step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: create_virtualenv 07:08:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:08:31 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 07:08:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:31 INFO - Using real prefix '/usr' 07:08:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:08:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:34 INFO - Installing pip.................done. 07:08:34 INFO - Return code: 0 07:08:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08: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', 'pip>=1.5'] in /builds/slave/test/build 07:08: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 pip>=1.5 07:08:34 INFO - Using env: {'DISPLAY': ':0', 07:08:34 INFO - 'HOME': '/home/cltbld', 07:08:34 INFO - 'LANG': 'en_US.UTF-8', 07:08:34 INFO - 'LANGUAGE': 'en_US:en', 07:08:34 INFO - 'LOGNAME': 'cltbld', 07:08:34 INFO - 'MAIL': '/var/mail/cltbld', 07:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:34 INFO - 'MOZ_NO_REMOTE': '1', 07:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:34 INFO - 'NO_EM_RESTART': '1', 07:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:34 INFO - 'PWD': '/builds/slave/test', 07:08:34 INFO - 'SHELL': '/bin/bash', 07:08:34 INFO - 'SHLVL': '1', 07:08:34 INFO - 'TERM': 'linux', 07:08:34 INFO - 'TMOUT': '86400', 07:08:34 INFO - 'USER': 'cltbld', 07:08:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:34 INFO - '_': '/tools/buildbot/bin/python'} 07:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:34 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 07:08:34 INFO - Cleaning up... 07:08:34 INFO - Return code: 0 07:08:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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', '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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:08: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 psutil>=0.7.1 07:08:34 INFO - Using env: {'DISPLAY': ':0', 07:08:34 INFO - 'HOME': '/home/cltbld', 07:08:34 INFO - 'LANG': 'en_US.UTF-8', 07:08:34 INFO - 'LANGUAGE': 'en_US:en', 07:08:34 INFO - 'LOGNAME': 'cltbld', 07:08:34 INFO - 'MAIL': '/var/mail/cltbld', 07:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:34 INFO - 'MOZ_NO_REMOTE': '1', 07:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:34 INFO - 'NO_EM_RESTART': '1', 07:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:34 INFO - 'PWD': '/builds/slave/test', 07:08:34 INFO - 'SHELL': '/bin/bash', 07:08:34 INFO - 'SHLVL': '1', 07:08:34 INFO - 'TERM': 'linux', 07:08:34 INFO - 'TMOUT': '86400', 07:08:34 INFO - 'USER': 'cltbld', 07:08:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:34 INFO - '_': '/tools/buildbot/bin/python'} 07:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:35 INFO - Downloading/unpacking psutil>=0.7.1 07:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:37 INFO - Installing collected packages: psutil 07:08:37 INFO - Running setup.py install for psutil 07:08:37 INFO - building 'psutil._psutil_linux' extension 07:08:37 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 07:08:39 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 07:08:39 INFO - building 'psutil._psutil_posix' extension 07:08:39 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 07:08:39 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 07:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:39 INFO - Successfully installed psutil 07:08:39 INFO - Cleaning up... 07:08:39 INFO - Return code: 0 07:08:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:08:39 INFO - Using env: {'DISPLAY': ':0', 07:08:39 INFO - 'HOME': '/home/cltbld', 07:08:39 INFO - 'LANG': 'en_US.UTF-8', 07:08:39 INFO - 'LANGUAGE': 'en_US:en', 07:08:39 INFO - 'LOGNAME': 'cltbld', 07:08:39 INFO - 'MAIL': '/var/mail/cltbld', 07:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:39 INFO - 'MOZ_NO_REMOTE': '1', 07:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:39 INFO - 'NO_EM_RESTART': '1', 07:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:39 INFO - 'PWD': '/builds/slave/test', 07:08:39 INFO - 'SHELL': '/bin/bash', 07:08:39 INFO - 'SHLVL': '1', 07:08:39 INFO - 'TERM': 'linux', 07:08:39 INFO - 'TMOUT': '86400', 07:08:39 INFO - 'USER': 'cltbld', 07:08:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:39 INFO - '_': '/tools/buildbot/bin/python'} 07:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:08:42 INFO - Installing collected packages: mozsystemmonitor 07:08:42 INFO - Running setup.py install for mozsystemmonitor 07:08:42 INFO - Successfully installed mozsystemmonitor 07:08:42 INFO - Cleaning up... 07:08:42 INFO - Return code: 0 07:08:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:42 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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:42 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 07:08:42 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 07:08:42 INFO - Using env: {'DISPLAY': ':0', 07:08:42 INFO - 'HOME': '/home/cltbld', 07:08:42 INFO - 'LANG': 'en_US.UTF-8', 07:08:42 INFO - 'LANGUAGE': 'en_US:en', 07:08:42 INFO - 'LOGNAME': 'cltbld', 07:08:42 INFO - 'MAIL': '/var/mail/cltbld', 07:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:42 INFO - 'MOZ_NO_REMOTE': '1', 07:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:42 INFO - 'NO_EM_RESTART': '1', 07:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:42 INFO - 'PWD': '/builds/slave/test', 07:08:42 INFO - 'SHELL': '/bin/bash', 07:08:42 INFO - 'SHLVL': '1', 07:08:42 INFO - 'TERM': 'linux', 07:08:42 INFO - 'TMOUT': '86400', 07:08:42 INFO - 'USER': 'cltbld', 07:08:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:42 INFO - '_': '/tools/buildbot/bin/python'} 07:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:42 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 07:08:42 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 07:08:42 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 07:08:42 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 07:08:42 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 07:08:42 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 07:08:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 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 07:08:44 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 07:08:45 INFO - Downloading docopt-0.6.1.tar.gz 07:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:45 INFO - Running setup.py install for blobuploader 07:08:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:45 INFO - Running setup.py install for requests 07:08:45 INFO - Running setup.py install for docopt 07:08:45 INFO - Successfully installed blobuploader requests docopt 07:08:45 INFO - Cleaning up... 07:08:45 INFO - Return code: 0 07:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:45 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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:45 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 07:08:45 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 07:08:45 INFO - Using env: {'DISPLAY': ':0', 07:08:45 INFO - 'HOME': '/home/cltbld', 07:08:45 INFO - 'LANG': 'en_US.UTF-8', 07:08:45 INFO - 'LANGUAGE': 'en_US:en', 07:08:45 INFO - 'LOGNAME': 'cltbld', 07:08:45 INFO - 'MAIL': '/var/mail/cltbld', 07:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:45 INFO - 'MOZ_NO_REMOTE': '1', 07:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:45 INFO - 'NO_EM_RESTART': '1', 07:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:45 INFO - 'PWD': '/builds/slave/test', 07:08:45 INFO - 'SHELL': '/bin/bash', 07:08:45 INFO - 'SHLVL': '1', 07:08:45 INFO - 'TERM': 'linux', 07:08:45 INFO - 'TMOUT': '86400', 07:08:45 INFO - 'USER': 'cltbld', 07:08:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:45 INFO - '_': '/tools/buildbot/bin/python'} 07:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:45 INFO - Running setup.py (path:/tmp/pip-1nrH6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:46 INFO - Running setup.py (path:/tmp/pip-Scdba_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:46 INFO - Running setup.py (path:/tmp/pip-8cbF9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:46 INFO - Running setup.py (path:/tmp/pip-sWM7uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:46 INFO - Running setup.py (path:/tmp/pip-wp8sx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:46 INFO - Running setup.py (path:/tmp/pip-J5KUyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:46 INFO - Running setup.py (path:/tmp/pip-ejChXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:46 INFO - Running setup.py (path:/tmp/pip-LPUFfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:46 INFO - Running setup.py (path:/tmp/pip-G4cLkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:46 INFO - Running setup.py (path:/tmp/pip-CvRdVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:46 INFO - Running setup.py (path:/tmp/pip-TrvtRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:46 INFO - Running setup.py (path:/tmp/pip-SsrodS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:46 INFO - Running setup.py (path:/tmp/pip-l3BAbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:46 INFO - Running setup.py (path:/tmp/pip-EmYyOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:46 INFO - Running setup.py (path:/tmp/pip-g52G_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:47 INFO - Running setup.py (path:/tmp/pip-Co9EwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:47 INFO - Running setup.py (path:/tmp/pip-Z0ZSt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:47 INFO - Running setup.py install for manifestparser 07:08:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Running setup.py install for mozcrash 07:08:47 INFO - Running setup.py install for mozdebug 07:08:47 INFO - Running setup.py install for mozdevice 07:08:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Running setup.py install for mozfile 07:08:47 INFO - Running setup.py install for mozhttpd 07:08:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Running setup.py install for mozinfo 07:08:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Running setup.py install for mozInstall 07:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:47 INFO - Running setup.py install for mozleak 07:08:48 INFO - Running setup.py install for mozlog 07:08:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Running setup.py install for moznetwork 07:08:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Running setup.py install for mozprocess 07:08:48 INFO - Running setup.py install for mozprofile 07:08:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Running setup.py install for mozrunner 07:08:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Running setup.py install for mozscreenshot 07:08:48 INFO - Running setup.py install for moztest 07:08:48 INFO - Running setup.py install for mozversion 07:08:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:48 INFO - Cleaning up... 07:08:48 INFO - Return code: 0 07:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:48 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')]} 07:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:48 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')]} 07:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:48 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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:48 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 07:08:48 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 07:08:48 INFO - Using env: {'DISPLAY': ':0', 07:08:48 INFO - 'HOME': '/home/cltbld', 07:08:48 INFO - 'LANG': 'en_US.UTF-8', 07:08:48 INFO - 'LANGUAGE': 'en_US:en', 07:08:48 INFO - 'LOGNAME': 'cltbld', 07:08:48 INFO - 'MAIL': '/var/mail/cltbld', 07:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:48 INFO - 'MOZ_NO_REMOTE': '1', 07:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:48 INFO - 'NO_EM_RESTART': '1', 07:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:48 INFO - 'PWD': '/builds/slave/test', 07:08:48 INFO - 'SHELL': '/bin/bash', 07:08:48 INFO - 'SHLVL': '1', 07:08:48 INFO - 'TERM': 'linux', 07:08:48 INFO - 'TMOUT': '86400', 07:08:48 INFO - 'USER': 'cltbld', 07:08:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:48 INFO - '_': '/tools/buildbot/bin/python'} 07:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:49 INFO - Running setup.py (path:/tmp/pip-9fu967-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:49 INFO - Running setup.py (path:/tmp/pip-K8MTSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:49 INFO - Running setup.py (path:/tmp/pip-AUKohK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:49 INFO - Running setup.py (path:/tmp/pip-qvigbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:49 INFO - Running setup.py (path:/tmp/pip-TGdmD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:49 INFO - Running setup.py (path:/tmp/pip-7WHnco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:49 INFO - Running setup.py (path:/tmp/pip-zPwuyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:49 INFO - Running setup.py (path:/tmp/pip-1rf0Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:49 INFO - Running setup.py (path:/tmp/pip-Mya1VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:49 INFO - Running setup.py (path:/tmp/pip-QWNWip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:49 INFO - Running setup.py (path:/tmp/pip-1cRr97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:49 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)) 07:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:49 INFO - Running setup.py (path:/tmp/pip-4NBpLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:50 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)) 07:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:50 INFO - Running setup.py (path:/tmp/pip-52HWYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:50 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)) 07:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:50 INFO - Running setup.py (path:/tmp/pip-5D4CBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:50 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)) 07:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:50 INFO - Running setup.py (path:/tmp/pip-SecJ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:50 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)) 07:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:50 INFO - Running setup.py (path:/tmp/pip-SdFk1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:50 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)) 07:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:50 INFO - Running setup.py (path:/tmp/pip-aoE8YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:50 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)) 07:08:50 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)) 07:08:50 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)) 07:08:50 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)) 07:08:50 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)) 07:08:50 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)) 07:08:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:52 INFO - Downloading blessings-1.6.tar.gz 07:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:52 INFO - Installing collected packages: blessings 07:08:52 INFO - Running setup.py install for blessings 07:08:52 INFO - Successfully installed blessings 07:08:52 INFO - Cleaning up... 07:08:52 INFO - Return code: 0 07:08:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:52 INFO - Reading from file tmpfile_stdout 07:08:52 INFO - Current package versions: 07:08:52 INFO - argparse == 1.2.1 07:08:52 INFO - blessings == 1.6 07:08:52 INFO - blobuploader == 1.2.4 07:08:52 INFO - docopt == 0.6.1 07:08:52 INFO - manifestparser == 1.1 07:08:52 INFO - mozInstall == 1.12 07:08:52 INFO - mozcrash == 0.17 07:08:52 INFO - mozdebug == 0.1 07:08:52 INFO - mozdevice == 0.48 07:08:52 INFO - mozfile == 1.2 07:08:52 INFO - mozhttpd == 0.7 07:08:52 INFO - mozinfo == 0.9 07:08:52 INFO - mozleak == 0.1 07:08:52 INFO - mozlog == 3.1 07:08:52 INFO - moznetwork == 0.27 07:08:52 INFO - mozprocess == 0.22 07:08:52 INFO - mozprofile == 0.28 07:08:52 INFO - mozrunner == 6.11 07:08:52 INFO - mozscreenshot == 0.1 07:08:52 INFO - mozsystemmonitor == 0.0 07:08:52 INFO - moztest == 0.7 07:08:52 INFO - mozversion == 1.4 07:08:52 INFO - psutil == 3.1.1 07:08:52 INFO - requests == 1.2.3 07:08:52 INFO - wsgiref == 0.1.2 07:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:52 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')]} 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 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')]} 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:52 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 07:08:52 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 07:08:52 INFO - Using env: {'DISPLAY': ':0', 07:08:52 INFO - 'HOME': '/home/cltbld', 07:08:52 INFO - 'LANG': 'en_US.UTF-8', 07:08:52 INFO - 'LANGUAGE': 'en_US:en', 07:08:52 INFO - 'LOGNAME': 'cltbld', 07:08:52 INFO - 'MAIL': '/var/mail/cltbld', 07:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:52 INFO - 'MOZ_NO_REMOTE': '1', 07:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:52 INFO - 'NO_EM_RESTART': '1', 07:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:52 INFO - 'PWD': '/builds/slave/test', 07:08:52 INFO - 'SHELL': '/bin/bash', 07:08:52 INFO - 'SHLVL': '1', 07:08:52 INFO - 'TERM': 'linux', 07:08:52 INFO - 'TMOUT': '86400', 07:08:52 INFO - 'USER': 'cltbld', 07:08:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:52 INFO - '_': '/tools/buildbot/bin/python'} 07:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 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)) 07:08:52 INFO - Cleaning up... 07:08:52 INFO - Return code: 0 07:08:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08:52 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')]} 07:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 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')]} 07:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:52 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 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:52 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 07:08:52 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 07:08:52 INFO - Using env: {'DISPLAY': ':0', 07:08:52 INFO - 'HOME': '/home/cltbld', 07:08:52 INFO - 'LANG': 'en_US.UTF-8', 07:08:52 INFO - 'LANGUAGE': 'en_US:en', 07:08:52 INFO - 'LOGNAME': 'cltbld', 07:08:52 INFO - 'MAIL': '/var/mail/cltbld', 07:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:52 INFO - 'MOZ_NO_REMOTE': '1', 07:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:52 INFO - 'NO_EM_RESTART': '1', 07:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:52 INFO - 'PWD': '/builds/slave/test', 07:08:52 INFO - 'SHELL': '/bin/bash', 07:08:52 INFO - 'SHLVL': '1', 07:08:52 INFO - 'TERM': 'linux', 07:08:52 INFO - 'TMOUT': '86400', 07:08:52 INFO - 'USER': 'cltbld', 07:08:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:52 INFO - '_': '/tools/buildbot/bin/python'} 07:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:53 INFO - Downloading/unpacking jsonschema 07:08:53 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 07:08:53 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 07:08:53 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 07:08:53 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 07:08:53 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 07:08:53 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 07:08:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:55 INFO - Downloading/unpacking functools32 (from jsonschema) 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:55 INFO - warning: no files found matching '*.txt' 07:08:55 INFO - no previously-included directories found matching 'build' 07:08:55 INFO - no previously-included directories found matching 'dist' 07:08:55 INFO - no previously-included directories found matching '.git*' 07:08:55 INFO - Installing collected packages: jsonschema, functools32 07:08:55 INFO - Running setup.py install for functools32 07:08:55 INFO - warning: no files found matching '*.txt' 07:08:55 INFO - no previously-included directories found matching 'build' 07:08:55 INFO - no previously-included directories found matching 'dist' 07:08:55 INFO - no previously-included directories found matching '.git*' 07:08:55 INFO - Successfully installed jsonschema functools32 07:08:55 INFO - Cleaning up... 07:08:55 INFO - Return code: 0 07:08:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06e67cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, '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': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', '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 07:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:08:55 INFO - Using env: {'DISPLAY': ':0', 07:08:55 INFO - 'HOME': '/home/cltbld', 07:08:55 INFO - 'LANG': 'en_US.UTF-8', 07:08:55 INFO - 'LANGUAGE': 'en_US:en', 07:08:55 INFO - 'LOGNAME': 'cltbld', 07:08:55 INFO - 'MAIL': '/var/mail/cltbld', 07:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:55 INFO - 'MOZ_NO_REMOTE': '1', 07:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:55 INFO - 'NO_EM_RESTART': '1', 07:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:55 INFO - 'PWD': '/builds/slave/test', 07:08:55 INFO - 'SHELL': '/bin/bash', 07:08:55 INFO - 'SHLVL': '1', 07:08:55 INFO - 'TERM': 'linux', 07:08:55 INFO - 'TMOUT': '86400', 07:08:55 INFO - 'USER': 'cltbld', 07:08:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:55 INFO - '_': '/tools/buildbot/bin/python'} 07:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:55 INFO - Downloading/unpacking flake8 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:08:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:08:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:58 INFO - no previously-included directories found matching 'docs/_build' 07:08:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:08:58 INFO - Running setup.py install for pep8 07:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:58 INFO - no previously-included directories found matching 'docs/_build' 07:08:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:08:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:08:58 INFO - Cleaning up... 07:08:58 INFO - Return code: 0 07:08:58 INFO - Running post-action listener: _resource_record_post_action 07:08:58 INFO - Running post-action listener: _start_resource_monitoring 07:08:58 INFO - Starting resource monitoring. 07:08:58 INFO - ##### 07:08:58 INFO - ##### Finished create-virtualenv step (success) 07:08:58 INFO - ##### 07:08:58 INFO - ##### 07:08:58 INFO - ##### Running install step. 07:08:58 INFO - ##### 07:08:58 INFO - Running pre-action listener: _resource_record_pre_action 07:08:58 INFO - Running main action method: install 07:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:58 INFO - Reading from file tmpfile_stdout 07:08:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:58 INFO - Reading from file tmpfile_stdout 07:08:58 INFO - Output received: 07:08:58 INFO - Usage: mozinstall [options] installer 07:08:58 INFO - Options: 07:08:58 INFO - -h, --help show this help message and exit 07:08:58 INFO - -d DEST, --destination=DEST 07:08:58 INFO - Directory to install application into. [default: 07:08:58 INFO - "/builds/slave/test"] 07:08:58 INFO - --app=APP Application being installed. [default: firefox] 07:08:58 INFO - mkdir: /builds/slave/test/build/application 07:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:09:15 INFO - Reading from file tmpfile_stdout 07:09:15 INFO - Output received: 07:09:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:15 INFO - Running post-action listener: _resource_record_post_action 07:09:15 INFO - ##### 07:09:15 INFO - ##### Finished install step (success) 07:09:15 INFO - ##### 07:09:15 INFO - ##### 07:09:15 INFO - ##### Running run-tests step. 07:09:15 INFO - ##### 07:09:15 INFO - Running pre-action listener: _resource_record_pre_action 07:09:15 INFO - Running main action method: run_tests 07:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:15 INFO - Python 2.7.3 07:09:15 INFO - Return code: 0 07:09:15 INFO - grabbing minidump binary from tooltool 07:09: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')]} 07:09:15 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 0x132e9c0>, '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 0x132f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x132fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:15 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 07:09:15 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 07:09:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:15 INFO - Return code: 0 07:09:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:16 INFO - Return code: 0 07:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 07:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 07:09:16 INFO - Using env: {'DISPLAY': ':0', 07:09:16 INFO - 'HOME': '/home/cltbld', 07:09:16 INFO - 'LANG': 'en_US.UTF-8', 07:09:16 INFO - 'LANGUAGE': 'en_US:en', 07:09:16 INFO - 'LOGNAME': 'cltbld', 07:09:16 INFO - 'MAIL': '/var/mail/cltbld', 07:09:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:16 INFO - 'MOZ_NO_REMOTE': '1', 07:09:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:16 INFO - 'NO_EM_RESTART': '1', 07:09:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:16 INFO - 'PWD': '/builds/slave/test', 07:09:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:16 INFO - 'SHELL': '/bin/bash', 07:09:16 INFO - 'SHLVL': '1', 07:09:16 INFO - 'TERM': 'linux', 07:09:16 INFO - 'TMOUT': '86400', 07:09:16 INFO - 'USER': 'cltbld', 07:09:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176', 07:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:16 INFO - '_': '/tools/buildbot/bin/python'} 07:09:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 07:09:16 INFO - mozversion application_buildid: 20160510043041 07:09:16 INFO - mozversion application_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 07:09:16 INFO - mozversion application_display_name: Nightly 07:09:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:16 INFO - mozversion application_name: Firefox 07:09:16 INFO - mozversion application_remotingname: firefox 07:09:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:16 INFO - mozversion application_vendor: Mozilla 07:09:16 INFO - mozversion application_version: 49.0a1 07:09:16 INFO - mozversion platform_buildid: 20160510043041 07:09:16 INFO - mozversion platform_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 07:09:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:16 INFO - mozversion platform_version: 49.0a1 07:09:16 INFO - using testdate: 1462889356 07:09:16 INFO - actual date: 1462889356 07:09:16 INFO - starting webserver on 'localhost:40339' 07:09:16 INFO - SUITE-START | Running 2 tests 07:09:16 INFO - TEST-START | dromaeo_css 07:09:16 INFO - operating with platform_type : linux_ 07:09:16 INFO - Initialising browser for dromaeo_css test... 07:09:16 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEf9rh/profile http://localhost:40339/getInfo.html) 07:09:22 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 07:09:22 INFO - PROCESS | 3306 | colorDepth:24 07:09:22 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 07:09:22 INFO - PROCESS | 3306 | __metrics 07:09:23 ERROR - PROCESS | 3306 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:09:24 INFO - TEST-INFO | 3306: exit 0 07:09:24 INFO - Browser initialized. 07:09:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:24 INFO - TEST-INFO | started process 3388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEf9rh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:36 INFO - PROCESS | 3388 | RSS: Main: 152174592 07:09:36 INFO - PROCESS | 3388 | 07:10:27 INFO - PROCESS | 3388 | 1462889427331 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] 07:12:35 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:40339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40339/tests/dromaeo/cssquery-ext.html) 07:12:36 INFO - PROCESS | 3388 | RSS: Main: 283869184 07:12:36 INFO - PROCESS | 3388 | 07:15:38 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:40339/tests/dromaeo/cssquery-ext.html (next: http://localhost:40339/tests/dromaeo/cssquery-jquery.html) 07:15:39 INFO - PROCESS | 3388 | RSS: Main: 240513024 07:15:39 INFO - PROCESS | 3388 | 07:18:41 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:40339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40339/tests/dromaeo/cssquery-mootools.html) 07:18:42 INFO - PROCESS | 3388 | RSS: Main: 244936704 07:18:42 INFO - PROCESS | 3388 | 07:21:44 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:40339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40339/tests/dromaeo/cssquery-prototype.html) 07:21:44 INFO - PROCESS | 3388 | RSS: Main: 226111488 07:21:44 INFO - PROCESS | 3388 | 07:24:47 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:40339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40339/tests/dromaeo/cssquery-yui.html) 07:24:47 INFO - PROCESS | 3388 | RSS: Main: 198119424 07:24:47 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:40339/tests/dromaeo/cssquery-yui.html (next: http://localhost:40339/tests/dromaeo/cssquery-dojo.html) 07:27:50 INFO - PROCESS | 3388 | RSS: Main: 265879552 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | __start_tp_report 07:27:50 INFO - PROCESS | 3388 | _x_x_mozilla_page_load 07:27:50 INFO - PROCESS | 3388 | _x_x_mozilla_page_load_details 07:27:50 INFO - PROCESS | 3388 | |i|pagename|runs| 07:27:50 INFO - PROCESS | 3388 | |0;dojo.html;3151.1019359482552;3162.3675264947015;3192;3193;3225.870965161392;5263.078961181797;5281.392639846419;5326.014687282855;5385.81149659762;5411.269478620385;5339.06566350888;5349.625526213166;5366.6243362964515;5413.106837371829;5473.370562385327;4785.449673287581;4877.902441951159;4888.24232244001;4920.360353154085;4998.325226094467;4796.952030479685;4984.327115839352;5030.06943715412;5043.798248070073;5049.293098966147;4797.928031079537;4807.519248075199;4813.855584332476;4839.854804355875;4865.294532292815;4837.0567739290855;4877.829275975359;4891.657583969123;4893.535114164149;4934.753262336904;4777.59390451812;4793.400824896888;4808.302796094582;4810.470848206694;4854.320395144682;5086.338775959139;5205.531502164786;5209.973950130263;5241.764120614582;5271.815486457956;5791.420857914217;5799.681017544033;5801.796937107181;5803.21656576361;5814.622049566765;5850.3564607893095;5851.707414629252;5868.530517558585;5880.059190529495;5882.0588705807295;5209.791608335662;5273.630845840793;5295.867603309909;5298.973505132488;5385.246065550826;5812.9709351452975;5830.096335068071;5868;5873.794417195378;5881.7647294107755;5439.265699130646;5609.943900560942;5640.943590564042;5660.066089095336;5668.631538949955;5619.634723742944;5641.182028605829;5655.745491452894;5757.539396848242;5770.605198842517;5628.183913332626;5629.240052592848;5690.231818704505;5694.658320500783;5712.828615141552;5628.774849006076;5631.493165615114;5688.175214593861;5689.317281926113;5703.458171473703;4253.680973926967;4320.1359728053885;4387.144506821203;4388.253996820485;4409;3902.746321489094;3918.5689574146822;3924.6860251179837;3949.7235193536176;3960.1683646433994;5289.57683385336;5493.478119578634;5500.724963751796;5505.779768809202;5509.752061157257;5711.828645140652;5749.022666146765;5752.798652047159;5762.507294155203;5801.709914504342;5470.398256191816;5472.480114389206;5473.17902314648;5481.780728770805;5486.61593688438;4864;4944.9258261126115;4985.451600323961;4988.501149885055;5029.723365214948;5936.22829032223;6005.519558435315;6018.518518518596;6035.7283922223605;6088.543359248074;5825.79609713658;5841.386654401226;5841.853953651193;5845.947729408747;5851.151583020353;5773.480386765212;5788.971055144697;5846.064629659404;5998.610090344114;6008.819735407945;5587.189857470726;5598.412166722435;5599.356074051373;5603.103503439593;5644.887102258014;5639.407862174413;5645.887082258414;5659.518940890071;5683.658980461186;5702.7718891243885;5463.781448742165;5541.251930989265;5570.721463926869;5631.577631677558;5634.830955071355;5614.41048689898;5622.437756224344;5628.437156284339;5639.407862174577;5641.9435805641415;5552;5569.944300557105;5570.2480165177185;5571.777128914798;5572.387037425961;5504.146857237135;5504.669719816824;5521.033819081725;5524.861878453071;5530.364008139116;5382.865428364322;5386.973065134649;5410.269613602113;5416.647917885325;5503.422140675331 07:27:50 INFO - PROCESS | 3388 | |1;ext.html;596.6986671730778;636.3604577399714;642.4571237304478;648.8183308673573;652.435643168659;44182.558174418285;45797.31304030442;45844.77077614607;45917.31124033138;49411;45827.77086114565;45884.54115458844;46290.768546157226;46452.76773616127;46486.53513464864;8938.776530586721;9080.046595107518;9083.682071127512;9085;9087.95456022719;8844.46933184011;8951.597178126967;8952.641894324219;8960.327975401871;8961.641534338618;8947.865782013243;9005.234555062827;9012.8648070279;9016.68441604544;9017.143371379709;8922.286217102615;8943;8973.685920992733;8974.865377019383;8980.640774369018;8830.47017178965;8894.510801905893;8900.198982091579;8905.599248033854;8909.242714369286;43011.56988430138;43202;43215;43372;43372.349414758806;3770.566384865748;3788.4506746521874;4067.97966010171;4080.10237747695;4400.273954797454;32698.346033079204;32703;32753.16220514581;32928.17679558006;33196.55620048034;4163.208990291835;4204.11713540157;4212.873613791591;4215.409842622035;4245.936310955338;322498;323769;323996;324298;325360;50979;57480;58502.99999999915;58570.12144817831;58621;50965.235521467206;55591.44408555944;55685.164722529196;60303.69848150731;61841;15527.611809704847;15762.684746305009;15769.132697701507;15770.290336934866;15771.44799931997;11925.940370298093;12013.759724805455;12032.699182520508;12033.939830300793;12041.819372709417;15085.396584136512;16703.916480417764;16904.577385565215;17224.483265502055;17533.386331478338;5898.410158984153;5911.645301281851;6011.579189456696;6153.7230824613;6159.630422174594;950.4914870544363;1029.6344797596896;1047.7590154264562;1096.2052511928787;1138.5047504335641;31401.842990785357;32260.35479290401;33007;33157.50263746046;33579.664203358145;1137.4312843578211;1203.7050922523863;1204.4098391788136;1229.7540491901655;1241.9755798049123;17250.827491725173;17591.73612395815;17605.433628053725;17722.29110835578;17807;438944;440768;441266;441320;441916;58066;58203.70898145482;58220.126698099564;58304.708476457345;58314;1265.8607553169145;1385.5289201671278;1412.3926711513943;1415.0213799951161;1421.2822524624999;32551.18622034468;33766.32467350688;34327.4850877232;34350.82824585861;34391.31217375588;49137.508624913295;50378.748106260704;50382.74808625934;50390.748046261004;50471.74764126156;351343;356098;356783;356937;358286;36514.634853652184;37630.43554346632;40340.3948940772;42462.78768606137;43026.35460468158;48160.518394815605;48879;49272.507274928226;49390;49448;41264.58735412607;42213.36679949742;42254.366184506645;45400.77299613481;45631.77184114058;42136;42598.78700606601;42675;43072.56927430686;43137.78431107824;41956.37065444082;42264.78867605642;42960.78519607382;43018.35472467853;43068.35397468978;34906;36844.26311473702;37110.8144459276;37248;37826.43260351152;28236.71763282341;28974.855125724236;29090.854545727136;29219.85390073036;29314.267143321587 07:27:50 INFO - PROCESS | 3388 | |2;jquery.html;411.80027686572;413.19014731126987;413.2623267467571;414.7117753161554;427.27576757396207;13719.65700857479;18093.81906180938;19075.427737167905;19554.21783128675;19628.607427851453;14969.625759356022;18257.634847303078;18847.528811779714;18966.905165474152;19023.048847557602;5714.228579141825;5831.387704291052;5880.206172166745;5917.585768996172;5918.2898052233795;5767.625104368202;5801.158831969362;5841.357450680422;5846.181534585162;5872.5889187756875;5731.054376027951;5800.651960882339;5808.854778630526;5827.737751801179;5864.706764661772;5773.30720313563;5826.271716035496;5842;5853.32686741026;5853.473187413153;5101.183810590288;5190.8061145936645;5208.479152084761;5208.973955130238;5230.686158830483;21755.564888702294;22146.778532214634;23078.423039423982;23323.533529329317;23336.299911002698;2517.144170981857;2537.5178716043893;2603.5313643544155;3095.4273459410083;3223.2747631782895;10233.334833235816;10664.093552048085;10771.946140269249;10838.72903177419;13816.585502434944;1943.280986035162;2028.9188432462831;2048.3342913553156;2057.722207501983;2076.927307544229;85154;85779;86971;87660.12339876647;87816;9931.205503559842;10256.58973641046;10691.465426728633;10876.401797901191;10934.289271197347;14693.926530367493;15146.924265378602;15174.696506069817;15536.300866461037;15691.686166276611;7625.351845093118;7713.807154821062;7947.761567152879;8192.918070819216;8260.958695206486;6449.871002579922;7296.306850849161;7404.370628496638;7654.464187506821;7906.446548741648;4548.658850586219;4585.587297143206;4705.247160454311;4762.190427627312;4768.47546769855;1911.4265720284138;1930.8165724256173;1944.1445763864137;1976.8517361197967;2034.6235946349973;932.3194068330157;969.2827307792184;998.3410948773775;1024.3802499487851;1044.770150566874;17928.641427171384;18936.62126757457;19569;19571.902140489205;19679.409617711204;991.306085739985;1031.9277650564388;1044.9738756530996;1099.8900109988938;1131.027316507819;10473.790524189473;10819.564634231212;10852.589958075841;10896.723003805113;10914.181436392302;363532;366517;367474;490411;491371;96493;98540;101081.49459252656;101698;102585;1097.6213206443924;1115.9243806519867;1127.1152145565854;1137.2721458266717;1137.806572882612;17105.144742762564;17248.741268880727;17248.82751172472;17435.651286974444;17603.55991100233;36512.45231321586;36836.26327473382;37378;40442;41170.38244426276;50556;53694.194587082005;53752.46247537475;53790;53829.46170538401;7737.419693522896;8130.593470326578;8152.2662960333855;8187.79530511742;12345.691357716129;13764.449422023006;14061.860200341445;14178.574642760734;14403.855961440251;15263.236838157825;12113.818292725793;12220.633380998584;12364.814527781911;12441.37793110359;12711.80932286035;7927.722529711433;8907.51008694528;12504.562340318045;12936.676583085498;13153.605391837877;12703.809442858179;12726.23642581411;12800;13104.541341053398;13382.93308533451;13362.933185334012;13470.191788492722;13477.25875076841;13477.326133693472;13480.460781568627;12028.63914082579;12131.101868619657;12150.21023633461;12362.75274494523;12415.93792031034 07:27:50 INFO - PROCESS | 3388 | |3;mootools.html;1369.5822774053922;1522.9466968656095;1554.9222538873057;1678.127373765642;1847.8706490545667;8200.343972482202;8583.399162058658;8590.65637374505;8721.825563488726;8761.561921903894;8476.533790641512;8712.520811355389;8723.38936274461;8735.825283494341;8742.344324175696;2314.1322004248364;2321.8390804597702;2343.3321503371544;2347.1550241912896;2348.201611452106;2191.298784388996;2244.4052326133587;2246.853954492961;2249.955000899981;2268.8298377621745;2283.4291427143216;2295.724513058427;2306;2311.884405779713;2318.4088057545387;2217.3791338425267;2269.9432514187197;2274.1585613323177;2275.112706044644;2279.9658005129936;2264.8188144948363;2270.2054281001683;2271.2845453682203;2273.4316420894775;2273.522560262347;8246.175382461766;8495.06554279035;8530.274926631182;8606.913930860674;8611.052784193733;5146.716930568818;5216.217567364925;5239.240310155006;5257.895841873211;5261.316028916254;3307.68576985186;3317.552130462381;3365.4951757236367;3412.539307193522;3420.247545540002;1181.8404515390484;1199.9520019199222;1213.8968187704056;1238.0467040378949;1264.8292480515197;12157.209781364272;12191.939040304831;12269.93865030678;12272.079594030483;12276.570320038845;4301.827926882889;4381.890452738707;4446.088551846864;4453.955460445419;4474.038081812426;9669.806603867883;9697.272704547046;9712.805743885083;9729.756756081013;9744.658936937172;5120.359955005624;5123.2827404163445;5156;5162.97418512905;5162.9741851291255;4268.359746038057;4644.419447569054;4725.1730947084125;4787.3537072495465;4798;3637.1089083174793;3655.908602284911;3721.2371463849845;3721.9441708374397;3746.6440688134585;1108.3959242213014;1116.553378648547;1118.222835129577;1120.6245907620876;1120.6581992492368;825.162460102996;904.4844438670026;961.4808003678075;993.8707967964118;1010.5351538292468;5739.684317362502;6010.188624535719;6030.427109424598;6035.124906888476;6136.110264011693;464.5818763113225;469.8613908896884;470.4777696756598;472.5534370020298;643.1992169748693;4040.2121586290978;4162.875113746592;4176.248275310412;4186.91626167475;4213.220554197484;10362.326448780956;10769.676909692722;10873.728156795985;10881.183911206692;10922.453877306103;10583.153347732163;10667.946660266649;10799.892001079888;10872.45637718111;10888.455577221108;7734;8093.838123237502;8217.917820821835;8325.625346859284;8338.499690018618;6006.759729610767;6047.425494578008;6080.391960803884;6141.310046284458;6196.349383314687;9751.707448776548;9836.754081148028;9889.456079915386;9958.004199579984;9976.50117494137;9846.950765246414;9876.209903207582;9990.800183996425;10129.290949633454;10144.239182061523;7162.964185179041;7370.926290737239;7394.334509894135;7742.8451430969935;7865.4494185406475;7970.920290797249;8016.438849280495;8156.510609363457;8293.917060829555;8586.098459661645;7498.32515073646;7595.088589369311;7706.460547761827;7724.034495688039;7793.337566306701;7524.377166513055;7611.923880761122;7642.694292228471;7689.846203076019;7755.030621172354;7144.821379465555;7154.606496642735;7168.605726685082;7214.567125972459;7217.422606191597;5182.637215394886;5203.479652034766;5305.336832895888;5343.519083282523;5355.785768569213;5235.267062611161;5267.236250743697;5326.9346130774775;5354.892902141857;5458.153986132156 07:27:50 INFO - PROCESS | 3388 | |4;prototype.html;336.2820378491919;345.771790618192;353.66225254881573;354.517855716226;355.6248158193105;5325.813596524123;5332.360116785986;5353.73231338433;5366.490183432573;5390.8921821563545;5087.211482220262;5088.440271570124;5172.45689202633;5224.164133738603;5342;4103.3229517129785;4121.9175616487655;4130.740124262099;4162.771047592381;4181.54003059664;4127.484064491939;4162.687798415116;4170.77060761658;4171.165766846628;4171.874843754677;3996.500437445319;4034.11249525104;4103.9179216415805;4110.547839737626;4148.5065376464445;4071.89820254496;4088.713790034699;4092.4270602115726;4092.836286548564;4100.17996400718;3646.890593282206;3651.6713495785507;3660.396034654279;3668.2663467306647;3673.779573225615;5053.090443720129;5078.21287700407;5127.846164615067;5129.230615407681;5138.845834624967;4719.4100737407825;4745.074710431467;4756.215224487955;4760.9289958868;4780.1873681474235;5435.1847222916485;5505.532029777473;5511.118221084607;5538.723063846832;5550.611457197998;3866.5447440874964;3987.2424239394422;3990.7452289456364;4001.379786133154;4007.979960100181;5690.089585666315;5711.857203569903;5717.799877004327;5718.142278658193;5725.341585717612;4122.381642753611;4123.670106391542;4124.711270211056;4124.835006599702;4131.607497287753;4059.939100913489;4168.2080404723;4182.979085104555;4195.349720793282;4208.473940757405;4660.9279865630415;4722.574968252874;4733.763311834395;4738.336632871401;4764.523547645277;5467.234587157801;5478.972605136949;5501.394846566875;5606.579506537026;5631.802886898939;1400.4538230090272;1430.1204759073096;1430.1919415530192;1434.6413396650837;1443.5092068696692;923.9168474837297;924.7595625137512;944.622151139536;947.218544700611;948.5826236455937;4666.719996800135;4684.6576711644175;4685.406961633061;4687.695299805502;4759.214729569651;5012.874678133076;5014;5037.471065538139;5042.881989564392;5077.923831142536;4553.157665831832;4698.1778188816825;4721.757165346502;4791.329213910055;4793.664443488992;2654.2700757291514;2690.4081102157493;2698.8245764025273;2701.824706252747;2704.432069265437;5065.518775716375;5101.857219967623;5160.793568257228;5171.224316352502;5195.168772996302;4879.926801097987;5133.23001549763;5158.303629010035;5183.585313174937;5188.636795424284;5068.341115655015;5139.563137133311;5155.484451554889;5158.742062896915;5193.675612718808;5003.098822447592;5041.924371134362;5055.494450555062;5059.645824792229;5065.56942659878;4790.083966413463;4980.726060066586;5035.697858128377;5077.416097148875;5084.5932325414615;5147.970405918756;5176.611754118381;5202.271681964452;5256.9748898964335;5288.603354748332;3769.3968964965475;3778.4332350147697;3793.8103094844596;3802.144517483655;3971.384435412516;5547.528460080777;5643.71781410936;5682.289713785777;5683.9715801420725;5742.626729262584;5476.534494568006;5489.725513724218;5574.494886380736;5619.426560562885;5646.71766411686;5322.574194064388;5431.321084864392;5506.760978779743;5533.7786488541615;5576.90865925278;5370.946290537045;5393.757280922289;5402.243685883901;5408.729563521887;5441.918371224514;5528.308961379827;5583.162525621189;5612.663240205601;5622.887542249214;5656.190019193818;5211.296474975829;5420.457954204706;5481.177823326533;5495.450454954473;5526.364468086061 07:27:50 INFO - PROCESS | 3388 | |5;yui.html;767.6277005652254;822.2722890242136;832.2301870769537;844.8986121665401;878.9208971192594;14234.71530569388;14356.856431435695;14383.92808035961;14395.06432081914;14597.270136493173;14127.293635318245;14140.929295353535;14149.36327865246;14199.503017394392;14274.357653905574;693.2132030145783;802.8795680647892;826.2109685250572;829.0258945738763;830.1034882327102;828.8342331533687;829.2950991657103;829.8132920092961;835.678263868412;836.0803116571752;730.2441972558403;882.3206131278912;883.5582208895552;883.9204471597554;884.4781578868466;869.8956125264978;889.4707648948897;890.3678388344283;893.2675206330812;894.0389081737094;649.9967500162517;651.4234902111618;652.2075678051143;652.2205963873173;652.2596852572365;14225.502107426293;14240.92879535606;14268.500602478967;14275.500357487543;14289.928550357181;13399.933000335033;13626.591202263948;13770.173789572558;13775.173489590657;13783.104098233583;11314.434278286053;11412.942935285353;11574;11596.652100437;11707.882921170765;4484.551544845522;4503.977480112611;4570.085982803453;4575.908481830378;4648.860534183946;49986;50201.748991255175;50230.7488462559;52720;53026.20460693093;10527.894721052844;10602.787944241227;10637.308574942605;10784.56861725538;10857.728556785985;18259.72610410845;18273.17770700322;18298.81701182998;18328.083595820157;18336.266549337877;7950.920490795133;8078.83842323162;8098.23066808664;8324.209200125979;8482.830343393098;4674.182018146878;4681.50844161365;4723.7874295656775;4787.569118779257;4792.496787837227;3307.751918606066;3397.8301084945656;3430.639782822818;3432.828358582111;3432.845521951518;594.7977687586241;601.1643815097019;607.1894021481284;607.6141650052249;618.0266080922565;683.4054372695687;703.8838591632324;748.0723902361033;769.376426386021;772.6252767407802;9478.38390504615;9601.32790704644;9748.268879833899;9789.559469823875;9885.75285617851;591.615449957531;601.3084952304885;737.6717360774511;760.8592410404093;776.6970881356276;4456.487503937089;4479.619232365286;4487.214737420938;4493.640508759291;4607.631389488833;65007.67496162489;65185.34814651793;65407.67296163584;65435;65455.34544654588;58957.41042589519;59200.407995919486;59693.701531492065;59902;60742.392576074555;51639.225411618856;52823.47176528186;53072;53596.19605705918;54428;9655.46894920758;9800.460974646463;9959.153471954965;9960.302778805413;10099.848502272325;33240.33519329648;33364;34078.318433631684;34166.82916585401;34346.14134646654;22275.777242228018;22582.887085564467;32405;32576.83711581522;42135.36796948109;11860.881391185978;12088.75822483563;12107.273563586214;12211.572594959134;12812.935935320264;13588.728225435634;14322.856771432153;14720;14880.107193568421;15282.159481228638;13661.726765464833;13968.860311396757;14364;14462.85537144615;14604;13598.86401135976;13661.316934153054;13778.242196679279;14239.786403203752;14355.497557585435;13695.726085478434;13702.725945480835;14271.928640356731;14329.78505322442;14347.067440616327;10642.787144257227;10845.295055821347;11151.944240278746;11386.829197562209;11388.715282118013;10629.205805311296;10791.298565593212;10794.86653901329;10814.459277036274;10853.131749460183 07:27:50 INFO - PROCESS | 3388 | __end_tp_report 07:27:50 INFO - PROCESS | 3388 | __start_cc_report 07:27:50 INFO - PROCESS | 3388 | _x_x_mozilla_cycle_collect,1121 07:27:50 INFO - PROCESS | 3388 | __end_cc_report 07:27:50 INFO - PROCESS | 3388 | __startTimestamp1462890470713__endTimestamp 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | ------- Summary: start ------- 07:27:50 INFO - PROCESS | 3388 | Number of tests: 6 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | [#0] dojo.html Cycles:165 Average:5321.40 Median:5505.78 stddev:597.15 (10.8%) stddev-sans-first:574.20 07:27:50 INFO - PROCESS | 3388 | Values: 3151.1 3162.4 3192.0 3193.0 3225.9 5263.1 5281.4 5326.0 5385.8 5411.3 5339.1 5349.6 5366.6 5413.1 5473.4 4785.4 4877.9 4888.2 4920.4 4998.3 4797.0 4984.3 5030.1 5043.8 5049.3 4797.9 4807.5 4813.9 4839.9 4865.3 4837.1 4877.8 4891.7 4893.5 4934.8 4777.6 4793.4 4808.3 4810.5 4854.3 5086.3 5205.5 5210.0 5241.8 5271.8 5791.4 5799.7 5801.8 5803.2 5814.6 5850.4 5851.7 5868.5 5880.1 5882.1 5209.8 5273.6 5295.9 5299.0 5385.2 5813.0 5830.1 5868.0 5873.8 5881.8 5439.3 5609.9 5640.9 5660.1 5668.6 5619.6 5641.2 5655.7 5757.5 5770.6 5628.2 5629.2 5690.2 5694.7 5712.8 5628.8 5631.5 5688.2 5689.3 5703.5 4253.7 4320.1 4387.1 4388.3 4409.0 3902.7 3918.6 3924.7 3949.7 3960.2 5289.6 5493.5 5500.7 5505.8 5509.8 5711.8 5749.0 5752.8 5762.5 5801.7 5470.4 5472.5 5473.2 5481.8 5486.6 4864.0 4944.9 4985.5 4988.5 5029.7 5936.2 6005.5 6018.5 6035.7 6088.5 5825.8 5841.4 5841.9 5845.9 5851.2 5773.5 5789.0 5846.1 5998.6 6008.8 5587.2 5598.4 5599.4 5603.1 5644.9 5639.4 5645.9 5659.5 5683.7 5702.8 5463.8 5541.3 5570.7 5631.6 5634.8 5614.4 5622.4 5628.4 5639.4 5641.9 5552.0 5569.9 5570.2 5571.8 5572.4 5504.1 5504.7 5521.0 5524.9 5530.4 5382.9 5387.0 5410.3 5416.6 5503.4 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | [#1] ext.html Cycles:180 Average:55187.68 Median:42986.18 stddev:99066.96 (230.5%) stddev-sans-first:99260.08 07:27:50 INFO - PROCESS | 3388 | Values: 596.7 636.4 642.5 648.8 652.4 44182.6 45797.3 45844.8 45917.3 49411.0 45827.8 45884.5 46290.8 46452.8 46486.5 8938.8 9080.0 9083.7 9085.0 9088.0 8844.5 8951.6 8952.6 8960.3 8961.6 8947.9 9005.2 9012.9 9016.7 9017.1 8922.3 8943.0 8973.7 8974.9 8980.6 8830.5 8894.5 8900.2 8905.6 8909.2 43011.6 43202.0 43215.0 43372.0 43372.3 3770.6 3788.5 4068.0 4080.1 4400.3 32698.3 32703.0 32753.2 32928.2 33196.6 4163.2 4204.1 4212.9 4215.4 4245.9 322498.0 323769.0 323996.0 324298.0 325360.0 50979.0 57480.0 58503.0 58570.1 58621.0 50965.2 55591.4 55685.2 60303.7 61841.0 15527.6 15762.7 15769.1 15770.3 15771.4 11925.9 12013.8 12032.7 12033.9 12041.8 15085.4 16703.9 16904.6 17224.5 17533.4 5898.4 5911.6 6011.6 6153.7 6159.6 950.5 1029.6 1047.8 1096.2 1138.5 31401.8 32260.4 33007.0 33157.5 33579.7 1137.4 1203.7 1204.4 1229.8 1242.0 17250.8 17591.7 17605.4 17722.3 17807.0 438944.0 440768.0 441266.0 441320.0 441916.0 58066.0 58203.7 58220.1 58304.7 58314.0 1265.9 1385.5 1412.4 1415.0 1421.3 32551.2 33766.3 34327.5 34350.8 34391.3 49137.5 50378.7 50382.7 50390.7 50471.7 351343.0 356098.0 356783.0 356937.0 358286.0 36514.6 37630.4 40340.4 42462.8 43026.4 48160.5 48879.0 49272.5 49390.0 49448.0 41264.6 42213.4 42254.4 45400.8 45631.8 42136.0 42598.8 42675.0 43072.6 43137.8 41956.4 42264.8 42960.8 43018.4 43068.4 34906.0 36844.3 37110.8 37248.0 37826.4 28236.7 28974.9 29090.9 29219.9 29314.3 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | [#2] jquery.html Cycles:180 Average:27262.08 Median:2067.32 stddev:70035.68 (3387.7%) stddev-sans-first:70203.13 07:27:50 INFO - PROCESS | 3388 | Values: 411.8 413.2 413.3 414.7 427.3 13719.7 18093.8 19075.4 19554.2 19628.6 14969.6 18257.6 18847.5 18966.9 19023.0 5714.2 5831.4 5880.2 5917.6 5918.3 5767.6 5801.2 5841.4 5846.2 5872.6 5731.1 5800.7 5808.9 5827.7 5864.7 5773.3 5826.3 5842.0 5853.3 5853.5 5101.2 5190.8 5208.5 5209.0 5230.7 21755.6 22146.8 23078.4 23323.5 23336.3 2517.1 2537.5 2603.5 3095.4 3223.3 10233.3 10664.1 10771.9 10838.7 13816.6 1943.3 2028.9 2048.3 2057.7 2076.9 85154.0 85779.0 86971.0 87660.1 87816.0 9931.2 10256.6 10691.5 10876.4 10934.3 14693.9 15146.9 15174.7 15536.3 15691.7 7625.4 7713.8 7947.8 8192.9 8261.0 6449.9 7296.3 7404.4 7654.5 7906.4 4548.7 4585.6 4705.2 4762.2 4768.5 1911.4 1930.8 1944.1 1976.9 2034.6 932.3 969.3 998.3 1024.4 1044.8 17928.6 18936.6 19569.0 19571.9 19679.4 991.3 1031.9 1045.0 1099.9 1131.0 10473.8 10819.6 10852.6 10896.7 10914.2 363532.0 366517.0 367474.0 490411.0 491371.0 96493.0 98540.0 101081.5 101698.0 102585.0 1097.6 1115.9 1127.1 1137.3 1137.8 17105.1 17248.7 17248.8 17435.7 17603.6 36512.5 36836.3 37378.0 40442.0 41170.4 50556.0 53694.2 53752.5 53790.0 53829.5 7737.4 8130.6 8152.3 8187.8 12345.7 13764.4 14061.9 14178.6 14403.9 15263.2 12113.8 12220.6 12364.8 12441.4 12711.8 7927.7 8907.5 12504.6 12936.7 13153.6 12703.8 12726.2 12800.0 13104.5 13382.9 13362.9 13470.2 13477.3 13477.3 13480.5 12028.6 12131.1 12150.2 12362.8 12415.9 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | [#3] mootools.html Cycles:180 Average:5709.99 Median:5159.49 stddev:3251.24 (63.0%) stddev-sans-first:3244.00 07:27:50 INFO - PROCESS | 3388 | Values: 1369.6 1522.9 1554.9 1678.1 1847.9 8200.3 8583.4 8590.7 8721.8 8761.6 8476.5 8712.5 8723.4 8735.8 8742.3 2314.1 2321.8 2343.3 2347.2 2348.2 2191.3 2244.4 2246.9 2250.0 2268.8 2283.4 2295.7 2306.0 2311.9 2318.4 2217.4 2269.9 2274.2 2275.1 2280.0 2264.8 2270.2 2271.3 2273.4 2273.5 8246.2 8495.1 8530.3 8606.9 8611.1 5146.7 5216.2 5239.2 5257.9 5261.3 3307.7 3317.6 3365.5 3412.5 3420.2 1181.8 1200.0 1213.9 1238.0 1264.8 12157.2 12191.9 12269.9 12272.1 12276.6 4301.8 4381.9 4446.1 4454.0 4474.0 9669.8 9697.3 9712.8 9729.8 9744.7 5120.4 5123.3 5156.0 5163.0 5163.0 4268.4 4644.4 4725.2 4787.4 4798.0 3637.1 3655.9 3721.2 3721.9 3746.6 1108.4 1116.6 1118.2 1120.6 1120.7 825.2 904.5 961.5 993.9 1010.5 5739.7 6010.2 6030.4 6035.1 6136.1 464.6 469.9 470.5 472.6 643.2 4040.2 4162.9 4176.2 4186.9 4213.2 10362.3 10769.7 10873.7 10881.2 10922.5 10583.2 10667.9 10799.9 10872.5 10888.5 7734.0 8093.8 8217.9 8325.6 8338.5 6006.8 6047.4 6080.4 6141.3 6196.3 9751.7 9836.8 9889.5 9958.0 9976.5 9847.0 9876.2 9990.8 10129.3 10144.2 7163.0 7370.9 7394.3 7742.8 7865.4 7970.9 8016.4 8156.5 8293.9 8586.1 7498.3 7595.1 7706.5 7724.0 7793.3 7524.4 7611.9 7642.7 7689.8 7755.0 7144.8 7154.6 7168.6 7214.6 7217.4 5182.6 5203.5 5305.3 5343.5 5355.8 5235.3 5267.2 5326.9 5354.9 5458.2 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | [#4] prototype.html Cycles:180 Average:4491.91 Median:5054.29 stddev:1285.84 (25.4%) stddev-sans-first:1251.04 07:27:50 INFO - PROCESS | 3388 | Values: 336.3 345.8 353.7 354.5 355.6 5325.8 5332.4 5353.7 5366.5 5390.9 5087.2 5088.4 5172.5 5224.2 5342.0 4103.3 4121.9 4130.7 4162.8 4181.5 4127.5 4162.7 4170.8 4171.2 4171.9 3996.5 4034.1 4103.9 4110.5 4148.5 4071.9 4088.7 4092.4 4092.8 4100.2 3646.9 3651.7 3660.4 3668.3 3673.8 5053.1 5078.2 5127.8 5129.2 5138.8 4719.4 4745.1 4756.2 4760.9 4780.2 5435.2 5505.5 5511.1 5538.7 5550.6 3866.5 3987.2 3990.7 4001.4 4008.0 5690.1 5711.9 5717.8 5718.1 5725.3 4122.4 4123.7 4124.7 4124.8 4131.6 4059.9 4168.2 4183.0 4195.3 4208.5 4660.9 4722.6 4733.8 4738.3 4764.5 5467.2 5479.0 5501.4 5606.6 5631.8 1400.5 1430.1 1430.2 1434.6 1443.5 923.9 924.8 944.6 947.2 948.6 4666.7 4684.7 4685.4 4687.7 4759.2 5012.9 5014.0 5037.5 5042.9 5077.9 4553.2 4698.2 4721.8 4791.3 4793.7 2654.3 2690.4 2698.8 2701.8 2704.4 5065.5 5101.9 5160.8 5171.2 5195.2 4879.9 5133.2 5158.3 5183.6 5188.6 5068.3 5139.6 5155.5 5158.7 5193.7 5003.1 5041.9 5055.5 5059.6 5065.6 4790.1 4980.7 5035.7 5077.4 5084.6 5148.0 5176.6 5202.3 5257.0 5288.6 3769.4 3778.4 3793.8 3802.1 3971.4 5547.5 5643.7 5682.3 5684.0 5742.6 5476.5 5489.7 5574.5 5619.4 5646.7 5322.6 5431.3 5506.8 5533.8 5576.9 5370.9 5393.8 5402.2 5408.7 5441.9 5528.3 5583.2 5612.7 5622.9 5656.2 5211.3 5420.5 5481.2 5495.5 5526.4 07:27:50 INFO - PROCESS | 3388 | 07:27:50 INFO - PROCESS | 3388 | [#5] yui.html Cycles:180 Average:14813.50 Median:4498.81 stddev:17056.64 (379.1%) stddev-sans-first:17071.87 07:27:50 INFO - PROCESS | 3388 | Values: 767.6 822.3 832.2 844.9 878.9 14234.7 14356.9 14383.9 14395.1 14597.3 14127.3 14140.9 14149.4 14199.5 14274.4 693.2 802.9 826.2 829.0 830.1 828.8 829.3 829.8 835.7 836.1 730.2 882.3 883.6 883.9 884.5 869.9 889.5 890.4 893.3 894.0 650.0 651.4 652.2 652.2 652.3 14225.5 14240.9 14268.5 14275.5 14289.9 13399.9 13626.6 13770.2 13775.2 13783.1 11314.4 11412.9 11574.0 11596.7 11707.9 4484.6 4504.0 4570.1 4575.9 4648.9 49986.0 50201.7 50230.7 52720.0 53026.2 10527.9 10602.8 10637.3 10784.6 10857.7 18259.7 18273.2 18298.8 18328.1 18336.3 7950.9 8078.8 8098.2 8324.2 8482.8 4674.2 4681.5 4723.8 4787.6 4792.5 3307.8 3397.8 3430.6 3432.8 3432.8 594.8 601.2 607.2 607.6 618.0 683.4 703.9 748.1 769.4 772.6 9478.4 9601.3 9748.3 9789.6 9885.8 591.6 601.3 737.7 760.9 776.7 4456.5 4479.6 4487.2 4493.6 4607.6 65007.7 65185.3 65407.7 65435.0 65455.3 58957.4 59200.4 59693.7 59902.0 60742.4 51639.2 52823.5 53072.0 53596.2 54428.0 9655.5 9800.5 9959.2 9960.3 10099.8 33240.3 33364.0 34078.3 34166.8 34346.1 22275.8 22582.9 32405.0 32576.8 42135.4 11860.9 12088.8 12107.3 12211.6 12812.9 13588.7 14322.9 14720.0 14880.1 15282.2 13661.7 13968.9 14364.0 14462.9 14604.0 13598.9 13661.3 13778.2 14239.8 14355.5 13695.7 13702.7 14271.9 14329.8 14347.1 10642.8 10845.3 11151.9 11386.8 11388.7 10629.2 10791.3 10794.9 10814.5 10853.1 07:27:50 INFO - PROCESS | 3388 | -------- Summary: end -------- 07:27:50 INFO - PROCESS | 3388 | 07:27:51 INFO - TEST-INFO | 3388: exit 0 07:27:51 INFO - TEST-OK | dromaeo_css | took 1114649ms 07:27:51 INFO - TEST-START | kraken 07:27:51 INFO - operating with platform_type : linux_ 07:27:51 INFO - Initialising browser for kraken test... 07:27:51 INFO - TEST-INFO | started process 3579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQnPB8/profile http://localhost:40339/getInfo.html) 07:27:55 INFO - PROCESS | 3579 | __metrics Screen width/height:1600/1200 07:27:55 INFO - PROCESS | 3579 | colorDepth:24 07:27:55 INFO - PROCESS | 3579 | Browser inner width/height: 1024/697 07:27:55 INFO - PROCESS | 3579 | __metrics 07:27:56 ERROR - PROCESS | 3579 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:27:57 INFO - TEST-INFO | 3579: exit 0 07:27:57 INFO - Browser initialized. 07:27:57 INFO - Running cycle 1/1 for kraken test... 07:27:57 INFO - TEST-INFO | started process 3661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQnPB8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:09 INFO - PROCESS | 3661 | RSS: Main: 151879680 07:28:09 INFO - PROCESS | 3661 | 07:28:12 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40339/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:13 INFO - PROCESS | 3661 | RSS: Main: 207912960 07:28:13 INFO - PROCESS | 3661 | 07:28:15 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40339/tests/kraken/driver.html?testName=audio-dft) 07:28:16 INFO - PROCESS | 3661 | RSS: Main: 196739072 07:28:16 INFO - PROCESS | 3661 | 07:28:19 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40339/tests/kraken/driver.html?testName=audio-fft) 07:28:20 INFO - PROCESS | 3661 | RSS: Main: 264417280 07:28:20 INFO - PROCESS | 3661 | 07:28:22 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40339/tests/kraken/driver.html?testName=audio-oscillator) 07:28:22 INFO - PROCESS | 3661 | RSS: Main: 174145536 07:28:22 INFO - PROCESS | 3661 | 07:28:25 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:25 INFO - PROCESS | 3661 | RSS: Main: 177950720 07:28:25 INFO - PROCESS | 3661 | 07:28:28 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40339/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:29 INFO - PROCESS | 3661 | RSS: Main: 214065152 07:28:29 INFO - PROCESS | 3661 | 07:28:33 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40339/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:33 INFO - PROCESS | 3661 | RSS: Main: 212189184 07:28:33 INFO - PROCESS | 3661 | 07:28:36 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40339/tests/kraken/driver.html?testName=json-parse-financial) 07:28:37 INFO - PROCESS | 3661 | RSS: Main: 212971520 07:28:37 INFO - PROCESS | 3661 | 07:28:38 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:39 INFO - PROCESS | 3661 | RSS: Main: 202760192 07:28:39 INFO - PROCESS | 3661 | 07:28:41 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:41 INFO - PROCESS | 3661 | RSS: Main: 205492224 07:28:41 INFO - PROCESS | 3661 | 07:28:43 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:44 INFO - PROCESS | 3661 | RSS: Main: 213684224 07:28:44 INFO - PROCESS | 3661 | 07:28:47 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:48 INFO - PROCESS | 3661 | RSS: Main: 219439104 07:28:48 INFO - PROCESS | 3661 | 07:28:50 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:51 INFO - PROCESS | 3661 | RSS: Main: 216793088 07:28:51 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | Cycle 1(1): loaded http://localhost:40339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40339/tests/kraken/driver.html?testName=ai-astar) 07:28:53 INFO - PROCESS | 3661 | RSS: Main: 262504448 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | __start_tp_report 07:28:53 INFO - PROCESS | 3661 | _x_x_mozilla_page_load 07:28:53 INFO - PROCESS | 3661 | _x_x_mozilla_page_load_details 07:28:53 INFO - PROCESS | 3661 | |i|pagename|runs| 07:28:53 INFO - PROCESS | 3661 | |0;ai-astar;112;105;111;111;111;111;110;110;111;111 07:28:53 INFO - PROCESS | 3661 | |1;audio-beat-detection;156;131;150;206;125;148;150;129;177;125 07:28:53 INFO - PROCESS | 3661 | |2;audio-dft;160;161;159;160;160;161;162;160;160;162 07:28:53 INFO - PROCESS | 3661 | |3;audio-fft;73;75;77;154;75;74;76;74;133;76 07:28:53 INFO - PROCESS | 3661 | |4;audio-oscillator;90;91;150;92;91;92;118;92;92;121 07:28:53 INFO - PROCESS | 3661 | |5;imaging-gaussian-blur;117;116;116;117;117;117;118;117;116;117 07:28:53 INFO - PROCESS | 3661 | |6;imaging-darkroom;145;145;146;145;145;145;144;145;145;144 07:28:53 INFO - PROCESS | 3661 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:28:53 INFO - PROCESS | 3661 | |8;json-parse-financial;58;58;60;58;58;59;60;110;56;56 07:28:53 INFO - PROCESS | 3661 | |9;json-stringify-tinderbox;59;61;59;59;60;59;59;59;59;59 07:28:53 INFO - PROCESS | 3661 | |10;stanford-crypto-aes;83;78;78;77;78;79;79;78;79;78 07:28:53 INFO - PROCESS | 3661 | |11;stanford-crypto-ccm;124;123;125;140;129;121;128;123;240;130 07:28:53 INFO - PROCESS | 3661 | |12;stanford-crypto-pbkdf2;175;170;171;169;171;176;170;173;168;171 07:28:53 INFO - PROCESS | 3661 | |13;stanford-crypto-sha256-iterative;64;65;65;66;65;68;67;64;62;62 07:28:53 INFO - PROCESS | 3661 | __end_tp_report 07:28:53 INFO - PROCESS | 3661 | __start_cc_report 07:28:53 INFO - PROCESS | 3661 | _x_x_mozilla_cycle_collect,1805 07:28:53 INFO - PROCESS | 3661 | __end_cc_report 07:28:53 INFO - PROCESS | 3661 | __startTimestamp1462890533446__endTimestamp 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | ------- Summary: start ------- 07:28:53 INFO - PROCESS | 3661 | Number of tests: 14 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.95 (1.8%) stddev-sans-first:1.96 07:28:53 INFO - PROCESS | 3661 | Values: 112.0 105.0 111.0 111.0 111.0 111.0 110.0 110.0 111.0 111.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:150.00 stddev:25.73 (17.2%) stddev-sans-first:27.18 07:28:53 INFO - PROCESS | 3661 | Values: 156.0 131.0 150.0 206.0 125.0 148.0 150.0 129.0 177.0 125.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 07:28:53 INFO - PROCESS | 3661 | Values: 160.0 161.0 159.0 160.0 160.0 161.0 162.0 160.0 160.0 162.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#3] audio-fft Cycles:10 Average:88.70 Median:75.00 stddev:29.33 (39.1%) stddev-sans-first:30.55 07:28:53 INFO - PROCESS | 3661 | Values: 73.0 75.0 77.0 154.0 75.0 74.0 76.0 74.0 133.0 76.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:91.50 stddev:20.27 (22.2%) stddev-sans-first:20.96 07:28:53 INFO - PROCESS | 3661 | Values: 90.0 91.0 150.0 92.0 91.0 92.0 118.0 92.0 92.0 121.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:28:53 INFO - PROCESS | 3661 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:28:53 INFO - PROCESS | 3661 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 144.0 145.0 145.0 144.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:28:53 INFO - PROCESS | 3661 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:58.00 stddev:16.47 (28.4%) stddev-sans-first:17.35 07:28:53 INFO - PROCESS | 3661 | Values: 58.0 58.0 60.0 58.0 58.0 59.0 60.0 110.0 56.0 56.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 07:28:53 INFO - PROCESS | 3661 | Values: 59.0 61.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:1.64 (2.1%) stddev-sans-first:0.67 07:28:53 INFO - PROCESS | 3661 | Values: 83.0 78.0 78.0 77.0 78.0 79.0 79.0 78.0 79.0 78.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:128.50 stddev:36.14 (28.1%) stddev-sans-first:37.96 07:28:53 INFO - PROCESS | 3661 | Values: 124.0 123.0 125.0 140.0 129.0 121.0 128.0 123.0 240.0 130.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:2.55 (1.5%) stddev-sans-first:2.35 07:28:53 INFO - PROCESS | 3661 | Values: 175.0 170.0 171.0 169.0 171.0 176.0 170.0 173.0 168.0 171.0 07:28:53 INFO - PROCESS | 3661 | 07:28:53 INFO - PROCESS | 3661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.93 (3.0%) stddev-sans-first:2.03 07:28:53 INFO - PROCESS | 3661 | Values: 64.0 65.0 65.0 66.0 65.0 68.0 67.0 64.0 62.0 62.0 07:28:53 INFO - PROCESS | 3661 | -------- Summary: end -------- 07:28:53 INFO - PROCESS | 3661 | 07:28:54 INFO - TEST-INFO | 3661: exit 0 07:28:54 INFO - TEST-OK | kraken | took 63042ms 07:28:54 INFO - SUITE-END | took 1177s 07:28:54 INFO - Completed test suite (00:19:37) 07:28:54 INFO - javascript benchmark 07:28:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.1019359482552, 3162.3675264947015, 3192.0, 3193.0, 3225.870965161392, 5263.078961181797, 5281.392639846419, 5326.014687282855, 5385.81149659762, 5411.269478620385, 5339.06566350888, 5349.625526213166, 5366.6243362964515, 5413.106837371829, 5473.370562385327, 4785.449673287581, 4877.902441951159, 4888.24232244001, 4920.360353154085, 4998.325226094467, 4796.952030479685, 4984.327115839352, 5030.06943715412, 5043.798248070073, 5049.293098966147, 4797.928031079537, 4807.519248075199, 4813.855584332476, 4839.854804355875, 4865.294532292815, 4837.0567739290855, 4877.829275975359, 4891.657583969123, 4893.535114164149, 4934.753262336904, 4777.59390451812, 4793.400824896888, 4808.302796094582, 4810.470848206694, 4854.320395144682, 5086.338775959139, 5205.531502164786, 5209.973950130263, 5241.764120614582, 5271.815486457956, 5791.420857914217, 5799.681017544033, 5801.796937107181, 5803.21656576361, 5814.622049566765, 5850.3564607893095, 5851.707414629252, 5868.530517558585, 5880.059190529495, 5882.0588705807295, 5209.791608335662, 5273.630845840793, 5295.867603309909, 5298.973505132488, 5385.246065550826, 5812.9709351452975, 5830.096335068071, 5868.0, 5873.794417195378, 5881.7647294107755, 5439.265699130646, 5609.943900560942, 5640.943590564042, 5660.066089095336, 5668.631538949955, 5619.634723742944, 5641.182028605829, 5655.745491452894, 5757.539396848242, 5770.605198842517, 5628.183913332626, 5629.240052592848, 5690.231818704505, 5694.658320500783, 5712.828615141552, 5628.774849006076, 5631.493165615114, 5688.175214593861, 5689.317281926113, 5703.458171473703, 4253.680973926967, 4320.1359728053885, 4387.144506821203, 4388.253996820485, 4409.0, 3902.746321489094, 3918.5689574146822, 3924.6860251179837, 3949.7235193536176, 3960.1683646433994, 5289.57683385336, 5493.478119578634, 5500.724963751796, 5505.779768809202, 5509.752061157257, 5711.828645140652, 5749.022666146765, 5752.798652047159, 5762.507294155203, 5801.709914504342, 5470.398256191816, 5472.480114389206, 5473.17902314648, 5481.780728770805, 5486.61593688438, 4864.0, 4944.9258261126115, 4985.451600323961, 4988.501149885055, 5029.723365214948, 5936.22829032223, 6005.519558435315, 6018.518518518596, 6035.7283922223605, 6088.543359248074, 5825.79609713658, 5841.386654401226, 5841.853953651193, 5845.947729408747, 5851.151583020353, 5773.480386765212, 5788.971055144697, 5846.064629659404, 5998.610090344114, 6008.819735407945, 5587.189857470726, 5598.412166722435, 5599.356074051373, 5603.103503439593, 5644.887102258014, 5639.407862174413, 5645.887082258414, 5659.518940890071, 5683.658980461186, 5702.7718891243885, 5463.781448742165, 5541.251930989265, 5570.721463926869, 5631.577631677558, 5634.830955071355, 5614.41048689898, 5622.437756224344, 5628.437156284339, 5639.407862174577, 5641.9435805641415, 5552.0, 5569.944300557105, 5570.2480165177185, 5571.777128914798, 5572.387037425961, 5504.146857237135, 5504.669719816824, 5521.033819081725, 5524.861878453071, 5530.364008139116, 5382.865428364322, 5386.973065134649, 5410.269613602113, 5416.647917885325, 5503.422140675331], "value": 5282.154509829483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6986671730778, 636.3604577399714, 642.4571237304478, 648.8183308673573, 652.435643168659, 44182.558174418285, 45797.31304030442, 45844.77077614607, 45917.31124033138, 49411.0, 45827.77086114565, 45884.54115458844, 46290.768546157226, 46452.76773616127, 46486.53513464864, 8938.776530586721, 9080.046595107518, 9083.682071127512, 9085.0, 9087.95456022719, 8844.46933184011, 8951.597178126967, 8952.641894324219, 8960.327975401871, 8961.641534338618, 8947.865782013243, 9005.234555062827, 9012.8648070279, 9016.68441604544, 9017.143371379709, 8922.286217102615, 8943.0, 8973.685920992733, 8974.865377019383, 8980.640774369018, 8830.47017178965, 8894.510801905893, 8900.198982091579, 8905.599248033854, 8909.242714369286, 43011.56988430138, 43202.0, 43215.0, 43372.0, 43372.349414758806, 3770.566384865748, 3788.4506746521874, 4067.97966010171, 4080.10237747695, 4400.273954797454, 32698.346033079204, 32703.0, 32753.16220514581, 32928.17679558006, 33196.55620048034, 4163.208990291835, 4204.11713540157, 4212.873613791591, 4215.409842622035, 4245.936310955338, 322498.0, 323769.0, 323996.0, 324298.0, 325360.0, 50979.0, 57480.0, 58502.99999999915, 58570.12144817831, 58621.0, 50965.235521467206, 55591.44408555944, 55685.164722529196, 60303.69848150731, 61841.0, 15527.611809704847, 15762.684746305009, 15769.132697701507, 15770.290336934866, 15771.44799931997, 11925.940370298093, 12013.759724805455, 12032.699182520508, 12033.939830300793, 12041.819372709417, 15085.396584136512, 16703.916480417764, 16904.577385565215, 17224.483265502055, 17533.386331478338, 5898.410158984153, 5911.645301281851, 6011.579189456696, 6153.7230824613, 6159.630422174594, 950.4914870544363, 1029.6344797596896, 1047.7590154264562, 1096.2052511928787, 1138.5047504335641, 31401.842990785357, 32260.35479290401, 33007.0, 33157.50263746046, 33579.664203358145, 1137.4312843578211, 1203.7050922523863, 1204.4098391788136, 1229.7540491901655, 1241.9755798049123, 17250.827491725173, 17591.73612395815, 17605.433628053725, 17722.29110835578, 17807.0, 438944.0, 440768.0, 441266.0, 441320.0, 441916.0, 58066.0, 58203.70898145482, 58220.126698099564, 58304.708476457345, 58314.0, 1265.8607553169145, 1385.5289201671278, 1412.3926711513943, 1415.0213799951161, 1421.2822524624999, 32551.18622034468, 33766.32467350688, 34327.4850877232, 34350.82824585861, 34391.31217375588, 49137.508624913295, 50378.748106260704, 50382.74808625934, 50390.748046261004, 50471.74764126156, 351343.0, 356098.0, 356783.0, 356937.0, 358286.0, 36514.634853652184, 37630.43554346632, 40340.3948940772, 42462.78768606137, 43026.35460468158, 48160.518394815605, 48879.0, 49272.507274928226, 49390.0, 49448.0, 41264.58735412607, 42213.36679949742, 42254.366184506645, 45400.77299613481, 45631.77184114058, 42136.0, 42598.78700606601, 42675.0, 43072.56927430686, 43137.78431107824, 41956.37065444082, 42264.78867605642, 42960.78519607382, 43018.35472467853, 43068.35397468978, 34906.0, 36844.26311473702, 37110.8144459276, 37248.0, 37826.43260351152, 28236.71763282341, 28974.855125724236, 29090.854545727136, 29219.85390073036, 29314.267143321587], "value": 20193.896973760162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.80027686572, 413.19014731126987, 413.2623267467571, 414.7117753161554, 427.27576757396207, 13719.65700857479, 18093.81906180938, 19075.427737167905, 19554.21783128675, 19628.607427851453, 14969.625759356022, 18257.634847303078, 18847.528811779714, 18966.905165474152, 19023.048847557602, 5714.228579141825, 5831.387704291052, 5880.206172166745, 5917.585768996172, 5918.2898052233795, 5767.625104368202, 5801.158831969362, 5841.357450680422, 5846.181534585162, 5872.5889187756875, 5731.054376027951, 5800.651960882339, 5808.854778630526, 5827.737751801179, 5864.706764661772, 5773.30720313563, 5826.271716035496, 5842.0, 5853.32686741026, 5853.473187413153, 5101.183810590288, 5190.8061145936645, 5208.479152084761, 5208.973955130238, 5230.686158830483, 21755.564888702294, 22146.778532214634, 23078.423039423982, 23323.533529329317, 23336.299911002698, 2517.144170981857, 2537.5178716043893, 2603.5313643544155, 3095.4273459410083, 3223.2747631782895, 10233.334833235816, 10664.093552048085, 10771.946140269249, 10838.72903177419, 13816.585502434944, 1943.280986035162, 2028.9188432462831, 2048.3342913553156, 2057.722207501983, 2076.927307544229, 85154.0, 85779.0, 86971.0, 87660.12339876647, 87816.0, 9931.205503559842, 10256.58973641046, 10691.465426728633, 10876.401797901191, 10934.289271197347, 14693.926530367493, 15146.924265378602, 15174.696506069817, 15536.300866461037, 15691.686166276611, 7625.351845093118, 7713.807154821062, 7947.761567152879, 8192.918070819216, 8260.958695206486, 6449.871002579922, 7296.306850849161, 7404.370628496638, 7654.464187506821, 7906.446548741648, 4548.658850586219, 4585.587297143206, 4705.247160454311, 4762.190427627312, 4768.47546769855, 1911.4265720284138, 1930.8165724256173, 1944.1445763864137, 1976.8517361197967, 2034.6235946349973, 932.3194068330157, 969.2827307792184, 998.3410948773775, 1024.3802499487851, 1044.770150566874, 17928.641427171384, 18936.62126757457, 19569.0, 19571.902140489205, 19679.409617711204, 991.306085739985, 1031.9277650564388, 1044.9738756530996, 1099.8900109988938, 1131.027316507819, 10473.790524189473, 10819.564634231212, 10852.589958075841, 10896.723003805113, 10914.181436392302, 363532.0, 366517.0, 367474.0, 490411.0, 491371.0, 96493.0, 98540.0, 101081.49459252656, 101698.0, 102585.0, 1097.6213206443924, 1115.9243806519867, 1127.1152145565854, 1137.2721458266717, 1137.806572882612, 17105.144742762564, 17248.741268880727, 17248.82751172472, 17435.651286974444, 17603.55991100233, 36512.45231321586, 36836.26327473382, 37378.0, 40442.0, 41170.38244426276, 50556.0, 53694.194587082005, 53752.46247537475, 53790.0, 53829.46170538401, 7737.419693522896, 8130.593470326578, 8152.2662960333855, 8187.79530511742, 12345.691357716129, 13764.449422023006, 14061.860200341445, 14178.574642760734, 14403.855961440251, 15263.236838157825, 12113.818292725793, 12220.633380998584, 12364.814527781911, 12441.37793110359, 12711.80932286035, 7927.722529711433, 8907.51008694528, 12504.562340318045, 12936.676583085498, 13153.605391837877, 12703.809442858179, 12726.23642581411, 12800.0, 13104.541341053398, 13382.93308533451, 13362.933185334012, 13470.191788492722, 13477.25875076841, 13477.326133693472, 13480.460781568627, 12028.63914082579, 12131.101868619657, 12150.21023633461, 12362.75274494523, 12415.93792031034], "value": 9423.684967168252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.5822774053922, 1522.9466968656095, 1554.9222538873057, 1678.127373765642, 1847.8706490545667, 8200.343972482202, 8583.399162058658, 8590.65637374505, 8721.825563488726, 8761.561921903894, 8476.533790641512, 8712.520811355389, 8723.38936274461, 8735.825283494341, 8742.344324175696, 2314.1322004248364, 2321.8390804597702, 2343.3321503371544, 2347.1550241912896, 2348.201611452106, 2191.298784388996, 2244.4052326133587, 2246.853954492961, 2249.955000899981, 2268.8298377621745, 2283.4291427143216, 2295.724513058427, 2306.0, 2311.884405779713, 2318.4088057545387, 2217.3791338425267, 2269.9432514187197, 2274.1585613323177, 2275.112706044644, 2279.9658005129936, 2264.8188144948363, 2270.2054281001683, 2271.2845453682203, 2273.4316420894775, 2273.522560262347, 8246.175382461766, 8495.06554279035, 8530.274926631182, 8606.913930860674, 8611.052784193733, 5146.716930568818, 5216.217567364925, 5239.240310155006, 5257.895841873211, 5261.316028916254, 3307.68576985186, 3317.552130462381, 3365.4951757236367, 3412.539307193522, 3420.247545540002, 1181.8404515390484, 1199.9520019199222, 1213.8968187704056, 1238.0467040378949, 1264.8292480515197, 12157.209781364272, 12191.939040304831, 12269.93865030678, 12272.079594030483, 12276.570320038845, 4301.827926882889, 4381.890452738707, 4446.088551846864, 4453.955460445419, 4474.038081812426, 9669.806603867883, 9697.272704547046, 9712.805743885083, 9729.756756081013, 9744.658936937172, 5120.359955005624, 5123.2827404163445, 5156.0, 5162.97418512905, 5162.9741851291255, 4268.359746038057, 4644.419447569054, 4725.1730947084125, 4787.3537072495465, 4798.0, 3637.1089083174793, 3655.908602284911, 3721.2371463849845, 3721.9441708374397, 3746.6440688134585, 1108.3959242213014, 1116.553378648547, 1118.222835129577, 1120.6245907620876, 1120.6581992492368, 825.162460102996, 904.4844438670026, 961.4808003678075, 993.8707967964118, 1010.5351538292468, 5739.684317362502, 6010.188624535719, 6030.427109424598, 6035.124906888476, 6136.110264011693, 464.5818763113225, 469.8613908896884, 470.4777696756598, 472.5534370020298, 643.1992169748693, 4040.2121586290978, 4162.875113746592, 4176.248275310412, 4186.91626167475, 4213.220554197484, 10362.326448780956, 10769.676909692722, 10873.728156795985, 10881.183911206692, 10922.453877306103, 10583.153347732163, 10667.946660266649, 10799.892001079888, 10872.45637718111, 10888.455577221108, 7734.0, 8093.838123237502, 8217.917820821835, 8325.625346859284, 8338.499690018618, 6006.759729610767, 6047.425494578008, 6080.391960803884, 6141.310046284458, 6196.349383314687, 9751.707448776548, 9836.754081148028, 9889.456079915386, 9958.004199579984, 9976.50117494137, 9846.950765246414, 9876.209903207582, 9990.800183996425, 10129.290949633454, 10144.239182061523, 7162.964185179041, 7370.926290737239, 7394.334509894135, 7742.8451430969935, 7865.4494185406475, 7970.920290797249, 8016.438849280495, 8156.510609363457, 8293.917060829555, 8586.098459661645, 7498.32515073646, 7595.088589369311, 7706.460547761827, 7724.034495688039, 7793.337566306701, 7524.377166513055, 7611.923880761122, 7642.694292228471, 7689.846203076019, 7755.030621172354, 7144.821379465555, 7154.606496642735, 7168.605726685082, 7214.567125972459, 7217.422606191597, 5182.637215394886, 5203.479652034766, 5305.336832895888, 5343.519083282523, 5355.785768569213, 5235.267062611161, 5267.236250743697, 5326.9346130774775, 5354.892902141857, 5458.153986132156], "value": 4504.064574536208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.2820378491919, 345.771790618192, 353.66225254881573, 354.517855716226, 355.6248158193105, 5325.813596524123, 5332.360116785986, 5353.73231338433, 5366.490183432573, 5390.8921821563545, 5087.211482220262, 5088.440271570124, 5172.45689202633, 5224.164133738603, 5342.0, 4103.3229517129785, 4121.9175616487655, 4130.740124262099, 4162.771047592381, 4181.54003059664, 4127.484064491939, 4162.687798415116, 4170.77060761658, 4171.165766846628, 4171.874843754677, 3996.500437445319, 4034.11249525104, 4103.9179216415805, 4110.547839737626, 4148.5065376464445, 4071.89820254496, 4088.713790034699, 4092.4270602115726, 4092.836286548564, 4100.17996400718, 3646.890593282206, 3651.6713495785507, 3660.396034654279, 3668.2663467306647, 3673.779573225615, 5053.090443720129, 5078.21287700407, 5127.846164615067, 5129.230615407681, 5138.845834624967, 4719.4100737407825, 4745.074710431467, 4756.215224487955, 4760.9289958868, 4780.1873681474235, 5435.1847222916485, 5505.532029777473, 5511.118221084607, 5538.723063846832, 5550.611457197998, 3866.5447440874964, 3987.2424239394422, 3990.7452289456364, 4001.379786133154, 4007.979960100181, 5690.089585666315, 5711.857203569903, 5717.799877004327, 5718.142278658193, 5725.341585717612, 4122.381642753611, 4123.670106391542, 4124.711270211056, 4124.835006599702, 4131.607497287753, 4059.939100913489, 4168.2080404723, 4182.979085104555, 4195.349720793282, 4208.473940757405, 4660.9279865630415, 4722.574968252874, 4733.763311834395, 4738.336632871401, 4764.523547645277, 5467.234587157801, 5478.972605136949, 5501.394846566875, 5606.579506537026, 5631.802886898939, 1400.4538230090272, 1430.1204759073096, 1430.1919415530192, 1434.6413396650837, 1443.5092068696692, 923.9168474837297, 924.7595625137512, 944.622151139536, 947.218544700611, 948.5826236455937, 4666.719996800135, 4684.6576711644175, 4685.406961633061, 4687.695299805502, 4759.214729569651, 5012.874678133076, 5014.0, 5037.471065538139, 5042.881989564392, 5077.923831142536, 4553.157665831832, 4698.1778188816825, 4721.757165346502, 4791.329213910055, 4793.664443488992, 2654.2700757291514, 2690.4081102157493, 2698.8245764025273, 2701.824706252747, 2704.432069265437, 5065.518775716375, 5101.857219967623, 5160.793568257228, 5171.224316352502, 5195.168772996302, 4879.926801097987, 5133.23001549763, 5158.303629010035, 5183.585313174937, 5188.636795424284, 5068.341115655015, 5139.563137133311, 5155.484451554889, 5158.742062896915, 5193.675612718808, 5003.098822447592, 5041.924371134362, 5055.494450555062, 5059.645824792229, 5065.56942659878, 4790.083966413463, 4980.726060066586, 5035.697858128377, 5077.416097148875, 5084.5932325414615, 5147.970405918756, 5176.611754118381, 5202.271681964452, 5256.9748898964335, 5288.603354748332, 3769.3968964965475, 3778.4332350147697, 3793.8103094844596, 3802.144517483655, 3971.384435412516, 5547.528460080777, 5643.71781410936, 5682.289713785777, 5683.9715801420725, 5742.626729262584, 5476.534494568006, 5489.725513724218, 5574.494886380736, 5619.426560562885, 5646.71766411686, 5322.574194064388, 5431.321084864392, 5506.760978779743, 5533.7786488541615, 5576.90865925278, 5370.946290537045, 5393.757280922289, 5402.243685883901, 5408.729563521887, 5441.918371224514, 5528.308961379827, 5583.162525621189, 5612.663240205601, 5622.887542249214, 5656.190019193818, 5211.296474975829, 5420.457954204706, 5481.177823326533, 5495.450454954473, 5526.364468086061], "value": 4092.1645526065363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.6277005652254, 822.2722890242136, 832.2301870769537, 844.8986121665401, 878.9208971192594, 14234.71530569388, 14356.856431435695, 14383.92808035961, 14395.06432081914, 14597.270136493173, 14127.293635318245, 14140.929295353535, 14149.36327865246, 14199.503017394392, 14274.357653905574, 693.2132030145783, 802.8795680647892, 826.2109685250572, 829.0258945738763, 830.1034882327102, 828.8342331533687, 829.2950991657103, 829.8132920092961, 835.678263868412, 836.0803116571752, 730.2441972558403, 882.3206131278912, 883.5582208895552, 883.9204471597554, 884.4781578868466, 869.8956125264978, 889.4707648948897, 890.3678388344283, 893.2675206330812, 894.0389081737094, 649.9967500162517, 651.4234902111618, 652.2075678051143, 652.2205963873173, 652.2596852572365, 14225.502107426293, 14240.92879535606, 14268.500602478967, 14275.500357487543, 14289.928550357181, 13399.933000335033, 13626.591202263948, 13770.173789572558, 13775.173489590657, 13783.104098233583, 11314.434278286053, 11412.942935285353, 11574.0, 11596.652100437, 11707.882921170765, 4484.551544845522, 4503.977480112611, 4570.085982803453, 4575.908481830378, 4648.860534183946, 49986.0, 50201.748991255175, 50230.7488462559, 52720.0, 53026.20460693093, 10527.894721052844, 10602.787944241227, 10637.308574942605, 10784.56861725538, 10857.728556785985, 18259.72610410845, 18273.17770700322, 18298.81701182998, 18328.083595820157, 18336.266549337877, 7950.920490795133, 8078.83842323162, 8098.23066808664, 8324.209200125979, 8482.830343393098, 4674.182018146878, 4681.50844161365, 4723.7874295656775, 4787.569118779257, 4792.496787837227, 3307.751918606066, 3397.8301084945656, 3430.639782822818, 3432.828358582111, 3432.845521951518, 594.7977687586241, 601.1643815097019, 607.1894021481284, 607.6141650052249, 618.0266080922565, 683.4054372695687, 703.8838591632324, 748.0723902361033, 769.376426386021, 772.6252767407802, 9478.38390504615, 9601.32790704644, 9748.268879833899, 9789.559469823875, 9885.75285617851, 591.615449957531, 601.3084952304885, 737.6717360774511, 760.8592410404093, 776.6970881356276, 4456.487503937089, 4479.619232365286, 4487.214737420938, 4493.640508759291, 4607.631389488833, 65007.67496162489, 65185.34814651793, 65407.67296163584, 65435.0, 65455.34544654588, 58957.41042589519, 59200.407995919486, 59693.701531492065, 59902.0, 60742.392576074555, 51639.225411618856, 52823.47176528186, 53072.0, 53596.19605705918, 54428.0, 9655.46894920758, 9800.460974646463, 9959.153471954965, 9960.302778805413, 10099.848502272325, 33240.33519329648, 33364.0, 34078.318433631684, 34166.82916585401, 34346.14134646654, 22275.777242228018, 22582.887085564467, 32405.0, 32576.83711581522, 42135.36796948109, 11860.881391185978, 12088.75822483563, 12107.273563586214, 12211.572594959134, 12812.935935320264, 13588.728225435634, 14322.856771432153, 14720.0, 14880.107193568421, 15282.159481228638, 13661.726765464833, 13968.860311396757, 14364.0, 14462.85537144615, 14604.0, 13598.86401135976, 13661.316934153054, 13778.242196679279, 14239.786403203752, 14355.497557585435, 13695.726085478434, 13702.725945480835, 14271.928640356731, 14329.78505322442, 14347.067440616327, 10642.787144257227, 10845.295055821347, 11151.944240278746, 11386.829197562209, 11388.715282118013, 10629.205805311296, 10791.298565593212, 10794.86653901329, 10814.459277036274, 10853.131749460183], "value": 6858.0316928058655, "unit": "score"}], "name": "dromaeo_css", "value": 7090.489623953999, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 150.0, 206.0, 125.0, 148.0, 150.0, 129.0, 177.0, 125.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 160.0, 161.0, 162.0, 160.0, 160.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 77.0, 154.0, 75.0, 74.0, 76.0, 74.0, 133.0, 76.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 150.0, 92.0, 91.0, 92.0, 118.0, 92.0, 92.0, 121.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 144.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 58.0, 58.0, 59.0, 60.0, 110.0, 56.0, 56.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 78.0, 77.0, 78.0, 79.0, 79.0, 78.0, 79.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 125.0, 140.0, 129.0, 121.0, 128.0, 123.0, 240.0, 130.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 171.0, 169.0, 171.0, 176.0, 170.0, 173.0, 168.0, 171.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 68.0, 67.0, 64.0, 62.0, 62.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1544.6, "alertThreshold": 2.0}]} 07:28:54 INFO - Return code: 0 07:28:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:28:54 ERROR - # TBPL SUCCESS # 07:28:54 INFO - Running post-action listener: _resource_record_post_action 07:28:54 INFO - ##### 07:28:54 INFO - ##### Finished run-tests step (success) 07:28:54 INFO - ##### 07:28:54 INFO - Running post-run listener: _resource_record_post_run 07:28:55 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7798784; Write bytes: 376430592; Read time: 1088; Write time: 281852 07:28:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107859968; Read time: 0; Write time: 107720 07:28:55 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 6062080; Write bytes: 268570624; Read time: 1040; Write time: 174132 07:28:55 INFO - Running post-run listener: _upload_blobber_files 07:28:55 INFO - Blob upload gear active. 07:28:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:28:55 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 07:28:55 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:28:55 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:28:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:57 INFO - (blobuploader) - INFO - Done attempting. 07:28:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:58 INFO - (blobuploader) - INFO - Done attempting. 07:28:58 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:58 INFO - Return code: 0 07:28:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1c19ee5e95c4cd40a1111eb329f1c55b8ccebdf532ee978cb66ba0c0525aa86f64afea408979284a809b8827047be3ebc44b28ceb1637bfc7823f276d0cf81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f675c24d57e3cd720bc598f8a656053449d2d00a0d5ba5bed3fd4e64ee28ce795e4527fc569b51f6d26f24867aec785b218a7c67e8edb797594c505d02bddc4"} 07:28:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:58 INFO - Contents: 07:28:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1c19ee5e95c4cd40a1111eb329f1c55b8ccebdf532ee978cb66ba0c0525aa86f64afea408979284a809b8827047be3ebc44b28ceb1637bfc7823f276d0cf81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f675c24d57e3cd720bc598f8a656053449d2d00a0d5ba5bed3fd4e64ee28ce795e4527fc569b51f6d26f24867aec785b218a7c67e8edb797594c505d02bddc4"} 07:28:58 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:58 INFO - Copying logs to upload dir... 07:28:58 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.228925 ========= master_lag: 17.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-10 07:29:15.351676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 07:29:15.354952) ========= 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=232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1c19ee5e95c4cd40a1111eb329f1c55b8ccebdf532ee978cb66ba0c0525aa86f64afea408979284a809b8827047be3ebc44b28ceb1637bfc7823f276d0cf81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f675c24d57e3cd720bc598f8a656053449d2d00a0d5ba5bed3fd4e64ee28ce795e4527fc569b51f6d26f24867aec785b218a7c67e8edb797594c505d02bddc4"} build_url:https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b1c19ee5e95c4cd40a1111eb329f1c55b8ccebdf532ee978cb66ba0c0525aa86f64afea408979284a809b8827047be3ebc44b28ceb1637bfc7823f276d0cf81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f675c24d57e3cd720bc598f8a656053449d2d00a0d5ba5bed3fd4e64ee28ce795e4527fc569b51f6d26f24867aec785b218a7c67e8edb797594c505d02bddc4"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 07:29:15.695906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:29:15.696280) ========= 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=232498196343f89f466a4a9a000001c8-1462886256.968673-1787482176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:29:15.721555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 07:29:15.721836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 07:29:15.722125) ========= ========= Total master_lag: 17.65 =========