builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1461259153.49 results: success (0) buildid: 20160421073719 builduid: 0ab6c4c4b9af4784a807d2c8c9a6e949 revision: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.488371) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.488789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.489087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.530879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.531236) ========= 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=836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 10:19:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.3M=0s 2016-04-21 10:19:14 (24.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.678790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.679103) ========= 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=836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.732910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:13.733241) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 --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 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 --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=836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 10:19:14,298 truncating revision to first 12 chars 2016-04-21 10:19:14,298 Setting DEBUG logging. 2016-04-21 10:19:14,298 attempt 1/10 2016-04-21 10:19:14,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1152d99d8c53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 10:19:14,530 unpacking tar archive at: mozilla-central-1152d99d8c53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:14.264578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:14.264899) ========= script_repo_revision: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:14.265324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:14.265606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:19:14.273784) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-21 10:19:14.274270) ========= /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=836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:19:14 INFO - MultiFileLogger online at 20160421 10:19:14 in /builds/slave/test 10:19:14 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 10:19:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:19:14 INFO - {'append_to_log': False, 10:19:14 INFO - 'base_work_dir': '/builds/slave/test', 10:19:14 INFO - 'blob_upload_branch': 'Firefox', 10:19:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:19:14 INFO - 'branch': 'Firefox', 10:19:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:14 INFO - 'config_files': ('talos/linux_config.py',), 10:19:14 INFO - 'default_actions': ('clobber', 10:19:14 INFO - 'read-buildbot-config', 10:19:14 INFO - 'download-and-extract', 10:19:14 INFO - 'populate-webroot', 10:19:14 INFO - 'create-virtualenv', 10:19:14 INFO - 'install', 10:19:14 INFO - 'run-tests'), 10:19:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:14 INFO - 'download_minidump_stackwalk': True, 10:19:14 INFO - 'download_symbols': 'ondemand', 10:19:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:14 INFO - 'installer_path': 'installer.exe', 10:19:14 INFO - 'log_level': 'info', 10:19:14 INFO - 'log_name': 'talos', 10:19:14 INFO - 'log_to_console': True, 10:19:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:19:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:19:14 INFO - 'opt_config_files': (), 10:19:14 INFO - 'pip_index': False, 10:19:14 INFO - 'sps_profile': False, 10:19:14 INFO - 'sps_profile_interval': 0, 10:19:14 INFO - 'suite': 'dromaeojs', 10:19:14 INFO - 'system_bits': '32', 10:19:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:14 INFO - 'title': 'talos-linux64-ix-028', 10:19:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:14 INFO - 'use_talos_json': True, 10:19:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:19:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:14 INFO - 'work_dir': 'build'} 10:19:14 INFO - ##### 10:19:14 INFO - ##### Running clobber step. 10:19:14 INFO - ##### 10:19:14 INFO - Running pre-action listener: _resource_record_pre_action 10:19:14 INFO - Running main action method: clobber 10:19:14 INFO - rmtree: /builds/slave/test/build 10:19:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:19:15 INFO - Running post-action listener: _resource_record_post_action 10:19:15 INFO - ##### 10:19:15 INFO - ##### Running read-buildbot-config step. 10:19:15 INFO - ##### 10:19:15 INFO - Running pre-action listener: _resource_record_pre_action 10:19:15 INFO - Running main action method: read_buildbot_config 10:19:15 INFO - Using buildbot properties: 10:19:15 INFO - { 10:19:15 INFO - "project": "", 10:19:15 INFO - "product": "firefox", 10:19:15 INFO - "script_repo_revision": "production", 10:19:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:19:15 INFO - "repository": "", 10:19:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:19:15 INFO - "buildid": "20160421073719", 10:19:15 INFO - "pgo_build": "True", 10:19:15 INFO - "basedir": "/builds/slave/test", 10:19:15 INFO - "buildnumber": 750, 10:19:15 INFO - "slavename": "talos-linux64-ix-028", 10:19:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:19:15 INFO - "platform": "ubuntu64_hw", 10:19:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:19:15 INFO - "branch": "mozilla-central", 10:19:15 INFO - "repo_path": "mozilla-central", 10:19:15 INFO - "revision": "1152d99d8c53ac9dae371a6e6d9fab03d3f98697", 10:19:15 INFO - "stage_platform": "linux64-pgo", 10:19:15 INFO - "builduid": "0ab6c4c4b9af4784a807d2c8c9a6e949", 10:19:15 INFO - "slavebuilddir": "test" 10:19:15 INFO - } 10:19:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:19:15 INFO - Running post-action listener: _resource_record_post_action 10:19:15 INFO - ##### 10:19:15 INFO - ##### Running download-and-extract step. 10:19:15 INFO - ##### 10:19:15 INFO - Running pre-action listener: _resource_record_pre_action 10:19:15 INFO - Running main action method: download_and_extract 10:19:15 INFO - mkdir: /builds/slave/test/build/tests 10:19: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')]} 10:19:15 INFO - https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:19:24 INFO - Downloaded 1361 bytes. 10:19:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:19:24 INFO - Using the following test package requirements: 10:19:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:19:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:19:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'jsshell-linux-x86_64.zip'], 10:19:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:19:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:19:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:19:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:19:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:19:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:19:31 INFO - Downloaded 23847635 bytes. 10:19:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:19:32 INFO - Return code: 0 10:19:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:32 INFO - https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:19:36 INFO - Downloaded 23847635 bytes. 10:19:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:19:37 INFO - Return code: 0 10:19:37 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')]} 10:19:37 INFO - https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:19:38 INFO - Downloaded 10845952 bytes. 10:19:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:19:38 INFO - Return code: 0 10:19:38 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')]} 10:19:38 INFO - https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:19:40 INFO - Downloaded 58300214 bytes. 10:19:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:19:40 INFO - mkdir: /builds/slave/test/properties 10:19:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:40 INFO - Contents: 10:19:40 INFO - build_url:https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:19:41 INFO - Running post-action listener: _resource_record_post_action 10:19:41 INFO - Running post-action listener: set_extra_try_arguments 10:19:41 INFO - ##### 10:19:41 INFO - ##### Running populate-webroot step. 10:19:41 INFO - ##### 10:19:41 INFO - Running pre-action listener: _resource_record_pre_action 10:19:41 INFO - Running main action method: populate_webroot 10:19:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:41 INFO - '--tppagecycles', 10:19:41 INFO - '7'], 10:19:41 INFO - 'tests': ['tsvgm']}}, 10:19:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['damp', 'tps']}, 10:19:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'tests': ['damp', 'tps']}, 10:19:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['dromaeo_dom']}, 10:19:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['a11yr', 10:19:41 INFO - 'ts_paint', 10:19:41 INFO - 'tpaint', 10:19:41 INFO - 'sessionrestore', 10:19:41 INFO - 'sessionrestore_no_auto_restore', 10:19:41 INFO - 'tabpaint']}, 10:19:41 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:41 INFO - 'ts_paint', 10:19:41 INFO - 'tpaint', 10:19:41 INFO - 'sessionrestore', 10:19:41 INFO - 'sessionrestore_no_auto_restore', 10:19:41 INFO - 'tabpaint']}, 10:19:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:41 INFO - 'ts_paint', 10:19:41 INFO - 'tpaint', 10:19:41 INFO - 'sessionrestore', 10:19:41 INFO - 'sessionrestore_no_auto_restore', 10:19:41 INFO - 'tabpaint']}, 10:19:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:41 INFO - 'ts_paint', 10:19:41 INFO - 'tpaint', 10:19:41 INFO - 'sessionrestore', 10:19:41 INFO - 'sessionrestore_no_auto_restore', 10:19:41 INFO - 'tabpaint']}, 10:19:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['a11yr', 10:19:41 INFO - 'ts_paint', 10:19:41 INFO - 'tpaint', 10:19:41 INFO - 'sessionrestore', 10:19:41 INFO - 'sessionrestore_no_auto_restore', 10:19:41 INFO - 'tabpaint']}, 10:19:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['a11yr', 10:19:41 INFO - 'ts_paint', 10:19:41 INFO - 'tpaint', 10:19:41 INFO - 'sessionrestore', 10:19:41 INFO - 'sessionrestore_no_auto_restore', 10:19:41 INFO - 'tabpaint']}, 10:19:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['tsvgx', 10:19:41 INFO - 'tsvgr_opacity', 10:19:41 INFO - 'tart', 10:19:41 INFO - 'tscrollx', 10:19:41 INFO - 'cart']}, 10:19:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:41 INFO - 'tsvgr_opacity', 10:19:41 INFO - 'tart', 10:19:41 INFO - 'tscrollx', 10:19:41 INFO - 'cart']}, 10:19:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'talos_options': ['--disable-e10s'], 10:19:41 INFO - 'tests': ['tp5o']}, 10:19:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'tests': ['tp5o']}, 10:19:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'talos_options': ['--disable-e10s', 10:19:41 INFO - '--xperf_path', 10:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:41 INFO - 'tests': ['tp5n']}, 10:19:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:41 INFO - 'talos_options': ['--xperf_path', 10:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:41 INFO - 'tests': ['tp5n']}}, 10:19:41 INFO - 'talos.zip': {'path': '', 10:19:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:41 INFO - Running post-action listener: _resource_record_post_action 10:19:41 INFO - ##### 10:19:41 INFO - ##### Running create-virtualenv step. 10:19:41 INFO - ##### 10:19:41 INFO - Running pre-action listener: _resource_record_pre_action 10:19:41 INFO - Running main action method: create_virtualenv 10:19:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:41 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 10:19:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:41 INFO - Using real prefix '/usr' 10:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:43 INFO - Installing pip.................done. 10:19:43 INFO - Return code: 0 10:19:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:19:43 INFO - Using env: {'DISPLAY': ':0', 10:19:43 INFO - 'HOME': '/home/cltbld', 10:19:43 INFO - 'LANG': 'en_US.UTF-8', 10:19:43 INFO - 'LANGUAGE': 'en_US:en', 10:19:43 INFO - 'LOGNAME': 'cltbld', 10:19:43 INFO - 'MAIL': '/var/mail/cltbld', 10:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:43 INFO - 'MOZ_NO_REMOTE': '1', 10:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:43 INFO - 'NO_EM_RESTART': '1', 10:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:43 INFO - 'PWD': '/builds/slave/test', 10:19:43 INFO - 'SHELL': '/bin/bash', 10:19:43 INFO - 'SHLVL': '1', 10:19:43 INFO - 'TERM': 'linux', 10:19:43 INFO - 'TMOUT': '86400', 10:19:43 INFO - 'USER': 'cltbld', 10:19:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:43 INFO - '_': '/tools/buildbot/bin/python'} 10:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:43 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 10:19:43 INFO - Cleaning up... 10:19:43 INFO - Return code: 0 10:19:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:19:43 INFO - Using env: {'DISPLAY': ':0', 10:19:43 INFO - 'HOME': '/home/cltbld', 10:19:43 INFO - 'LANG': 'en_US.UTF-8', 10:19:43 INFO - 'LANGUAGE': 'en_US:en', 10:19:43 INFO - 'LOGNAME': 'cltbld', 10:19:43 INFO - 'MAIL': '/var/mail/cltbld', 10:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:43 INFO - 'MOZ_NO_REMOTE': '1', 10:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:43 INFO - 'NO_EM_RESTART': '1', 10:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:43 INFO - 'PWD': '/builds/slave/test', 10:19:43 INFO - 'SHELL': '/bin/bash', 10:19:43 INFO - 'SHLVL': '1', 10:19:43 INFO - 'TERM': 'linux', 10:19:43 INFO - 'TMOUT': '86400', 10:19:43 INFO - 'USER': 'cltbld', 10:19:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:43 INFO - '_': '/tools/buildbot/bin/python'} 10:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:44 INFO - Downloading/unpacking psutil>=0.7.1 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:46 INFO - Installing collected packages: psutil 10:19:46 INFO - Running setup.py install for psutil 10:19:46 INFO - building 'psutil._psutil_linux' extension 10:19:46 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 10:19:46 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 10:19:46 INFO - building 'psutil._psutil_posix' extension 10:19:46 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 10:19:46 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 10:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:46 INFO - Successfully installed psutil 10:19:46 INFO - Cleaning up... 10:19:46 INFO - Return code: 0 10:19:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:19:46 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')]} 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:46 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')]} 10:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:46 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:46 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 10:19:46 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 10:19:46 INFO - Using env: {'DISPLAY': ':0', 10:19:46 INFO - 'HOME': '/home/cltbld', 10:19:46 INFO - 'LANG': 'en_US.UTF-8', 10:19:46 INFO - 'LANGUAGE': 'en_US:en', 10:19:46 INFO - 'LOGNAME': 'cltbld', 10:19:46 INFO - 'MAIL': '/var/mail/cltbld', 10:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:46 INFO - 'MOZ_NO_REMOTE': '1', 10:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:46 INFO - 'NO_EM_RESTART': '1', 10:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:46 INFO - 'PWD': '/builds/slave/test', 10:19:46 INFO - 'SHELL': '/bin/bash', 10:19:46 INFO - 'SHLVL': '1', 10:19:46 INFO - 'TERM': 'linux', 10:19:46 INFO - 'TMOUT': '86400', 10:19:46 INFO - 'USER': 'cltbld', 10:19:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:46 INFO - '_': '/tools/buildbot/bin/python'} 10:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:19:48 INFO - Installing collected packages: mozsystemmonitor 10:19:48 INFO - Running setup.py install for mozsystemmonitor 10:19:48 INFO - Successfully installed mozsystemmonitor 10:19:48 INFO - Cleaning up... 10:19:48 INFO - Return code: 0 10:19:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:48 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:48 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 10:19:48 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 10:19:48 INFO - Using env: {'DISPLAY': ':0', 10:19:48 INFO - 'HOME': '/home/cltbld', 10:19:48 INFO - 'LANG': 'en_US.UTF-8', 10:19:48 INFO - 'LANGUAGE': 'en_US:en', 10:19:48 INFO - 'LOGNAME': 'cltbld', 10:19:48 INFO - 'MAIL': '/var/mail/cltbld', 10:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:48 INFO - 'MOZ_NO_REMOTE': '1', 10:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:48 INFO - 'NO_EM_RESTART': '1', 10:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:48 INFO - 'PWD': '/builds/slave/test', 10:19:48 INFO - 'SHELL': '/bin/bash', 10:19:48 INFO - 'SHLVL': '1', 10:19:48 INFO - 'TERM': 'linux', 10:19:48 INFO - 'TMOUT': '86400', 10:19:48 INFO - 'USER': 'cltbld', 10:19:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:48 INFO - '_': '/tools/buildbot/bin/python'} 10:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:49 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 10:19:49 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 10:19:49 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 10:19:49 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 10:19:49 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 10:19:49 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 10:19:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 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 10:19:51 INFO - Downloading docopt-0.6.1.tar.gz 10:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:51 INFO - Running setup.py install for blobuploader 10:19:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:51 INFO - Running setup.py install for requests 10:19:52 INFO - Running setup.py install for docopt 10:19:52 INFO - Successfully installed blobuploader requests docopt 10:19:52 INFO - Cleaning up... 10:19:52 INFO - Return code: 0 10:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:52 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:52 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 10:19:52 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 10:19:52 INFO - Using env: {'DISPLAY': ':0', 10:19:52 INFO - 'HOME': '/home/cltbld', 10:19:52 INFO - 'LANG': 'en_US.UTF-8', 10:19:52 INFO - 'LANGUAGE': 'en_US:en', 10:19:52 INFO - 'LOGNAME': 'cltbld', 10:19:52 INFO - 'MAIL': '/var/mail/cltbld', 10:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:52 INFO - 'MOZ_NO_REMOTE': '1', 10:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:52 INFO - 'NO_EM_RESTART': '1', 10:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:52 INFO - 'PWD': '/builds/slave/test', 10:19:52 INFO - 'SHELL': '/bin/bash', 10:19:52 INFO - 'SHLVL': '1', 10:19:52 INFO - 'TERM': 'linux', 10:19:52 INFO - 'TMOUT': '86400', 10:19:52 INFO - 'USER': 'cltbld', 10:19:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:52 INFO - '_': '/tools/buildbot/bin/python'} 10:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:52 INFO - Running setup.py (path:/tmp/pip-93hppB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:52 INFO - Running setup.py (path:/tmp/pip-MDdrAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:52 INFO - Running setup.py (path:/tmp/pip-RC3AHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:52 INFO - Running setup.py (path:/tmp/pip-WqcY1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:52 INFO - Running setup.py (path:/tmp/pip-S2zs36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:52 INFO - Running setup.py (path:/tmp/pip-I1mDVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:53 INFO - Running setup.py (path:/tmp/pip-H79lXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:53 INFO - Running setup.py (path:/tmp/pip-kcdfIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:53 INFO - Running setup.py (path:/tmp/pip-1Pmk4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:53 INFO - Running setup.py (path:/tmp/pip-fdRz0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:53 INFO - Running setup.py (path:/tmp/pip-3H81AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:53 INFO - Running setup.py (path:/tmp/pip-FVQpTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:53 INFO - Running setup.py (path:/tmp/pip-LDlugF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:53 INFO - Running setup.py (path:/tmp/pip-mNNt14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:53 INFO - Running setup.py (path:/tmp/pip-DSmvDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:53 INFO - Running setup.py (path:/tmp/pip-_YYLw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:53 INFO - Running setup.py (path:/tmp/pip-qTUrKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:53 INFO - Running setup.py install for manifestparser 10:19:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:53 INFO - Running setup.py install for mozcrash 10:19:54 INFO - Running setup.py install for mozdebug 10:19:54 INFO - Running setup.py install for mozdevice 10:19:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozfile 10:19:54 INFO - Running setup.py install for mozhttpd 10:19:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozinfo 10:19:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozInstall 10:19:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozleak 10:19:54 INFO - Running setup.py install for mozlog 10:19:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for moznetwork 10:19:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:54 INFO - Running setup.py install for mozprocess 10:19:55 INFO - Running setup.py install for mozprofile 10:19:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:55 INFO - Running setup.py install for mozrunner 10:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:55 INFO - Running setup.py install for mozscreenshot 10:19:55 INFO - Running setup.py install for moztest 10:19:55 INFO - Running setup.py install for mozversion 10:19:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:55 INFO - Cleaning up... 10:19:55 INFO - Return code: 0 10:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:55 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:55 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 10:19:55 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 10:19:55 INFO - Using env: {'DISPLAY': ':0', 10:19:55 INFO - 'HOME': '/home/cltbld', 10:19:55 INFO - 'LANG': 'en_US.UTF-8', 10:19:55 INFO - 'LANGUAGE': 'en_US:en', 10:19:55 INFO - 'LOGNAME': 'cltbld', 10:19:55 INFO - 'MAIL': '/var/mail/cltbld', 10:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:55 INFO - 'MOZ_NO_REMOTE': '1', 10:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:55 INFO - 'NO_EM_RESTART': '1', 10:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:55 INFO - 'PWD': '/builds/slave/test', 10:19:55 INFO - 'SHELL': '/bin/bash', 10:19:55 INFO - 'SHLVL': '1', 10:19:55 INFO - 'TERM': 'linux', 10:19:55 INFO - 'TMOUT': '86400', 10:19:55 INFO - 'USER': 'cltbld', 10:19:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:55 INFO - '_': '/tools/buildbot/bin/python'} 10:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:55 INFO - Running setup.py (path:/tmp/pip-cheyQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:55 INFO - Running setup.py (path:/tmp/pip-mrwZXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:55 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)) 10:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:55 INFO - Running setup.py (path:/tmp/pip-CuRYFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:56 INFO - Running setup.py (path:/tmp/pip-KJwpj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:56 INFO - Running setup.py (path:/tmp/pip-PcV7BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:56 INFO - Running setup.py (path:/tmp/pip-hrSSJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:56 INFO - Running setup.py (path:/tmp/pip-ey4h4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:56 INFO - Running setup.py (path:/tmp/pip-GTyUNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:56 INFO - Running setup.py (path:/tmp/pip-DbrHDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:56 INFO - Running setup.py (path:/tmp/pip-0E6s6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:56 INFO - Running setup.py (path:/tmp/pip-GT6Zpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:56 INFO - Running setup.py (path:/tmp/pip-RFfVfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:56 INFO - Running setup.py (path:/tmp/pip-aFfI3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:56 INFO - Running setup.py (path:/tmp/pip-ctpnpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:56 INFO - Running setup.py (path:/tmp/pip-Na1xt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:56 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)) 10:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:56 INFO - Running setup.py (path:/tmp/pip-vfUJdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:57 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)) 10:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:57 INFO - Running setup.py (path:/tmp/pip-aYcQU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:57 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)) 10:19:57 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)) 10:19:57 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)) 10:19:57 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)) 10:19:57 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)) 10:19:57 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)) 10:19:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:58 INFO - Downloading blessings-1.6.tar.gz 10:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:59 INFO - Installing collected packages: blessings 10:19:59 INFO - Running setup.py install for blessings 10:19:59 INFO - Successfully installed blessings 10:19:59 INFO - Cleaning up... 10:19:59 INFO - Return code: 0 10:19:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:59 INFO - Reading from file tmpfile_stdout 10:19:59 INFO - Current package versions: 10:19:59 INFO - argparse == 1.2.1 10:19:59 INFO - blessings == 1.6 10:19:59 INFO - blobuploader == 1.2.4 10:19:59 INFO - docopt == 0.6.1 10:19:59 INFO - manifestparser == 1.1 10:19:59 INFO - mozInstall == 1.12 10:19:59 INFO - mozcrash == 0.17 10:19:59 INFO - mozdebug == 0.1 10:19:59 INFO - mozdevice == 0.48 10:19:59 INFO - mozfile == 1.2 10:19:59 INFO - mozhttpd == 0.7 10:19:59 INFO - mozinfo == 0.9 10:19:59 INFO - mozleak == 0.1 10:19:59 INFO - mozlog == 3.1 10:19:59 INFO - moznetwork == 0.27 10:19:59 INFO - mozprocess == 0.22 10:19:59 INFO - mozprofile == 0.28 10:19:59 INFO - mozrunner == 6.11 10:19:59 INFO - mozscreenshot == 0.1 10:19:59 INFO - mozsystemmonitor == 0.0 10:19:59 INFO - moztest == 0.7 10:19:59 INFO - mozversion == 1.4 10:19:59 INFO - psutil == 3.1.1 10:19:59 INFO - requests == 1.2.3 10:19:59 INFO - wsgiref == 0.1.2 10:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:59 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 10:19:59 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 10:19:59 INFO - Using env: {'DISPLAY': ':0', 10:19:59 INFO - 'HOME': '/home/cltbld', 10:19:59 INFO - 'LANG': 'en_US.UTF-8', 10:19:59 INFO - 'LANGUAGE': 'en_US:en', 10:19:59 INFO - 'LOGNAME': 'cltbld', 10:19:59 INFO - 'MAIL': '/var/mail/cltbld', 10:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:59 INFO - 'MOZ_NO_REMOTE': '1', 10:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:59 INFO - 'NO_EM_RESTART': '1', 10:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:59 INFO - 'PWD': '/builds/slave/test', 10:19:59 INFO - 'SHELL': '/bin/bash', 10:19:59 INFO - 'SHLVL': '1', 10:19:59 INFO - 'TERM': 'linux', 10:19:59 INFO - 'TMOUT': '86400', 10:19:59 INFO - 'USER': 'cltbld', 10:19:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:59 INFO - '_': '/tools/buildbot/bin/python'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 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)) 10:19:59 INFO - Cleaning up... 10:19:59 INFO - Return code: 0 10:19:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:19:59 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 10:19:59 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 10:19:59 INFO - Using env: {'DISPLAY': ':0', 10:19:59 INFO - 'HOME': '/home/cltbld', 10:19:59 INFO - 'LANG': 'en_US.UTF-8', 10:19:59 INFO - 'LANGUAGE': 'en_US:en', 10:19:59 INFO - 'LOGNAME': 'cltbld', 10:19:59 INFO - 'MAIL': '/var/mail/cltbld', 10:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:59 INFO - 'MOZ_NO_REMOTE': '1', 10:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:59 INFO - 'NO_EM_RESTART': '1', 10:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:59 INFO - 'PWD': '/builds/slave/test', 10:19:59 INFO - 'SHELL': '/bin/bash', 10:19:59 INFO - 'SHLVL': '1', 10:19:59 INFO - 'TERM': 'linux', 10:19:59 INFO - 'TMOUT': '86400', 10:19:59 INFO - 'USER': 'cltbld', 10:19:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:59 INFO - '_': '/tools/buildbot/bin/python'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 INFO - Downloading/unpacking jsonschema 10:19:59 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 10:19:59 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 10:19:59 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 10:19:59 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 10:19:59 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 10:19:59 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 10:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:01 INFO - Downloading/unpacking functools32 (from jsonschema) 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 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 10:20:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:20:02 INFO - warning: no files found matching '*.txt' 10:20:02 INFO - no previously-included directories found matching 'build' 10:20:02 INFO - no previously-included directories found matching 'dist' 10:20:02 INFO - no previously-included directories found matching '.git*' 10:20:02 INFO - Installing collected packages: jsonschema, functools32 10:20:02 INFO - Running setup.py install for functools32 10:20:02 INFO - warning: no files found matching '*.txt' 10:20:02 INFO - no previously-included directories found matching 'build' 10:20:02 INFO - no previously-included directories found matching 'dist' 10:20:02 INFO - no previously-included directories found matching '.git*' 10:20:02 INFO - Successfully installed jsonschema functools32 10:20:02 INFO - Cleaning up... 10:20:02 INFO - Return code: 0 10:20:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:02 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 0x7f91c6de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, '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': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', '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 10:20:02 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 10:20:02 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 10:20:02 INFO - Using env: {'DISPLAY': ':0', 10:20:02 INFO - 'HOME': '/home/cltbld', 10:20:02 INFO - 'LANG': 'en_US.UTF-8', 10:20:02 INFO - 'LANGUAGE': 'en_US:en', 10:20:02 INFO - 'LOGNAME': 'cltbld', 10:20:02 INFO - 'MAIL': '/var/mail/cltbld', 10:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:02 INFO - 'MOZ_NO_REMOTE': '1', 10:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:02 INFO - 'NO_EM_RESTART': '1', 10:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:02 INFO - 'PWD': '/builds/slave/test', 10:20:02 INFO - 'SHELL': '/bin/bash', 10:20:02 INFO - 'SHLVL': '1', 10:20:02 INFO - 'TERM': 'linux', 10:20:02 INFO - 'TMOUT': '86400', 10:20:02 INFO - 'USER': 'cltbld', 10:20:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:02 INFO - '_': '/tools/buildbot/bin/python'} 10:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:02 INFO - Downloading/unpacking flake8 10:20:02 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 10:20:02 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 10:20:02 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 10:20:02 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 10:20:02 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 10:20:02 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 10:20:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:20:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:20:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 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 10:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:20:05 INFO - no previously-included directories found matching 'docs/_build' 10:20:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:20:05 INFO - Running setup.py install for pep8 10:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:20:05 INFO - no previously-included directories found matching 'docs/_build' 10:20:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:20:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:20:05 INFO - Cleaning up... 10:20:05 INFO - Return code: 0 10:20:05 INFO - Running post-action listener: _resource_record_post_action 10:20:05 INFO - Running post-action listener: _start_resource_monitoring 10:20:05 INFO - Starting resource monitoring. 10:20:05 INFO - ##### 10:20:05 INFO - ##### Running install step. 10:20:05 INFO - ##### 10:20:05 INFO - Running pre-action listener: _resource_record_pre_action 10:20:05 INFO - Running main action method: install 10:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:05 INFO - Reading from file tmpfile_stdout 10:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:05 INFO - Reading from file tmpfile_stdout 10:20:05 INFO - Output received: 10:20:05 INFO - Usage: mozinstall [options] installer 10:20:05 INFO - Options: 10:20:05 INFO - -h, --help show this help message and exit 10:20:05 INFO - -d DEST, --destination=DEST 10:20:05 INFO - Directory to install application into. [default: 10:20:05 INFO - "/builds/slave/test"] 10:20:05 INFO - --app=APP Application being installed. [default: firefox] 10:20:05 INFO - mkdir: /builds/slave/test/build/application 10:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:20:22 INFO - Reading from file tmpfile_stdout 10:20:22 INFO - Output received: 10:20:22 INFO - /builds/slave/test/build/application/firefox/firefox 10:20:22 INFO - Running post-action listener: _resource_record_post_action 10:20:22 INFO - ##### 10:20:22 INFO - ##### Running run-tests step. 10:20:22 INFO - ##### 10:20:22 INFO - Running pre-action listener: _resource_record_pre_action 10:20:22 INFO - Running main action method: run_tests 10:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:22 INFO - Python 2.7.3 10:20:22 INFO - Return code: 0 10:20:22 INFO - grabbing minidump binary from tooltool 10:20: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')]} 10:20:22 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 0x2cec810>, '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 0x2ced710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cedba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20:22 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 10:20:22 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 10:20:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:22 INFO - Return code: 0 10:20:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:20:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:20:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:20:23 INFO - Return code: 0 10:20:23 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/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 10:20:23 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/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 10:20:23 INFO - Using env: {'DISPLAY': ':0', 10:20:23 INFO - 'HOME': '/home/cltbld', 10:20:23 INFO - 'LANG': 'en_US.UTF-8', 10:20:23 INFO - 'LANGUAGE': 'en_US:en', 10:20:23 INFO - 'LOGNAME': 'cltbld', 10:20:23 INFO - 'MAIL': '/var/mail/cltbld', 10:20:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:23 INFO - 'MOZ_NO_REMOTE': '1', 10:20:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:23 INFO - 'NO_EM_RESTART': '1', 10:20:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:23 INFO - 'PWD': '/builds/slave/test', 10:20:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:23 INFO - 'SHELL': '/bin/bash', 10:20:23 INFO - 'SHLVL': '1', 10:20:23 INFO - 'TERM': 'linux', 10:20:23 INFO - 'TMOUT': '86400', 10:20:23 INFO - 'USER': 'cltbld', 10:20:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215', 10:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:23 INFO - '_': '/tools/buildbot/bin/python'} 10:20:23 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/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 10:20:23 INFO - mozversion application_buildid: 20160421073719 10:20:23 INFO - mozversion application_changeset: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 10:20:23 INFO - mozversion application_display_name: Nightly 10:20:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:23 INFO - mozversion application_name: Firefox 10:20:23 INFO - mozversion application_remotingname: firefox 10:20:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:20:23 INFO - mozversion application_vendor: Mozilla 10:20:23 INFO - mozversion application_version: 48.0a1 10:20:23 INFO - mozversion platform_buildid: 20160421073719 10:20:23 INFO - mozversion platform_changeset: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 10:20:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:20:23 INFO - mozversion platform_version: 48.0a1 10:20:23 INFO - using testdate: 1461259223 10:20:23 INFO - actual date: 1461259223 10:20:23 INFO - starting webserver on 'localhost:47475' 10:20:23 INFO - SUITE-START | Running 2 tests 10:20:23 INFO - TEST-START | dromaeo_css 10:20:23 INFO - operating with platform_type : linux_ 10:20:23 INFO - Initialising browser for dromaeo_css test... 10:20:23 INFO - TEST-INFO | started process 11482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI6f5YD/profile http://localhost:47475/getInfo.html) 10:20:27 INFO - PROCESS | 11482 | __metrics Screen width/height:1600/1200 10:20:27 INFO - PROCESS | 11482 | colorDepth:24 10:20:27 INFO - PROCESS | 11482 | Browser inner width/height: 1024/697 10:20:27 INFO - PROCESS | 11482 | __metrics 10:20:29 ERROR - PROCESS | 11482 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:20:29 INFO - TEST-INFO | 11482: exit 0 10:20:29 INFO - Browser initialized. 10:20:29 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:29 INFO - TEST-INFO | started process 11562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI6f5YD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:41 INFO - PROCESS | 11562 | RSS: Main: 152920064 10:20:41 INFO - PROCESS | 11562 | 10:21:32 INFO - PROCESS | 11562 | 1461259292726 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] 10:23:40 INFO - PROCESS | 11562 | Cycle 1(1): loaded http://localhost:47475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47475/tests/dromaeo/cssquery-ext.html) 10:23:41 INFO - PROCESS | 11562 | RSS: Main: 252039168 10:23:41 INFO - PROCESS | 11562 | 10:26:43 INFO - PROCESS | 11562 | Cycle 1(1): loaded http://localhost:47475/tests/dromaeo/cssquery-ext.html (next: http://localhost:47475/tests/dromaeo/cssquery-jquery.html) 10:26:44 INFO - PROCESS | 11562 | RSS: Main: 243191808 10:26:44 INFO - PROCESS | 11562 | 10:29:45 INFO - PROCESS | 11562 | Cycle 1(1): loaded http://localhost:47475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47475/tests/dromaeo/cssquery-mootools.html) 10:29:46 INFO - PROCESS | 11562 | RSS: Main: 233246720 10:29:46 INFO - PROCESS | 11562 | 10:32:48 INFO - PROCESS | 11562 | Cycle 1(1): loaded http://localhost:47475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47475/tests/dromaeo/cssquery-prototype.html) 10:32:48 INFO - PROCESS | 11562 | RSS: Main: 229339136 10:32:48 INFO - PROCESS | 11562 | 10:35:51 INFO - PROCESS | 11562 | Cycle 1(1): loaded http://localhost:47475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47475/tests/dromaeo/cssquery-yui.html) 10:35:52 INFO - PROCESS | 11562 | RSS: Main: 217235456 10:35:52 INFO - PROCESS | 11562 | 10:38:54 INFO - PROCESS | 11562 | Cycle 1(1): loaded http://localhost:47475/tests/dromaeo/cssquery-yui.html (next: http://localhost:47475/tests/dromaeo/cssquery-dojo.html) 10:38:55 INFO - PROCESS | 11562 | RSS: Main: 255078400 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | __start_tp_report 10:38:55 INFO - PROCESS | 11562 | _x_x_mozilla_page_load 10:38:55 INFO - PROCESS | 11562 | _x_x_mozilla_page_load_details 10:38:55 INFO - PROCESS | 11562 | |i|pagename|runs| 10:38:55 INFO - PROCESS | 11562 | |0;dojo.html;3079.2917628945343;3105.487594546897;3131.937361252775;3143.9528407073913;3176.1424415407832;5158.535731784148;5228.424873263947;5287.180487024512;5313.920291195625;5358.115910874706;5247.055530004607;5255.605829562779;5279.023380674568;5281.471852814717;5285;4664.2537194048955;4710.458297295812;4795.5444232798;4812.590929770974;4850.539198776129;4773.498782627827;4800.183968725325;4806.879828004293;4857.902841943159;4895.657303988723;4651.604613607848;4668.159731248374;4710.5289471052965;4734.455537613184;4802.063597598452;4760.547747963938;4764.8332308369045;4783.545563171493;4793.520647935214;4827.951720482785;4650.674452788307;4713.717176969359;4737.336772851803;4737.952620473786;4799.208130658437;5122.487751224885;5156.896862062776;5190.71451070191;5202.843914682566;5207.791688332462;5518.503334699856;5525.143602741581;5547.084731019418;5547.306586676666;5548.750306236229;5510.311211098613;5563.610547261694;5564.666120032811;5564.888702225973;5594.720263986785;5193.298904647862;5199.246109314128;5215.035218484592;5217.713025783618;5271.4992075753125;5705.229793977843;5711.400302968212;5711.514521265739;5715.857103572361;5716.485516303553;5386.91919621206;5463.180522921593;5473.397926228112;5486.259354987025;5535.059039963216;5594.552435805207;5600;5601.411851755588;5609.635373700697;5625.071863142617;5565.248691426606;5573.5819813514145;5580.637258578179;5581.441855814386;5588.189712491666;5527.778888844482;5557.138643510262;5577.749001294951;5582.665040097607;5615.298087739033;4244.3209086546;4255.616994470451;4255.893602659897;4262;4296.291111966553;3801.201747632973;3826.9808650956566;3839.040239940015;3854.6530812226474;3857.5756666766633;5173.3533308336455;5174.275601415805;5211.218317252366;5237.450067742909;5243.764030618631;5531.3362396512675;5540.944590554042;5551.306086739158;5552.639078459887;5566.248556444909;5217.50433708797;5218.817341393033;5220.582353411718;5248.186531087687;5249.2651028855225;4778.37881075458;4825.10735513931;4860.829870954571;4892.168331383673;4902.730349830794;5788.88422231553;5803.767849286066;5806.04200306953;5807.157962095557;5811.360750317462;5504.669719816824;5622.325320961347;5624.409437009137;5628.915566266591;5671.092625179951;5738.167965644875;5781.190633311256;5790.276215473066;5814.273215848019;5829.679367634821;5494.642848214853;5521.641093329082;5527.640703354269;5529.198266251291;5533.972330138324;5431.158170483582;5627.0715331971405;5638.23883775685;5640.520555752642;5643.604947653625;5531.585131115102;5553.861153471195;5558.138488534284;5562.833115006556;5609.49514543693;5521.199426083276;5544.61187716856;5545.7781688732;5546.722663866871;5548.750306236309;5344.866378340573;5403.081476149143;5427.1859221115565;5445.891082178414;5478.780848766005;5530.391656917816;5538.224648549287;5545.833624991256;5559.8610034747835;5583.804566840141;5383.81156659515;5403.648762830403;5414.810481633124;5419.187121931742;5437.238786569805 10:38:55 INFO - PROCESS | 11562 | |1;ext.html;595.4581330988798;621.8165641135864;633.4932054356514;644.983875403115;658.2758965138348;29853;30537.84731076344;32087.67912320873;33064.66935330646;33175.33649327018;38729.612703872954;39257.41113883294;39289.80355098221;39372.40941385881;39463.802680986555;7847.764567062997;8299.294559962394;8474.872876906851;8475.872861907077;8481.872771908425;7893.368530517545;8002.239787220234;8016.438849280553;10249.948750256239;10617.84073238902;10197.286189966706;10311.123554497877;10312.845307320396;10313.742156446111;10319.89680103197;7975.561344126071;10151.644692435766;10241.84637230442;10259.487025648763;10271.845922311171;10115;10547.894521054845;10548.103411209979;10551.419671918042;10558.736031599195;35620.28759424797;36574.817125914466;36585;36637.08407289813;36690.266194676224;3259.788113772597;3298.1259966109;3388.6272510023878;3433.896983090486;3608.4767708682357;25698.614520782205;27230.455390892268;27323.45353092947;27518;27697.446051079067;4196.538380778143;4200.831966721327;4303.225419424502;4338.696291259613;4513.661475389359;210458;211117;211837;212212;212905;33947.32105357879;34758.30483390368;34785.30429391398;51970;55461.72269138628;31447.685523144934;31505.212369690482;31785.841070794497;31792;31811.363772724417;14305.499307524187;14416.711665766627;14451.710965780836;14466.638334041523;14471.131732096108;12010.819837702442;12109.152359334938;12110.212836165621;12122;12127.757444851053;8198.672053117927;8242.587870606445;8248.051474080557;8262.793430164294;8322.6670933162;3222.6132864056462;3251.4635085210675;3274.8035117893;3317.2370354818527;3320.9833950830093;994.8159590475785;1015.9034891685278;1063.5373612478597;1082.0020026003997;1155.774623948322;29854;31114.222144446117;31406.685933140834;31591.21021974423;31933.361332773213;1102.7739313440725;1109.4578535835196;1122.2088427658482;1185.7747028064641;1230.501646833034;16497.587560311087;16789.41237056697;16945.83054169467;16946.830531694526;17081.658366832595;456560;460532;465871;466186;466667;54559.454405455435;55300.446995530336;55333.170002449995;55471.722641386536;55510.72244638751;1225.2709637765515;1294.0359432223054;1356.4099616666583;1370.1299674706634;1472.49935022093;27458.450830983667;27484.862575686995;27803.304917377227;28288.15135545937;29462.558061628664;43445;43909.56090439182;44061.33907991447;44104;44183.33724994063;264676;270485;271634;272241;272533;24345.39136521601;26634.866825665747;26854.328641784112;27159;27200.727992719818;40010.59989400069;40537.59462405456;40683;40801.59198407978;41292;36348.818255908554;36715;36765.81617092004;37200.62799371972;37776.433353500266;32921.670783292815;33072.1731956703;33136;33273.33453330968;33451;37683.81158094192;38555.22889542249;38664.80667596644;38740.6125938737;39031.414528781526;32995.67004329926;33396.66603333935;33594.66405336013;34164.65835341615;34169.65830341665;26352.472950540498;26588;26734;26951.730482695708;27089.86455067712 10:38:55 INFO - PROCESS | 11562 | |2;jquery.html;381.76712205554605;383.34065407499094;385.50655161393416;392.56033242768103;401.6465510350891;17568.297268109276;18604.34884779033;18917.05414729265;18969.336073237457;18979.71530427045;16989.405370812023;17357.132143392842;17651.293948242088;17651.82348176518;18518.537036574093;5549.250851135095;5641.18202860585;5670.886582268352;5718.799842005531;5722.513586345145;5514.751836167362;5638.661680299175;5663.546916246711;5695.743691533891;5714.200011998323;5572.3034620672415;5631.1271752878365;5635.436456354373;5638.210650508932;5642.097264437691;5450.182472629098;5589.217509548666;5628.43715628438;5635.492805647511;5646;4774.116788394123;4968.850934471935;4982.352294201767;4985.052839960396;4990.675606085593;21839.126434942584;21870.453238669;22027;22109.336719898267;22197.778022219733;2408.8072954163626;2540.4030052937546;2636.6967798703204;2750.917472475809;3096.9690303096904;6905.551139175937;13646.590602281947;13887.722245555133;14170.528220585918;14409.78385324221;1913.5407502199512;1915.3870761356372;1953.2089503751004;1992.750906136733;2059.969100463494;72640;73089;73887.63056184739;73911.89132163076;75575.62212188904;9488.430694158373;9649.131578158;9773;9818.826998525597;10212.131968782736;13657.385417656229;13750.65623359424;13760.587182384545;13773.517926872511;13784.379702913393;7335.486515943832;7438.7024519019715;7738.148803631596;7765.417593680384;7898.763037108896;7060.71757129709;7086.858262834715;7149.642517874086;7652.196519365498;7840.607969601497;6186.505079593621;6188.659623720649;6226.128342032119;6284.654344011124;6307.590006649553;1762.409592786431;1792.6056267621102;1805.268866109228;1809.4028970439724;1863.4223390748912;937.9343445958717;973.6543527047937;1025.2647443778962;1042.9843552346722;1098.2641630107846;18613.138686131548;18669.813301867078;18789.154488048072;18844.340448084524;19143.329983450512;993.4387071304834;1007.8488226765897;1024.8667673202585;1073.5383784972537;1079.3416016230094;10425.270231083752;10778;10787.67636970892;10813.729656758644;10840.45797710127;451757;455672;461825.4150715158;469508;470875;77095.22904770881;79940;81117.18882811215;81451;82242;1025.5948900184385;1063.6064656077301;1064.0370464729588;1083.5828206140693;1085.10478854945;16234.782391320461;16237.025778453331;16391.83608163903;16565.91717041407;16749.33002679879;37146.25707485889;37149;37900.81049594734;38860.805695971336;38937.805310973265;52752.736236318575;56087;56111.43888561225;56123.71938140283;56352.43647563472;8040.2361775631225;8218.342532597258;8342.082370939313;8395.24442800151;8496.745097647081;12386.504539818307;13290.136141150795;13441.731165376834;13735.587932362045;13766.380512876744;11868.703282418008;11875.643730688093;12011.699707507381;12181.512739490321;12379.75240495203;11326.660200194008;11820.290782553075;11856.525738970344;11908.821367679318;12079.27524348542;11950.223235489666;12093.153479256367;12281;12323.568675096329;12434.62696119118;8122.268995790408;8243.25810677018;8276;8465.576721163794;8742.606582703665;11534.480948357177;11796.882031179579;11887.702807429883;11962.700932476757;12015.819762703391 10:38:55 INFO - PROCESS | 11562 | |3;mootools.html;1311.2656912129214;1480.0823489436548;1488.9181095039776;1627.3409269245951;1787.2761531579706;7089.113860767404;8066.71766488173;8255.545944973024;8263.380246481523;8268.37987150963;7995.880061799077;8130.796730081736;8145.226203510671;8148.307393871513;8155.266026057654;1961.8724782889137;2018.0414303205932;2021.9494512637154;2211.0492488230057;2238.5187184755273;2140.3899888531773;2192.3861318830754;2192.901319440629;2195.879226642534;2195.9890200548975;2104.1057550541036;2120.289702949514;2129.755078166015;2133.967990480144;2149.6668016457475;1932.9323473678494;2043.5810658814908;2051.517893295082;2052.466358746729;2139.6255655260265;2055.6813693877475;2071.8964051797348;2073.460900165953;2073.668213085914;2074.2429013410147;7767.495112817649;7806.609669516558;7808.49244799092;7816.531008139473;7821.256980586835;4584.908301833944;4715.504871988426;4734.905301893978;4742;4747.525247475225;3012.9096127116222;3076.7538596912195;3118.3139709263924;3132.060381885448;3137.4352616529018;981.3130808434124;983.4099540275848;988.7528117970508;1011.1152741351318;1044.420346707577;11215.439228038565;11453.484593193243;11473.65579032622;11474.311541307548;11487;4158.4178215049915;4178.728382655178;4313.223619748475;4348.2825333819565;4382.561743825656;9837.655682051238;9857.11285984265;9880;9881.555330010167;9889.950550247202;4949;4979.726115063634;4982.825601104017;4988.625853061035;4994.825181118644;3912.667423268997;4266.935995960063;4332.0469496710675;4568.771561421916;4606.792694328763;3679.300932822755;3707.4253490708984;3747.756395834262;3794.0894185395305;3806.9428958565645;1153.4866984192122;1159.7274640459486;1170.607846371458;1174.3247632611283;1176.147293212414;795.6589637654016;864.9058940440348;884.8009197930543;900.230303090861;905.7735566108473;5224.346956630421;5303.575713942875;5512.118061110203;5539.667619942817;5609.915851262234;841.2218697704722;866.5797088412115;898.5417437107122;913.2967614936595;944.9244060475146;3468.4450487921813;3489.284696637183;3710.220853620716;3745.127436281859;3793.9241215176094;9681.806363872684;10098.394096354095;10174.236932230113;10180.287379883484;10187.08316251541;10157.695269141937;10158.39049657023;10274.434906080238;10341.741456463498;10505.107065899485;7594.696212151563;7629.2370762923265;7647.158812530617;7672.271134242238;7724.729634462767;5428.104362780097;5503;5523.226748255167;5596.737221279451;5617.297837770278;9466.668666596912;9510.048995100435;9540.141387275178;9578.185854202193;9660.855087173557;9538.23694104484;9729.85405218908;9936.602535898772;10090.09189172978;10107.090361867467;6020.217371741645;6579.342065793382;6700.83247918806;6851.246362899978;7063.611501367474;7194.820129496805;7273.818154546178;7286.307800758919;7312.488125831141;7321;6527.902081468686;6696.895012322912;6705.731770729116;6781.93218067813;6788.558743681645;6665.866682666417;6716.630585317855;6793.490488213502;6853.520253582401;6900.551464154814;5917.822465326047;5932.79235226765;5969.462748352669;5970.850728731816;5973.522118230444;4403.757793321398;4451.443569553806;4501.122281155143;4501.279795232747;4502.797374118238;4255.5957184067465;4257.446531950826;4314.762688052062;4345.239583073013;4347.65218782503 10:38:55 INFO - PROCESS | 11562 | |4;prototype.html;304.88719173905656;309.1806712212637;317.30193574136905;322.1093675985898;323.629444286292;5493.1760235964575;5573.108302671573;5591.3569939456975;5605.607607467479;5641.18202860585;5527.143292789614;5537.446255374461;5549.278593782813;5567.944320556793;5593.972030139854;4086.3053280942313;4136.834526618932;4251.574842515739;4277.379779931908;4305.784710764465;4260.3822445745345;4279.657627389817;4280.5291417944;4282.528921818597;4299.140171965604;4095.9795201023953;4249.957500424987;4250.61744443;4256.702030857841;4267.637250833667;4150.252954468195;4263.722858014219;4273.594008569181;4303.548127446605;4306.20335237982;3768.4724138620613;3773.584905660375;3777.0557360659836;3780.092777733352;3784.2242340320167;5214.6871187728475;5347.491988261109;5356;5369.409364969889;5375.865603359908;4854.417469903598;4868.367112275417;4869.8782530436665;4886.51134886512;4891.972685735964;5788.218590490314;5798.217240672498;5802.216700745387;5808.6224395414165;5831.504322132624;4071.7760523171214;4072.8370865165357;4096.3855421686685;4101.138760860223;4103.220388126247;5821.446962538552;6141.140240366308;6149.739303442783;6153.507719382439;6174.59865108771;4128.4632997710105;4149.771762553089;4150.730202536825;4158.979205103955;4170;4194.622483976456;4198.097409057067;4209.221294060609;4209.431726716915;4210.073783767628;4717.669763116549;4855.247436647325;4858.1012512685265;4864.391951006124;4870.853874383774;5851.502622277154;5888.116782482576;5891.407780576533;5891.793787217427;5953.404659534012;1453.7528620134603;1477.1580199286518;1478.6894752101964;1491.3512622009462;1491.4108926973784;897.8518544440094;925.9675911343071;959.5921733263475;974.6783561424713;982.3369225772718;5567.526760225345;5569.749361278752;5579.776808927679;5594.916076258859;5639.125935479925;6035.547333949971;6038.486728628028;6041.305249896318;6041.758329666852;6049.818505444844;5470.835874923759;5551.057939292182;5601.60788744784;5639.548836093103;5665.745041473061;3200.4719221328687;3200.5519227308196;3215.3087086276096;3216.8552415141376;3224.951625725616;6061.787837425669;6170.475509581646;6187.504999600022;6216.875662486725;6228.532860035425;6102.816915492543;6128.85490078469;6132.233470816148;6170.876582468415;6189.907151392733;6162.291336496361;6194.4115309045565;6226.906596401058;6229.719662615194;6230.56386052981;5803.593748437737;6005.609635373687;6031.819045428644;6038.456538911519;6063.848403789941;5906.497947674496;5956.702164891652;5957.910631340446;5959.404059594006;5971.373005834499;5938;6218.595791273553;6231.626102433868;6244.1570387997035;6277.529185311028;4140.544540100526;4160.604742549453;4170.416141740098;4170.666346692196;4172.541020487804;5959.404059594006;5991;5995.250593675791;6003.2796064470795;6040.848978775566;5661.867626474639;5849;5941.970290148694;5998.49012833914;6026.216591843032;5944;5946.405359464019;5949.970250148722;5955.583109182316;5974.790882319098;5433.157860531624;5610.5231055360755;5694.914576281442;5893.764249429974;5927.31835838884;5965.9105113422465;5988.461038506555;5992.910106348321;6007.30915944672;6034.064719968412;5838.4453476919625;5850.356460789395;5908.438698323653;5922.200502932049;5926.407359264039 10:38:55 INFO - PROCESS | 11562 | |5;yui.html;804.9517028978262;821.7288294862695;824.5135370131621;836.0886633569409;851.2083762101247;13810.792838107436;14250.714985700306;14383.712325753504;14401.63995900103;14497.782533262009;13050.673733156676;13296.734065318687;13319;13340.599782006531;13346.599602011931;672.3646154384109;790.0913948958686;818.2635627934876;820.1757233979841;820.7537738678402;815.351795322717;815.6859609050499;817.7546735979212;817.7546735979212;818.014292777205;708.3624737736027;855.1662129423825;859.6303589456531;859.96130174142;860.0195776814437;833.2833762963846;843.371688092369;843.7468759372164;843.7553109598209;845.6490556419079;609.3906093906094;610.7282259394572;610.8320211941707;616.0205273614929;618.8576627375729;13605;13681.521146759915;13697.315134243348;13698.315084245747;13774.586762397144;13622.318884055758;13659.658508537266;14074.22591757453;14403.279836008158;14479.565613031626;10751.462426878625;11017.83473247902;11043.282186657842;11163.386013769239;11175.608853690082;3849.6920246380223;3881.340172170738;3882.2081242306667;3924.9803750981064;3985.262726395626;54817.451825481636;54921.45078549203;55656.72171639156;55796.6050848728;55874.441255587735;10664.466776661136;11164.776704465865;11181.329120252649;11350.035247004098;11360.375179365214;19965.900170499055;19968.70046949297;20018.199272029247;20045.899770501055;20057.799422005886;7858.174891636296;7941.960290198512;8430.978436189556;8526;8633.223009929137;4406.4051353066925;4439.400680908101;4477.2164871147415;4516.841910533116;4543.795529201194;3320.352531256382;3374.6962773350515;3406.489026646023;3414.914627134292;3415.4193787055765;558.7764894042334;600.3246347858659;642.5052709413819;662.6057495789997;662.8641128568631;590.2739630254811;690.2200513419804;692.6052150274295;697.1285892634207;704.5244459989589;8892.860352040158;8976.730698078938;9321.860172097424;9370.531473426301;9546.522673866419;728.5446595877577;730.5069078372078;732.9910716508762;735.6505659811654;744.3152299884119;4279;4385.473743150778;4473.709208901411;4589.495155532889;4719.528047195253;48294.5170548297;48790.26814597784;51190;61497;61879.6906015467;48561.514384856404;49853;49901.750491248036;50348.49651503438;52966.47033529692;43283.350749738776;43433;45466.54533454689;45809.02241354301;46610.53389466062;9184.678536251198;9300.023497532662;9305.581248843682;9318.95340523293;9366.67216647414;27663;28939;29172.56241156342;29499.41001180007;32984.67015329816;39899.20957509148;40275.194496109325;41384;41875.162496750505;42269.78865105655;10226.590936362461;10461.110805581611;10544.89455105439;11622.76754464889;11707.121965852424;12980.935095324841;13084.411201495765;13601.795973060214;13607.931960340135;14323.069000514934;11387.772244554897;11448.3703396314;11510.94244528772;11729.41352932367;12110.939445302716;11687.298762074302;12004.879951200377;12446.813297800722;12709.110362274921;12995.28525931083;12167.878321216675;12168.08739344535;12282.692932676755;12594.181378210387;13059.542915997894;10239.846402303823;10625.726124526878;11056.834147487954;11107;11346.0355869752;10971.23201375896;10988.486072825392;11135.552378190783;11232.606858759904;11336.94331528337 10:38:55 INFO - PROCESS | 11562 | __end_tp_report 10:38:55 INFO - PROCESS | 11562 | __start_cc_report 10:38:55 INFO - PROCESS | 11562 | _x_x_mozilla_cycle_collect,873 10:38:55 INFO - PROCESS | 11562 | __end_cc_report 10:38:55 INFO - PROCESS | 11562 | __startTimestamp1461260335076__endTimestamp 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | ------- Summary: start ------- 10:38:55 INFO - PROCESS | 11562 | Number of tests: 6 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | [#0] dojo.html Cycles:165 Average:5201.95 Median:5427.19 stddev:577.03 (10.6%) stddev-sans-first:554.26 10:38:55 INFO - PROCESS | 11562 | Values: 3079.3 3105.5 3131.9 3144.0 3176.1 5158.5 5228.4 5287.2 5313.9 5358.1 5247.1 5255.6 5279.0 5281.5 5285.0 4664.3 4710.5 4795.5 4812.6 4850.5 4773.5 4800.2 4806.9 4857.9 4895.7 4651.6 4668.2 4710.5 4734.5 4802.1 4760.5 4764.8 4783.5 4793.5 4828.0 4650.7 4713.7 4737.3 4738.0 4799.2 5122.5 5156.9 5190.7 5202.8 5207.8 5518.5 5525.1 5547.1 5547.3 5548.8 5510.3 5563.6 5564.7 5564.9 5594.7 5193.3 5199.2 5215.0 5217.7 5271.5 5705.2 5711.4 5711.5 5715.9 5716.5 5386.9 5463.2 5473.4 5486.3 5535.1 5594.6 5600.0 5601.4 5609.6 5625.1 5565.2 5573.6 5580.6 5581.4 5588.2 5527.8 5557.1 5577.7 5582.7 5615.3 4244.3 4255.6 4255.9 4262.0 4296.3 3801.2 3827.0 3839.0 3854.7 3857.6 5173.4 5174.3 5211.2 5237.5 5243.8 5531.3 5540.9 5551.3 5552.6 5566.2 5217.5 5218.8 5220.6 5248.2 5249.3 4778.4 4825.1 4860.8 4892.2 4902.7 5788.9 5803.8 5806.0 5807.2 5811.4 5504.7 5622.3 5624.4 5628.9 5671.1 5738.2 5781.2 5790.3 5814.3 5829.7 5494.6 5521.6 5527.6 5529.2 5534.0 5431.2 5627.1 5638.2 5640.5 5643.6 5531.6 5553.9 5558.1 5562.8 5609.5 5521.2 5544.6 5545.8 5546.7 5548.8 5344.9 5403.1 5427.2 5445.9 5478.8 5530.4 5538.2 5545.8 5559.9 5583.8 5383.8 5403.6 5414.8 5419.2 5437.2 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | [#1] ext.html Cycles:180 Average:46187.68 Median:3267.30 stddev:88316.18 (2703.0%) stddev-sans-first:88497.59 10:38:55 INFO - PROCESS | 11562 | Values: 595.5 621.8 633.5 645.0 658.3 29853.0 30537.8 32087.7 33064.7 33175.3 38729.6 39257.4 39289.8 39372.4 39463.8 7847.8 8299.3 8474.9 8475.9 8481.9 7893.4 8002.2 8016.4 10249.9 10617.8 10197.3 10311.1 10312.8 10313.7 10319.9 7975.6 10151.6 10241.8 10259.5 10271.8 10115.0 10547.9 10548.1 10551.4 10558.7 35620.3 36574.8 36585.0 36637.1 36690.3 3259.8 3298.1 3388.6 3433.9 3608.5 25698.6 27230.5 27323.5 27518.0 27697.4 4196.5 4200.8 4303.2 4338.7 4513.7 210458.0 211117.0 211837.0 212212.0 212905.0 33947.3 34758.3 34785.3 51970.0 55461.7 31447.7 31505.2 31785.8 31792.0 31811.4 14305.5 14416.7 14451.7 14466.6 14471.1 12010.8 12109.2 12110.2 12122.0 12127.8 8198.7 8242.6 8248.1 8262.8 8322.7 3222.6 3251.5 3274.8 3317.2 3321.0 994.8 1015.9 1063.5 1082.0 1155.8 29854.0 31114.2 31406.7 31591.2 31933.4 1102.8 1109.5 1122.2 1185.8 1230.5 16497.6 16789.4 16945.8 16946.8 17081.7 456560.0 460532.0 465871.0 466186.0 466667.0 54559.5 55300.4 55333.2 55471.7 55510.7 1225.3 1294.0 1356.4 1370.1 1472.5 27458.5 27484.9 27803.3 28288.2 29462.6 43445.0 43909.6 44061.3 44104.0 44183.3 264676.0 270485.0 271634.0 272241.0 272533.0 24345.4 26634.9 26854.3 27159.0 27200.7 40010.6 40537.6 40683.0 40801.6 41292.0 36348.8 36715.0 36765.8 37200.6 37776.4 32921.7 33072.2 33136.0 33273.3 33451.0 37683.8 38555.2 38664.8 38740.6 39031.4 32995.7 33396.7 33594.7 34164.7 34169.7 26352.5 26588.0 26734.0 26951.7 27089.9 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | [#2] jquery.html Cycles:180 Average:27403.71 Median:2923.94 stddev:75926.52 (2596.7%) stddev-sans-first:76112.41 10:38:55 INFO - PROCESS | 11562 | Values: 381.8 383.3 385.5 392.6 401.6 17568.3 18604.3 18917.1 18969.3 18979.7 16989.4 17357.1 17651.3 17651.8 18518.5 5549.3 5641.2 5670.9 5718.8 5722.5 5514.8 5638.7 5663.5 5695.7 5714.2 5572.3 5631.1 5635.4 5638.2 5642.1 5450.2 5589.2 5628.4 5635.5 5646.0 4774.1 4968.9 4982.4 4985.1 4990.7 21839.1 21870.5 22027.0 22109.3 22197.8 2408.8 2540.4 2636.7 2750.9 3097.0 6905.6 13646.6 13887.7 14170.5 14409.8 1913.5 1915.4 1953.2 1992.8 2060.0 72640.0 73089.0 73887.6 73911.9 75575.6 9488.4 9649.1 9773.0 9818.8 10212.1 13657.4 13750.7 13760.6 13773.5 13784.4 7335.5 7438.7 7738.1 7765.4 7898.8 7060.7 7086.9 7149.6 7652.2 7840.6 6186.5 6188.7 6226.1 6284.7 6307.6 1762.4 1792.6 1805.3 1809.4 1863.4 937.9 973.7 1025.3 1043.0 1098.3 18613.1 18669.8 18789.2 18844.3 19143.3 993.4 1007.8 1024.9 1073.5 1079.3 10425.3 10778.0 10787.7 10813.7 10840.5 451757.0 455672.0 461825.4 469508.0 470875.0 77095.2 79940.0 81117.2 81451.0 82242.0 1025.6 1063.6 1064.0 1083.6 1085.1 16234.8 16237.0 16391.8 16565.9 16749.3 37146.3 37149.0 37900.8 38860.8 38937.8 52752.7 56087.0 56111.4 56123.7 56352.4 8040.2 8218.3 8342.1 8395.2 8496.7 12386.5 13290.1 13441.7 13735.6 13766.4 11868.7 11875.6 12011.7 12181.5 12379.8 11326.7 11820.3 11856.5 11908.8 12079.3 11950.2 12093.2 12281.0 12323.6 12434.6 8122.3 8243.3 8276.0 8465.6 8742.6 11534.5 11796.9 11887.7 11962.7 12015.8 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | [#3] mootools.html Cycles:180 Average:5291.95 Median:4738.45 stddev:3067.92 (64.7%) stddev-sans-first:3061.94 10:38:55 INFO - PROCESS | 11562 | Values: 1311.3 1480.1 1488.9 1627.3 1787.3 7089.1 8066.7 8255.5 8263.4 8268.4 7995.9 8130.8 8145.2 8148.3 8155.3 1961.9 2018.0 2021.9 2211.0 2238.5 2140.4 2192.4 2192.9 2195.9 2196.0 2104.1 2120.3 2129.8 2134.0 2149.7 1932.9 2043.6 2051.5 2052.5 2139.6 2055.7 2071.9 2073.5 2073.7 2074.2 7767.5 7806.6 7808.5 7816.5 7821.3 4584.9 4715.5 4734.9 4742.0 4747.5 3012.9 3076.8 3118.3 3132.1 3137.4 981.3 983.4 988.8 1011.1 1044.4 11215.4 11453.5 11473.7 11474.3 11487.0 4158.4 4178.7 4313.2 4348.3 4382.6 9837.7 9857.1 9880.0 9881.6 9890.0 4949.0 4979.7 4982.8 4988.6 4994.8 3912.7 4266.9 4332.0 4568.8 4606.8 3679.3 3707.4 3747.8 3794.1 3806.9 1153.5 1159.7 1170.6 1174.3 1176.1 795.7 864.9 884.8 900.2 905.8 5224.3 5303.6 5512.1 5539.7 5609.9 841.2 866.6 898.5 913.3 944.9 3468.4 3489.3 3710.2 3745.1 3793.9 9681.8 10098.4 10174.2 10180.3 10187.1 10157.7 10158.4 10274.4 10341.7 10505.1 7594.7 7629.2 7647.2 7672.3 7724.7 5428.1 5503.0 5523.2 5596.7 5617.3 9466.7 9510.0 9540.1 9578.2 9660.9 9538.2 9729.9 9936.6 10090.1 10107.1 6020.2 6579.3 6700.8 6851.2 7063.6 7194.8 7273.8 7286.3 7312.5 7321.0 6527.9 6696.9 6705.7 6781.9 6788.6 6665.9 6716.6 6793.5 6853.5 6900.6 5917.8 5932.8 5969.5 5970.9 5973.5 4403.8 4451.4 4501.1 4501.3 4502.8 4255.6 4257.4 4314.8 4345.2 4347.7 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | [#4] prototype.html Cycles:180 Average:4905.30 Median:5603.61 stddev:1476.84 (26.4%) stddev-sans-first:1440.05 10:38:55 INFO - PROCESS | 11562 | Values: 304.9 309.2 317.3 322.1 323.6 5493.2 5573.1 5591.4 5605.6 5641.2 5527.1 5537.4 5549.3 5567.9 5594.0 4086.3 4136.8 4251.6 4277.4 4305.8 4260.4 4279.7 4280.5 4282.5 4299.1 4096.0 4250.0 4250.6 4256.7 4267.6 4150.3 4263.7 4273.6 4303.5 4306.2 3768.5 3773.6 3777.1 3780.1 3784.2 5214.7 5347.5 5356.0 5369.4 5375.9 4854.4 4868.4 4869.9 4886.5 4892.0 5788.2 5798.2 5802.2 5808.6 5831.5 4071.8 4072.8 4096.4 4101.1 4103.2 5821.4 6141.1 6149.7 6153.5 6174.6 4128.5 4149.8 4150.7 4159.0 4170.0 4194.6 4198.1 4209.2 4209.4 4210.1 4717.7 4855.2 4858.1 4864.4 4870.9 5851.5 5888.1 5891.4 5891.8 5953.4 1453.8 1477.2 1478.7 1491.4 1491.4 897.9 926.0 959.6 974.7 982.3 5567.5 5569.7 5579.8 5594.9 5639.1 6035.5 6038.5 6041.3 6041.8 6049.8 5470.8 5551.1 5601.6 5639.5 5665.7 3200.5 3200.6 3215.3 3216.9 3225.0 6061.8 6170.5 6187.5 6216.9 6228.5 6102.8 6128.9 6132.2 6170.9 6189.9 6162.3 6194.4 6226.9 6229.7 6230.6 5803.6 6005.6 6031.8 6038.5 6063.8 5906.5 5956.7 5957.9 5959.4 5971.4 5938.0 6218.6 6231.6 6244.2 6277.5 4140.5 4160.6 4170.4 4170.7 4172.5 5959.4 5991.0 5995.3 6003.3 6040.8 5661.9 5849.0 5942.0 5998.5 6026.2 5944.0 5946.4 5950.0 5955.6 5974.8 5433.2 5610.5 5694.9 5893.8 5927.3 5965.9 5988.5 5992.9 6007.3 6034.1 5838.4 5850.4 5908.4 5922.2 5926.4 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - PROCESS | 11562 | [#5] yui.html Cycles:180 Average:14054.11 Median:23781.18 stddev:15670.66 (65.9%) stddev-sans-first:15683.03 10:38:55 INFO - PROCESS | 11562 | Values: 805.0 821.7 824.5 836.1 851.2 13810.8 14250.7 14383.7 14401.6 14497.8 13050.7 13296.7 13319.0 13340.6 13346.6 672.4 790.1 818.3 820.2 820.8 815.4 815.7 817.8 817.8 818.0 708.4 855.2 859.6 860.0 860.0 833.3 843.4 843.7 843.8 845.6 609.4 610.7 610.8 616.0 618.9 13605.0 13681.5 13697.3 13698.3 13774.6 13622.3 13659.7 14074.2 14403.3 14479.6 10751.5 11017.8 11043.3 11163.4 11175.6 3849.7 3881.3 3882.2 3925.0 3985.3 54817.5 54921.5 55656.7 55796.6 55874.4 10664.5 11164.8 11181.3 11350.0 11360.4 19965.9 19968.7 20018.2 20045.9 20057.8 7858.2 7942.0 8431.0 8526.0 8633.2 4406.4 4439.4 4477.2 4516.8 4543.8 3320.4 3374.7 3406.5 3414.9 3415.4 558.8 600.3 642.5 662.6 662.9 590.3 690.2 692.6 697.1 704.5 8892.9 8976.7 9321.9 9370.5 9546.5 728.5 730.5 733.0 735.7 744.3 4279.0 4385.5 4473.7 4589.5 4719.5 48294.5 48790.3 51190.0 61497.0 61879.7 48561.5 49853.0 49901.8 50348.5 52966.5 43283.4 43433.0 45466.5 45809.0 46610.5 9184.7 9300.0 9305.6 9319.0 9366.7 27663.0 28939.0 29172.6 29499.4 32984.7 39899.2 40275.2 41384.0 41875.2 42269.8 10226.6 10461.1 10544.9 11622.8 11707.1 12980.9 13084.4 13601.8 13607.9 14323.1 11387.8 11448.4 11510.9 11729.4 12110.9 11687.3 12004.9 12446.8 12709.1 12995.3 12167.9 12168.1 12282.7 12594.2 13059.5 10239.8 10625.7 11056.8 11107.0 11346.0 10971.2 10988.5 11135.6 11232.6 11336.9 10:38:55 INFO - PROCESS | 11562 | -------- Summary: end -------- 10:38:55 INFO - PROCESS | 11562 | 10:38:55 INFO - TEST-INFO | 11562: exit 0 10:38:55 INFO - TEST-OK | dromaeo_css | took 1112342ms 10:38:55 INFO - TEST-START | kraken 10:38:55 INFO - operating with platform_type : linux_ 10:38:55 INFO - Initialising browser for kraken test... 10:38:55 INFO - TEST-INFO | started process 11743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9hh1b/profile http://localhost:47475/getInfo.html) 10:38:59 INFO - PROCESS | 11743 | __metrics Screen width/height:1600/1200 10:38:59 INFO - PROCESS | 11743 | colorDepth:24 10:38:59 INFO - PROCESS | 11743 | Browser inner width/height: 1024/697 10:38:59 INFO - PROCESS | 11743 | __metrics 10:39:00 ERROR - PROCESS | 11743 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:39:01 INFO - TEST-INFO | 11743: exit 0 10:39:01 INFO - Browser initialized. 10:39:01 INFO - Running cycle 1/1 for kraken test... 10:39:01 INFO - TEST-INFO | started process 11826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9hh1b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:13 INFO - PROCESS | 11826 | RSS: Main: 153493504 10:39:13 INFO - PROCESS | 11826 | 10:39:16 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47475/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:16 INFO - PROCESS | 11826 | RSS: Main: 208498688 10:39:16 INFO - PROCESS | 11826 | 10:39:19 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47475/tests/kraken/driver.html?testName=audio-dft) 10:39:20 INFO - PROCESS | 11826 | RSS: Main: 194060288 10:39:20 INFO - PROCESS | 11826 | 10:39:23 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47475/tests/kraken/driver.html?testName=audio-fft) 10:39:24 INFO - PROCESS | 11826 | RSS: Main: 264511488 10:39:24 INFO - PROCESS | 11826 | 10:39:26 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47475/tests/kraken/driver.html?testName=audio-oscillator) 10:39:26 INFO - PROCESS | 11826 | RSS: Main: 173199360 10:39:26 INFO - PROCESS | 11826 | 10:39:28 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:29 INFO - PROCESS | 11826 | RSS: Main: 176898048 10:39:29 INFO - PROCESS | 11826 | 10:39:32 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47475/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:33 INFO - PROCESS | 11826 | RSS: Main: 213925888 10:39:33 INFO - PROCESS | 11826 | 10:39:36 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47475/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:36 INFO - PROCESS | 11826 | RSS: Main: 214220800 10:39:36 INFO - PROCESS | 11826 | 10:39:39 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47475/tests/kraken/driver.html?testName=json-parse-financial) 10:39:40 INFO - PROCESS | 11826 | RSS: Main: 214425600 10:39:40 INFO - PROCESS | 11826 | 10:39:41 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:42 INFO - PROCESS | 11826 | RSS: Main: 204107776 10:39:42 INFO - PROCESS | 11826 | 10:39:44 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:44 INFO - PROCESS | 11826 | RSS: Main: 203595776 10:39:44 INFO - PROCESS | 11826 | 10:39:46 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:47 INFO - PROCESS | 11826 | RSS: Main: 219856896 10:39:47 INFO - PROCESS | 11826 | 10:39:50 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:50 INFO - PROCESS | 11826 | RSS: Main: 223318016 10:39:50 INFO - PROCESS | 11826 | 10:39:53 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:54 INFO - PROCESS | 11826 | RSS: Main: 220508160 10:39:54 INFO - PROCESS | 11826 | 10:39:55 INFO - PROCESS | 11826 | Cycle 1(1): loaded http://localhost:47475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47475/tests/kraken/driver.html?testName=ai-astar) 10:39:56 INFO - PROCESS | 11826 | RSS: Main: 283967488 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | __start_tp_report 10:39:56 INFO - PROCESS | 11826 | _x_x_mozilla_page_load 10:39:56 INFO - PROCESS | 11826 | _x_x_mozilla_page_load_details 10:39:56 INFO - PROCESS | 11826 | |i|pagename|runs| 10:39:56 INFO - PROCESS | 11826 | |0;ai-astar;110;111;106;111;111;112;101;110;111;110 10:39:56 INFO - PROCESS | 11826 | |1;audio-beat-detection;152;128;154;201;138;161;158;129;190;128 10:39:56 INFO - PROCESS | 11826 | |2;audio-dft;161;163;163;161;161;160;162;163;160;161 10:39:56 INFO - PROCESS | 11826 | |3;audio-fft;73;73;102;108;73;76;73;119;102;76 10:39:56 INFO - PROCESS | 11826 | |4;audio-oscillator;93;93;141;93;93;92;152;92;93;141 10:39:56 INFO - PROCESS | 11826 | |5;imaging-gaussian-blur;116;116;116;116;117;117;117;117;117;117 10:39:56 INFO - PROCESS | 11826 | |6;imaging-darkroom;145;146;145;145;145;145;145;146;146;146 10:39:56 INFO - PROCESS | 11826 | |7;imaging-desaturate;95;95;95;94;95;94;96;94;95;94 10:39:56 INFO - PROCESS | 11826 | |8;json-parse-financial;56;57;58;58;57;57;58;75;54;54 10:39:56 INFO - PROCESS | 11826 | |9;json-stringify-tinderbox;62;63;62;62;64;62;62;63;62;62 10:39:56 INFO - PROCESS | 11826 | |10;stanford-crypto-aes;77;77;75;76;78;78;78;79;78;78 10:39:56 INFO - PROCESS | 11826 | |11;stanford-crypto-ccm;140;126;124;125;130;123;126;123;158;125 10:39:56 INFO - PROCESS | 11826 | |12;stanford-crypto-pbkdf2;172;165;166;166;166;165;171;172;165;166 10:39:56 INFO - PROCESS | 11826 | |13;stanford-crypto-sha256-iterative;72;67;68;67;69;69;69;68;68;76 10:39:56 INFO - PROCESS | 11826 | __end_tp_report 10:39:56 INFO - PROCESS | 11826 | __start_cc_report 10:39:56 INFO - PROCESS | 11826 | _x_x_mozilla_cycle_collect,1598 10:39:56 INFO - PROCESS | 11826 | __end_cc_report 10:39:56 INFO - PROCESS | 11826 | __startTimestamp1461260396086__endTimestamp 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | ------- Summary: start ------- 10:39:56 INFO - PROCESS | 11826 | Number of tests: 14 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.33 (3.0%) stddev-sans-first:3.53 10:39:56 INFO - PROCESS | 11826 | Values: 110.0 111.0 106.0 111.0 111.0 112.0 101.0 110.0 111.0 110.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:156.00 stddev:25.40 (16.3%) stddev-sans-first:26.93 10:39:56 INFO - PROCESS | 11826 | Values: 152.0 128.0 154.0 201.0 138.0 161.0 158.0 129.0 190.0 128.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.18 (0.7%) stddev-sans-first:1.24 10:39:56 INFO - PROCESS | 11826 | Values: 161.0 163.0 163.0 161.0 161.0 160.0 162.0 163.0 160.0 161.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#3] audio-fft Cycles:10 Average:87.50 Median:73.00 stddev:18.07 (24.8%) stddev-sans-first:18.39 10:39:56 INFO - PROCESS | 11826 | Values: 73.0 73.0 102.0 108.0 73.0 76.0 73.0 119.0 102.0 76.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:25.28 (27.2%) stddev-sans-first:26.20 10:39:56 INFO - PROCESS | 11826 | Values: 93.0 93.0 141.0 93.0 93.0 92.0 152.0 92.0 93.0 141.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:39:56 INFO - PROCESS | 11826 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:39:56 INFO - PROCESS | 11826 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:39:56 INFO - PROCESS | 11826 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 96.0 94.0 95.0 94.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.50 stddev:6.02 (10.5%) stddev-sans-first:6.32 10:39:56 INFO - PROCESS | 11826 | Values: 56.0 57.0 58.0 58.0 57.0 57.0 58.0 75.0 54.0 54.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 10:39:56 INFO - PROCESS | 11826 | Values: 62.0 63.0 62.0 62.0 64.0 62.0 62.0 63.0 62.0 62.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:78.00 stddev:1.17 (1.5%) stddev-sans-first:1.24 10:39:56 INFO - PROCESS | 11826 | Values: 77.0 77.0 75.0 76.0 78.0 78.0 78.0 79.0 78.0 78.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:126.00 stddev:11.06 (8.8%) stddev-sans-first:11.12 10:39:56 INFO - PROCESS | 11826 | Values: 140.0 126.0 124.0 125.0 130.0 123.0 126.0 123.0 158.0 125.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:166.00 stddev:2.99 (1.8%) stddev-sans-first:2.67 10:39:56 INFO - PROCESS | 11826 | Values: 172.0 165.0 166.0 166.0 166.0 165.0 171.0 172.0 165.0 166.0 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - PROCESS | 11826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.75 (4.0%) stddev-sans-first:2.74 10:39:56 INFO - PROCESS | 11826 | Values: 72.0 67.0 68.0 67.0 69.0 69.0 69.0 68.0 68.0 76.0 10:39:56 INFO - PROCESS | 11826 | -------- Summary: end -------- 10:39:56 INFO - PROCESS | 11826 | 10:39:56 INFO - TEST-INFO | 11826: exit 0 10:39:57 INFO - TEST-OK | kraken | took 61260ms 10:39:57 INFO - SUITE-END | took 1173s 10:39:57 INFO - Completed test suite (00:19:33) 10:39:57 INFO - javascript benchmark 10:39:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.2917628945343, 3105.487594546897, 3131.937361252775, 3143.9528407073913, 3176.1424415407832, 5158.535731784148, 5228.424873263947, 5287.180487024512, 5313.920291195625, 5358.115910874706, 5247.055530004607, 5255.605829562779, 5279.023380674568, 5281.471852814717, 5285.0, 4664.2537194048955, 4710.458297295812, 4795.5444232798, 4812.590929770974, 4850.539198776129, 4773.498782627827, 4800.183968725325, 4806.879828004293, 4857.902841943159, 4895.657303988723, 4651.604613607848, 4668.159731248374, 4710.5289471052965, 4734.455537613184, 4802.063597598452, 4760.547747963938, 4764.8332308369045, 4783.545563171493, 4793.520647935214, 4827.951720482785, 4650.674452788307, 4713.717176969359, 4737.336772851803, 4737.952620473786, 4799.208130658437, 5122.487751224885, 5156.896862062776, 5190.71451070191, 5202.843914682566, 5207.791688332462, 5518.503334699856, 5525.143602741581, 5547.084731019418, 5547.306586676666, 5548.750306236229, 5510.311211098613, 5563.610547261694, 5564.666120032811, 5564.888702225973, 5594.720263986785, 5193.298904647862, 5199.246109314128, 5215.035218484592, 5217.713025783618, 5271.4992075753125, 5705.229793977843, 5711.400302968212, 5711.514521265739, 5715.857103572361, 5716.485516303553, 5386.91919621206, 5463.180522921593, 5473.397926228112, 5486.259354987025, 5535.059039963216, 5594.552435805207, 5600.0, 5601.411851755588, 5609.635373700697, 5625.071863142617, 5565.248691426606, 5573.5819813514145, 5580.637258578179, 5581.441855814386, 5588.189712491666, 5527.778888844482, 5557.138643510262, 5577.749001294951, 5582.665040097607, 5615.298087739033, 4244.3209086546, 4255.616994470451, 4255.893602659897, 4262.0, 4296.291111966553, 3801.201747632973, 3826.9808650956566, 3839.040239940015, 3854.6530812226474, 3857.5756666766633, 5173.3533308336455, 5174.275601415805, 5211.218317252366, 5237.450067742909, 5243.764030618631, 5531.3362396512675, 5540.944590554042, 5551.306086739158, 5552.639078459887, 5566.248556444909, 5217.50433708797, 5218.817341393033, 5220.582353411718, 5248.186531087687, 5249.2651028855225, 4778.37881075458, 4825.10735513931, 4860.829870954571, 4892.168331383673, 4902.730349830794, 5788.88422231553, 5803.767849286066, 5806.04200306953, 5807.157962095557, 5811.360750317462, 5504.669719816824, 5622.325320961347, 5624.409437009137, 5628.915566266591, 5671.092625179951, 5738.167965644875, 5781.190633311256, 5790.276215473066, 5814.273215848019, 5829.679367634821, 5494.642848214853, 5521.641093329082, 5527.640703354269, 5529.198266251291, 5533.972330138324, 5431.158170483582, 5627.0715331971405, 5638.23883775685, 5640.520555752642, 5643.604947653625, 5531.585131115102, 5553.861153471195, 5558.138488534284, 5562.833115006556, 5609.49514543693, 5521.199426083276, 5544.61187716856, 5545.7781688732, 5546.722663866871, 5548.750306236309, 5344.866378340573, 5403.081476149143, 5427.1859221115565, 5445.891082178414, 5478.780848766005, 5530.391656917816, 5538.224648549287, 5545.833624991256, 5559.8610034747835, 5583.804566840141, 5383.81156659515, 5403.648762830403, 5414.810481633124, 5419.187121931742, 5437.238786569805], "value": 5164.281521270169, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.4581330988798, 621.8165641135864, 633.4932054356514, 644.983875403115, 658.2758965138348, 29853.0, 30537.84731076344, 32087.67912320873, 33064.66935330646, 33175.33649327018, 38729.612703872954, 39257.41113883294, 39289.80355098221, 39372.40941385881, 39463.802680986555, 7847.764567062997, 8299.294559962394, 8474.872876906851, 8475.872861907077, 8481.872771908425, 7893.368530517545, 8002.239787220234, 8016.438849280553, 10249.948750256239, 10617.84073238902, 10197.286189966706, 10311.123554497877, 10312.845307320396, 10313.742156446111, 10319.89680103197, 7975.561344126071, 10151.644692435766, 10241.84637230442, 10259.487025648763, 10271.845922311171, 10115.0, 10547.894521054845, 10548.103411209979, 10551.419671918042, 10558.736031599195, 35620.28759424797, 36574.817125914466, 36585.0, 36637.08407289813, 36690.266194676224, 3259.788113772597, 3298.1259966109, 3388.6272510023878, 3433.896983090486, 3608.4767708682357, 25698.614520782205, 27230.455390892268, 27323.45353092947, 27518.0, 27697.446051079067, 4196.538380778143, 4200.831966721327, 4303.225419424502, 4338.696291259613, 4513.661475389359, 210458.0, 211117.0, 211837.0, 212212.0, 212905.0, 33947.32105357879, 34758.30483390368, 34785.30429391398, 51970.0, 55461.72269138628, 31447.685523144934, 31505.212369690482, 31785.841070794497, 31792.0, 31811.363772724417, 14305.499307524187, 14416.711665766627, 14451.710965780836, 14466.638334041523, 14471.131732096108, 12010.819837702442, 12109.152359334938, 12110.212836165621, 12122.0, 12127.757444851053, 8198.672053117927, 8242.587870606445, 8248.051474080557, 8262.793430164294, 8322.6670933162, 3222.6132864056462, 3251.4635085210675, 3274.8035117893, 3317.2370354818527, 3320.9833950830093, 994.8159590475785, 1015.9034891685278, 1063.5373612478597, 1082.0020026003997, 1155.774623948322, 29854.0, 31114.222144446117, 31406.685933140834, 31591.21021974423, 31933.361332773213, 1102.7739313440725, 1109.4578535835196, 1122.2088427658482, 1185.7747028064641, 1230.501646833034, 16497.587560311087, 16789.41237056697, 16945.83054169467, 16946.830531694526, 17081.658366832595, 456560.0, 460532.0, 465871.0, 466186.0, 466667.0, 54559.454405455435, 55300.446995530336, 55333.170002449995, 55471.722641386536, 55510.72244638751, 1225.2709637765515, 1294.0359432223054, 1356.4099616666583, 1370.1299674706634, 1472.49935022093, 27458.450830983667, 27484.862575686995, 27803.304917377227, 28288.15135545937, 29462.558061628664, 43445.0, 43909.56090439182, 44061.33907991447, 44104.0, 44183.33724994063, 264676.0, 270485.0, 271634.0, 272241.0, 272533.0, 24345.39136521601, 26634.866825665747, 26854.328641784112, 27159.0, 27200.727992719818, 40010.59989400069, 40537.59462405456, 40683.0, 40801.59198407978, 41292.0, 36348.818255908554, 36715.0, 36765.81617092004, 37200.62799371972, 37776.433353500266, 32921.670783292815, 33072.1731956703, 33136.0, 33273.33453330968, 33451.0, 37683.81158094192, 38555.22889542249, 38664.80667596644, 38740.6125938737, 39031.414528781526, 32995.67004329926, 33396.66603333935, 33594.66405336013, 34164.65835341615, 34169.65830341665, 26352.472950540498, 26588.0, 26734.0, 26951.730482695708, 27089.86455067712], "value": 17338.394973333936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.76712205554605, 383.34065407499094, 385.50655161393416, 392.56033242768103, 401.6465510350891, 17568.297268109276, 18604.34884779033, 18917.05414729265, 18969.336073237457, 18979.71530427045, 16989.405370812023, 17357.132143392842, 17651.293948242088, 17651.82348176518, 18518.537036574093, 5549.250851135095, 5641.18202860585, 5670.886582268352, 5718.799842005531, 5722.513586345145, 5514.751836167362, 5638.661680299175, 5663.546916246711, 5695.743691533891, 5714.200011998323, 5572.3034620672415, 5631.1271752878365, 5635.436456354373, 5638.210650508932, 5642.097264437691, 5450.182472629098, 5589.217509548666, 5628.43715628438, 5635.492805647511, 5646.0, 4774.116788394123, 4968.850934471935, 4982.352294201767, 4985.052839960396, 4990.675606085593, 21839.126434942584, 21870.453238669, 22027.0, 22109.336719898267, 22197.778022219733, 2408.8072954163626, 2540.4030052937546, 2636.6967798703204, 2750.917472475809, 3096.9690303096904, 6905.551139175937, 13646.590602281947, 13887.722245555133, 14170.528220585918, 14409.78385324221, 1913.5407502199512, 1915.3870761356372, 1953.2089503751004, 1992.750906136733, 2059.969100463494, 72640.0, 73089.0, 73887.63056184739, 73911.89132163076, 75575.62212188904, 9488.430694158373, 9649.131578158, 9773.0, 9818.826998525597, 10212.131968782736, 13657.385417656229, 13750.65623359424, 13760.587182384545, 13773.517926872511, 13784.379702913393, 7335.486515943832, 7438.7024519019715, 7738.148803631596, 7765.417593680384, 7898.763037108896, 7060.71757129709, 7086.858262834715, 7149.642517874086, 7652.196519365498, 7840.607969601497, 6186.505079593621, 6188.659623720649, 6226.128342032119, 6284.654344011124, 6307.590006649553, 1762.409592786431, 1792.6056267621102, 1805.268866109228, 1809.4028970439724, 1863.4223390748912, 937.9343445958717, 973.6543527047937, 1025.2647443778962, 1042.9843552346722, 1098.2641630107846, 18613.138686131548, 18669.813301867078, 18789.154488048072, 18844.340448084524, 19143.329983450512, 993.4387071304834, 1007.8488226765897, 1024.8667673202585, 1073.5383784972537, 1079.3416016230094, 10425.270231083752, 10778.0, 10787.67636970892, 10813.729656758644, 10840.45797710127, 451757.0, 455672.0, 461825.4150715158, 469508.0, 470875.0, 77095.22904770881, 79940.0, 81117.18882811215, 81451.0, 82242.0, 1025.5948900184385, 1063.6064656077301, 1064.0370464729588, 1083.5828206140693, 1085.10478854945, 16234.782391320461, 16237.025778453331, 16391.83608163903, 16565.91717041407, 16749.33002679879, 37146.25707485889, 37149.0, 37900.81049594734, 38860.805695971336, 38937.805310973265, 52752.736236318575, 56087.0, 56111.43888561225, 56123.71938140283, 56352.43647563472, 8040.2361775631225, 8218.342532597258, 8342.082370939313, 8395.24442800151, 8496.745097647081, 12386.504539818307, 13290.136141150795, 13441.731165376834, 13735.587932362045, 13766.380512876744, 11868.703282418008, 11875.643730688093, 12011.699707507381, 12181.512739490321, 12379.75240495203, 11326.660200194008, 11820.290782553075, 11856.525738970344, 11908.821367679318, 12079.27524348542, 11950.223235489666, 12093.153479256367, 12281.0, 12323.568675096329, 12434.62696119118, 8122.268995790408, 8243.25810677018, 8276.0, 8465.576721163794, 8742.606582703665, 11534.480948357177, 11796.882031179579, 11887.702807429883, 11962.700932476757, 12015.819762703391], "value": 9092.309864323139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.2656912129214, 1480.0823489436548, 1488.9181095039776, 1627.3409269245951, 1787.2761531579706, 7089.113860767404, 8066.71766488173, 8255.545944973024, 8263.380246481523, 8268.37987150963, 7995.880061799077, 8130.796730081736, 8145.226203510671, 8148.307393871513, 8155.266026057654, 1961.8724782889137, 2018.0414303205932, 2021.9494512637154, 2211.0492488230057, 2238.5187184755273, 2140.3899888531773, 2192.3861318830754, 2192.901319440629, 2195.879226642534, 2195.9890200548975, 2104.1057550541036, 2120.289702949514, 2129.755078166015, 2133.967990480144, 2149.6668016457475, 1932.9323473678494, 2043.5810658814908, 2051.517893295082, 2052.466358746729, 2139.6255655260265, 2055.6813693877475, 2071.8964051797348, 2073.460900165953, 2073.668213085914, 2074.2429013410147, 7767.495112817649, 7806.609669516558, 7808.49244799092, 7816.531008139473, 7821.256980586835, 4584.908301833944, 4715.504871988426, 4734.905301893978, 4742.0, 4747.525247475225, 3012.9096127116222, 3076.7538596912195, 3118.3139709263924, 3132.060381885448, 3137.4352616529018, 981.3130808434124, 983.4099540275848, 988.7528117970508, 1011.1152741351318, 1044.420346707577, 11215.439228038565, 11453.484593193243, 11473.65579032622, 11474.311541307548, 11487.0, 4158.4178215049915, 4178.728382655178, 4313.223619748475, 4348.2825333819565, 4382.561743825656, 9837.655682051238, 9857.11285984265, 9880.0, 9881.555330010167, 9889.950550247202, 4949.0, 4979.726115063634, 4982.825601104017, 4988.625853061035, 4994.825181118644, 3912.667423268997, 4266.935995960063, 4332.0469496710675, 4568.771561421916, 4606.792694328763, 3679.300932822755, 3707.4253490708984, 3747.756395834262, 3794.0894185395305, 3806.9428958565645, 1153.4866984192122, 1159.7274640459486, 1170.607846371458, 1174.3247632611283, 1176.147293212414, 795.6589637654016, 864.9058940440348, 884.8009197930543, 900.230303090861, 905.7735566108473, 5224.346956630421, 5303.575713942875, 5512.118061110203, 5539.667619942817, 5609.915851262234, 841.2218697704722, 866.5797088412115, 898.5417437107122, 913.2967614936595, 944.9244060475146, 3468.4450487921813, 3489.284696637183, 3710.220853620716, 3745.127436281859, 3793.9241215176094, 9681.806363872684, 10098.394096354095, 10174.236932230113, 10180.287379883484, 10187.08316251541, 10157.695269141937, 10158.39049657023, 10274.434906080238, 10341.741456463498, 10505.107065899485, 7594.696212151563, 7629.2370762923265, 7647.158812530617, 7672.271134242238, 7724.729634462767, 5428.104362780097, 5503.0, 5523.226748255167, 5596.737221279451, 5617.297837770278, 9466.668666596912, 9510.048995100435, 9540.141387275178, 9578.185854202193, 9660.855087173557, 9538.23694104484, 9729.85405218908, 9936.602535898772, 10090.09189172978, 10107.090361867467, 6020.217371741645, 6579.342065793382, 6700.83247918806, 6851.246362899978, 7063.611501367474, 7194.820129496805, 7273.818154546178, 7286.307800758919, 7312.488125831141, 7321.0, 6527.902081468686, 6696.895012322912, 6705.731770729116, 6781.93218067813, 6788.558743681645, 6665.866682666417, 6716.630585317855, 6793.490488213502, 6853.520253582401, 6900.551464154814, 5917.822465326047, 5932.79235226765, 5969.462748352669, 5970.850728731816, 5973.522118230444, 4403.757793321398, 4451.443569553806, 4501.122281155143, 4501.279795232747, 4502.797374118238, 4255.5957184067465, 4257.446531950826, 4314.762688052062, 4345.239583073013, 4347.65218782503], "value": 4226.052897667027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.88719173905656, 309.1806712212637, 317.30193574136905, 322.1093675985898, 323.629444286292, 5493.1760235964575, 5573.108302671573, 5591.3569939456975, 5605.607607467479, 5641.18202860585, 5527.143292789614, 5537.446255374461, 5549.278593782813, 5567.944320556793, 5593.972030139854, 4086.3053280942313, 4136.834526618932, 4251.574842515739, 4277.379779931908, 4305.784710764465, 4260.3822445745345, 4279.657627389817, 4280.5291417944, 4282.528921818597, 4299.140171965604, 4095.9795201023953, 4249.957500424987, 4250.61744443, 4256.702030857841, 4267.637250833667, 4150.252954468195, 4263.722858014219, 4273.594008569181, 4303.548127446605, 4306.20335237982, 3768.4724138620613, 3773.584905660375, 3777.0557360659836, 3780.092777733352, 3784.2242340320167, 5214.6871187728475, 5347.491988261109, 5356.0, 5369.409364969889, 5375.865603359908, 4854.417469903598, 4868.367112275417, 4869.8782530436665, 4886.51134886512, 4891.972685735964, 5788.218590490314, 5798.217240672498, 5802.216700745387, 5808.6224395414165, 5831.504322132624, 4071.7760523171214, 4072.8370865165357, 4096.3855421686685, 4101.138760860223, 4103.220388126247, 5821.446962538552, 6141.140240366308, 6149.739303442783, 6153.507719382439, 6174.59865108771, 4128.4632997710105, 4149.771762553089, 4150.730202536825, 4158.979205103955, 4170.0, 4194.622483976456, 4198.097409057067, 4209.221294060609, 4209.431726716915, 4210.073783767628, 4717.669763116549, 4855.247436647325, 4858.1012512685265, 4864.391951006124, 4870.853874383774, 5851.502622277154, 5888.116782482576, 5891.407780576533, 5891.793787217427, 5953.404659534012, 1453.7528620134603, 1477.1580199286518, 1478.6894752101964, 1491.3512622009462, 1491.4108926973784, 897.8518544440094, 925.9675911343071, 959.5921733263475, 974.6783561424713, 982.3369225772718, 5567.526760225345, 5569.749361278752, 5579.776808927679, 5594.916076258859, 5639.125935479925, 6035.547333949971, 6038.486728628028, 6041.305249896318, 6041.758329666852, 6049.818505444844, 5470.835874923759, 5551.057939292182, 5601.60788744784, 5639.548836093103, 5665.745041473061, 3200.4719221328687, 3200.5519227308196, 3215.3087086276096, 3216.8552415141376, 3224.951625725616, 6061.787837425669, 6170.475509581646, 6187.504999600022, 6216.875662486725, 6228.532860035425, 6102.816915492543, 6128.85490078469, 6132.233470816148, 6170.876582468415, 6189.907151392733, 6162.291336496361, 6194.4115309045565, 6226.906596401058, 6229.719662615194, 6230.56386052981, 5803.593748437737, 6005.609635373687, 6031.819045428644, 6038.456538911519, 6063.848403789941, 5906.497947674496, 5956.702164891652, 5957.910631340446, 5959.404059594006, 5971.373005834499, 5938.0, 6218.595791273553, 6231.626102433868, 6244.1570387997035, 6277.529185311028, 4140.544540100526, 4160.604742549453, 4170.416141740098, 4170.666346692196, 4172.541020487804, 5959.404059594006, 5991.0, 5995.250593675791, 6003.2796064470795, 6040.848978775566, 5661.867626474639, 5849.0, 5941.970290148694, 5998.49012833914, 6026.216591843032, 5944.0, 5946.405359464019, 5949.970250148722, 5955.583109182316, 5974.790882319098, 5433.157860531624, 5610.5231055360755, 5694.914576281442, 5893.764249429974, 5927.31835838884, 5965.9105113422465, 5988.461038506555, 5992.910106348321, 6007.30915944672, 6034.064719968412, 5838.4453476919625, 5850.356460789395, 5908.438698323653, 5922.200502932049, 5926.407359264039], "value": 4422.184467565464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.9517028978262, 821.7288294862695, 824.5135370131621, 836.0886633569409, 851.2083762101247, 13810.792838107436, 14250.714985700306, 14383.712325753504, 14401.63995900103, 14497.782533262009, 13050.673733156676, 13296.734065318687, 13319.0, 13340.599782006531, 13346.599602011931, 672.3646154384109, 790.0913948958686, 818.2635627934876, 820.1757233979841, 820.7537738678402, 815.351795322717, 815.6859609050499, 817.7546735979212, 817.7546735979212, 818.014292777205, 708.3624737736027, 855.1662129423825, 859.6303589456531, 859.96130174142, 860.0195776814437, 833.2833762963846, 843.371688092369, 843.7468759372164, 843.7553109598209, 845.6490556419079, 609.3906093906094, 610.7282259394572, 610.8320211941707, 616.0205273614929, 618.8576627375729, 13605.0, 13681.521146759915, 13697.315134243348, 13698.315084245747, 13774.586762397144, 13622.318884055758, 13659.658508537266, 14074.22591757453, 14403.279836008158, 14479.565613031626, 10751.462426878625, 11017.83473247902, 11043.282186657842, 11163.386013769239, 11175.608853690082, 3849.6920246380223, 3881.340172170738, 3882.2081242306667, 3924.9803750981064, 3985.262726395626, 54817.451825481636, 54921.45078549203, 55656.72171639156, 55796.6050848728, 55874.441255587735, 10664.466776661136, 11164.776704465865, 11181.329120252649, 11350.035247004098, 11360.375179365214, 19965.900170499055, 19968.70046949297, 20018.199272029247, 20045.899770501055, 20057.799422005886, 7858.174891636296, 7941.960290198512, 8430.978436189556, 8526.0, 8633.223009929137, 4406.4051353066925, 4439.400680908101, 4477.2164871147415, 4516.841910533116, 4543.795529201194, 3320.352531256382, 3374.6962773350515, 3406.489026646023, 3414.914627134292, 3415.4193787055765, 558.7764894042334, 600.3246347858659, 642.5052709413819, 662.6057495789997, 662.8641128568631, 590.2739630254811, 690.2200513419804, 692.6052150274295, 697.1285892634207, 704.5244459989589, 8892.860352040158, 8976.730698078938, 9321.860172097424, 9370.531473426301, 9546.522673866419, 728.5446595877577, 730.5069078372078, 732.9910716508762, 735.6505659811654, 744.3152299884119, 4279.0, 4385.473743150778, 4473.709208901411, 4589.495155532889, 4719.528047195253, 48294.5170548297, 48790.26814597784, 51190.0, 61497.0, 61879.6906015467, 48561.514384856404, 49853.0, 49901.750491248036, 50348.49651503438, 52966.47033529692, 43283.350749738776, 43433.0, 45466.54533454689, 45809.02241354301, 46610.53389466062, 9184.678536251198, 9300.023497532662, 9305.581248843682, 9318.95340523293, 9366.67216647414, 27663.0, 28939.0, 29172.56241156342, 29499.41001180007, 32984.67015329816, 39899.20957509148, 40275.194496109325, 41384.0, 41875.162496750505, 42269.78865105655, 10226.590936362461, 10461.110805581611, 10544.89455105439, 11622.76754464889, 11707.121965852424, 12980.935095324841, 13084.411201495765, 13601.795973060214, 13607.931960340135, 14323.069000514934, 11387.772244554897, 11448.3703396314, 11510.94244528772, 11729.41352932367, 12110.939445302716, 11687.298762074302, 12004.879951200377, 12446.813297800722, 12709.110362274921, 12995.28525931083, 12167.878321216675, 12168.08739344535, 12282.692932676755, 12594.181378210387, 13059.542915997894, 10239.846402303823, 10625.726124526878, 11056.834147487954, 11107.0, 11346.0355869752, 10971.23201375896, 10988.486072825392, 11135.552378190783, 11232.606858759904, 11336.94331528337], "value": 6599.9955782891975, "unit": "score"}], "name": "dromaeo_css", "value": 6817.759146547059, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 111.0, 111.0, 112.0, 101.0, 110.0, 111.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 154.0, 201.0, 138.0, 161.0, 158.0, 129.0, 190.0, 128.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 161.0, 160.0, 162.0, 163.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 102.0, 108.0, 73.0, 76.0, 73.0, 119.0, 102.0, 76.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 141.0, 93.0, 93.0, 92.0, 152.0, 92.0, 93.0, 141.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 75.0, 54.0, 54.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 64.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 76.0, 78.0, 78.0, 78.0, 79.0, 78.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 126.0, 124.0, 125.0, 130.0, 123.0, 126.0, 123.0, 158.0, 125.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 166.0, 166.0, 166.0, 165.0, 171.0, 172.0, 165.0, 166.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 68.0, 67.0, 69.0, 69.0, 69.0, 68.0, 68.0, 76.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1542.1000000000004, "alertThreshold": 2.0}]} 10:39:57 INFO - Return code: 0 10:39:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:39:57 ERROR - # TBPL SUCCESS # 10:39:57 INFO - Running post-action listener: _resource_record_post_action 10:39:57 INFO - Running post-run listener: _resource_record_post_run 10:39:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533733376; Read time: 12; Write time: 551004 10:39:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244649984; Read time: 0; Write time: 314348 10:39:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289083392; Read time: 12; Write time: 236656 10:39:58 INFO - Running post-run listener: _upload_blobber_files 10:39:58 INFO - Blob upload gear active. 10:39:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:58 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 10:39:58 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'] 10:39:58 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 10:39:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:59 INFO - (blobuploader) - INFO - Done attempting. 10:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:00 INFO - (blobuploader) - INFO - Done attempting. 10:40:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:00 INFO - Return code: 0 10:40:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e696ab36cb870fc13f9502e0f2aff02eaecfd10f9cac973c761161df06d1ec63267e942907f9063f75d60bf4c5cf5e54333177f2fac8253e82edd181abe762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71738d12541a9ca046d46ecb4debde32ab7af612ff8297a9b5a95fcd707169fe87c7727e0fe34144b362b2c049deb269568ece36187bc06fa97835edf304a200"} 10:40:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:00 INFO - Contents: 10:40:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e696ab36cb870fc13f9502e0f2aff02eaecfd10f9cac973c761161df06d1ec63267e942907f9063f75d60bf4c5cf5e54333177f2fac8253e82edd181abe762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71738d12541a9ca046d46ecb4debde32ab7af612ff8297a9b5a95fcd707169fe87c7727e0fe34144b362b2c049deb269568ece36187bc06fa97835edf304a200"} 10:40:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:00 INFO - Copying logs to upload dir... 10:40:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.708416 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-21 10:39:59.996802) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:40:00.000647) ========= 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=836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215 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/d5e696ab36cb870fc13f9502e0f2aff02eaecfd10f9cac973c761161df06d1ec63267e942907f9063f75d60bf4c5cf5e54333177f2fac8253e82edd181abe762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71738d12541a9ca046d46ecb4debde32ab7af612ff8297a9b5a95fcd707169fe87c7727e0fe34144b362b2c049deb269568ece36187bc06fa97835edf304a200"} build_url:https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/AIsYKh-gSIqk0J-IOPNZsw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e696ab36cb870fc13f9502e0f2aff02eaecfd10f9cac973c761161df06d1ec63267e942907f9063f75d60bf4c5cf5e54333177f2fac8253e82edd181abe762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71738d12541a9ca046d46ecb4debde32ab7af612ff8297a9b5a95fcd707169fe87c7727e0fe34144b362b2c049deb269568ece36187bc06fa97835edf304a200"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:40:00.025565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:40:00.025901) ========= 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=836cfdc75598d54cb747368e000001a9-1461258607.74486-346791215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:40:00.111455) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:40:00.111901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:40:00.112206) ========= ========= Total master_lag: 0.18 =========