builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1464430273.26 results: success (0) buildid: 20160525152143 builduid: 8654ccbbea454f27b451ee4808dca30e revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.264889) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.265315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.265614) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.279827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.280091) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:11:13-- 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% 45.8M=0s 2016-05-28 03:11:13 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129625 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.423110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.423423) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:13.473321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:11:13.473689) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --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=a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:11:13,668 truncating revision to first 12 chars 2016-05-28 03:11:13,668 Setting DEBUG logging. 2016-05-28 03:11:13,668 attempt 1/10 2016-05-28 03:11:13,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7c3a2567f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:11:15,053 unpacking tar archive at: mozilla-aurora-4f7c3a2567f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.737823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:11:15.225166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:15.225504) ========= script_repo_revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:15.225892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:15.226161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:15.235578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-28 03:11:15.235845) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:11:15 INFO - MultiFileLogger online at 20160528 03:11:15 in /builds/slave/test 03:11:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:11:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:15 INFO - {'append_to_log': False, 03:11:15 INFO - 'base_work_dir': '/builds/slave/test', 03:11:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:11:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:15 INFO - 'branch': 'Mozilla-Aurora', 03:11:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:15 INFO - 'config_files': ('talos/linux_config.py',), 03:11:15 INFO - 'default_actions': ('clobber', 03:11:15 INFO - 'read-buildbot-config', 03:11:15 INFO - 'download-and-extract', 03:11:15 INFO - 'populate-webroot', 03:11:15 INFO - 'create-virtualenv', 03:11:15 INFO - 'install', 03:11:15 INFO - 'run-tests'), 03:11:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:15 INFO - 'download_minidump_stackwalk': True, 03:11:15 INFO - 'download_symbols': 'ondemand', 03:11:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:15 INFO - 'installer_path': 'installer.exe', 03:11:15 INFO - 'log_level': 'info', 03:11:15 INFO - 'log_name': 'talos', 03:11:15 INFO - 'log_to_console': True, 03:11:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:11:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:11:15 INFO - 'opt_config_files': (), 03:11:15 INFO - 'pip_index': False, 03:11:15 INFO - 'sps_profile': False, 03:11:15 INFO - 'sps_profile_interval': 0, 03:11:15 INFO - 'suite': 'dromaeojs', 03:11:15 INFO - 'system_bits': '32', 03:11:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:15 INFO - 'title': 'talos-linux64-ix-064', 03:11:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:15 INFO - 'use_talos_json': True, 03:11:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:15 INFO - 'work_dir': 'build'} 03:11:15 INFO - ##### 03:11:15 INFO - ##### Running clobber step. 03:11:15 INFO - ##### 03:11:15 INFO - Running pre-action listener: _resource_record_pre_action 03:11:15 INFO - Running main action method: clobber 03:11:15 INFO - rmtree: /builds/slave/test/build 03:11:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:15 INFO - Running post-action listener: _resource_record_post_action 03:11:15 INFO - ##### 03:11:15 INFO - ##### Running read-buildbot-config step. 03:11:15 INFO - ##### 03:11:15 INFO - Running pre-action listener: _resource_record_pre_action 03:11:15 INFO - Running main action method: read_buildbot_config 03:11:15 INFO - Using buildbot properties: 03:11:15 INFO - { 03:11:15 INFO - "project": "", 03:11:15 INFO - "product": "firefox", 03:11:15 INFO - "script_repo_revision": "production", 03:11:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:11:15 INFO - "repository": "", 03:11:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:11:15 INFO - "buildid": "20160525152143", 03:11:15 INFO - "pgo_build": "True", 03:11:15 INFO - "basedir": "/builds/slave/test", 03:11:15 INFO - "buildnumber": 263, 03:11:15 INFO - "slavename": "talos-linux64-ix-064", 03:11:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:11:15 INFO - "platform": "ubuntu64_hw", 03:11:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:11:15 INFO - "branch": "mozilla-aurora", 03:11:15 INFO - "repo_path": "releases/mozilla-aurora", 03:11:15 INFO - "revision": "4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3", 03:11:15 INFO - "stage_platform": "linux64-pgo", 03:11:15 INFO - "builduid": "8654ccbbea454f27b451ee4808dca30e", 03:11:15 INFO - "slavebuilddir": "test" 03:11:15 INFO - } 03:11:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:11:15 INFO - Running post-action listener: _resource_record_post_action 03:11:15 INFO - ##### 03:11:15 INFO - ##### Running download-and-extract step. 03:11:15 INFO - ##### 03:11:15 INFO - Running pre-action listener: _resource_record_pre_action 03:11:15 INFO - Running main action method: download_and_extract 03:11:15 INFO - mkdir: /builds/slave/test/build/tests 03:11: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')]} 03:11:15 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:11:16 INFO - Downloaded 1361 bytes. 03:11:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:16 INFO - Using the following test package requirements: 03:11:16 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:16 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:11:16 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:11:16 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'jsshell-linux-x86_64.zip'], 03:11:16 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:11:16 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:16 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:11:16 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:11:16 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:11:16 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:11:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:11:16 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')]} 03:11:16 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:11:18 INFO - Downloaded 24135950 bytes. 03:11:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:11:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:11:19 INFO - Return code: 0 03:11:19 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:11:19 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')]} 03:11:19 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:11:22 INFO - Downloaded 24135950 bytes. 03:11:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:11:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:11:23 INFO - Return code: 0 03:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:23 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:11:24 INFO - Downloaded 10840145 bytes. 03:11:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:11:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:11:24 INFO - Return code: 0 03:11: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')]} 03:11:24 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:11:30 INFO - Downloaded 62768089 bytes. 03:11:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:30 INFO - mkdir: /builds/slave/test/properties 03:11:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:30 INFO - Contents: 03:11:30 INFO - build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:30 INFO - Running post-action listener: _resource_record_post_action 03:11:30 INFO - Running post-action listener: set_extra_try_arguments 03:11:30 INFO - ##### 03:11:30 INFO - ##### Running populate-webroot step. 03:11:30 INFO - ##### 03:11:30 INFO - Running pre-action listener: _resource_record_pre_action 03:11:30 INFO - Running main action method: populate_webroot 03:11:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:30 INFO - '--tppagecycles', 03:11:30 INFO - '7'], 03:11:30 INFO - 'tests': ['tsvgm']}}, 03:11:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['damp', 'tps']}, 03:11:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'tests': ['damp', 'tps']}, 03:11:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['dromaeo_dom']}, 03:11:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['a11yr', 03:11:30 INFO - 'ts_paint', 03:11:30 INFO - 'tpaint', 03:11:30 INFO - 'sessionrestore', 03:11:30 INFO - 'sessionrestore_no_auto_restore', 03:11:30 INFO - 'tabpaint']}, 03:11:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:30 INFO - 'ts_paint', 03:11:30 INFO - 'tpaint', 03:11:30 INFO - 'sessionrestore', 03:11:30 INFO - 'sessionrestore_no_auto_restore', 03:11:30 INFO - 'tabpaint']}, 03:11:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:30 INFO - 'ts_paint', 03:11:30 INFO - 'tpaint', 03:11:30 INFO - 'sessionrestore', 03:11:30 INFO - 'sessionrestore_no_auto_restore', 03:11:30 INFO - 'tabpaint']}, 03:11:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:30 INFO - 'ts_paint', 03:11:30 INFO - 'tpaint', 03:11:30 INFO - 'sessionrestore', 03:11:30 INFO - 'sessionrestore_no_auto_restore', 03:11:30 INFO - 'tabpaint']}, 03:11:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['a11yr', 03:11:30 INFO - 'ts_paint', 03:11:30 INFO - 'tpaint', 03:11:30 INFO - 'sessionrestore', 03:11:30 INFO - 'sessionrestore_no_auto_restore', 03:11:30 INFO - 'tabpaint']}, 03:11:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['a11yr', 03:11:30 INFO - 'ts_paint', 03:11:30 INFO - 'tpaint', 03:11:30 INFO - 'sessionrestore', 03:11:30 INFO - 'sessionrestore_no_auto_restore', 03:11:30 INFO - 'tabpaint']}, 03:11:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['tsvgx', 03:11:30 INFO - 'tsvgr_opacity', 03:11:30 INFO - 'tart', 03:11:30 INFO - 'tscrollx', 03:11:30 INFO - 'cart']}, 03:11:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:30 INFO - 'tsvgr_opacity', 03:11:30 INFO - 'tart', 03:11:30 INFO - 'tscrollx', 03:11:30 INFO - 'cart']}, 03:11:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'talos_options': ['--disable-e10s'], 03:11:30 INFO - 'tests': ['tp5o']}, 03:11:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'tests': ['tp5o']}, 03:11:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'talos_options': ['--disable-e10s', 03:11:30 INFO - '--xperf_path', 03:11:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:30 INFO - 'tests': ['tp5n']}, 03:11:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:30 INFO - 'talos_options': ['--xperf_path', 03:11:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:30 INFO - 'tests': ['tp5n']}}, 03:11:30 INFO - 'talos.zip': {'path': '', 03:11:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:30 INFO - Running post-action listener: _resource_record_post_action 03:11:30 INFO - ##### 03:11:30 INFO - ##### Running create-virtualenv step. 03:11:30 INFO - ##### 03:11:30 INFO - Running pre-action listener: _resource_record_pre_action 03:11:30 INFO - Running main action method: create_virtualenv 03:11:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:30 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 03:11:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:30 INFO - Using real prefix '/usr' 03:11:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:33 INFO - Installing pip.................done. 03:11:33 INFO - Return code: 0 03:11:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:33 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')]} 03:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:33 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')]} 03:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:33 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:33 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 03:11:33 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 03:11:33 INFO - Using env: {'DISPLAY': ':0', 03:11:33 INFO - 'HOME': '/home/cltbld', 03:11:33 INFO - 'LANG': 'en_US.UTF-8', 03:11:33 INFO - 'LANGUAGE': 'en_US:en', 03:11:33 INFO - 'LOGNAME': 'cltbld', 03:11:33 INFO - 'MAIL': '/var/mail/cltbld', 03:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:33 INFO - 'MOZ_NO_REMOTE': '1', 03:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:33 INFO - 'NO_EM_RESTART': '1', 03:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:33 INFO - 'PWD': '/builds/slave/test', 03:11:33 INFO - 'SHELL': '/bin/bash', 03:11:33 INFO - 'SHLVL': '1', 03:11:33 INFO - 'TERM': 'linux', 03:11:33 INFO - 'TMOUT': '86400', 03:11:33 INFO - 'USER': 'cltbld', 03:11:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:33 INFO - '_': '/tools/buildbot/bin/python'} 03:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:33 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 03:11:33 INFO - Cleaning up... 03:11:33 INFO - Return code: 0 03:11:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:11:33 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')]} 03:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:33 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')]} 03:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:33 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:33 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 03:11:33 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 03:11:33 INFO - Using env: {'DISPLAY': ':0', 03:11:33 INFO - 'HOME': '/home/cltbld', 03:11:33 INFO - 'LANG': 'en_US.UTF-8', 03:11:33 INFO - 'LANGUAGE': 'en_US:en', 03:11:33 INFO - 'LOGNAME': 'cltbld', 03:11:33 INFO - 'MAIL': '/var/mail/cltbld', 03:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:33 INFO - 'MOZ_NO_REMOTE': '1', 03:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:33 INFO - 'NO_EM_RESTART': '1', 03:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:33 INFO - 'PWD': '/builds/slave/test', 03:11:33 INFO - 'SHELL': '/bin/bash', 03:11:33 INFO - 'SHLVL': '1', 03:11:33 INFO - 'TERM': 'linux', 03:11:33 INFO - 'TMOUT': '86400', 03:11:33 INFO - 'USER': 'cltbld', 03:11:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:33 INFO - '_': '/tools/buildbot/bin/python'} 03:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:33 INFO - Downloading/unpacking psutil>=0.7.1 03:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:35 INFO - Installing collected packages: psutil 03:11:35 INFO - Running setup.py install for psutil 03:11:35 INFO - building 'psutil._psutil_linux' extension 03:11:35 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 03:11:36 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 03:11:36 INFO - building 'psutil._psutil_posix' extension 03:11:36 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 03:11:36 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 03:11:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:36 INFO - Successfully installed psutil 03:11:36 INFO - Cleaning up... 03:11:36 INFO - Return code: 0 03:11:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:11:36 INFO - Using env: {'DISPLAY': ':0', 03:11:36 INFO - 'HOME': '/home/cltbld', 03:11:36 INFO - 'LANG': 'en_US.UTF-8', 03:11:36 INFO - 'LANGUAGE': 'en_US:en', 03:11:36 INFO - 'LOGNAME': 'cltbld', 03:11:36 INFO - 'MAIL': '/var/mail/cltbld', 03:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:36 INFO - 'MOZ_NO_REMOTE': '1', 03:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:36 INFO - 'NO_EM_RESTART': '1', 03:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:36 INFO - 'PWD': '/builds/slave/test', 03:11:36 INFO - 'SHELL': '/bin/bash', 03:11:36 INFO - 'SHLVL': '1', 03:11:36 INFO - 'TERM': 'linux', 03:11:36 INFO - 'TMOUT': '86400', 03:11:36 INFO - 'USER': 'cltbld', 03:11:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:36 INFO - '_': '/tools/buildbot/bin/python'} 03:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:11:38 INFO - Installing collected packages: mozsystemmonitor 03:11:38 INFO - Running setup.py install for mozsystemmonitor 03:11:38 INFO - Successfully installed mozsystemmonitor 03:11:38 INFO - Cleaning up... 03:11:38 INFO - Return code: 0 03:11:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:38 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:38 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 03:11:38 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 03:11:38 INFO - Using env: {'DISPLAY': ':0', 03:11:38 INFO - 'HOME': '/home/cltbld', 03:11:38 INFO - 'LANG': 'en_US.UTF-8', 03:11:38 INFO - 'LANGUAGE': 'en_US:en', 03:11:38 INFO - 'LOGNAME': 'cltbld', 03:11:38 INFO - 'MAIL': '/var/mail/cltbld', 03:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:38 INFO - 'MOZ_NO_REMOTE': '1', 03:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:38 INFO - 'NO_EM_RESTART': '1', 03:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:38 INFO - 'PWD': '/builds/slave/test', 03:11:38 INFO - 'SHELL': '/bin/bash', 03:11:38 INFO - 'SHLVL': '1', 03:11:38 INFO - 'TERM': 'linux', 03:11:38 INFO - 'TMOUT': '86400', 03:11:38 INFO - 'USER': 'cltbld', 03:11:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:38 INFO - '_': '/tools/buildbot/bin/python'} 03:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:41 INFO - Downloading docopt-0.6.1.tar.gz 03:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:41 INFO - Running setup.py install for blobuploader 03:11:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:41 INFO - Running setup.py install for requests 03:11:42 INFO - Running setup.py install for docopt 03:11:42 INFO - Successfully installed blobuploader requests docopt 03:11:42 INFO - Cleaning up... 03:11:42 INFO - Return code: 0 03:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:42 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 03:11:42 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 03:11:42 INFO - Using env: {'DISPLAY': ':0', 03:11:42 INFO - 'HOME': '/home/cltbld', 03:11:42 INFO - 'LANG': 'en_US.UTF-8', 03:11:42 INFO - 'LANGUAGE': 'en_US:en', 03:11:42 INFO - 'LOGNAME': 'cltbld', 03:11:42 INFO - 'MAIL': '/var/mail/cltbld', 03:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:42 INFO - 'MOZ_NO_REMOTE': '1', 03:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:42 INFO - 'NO_EM_RESTART': '1', 03:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:42 INFO - 'PWD': '/builds/slave/test', 03:11:42 INFO - 'SHELL': '/bin/bash', 03:11:42 INFO - 'SHLVL': '1', 03:11:42 INFO - 'TERM': 'linux', 03:11:42 INFO - 'TMOUT': '86400', 03:11:42 INFO - 'USER': 'cltbld', 03:11:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:42 INFO - '_': '/tools/buildbot/bin/python'} 03:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:42 INFO - Running setup.py (path:/tmp/pip-cccCQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:42 INFO - Running setup.py (path:/tmp/pip-Uepzx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:42 INFO - Running setup.py (path:/tmp/pip-fZTwcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:42 INFO - Running setup.py (path:/tmp/pip-Uq9xJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:42 INFO - Running setup.py (path:/tmp/pip-Wm7sur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:42 INFO - Running setup.py (path:/tmp/pip-oQP_7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:42 INFO - Running setup.py (path:/tmp/pip-Fimhml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:42 INFO - Running setup.py (path:/tmp/pip-JlaC37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:43 INFO - Running setup.py (path:/tmp/pip-6FQOih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:43 INFO - Running setup.py (path:/tmp/pip-qCNpuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:43 INFO - Running setup.py (path:/tmp/pip-yD4Amb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:43 INFO - Running setup.py (path:/tmp/pip-5pTKiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:43 INFO - Running setup.py (path:/tmp/pip-yGq01k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:43 INFO - Running setup.py (path:/tmp/pip-JjSykP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:43 INFO - Running setup.py (path:/tmp/pip-wYwEjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:43 INFO - Running setup.py (path:/tmp/pip-Vtz8lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:43 INFO - Running setup.py (path:/tmp/pip-soQoTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:43 INFO - Running setup.py install for manifestparser 03:11:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:11:43 INFO - Running setup.py install for mozcrash 03:11:43 INFO - Running setup.py install for mozdebug 03:11:43 INFO - Running setup.py install for mozdevice 03:11:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Running setup.py install for mozfile 03:11:44 INFO - Running setup.py install for mozhttpd 03:11:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Running setup.py install for mozinfo 03:11:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Running setup.py install for mozInstall 03:11:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Running setup.py install for mozleak 03:11:44 INFO - Running setup.py install for mozlog 03:11:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Running setup.py install for moznetwork 03:11:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Running setup.py install for mozprocess 03:11:44 INFO - Running setup.py install for mozprofile 03:11:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:11:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:11:45 INFO - Running setup.py install for mozrunner 03:11:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:11:45 INFO - Running setup.py install for mozscreenshot 03:11:45 INFO - Running setup.py install for moztest 03:11:45 INFO - Running setup.py install for mozversion 03:11:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:11:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:45 INFO - Cleaning up... 03:11:45 INFO - Return code: 0 03:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:45 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:45 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 03:11:45 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 03:11:45 INFO - Using env: {'DISPLAY': ':0', 03:11:45 INFO - 'HOME': '/home/cltbld', 03:11:45 INFO - 'LANG': 'en_US.UTF-8', 03:11:45 INFO - 'LANGUAGE': 'en_US:en', 03:11:45 INFO - 'LOGNAME': 'cltbld', 03:11:45 INFO - 'MAIL': '/var/mail/cltbld', 03:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:45 INFO - 'MOZ_NO_REMOTE': '1', 03:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:45 INFO - 'NO_EM_RESTART': '1', 03:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:45 INFO - 'PWD': '/builds/slave/test', 03:11:45 INFO - 'SHELL': '/bin/bash', 03:11:45 INFO - 'SHLVL': '1', 03:11:45 INFO - 'TERM': 'linux', 03:11:45 INFO - 'TMOUT': '86400', 03:11:45 INFO - 'USER': 'cltbld', 03:11:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:45 INFO - '_': '/tools/buildbot/bin/python'} 03:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:45 INFO - Running setup.py (path:/tmp/pip-i3q1LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:45 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)) 03:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:45 INFO - Running setup.py (path:/tmp/pip-eFBFCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:45 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)) 03:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:45 INFO - Running setup.py (path:/tmp/pip-_2vZCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:45 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)) 03:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:45 INFO - Running setup.py (path:/tmp/pip-JtgUdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:45 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)) 03:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:45 INFO - Running setup.py (path:/tmp/pip-q9KbDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:46 INFO - Running setup.py (path:/tmp/pip-o9iqs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:46 INFO - Running setup.py (path:/tmp/pip-YlTh6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:46 INFO - Running setup.py (path:/tmp/pip-H1kQ0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:46 INFO - Running setup.py (path:/tmp/pip-orkmmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:46 INFO - Running setup.py (path:/tmp/pip-gDFjKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:46 INFO - Running setup.py (path:/tmp/pip-FQUTTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:46 INFO - Running setup.py (path:/tmp/pip-RbWeKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:46 INFO - Running setup.py (path:/tmp/pip-HG_E07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:46 INFO - Running setup.py (path:/tmp/pip-01tnDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:46 INFO - Running setup.py (path:/tmp/pip-P8F37c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:46 INFO - Running setup.py (path:/tmp/pip-Gxoiam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:46 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)) 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:46 INFO - Running setup.py (path:/tmp/pip-QGSFBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:46 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)) 03:11:46 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)) 03:11:46 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)) 03:11:46 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)) 03:11:46 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)) 03:11:46 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)) 03:11:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11:48 INFO - Downloading blessings-1.6.tar.gz 03:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:48 INFO - Installing collected packages: blessings 03:11:48 INFO - Running setup.py install for blessings 03:11:48 INFO - Successfully installed blessings 03:11:48 INFO - Cleaning up... 03:11:49 INFO - Return code: 0 03:11:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:11:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:49 INFO - Reading from file tmpfile_stdout 03:11:49 INFO - Current package versions: 03:11:49 INFO - argparse == 1.2.1 03:11:49 INFO - blessings == 1.6 03:11:49 INFO - blobuploader == 1.2.4 03:11:49 INFO - docopt == 0.6.1 03:11:49 INFO - manifestparser == 1.1 03:11:49 INFO - mozInstall == 1.12 03:11:49 INFO - mozcrash == 0.17 03:11:49 INFO - mozdebug == 0.1 03:11:49 INFO - mozdevice == 0.48 03:11:49 INFO - mozfile == 1.2 03:11:49 INFO - mozhttpd == 0.7 03:11:49 INFO - mozinfo == 0.9 03:11:49 INFO - mozleak == 0.1 03:11:49 INFO - mozlog == 3.1 03:11:49 INFO - moznetwork == 0.27 03:11:49 INFO - mozprocess == 0.22 03:11:49 INFO - mozprofile == 0.28 03:11:49 INFO - mozrunner == 6.11 03:11:49 INFO - mozscreenshot == 0.1 03:11:49 INFO - mozsystemmonitor == 0.0 03:11:49 INFO - moztest == 0.7 03:11:49 INFO - mozversion == 1.4 03:11:49 INFO - psutil == 3.1.1 03:11:49 INFO - requests == 1.2.3 03:11:49 INFO - wsgiref == 0.1.2 03:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:49 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')]} 03:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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')]} 03:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:49 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 03:11:49 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 03:11:49 INFO - Using env: {'DISPLAY': ':0', 03:11:49 INFO - 'HOME': '/home/cltbld', 03:11:49 INFO - 'LANG': 'en_US.UTF-8', 03:11:49 INFO - 'LANGUAGE': 'en_US:en', 03:11:49 INFO - 'LOGNAME': 'cltbld', 03:11:49 INFO - 'MAIL': '/var/mail/cltbld', 03:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:49 INFO - 'MOZ_NO_REMOTE': '1', 03:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:49 INFO - 'NO_EM_RESTART': '1', 03:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:49 INFO - 'PWD': '/builds/slave/test', 03:11:49 INFO - 'SHELL': '/bin/bash', 03:11:49 INFO - 'SHLVL': '1', 03:11:49 INFO - 'TERM': 'linux', 03:11:49 INFO - 'TMOUT': '86400', 03:11:49 INFO - 'USER': 'cltbld', 03:11:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:49 INFO - '_': '/tools/buildbot/bin/python'} 03:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 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)) 03:11:49 INFO - Cleaning up... 03:11:49 INFO - Return code: 0 03:11:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:49 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')]} 03:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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')]} 03:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:49 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 03:11:49 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 03:11:49 INFO - Using env: {'DISPLAY': ':0', 03:11:49 INFO - 'HOME': '/home/cltbld', 03:11:49 INFO - 'LANG': 'en_US.UTF-8', 03:11:49 INFO - 'LANGUAGE': 'en_US:en', 03:11:49 INFO - 'LOGNAME': 'cltbld', 03:11:49 INFO - 'MAIL': '/var/mail/cltbld', 03:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:49 INFO - 'MOZ_NO_REMOTE': '1', 03:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:49 INFO - 'NO_EM_RESTART': '1', 03:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:49 INFO - 'PWD': '/builds/slave/test', 03:11:49 INFO - 'SHELL': '/bin/bash', 03:11:49 INFO - 'SHLVL': '1', 03:11:49 INFO - 'TERM': 'linux', 03:11:49 INFO - 'TMOUT': '86400', 03:11:49 INFO - 'USER': 'cltbld', 03:11:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:49 INFO - '_': '/tools/buildbot/bin/python'} 03:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:49 INFO - Downloading/unpacking jsonschema 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:51 INFO - Downloading/unpacking functools32 (from jsonschema) 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:51 INFO - warning: no files found matching '*.txt' 03:11:51 INFO - no previously-included directories found matching 'build' 03:11:51 INFO - no previously-included directories found matching 'dist' 03:11:51 INFO - no previously-included directories found matching '.git*' 03:11:51 INFO - Installing collected packages: jsonschema, functools32 03:11:51 INFO - Running setup.py install for functools32 03:11:51 INFO - warning: no files found matching '*.txt' 03:11:51 INFO - no previously-included directories found matching 'build' 03:11:51 INFO - no previously-included directories found matching 'dist' 03:11:51 INFO - no previously-included directories found matching '.git*' 03:11:51 INFO - Successfully installed jsonschema functools32 03:11:51 INFO - Cleaning up... 03:11:52 INFO - Return code: 0 03:11:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e31835f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', '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 03:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:11:52 INFO - Using env: {'DISPLAY': ':0', 03:11:52 INFO - 'HOME': '/home/cltbld', 03:11:52 INFO - 'LANG': 'en_US.UTF-8', 03:11:52 INFO - 'LANGUAGE': 'en_US:en', 03:11:52 INFO - 'LOGNAME': 'cltbld', 03:11:52 INFO - 'MAIL': '/var/mail/cltbld', 03:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:52 INFO - 'MOZ_NO_REMOTE': '1', 03:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:52 INFO - 'NO_EM_RESTART': '1', 03:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:52 INFO - 'PWD': '/builds/slave/test', 03:11:52 INFO - 'SHELL': '/bin/bash', 03:11:52 INFO - 'SHLVL': '1', 03:11:52 INFO - 'TERM': 'linux', 03:11:52 INFO - 'TMOUT': '86400', 03:11:52 INFO - 'USER': 'cltbld', 03:11:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:52 INFO - '_': '/tools/buildbot/bin/python'} 03:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:52 INFO - Downloading/unpacking flake8 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 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 03:11:52 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 03:11:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:11:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:11:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:11:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:55 INFO - no previously-included directories found matching 'docs/_build' 03:11:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:11:55 INFO - Running setup.py install for pep8 03:11:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:55 INFO - no previously-included directories found matching 'docs/_build' 03:11:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:11:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:11:55 INFO - Cleaning up... 03:11:55 INFO - Return code: 0 03:11:55 INFO - Running post-action listener: _resource_record_post_action 03:11:55 INFO - Running post-action listener: _start_resource_monitoring 03:11:55 INFO - Starting resource monitoring. 03:11:55 INFO - ##### 03:11:55 INFO - ##### Running install step. 03:11:55 INFO - ##### 03:11:55 INFO - Running pre-action listener: _resource_record_pre_action 03:11:55 INFO - Running main action method: install 03:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:55 INFO - Reading from file tmpfile_stdout 03:11:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:55 INFO - Reading from file tmpfile_stdout 03:11:55 INFO - Output received: 03:11:55 INFO - Usage: mozinstall [options] installer 03:11:55 INFO - Options: 03:11:55 INFO - -h, --help show this help message and exit 03:11:55 INFO - -d DEST, --destination=DEST 03:11:55 INFO - Directory to install application into. [default: 03:11:55 INFO - "/builds/slave/test"] 03:11:55 INFO - --app=APP Application being installed. [default: firefox] 03:11:55 INFO - mkdir: /builds/slave/test/build/application 03:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:12:11 INFO - Reading from file tmpfile_stdout 03:12:11 INFO - Output received: 03:12:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:12:11 INFO - Running post-action listener: _resource_record_post_action 03:12:11 INFO - ##### 03:12:11 INFO - ##### Running run-tests step. 03:12:11 INFO - ##### 03:12:11 INFO - Running pre-action listener: _resource_record_pre_action 03:12:11 INFO - Running main action method: run_tests 03:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:11 INFO - Python 2.7.3 03:12:11 INFO - Return code: 0 03:12:11 INFO - grabbing minidump binary from tooltool 03:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:11 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 0xe5a410>, '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 0xe5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:11 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 03:12:11 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 03:12:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:11 INFO - Return code: 0 03:12:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:12:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:12:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:12:12 INFO - Return code: 0 03:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 03:12:12 INFO - Using env: {'DISPLAY': ':0', 03:12:12 INFO - 'HOME': '/home/cltbld', 03:12:12 INFO - 'LANG': 'en_US.UTF-8', 03:12:12 INFO - 'LANGUAGE': 'en_US:en', 03:12:12 INFO - 'LOGNAME': 'cltbld', 03:12:12 INFO - 'MAIL': '/var/mail/cltbld', 03:12:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:12 INFO - 'MOZ_NO_REMOTE': '1', 03:12:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:12 INFO - 'NO_EM_RESTART': '1', 03:12:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:12 INFO - 'PWD': '/builds/slave/test', 03:12:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:12 INFO - 'SHELL': '/bin/bash', 03:12:12 INFO - 'SHLVL': '1', 03:12:12 INFO - 'TERM': 'linux', 03:12:12 INFO - 'TMOUT': '86400', 03:12:12 INFO - 'USER': 'cltbld', 03:12:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410', 03:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:12 INFO - '_': '/tools/buildbot/bin/python'} 03:12:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:12:12 INFO - mozversion application_buildid: 20160525152143 03:12:12 INFO - mozversion application_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:12 INFO - mozversion application_name: Firefox 03:12:12 INFO - mozversion application_remotingname: firefox-dev 03:12:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:12 INFO - mozversion application_vendor: Mozilla 03:12:12 INFO - mozversion application_version: 48.0a2 03:12:12 INFO - mozversion platform_buildid: 20160525152143 03:12:12 INFO - mozversion platform_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:12 INFO - mozversion platform_version: 48.0a2 03:12:12 INFO - using testdate: 1464430332 03:12:12 INFO - actual date: 1464430332 03:12:12 INFO - starting webserver on 'localhost:41452' 03:12:12 INFO - SUITE-START | Running 2 tests 03:12:12 INFO - TEST-START | dromaeo_css 03:12:12 INFO - operating with platform_type : linux_ 03:12:12 INFO - Initialising browser for dromaeo_css test... 03:12:12 INFO - TEST-INFO | started process 8332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqObgsT/profile http://localhost:41452/getInfo.html) 03:12:17 INFO - PROCESS | 8332 | __metrics Screen width/height:1600/1200 03:12:17 INFO - PROCESS | 8332 | colorDepth:24 03:12:17 INFO - PROCESS | 8332 | Browser inner width/height: 1024/697 03:12:17 INFO - PROCESS | 8332 | __metrics 03:12:18 ERROR - PROCESS | 8332 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:12:19 INFO - TEST-INFO | 8332: exit 0 03:12:19 INFO - Browser initialized. 03:12:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:19 INFO - TEST-INFO | started process 8424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqObgsT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:30 INFO - PROCESS | 8424 | RSS: Main: 141819904 03:12:30 INFO - PROCESS | 8424 | 03:13:21 INFO - PROCESS | 8424 | 1464430401966 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] 03:15:29 INFO - PROCESS | 8424 | Cycle 1(1): loaded http://localhost:41452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41452/tests/dromaeo/cssquery-ext.html) 03:15:30 INFO - PROCESS | 8424 | RSS: Main: 249798656 03:15:30 INFO - PROCESS | 8424 | 03:18:32 INFO - PROCESS | 8424 | Cycle 1(1): loaded http://localhost:41452/tests/dromaeo/cssquery-ext.html (next: http://localhost:41452/tests/dromaeo/cssquery-jquery.html) 03:18:33 INFO - PROCESS | 8424 | RSS: Main: 225288192 03:18:33 INFO - PROCESS | 8424 | 03:21:35 INFO - PROCESS | 8424 | Cycle 1(1): loaded http://localhost:41452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41452/tests/dromaeo/cssquery-mootools.html) 03:21:35 INFO - PROCESS | 8424 | RSS: Main: 216993792 03:21:35 INFO - PROCESS | 8424 | 03:24:37 INFO - PROCESS | 8424 | Cycle 1(1): loaded http://localhost:41452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41452/tests/dromaeo/cssquery-prototype.html) 03:24:38 INFO - PROCESS | 8424 | RSS: Main: 218791936 03:24:38 INFO - PROCESS | 8424 | 03:27:40 INFO - PROCESS | 8424 | Cycle 1(1): loaded http://localhost:41452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41452/tests/dromaeo/cssquery-yui.html) 03:27:41 INFO - PROCESS | 8424 | RSS: Main: 186888192 03:27:41 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | Cycle 1(1): loaded http://localhost:41452/tests/dromaeo/cssquery-yui.html (next: http://localhost:41452/tests/dromaeo/cssquery-dojo.html) 03:30:43 INFO - PROCESS | 8424 | RSS: Main: 256958464 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | __start_tp_report 03:30:43 INFO - PROCESS | 8424 | _x_x_mozilla_page_load 03:30:43 INFO - PROCESS | 8424 | _x_x_mozilla_page_load_details 03:30:43 INFO - PROCESS | 8424 | |i|pagename|runs| 03:30:43 INFO - PROCESS | 8424 | |0;dojo.html;3306.768526203165;3343.3313337332524;3373.1567108222944;3400.9489857652125;3413.5562376891003;5538.501534861862;5556.277683901092;5560.388357280701;5569.582281328896;5591.2731344925205;5520.06158952978;5584.972075139619;5587.1339942308905;5592.832215033545;5632.831015069544;4987.426445958725;5025.070361983036;5080.364954380702;5134.768935397898;5168.379794424655;5036.320096786942;5130.6152038597065;5134.358205224347;5137.768800403972;5139.974300128494;5027.09512287788;5108.310378098965;5133.537981581657;5141.640085194038;5146.819861304855;5183.792648294083;5207.583393328562;5228.973855130738;5236.554892834114;5262.3422072241165;4936.679115857458;4993.650444468889;5015.598752099823;5107;5109.386873575195;5471.124620060811;5515.7242137893345;5526.06056970316;5539.944600553983;5544.667319960815;5881.117832325142;5883.294004719461;5886.323072846634;5894.2926848778425;5896.823095307148;5946.07835785454;6061.060535616986;6097.20736304282;6099.878002439971;6132.509399248094;5563.193336966117;5614.3543492498475;5618.57860660448;5626.381098079208;5650.4349565043985;5891.587588868738;6130.569288464064;6156.29202641702;6161.106639537332;6175.382461753788;5943.197668314809;6016.067509536029;6020.668863212565;6030.427109424685;6043.939560604425;6044.546659000593;6050.818475445743;6051.515878729691;6057.606255593372;6066.545009124334;5802.854928626818;5933.2880054393745;6016.969915150396;6018.067199583984;6018.969905150446;5991.970040149771;5992;6004.729787159588;6006.789762358384;6025.9096113558335;4532.456105267323;4543.750093744876;4548.476925153584;4550.453945526558;4582.060677561092;3964.345882929342;4043.3732771420478;4073.6130067643526;4105.58944105587;4129.380592911028;5736.426357364314;5751.1085781703905;5760.942390576124;5762.4525670061275;5777.277840269966;6035.969820150959;6086.330503644595;6090.63456192621;6094.847628809315;6103.1455596216565;5543.695096769717;5678.119891416837;5742.655440673573;5755.165501002331;5760.279965004374;5166.741662916839;5177.948220517822;5189.42916279209;5192.143296356135;5196.376434827845;6274.309825919146;6284;6286.214223222098;6286.402791734778;6291.150694656254;5907.261592300876;5928.762849486145;5955.731992060281;5996.640201587918;6001.459868611846;6204.945159322836;6230.127782110599;6230.875382492415;6234.127222188807;6257.78097766576;5893.027650437802;5904.084866845646;5906.763729450774;5907;5964.343922168471;5697.373288938131;5762.164486149569;5770.13447982806;5772.04761214395;5818.44724751148;5776.104703770922;5814.651120932757;5821.039528477754;5828.067509198678;5828.446297601721;5630.971845140748;5744.281964754406;5791.565632577489;5802.187693722966;5805.622634528742;5649.237352957298;5726.055200891807;5740.598158128891;5742.253507044057;5794.768209271582;5815.709214539172;5816.534677225727;5827.650340979555;5855.121731740102;5888.3228428729535;5661.547076233809;5761.308642962871;5767.798127065533;5768.451997060272;5777.595568310178 03:30:43 INFO - PROCESS | 8424 | |1;ext.html;621.2575971713801;662.8409181796369;667.152716050616;674.140470899603;678.6538865178758;29282;29797.404051918977;29824.552631710543;36802.447963280574;37330.253394932086;38806.61193388065;39443.80278098606;39538.40692389617;39654.60345396545;39730.205395892066;8748.081451447602;8925.598348074353;8925.776855578597;8926.598303076345;8934;8251.711190108348;10277.743056423611;10537.47312634369;10538.525766340534;10544.261901666887;10430.165586753079;10523.210759193053;10541.84187237192;10547.47262636869;10555.050045495904;10244.692659220198;10334.121599664037;10340.896591034107;10342.224333174967;10343.89656103437;10298.794024119476;10381.532831022621;10385.16918646514;10390.168786497063;10453.581856725721;37553;37902;37946.24107517834;37960;38020.23959520794;2879.337752316979;3285.211549228192;3385.9492107618407;3516.6307537708426;3895.9610403896163;26305.210843674722;26577;26742;27089.1873243803;27094.458110837673;4136.544980052192;4140.565240649748;4191;4211.894702632428;4254.936175957332;220435;221125;221189;221560;279910;48003.27995080077;48215.75892120517;48339;48499.757501212975;48564;49726;55386;56232.718836405555;56589.43410565924;56983;14962.251887405586;15123.092614442949;15135.470258540898;15136.091834489966;15149.848501515064;10632.096271816827;10974.067204287565;11184.44077796107;11248.437578121226;11273.774524509628;15911.522654320388;16037.679246415006;16188.919055404647;16299.837001629832;16314.592135196715;6027.246594175728;6042;6212.254529456494;6341;6357.078223657636;979.6081567372966;994.1897353656747;1007.8588997540351;1008.3042700536606;1081.5457507846722;29052;29285.41429171447;29901.401971960873;29928.401431971237;30063.398732025238;1081.8323159910226;1090.4002798460815;1106.2366966792888;1125.5779082843933;1148.6137077847197;15133.243337833064;15177.165255911032;15265.465708700141;15403.46087886941;15571.143587102819;472719;479370;481920;482680;483798;56740.43259567351;57594.83228422477;57614.7119264401;57638;57737.13394299089;1229.5819421396768;1233.5805826019196;1287.3434548380205;1305.7257975825182;1316.4470922212693;28352;28978.420431591672;29352.412951741273;29508.852455737582;29889.402211956072;41506.37740433956;41714.58285417107;41793;41852.58147418609;41871.7906410466;290428;291590;291703;292444;293620;24601.261962141165;26723.732762672902;27037.324066898484;27403.45193096087;27457.17628471149;38701;38763.612363876004;39379.80310098431;39758.403623946244;39892.60107399005;34396.65603343934;36548.26903461969;37269.440958386185;37475.25049499049;37631.2473750518;33282.83358583192;33314.833425832716;33562.328753424306;33726.83136584301;33838.3232335347;34520.30959380849;34572.13569660779;35083;35284.82357588196;38503.229935401694;29843.552346714383;30407;31177.8441107793;31245.37509249757;31439.84280078585;25438.49123017492;25737.227883163534;25906.48187036211;25973.090941816947;25989.22032338957 03:30:43 INFO - PROCESS | 8424 | |2;jquery.html;406.50000499385743;410.0630060312187;415.97296175748573;416.6666666666668;419.72508007255243;17026.82973170268;17432.302707891686;17959.19183636736;18003.81996180038;18014.549636259082;16032.59918502038;16516;16662.83337166628;16937.153142342897;16948.152592370363;5130.486951304868;5700.743466543995;5704.34400043994;5718.914216286759;5727.914081288784;5424;5538.861528461781;5633.211350410946;5640.830775076754;5643.238162848024;5541.473560011813;5554.1946417769395;5563.415841336662;5571.916421253684;5591.916121258185;5383.515483606475;5529.834104976857;5541.722913854312;5611.551075913917;5616.438356164392;5070.2141168119;5072.34059572257;5084.923726144111;5096.719680417576;5100.311457953166;21345.932703364924;21407.57184856294;21990.120395184174;22094.668579971312;22128.88935555328;1089.8855620159848;2533.2780157655166;2579.9871000645066;2596.4421347191533;3333.2666813301034;13777.173369597756;13845.446182152702;13958.58124256274;13983.79024314636;14715.411383544646;2025.0785892418915;2073.9896300518553;2085.343116918166;2104.421284146872;2123.607132680459;77731;80794;80922.5953870227;81631;81664;10456.111230545337;10474.790504189874;10711.46442677863;10852.348859068323;10916.454177291103;14968;15038.699226015637;15066.246687665573;15084.170370629501;15096.773548396783;7781.766547003599;7838.921610783933;7915.9208407915185;7969.163237860057;7997.5601341925585;7443.441741869381;7475.36459400957;7571;7576.696932122653;7592.050993625797;6507.154069970874;6515.7393704252245;6516.543841931019;6634.469242460592;6636.900446493307;1894.6589613869635;1908.2843933524928;1935.3613307608737;1943.3392646500258;1971.3494546799523;907.2197909797569;955.3169483819103;1011.529638717985;1012.6860673191187;1027.4503140819625;18719.438416847515;18839;19064.71402928957;19123.71314430285;19196.328128515433;977.4477420257532;986.033686986757;1006.854006169116;1009.2279406254221;1019.6023550815188;9630.807383852423;10704.30422022566;10735.194860385502;10783.514741836636;10800.405977671146;488405;491748;495138;499383;499386;49508;51414.74292628588;57195;82807;86015.13984860071;1096.1942971915635;1127.3292391027326;1132.269686052508;1155.485808815086;1160.5299853559322;12188.817167742669;15729.68540629204;15826.208689565707;15877.841221587636;16333.918330408747;34704.30591388208;34754.82622586871;35510;35991.460128098624;36542;58244.708776455846;59495.40504594899;60345;60501.69749151402;60616.69691651514;8180.222878826502;8248.876266855881;8368.288695460711;8499.490030598185;8658.264047556027;11470.82793758111;13589.79615305791;13760.65598360049;13830.861691382957;14015.719685606435;12220.87779122233;12250.448729807358;12369.62891113268;12404.503819847105;12471.127021108436;7697.6151192441275;9490.430574165572;11896.405179740805;12021.398930053287;12278.77212278765;11304.717382065513;11436.771264574496;11908.404579770804;12175.269483830998;12797.232166070065;7946.8807967879375;8075.636596353061;8083.9191608083165;8162.755117346489;8217.83564328698;8312.87530687028;10942.562297508011;11414.429278536207;11464.669631638699;11576.479058442223 03:30:43 INFO - PROCESS | 8424 | |3;mootools.html;1272.1858010873036;1316.8748968847958;1341.1081630715576;1352.2359866675329;1488.858558436949;7346.70613175473;8110.067342255642;8229.917700822998;8240.752777416672;8241.052278987918;8245;8406.075331713506;8415.873761893576;8419.368547358941;8419.66321347147;2088.926887558936;2134.882581458019;2320.443093657527;2359.4927090675546;2386.53462574798;2363.2555744940373;2368.834181607288;2372.146027430124;2384;2384.0463814474174;2298.161171172518;2336.042222688698;2361.327021798788;2363.869987150706;2365.1721897335965;2041.56106437116;2198.659207822782;2251.864888106719;2255.1768604459417;2315.166540045582;2288.6567014947723;2300.0799680128084;2336.158982766203;2337.8947947342413;2342.320726989171;8152.18478152186;8223.136570660114;8225.054118776357;8230.09468958414;8241.25828675422;5085.313482679828;5218.9739051304505;5223.582113430954;5260.184671375943;5269.552088072518;3430.5540279763723;3435.707964822993;3509.94735078974;3525.6121826599056;3548.964510354889;1091.230682368936;1157.6255216045217;1168.0713832503181;1172.9003034742057;1185.2769810415639;12155.878441215564;12265.816012759726;12278.079144064232;12287.078469114853;12301.753964920741;4610.2623580227;4716.221823399169;4764.571188593043;4833.613310935117;4838.250071238964;10320.48397580118;10324.12244959172;10324.328918620266;10331.276810623183;10337.173026157889;5019.874503137451;5021.698698078127;5021.824236151717;5025.246213068069;5027.271045698353;4200.306949353322;4693.436787585443;4727.196376615983;4755.857324280277;4775.140474714515;3957.5250969883223;4070.6946978976694;4091.7749523775883;4138.730982486129;4159.230542349675;1325.9535916242885;1334.6263046346844;1349.2444231230543;1350.0617071135466;1364.6451922500023;906.1572737354323;930.9906900930904;958.4201558057414;975.2100798353215;984.7882705218412;5585.888282234332;5621.184928185472;5674.546036317085;5715.599908006483;5786.971065144731;443.17348145708667;444.75093947389564;445.7214241099313;446.9642428605704;467.68197625614226;3634.1459756957092;3681.815909204529;3707.870224542128;3734.458503516975;3763.717721170923;10242;10653.84019239712;10743.78512429747;10746.946265268623;10760.19298552596;10580.36517808934;10580.841287380696;10581.894181058246;10585.417802020962;10587.364758114538;7894.328982036591;8024.037115546055;8049.195080492021;8071.959640201879;8072.152423995513;5323.2547443358735;5412.918806217988;5471.425500322568;5544.916826247691;5583.525400341016;9414.435133891988;9738.853917191389;9753.366031207948;9763.170130538983;9770.071843174886;9560.474173920502;9631.373960692532;9813.558389872616;9820.459874706674;9840.458774767456;6653.234877989094;7309.707611695472;7427.442941779496;7601.961990190235;7774.961125194338;7963.880541791762;7965.800854978672;8018.3585313173635;8050.355971522147;8055.1542088079905;7095.609741464063;7339.376153027052;7368.926310737039;7432.219616940143;7561.508501947355;7159.713611455483;7165.390941770008;7335.596542190231;7354.521956072838;7446.925530744623;6813.523053386215;6867.690953907186;6878.828029299308;6910.585364878123;6917.861642767016;4672.696274742267;4681.321208424827;4691.061787642553;4726.976365118152;4728.787204575733;4863.8540843774745;4872.14737420957;4891.119598472309;4930.7534623267975;4962.181240095489 03:30:43 INFO - PROCESS | 8424 | |4;prototype.html;365.5430711610487;369.97965111918853;372.48968912589754;374.1898789121551;375.45558939537676;6092.573519853612;6233.345498722637;6261.279952805428;6331.841703957403;6351.174347334846;6144.477719393857;6240.500759939206;6280.057991301295;6301.212348456443;6319.589226700261;4809.326694262797;4827.58965487934;4843;4848.224284114543;4848.878778030542;4622.768861556926;4630.328602352657;4762.595179409737;4838.177509823338;4840.177169881129;4729.739864307462;4734.242521196609;4746.121967436018;4747.8338258160975;4760.285957106445;4702.636235491704;4728.787204575802;4733.928991065137;4744.620430365562;4762.428508578958;4174.248635245654;4188.748675079474;4191.224623444673;4200;4205.936910946339;6037.45662890342;6046.848828779272;6049.48579370754;6055.515558755289;6072.210612620375;5288.127458969304;5546.833594992117;5557.861053473655;5559.33288005442;5561.054620714448;6623.07276981223;6642.568233064883;6669.866602667919;6672.633005184713;6686.465082793365;4540.023894862587;4547.15877562652;4547.499775024745;4550.3402006709175;4559.77201139945;6829.590224586491;6890.517663763539;6898.758543451006;6901.378875901193;6913.1358580176975;4708.152532544106;4713.764311784397;4714.127886341038;4714.811407543729;4715.504871988461;4664.067186562701;4767.76161191939;4769.76151192439;4770.713757174581;4775.761211939389;5457.645253058538;5485.177223416519;5493.807716729895;5499.945000549943;5500.58745594082;6578.80263592093;6580.144581204413;6599.307072757388;6608.801735947833;6612.404883560503;1588.7219736546058;1645.489898131583;1671.8328167183183;1678.4964510646757;1678.6139187986832;1094.2012330998416;1112.4548971004149;1121.5345631562973;1122.2312715789546;1122.7922834275685;6350.269718982284;6371.267304259976;6374.235091789015;6376.426121648981;6378.521610879203;6778.254392016875;6790.117284752951;6791.185057793096;6807.795766127024;6812.216595091529;6394.520410969196;6415.166028416276;6454.515911306671;6456.192975878015;6467.029945508211;3658.140337020798;3683.1896982664307;3684.981575092161;3688.133288677159;3690.9077273068388;6919.238883722786;7040.507164498538;7063.04648872406;7065.187503437068;7072.045273887959;6903.240643529208;6929.272426395257;6935.7225710971;6937.68780404883;6955.304469553004;7031.753888613874;7034.788956331318;7051.788446346618;7052.2595127511895;7058.153021637437;6782.593044417351;6788.355106264897;6790.32096790317;6791.151106111736;6792.830179245559;6555.2133743949125;6697.631630260383;6767.120274364498;6793.218779840184;6823.590584564942;7096.858062838817;7106.360427561544;7165.641717914188;7173.569585824867;7187.389071928736;4728.38530990969;4764.213904705824;4765.928511072268;4767.070421267819;4768.785404656729;6593.439557637655;6688.130543029375;6887.414569761426;6899.655017249017;6901;6653.500987425866;6662.133922590032;6663.067170596023;6672.032555279555;6677;6610.867782644224;6611.834704132243;6616.4045235929;6619.867602648016;6621.404073633396;6451;6495.967520162369;6536.967315163393;6567.113439685581;6582.407583317333;6567.343265673395;6699.062131301719;6722.394984451423;6727.697253623501;6756.864862702817;6538.934610654022;6618.90071648916;6619.106420633346;6637.402633762791;6646.933530664632 03:30:43 INFO - PROCESS | 8424 | |5;yui.html;647.715005397625;661.3551787007665;673.6126727131899;676.0636518421984;683.3166833166833;14918.925405372971;15161.696766064671;15166.696666066671;15191.46829860955;15195;13661.795073073912;13967.79048314276;14046.508372206974;14075.29623518825;14082.859171408283;530.4350866327349;595.0301009354756;628.8836565235446;639.9936000640004;698.1377998172253;625.7152995387088;646.6378827856415;656.1535619051418;673.4141297071554;684.3737979748524;672.7914346552584;674.4570620650375;675.9590231044186;676.8747781660384;677.8169894128582;541.1936215039602;643.1317721076556;646.5926466326208;678.9083473731032;681.5706105153721;462.0597084932147;464.2803654335766;466.5987250964168;467.2337366718584;469.1531785127843;13246.66883327915;13344.2660653664;13354.065215434923;13362.532311369152;13406;12678.556250531186;12842.678933026657;12981.805272920914;13357.53248636293;13449.731005379936;11660.30038197711;11696.364790856438;11731.17881748278;11794.646160615195;12002.279863208236;3810.2569998850236;3899.844006239747;3918.981064923112;4006.1386801837743;4009.077912080238;55829;55911.16133258004;56393.43606563923;56670;57004.71497642485;10486.528106235237;10491;10493.527791249413;10637.255392122477;10652.573897044187;16814.747778783327;16827.074510901773;16842.663146736995;16874.15629218534;16882.91558542224;8313.251807337369;8404.07555168931;8432.789180270542;8605.870911936327;8607.655693772303;4884.072982232483;4885.2427873679635;4908.901821963541;4915.090708218991;5125.513076257749;3134.6865313468925;3186.0919637903085;3190.0429871038596;3191.728703060266;3191.792533485316;563.433749082178;593.4480932732514;605.1014243847883;610.6702380714453;625.2028663454041;619.065211530592;647.2233320015999;657.5002997721766;668.5019660353069;734.5042096584784;9527.38072025316;9724.173445257233;9768.07203315684;9791.740239844408;9846.803063938682;737.9262073792578;766.9578173200416;774.1639029847751;785.9449838511249;795.8766391209372;4472.530384309665;4519.389882365905;4522.321651752198;4624.583787459145;4645.837395691202;56983.71508142433;57759.133612995836;64599.35400645933;65157.674211629586;65679;54185.1872221917;54916;55236.17145742817;55966.72016639891;56431.71784141135;50379;50411;50803.74598126986;51078.66311600467;51330;10222.744431388977;10324.948375258376;10336.689899303034;10408.063274305348;10506.106980906708;35835.64164358323;36790.44814327841;37663;38816.22367552577;38993;45752.54247457483;47786.28320575125;47887.042259153925;48715;49508.25737614011;11999.700007499534;12182.634520964386;12290;12528.87471125277;12543.749125017632;13664.521741738992;13715.382807773474;13729.382177801823;13861.37623806911;14416.351264192926;12906.161099528501;13014.414351354022;13120.212787232796;13305.66735831612;13650.317484125953;12649.557265495663;12757.425915833624;12807.871921280668;12853;12886.033547484163;12667.556635517712;12771.169873958162;12912.612621621367;13169.53906613264;13504.662383440493;10346.844797328196;10603.46982650849;10828.296160749525;11148.721281968015;11338.943305283421;11119.888801111885;11319.434028298718;11413.372264525531;11477.081833453136;11485.540578377106 03:30:43 INFO - PROCESS | 8424 | __end_tp_report 03:30:43 INFO - PROCESS | 8424 | __start_cc_report 03:30:43 INFO - PROCESS | 8424 | _x_x_mozilla_cycle_collect,840 03:30:43 INFO - PROCESS | 8424 | __end_cc_report 03:30:43 INFO - PROCESS | 8424 | __startTimestamp1464431443608__endTimestamp 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | ------- Summary: start ------- 03:30:43 INFO - PROCESS | 8424 | Number of tests: 6 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | [#0] dojo.html Cycles:165 Average:5565.83 Median:5762.16 stddev:620.72 (10.8%) stddev-sans-first:596.78 03:30:43 INFO - PROCESS | 8424 | Values: 3306.8 3343.3 3373.2 3400.9 3413.6 5538.5 5556.3 5560.4 5569.6 5591.3 5520.1 5585.0 5587.1 5592.8 5632.8 4987.4 5025.1 5080.4 5134.8 5168.4 5036.3 5130.6 5134.4 5137.8 5140.0 5027.1 5108.3 5133.5 5141.6 5146.8 5183.8 5207.6 5229.0 5236.6 5262.3 4936.7 4993.7 5015.6 5107.0 5109.4 5471.1 5515.7 5526.1 5539.9 5544.7 5881.1 5883.3 5886.3 5894.3 5896.8 5946.1 6061.1 6097.2 6099.9 6132.5 5563.2 5614.4 5618.6 5626.4 5650.4 5891.6 6130.6 6156.3 6161.1 6175.4 5943.2 6016.1 6020.7 6030.4 6043.9 6044.5 6050.8 6051.5 6057.6 6066.5 5802.9 5933.3 6017.0 6018.1 6019.0 5992.0 5992.0 6004.7 6006.8 6025.9 4532.5 4543.8 4548.5 4550.5 4582.1 3964.3 4043.4 4073.6 4105.6 4129.4 5736.4 5751.1 5760.9 5762.5 5777.3 6036.0 6086.3 6090.6 6094.8 6103.1 5543.7 5678.1 5742.7 5755.2 5760.3 5166.7 5177.9 5189.4 5192.1 5196.4 6274.3 6284.0 6286.2 6286.4 6291.2 5907.3 5928.8 5955.7 5996.6 6001.5 6204.9 6230.1 6230.9 6234.1 6257.8 5893.0 5904.1 5906.8 5907.0 5964.3 5697.4 5762.2 5770.1 5772.0 5818.4 5776.1 5814.7 5821.0 5828.1 5828.4 5631.0 5744.3 5791.6 5802.2 5805.6 5649.2 5726.1 5740.6 5742.3 5794.8 5815.7 5816.5 5827.7 5855.1 5888.3 5661.5 5761.3 5767.8 5768.5 5777.6 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | [#1] ext.html Cycles:180 Average:48803.97 Median:29995.90 stddev:93165.25 (310.6%) stddev-sans-first:93356.37 03:30:43 INFO - PROCESS | 8424 | Values: 621.3 662.8 667.2 674.1 678.7 29282.0 29797.4 29824.6 36802.4 37330.3 38806.6 39443.8 39538.4 39654.6 39730.2 8748.1 8925.6 8925.8 8926.6 8934.0 8251.7 10277.7 10537.5 10538.5 10544.3 10430.2 10523.2 10541.8 10547.5 10555.1 10244.7 10334.1 10340.9 10342.2 10343.9 10298.8 10381.5 10385.2 10390.2 10453.6 37553.0 37902.0 37946.2 37960.0 38020.2 2879.3 3285.2 3385.9 3516.6 3896.0 26305.2 26577.0 26742.0 27089.2 27094.5 4136.5 4140.6 4191.0 4211.9 4254.9 220435.0 221125.0 221189.0 221560.0 279910.0 48003.3 48215.8 48339.0 48499.8 48564.0 49726.0 55386.0 56232.7 56589.4 56983.0 14962.3 15123.1 15135.5 15136.1 15149.8 10632.1 10974.1 11184.4 11248.4 11273.8 15911.5 16037.7 16188.9 16299.8 16314.6 6027.2 6042.0 6212.3 6341.0 6357.1 979.6 994.2 1007.9 1008.3 1081.5 29052.0 29285.4 29901.4 29928.4 30063.4 1081.8 1090.4 1106.2 1125.6 1148.6 15133.2 15177.2 15265.5 15403.5 15571.1 472719.0 479370.0 481920.0 482680.0 483798.0 56740.4 57594.8 57614.7 57638.0 57737.1 1229.6 1233.6 1287.3 1305.7 1316.4 28352.0 28978.4 29352.4 29508.9 29889.4 41506.4 41714.6 41793.0 41852.6 41871.8 290428.0 291590.0 291703.0 292444.0 293620.0 24601.3 26723.7 27037.3 27403.5 27457.2 38701.0 38763.6 39379.8 39758.4 39892.6 34396.7 36548.3 37269.4 37475.3 37631.2 33282.8 33314.8 33562.3 33726.8 33838.3 34520.3 34572.1 35083.0 35284.8 38503.2 29843.6 30407.0 31177.8 31245.4 31439.8 25438.5 25737.2 25906.5 25973.1 25989.2 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | [#2] jquery.html Cycles:180 Average:28097.84 Median:2964.85 stddev:81153.35 (2737.2%) stddev-sans-first:81354.37 03:30:43 INFO - PROCESS | 8424 | Values: 406.5 410.1 416.0 416.7 419.7 17026.8 17432.3 17959.2 18003.8 18014.5 16032.6 16516.0 16662.8 16937.2 16948.2 5130.5 5700.7 5704.3 5718.9 5727.9 5424.0 5538.9 5633.2 5640.8 5643.2 5541.5 5554.2 5563.4 5571.9 5591.9 5383.5 5529.8 5541.7 5611.6 5616.4 5070.2 5072.3 5084.9 5096.7 5100.3 21345.9 21407.6 21990.1 22094.7 22128.9 1089.9 2533.3 2580.0 2596.4 3333.3 13777.2 13845.4 13958.6 13983.8 14715.4 2025.1 2074.0 2085.3 2104.4 2123.6 77731.0 80794.0 80922.6 81631.0 81664.0 10456.1 10474.8 10711.5 10852.3 10916.5 14968.0 15038.7 15066.2 15084.2 15096.8 7781.8 7838.9 7915.9 7969.2 7997.6 7443.4 7475.4 7571.0 7576.7 7592.1 6507.2 6515.7 6516.5 6634.5 6636.9 1894.7 1908.3 1935.4 1943.3 1971.3 907.2 955.3 1011.5 1012.7 1027.5 18719.4 18839.0 19064.7 19123.7 19196.3 977.4 986.0 1006.9 1009.2 1019.6 9630.8 10704.3 10735.2 10783.5 10800.4 488405.0 491748.0 495138.0 499383.0 499386.0 49508.0 51414.7 57195.0 82807.0 86015.1 1096.2 1127.3 1132.3 1155.5 1160.5 12188.8 15729.7 15826.2 15877.8 16333.9 34704.3 34754.8 35510.0 35991.5 36542.0 58244.7 59495.4 60345.0 60501.7 60616.7 8180.2 8248.9 8368.3 8499.5 8658.3 11470.8 13589.8 13760.7 13830.9 14015.7 12220.9 12250.4 12369.6 12404.5 12471.1 7697.6 9490.4 11896.4 12021.4 12278.8 11304.7 11436.8 11908.4 12175.3 12797.2 7946.9 8075.6 8083.9 8162.8 8217.8 8312.9 10942.6 11414.4 11464.7 11576.5 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | [#3] mootools.html Cycles:180 Average:5588.18 Median:4760.21 stddev:3198.13 (67.2%) stddev-sans-first:3190.65 03:30:43 INFO - PROCESS | 8424 | Values: 1272.2 1316.9 1341.1 1352.2 1488.9 7346.7 8110.1 8229.9 8240.8 8241.1 8245.0 8406.1 8415.9 8419.4 8419.7 2088.9 2134.9 2320.4 2359.5 2386.5 2363.3 2368.8 2372.1 2384.0 2384.0 2298.2 2336.0 2361.3 2363.9 2365.2 2041.6 2198.7 2251.9 2255.2 2315.2 2288.7 2300.1 2336.2 2337.9 2342.3 8152.2 8223.1 8225.1 8230.1 8241.3 5085.3 5219.0 5223.6 5260.2 5269.6 3430.6 3435.7 3509.9 3525.6 3549.0 1091.2 1157.6 1168.1 1172.9 1185.3 12155.9 12265.8 12278.1 12287.1 12301.8 4610.3 4716.2 4764.6 4833.6 4838.3 10320.5 10324.1 10324.3 10331.3 10337.2 5019.9 5021.7 5021.8 5025.2 5027.3 4200.3 4693.4 4727.2 4755.9 4775.1 3957.5 4070.7 4091.8 4138.7 4159.2 1326.0 1334.6 1349.2 1350.1 1364.6 906.2 931.0 958.4 975.2 984.8 5585.9 5621.2 5674.5 5715.6 5787.0 443.2 444.8 445.7 447.0 467.7 3634.1 3681.8 3707.9 3734.5 3763.7 10242.0 10653.8 10743.8 10746.9 10760.2 10580.4 10580.8 10581.9 10585.4 10587.4 7894.3 8024.0 8049.2 8072.0 8072.2 5323.3 5412.9 5471.4 5544.9 5583.5 9414.4 9738.9 9753.4 9763.2 9770.1 9560.5 9631.4 9813.6 9820.5 9840.5 6653.2 7309.7 7427.4 7602.0 7775.0 7963.9 7965.8 8018.4 8050.4 8055.2 7095.6 7339.4 7368.9 7432.2 7561.5 7159.7 7165.4 7335.6 7354.5 7446.9 6813.5 6867.7 6878.8 6910.6 6917.9 4672.7 4681.3 4691.1 4727.0 4728.8 4863.9 4872.1 4891.1 4930.8 4962.2 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | [#4] prototype.html Cycles:180 Average:5547.64 Median:6361.22 stddev:1671.80 (26.3%) stddev-sans-first:1630.62 03:30:43 INFO - PROCESS | 8424 | Values: 365.5 370.0 372.5 374.2 375.5 6092.6 6233.3 6261.3 6331.8 6351.2 6144.5 6240.5 6280.1 6301.2 6319.6 4809.3 4827.6 4843.0 4848.2 4848.9 4622.8 4630.3 4762.6 4838.2 4840.2 4729.7 4734.2 4746.1 4747.8 4760.3 4702.6 4728.8 4733.9 4744.6 4762.4 4174.2 4188.7 4191.2 4200.0 4205.9 6037.5 6046.8 6049.5 6055.5 6072.2 5288.1 5546.8 5557.9 5559.3 5561.1 6623.1 6642.6 6669.9 6672.6 6686.5 4540.0 4547.2 4547.5 4550.3 4559.8 6829.6 6890.5 6898.8 6901.4 6913.1 4708.2 4713.8 4714.1 4714.8 4715.5 4664.1 4767.8 4769.8 4770.7 4775.8 5457.6 5485.2 5493.8 5499.9 5500.6 6578.8 6580.1 6599.3 6608.8 6612.4 1588.7 1645.5 1671.8 1678.5 1678.6 1094.2 1112.5 1121.5 1122.2 1122.8 6350.3 6371.3 6374.2 6376.4 6378.5 6778.3 6790.1 6791.2 6807.8 6812.2 6394.5 6415.2 6454.5 6456.2 6467.0 3658.1 3683.2 3685.0 3688.1 3690.9 6919.2 7040.5 7063.0 7065.2 7072.0 6903.2 6929.3 6935.7 6937.7 6955.3 7031.8 7034.8 7051.8 7052.3 7058.2 6782.6 6788.4 6790.3 6791.2 6792.8 6555.2 6697.6 6767.1 6793.2 6823.6 7096.9 7106.4 7165.6 7173.6 7187.4 4728.4 4764.2 4765.9 4767.1 4768.8 6593.4 6688.1 6887.4 6899.7 6901.0 6653.5 6662.1 6663.1 6672.0 6677.0 6610.9 6611.8 6616.4 6619.9 6621.4 6451.0 6496.0 6537.0 6567.1 6582.4 6567.3 6699.1 6722.4 6727.7 6756.9 6538.9 6618.9 6619.1 6637.4 6646.9 03:30:43 INFO - PROCESS | 8424 | 03:30:43 INFO - PROCESS | 8424 | [#5] yui.html Cycles:180 Average:15086.16 Median:4495.96 stddev:17497.22 (389.2%) stddev-sans-first:17512.71 03:30:43 INFO - PROCESS | 8424 | Values: 647.7 661.4 673.6 676.1 683.3 14918.9 15161.7 15166.7 15191.5 15195.0 13661.8 13967.8 14046.5 14075.3 14082.9 530.4 595.0 628.9 640.0 698.1 625.7 646.6 656.2 673.4 684.4 672.8 674.5 676.0 676.9 677.8 541.2 643.1 646.6 678.9 681.6 462.1 464.3 466.6 467.2 469.2 13246.7 13344.3 13354.1 13362.5 13406.0 12678.6 12842.7 12981.8 13357.5 13449.7 11660.3 11696.4 11731.2 11794.6 12002.3 3810.3 3899.8 3919.0 4006.1 4009.1 55829.0 55911.2 56393.4 56670.0 57004.7 10486.5 10491.0 10493.5 10637.3 10652.6 16814.7 16827.1 16842.7 16874.2 16882.9 8313.3 8404.1 8432.8 8605.9 8607.7 4884.1 4885.2 4908.9 4915.1 5125.5 3134.7 3186.1 3190.0 3191.7 3191.8 563.4 593.4 605.1 610.7 625.2 619.1 647.2 657.5 668.5 734.5 9527.4 9724.2 9768.1 9791.7 9846.8 737.9 767.0 774.2 785.9 795.9 4472.5 4519.4 4522.3 4624.6 4645.8 56983.7 57759.1 64599.4 65157.7 65679.0 54185.2 54916.0 55236.2 55966.7 56431.7 50379.0 50411.0 50803.7 51078.7 51330.0 10222.7 10324.9 10336.7 10408.1 10506.1 35835.6 36790.4 37663.0 38816.2 38993.0 45752.5 47786.3 47887.0 48715.0 49508.3 11999.7 12182.6 12290.0 12528.9 12543.7 13664.5 13715.4 13729.4 13861.4 14416.4 12906.2 13014.4 13120.2 13305.7 13650.3 12649.6 12757.4 12807.9 12853.0 12886.0 12667.6 12771.2 12912.6 13169.5 13504.7 10346.8 10603.5 10828.3 11148.7 11338.9 11119.9 11319.4 11413.4 11477.1 11485.5 03:30:43 INFO - PROCESS | 8424 | -------- Summary: end -------- 03:30:43 INFO - PROCESS | 8424 | 03:30:44 INFO - TEST-INFO | 8424: exit 0 03:30:44 INFO - TEST-OK | dromaeo_css | took 1111900ms 03:30:44 INFO - TEST-START | kraken 03:30:44 INFO - operating with platform_type : linux_ 03:30:44 INFO - Initialising browser for kraken test... 03:30:44 INFO - TEST-INFO | started process 8619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplquLxb/profile http://localhost:41452/getInfo.html) 03:30:48 INFO - PROCESS | 8619 | __metrics Screen width/height:1600/1200 03:30:48 INFO - PROCESS | 8619 | colorDepth:24 03:30:48 INFO - PROCESS | 8619 | Browser inner width/height: 1024/697 03:30:48 INFO - PROCESS | 8619 | __metrics 03:30:49 ERROR - PROCESS | 8619 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:30:50 INFO - TEST-INFO | 8619: exit 0 03:30:50 INFO - Browser initialized. 03:30:50 INFO - Running cycle 1/1 for kraken test... 03:30:50 INFO - TEST-INFO | started process 8710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplquLxb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:02 INFO - PROCESS | 8710 | RSS: Main: 141688832 03:31:02 INFO - PROCESS | 8710 | 03:31:04 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41452/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:05 INFO - PROCESS | 8710 | RSS: Main: 197332992 03:31:05 INFO - PROCESS | 8710 | 03:31:08 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41452/tests/kraken/driver.html?testName=audio-dft) 03:31:08 INFO - PROCESS | 8710 | RSS: Main: 181919744 03:31:08 INFO - PROCESS | 8710 | 03:31:11 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41452/tests/kraken/driver.html?testName=audio-fft) 03:31:12 INFO - PROCESS | 8710 | RSS: Main: 271831040 03:31:12 INFO - PROCESS | 8710 | 03:31:14 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41452/tests/kraken/driver.html?testName=audio-oscillator) 03:31:14 INFO - PROCESS | 8710 | RSS: Main: 177950720 03:31:14 INFO - PROCESS | 8710 | 03:31:17 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:17 INFO - PROCESS | 8710 | RSS: Main: 176173056 03:31:17 INFO - PROCESS | 8710 | 03:31:20 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41452/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:21 INFO - PROCESS | 8710 | RSS: Main: 211218432 03:31:21 INFO - PROCESS | 8710 | 03:31:24 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41452/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:25 INFO - PROCESS | 8710 | RSS: Main: 211427328 03:31:25 INFO - PROCESS | 8710 | 03:31:27 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41452/tests/kraken/driver.html?testName=json-parse-financial) 03:31:28 INFO - PROCESS | 8710 | RSS: Main: 210993152 03:31:28 INFO - PROCESS | 8710 | 03:31:30 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:30 INFO - PROCESS | 8710 | RSS: Main: 189734912 03:31:30 INFO - PROCESS | 8710 | 03:31:32 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:32 INFO - PROCESS | 8710 | RSS: Main: 192331776 03:31:32 INFO - PROCESS | 8710 | 03:31:34 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:35 INFO - PROCESS | 8710 | RSS: Main: 206397440 03:31:35 INFO - PROCESS | 8710 | 03:31:37 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:38 INFO - PROCESS | 8710 | RSS: Main: 212504576 03:31:38 INFO - PROCESS | 8710 | 03:31:41 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:41 INFO - PROCESS | 8710 | RSS: Main: 207605760 03:31:41 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | Cycle 1(1): loaded http://localhost:41452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41452/tests/kraken/driver.html?testName=ai-astar) 03:31:43 INFO - PROCESS | 8710 | RSS: Main: 271749120 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | __start_tp_report 03:31:43 INFO - PROCESS | 8710 | _x_x_mozilla_page_load 03:31:43 INFO - PROCESS | 8710 | _x_x_mozilla_page_load_details 03:31:43 INFO - PROCESS | 8710 | |i|pagename|runs| 03:31:43 INFO - PROCESS | 8710 | |0;ai-astar;110;110;110;109;111;110;104;111;110;109 03:31:43 INFO - PROCESS | 8710 | |1;audio-beat-detection;150;125;153;184;133;156;173;134;189;127 03:31:43 INFO - PROCESS | 8710 | |2;audio-dft;161;162;163;160;161;160;159;160;159;162 03:31:43 INFO - PROCESS | 8710 | |3;audio-fft;75;75;76;181;77;75;75;76;157;76 03:31:43 INFO - PROCESS | 8710 | |4;audio-oscillator;92;92;157;92;93;93;157;92;93;152 03:31:43 INFO - PROCESS | 8710 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 03:31:43 INFO - PROCESS | 8710 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;145;145 03:31:43 INFO - PROCESS | 8710 | |7;imaging-desaturate;94;95;95;94;94;95;95;95;95;95 03:31:43 INFO - PROCESS | 8710 | |8;json-parse-financial;52;53;53;54;55;53;54;74;52;52 03:31:43 INFO - PROCESS | 8710 | |9;json-stringify-tinderbox;58;58;57;58;58;58;57;58;58;58 03:31:43 INFO - PROCESS | 8710 | |10;stanford-crypto-aes;72;72;72;81;73;74;73;74;80;74 03:31:43 INFO - PROCESS | 8710 | |11;stanford-crypto-ccm;123;119;110;111;107;110;108;108;128;109 03:31:43 INFO - PROCESS | 8710 | |12;stanford-crypto-pbkdf2;159;157;157;154;159;156;155;156;157;157 03:31:43 INFO - PROCESS | 8710 | |13;stanford-crypto-sha256-iterative;64;64;65;71;65;65;64;65;66;64 03:31:43 INFO - PROCESS | 8710 | __end_tp_report 03:31:43 INFO - PROCESS | 8710 | __start_cc_report 03:31:43 INFO - PROCESS | 8710 | _x_x_mozilla_cycle_collect,1580 03:31:43 INFO - PROCESS | 8710 | __end_cc_report 03:31:43 INFO - PROCESS | 8710 | __startTimestamp1464431503779__endTimestamp 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | ------- Summary: start ------- 03:31:43 INFO - PROCESS | 8710 | Number of tests: 14 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.01 (1.8%) stddev-sans-first:2.12 03:31:43 INFO - PROCESS | 8710 | Values: 110.0 110.0 110.0 109.0 111.0 110.0 104.0 111.0 110.0 109.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:154.50 stddev:23.32 (15.1%) stddev-sans-first:24.71 03:31:43 INFO - PROCESS | 8710 | Values: 150.0 125.0 153.0 184.0 133.0 156.0 173.0 134.0 189.0 127.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 03:31:43 INFO - PROCESS | 8710 | Values: 161.0 162.0 163.0 160.0 161.0 160.0 159.0 160.0 159.0 162.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.78 (52.7%) stddev-sans-first:41.58 03:31:43 INFO - PROCESS | 8710 | Values: 75.0 75.0 76.0 181.0 77.0 75.0 75.0 76.0 157.0 76.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:92.00 stddev:30.42 (33.1%) stddev-sans-first:31.45 03:31:43 INFO - PROCESS | 8710 | Values: 92.0 92.0 157.0 92.0 93.0 93.0 157.0 92.0 93.0 152.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:31:43 INFO - PROCESS | 8710 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 03:31:43 INFO - PROCESS | 8710 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:31:43 INFO - PROCESS | 8710 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:53.50 stddev:6.68 (12.5%) stddev-sans-first:6.98 03:31:43 INFO - PROCESS | 8710 | Values: 52.0 53.0 53.0 54.0 55.0 53.0 54.0 74.0 52.0 52.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:31:43 INFO - PROCESS | 8710 | Values: 58.0 58.0 57.0 58.0 58.0 58.0 57.0 58.0 58.0 58.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:3.27 (4.4%) stddev-sans-first:3.35 03:31:43 INFO - PROCESS | 8710 | Values: 72.0 72.0 72.0 81.0 73.0 74.0 73.0 74.0 80.0 74.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:110.50 stddev:7.33 (6.6%) stddev-sans-first:6.89 03:31:43 INFO - PROCESS | 8710 | Values: 123.0 119.0 110.0 111.0 107.0 110.0 108.0 108.0 128.0 109.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:157.00 stddev:1.57 (1.0%) stddev-sans-first:1.42 03:31:43 INFO - PROCESS | 8710 | Values: 159.0 157.0 157.0 154.0 159.0 156.0 155.0 156.0 157.0 157.0 03:31:43 INFO - PROCESS | 8710 | 03:31:43 INFO - PROCESS | 8710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:2.19 03:31:43 INFO - PROCESS | 8710 | Values: 64.0 64.0 65.0 71.0 65.0 65.0 64.0 65.0 66.0 64.0 03:31:43 INFO - PROCESS | 8710 | -------- Summary: end -------- 03:31:43 INFO - PROCESS | 8710 | 03:31:44 INFO - TEST-INFO | 8710: exit 0 03:31:44 INFO - TEST-OK | kraken | took 60442ms 03:31:44 INFO - SUITE-END | took 1172s 03:31:44 INFO - Completed test suite (00:19:32) 03:31:44 INFO - javascript benchmark 03:31:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.768526203165, 3343.3313337332524, 3373.1567108222944, 3400.9489857652125, 3413.5562376891003, 5538.501534861862, 5556.277683901092, 5560.388357280701, 5569.582281328896, 5591.2731344925205, 5520.06158952978, 5584.972075139619, 5587.1339942308905, 5592.832215033545, 5632.831015069544, 4987.426445958725, 5025.070361983036, 5080.364954380702, 5134.768935397898, 5168.379794424655, 5036.320096786942, 5130.6152038597065, 5134.358205224347, 5137.768800403972, 5139.974300128494, 5027.09512287788, 5108.310378098965, 5133.537981581657, 5141.640085194038, 5146.819861304855, 5183.792648294083, 5207.583393328562, 5228.973855130738, 5236.554892834114, 5262.3422072241165, 4936.679115857458, 4993.650444468889, 5015.598752099823, 5107.0, 5109.386873575195, 5471.124620060811, 5515.7242137893345, 5526.06056970316, 5539.944600553983, 5544.667319960815, 5881.117832325142, 5883.294004719461, 5886.323072846634, 5894.2926848778425, 5896.823095307148, 5946.07835785454, 6061.060535616986, 6097.20736304282, 6099.878002439971, 6132.509399248094, 5563.193336966117, 5614.3543492498475, 5618.57860660448, 5626.381098079208, 5650.4349565043985, 5891.587588868738, 6130.569288464064, 6156.29202641702, 6161.106639537332, 6175.382461753788, 5943.197668314809, 6016.067509536029, 6020.668863212565, 6030.427109424685, 6043.939560604425, 6044.546659000593, 6050.818475445743, 6051.515878729691, 6057.606255593372, 6066.545009124334, 5802.854928626818, 5933.2880054393745, 6016.969915150396, 6018.067199583984, 6018.969905150446, 5991.970040149771, 5992.0, 6004.729787159588, 6006.789762358384, 6025.9096113558335, 4532.456105267323, 4543.750093744876, 4548.476925153584, 4550.453945526558, 4582.060677561092, 3964.345882929342, 4043.3732771420478, 4073.6130067643526, 4105.58944105587, 4129.380592911028, 5736.426357364314, 5751.1085781703905, 5760.942390576124, 5762.4525670061275, 5777.277840269966, 6035.969820150959, 6086.330503644595, 6090.63456192621, 6094.847628809315, 6103.1455596216565, 5543.695096769717, 5678.119891416837, 5742.655440673573, 5755.165501002331, 5760.279965004374, 5166.741662916839, 5177.948220517822, 5189.42916279209, 5192.143296356135, 5196.376434827845, 6274.309825919146, 6284.0, 6286.214223222098, 6286.402791734778, 6291.150694656254, 5907.261592300876, 5928.762849486145, 5955.731992060281, 5996.640201587918, 6001.459868611846, 6204.945159322836, 6230.127782110599, 6230.875382492415, 6234.127222188807, 6257.78097766576, 5893.027650437802, 5904.084866845646, 5906.763729450774, 5907.0, 5964.343922168471, 5697.373288938131, 5762.164486149569, 5770.13447982806, 5772.04761214395, 5818.44724751148, 5776.104703770922, 5814.651120932757, 5821.039528477754, 5828.067509198678, 5828.446297601721, 5630.971845140748, 5744.281964754406, 5791.565632577489, 5802.187693722966, 5805.622634528742, 5649.237352957298, 5726.055200891807, 5740.598158128891, 5742.253507044057, 5794.768209271582, 5815.709214539172, 5816.534677225727, 5827.650340979555, 5855.121731740102, 5888.3228428729535, 5661.547076233809, 5761.308642962871, 5767.798127065533, 5768.451997060272, 5777.595568310178], "value": 5525.314930041127, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2575971713801, 662.8409181796369, 667.152716050616, 674.140470899603, 678.6538865178758, 29282.0, 29797.404051918977, 29824.552631710543, 36802.447963280574, 37330.253394932086, 38806.61193388065, 39443.80278098606, 39538.40692389617, 39654.60345396545, 39730.205395892066, 8748.081451447602, 8925.598348074353, 8925.776855578597, 8926.598303076345, 8934.0, 8251.711190108348, 10277.743056423611, 10537.47312634369, 10538.525766340534, 10544.261901666887, 10430.165586753079, 10523.210759193053, 10541.84187237192, 10547.47262636869, 10555.050045495904, 10244.692659220198, 10334.121599664037, 10340.896591034107, 10342.224333174967, 10343.89656103437, 10298.794024119476, 10381.532831022621, 10385.16918646514, 10390.168786497063, 10453.581856725721, 37553.0, 37902.0, 37946.24107517834, 37960.0, 38020.23959520794, 2879.337752316979, 3285.211549228192, 3385.9492107618407, 3516.6307537708426, 3895.9610403896163, 26305.210843674722, 26577.0, 26742.0, 27089.1873243803, 27094.458110837673, 4136.544980052192, 4140.565240649748, 4191.0, 4211.894702632428, 4254.936175957332, 220435.0, 221125.0, 221189.0, 221560.0, 279910.0, 48003.27995080077, 48215.75892120517, 48339.0, 48499.757501212975, 48564.0, 49726.0, 55386.0, 56232.718836405555, 56589.43410565924, 56983.0, 14962.251887405586, 15123.092614442949, 15135.470258540898, 15136.091834489966, 15149.848501515064, 10632.096271816827, 10974.067204287565, 11184.44077796107, 11248.437578121226, 11273.774524509628, 15911.522654320388, 16037.679246415006, 16188.919055404647, 16299.837001629832, 16314.592135196715, 6027.246594175728, 6042.0, 6212.254529456494, 6341.0, 6357.078223657636, 979.6081567372966, 994.1897353656747, 1007.8588997540351, 1008.3042700536606, 1081.5457507846722, 29052.0, 29285.41429171447, 29901.401971960873, 29928.401431971237, 30063.398732025238, 1081.8323159910226, 1090.4002798460815, 1106.2366966792888, 1125.5779082843933, 1148.6137077847197, 15133.243337833064, 15177.165255911032, 15265.465708700141, 15403.46087886941, 15571.143587102819, 472719.0, 479370.0, 481920.0, 482680.0, 483798.0, 56740.43259567351, 57594.83228422477, 57614.7119264401, 57638.0, 57737.13394299089, 1229.5819421396768, 1233.5805826019196, 1287.3434548380205, 1305.7257975825182, 1316.4470922212693, 28352.0, 28978.420431591672, 29352.412951741273, 29508.852455737582, 29889.402211956072, 41506.37740433956, 41714.58285417107, 41793.0, 41852.58147418609, 41871.7906410466, 290428.0, 291590.0, 291703.0, 292444.0, 293620.0, 24601.261962141165, 26723.732762672902, 27037.324066898484, 27403.45193096087, 27457.17628471149, 38701.0, 38763.612363876004, 39379.80310098431, 39758.403623946244, 39892.60107399005, 34396.65603343934, 36548.26903461969, 37269.440958386185, 37475.25049499049, 37631.2473750518, 33282.83358583192, 33314.833425832716, 33562.328753424306, 33726.83136584301, 33838.3232335347, 34520.30959380849, 34572.13569660779, 35083.0, 35284.82357588196, 38503.229935401694, 29843.552346714383, 30407.0, 31177.8441107793, 31245.37509249757, 31439.84280078585, 25438.49123017492, 25737.227883163534, 25906.48187036211, 25973.090941816947, 25989.22032338957], "value": 18330.763005608766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.50000499385743, 410.0630060312187, 415.97296175748573, 416.6666666666668, 419.72508007255243, 17026.82973170268, 17432.302707891686, 17959.19183636736, 18003.81996180038, 18014.549636259082, 16032.59918502038, 16516.0, 16662.83337166628, 16937.153142342897, 16948.152592370363, 5130.486951304868, 5700.743466543995, 5704.34400043994, 5718.914216286759, 5727.914081288784, 5424.0, 5538.861528461781, 5633.211350410946, 5640.830775076754, 5643.238162848024, 5541.473560011813, 5554.1946417769395, 5563.415841336662, 5571.916421253684, 5591.916121258185, 5383.515483606475, 5529.834104976857, 5541.722913854312, 5611.551075913917, 5616.438356164392, 5070.2141168119, 5072.34059572257, 5084.923726144111, 5096.719680417576, 5100.311457953166, 21345.932703364924, 21407.57184856294, 21990.120395184174, 22094.668579971312, 22128.88935555328, 1089.8855620159848, 2533.2780157655166, 2579.9871000645066, 2596.4421347191533, 3333.2666813301034, 13777.173369597756, 13845.446182152702, 13958.58124256274, 13983.79024314636, 14715.411383544646, 2025.0785892418915, 2073.9896300518553, 2085.343116918166, 2104.421284146872, 2123.607132680459, 77731.0, 80794.0, 80922.5953870227, 81631.0, 81664.0, 10456.111230545337, 10474.790504189874, 10711.46442677863, 10852.348859068323, 10916.454177291103, 14968.0, 15038.699226015637, 15066.246687665573, 15084.170370629501, 15096.773548396783, 7781.766547003599, 7838.921610783933, 7915.9208407915185, 7969.163237860057, 7997.5601341925585, 7443.441741869381, 7475.36459400957, 7571.0, 7576.696932122653, 7592.050993625797, 6507.154069970874, 6515.7393704252245, 6516.543841931019, 6634.469242460592, 6636.900446493307, 1894.6589613869635, 1908.2843933524928, 1935.3613307608737, 1943.3392646500258, 1971.3494546799523, 907.2197909797569, 955.3169483819103, 1011.529638717985, 1012.6860673191187, 1027.4503140819625, 18719.438416847515, 18839.0, 19064.71402928957, 19123.71314430285, 19196.328128515433, 977.4477420257532, 986.033686986757, 1006.854006169116, 1009.2279406254221, 1019.6023550815188, 9630.807383852423, 10704.30422022566, 10735.194860385502, 10783.514741836636, 10800.405977671146, 488405.0, 491748.0, 495138.0, 499383.0, 499386.0, 49508.0, 51414.74292628588, 57195.0, 82807.0, 86015.13984860071, 1096.1942971915635, 1127.3292391027326, 1132.269686052508, 1155.485808815086, 1160.5299853559322, 12188.817167742669, 15729.68540629204, 15826.208689565707, 15877.841221587636, 16333.918330408747, 34704.30591388208, 34754.82622586871, 35510.0, 35991.460128098624, 36542.0, 58244.708776455846, 59495.40504594899, 60345.0, 60501.69749151402, 60616.69691651514, 8180.222878826502, 8248.876266855881, 8368.288695460711, 8499.490030598185, 8658.264047556027, 11470.82793758111, 13589.79615305791, 13760.65598360049, 13830.861691382957, 14015.719685606435, 12220.87779122233, 12250.448729807358, 12369.62891113268, 12404.503819847105, 12471.127021108436, 7697.6151192441275, 9490.430574165572, 11896.405179740805, 12021.398930053287, 12278.77212278765, 11304.717382065513, 11436.771264574496, 11908.404579770804, 12175.269483830998, 12797.232166070065, 7946.8807967879375, 8075.636596353061, 8083.9191608083165, 8162.755117346489, 8217.83564328698, 8312.87530687028, 10942.562297508011, 11414.429278536207, 11464.669631638699, 11576.479058442223], "value": 9089.451052820388, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.1858010873036, 1316.8748968847958, 1341.1081630715576, 1352.2359866675329, 1488.858558436949, 7346.70613175473, 8110.067342255642, 8229.917700822998, 8240.752777416672, 8241.052278987918, 8245.0, 8406.075331713506, 8415.873761893576, 8419.368547358941, 8419.66321347147, 2088.926887558936, 2134.882581458019, 2320.443093657527, 2359.4927090675546, 2386.53462574798, 2363.2555744940373, 2368.834181607288, 2372.146027430124, 2384.0, 2384.0463814474174, 2298.161171172518, 2336.042222688698, 2361.327021798788, 2363.869987150706, 2365.1721897335965, 2041.56106437116, 2198.659207822782, 2251.864888106719, 2255.1768604459417, 2315.166540045582, 2288.6567014947723, 2300.0799680128084, 2336.158982766203, 2337.8947947342413, 2342.320726989171, 8152.18478152186, 8223.136570660114, 8225.054118776357, 8230.09468958414, 8241.25828675422, 5085.313482679828, 5218.9739051304505, 5223.582113430954, 5260.184671375943, 5269.552088072518, 3430.5540279763723, 3435.707964822993, 3509.94735078974, 3525.6121826599056, 3548.964510354889, 1091.230682368936, 1157.6255216045217, 1168.0713832503181, 1172.9003034742057, 1185.2769810415639, 12155.878441215564, 12265.816012759726, 12278.079144064232, 12287.078469114853, 12301.753964920741, 4610.2623580227, 4716.221823399169, 4764.571188593043, 4833.613310935117, 4838.250071238964, 10320.48397580118, 10324.12244959172, 10324.328918620266, 10331.276810623183, 10337.173026157889, 5019.874503137451, 5021.698698078127, 5021.824236151717, 5025.246213068069, 5027.271045698353, 4200.306949353322, 4693.436787585443, 4727.196376615983, 4755.857324280277, 4775.140474714515, 3957.5250969883223, 4070.6946978976694, 4091.7749523775883, 4138.730982486129, 4159.230542349675, 1325.9535916242885, 1334.6263046346844, 1349.2444231230543, 1350.0617071135466, 1364.6451922500023, 906.1572737354323, 930.9906900930904, 958.4201558057414, 975.2100798353215, 984.7882705218412, 5585.888282234332, 5621.184928185472, 5674.546036317085, 5715.599908006483, 5786.971065144731, 443.17348145708667, 444.75093947389564, 445.7214241099313, 446.9642428605704, 467.68197625614226, 3634.1459756957092, 3681.815909204529, 3707.870224542128, 3734.458503516975, 3763.717721170923, 10242.0, 10653.84019239712, 10743.78512429747, 10746.946265268623, 10760.19298552596, 10580.36517808934, 10580.841287380696, 10581.894181058246, 10585.417802020962, 10587.364758114538, 7894.328982036591, 8024.037115546055, 8049.195080492021, 8071.959640201879, 8072.152423995513, 5323.2547443358735, 5412.918806217988, 5471.425500322568, 5544.916826247691, 5583.525400341016, 9414.435133891988, 9738.853917191389, 9753.366031207948, 9763.170130538983, 9770.071843174886, 9560.474173920502, 9631.373960692532, 9813.558389872616, 9820.459874706674, 9840.458774767456, 6653.234877989094, 7309.707611695472, 7427.442941779496, 7601.961990190235, 7774.961125194338, 7963.880541791762, 7965.800854978672, 8018.3585313173635, 8050.355971522147, 8055.1542088079905, 7095.609741464063, 7339.376153027052, 7368.926310737039, 7432.219616940143, 7561.508501947355, 7159.713611455483, 7165.390941770008, 7335.596542190231, 7354.521956072838, 7446.925530744623, 6813.523053386215, 6867.690953907186, 6878.828029299308, 6910.585364878123, 6917.861642767016, 4672.696274742267, 4681.321208424827, 4691.061787642553, 4726.976365118152, 4728.787204575733, 4863.8540843774745, 4872.14737420957, 4891.119598472309, 4930.7534623267975, 4962.181240095489], "value": 4414.517427062901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5430711610487, 369.97965111918853, 372.48968912589754, 374.1898789121551, 375.45558939537676, 6092.573519853612, 6233.345498722637, 6261.279952805428, 6331.841703957403, 6351.174347334846, 6144.477719393857, 6240.500759939206, 6280.057991301295, 6301.212348456443, 6319.589226700261, 4809.326694262797, 4827.58965487934, 4843.0, 4848.224284114543, 4848.878778030542, 4622.768861556926, 4630.328602352657, 4762.595179409737, 4838.177509823338, 4840.177169881129, 4729.739864307462, 4734.242521196609, 4746.121967436018, 4747.8338258160975, 4760.285957106445, 4702.636235491704, 4728.787204575802, 4733.928991065137, 4744.620430365562, 4762.428508578958, 4174.248635245654, 4188.748675079474, 4191.224623444673, 4200.0, 4205.936910946339, 6037.45662890342, 6046.848828779272, 6049.48579370754, 6055.515558755289, 6072.210612620375, 5288.127458969304, 5546.833594992117, 5557.861053473655, 5559.33288005442, 5561.054620714448, 6623.07276981223, 6642.568233064883, 6669.866602667919, 6672.633005184713, 6686.465082793365, 4540.023894862587, 4547.15877562652, 4547.499775024745, 4550.3402006709175, 4559.77201139945, 6829.590224586491, 6890.517663763539, 6898.758543451006, 6901.378875901193, 6913.1358580176975, 4708.152532544106, 4713.764311784397, 4714.127886341038, 4714.811407543729, 4715.504871988461, 4664.067186562701, 4767.76161191939, 4769.76151192439, 4770.713757174581, 4775.761211939389, 5457.645253058538, 5485.177223416519, 5493.807716729895, 5499.945000549943, 5500.58745594082, 6578.80263592093, 6580.144581204413, 6599.307072757388, 6608.801735947833, 6612.404883560503, 1588.7219736546058, 1645.489898131583, 1671.8328167183183, 1678.4964510646757, 1678.6139187986832, 1094.2012330998416, 1112.4548971004149, 1121.5345631562973, 1122.2312715789546, 1122.7922834275685, 6350.269718982284, 6371.267304259976, 6374.235091789015, 6376.426121648981, 6378.521610879203, 6778.254392016875, 6790.117284752951, 6791.185057793096, 6807.795766127024, 6812.216595091529, 6394.520410969196, 6415.166028416276, 6454.515911306671, 6456.192975878015, 6467.029945508211, 3658.140337020798, 3683.1896982664307, 3684.981575092161, 3688.133288677159, 3690.9077273068388, 6919.238883722786, 7040.507164498538, 7063.04648872406, 7065.187503437068, 7072.045273887959, 6903.240643529208, 6929.272426395257, 6935.7225710971, 6937.68780404883, 6955.304469553004, 7031.753888613874, 7034.788956331318, 7051.788446346618, 7052.2595127511895, 7058.153021637437, 6782.593044417351, 6788.355106264897, 6790.32096790317, 6791.151106111736, 6792.830179245559, 6555.2133743949125, 6697.631630260383, 6767.120274364498, 6793.218779840184, 6823.590584564942, 7096.858062838817, 7106.360427561544, 7165.641717914188, 7173.569585824867, 7187.389071928736, 4728.38530990969, 4764.213904705824, 4765.928511072268, 4767.070421267819, 4768.785404656729, 6593.439557637655, 6688.130543029375, 6887.414569761426, 6899.655017249017, 6901.0, 6653.500987425866, 6662.133922590032, 6663.067170596023, 6672.032555279555, 6677.0, 6610.867782644224, 6611.834704132243, 6616.4045235929, 6619.867602648016, 6621.404073633396, 6451.0, 6495.967520162369, 6536.967315163393, 6567.113439685581, 6582.407583317333, 6567.343265673395, 6699.062131301719, 6722.394984451423, 6727.697253623501, 6756.864862702817, 6538.934610654022, 6618.90071648916, 6619.106420633346, 6637.402633762791, 6646.933530664632], "value": 5008.31460631543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.715005397625, 661.3551787007665, 673.6126727131899, 676.0636518421984, 683.3166833166833, 14918.925405372971, 15161.696766064671, 15166.696666066671, 15191.46829860955, 15195.0, 13661.795073073912, 13967.79048314276, 14046.508372206974, 14075.29623518825, 14082.859171408283, 530.4350866327349, 595.0301009354756, 628.8836565235446, 639.9936000640004, 698.1377998172253, 625.7152995387088, 646.6378827856415, 656.1535619051418, 673.4141297071554, 684.3737979748524, 672.7914346552584, 674.4570620650375, 675.9590231044186, 676.8747781660384, 677.8169894128582, 541.1936215039602, 643.1317721076556, 646.5926466326208, 678.9083473731032, 681.5706105153721, 462.0597084932147, 464.2803654335766, 466.5987250964168, 467.2337366718584, 469.1531785127843, 13246.66883327915, 13344.2660653664, 13354.065215434923, 13362.532311369152, 13406.0, 12678.556250531186, 12842.678933026657, 12981.805272920914, 13357.53248636293, 13449.731005379936, 11660.30038197711, 11696.364790856438, 11731.17881748278, 11794.646160615195, 12002.279863208236, 3810.2569998850236, 3899.844006239747, 3918.981064923112, 4006.1386801837743, 4009.077912080238, 55829.0, 55911.16133258004, 56393.43606563923, 56670.0, 57004.71497642485, 10486.528106235237, 10491.0, 10493.527791249413, 10637.255392122477, 10652.573897044187, 16814.747778783327, 16827.074510901773, 16842.663146736995, 16874.15629218534, 16882.91558542224, 8313.251807337369, 8404.07555168931, 8432.789180270542, 8605.870911936327, 8607.655693772303, 4884.072982232483, 4885.2427873679635, 4908.901821963541, 4915.090708218991, 5125.513076257749, 3134.6865313468925, 3186.0919637903085, 3190.0429871038596, 3191.728703060266, 3191.792533485316, 563.433749082178, 593.4480932732514, 605.1014243847883, 610.6702380714453, 625.2028663454041, 619.065211530592, 647.2233320015999, 657.5002997721766, 668.5019660353069, 734.5042096584784, 9527.38072025316, 9724.173445257233, 9768.07203315684, 9791.740239844408, 9846.803063938682, 737.9262073792578, 766.9578173200416, 774.1639029847751, 785.9449838511249, 795.8766391209372, 4472.530384309665, 4519.389882365905, 4522.321651752198, 4624.583787459145, 4645.837395691202, 56983.71508142433, 57759.133612995836, 64599.35400645933, 65157.674211629586, 65679.0, 54185.1872221917, 54916.0, 55236.17145742817, 55966.72016639891, 56431.71784141135, 50379.0, 50411.0, 50803.74598126986, 51078.66311600467, 51330.0, 10222.744431388977, 10324.948375258376, 10336.689899303034, 10408.063274305348, 10506.106980906708, 35835.64164358323, 36790.44814327841, 37663.0, 38816.22367552577, 38993.0, 45752.54247457483, 47786.28320575125, 47887.042259153925, 48715.0, 49508.25737614011, 11999.700007499534, 12182.634520964386, 12290.0, 12528.87471125277, 12543.749125017632, 13664.521741738992, 13715.382807773474, 13729.382177801823, 13861.37623806911, 14416.351264192926, 12906.161099528501, 13014.414351354022, 13120.212787232796, 13305.66735831612, 13650.317484125953, 12649.557265495663, 12757.425915833624, 12807.871921280668, 12853.0, 12886.033547484163, 12667.556635517712, 12771.169873958162, 12912.612621621367, 13169.53906613264, 13504.662383440493, 10346.844797328196, 10603.46982650849, 10828.296160749525, 11148.721281968015, 11338.943305283421, 11119.888801111885, 11319.434028298718, 11413.372264525531, 11477.081833453136, 11485.540578377106], "value": 6561.540479137852, "unit": "score"}], "name": "dromaeo_css", "value": 7149.606301729431, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 104.0, 111.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 153.0, 184.0, 133.0, 156.0, 173.0, 134.0, 189.0, 127.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 160.0, 161.0, 160.0, 159.0, 160.0, 159.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 181.0, 77.0, 75.0, 75.0, 76.0, 157.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 157.0, 92.0, 93.0, 93.0, 157.0, 92.0, 93.0, 152.0], "value": 111.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 54.0, 55.0, 53.0, 54.0, 74.0, 52.0, 52.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 81.0, 73.0, 74.0, 73.0, 74.0, 80.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 110.0, 111.0, 107.0, 110.0, 108.0, 108.0, 128.0, 109.0], "value": 113.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 157.0, 154.0, 159.0, 156.0, 155.0, 156.0, 157.0, 157.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 71.0, 65.0, 65.0, 64.0, 65.0, 66.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1507.4999999999998, "alertThreshold": 2.0}]} 03:31:45 INFO - Return code: 0 03:31:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:31:45 ERROR - # TBPL SUCCESS # 03:31:45 INFO - Running post-action listener: _resource_record_post_action 03:31:45 INFO - Running post-run listener: _resource_record_post_run 03:31:46 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 765952; Write bytes: 247009280; Read time: 72; Write time: 112072 03:31:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1183744; Read time: 0; Write time: 40 03:31:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 765952; Write bytes: 245825536; Read time: 72; Write time: 112032 03:31:46 INFO - Running post-run listener: _upload_blobber_files 03:31:46 INFO - Blob upload gear active. 03:31:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:31:46 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 03:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:31:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:47 INFO - (blobuploader) - INFO - Done attempting. 03:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:48 INFO - (blobuploader) - INFO - Done attempting. 03:31:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:48 INFO - Return code: 0 03:31:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ae6c55680db1e6a34321d3f0c3fb156c5dddc3c978d4fbcd38fe73eff432dc4a476eeccabe3fc09d3a30870b417085dfc166ef90d406e8ab021edec55736f95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f875c40bf439edaa078dfcab9fca831639052f9ae669b39c6e8622432bf2fba16f9223ccb9fd6a1199081e5747b5450538deeb2a32a0e165ecb6550b5bdd0404"} 03:31:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:48 INFO - Contents: 03:31:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ae6c55680db1e6a34321d3f0c3fb156c5dddc3c978d4fbcd38fe73eff432dc4a476eeccabe3fc09d3a30870b417085dfc166ef90d406e8ab021edec55736f95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f875c40bf439edaa078dfcab9fca831639052f9ae669b39c6e8622432bf2fba16f9223ccb9fd6a1199081e5747b5450538deeb2a32a0e165ecb6550b5bdd0404"} 03:31:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:48 INFO - Copying logs to upload dir... 03:31:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.682820 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-28 03:31:47.940704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:47.944115) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ae6c55680db1e6a34321d3f0c3fb156c5dddc3c978d4fbcd38fe73eff432dc4a476eeccabe3fc09d3a30870b417085dfc166ef90d406e8ab021edec55736f95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f875c40bf439edaa078dfcab9fca831639052f9ae669b39c6e8622432bf2fba16f9223ccb9fd6a1199081e5747b5450538deeb2a32a0e165ecb6550b5bdd0404"} build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ae6c55680db1e6a34321d3f0c3fb156c5dddc3c978d4fbcd38fe73eff432dc4a476eeccabe3fc09d3a30870b417085dfc166ef90d406e8ab021edec55736f95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f875c40bf439edaa078dfcab9fca831639052f9ae669b39c6e8622432bf2fba16f9223ccb9fd6a1199081e5747b5450538deeb2a32a0e165ecb6550b5bdd0404"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:47.975976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:47.976468) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464430272.780555-2107064410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:48.028055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:48.028646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:48.029037) ========= ========= Total master_lag: 0.15 =========