builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1460810895.03 results: success (0) buildid: 20160416030220 builduid: a806c9e3234c4fd7a14e2dc1fc6463d2 revision: a5322c766f510d2a6544b519ffcc72a19879c779 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.029830) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.030551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.030843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.061418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.061714) ========= 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=df17445c3590ff7897617a0e00000225-1460809304.207617-399045168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 05:48:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-04-16 05:48:15 (18.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075472 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.151175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.151509) ========= 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=df17445c3590ff7897617a0e00000225-1460809304.207617-399045168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015291 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.200987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.201352) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5322c766f510d2a6544b519ffcc72a19879c779 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a5322c766f510d2a6544b519ffcc72a19879c779 --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=df17445c3590ff7897617a0e00000225-1460809304.207617-399045168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 05:48:16,067 truncating revision to first 12 chars 2016-04-16 05:48:16,067 Setting DEBUG logging. 2016-04-16 05:48:16,067 attempt 1/10 2016-04-16 05:48:16,067 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5322c766f51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 05:48:16,441 unpacking tar archive at: mozilla-central-a5322c766f51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.903848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.904136) ========= script_repo_revision: a5322c766f510d2a6544b519ffcc72a19879c779 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.904508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.904823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 05:48:15.914622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-16 05:48:15.914900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460809304.207617-399045168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:16 INFO - MultiFileLogger online at 20160416 05:48:16 in /builds/slave/test 05:48:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:48:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:16 INFO - {'append_to_log': False, 05:48:16 INFO - 'base_work_dir': '/builds/slave/test', 05:48:16 INFO - 'blob_upload_branch': 'Firefox', 05:48:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:16 INFO - 'branch': 'Firefox', 05:48:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:16 INFO - 'config_files': ('talos/linux_config.py',), 05:48:16 INFO - 'default_actions': ('clobber', 05:48:16 INFO - 'read-buildbot-config', 05:48:16 INFO - 'download-and-extract', 05:48:16 INFO - 'populate-webroot', 05:48:16 INFO - 'create-virtualenv', 05:48:16 INFO - 'install', 05:48:16 INFO - 'run-tests'), 05:48:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:16 INFO - 'download_minidump_stackwalk': True, 05:48:16 INFO - 'download_symbols': 'ondemand', 05:48:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:16 INFO - 'installer_path': 'installer.exe', 05:48:16 INFO - 'log_level': 'info', 05:48:16 INFO - 'log_name': 'talos', 05:48:16 INFO - 'log_to_console': True, 05:48:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:16 INFO - 'opt_config_files': (), 05:48:16 INFO - 'pip_index': False, 05:48:16 INFO - 'sps_profile': False, 05:48:16 INFO - 'sps_profile_interval': 0, 05:48:16 INFO - 'suite': 'dromaeojs', 05:48:16 INFO - 'system_bits': '32', 05:48:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:16 INFO - 'title': 'talos-linux64-ix-021', 05:48:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:16 INFO - 'use_talos_json': True, 05:48:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:16 INFO - 'work_dir': 'build'} 05:48:16 INFO - ##### 05:48:16 INFO - ##### Running clobber step. 05:48:16 INFO - ##### 05:48:16 INFO - Running pre-action listener: _resource_record_pre_action 05:48:16 INFO - Running main action method: clobber 05:48:16 INFO - rmtree: /builds/slave/test/build 05:48:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:17 INFO - Running post-action listener: _resource_record_post_action 05:48:17 INFO - ##### 05:48:17 INFO - ##### Running read-buildbot-config step. 05:48:17 INFO - ##### 05:48:17 INFO - Running pre-action listener: _resource_record_pre_action 05:48:17 INFO - Running main action method: read_buildbot_config 05:48:17 INFO - Using buildbot properties: 05:48:17 INFO - { 05:48:17 INFO - "project": "", 05:48:17 INFO - "product": "firefox", 05:48:17 INFO - "script_repo_revision": "production", 05:48:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:48:17 INFO - "repository": "", 05:48:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:48:17 INFO - "buildid": "20160416030220", 05:48:17 INFO - "stage_platform": "linux64-pgo", 05:48:17 INFO - "basedir": "/builds/slave/test", 05:48:17 INFO - "nightly_build": "True", 05:48:17 INFO - "buildnumber": 262, 05:48:17 INFO - "slavename": "talos-linux64-ix-021", 05:48:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:48:17 INFO - "platform": "ubuntu64_hw", 05:48:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:48:17 INFO - "branch": "mozilla-central", 05:48:17 INFO - "repo_path": "mozilla-central", 05:48:17 INFO - "revision": "a5322c766f510d2a6544b519ffcc72a19879c779", 05:48:17 INFO - "pgo_build": "True", 05:48:17 INFO - "builduid": "a806c9e3234c4fd7a14e2dc1fc6463d2", 05:48:17 INFO - "slavebuilddir": "test" 05:48:17 INFO - } 05:48:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:48:17 INFO - Running post-action listener: _resource_record_post_action 05:48:17 INFO - ##### 05:48:17 INFO - ##### Running download-and-extract step. 05:48:17 INFO - ##### 05:48:17 INFO - Running pre-action listener: _resource_record_pre_action 05:48:17 INFO - Running main action method: download_and_extract 05:48:17 INFO - mkdir: /builds/slave/test/build/tests 05:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:17 INFO - https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:48:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:48:23 INFO - Downloaded 1361 bytes. 05:48:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:48:23 INFO - Using the following test package requirements: 05:48:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:48:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:48:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'jsshell-linux-x86_64.zip'], 05:48:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:48:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:48:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:48:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:48:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:48:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:23 INFO - https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:48:24 INFO - Downloaded 23774879 bytes. 05:48:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:48:25 INFO - Return code: 0 05:48:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:25 INFO - https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:48:27 INFO - Downloaded 23774879 bytes. 05:48:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:48:28 INFO - Return code: 0 05:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:28 INFO - https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:48:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:48:30 INFO - Downloaded 10841076 bytes. 05:48:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:48:30 INFO - Return code: 0 05:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:30 INFO - https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:48:31 INFO - Downloaded 58228028 bytes. 05:48:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:31 INFO - mkdir: /builds/slave/test/properties 05:48:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:31 INFO - Contents: 05:48:31 INFO - build_url:https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:48:32 INFO - Running post-action listener: _resource_record_post_action 05:48:32 INFO - Running post-action listener: set_extra_try_arguments 05:48:32 INFO - ##### 05:48:32 INFO - ##### Running populate-webroot step. 05:48:32 INFO - ##### 05:48:32 INFO - Running pre-action listener: _resource_record_pre_action 05:48:32 INFO - Running main action method: populate_webroot 05:48:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:32 INFO - '--tppagecycles', 05:48:32 INFO - '7'], 05:48:32 INFO - 'tests': ['tsvgm']}}, 05:48:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['damp', 'tps']}, 05:48:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'tests': ['damp', 'tps']}, 05:48:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['dromaeo_dom']}, 05:48:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tsvgx', 05:48:32 INFO - 'tsvgr_opacity', 05:48:32 INFO - 'tart', 05:48:32 INFO - 'tscrollx', 05:48:32 INFO - 'cart']}, 05:48:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:32 INFO - 'tsvgr_opacity', 05:48:32 INFO - 'tart', 05:48:32 INFO - 'tscrollx', 05:48:32 INFO - 'cart']}, 05:48:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tp5o']}, 05:48:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'tests': ['tp5o']}, 05:48:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s', 05:48:32 INFO - '--xperf_path', 05:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:32 INFO - 'tests': ['tp5n']}, 05:48:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:32 INFO - 'talos_options': ['--xperf_path', 05:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:32 INFO - 'tests': ['tp5n']}}, 05:48:32 INFO - 'talos.zip': {'path': '', 05:48:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:32 INFO - Running post-action listener: _resource_record_post_action 05:48:32 INFO - ##### 05:48:32 INFO - ##### Running create-virtualenv step. 05:48:32 INFO - ##### 05:48:32 INFO - Running pre-action listener: _resource_record_pre_action 05:48:32 INFO - Running main action method: create_virtualenv 05:48:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:48:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:32 INFO - Using real prefix '/usr' 05:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:35 INFO - Installing pip.................done. 05:48:35 INFO - Return code: 0 05:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:48:35 INFO - Using env: {'DISPLAY': ':0', 05:48:35 INFO - 'HOME': '/home/cltbld', 05:48:35 INFO - 'LANG': 'en_US.UTF-8', 05:48:35 INFO - 'LANGUAGE': 'en_US:en', 05:48:35 INFO - 'LOGNAME': 'cltbld', 05:48:35 INFO - 'MAIL': '/var/mail/cltbld', 05:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:35 INFO - 'MOZ_NO_REMOTE': '1', 05:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:35 INFO - 'NO_EM_RESTART': '1', 05:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:35 INFO - 'PWD': '/builds/slave/test', 05:48:35 INFO - 'SHELL': '/bin/bash', 05:48:35 INFO - 'SHLVL': '1', 05:48:35 INFO - 'TERM': 'linux', 05:48:35 INFO - 'TMOUT': '86400', 05:48:35 INFO - 'USER': 'cltbld', 05:48:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:35 INFO - '_': '/tools/buildbot/bin/python'} 05:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:48:35 INFO - Cleaning up... 05:48:35 INFO - Return code: 0 05:48:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:48:35 INFO - Using env: {'DISPLAY': ':0', 05:48:35 INFO - 'HOME': '/home/cltbld', 05:48:35 INFO - 'LANG': 'en_US.UTF-8', 05:48:35 INFO - 'LANGUAGE': 'en_US:en', 05:48:35 INFO - 'LOGNAME': 'cltbld', 05:48:35 INFO - 'MAIL': '/var/mail/cltbld', 05:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:35 INFO - 'MOZ_NO_REMOTE': '1', 05:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:35 INFO - 'NO_EM_RESTART': '1', 05:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:35 INFO - 'PWD': '/builds/slave/test', 05:48:35 INFO - 'SHELL': '/bin/bash', 05:48:35 INFO - 'SHLVL': '1', 05:48:35 INFO - 'TERM': 'linux', 05:48:35 INFO - 'TMOUT': '86400', 05:48:35 INFO - 'USER': 'cltbld', 05:48:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:35 INFO - '_': '/tools/buildbot/bin/python'} 05:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:35 INFO - Downloading/unpacking psutil>=0.7.1 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:37 INFO - Installing collected packages: psutil 05:48:37 INFO - Running setup.py install for psutil 05:48:37 INFO - building 'psutil._psutil_linux' extension 05:48:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:48:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:48:37 INFO - building 'psutil._psutil_posix' extension 05:48:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:48:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:48:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:37 INFO - Successfully installed psutil 05:48:37 INFO - Cleaning up... 05:48:38 INFO - Return code: 0 05:48:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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', '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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:48: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 mozsystemmonitor==0.0.0 05:48:38 INFO - Using env: {'DISPLAY': ':0', 05:48:38 INFO - 'HOME': '/home/cltbld', 05:48:38 INFO - 'LANG': 'en_US.UTF-8', 05:48:38 INFO - 'LANGUAGE': 'en_US:en', 05:48:38 INFO - 'LOGNAME': 'cltbld', 05:48:38 INFO - 'MAIL': '/var/mail/cltbld', 05:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:38 INFO - 'MOZ_NO_REMOTE': '1', 05:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:38 INFO - 'NO_EM_RESTART': '1', 05:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:38 INFO - 'PWD': '/builds/slave/test', 05:48:38 INFO - 'SHELL': '/bin/bash', 05:48:38 INFO - 'SHLVL': '1', 05:48:38 INFO - 'TERM': 'linux', 05:48:38 INFO - 'TMOUT': '86400', 05:48:38 INFO - 'USER': 'cltbld', 05:48:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:38 INFO - '_': '/tools/buildbot/bin/python'} 05:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:48:40 INFO - Installing collected packages: mozsystemmonitor 05:48:40 INFO - Running setup.py install for mozsystemmonitor 05:48:40 INFO - Successfully installed mozsystemmonitor 05:48:40 INFO - Cleaning up... 05:48:40 INFO - Return code: 0 05:48:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:40 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:40 INFO - Using env: {'DISPLAY': ':0', 05:48:40 INFO - 'HOME': '/home/cltbld', 05:48:40 INFO - 'LANG': 'en_US.UTF-8', 05:48:40 INFO - 'LANGUAGE': 'en_US:en', 05:48:40 INFO - 'LOGNAME': 'cltbld', 05:48:40 INFO - 'MAIL': '/var/mail/cltbld', 05:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:40 INFO - 'MOZ_NO_REMOTE': '1', 05:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:40 INFO - 'NO_EM_RESTART': '1', 05:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:40 INFO - 'PWD': '/builds/slave/test', 05:48:40 INFO - 'SHELL': '/bin/bash', 05:48:40 INFO - 'SHLVL': '1', 05:48:40 INFO - 'TERM': 'linux', 05:48:40 INFO - 'TMOUT': '86400', 05:48:40 INFO - 'USER': 'cltbld', 05:48:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:40 INFO - '_': '/tools/buildbot/bin/python'} 05:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - Downloading docopt-0.6.1.tar.gz 05:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:43 INFO - Running setup.py install for blobuploader 05:48:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:43 INFO - Running setup.py install for requests 05:48:43 INFO - Running setup.py install for docopt 05:48:43 INFO - Successfully installed blobuploader requests docopt 05:48:43 INFO - Cleaning up... 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:43 INFO - Running setup.py (path:/tmp/pip-PJaIEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:44 INFO - Running setup.py (path:/tmp/pip-B4ct7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:44 INFO - Running setup.py (path:/tmp/pip-u_COQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:44 INFO - Running setup.py (path:/tmp/pip-QkpedQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:44 INFO - Running setup.py (path:/tmp/pip-lprFut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:44 INFO - Running setup.py (path:/tmp/pip-k5GBl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:44 INFO - Running setup.py (path:/tmp/pip-eGjF2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:44 INFO - Running setup.py (path:/tmp/pip-0WMLsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:44 INFO - Running setup.py (path:/tmp/pip-twTie3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:44 INFO - Running setup.py (path:/tmp/pip-7YFFFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:44 INFO - Running setup.py (path:/tmp/pip-cqLZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:44 INFO - Running setup.py (path:/tmp/pip-MfdvAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:44 INFO - Running setup.py (path:/tmp/pip-3qh_Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:44 INFO - Running setup.py (path:/tmp/pip-rcQJuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:45 INFO - Running setup.py (path:/tmp/pip-t0cxJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:45 INFO - Running setup.py (path:/tmp/pip-xmFb4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:45 INFO - Running setup.py (path:/tmp/pip-BMWyQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:45 INFO - Running setup.py install for manifestparser 05:48:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:45 INFO - Running setup.py install for mozcrash 05:48:45 INFO - Running setup.py install for mozdebug 05:48:45 INFO - Running setup.py install for mozdevice 05:48:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:45 INFO - Running setup.py install for mozfile 05:48:45 INFO - Running setup.py install for mozhttpd 05:48:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:45 INFO - Running setup.py install for mozinfo 05:48:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:45 INFO - Running setup.py install for mozInstall 05:48:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Running setup.py install for mozleak 05:48:46 INFO - Running setup.py install for mozlog 05:48:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Running setup.py install for moznetwork 05:48:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Running setup.py install for mozprocess 05:48:46 INFO - Running setup.py install for mozprofile 05:48:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Running setup.py install for mozrunner 05:48:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Running setup.py install for mozscreenshot 05:48:46 INFO - Running setup.py install for moztest 05:48:46 INFO - Running setup.py install for mozversion 05:48:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:46 INFO - Cleaning up... 05:48:47 INFO - Return code: 0 05:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:47 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:47 INFO - Using env: {'DISPLAY': ':0', 05:48:47 INFO - 'HOME': '/home/cltbld', 05:48:47 INFO - 'LANG': 'en_US.UTF-8', 05:48:47 INFO - 'LANGUAGE': 'en_US:en', 05:48:47 INFO - 'LOGNAME': 'cltbld', 05:48:47 INFO - 'MAIL': '/var/mail/cltbld', 05:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:47 INFO - 'MOZ_NO_REMOTE': '1', 05:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:47 INFO - 'NO_EM_RESTART': '1', 05:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:47 INFO - 'PWD': '/builds/slave/test', 05:48:47 INFO - 'SHELL': '/bin/bash', 05:48:47 INFO - 'SHLVL': '1', 05:48:47 INFO - 'TERM': 'linux', 05:48:47 INFO - 'TMOUT': '86400', 05:48:47 INFO - 'USER': 'cltbld', 05:48:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:47 INFO - '_': '/tools/buildbot/bin/python'} 05:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:47 INFO - Running setup.py (path:/tmp/pip-yKdNse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:47 INFO - Running setup.py (path:/tmp/pip-GvZ4g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:47 INFO - Running setup.py (path:/tmp/pip-meV1LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:47 INFO - Running setup.py (path:/tmp/pip-qSEndk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:47 INFO - Running setup.py (path:/tmp/pip-eI8v3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:47 INFO - Running setup.py (path:/tmp/pip-S7EpPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:47 INFO - Running setup.py (path:/tmp/pip-Sv6blY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:47 INFO - Running setup.py (path:/tmp/pip-NQljB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:47 INFO - Running setup.py (path:/tmp/pip-JRWgyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:47 INFO - Running setup.py (path:/tmp/pip-QJmG6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:47 INFO - Running setup.py (path:/tmp/pip-d40G1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:48 INFO - Running setup.py (path:/tmp/pip-tUtNXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:48 INFO - Running setup.py (path:/tmp/pip-9y_xaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:48 INFO - Running setup.py (path:/tmp/pip-9W_rlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:48 INFO - Running setup.py (path:/tmp/pip-xFkLcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:48 INFO - Running setup.py (path:/tmp/pip-oANooA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:48 INFO - Running setup.py (path:/tmp/pip-Wv4Fe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:50 INFO - Downloading blessings-1.6.tar.gz 05:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:50 INFO - Installing collected packages: blessings 05:48:50 INFO - Running setup.py install for blessings 05:48:50 INFO - Successfully installed blessings 05:48:50 INFO - Cleaning up... 05:48:50 INFO - Return code: 0 05:48:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:50 INFO - Reading from file tmpfile_stdout 05:48:50 INFO - Current package versions: 05:48:50 INFO - argparse == 1.2.1 05:48:50 INFO - blessings == 1.6 05:48:50 INFO - blobuploader == 1.2.4 05:48:50 INFO - docopt == 0.6.1 05:48:50 INFO - manifestparser == 1.1 05:48:50 INFO - mozInstall == 1.12 05:48:50 INFO - mozcrash == 0.17 05:48:50 INFO - mozdebug == 0.1 05:48:50 INFO - mozdevice == 0.48 05:48:50 INFO - mozfile == 1.2 05:48:50 INFO - mozhttpd == 0.7 05:48:50 INFO - mozinfo == 0.9 05:48:50 INFO - mozleak == 0.1 05:48:50 INFO - mozlog == 3.1 05:48:50 INFO - moznetwork == 0.27 05:48:50 INFO - mozprocess == 0.22 05:48:50 INFO - mozprofile == 0.28 05:48:50 INFO - mozrunner == 6.11 05:48:50 INFO - mozscreenshot == 0.1 05:48:50 INFO - mozsystemmonitor == 0.0 05:48:50 INFO - moztest == 0.7 05:48:50 INFO - mozversion == 1.4 05:48:50 INFO - psutil == 3.1.1 05:48:50 INFO - requests == 1.2.3 05:48:50 INFO - wsgiref == 0.1.2 05:48:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:50 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:50 INFO - Using env: {'DISPLAY': ':0', 05:48:50 INFO - 'HOME': '/home/cltbld', 05:48:50 INFO - 'LANG': 'en_US.UTF-8', 05:48:50 INFO - 'LANGUAGE': 'en_US:en', 05:48:50 INFO - 'LOGNAME': 'cltbld', 05:48:50 INFO - 'MAIL': '/var/mail/cltbld', 05:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:50 INFO - 'MOZ_NO_REMOTE': '1', 05:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:50 INFO - 'NO_EM_RESTART': '1', 05:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:50 INFO - 'PWD': '/builds/slave/test', 05:48:50 INFO - 'SHELL': '/bin/bash', 05:48:50 INFO - 'SHLVL': '1', 05:48:50 INFO - 'TERM': 'linux', 05:48:50 INFO - 'TMOUT': '86400', 05:48:50 INFO - 'USER': 'cltbld', 05:48:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:50 INFO - '_': '/tools/buildbot/bin/python'} 05:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:51 INFO - Cleaning up... 05:48:51 INFO - Return code: 0 05:48:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:51 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:48:51 INFO - Using env: {'DISPLAY': ':0', 05:48:51 INFO - 'HOME': '/home/cltbld', 05:48:51 INFO - 'LANG': 'en_US.UTF-8', 05:48:51 INFO - 'LANGUAGE': 'en_US:en', 05:48:51 INFO - 'LOGNAME': 'cltbld', 05:48:51 INFO - 'MAIL': '/var/mail/cltbld', 05:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:51 INFO - 'MOZ_NO_REMOTE': '1', 05:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:51 INFO - 'NO_EM_RESTART': '1', 05:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:51 INFO - 'PWD': '/builds/slave/test', 05:48:51 INFO - 'SHELL': '/bin/bash', 05:48:51 INFO - 'SHLVL': '1', 05:48:51 INFO - 'TERM': 'linux', 05:48:51 INFO - 'TMOUT': '86400', 05:48:51 INFO - 'USER': 'cltbld', 05:48:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:51 INFO - '_': '/tools/buildbot/bin/python'} 05:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:51 INFO - Downloading/unpacking jsonschema 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:53 INFO - Downloading/unpacking functools32 (from jsonschema) 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:53 INFO - warning: no files found matching '*.txt' 05:48:53 INFO - no previously-included directories found matching 'build' 05:48:53 INFO - no previously-included directories found matching 'dist' 05:48:53 INFO - no previously-included directories found matching '.git*' 05:48:53 INFO - Installing collected packages: jsonschema, functools32 05:48:53 INFO - Running setup.py install for functools32 05:48:53 INFO - warning: no files found matching '*.txt' 05:48:53 INFO - no previously-included directories found matching 'build' 05:48:53 INFO - no previously-included directories found matching 'dist' 05:48:53 INFO - no previously-included directories found matching '.git*' 05:48:53 INFO - Successfully installed jsonschema functools32 05:48:53 INFO - Cleaning up... 05:48:53 INFO - Return code: 0 05:48:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:53 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 0x7f85579aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23929a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, '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': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:48:53 INFO - Using env: {'DISPLAY': ':0', 05:48:53 INFO - 'HOME': '/home/cltbld', 05:48:53 INFO - 'LANG': 'en_US.UTF-8', 05:48:53 INFO - 'LANGUAGE': 'en_US:en', 05:48:53 INFO - 'LOGNAME': 'cltbld', 05:48:53 INFO - 'MAIL': '/var/mail/cltbld', 05:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:53 INFO - 'MOZ_NO_REMOTE': '1', 05:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:53 INFO - 'NO_EM_RESTART': '1', 05:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:53 INFO - 'PWD': '/builds/slave/test', 05:48:53 INFO - 'SHELL': '/bin/bash', 05:48:53 INFO - 'SHLVL': '1', 05:48:53 INFO - 'TERM': 'linux', 05:48:53 INFO - 'TMOUT': '86400', 05:48:53 INFO - 'USER': 'cltbld', 05:48:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:53 INFO - '_': '/tools/buildbot/bin/python'} 05:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:53 INFO - Downloading/unpacking flake8 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:56 INFO - no previously-included directories found matching 'docs/_build' 05:48:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:56 INFO - Running setup.py install for pep8 05:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:56 INFO - no previously-included directories found matching 'docs/_build' 05:48:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:48:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:56 INFO - Cleaning up... 05:48:56 INFO - Return code: 0 05:48:56 INFO - Running post-action listener: _resource_record_post_action 05:48:56 INFO - Running post-action listener: _start_resource_monitoring 05:48:56 INFO - Starting resource monitoring. 05:48:56 INFO - ##### 05:48:56 INFO - ##### Running install step. 05:48:56 INFO - ##### 05:48:56 INFO - Running pre-action listener: _resource_record_pre_action 05:48:56 INFO - Running main action method: install 05:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:56 INFO - Reading from file tmpfile_stdout 05:48:56 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:57 INFO - Reading from file tmpfile_stdout 05:48:57 INFO - Output received: 05:48:57 INFO - Usage: mozinstall [options] installer 05:48:57 INFO - Options: 05:48:57 INFO - -h, --help show this help message and exit 05:48:57 INFO - -d DEST, --destination=DEST 05:48:57 INFO - Directory to install application into. [default: 05:48:57 INFO - "/builds/slave/test"] 05:48:57 INFO - --app=APP Application being installed. [default: firefox] 05:48:57 INFO - mkdir: /builds/slave/test/build/application 05:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:49:13 INFO - Reading from file tmpfile_stdout 05:49:13 INFO - Output received: 05:49:13 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:13 INFO - Running post-action listener: _resource_record_post_action 05:49:13 INFO - ##### 05:49:13 INFO - ##### Running run-tests step. 05:49:13 INFO - ##### 05:49:13 INFO - Running pre-action listener: _resource_record_pre_action 05:49:13 INFO - Running main action method: run_tests 05:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:13 INFO - Python 2.7.3 05:49:13 INFO - Return code: 0 05:49:13 INFO - grabbing minidump binary from tooltool 05:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:13 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 0x2421810>, '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 0x2422710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2422ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:49:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:49:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:13 INFO - Return code: 0 05:49:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:49:14 INFO - Return code: 0 05:49:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:49:14 INFO - Using env: {'DISPLAY': ':0', 05:49:14 INFO - 'HOME': '/home/cltbld', 05:49:14 INFO - 'LANG': 'en_US.UTF-8', 05:49:14 INFO - 'LANGUAGE': 'en_US:en', 05:49:14 INFO - 'LOGNAME': 'cltbld', 05:49:14 INFO - 'MAIL': '/var/mail/cltbld', 05:49:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:14 INFO - 'MOZ_NO_REMOTE': '1', 05:49:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:14 INFO - 'NO_EM_RESTART': '1', 05:49:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:14 INFO - 'PWD': '/builds/slave/test', 05:49:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:14 INFO - 'SHELL': '/bin/bash', 05:49:14 INFO - 'SHLVL': '1', 05:49:14 INFO - 'TERM': 'linux', 05:49:14 INFO - 'TMOUT': '86400', 05:49:14 INFO - 'USER': 'cltbld', 05:49:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460809304.207617-399045168', 05:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:14 INFO - '_': '/tools/buildbot/bin/python'} 05:49:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:49:14 INFO - mozversion application_buildid: 20160416030220 05:49:14 INFO - mozversion application_changeset: a5322c766f510d2a6544b519ffcc72a19879c779 05:49:14 INFO - mozversion application_display_name: Nightly 05:49:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:14 INFO - mozversion application_name: Firefox 05:49:14 INFO - mozversion application_remotingname: firefox 05:49:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:14 INFO - mozversion application_vendor: Mozilla 05:49:14 INFO - mozversion application_version: 48.0a1 05:49:14 INFO - mozversion platform_buildid: 20160416030220 05:49:14 INFO - mozversion platform_changeset: a5322c766f510d2a6544b519ffcc72a19879c779 05:49:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:14 INFO - mozversion platform_version: 48.0a1 05:49:14 INFO - using testdate: 1460810954 05:49:14 INFO - actual date: 1460810954 05:49:14 INFO - starting webserver on 'localhost:53378' 05:49:14 INFO - SUITE-START | Running 2 tests 05:49:14 INFO - TEST-START | dromaeo_css 05:49:14 INFO - operating with platform_type : linux_ 05:49:14 INFO - Initialising browser for dromaeo_css test... 05:49:14 INFO - TEST-INFO | started process 7553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYHjPU/profile http://localhost:53378/getInfo.html) 05:49:19 INFO - PROCESS | 7553 | __metrics Screen width/height:1600/1200 05:49:19 INFO - PROCESS | 7553 | colorDepth:24 05:49:19 INFO - PROCESS | 7553 | Browser inner width/height: 1024/697 05:49:19 INFO - PROCESS | 7553 | __metrics 05:49:21 ERROR - PROCESS | 7553 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:49:22 INFO - TEST-INFO | 7553: exit 0 05:49:22 INFO - Browser initialized. 05:49:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:22 INFO - TEST-INFO | started process 7638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYHjPU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:34 INFO - PROCESS | 7638 | RSS: Main: 153014272 05:49:34 INFO - PROCESS | 7638 | 05:50:25 INFO - PROCESS | 7638 | 1460811024998 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:52:32 INFO - PROCESS | 7638 | Cycle 1(1): loaded http://localhost:53378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53378/tests/dromaeo/cssquery-ext.html) 05:52:33 INFO - PROCESS | 7638 | RSS: Main: 239771648 05:52:33 INFO - PROCESS | 7638 | 05:55:35 INFO - PROCESS | 7638 | Cycle 1(1): loaded http://localhost:53378/tests/dromaeo/cssquery-ext.html (next: http://localhost:53378/tests/dromaeo/cssquery-jquery.html) 05:55:36 INFO - PROCESS | 7638 | RSS: Main: 231391232 05:55:36 INFO - PROCESS | 7638 | 05:58:38 INFO - PROCESS | 7638 | Cycle 1(1): loaded http://localhost:53378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53378/tests/dromaeo/cssquery-mootools.html) 05:58:38 INFO - PROCESS | 7638 | RSS: Main: 232361984 05:58:38 INFO - PROCESS | 7638 | 06:01:40 INFO - PROCESS | 7638 | Cycle 1(1): loaded http://localhost:53378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53378/tests/dromaeo/cssquery-prototype.html) 06:01:41 INFO - PROCESS | 7638 | RSS: Main: 226099200 06:01:41 INFO - PROCESS | 7638 | 06:04:43 INFO - PROCESS | 7638 | Cycle 1(1): loaded http://localhost:53378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53378/tests/dromaeo/cssquery-yui.html) 06:04:44 INFO - PROCESS | 7638 | RSS: Main: 217468928 06:04:44 INFO - PROCESS | 7638 | 06:07:46 INFO - PROCESS | 7638 | Cycle 1(1): loaded http://localhost:53378/tests/dromaeo/cssquery-yui.html (next: http://localhost:53378/tests/dromaeo/cssquery-dojo.html) 06:07:47 INFO - PROCESS | 7638 | RSS: Main: 268894208 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | __start_tp_report 06:07:47 INFO - PROCESS | 7638 | _x_x_mozilla_page_load 06:07:47 INFO - PROCESS | 7638 | _x_x_mozilla_page_load_details 06:07:47 INFO - PROCESS | 7638 | |i|pagename|runs| 06:07:47 INFO - PROCESS | 7638 | |0;dojo.html;3043.71084746949;3085.197848559377;3121.3445176512932;3124.047165614488;3150.133713228862;5220.973895130529;5282.471752824716;5319.601029922752;5341.4658534146565;5342.412334643186;5229.921551176726;5283.577313814885;5338.706371149595;5341.4925582069645;5368.651037682557;4743.928841067387;4751.64362672801;4756.405449318835;4771.689840160396;4930.901381972359;4849.199882019462;4881.511848815107;4896.583790377822;4899.779509922044;4919.680220785655;4699.177643912319;4702.952970470303;4732.124556956974;4762.119007983534;4888.120138375091;4738.976305118486;4743.620510359197;4755.286706993944;4757.643176761757;4792.065547218293;4686.742229177394;4720.787564559569;4722.055588882237;4740.834070807505;4760.95239047612;5054.090263752523;5097.337346145015;5175.430702622709;5220.6084543659;5227.634065615409;5483.424240454735;5499.450054994509;5509.696966666832;5513.751881165357;5521.889562208774;5444.537214336786;5558.221848941152;5558.555315574744;5562.360328562227;5580.107182850725;5281.894362112775;5313.442088580682;5334.119870221448;5363.544098751572;5376.650517716336;5828.6211396259105;5828.795992140254;5834.27071616048;5835.35811060783;5870.354261031283;5341.86645333862;5508.504234618904;5589.888202236014;5594.9720251398485;5605.467480589419;5596.412376700469;5608.775648973995;5612.158176273591;5614.270144881221;5667.376588575254;5571.442855714477;5583.720813959367;5595.7481913313995;5596.104623260258;5598.3282006159525;5513.007658621486;5560.221568980346;5578.330600327987;5597.244372009808;5634.577406694514;4291.892702682396;4293.549177336335;4318.892027699333;4324.135172965357;4338.891527711832;3814.3515602347666;3831.7700937943814;3836.9808150959066;3867.690584753213;3872.8838134855437;5149.510796474329;5155.32980712505;5274.5780337572905;5313.229581710631;5333.359996800331;5569.053260945649;5585.888282234414;5591.944080559224;5592.748326325325;5626.35296940857;5256.868578285497;5260.079486089919;5264.15773476242;5274.657147285414;5302.522772950453;4739.099571081483;4819.228923372314;4830;4830.3479030331155;4893.388326459192;5774.942250577525;5788.855278618068;5789.681567513827;5822.563307751935;5858.472737453564;5594.832155035356;5602.355729091207;5604.299462567179;5611.579131565068;5614.606977511535;5661;5801.071828507418;5811.593188476766;5898.35118136996;5914.615549989237;5396.568274537949;5400.459954004568;5403.459654034565;5411.648242864201;5457.235986961749;5457;5506.201600767947;5516.751746171351;5545.3622833374675;5548.0845660465575;5408.37803652585;5541.9168712470155;5583.637063590853;5591.720413979366;5635.408282130317;5279.366476022902;5342;5344.091504444176;5353.518183363516;5370.677759334452;5225.451327610546;5233.738313084406;5271.103912334989;5299.5760339172;5309.681419114865;5487.478689524489;5509.090999984957;5527.613067085265;5546.694931778791;5553.361363443094;5477.808276710296;5485.451454854483;5487.286652735119;5494.313210848644;5497.285352904097 06:07:47 INFO - PROCESS | 7638 | |1;ext.html;597.9372165922578;630.9463695585875;646.9385408386202;649.8245473722095;658.1444122640569;28806.279843003937;38383.42424863629;38605;38711.225775484505;38749.225015499745;39503;40010.799946000305;40327.16891895265;40479.79760101195;40482;7276.199618042011;8408.369372297071;8603.870941935877;8606.35452341077;8613.741587752378;7290.671919763597;7403.62981850908;7404.1855395906405;10279.537420816081;10506.68479945599;10117.747056323577;10232.027957344078;10259.230557708164;10260.179185665167;10266.12737917278;7417.109946806364;10152.593896244141;10225.38647681134;10241.12950399217;10251.692449226535;10159.746006349826;10411.479426028669;10427.217958653131;10427.374357538572;10437.843432348522;36874;37449.43825842615;37659.435108473124;37687.246255074744;37712.43431348532;3437.020449171974;3524.4537096750046;3809.5047643806406;4126.773027483488;4155.252054630166;30597.38805223883;31450;31538.684613154033;31616;31787;3787.1478917243676;3797.468354430382;3824;3903.3364328064013;3934.5278566572197;311675;314044.99999999773;314840;314879;316520;59593.404065958784;59909.70045149746;60143.69928150419;60244;60305.39694602998;63117;64014.359856401774;64073;64179.35820641827;64208.67895660585;14711.190884501455;15062.096274223582;15079.924600377148;15080.321385537678;15103.244837758288;10894.128469722404;10938.179636527293;10961.616343427942;10972.561097556008;10976.670699879016;18356.17397217102;18419.81580184181;18433.90783046103;18948.526286842938;19143.329983450792;6673.332666733288;6720.193576770819;6747.730090796412;6888.965555172192;6981.127359080115;1029.2229366827996;1082.9224921203454;1127.9266847654876;1142.6743378137191;1177.3289225141586;32558.511622325685;32680.509792353132;32717.67282327194;33182.170445738564;33960.150996224795;1117.541807858774;1152.3431643963029;1154.1689983212075;1208.7703336366062;1249.9875001250052;16717.916410418115;17566.308527930887;17568.121593920252;17643.470695879143;17794.46616601504;415228;526770;537455;543146;544124;57301.713491432274;58205.41794582;58550;58582.707086464296;58956.705216474504;1276.6489215465635;1400.985990140106;1419.198153043527;1441.4810668159455;1492.44779431611;29557;31899;31935.84032079825;31985.520217196296;32192.35615287728;42984.78507607567;43677.78161109174;43833.56166438422;43882.780586096866;43914.12171756611;293909;299746;302734;303431;304001;25007.74992250054;28585;28593.14220573386;28990.7100928988;29011.27471813137;41893.37159942542;42183.578164217965;43178.56821431871;43244.13511729685;48234.75882620705;37088.07279818026;38864.6113538861;38974;39539;40113.79943100383;39548;39638.2072358557;40118.598814011486;40353.79823100866;40604;38323.425148622235;38700;38789.41815872708;39368;39472.802635986634;33637.38721981615;34232.486512701835;35361.469577956865;35645;35951.820240898625;27700.8614956932;27905.16284511468;27939;28088;28148.85925570441 06:07:47 INFO - PROCESS | 7638 | |2;jquery.html;378.83508212247335;384.8402912791192;391.3034798059454;392.9882103536895;400.9158076803871;14066.507672231473;16723.16384180792;17157.227924743383;18361.63276734466;18810.52973675657;17092.572685682833;17272.654546909056;17723.29106835725;17733.113344332764;19117.522061948424;5503.174523821429;5630.971845140769;5655.688937108457;5675.404082571333;5680.289963754531;5466.453354664522;5625.5218306444;5638.4361563843495;5643.8024669136585;5671.8014869479575;5422.48486393794;5555.055640541097;5591.944080559183;5601.579881508883;5622.91565626516;5439.864003399907;5490.627343164209;5595.272614560102;5614.326280846324;5618.747156377973;4954.975225123887;5004.5495905368325;5008.774605142778;5009.048280826668;5013.0725815723845;21804.236851710113;21908.23321183751;22122;22135.667964980537;22391.552168956692;2378.9048438062455;2399.1003373734848;2554.604036374365;2613.8431694098417;2960.703929607022;13788.793168102486;13889.166650001032;13950.23273719945;13966.371513281927;14457.855421445862;1887.6036032433205;1907.1131923655428;1964.1946801811332;1988.1053525913396;1988.7812340642517;75135.24864751338;76223;76461;76503;77236.61381693055;9910.405375677483;10210.948945255375;10433.791324173626;10518.421486818146;10635.787284254271;14397;14401.927990359982;14459;14493.855061449462;14499.130052196902;7590.8102297443;7623.912315512226;7690.2694244046725;7702.460827742117;7716.498427602188;7092.6099064551945;7162.892556611655;7255.782326530212;7272.454565907578;7274.127104747358;6225.533085018642;6266.843328916722;6425.228972523327;6444.548881578245;6458.257300410513;1768.9646207076044;1862.4040307101598;1871.8315351618419;1880.6520793653217;1881.7177423386602;470.22882472744726;471.27659043368266;872.6422166911663;1051.8211903976342;1068.2308737708838;11229.438528073564;11634.185607007428;11683.649490515298;18680.7197892029;19640.607187856163;1002.9348092373972;1009.0284113286448;1020.505055048301;1025.9897401025894;1072.5066469423996;10220.284580079471;10253.179745620333;10599.470026498644;10630.521626526825;10653.84019239712;504988;508259;509308;511512;529775;88816;90465.57206567627;90777.54611226902;91555;92349.53825230831;1070.063694267516;1077.138289368502;1094.600470828142;1118.6867677050438;1122.7698321844002;16321.265543050355;16523.091229982467;16563.254653540378;16771.91614041922;17013.064281464638;30990;38138.61861381351;38271;38411.2317753649;39270.80364598273;51388;54457.45542544524;55647;55650.16524752213;56065;8300.501969881827;8418.831623367621;8525.317974562144;8613.09562495929;8735.956320218358;11969.581064662694;12567.30879801583;12799.680007999874;13462.326883655582;13527.188368697909;11467.942660286646;11616.5353385867;11628.94185529067;11724.120690948042;12029.097817663534;5620.550355971431;10365.341545352707;10739.892601074202;10927.508262128064;11014.59381381706;12176.147669663038;12254.387280635754;12337.198082124632;12435.626931192079;12504.437300321326;8419.8737018946;8472;8734.301255899385;8736.956315218384;8811.823763524822;11883.940580297389;11949.701257468285;12020.398980050788;12043.156979011384;12270.692004732182 06:07:47 INFO - PROCESS | 7638 | |3;mootools.html;1315.256879862878;1479.956630575444;1527.1142737212417;1633.7386018237084;1777.3246166456752;7488.288612581803;7744.806379840493;7747.186545412735;7762.961185194066;7778.8833167502535;7680.462367634268;7833.451658383916;7844.568548729818;7847.607619619011;7848.175941526143;1838.7793464784245;2065.0500769645982;2085.4577809769457;2116.33335499318;2117.375374264588;2030.6649402848511;2037.7147199392098;2054.4452997690614;2060.6393881070826;2062.2060506704875;2002.0990554250645;2023.8380929525604;2052.4560991337307;2054.435030366646;2058.989705051473;1965.2924947019062;1989.7413336266193;1997.4407165993473;2000.4298774849244;2008.8794672319634;2006.9197232110698;2008.5179556906382;2028.3205126282712;2032.5934813037452;2034.7761746207905;7984.281414672707;8056.234657707509;8057.5165490070785;8070.112287648354;8071.596420179027;4676.883077923045;4815;4839.540243676845;4861.73260470674;4865.683730557503;2560.7823335016546;3003.57949887016;3258.8859389921477;3267.836608169582;3286.227736481949;1056.9894301057045;1062.914966802654;1091.8143915534379;1104.2932523185168;1136.9147313951487;10028.448435336053;10068.597256109746;10080.092791648713;10084.647037353658;10132.442715650635;4025.335819589735;4137.586241375839;4154.584541545822;4292.678049146264;4322.200392927319;8558.486490810572;8823.426477278956;8906.510141942255;8909.910900891038;8912.73261802147;4781.665283430127;4784.784684689197;4799.832005879777;4802.591779698695;4810.5670489656095;4438.467383913951;4448.288273876165;4486.528914463999;4499.595036446735;4517.683762136685;3502.4746288056485;3551.698105660996;3606.5393515625688;3688.3176612326806;3711.4432835074954;1207.2032458577473;1224.179799534314;1225.136278923357;1230.5139469909336;1237.3565745812127;995.1143482300758;996.923322811362;1009.2733232072895;1010.3735683875897;1032.5043978890176;5750.367459579443;5780.132980053026;5789.565782566325;5791.478766910998;5953.196318497034;408.77925920002866;415.142730262008;421.084141991168;421.4037137450473;423.66107114309045;3941.165378087904;4069.267531844237;4116.835326586903;4123.36087906375;4169.937450938239;8908.599113039929;9354.251659867194;9676.177524910461;10043.598256069821;10117.949410253048;9599.184069354043;9629.229661627052;9649.710508684751;9705.641210230573;9727.367721098106;7148.820444626578;7239.674214660353;7264.346208841124;7292.817679558054;7366.263373662698;5489.451054894478;5534.169874518693;5548.278723765885;5589.804356847653;5713;8493;8737.269963831239;8909.331800115147;8921.241694455784;8964.193222609996;8885.91114088851;9193.494357810385;9217.815643687223;9227.815443691223;9240.95379523098;7051.330123638246;7068.6112263823925;7136.964315178391;7149.285071492809;7164.641767911479;7796.727114550963;7803.882941755992;7874.05511338643;7886.290233878978;7889.723859664884;7086.255943125898;7093.467989900882;7186;7212.819679508054;7250.20247772734;7025.578465292099;7043.894341584983;7122.85754284901;7204.675789589586;7235.963820180866;6604.174478190226;6651.235107962646;6688.398044176048;6702.329767023259;6702.83242918931;4931.3589233399425;5070.898582028412;5120.743962801919;5150.562202212854;5175.689458632494;5116.411612664442;5129.153689641167;5263.921041184309;5286.7356632169;5302.840914772563 06:07:47 INFO - PROCESS | 7638 | |4;prototype.html;325.4369940003793;328.4629630554045;329.76257094891685;332.2043705325745;337.10162417158244;5507.146392309189;5598.972005139969;5602.8319150425505;5607.887842243153;5610.298712660918;5519.917201241985;5524.640898341615;5524.972375138119;5525.972370138144;5549.639273447223;4073.5926407359248;4134.6692264618905;4253.744775313491;4275.422817919588;4291.3777502262155;4265.210935976838;4303.462067241595;4316.6546676265825;4321.783910804463;4336.176126535964;4115;4301.913961720764;4306.806193721274;4314.417553630251;4320.719153255029;3967.1867267210155;4218.219629368561;4262.744235345858;4304.268274393329;4311.310190369526;3781.5840257571645;3782.111203867089;3788.337041017811;3817.5609804872515;3822.4075268333454;5263.894722105575;5346.465353464661;5349.331333583302;5372;5376.327959005124;4872.098661747553;4918.163912134945;4945.7774400152075;4951.480094590052;4963.751812409365;5713.942860571424;5749.913751293734;5759.128283307941;5800.187973683687;5858.150568167592;4100.667283132964;4191.972966623197;4199.454070970784;4200.663946884242;4204.726692764991;6087.452129308339;6112.419320164578;6127.632342059446;6129.816105516842;6137;4233.5131459882505;4283.764392958417;4295.334223195409;4301.118270754488;4306.569343065668;4210.5578914214175;4291.442112525414;4314.201872653506;4319.913601727948;4324.524302326741;4866.1727506323305;4910.189818679878;4915.508449155127;4926.729029903318;4950.356453661001;5818.5636077294375;5822.970885145632;5829.038208695602;5835.35811060783;5860.208871802337;1397.916125032481;1493.2160615676858;1518.7266292067534;1524.5502576739889;1526.6107142678545;911.7857303533664;960.7598100474881;964.4647220792388;968.5786682793008;1023.3961962442195;5521.033819081645;5533.667979921218;5546.084895992197;5603.859903502445;5615.831525054255;5985.6408615483215;5985.910211346833;5994.790182343597;5999.910001349983;6001.909971350433;5481.698506582096;5563.332400111932;5595.776168953196;5603.35561410443;5606.074997625427;3147.2289289123855;3174.2540502981783;3205.743540516753;3206.1824234820438;3206.454902666506;6039;6160.784372546939;6166.7224974876235;6167.660778657217;6180.381961803873;6079.145860512586;6094.299155597075;6096.9390306096375;6109.983705377215;6112.113743507255;6170.475509581646;6173.259208894961;6175.228096487939;6183.907241391383;6191.380861913863;5782.942170578241;5963.821085367446;5974.551908606785;5990.281166260077;6015.6691381974415;5826.533877289891;5846.6784326862435;5867.765289388377;5877.735501902339;5909.320428150646;5975.970120149372;6074.271087469532;6102.359252278625;6102.420270074336;6128.701736848681;4308.784560772012;4327.091310824762;4332.350147477903;4337.5011873633675;4341.934870976875;5909.320428150646;5934.228550288435;5939.406059394199;5939.4357536034;5950.672713000653;5556;5762.193292939076;5790.060329789568;5853.326867410302;5863.091220860773;5813.505852002627;5822.243108395882;5828.6502809831545;5834.795782147605;5837.6497410155525;5348.705821179872;5535;5737.397573254748;5739.110437881968;5745.8563535911935;5841.707914604338;5932.139839723302;5996.2504686914135;5998.1002849572915;6008.429199226067;5766.452187042224;5795.7971471;5837.883242335214;5843.532517398683;5851.970740146272 06:07:47 INFO - PROCESS | 7638 | |5;yui.html;760.748952845561;797.7686470923433;806.4153488720676;834.9415540912134;840.0759164918586;14401.855981440196;14893.77659335111;14917;14918.17950012749;14960.476383326572;13498.93250533746;13534.796978045337;13600.455981760742;13821.447142114328;13861.861381386183;651.244556314675;807.9232472915093;814.8655471847153;825.1500954017372;828.4863384701493;783.189398972064;813.3777660090036;826.3513142183388;827.2802661684343;827.4249396669318;807.9878801817978;855.5722138930535;860.9569521523899;866.7746385939638;868.2055918834259;681.8363592737757;811.4644334739073;836.4521238588734;851.1998721202082;853.0658928473312;620.3672254300589;623.510544222783;628.8239292997968;629.2417636747708;629.8299459146051;13908.721825563433;13911.095778774346;13916;13925.721485570231;13934.233617151052;13839.515616953458;14354.712905741932;14484.927575362055;14549.854501454956;14590.124592524482;11054.668359949215;11388.202825802196;11398.487068081957;11561.364124973123;11568.190226684135;3848.1918797052654;3875.8643447479485;3878.9224215515815;3932.0956180078456;4000;51939.48060519384;52236.21645675318;53314.20028699573;53666.19500707492;53825.73087134578;11037.889621103686;11045.723856903642;11124.332540047622;11166;11201.775964480665;19480.123394447284;19632.70550941737;19682.50793730168;19896.70154947677;19899;7395.297446742551;7552.433567482461;7632.847343053108;7818.3354414875375;8068.233517815798;4811.4707382187935;4884.12085824555;4909.361782968192;4912.606991440676;4975.154223781966;3254.7558933080113;3332.983335083309;3333.6499667535045;3337.132345590164;3341.114604629775;577.0680351232729;582.4234008331721;600.570592026703;604.1994357476361;669.2504395077447;730.817295676081;736.7716008037526;744.3784439992559;749.1272667342594;749.2133260076897;8704.909757036288;9506.762330941643;9551.188149007412;9780.364276322016;9922.900770992197;587.3421767620207;596.5198015597485;643.9195100612424;705.9058459387928;735.3528894572742;4197.874063778091;4420.8673739787855;4463.375127482155;4521.796519156645;4535.909281814411;49137.508624913295;61347.38652613417;62136.68931655403;62509;62752;44526.77736611296;44955.77522112369;45077;46982;49513.75243123761;40051.99870003273;43440.348394774104;43656.3451548227;43925.12149757051;44779;8908.73273801787;9146.961512324218;9169.908300917172;9231;9269.536523173949;31153;31420;31962.52056219112;32064.519032215;32443.837780810944;38602.6139738599;39190.216195675355;41783.373249400676;42523.1495370097;42781;11137.387443690675;11211.271267367594;11738.70653233676;12003.699907502383;12312;13222.537211197561;13496.392662330023;13516.662083447993;13800.93099534496;14699.779503307245;12523;12821.487140514275;12902.225866448043;12904.870951290366;12907.419166137359;11978.04175665962;12113.75772484563;12153.513859445524;12386;12809.295488748208;13097.934510327388;13372.398242079324;13497.190168589916;13756.724865502434;13789.310534473036;10524.105451036748;10840.403777792297;10843.945780271048;11041.687394289062;11428.71428214268;10378.221633377376;10903.618373356894;11395.943020285176;11603.883961160618;11626.767464650491 06:07:47 INFO - PROCESS | 7638 | __end_tp_report 06:07:47 INFO - PROCESS | 7638 | __start_cc_report 06:07:47 INFO - PROCESS | 7638 | _x_x_mozilla_cycle_collect,789 06:07:47 INFO - PROCESS | 7638 | __end_cc_report 06:07:47 INFO - PROCESS | 7638 | __startTimestamp1460812067176__endTimestamp 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | ------- Summary: start ------- 06:07:47 INFO - PROCESS | 7638 | Number of tests: 6 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | [#0] dojo.html Cycles:165 Average:5204.50 Median:5363.54 stddev:576.40 (10.7%) stddev-sans-first:552.68 06:07:47 INFO - PROCESS | 7638 | Values: 3043.7 3085.2 3121.3 3124.0 3150.1 5221.0 5282.5 5319.6 5341.5 5342.4 5229.9 5283.6 5338.7 5341.5 5368.7 4743.9 4751.6 4756.4 4771.7 4930.9 4849.2 4881.5 4896.6 4899.8 4919.7 4699.2 4703.0 4732.1 4762.1 4888.1 4739.0 4743.6 4755.3 4757.6 4792.1 4686.7 4720.8 4722.1 4740.8 4761.0 5054.1 5097.3 5175.4 5220.6 5227.6 5483.4 5499.5 5509.7 5513.8 5521.9 5444.5 5558.2 5558.6 5562.4 5580.1 5281.9 5313.4 5334.1 5363.5 5376.7 5828.6 5828.8 5834.3 5835.4 5870.4 5341.9 5508.5 5589.9 5595.0 5605.5 5596.4 5608.8 5612.2 5614.3 5667.4 5571.4 5583.7 5595.7 5596.1 5598.3 5513.0 5560.2 5578.3 5597.2 5634.6 4291.9 4293.5 4318.9 4324.1 4338.9 3814.4 3831.8 3837.0 3867.7 3872.9 5149.5 5155.3 5274.6 5313.2 5333.4 5569.1 5585.9 5591.9 5592.7 5626.4 5256.9 5260.1 5264.2 5274.7 5302.5 4739.1 4819.2 4830.0 4830.3 4893.4 5774.9 5788.9 5789.7 5822.6 5858.5 5594.8 5602.4 5604.3 5611.6 5614.6 5661.0 5801.1 5811.6 5898.4 5914.6 5396.6 5400.5 5403.5 5411.6 5457.2 5457.0 5506.2 5516.8 5545.4 5548.1 5408.4 5541.9 5583.6 5591.7 5635.4 5279.4 5342.0 5344.1 5353.5 5370.7 5225.5 5233.7 5271.1 5299.6 5309.7 5487.5 5509.1 5527.6 5546.7 5553.4 5477.8 5485.5 5487.3 5494.3 5497.3 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | [#1] ext.html Cycles:180 Average:54035.15 Median:19442.96 stddev:103229.48 (530.9%) stddev-sans-first:103441.10 06:07:47 INFO - PROCESS | 7638 | Values: 597.9 630.9 646.9 649.8 658.1 28806.3 38383.4 38605.0 38711.2 38749.2 39503.0 40010.8 40327.2 40479.8 40482.0 7276.2 8408.4 8603.9 8606.4 8613.7 7290.7 7403.6 7404.2 10279.5 10506.7 10117.7 10232.0 10259.2 10260.2 10266.1 7417.1 10152.6 10225.4 10241.1 10251.7 10159.7 10411.5 10427.2 10427.4 10437.8 36874.0 37449.4 37659.4 37687.2 37712.4 3437.0 3524.5 3809.5 4126.8 4155.3 30597.4 31450.0 31538.7 31616.0 31787.0 3787.1 3797.5 3824.0 3903.3 3934.5 311675.0 314045.0 314840.0 314879.0 316520.0 59593.4 59909.7 60143.7 60244.0 60305.4 63117.0 64014.4 64073.0 64179.4 64208.7 14711.2 15062.1 15079.9 15080.3 15103.2 10894.1 10938.2 10961.6 10972.6 10976.7 18356.2 18419.8 18433.9 18948.5 19143.3 6673.3 6720.2 6747.7 6889.0 6981.1 1029.2 1082.9 1127.9 1142.7 1177.3 32558.5 32680.5 32717.7 33182.2 33960.2 1117.5 1152.3 1154.2 1208.8 1250.0 16717.9 17566.3 17568.1 17643.5 17794.5 415228.0 526770.0 537455.0 543146.0 544124.0 57301.7 58205.4 58550.0 58582.7 58956.7 1276.6 1401.0 1419.2 1441.5 1492.4 29557.0 31899.0 31935.8 31985.5 32192.4 42984.8 43677.8 43833.6 43882.8 43914.1 293909.0 299746.0 302734.0 303431.0 304001.0 25007.7 28585.0 28593.1 28990.7 29011.3 41893.4 42183.6 43178.6 43244.1 48234.8 37088.1 38864.6 38974.0 39539.0 40113.8 39548.0 39638.2 40118.6 40353.8 40604.0 38323.4 38700.0 38789.4 39368.0 39472.8 33637.4 34232.5 35361.5 35645.0 35951.8 27700.9 27905.2 27939.0 28088.0 28148.9 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | [#2] jquery.html Cycles:180 Average:28971.96 Median:2389.00 stddev:84333.34 (3530.1%) stddev-sans-first:84542.59 06:07:47 INFO - PROCESS | 7638 | Values: 378.8 384.8 391.3 393.0 400.9 14066.5 16723.2 17157.2 18361.6 18810.5 17092.6 17272.7 17723.3 17733.1 19117.5 5503.2 5631.0 5655.7 5675.4 5680.3 5466.5 5625.5 5638.4 5643.8 5671.8 5422.5 5555.1 5591.9 5601.6 5622.9 5439.9 5490.6 5595.3 5614.3 5618.7 4955.0 5004.5 5008.8 5009.0 5013.1 21804.2 21908.2 22122.0 22135.7 22391.6 2378.9 2399.1 2554.6 2613.8 2960.7 13788.8 13889.2 13950.2 13966.4 14457.9 1887.6 1907.1 1964.2 1988.1 1988.8 75135.2 76223.0 76461.0 76503.0 77236.6 9910.4 10210.9 10433.8 10518.4 10635.8 14397.0 14401.9 14459.0 14493.9 14499.1 7590.8 7623.9 7690.3 7702.5 7716.5 7092.6 7162.9 7255.8 7272.5 7274.1 6225.5 6266.8 6425.2 6444.5 6458.3 1769.0 1862.4 1871.8 1880.7 1881.7 470.2 471.3 872.6 1051.8 1068.2 11229.4 11634.2 11683.6 18680.7 19640.6 1002.9 1009.0 1020.5 1026.0 1072.5 10220.3 10253.2 10599.5 10630.5 10653.8 504988.0 508259.0 509308.0 511512.0 529775.0 88816.0 90465.6 90777.5 91555.0 92349.5 1070.1 1077.1 1094.6 1118.7 1122.8 16321.3 16523.1 16563.3 16771.9 17013.1 30990.0 38138.6 38271.0 38411.2 39270.8 51388.0 54457.5 55647.0 55650.2 56065.0 8300.5 8418.8 8525.3 8613.1 8736.0 11969.6 12567.3 12799.7 13462.3 13527.2 11467.9 11616.5 11628.9 11724.1 12029.1 5620.6 10365.3 10739.9 10927.5 11014.6 12176.1 12254.4 12337.2 12435.6 12504.4 8419.9 8472.0 8734.3 8737.0 8811.8 11883.9 11949.7 12020.4 12043.2 12270.7 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | [#3] mootools.html Cycles:180 Average:5251.97 Median:5001.13 stddev:2888.35 (57.8%) stddev-sans-first:2881.29 06:07:47 INFO - PROCESS | 7638 | Values: 1315.3 1480.0 1527.1 1633.7 1777.3 7488.3 7744.8 7747.2 7763.0 7778.9 7680.5 7833.5 7844.6 7847.6 7848.2 1838.8 2065.1 2085.5 2116.3 2117.4 2030.7 2037.7 2054.4 2060.6 2062.2 2002.1 2023.8 2052.5 2054.4 2059.0 1965.3 1989.7 1997.4 2000.4 2008.9 2006.9 2008.5 2028.3 2032.6 2034.8 7984.3 8056.2 8057.5 8070.1 8071.6 4676.9 4815.0 4839.5 4861.7 4865.7 2560.8 3003.6 3258.9 3267.8 3286.2 1057.0 1062.9 1091.8 1104.3 1136.9 10028.4 10068.6 10080.1 10084.6 10132.4 4025.3 4137.6 4154.6 4292.7 4322.2 8558.5 8823.4 8906.5 8909.9 8912.7 4781.7 4784.8 4799.8 4802.6 4810.6 4438.5 4448.3 4486.5 4499.6 4517.7 3502.5 3551.7 3606.5 3688.3 3711.4 1207.2 1224.2 1225.1 1230.5 1237.4 995.1 996.9 1009.3 1010.4 1032.5 5750.4 5780.1 5789.6 5791.5 5953.2 408.8 415.1 421.1 421.4 423.7 3941.2 4069.3 4116.8 4123.4 4169.9 8908.6 9354.3 9676.2 10043.6 10117.9 9599.2 9629.2 9649.7 9705.6 9727.4 7148.8 7239.7 7264.3 7292.8 7366.3 5489.5 5534.2 5548.3 5589.8 5713.0 8493.0 8737.3 8909.3 8921.2 8964.2 8885.9 9193.5 9217.8 9227.8 9241.0 7051.3 7068.6 7137.0 7149.3 7164.6 7796.7 7803.9 7874.1 7886.3 7889.7 7086.3 7093.5 7186.0 7212.8 7250.2 7025.6 7043.9 7122.9 7204.7 7236.0 6604.2 6651.2 6688.4 6702.3 6702.8 4931.4 5070.9 5120.7 5150.6 5175.7 5116.4 5129.2 5263.9 5286.7 5302.8 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | [#4] prototype.html Cycles:180 Average:4895.72 Median:5597.37 stddev:1447.11 (25.9%) stddev-sans-first:1409.92 06:07:47 INFO - PROCESS | 7638 | Values: 325.4 328.5 329.8 332.2 337.1 5507.1 5599.0 5602.8 5607.9 5610.3 5519.9 5524.6 5525.0 5526.0 5549.6 4073.6 4134.7 4253.7 4275.4 4291.4 4265.2 4303.5 4316.7 4321.8 4336.2 4115.0 4301.9 4306.8 4314.4 4320.7 3967.2 4218.2 4262.7 4304.3 4311.3 3781.6 3782.1 3788.3 3817.6 3822.4 5263.9 5346.5 5349.3 5372.0 5376.3 4872.1 4918.2 4945.8 4951.5 4963.8 5713.9 5749.9 5759.1 5800.2 5858.2 4100.7 4192.0 4199.5 4200.7 4204.7 6087.5 6112.4 6127.6 6129.8 6137.0 4233.5 4283.8 4295.3 4301.1 4306.6 4210.6 4291.4 4314.2 4319.9 4324.5 4866.2 4910.2 4915.5 4926.7 4950.4 5818.6 5823.0 5829.0 5835.4 5860.2 1397.9 1493.2 1518.7 1524.6 1526.6 911.8 960.8 964.5 968.6 1023.4 5521.0 5533.7 5546.1 5603.9 5615.8 5985.6 5985.9 5994.8 5999.9 6001.9 5481.7 5563.3 5595.8 5603.4 5606.1 3147.2 3174.3 3205.7 3206.2 3206.5 6039.0 6160.8 6166.7 6167.7 6180.4 6079.1 6094.3 6096.9 6110.0 6112.1 6170.5 6173.3 6175.2 6183.9 6191.4 5782.9 5963.8 5974.6 5990.3 6015.7 5826.5 5846.7 5867.8 5877.7 5909.3 5976.0 6074.3 6102.4 6102.4 6128.7 4308.8 4327.1 4332.4 4337.5 4341.9 5909.3 5934.2 5939.4 5939.4 5950.7 5556.0 5762.2 5790.1 5853.3 5863.1 5813.5 5822.2 5828.7 5834.8 5837.6 5348.7 5535.0 5737.4 5739.1 5745.9 5841.7 5932.1 5996.3 5998.1 6008.4 5766.5 5795.8 5837.9 5843.5 5852.0 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - PROCESS | 7638 | [#5] yui.html Cycles:180 Average:14151.71 Median:42652.07 stddev:15589.84 (36.6%) stddev-sans-first:15601.14 06:07:47 INFO - PROCESS | 7638 | Values: 760.7 797.8 806.4 834.9 840.1 14401.9 14893.8 14917.0 14918.2 14960.5 13498.9 13534.8 13600.5 13821.4 13861.9 651.2 807.9 814.9 825.2 828.5 783.2 813.4 826.4 827.3 827.4 808.0 855.6 861.0 866.8 868.2 681.8 811.5 836.5 851.2 853.1 620.4 623.5 628.8 629.2 629.8 13908.7 13911.1 13916.0 13925.7 13934.2 13839.5 14354.7 14484.9 14549.9 14590.1 11054.7 11388.2 11398.5 11561.4 11568.2 3848.2 3875.9 3878.9 3932.1 4000.0 51939.5 52236.2 53314.2 53666.2 53825.7 11037.9 11045.7 11124.3 11166.0 11201.8 19480.1 19632.7 19682.5 19896.7 19899.0 7395.3 7552.4 7632.8 7818.3 8068.2 4811.5 4884.1 4909.4 4912.6 4975.2 3254.8 3333.0 3333.6 3337.1 3341.1 577.1 582.4 600.6 604.2 669.3 730.8 736.8 744.4 749.1 749.2 8704.9 9506.8 9551.2 9780.4 9922.9 587.3 596.5 643.9 705.9 735.4 4197.9 4420.9 4463.4 4521.8 4535.9 49137.5 61347.4 62136.7 62509.0 62752.0 44526.8 44955.8 45077.0 46982.0 49513.8 40052.0 43440.3 43656.3 43925.1 44779.0 8908.7 9147.0 9169.9 9231.0 9269.5 31153.0 31420.0 31962.5 32064.5 32443.8 38602.6 39190.2 41783.4 42523.1 42781.0 11137.4 11211.3 11738.7 12003.7 12312.0 13222.5 13496.4 13516.7 13800.9 14699.8 12523.0 12821.5 12902.2 12904.9 12907.4 11978.0 12113.8 12153.5 12386.0 12809.3 13097.9 13372.4 13497.2 13756.7 13789.3 10524.1 10840.4 10843.9 11041.7 11428.7 10378.2 10903.6 11395.9 11603.9 11626.8 06:07:47 INFO - PROCESS | 7638 | -------- Summary: end -------- 06:07:47 INFO - PROCESS | 7638 | 06:07:47 INFO - TEST-INFO | 7638: exit 0 06:07:47 INFO - TEST-OK | dromaeo_css | took 1112961ms 06:07:47 INFO - TEST-START | kraken 06:07:47 INFO - operating with platform_type : linux_ 06:07:47 INFO - Initialising browser for kraken test... 06:07:47 INFO - TEST-INFO | started process 7823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOt0Xf/profile http://localhost:53378/getInfo.html) 06:07:52 INFO - PROCESS | 7823 | __metrics Screen width/height:1600/1200 06:07:52 INFO - PROCESS | 7823 | colorDepth:24 06:07:52 INFO - PROCESS | 7823 | Browser inner width/height: 1024/697 06:07:52 INFO - PROCESS | 7823 | __metrics 06:07:53 ERROR - PROCESS | 7823 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:07:54 INFO - TEST-INFO | 7823: exit 0 06:07:54 INFO - Browser initialized. 06:07:54 INFO - Running cycle 1/1 for kraken test... 06:07:54 INFO - TEST-INFO | started process 7904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOt0Xf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:06 INFO - PROCESS | 7904 | RSS: Main: 152289280 06:08:06 INFO - PROCESS | 7904 | 06:08:08 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53378/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:09 INFO - PROCESS | 7904 | RSS: Main: 207880192 06:08:09 INFO - PROCESS | 7904 | 06:08:12 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53378/tests/kraken/driver.html?testName=audio-dft) 06:08:12 INFO - PROCESS | 7904 | RSS: Main: 193511424 06:08:12 INFO - PROCESS | 7904 | 06:08:15 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53378/tests/kraken/driver.html?testName=audio-fft) 06:08:16 INFO - PROCESS | 7904 | RSS: Main: 265723904 06:08:16 INFO - PROCESS | 7904 | 06:08:18 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53378/tests/kraken/driver.html?testName=audio-oscillator) 06:08:19 INFO - PROCESS | 7904 | RSS: Main: 172326912 06:08:19 INFO - PROCESS | 7904 | 06:08:21 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:22 INFO - PROCESS | 7904 | RSS: Main: 176934912 06:08:22 INFO - PROCESS | 7904 | 06:08:25 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53378/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:25 INFO - PROCESS | 7904 | RSS: Main: 212910080 06:08:25 INFO - PROCESS | 7904 | 06:08:28 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53378/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:29 INFO - PROCESS | 7904 | RSS: Main: 213823488 06:08:29 INFO - PROCESS | 7904 | 06:08:32 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53378/tests/kraken/driver.html?testName=json-parse-financial) 06:08:32 INFO - PROCESS | 7904 | RSS: Main: 213860352 06:08:32 INFO - PROCESS | 7904 | 06:08:34 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:35 INFO - PROCESS | 7904 | RSS: Main: 201412608 06:08:35 INFO - PROCESS | 7904 | 06:08:36 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:37 INFO - PROCESS | 7904 | RSS: Main: 203329536 06:08:37 INFO - PROCESS | 7904 | 06:08:39 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:40 INFO - PROCESS | 7904 | RSS: Main: 218238976 06:08:40 INFO - PROCESS | 7904 | 06:08:42 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:43 INFO - PROCESS | 7904 | RSS: Main: 221716480 06:08:43 INFO - PROCESS | 7904 | 06:08:46 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:46 INFO - PROCESS | 7904 | RSS: Main: 216510464 06:08:46 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | Cycle 1(1): loaded http://localhost:53378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53378/tests/kraken/driver.html?testName=ai-astar) 06:08:48 INFO - PROCESS | 7904 | RSS: Main: 279392256 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | __start_tp_report 06:08:48 INFO - PROCESS | 7904 | _x_x_mozilla_page_load 06:08:48 INFO - PROCESS | 7904 | _x_x_mozilla_page_load_details 06:08:48 INFO - PROCESS | 7904 | |i|pagename|runs| 06:08:48 INFO - PROCESS | 7904 | |0;ai-astar;110;111;106;111;112;113;99;111;114;115 06:08:48 INFO - PROCESS | 7904 | |1;audio-beat-detection;156;128;160;190;134;152;152;128;178;129 06:08:48 INFO - PROCESS | 7904 | |2;audio-dft;163;161;162;162;160;162;160;161;163;161 06:08:48 INFO - PROCESS | 7904 | |3;audio-fft;73;74;99;131;74;76;72;122;106;73 06:08:48 INFO - PROCESS | 7904 | |4;audio-oscillator;92;93;152;93;92;93;151;92;93;152 06:08:48 INFO - PROCESS | 7904 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;116;116 06:08:48 INFO - PROCESS | 7904 | |6;imaging-darkroom;145;145;144;145;145;146;145;145;145;145 06:08:48 INFO - PROCESS | 7904 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;95;96 06:08:48 INFO - PROCESS | 7904 | |8;json-parse-financial;58;58;58;57;57;58;58;75;56;55 06:08:48 INFO - PROCESS | 7904 | |9;json-stringify-tinderbox;63;63;62;62;62;62;62;62;61;62 06:08:48 INFO - PROCESS | 7904 | |10;stanford-crypto-aes;78;76;75;75;77;77;77;77;78;77 06:08:48 INFO - PROCESS | 7904 | |11;stanford-crypto-ccm;125;131;124;125;120;122;126;124;158;124 06:08:48 INFO - PROCESS | 7904 | |12;stanford-crypto-pbkdf2;163;174;169;168;170;166;174;164;165;167 06:08:48 INFO - PROCESS | 7904 | |13;stanford-crypto-sha256-iterative;68;68;67;67;68;67;68;68;67;68 06:08:48 INFO - PROCESS | 7904 | __end_tp_report 06:08:48 INFO - PROCESS | 7904 | __start_cc_report 06:08:48 INFO - PROCESS | 7904 | _x_x_mozilla_cycle_collect,1603 06:08:48 INFO - PROCESS | 7904 | __end_cc_report 06:08:48 INFO - PROCESS | 7904 | __startTimestamp1460812128603__endTimestamp 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | ------- Summary: start ------- 06:08:48 INFO - PROCESS | 7904 | Number of tests: 14 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.50 stddev:4.64 (4.1%) stddev-sans-first:4.92 06:08:48 INFO - PROCESS | 7904 | Values: 110.0 111.0 106.0 111.0 112.0 113.0 99.0 111.0 114.0 115.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:154.00 stddev:21.57 (14.0%) stddev-sans-first:22.79 06:08:48 INFO - PROCESS | 7904 | Values: 156.0 128.0 160.0 190.0 134.0 152.0 152.0 128.0 178.0 129.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 06:08:48 INFO - PROCESS | 7904 | Values: 163.0 161.0 162.0 162.0 160.0 162.0 160.0 161.0 163.0 161.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#3] audio-fft Cycles:10 Average:90.00 Median:73.50 stddev:22.74 (30.9%) stddev-sans-first:23.27 06:08:48 INFO - PROCESS | 7904 | Values: 73.0 74.0 99.0 131.0 74.0 76.0 72.0 122.0 106.0 73.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.50 stddev:28.55 (30.9%) stddev-sans-first:29.50 06:08:48 INFO - PROCESS | 7904 | Values: 92.0 93.0 152.0 93.0 92.0 93.0 151.0 92.0 93.0 152.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:08:48 INFO - PROCESS | 7904 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 06:08:48 INFO - PROCESS | 7904 | Values: 145.0 145.0 144.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:08:48 INFO - PROCESS | 7904 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 96.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.00 stddev:5.72 (9.9%) stddev-sans-first:6.05 06:08:48 INFO - PROCESS | 7904 | Values: 58.0 58.0 58.0 57.0 57.0 58.0 58.0 75.0 56.0 55.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 06:08:48 INFO - PROCESS | 7904 | Values: 63.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:77.00 stddev:1.06 (1.4%) stddev-sans-first:1.01 06:08:48 INFO - PROCESS | 7904 | Values: 78.0 76.0 75.0 75.0 77.0 77.0 77.0 77.0 78.0 77.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.00 stddev:10.95 (8.8%) stddev-sans-first:11.56 06:08:48 INFO - PROCESS | 7904 | Values: 125.0 131.0 124.0 125.0 120.0 122.0 126.0 124.0 158.0 124.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:3.83 (2.3%) stddev-sans-first:3.61 06:08:48 INFO - PROCESS | 7904 | Values: 163.0 174.0 169.0 168.0 170.0 166.0 174.0 164.0 165.0 167.0 06:08:48 INFO - PROCESS | 7904 | 06:08:48 INFO - PROCESS | 7904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:08:48 INFO - PROCESS | 7904 | Values: 68.0 68.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 68.0 06:08:48 INFO - PROCESS | 7904 | -------- Summary: end -------- 06:08:48 INFO - PROCESS | 7904 | 06:08:49 INFO - TEST-INFO | 7904: exit 0 06:08:49 INFO - TEST-OK | kraken | took 61680ms 06:08:49 INFO - SUITE-END | took 1174s 06:08:49 INFO - Completed test suite (00:19:34) 06:08:49 INFO - javascript benchmark 06:08:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.71084746949, 3085.197848559377, 3121.3445176512932, 3124.047165614488, 3150.133713228862, 5220.973895130529, 5282.471752824716, 5319.601029922752, 5341.4658534146565, 5342.412334643186, 5229.921551176726, 5283.577313814885, 5338.706371149595, 5341.4925582069645, 5368.651037682557, 4743.928841067387, 4751.64362672801, 4756.405449318835, 4771.689840160396, 4930.901381972359, 4849.199882019462, 4881.511848815107, 4896.583790377822, 4899.779509922044, 4919.680220785655, 4699.177643912319, 4702.952970470303, 4732.124556956974, 4762.119007983534, 4888.120138375091, 4738.976305118486, 4743.620510359197, 4755.286706993944, 4757.643176761757, 4792.065547218293, 4686.742229177394, 4720.787564559569, 4722.055588882237, 4740.834070807505, 4760.95239047612, 5054.090263752523, 5097.337346145015, 5175.430702622709, 5220.6084543659, 5227.634065615409, 5483.424240454735, 5499.450054994509, 5509.696966666832, 5513.751881165357, 5521.889562208774, 5444.537214336786, 5558.221848941152, 5558.555315574744, 5562.360328562227, 5580.107182850725, 5281.894362112775, 5313.442088580682, 5334.119870221448, 5363.544098751572, 5376.650517716336, 5828.6211396259105, 5828.795992140254, 5834.27071616048, 5835.35811060783, 5870.354261031283, 5341.86645333862, 5508.504234618904, 5589.888202236014, 5594.9720251398485, 5605.467480589419, 5596.412376700469, 5608.775648973995, 5612.158176273591, 5614.270144881221, 5667.376588575254, 5571.442855714477, 5583.720813959367, 5595.7481913313995, 5596.104623260258, 5598.3282006159525, 5513.007658621486, 5560.221568980346, 5578.330600327987, 5597.244372009808, 5634.577406694514, 4291.892702682396, 4293.549177336335, 4318.892027699333, 4324.135172965357, 4338.891527711832, 3814.3515602347666, 3831.7700937943814, 3836.9808150959066, 3867.690584753213, 3872.8838134855437, 5149.510796474329, 5155.32980712505, 5274.5780337572905, 5313.229581710631, 5333.359996800331, 5569.053260945649, 5585.888282234414, 5591.944080559224, 5592.748326325325, 5626.35296940857, 5256.868578285497, 5260.079486089919, 5264.15773476242, 5274.657147285414, 5302.522772950453, 4739.099571081483, 4819.228923372314, 4830.0, 4830.3479030331155, 4893.388326459192, 5774.942250577525, 5788.855278618068, 5789.681567513827, 5822.563307751935, 5858.472737453564, 5594.832155035356, 5602.355729091207, 5604.299462567179, 5611.579131565068, 5614.606977511535, 5661.0, 5801.071828507418, 5811.593188476766, 5898.35118136996, 5914.615549989237, 5396.568274537949, 5400.459954004568, 5403.459654034565, 5411.648242864201, 5457.235986961749, 5457.0, 5506.201600767947, 5516.751746171351, 5545.3622833374675, 5548.0845660465575, 5408.37803652585, 5541.9168712470155, 5583.637063590853, 5591.720413979366, 5635.408282130317, 5279.366476022902, 5342.0, 5344.091504444176, 5353.518183363516, 5370.677759334452, 5225.451327610546, 5233.738313084406, 5271.103912334989, 5299.5760339172, 5309.681419114865, 5487.478689524489, 5509.090999984957, 5527.613067085265, 5546.694931778791, 5553.361363443094, 5477.808276710296, 5485.451454854483, 5487.286652735119, 5494.313210848644, 5497.285352904097], "value": 5166.895482652226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.9372165922578, 630.9463695585875, 646.9385408386202, 649.8245473722095, 658.1444122640569, 28806.279843003937, 38383.42424863629, 38605.0, 38711.225775484505, 38749.225015499745, 39503.0, 40010.799946000305, 40327.16891895265, 40479.79760101195, 40482.0, 7276.199618042011, 8408.369372297071, 8603.870941935877, 8606.35452341077, 8613.741587752378, 7290.671919763597, 7403.62981850908, 7404.1855395906405, 10279.537420816081, 10506.68479945599, 10117.747056323577, 10232.027957344078, 10259.230557708164, 10260.179185665167, 10266.12737917278, 7417.109946806364, 10152.593896244141, 10225.38647681134, 10241.12950399217, 10251.692449226535, 10159.746006349826, 10411.479426028669, 10427.217958653131, 10427.374357538572, 10437.843432348522, 36874.0, 37449.43825842615, 37659.435108473124, 37687.246255074744, 37712.43431348532, 3437.020449171974, 3524.4537096750046, 3809.5047643806406, 4126.773027483488, 4155.252054630166, 30597.38805223883, 31450.0, 31538.684613154033, 31616.0, 31787.0, 3787.1478917243676, 3797.468354430382, 3824.0, 3903.3364328064013, 3934.5278566572197, 311675.0, 314044.99999999773, 314840.0, 314879.0, 316520.0, 59593.404065958784, 59909.70045149746, 60143.69928150419, 60244.0, 60305.39694602998, 63117.0, 64014.359856401774, 64073.0, 64179.35820641827, 64208.67895660585, 14711.190884501455, 15062.096274223582, 15079.924600377148, 15080.321385537678, 15103.244837758288, 10894.128469722404, 10938.179636527293, 10961.616343427942, 10972.561097556008, 10976.670699879016, 18356.17397217102, 18419.81580184181, 18433.90783046103, 18948.526286842938, 19143.329983450792, 6673.332666733288, 6720.193576770819, 6747.730090796412, 6888.965555172192, 6981.127359080115, 1029.2229366827996, 1082.9224921203454, 1127.9266847654876, 1142.6743378137191, 1177.3289225141586, 32558.511622325685, 32680.509792353132, 32717.67282327194, 33182.170445738564, 33960.150996224795, 1117.541807858774, 1152.3431643963029, 1154.1689983212075, 1208.7703336366062, 1249.9875001250052, 16717.916410418115, 17566.308527930887, 17568.121593920252, 17643.470695879143, 17794.46616601504, 415228.0, 526770.0, 537455.0, 543146.0, 544124.0, 57301.713491432274, 58205.41794582, 58550.0, 58582.707086464296, 58956.705216474504, 1276.6489215465635, 1400.985990140106, 1419.198153043527, 1441.4810668159455, 1492.44779431611, 29557.0, 31899.0, 31935.84032079825, 31985.520217196296, 32192.35615287728, 42984.78507607567, 43677.78161109174, 43833.56166438422, 43882.780586096866, 43914.12171756611, 293909.0, 299746.0, 302734.0, 303431.0, 304001.0, 25007.74992250054, 28585.0, 28593.14220573386, 28990.7100928988, 29011.27471813137, 41893.37159942542, 42183.578164217965, 43178.56821431871, 43244.13511729685, 48234.75882620705, 37088.07279818026, 38864.6113538861, 38974.0, 39539.0, 40113.79943100383, 39548.0, 39638.2072358557, 40118.598814011486, 40353.79823100866, 40604.0, 38323.425148622235, 38700.0, 38789.41815872708, 39368.0, 39472.802635986634, 33637.38721981615, 34232.486512701835, 35361.469577956865, 35645.0, 35951.820240898625, 27700.8614956932, 27905.16284511468, 27939.0, 28088.0, 28148.85925570441], "value": 19516.998722316315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.83508212247335, 384.8402912791192, 391.3034798059454, 392.9882103536895, 400.9158076803871, 14066.507672231473, 16723.16384180792, 17157.227924743383, 18361.63276734466, 18810.52973675657, 17092.572685682833, 17272.654546909056, 17723.29106835725, 17733.113344332764, 19117.522061948424, 5503.174523821429, 5630.971845140769, 5655.688937108457, 5675.404082571333, 5680.289963754531, 5466.453354664522, 5625.5218306444, 5638.4361563843495, 5643.8024669136585, 5671.8014869479575, 5422.48486393794, 5555.055640541097, 5591.944080559183, 5601.579881508883, 5622.91565626516, 5439.864003399907, 5490.627343164209, 5595.272614560102, 5614.326280846324, 5618.747156377973, 4954.975225123887, 5004.5495905368325, 5008.774605142778, 5009.048280826668, 5013.0725815723845, 21804.236851710113, 21908.23321183751, 22122.0, 22135.667964980537, 22391.552168956692, 2378.9048438062455, 2399.1003373734848, 2554.604036374365, 2613.8431694098417, 2960.703929607022, 13788.793168102486, 13889.166650001032, 13950.23273719945, 13966.371513281927, 14457.855421445862, 1887.6036032433205, 1907.1131923655428, 1964.1946801811332, 1988.1053525913396, 1988.7812340642517, 75135.24864751338, 76223.0, 76461.0, 76503.0, 77236.61381693055, 9910.405375677483, 10210.948945255375, 10433.791324173626, 10518.421486818146, 10635.787284254271, 14397.0, 14401.927990359982, 14459.0, 14493.855061449462, 14499.130052196902, 7590.8102297443, 7623.912315512226, 7690.2694244046725, 7702.460827742117, 7716.498427602188, 7092.6099064551945, 7162.892556611655, 7255.782326530212, 7272.454565907578, 7274.127104747358, 6225.533085018642, 6266.843328916722, 6425.228972523327, 6444.548881578245, 6458.257300410513, 1768.9646207076044, 1862.4040307101598, 1871.8315351618419, 1880.6520793653217, 1881.7177423386602, 470.22882472744726, 471.27659043368266, 872.6422166911663, 1051.8211903976342, 1068.2308737708838, 11229.438528073564, 11634.185607007428, 11683.649490515298, 18680.7197892029, 19640.607187856163, 1002.9348092373972, 1009.0284113286448, 1020.505055048301, 1025.9897401025894, 1072.5066469423996, 10220.284580079471, 10253.179745620333, 10599.470026498644, 10630.521626526825, 10653.84019239712, 504988.0, 508259.0, 509308.0, 511512.0, 529775.0, 88816.0, 90465.57206567627, 90777.54611226902, 91555.0, 92349.53825230831, 1070.063694267516, 1077.138289368502, 1094.600470828142, 1118.6867677050438, 1122.7698321844002, 16321.265543050355, 16523.091229982467, 16563.254653540378, 16771.91614041922, 17013.064281464638, 30990.0, 38138.61861381351, 38271.0, 38411.2317753649, 39270.80364598273, 51388.0, 54457.45542544524, 55647.0, 55650.16524752213, 56065.0, 8300.501969881827, 8418.831623367621, 8525.317974562144, 8613.09562495929, 8735.956320218358, 11969.581064662694, 12567.30879801583, 12799.680007999874, 13462.326883655582, 13527.188368697909, 11467.942660286646, 11616.5353385867, 11628.94185529067, 11724.120690948042, 12029.097817663534, 5620.550355971431, 10365.341545352707, 10739.892601074202, 10927.508262128064, 11014.59381381706, 12176.147669663038, 12254.387280635754, 12337.198082124632, 12435.626931192079, 12504.437300321326, 8419.8737018946, 8472.0, 8734.301255899385, 8736.956315218384, 8811.823763524822, 11883.940580297389, 11949.701257468285, 12020.398980050788, 12043.156979011384, 12270.692004732182], "value": 9001.125893975559, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.256879862878, 1479.956630575444, 1527.1142737212417, 1633.7386018237084, 1777.3246166456752, 7488.288612581803, 7744.806379840493, 7747.186545412735, 7762.961185194066, 7778.8833167502535, 7680.462367634268, 7833.451658383916, 7844.568548729818, 7847.607619619011, 7848.175941526143, 1838.7793464784245, 2065.0500769645982, 2085.4577809769457, 2116.33335499318, 2117.375374264588, 2030.6649402848511, 2037.7147199392098, 2054.4452997690614, 2060.6393881070826, 2062.2060506704875, 2002.0990554250645, 2023.8380929525604, 2052.4560991337307, 2054.435030366646, 2058.989705051473, 1965.2924947019062, 1989.7413336266193, 1997.4407165993473, 2000.4298774849244, 2008.8794672319634, 2006.9197232110698, 2008.5179556906382, 2028.3205126282712, 2032.5934813037452, 2034.7761746207905, 7984.281414672707, 8056.234657707509, 8057.5165490070785, 8070.112287648354, 8071.596420179027, 4676.883077923045, 4815.0, 4839.540243676845, 4861.73260470674, 4865.683730557503, 2560.7823335016546, 3003.57949887016, 3258.8859389921477, 3267.836608169582, 3286.227736481949, 1056.9894301057045, 1062.914966802654, 1091.8143915534379, 1104.2932523185168, 1136.9147313951487, 10028.448435336053, 10068.597256109746, 10080.092791648713, 10084.647037353658, 10132.442715650635, 4025.335819589735, 4137.586241375839, 4154.584541545822, 4292.678049146264, 4322.200392927319, 8558.486490810572, 8823.426477278956, 8906.510141942255, 8909.910900891038, 8912.73261802147, 4781.665283430127, 4784.784684689197, 4799.832005879777, 4802.591779698695, 4810.5670489656095, 4438.467383913951, 4448.288273876165, 4486.528914463999, 4499.595036446735, 4517.683762136685, 3502.4746288056485, 3551.698105660996, 3606.5393515625688, 3688.3176612326806, 3711.4432835074954, 1207.2032458577473, 1224.179799534314, 1225.136278923357, 1230.5139469909336, 1237.3565745812127, 995.1143482300758, 996.923322811362, 1009.2733232072895, 1010.3735683875897, 1032.5043978890176, 5750.367459579443, 5780.132980053026, 5789.565782566325, 5791.478766910998, 5953.196318497034, 408.77925920002866, 415.142730262008, 421.084141991168, 421.4037137450473, 423.66107114309045, 3941.165378087904, 4069.267531844237, 4116.835326586903, 4123.36087906375, 4169.937450938239, 8908.599113039929, 9354.251659867194, 9676.177524910461, 10043.598256069821, 10117.949410253048, 9599.184069354043, 9629.229661627052, 9649.710508684751, 9705.641210230573, 9727.367721098106, 7148.820444626578, 7239.674214660353, 7264.346208841124, 7292.817679558054, 7366.263373662698, 5489.451054894478, 5534.169874518693, 5548.278723765885, 5589.804356847653, 5713.0, 8493.0, 8737.269963831239, 8909.331800115147, 8921.241694455784, 8964.193222609996, 8885.91114088851, 9193.494357810385, 9217.815643687223, 9227.815443691223, 9240.95379523098, 7051.330123638246, 7068.6112263823925, 7136.964315178391, 7149.285071492809, 7164.641767911479, 7796.727114550963, 7803.882941755992, 7874.05511338643, 7886.290233878978, 7889.723859664884, 7086.255943125898, 7093.467989900882, 7186.0, 7212.819679508054, 7250.20247772734, 7025.578465292099, 7043.894341584983, 7122.85754284901, 7204.675789589586, 7235.963820180866, 6604.174478190226, 6651.235107962646, 6688.398044176048, 6702.329767023259, 6702.83242918931, 4931.3589233399425, 5070.898582028412, 5120.743962801919, 5150.562202212854, 5175.689458632494, 5116.411612664442, 5129.153689641167, 5263.921041184309, 5286.7356632169, 5302.840914772563], "value": 4178.148577563868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.4369940003793, 328.4629630554045, 329.76257094891685, 332.2043705325745, 337.10162417158244, 5507.146392309189, 5598.972005139969, 5602.8319150425505, 5607.887842243153, 5610.298712660918, 5519.917201241985, 5524.640898341615, 5524.972375138119, 5525.972370138144, 5549.639273447223, 4073.5926407359248, 4134.6692264618905, 4253.744775313491, 4275.422817919588, 4291.3777502262155, 4265.210935976838, 4303.462067241595, 4316.6546676265825, 4321.783910804463, 4336.176126535964, 4115.0, 4301.913961720764, 4306.806193721274, 4314.417553630251, 4320.719153255029, 3967.1867267210155, 4218.219629368561, 4262.744235345858, 4304.268274393329, 4311.310190369526, 3781.5840257571645, 3782.111203867089, 3788.337041017811, 3817.5609804872515, 3822.4075268333454, 5263.894722105575, 5346.465353464661, 5349.331333583302, 5372.0, 5376.327959005124, 4872.098661747553, 4918.163912134945, 4945.7774400152075, 4951.480094590052, 4963.751812409365, 5713.942860571424, 5749.913751293734, 5759.128283307941, 5800.187973683687, 5858.150568167592, 4100.667283132964, 4191.972966623197, 4199.454070970784, 4200.663946884242, 4204.726692764991, 6087.452129308339, 6112.419320164578, 6127.632342059446, 6129.816105516842, 6137.0, 4233.5131459882505, 4283.764392958417, 4295.334223195409, 4301.118270754488, 4306.569343065668, 4210.5578914214175, 4291.442112525414, 4314.201872653506, 4319.913601727948, 4324.524302326741, 4866.1727506323305, 4910.189818679878, 4915.508449155127, 4926.729029903318, 4950.356453661001, 5818.5636077294375, 5822.970885145632, 5829.038208695602, 5835.35811060783, 5860.208871802337, 1397.916125032481, 1493.2160615676858, 1518.7266292067534, 1524.5502576739889, 1526.6107142678545, 911.7857303533664, 960.7598100474881, 964.4647220792388, 968.5786682793008, 1023.3961962442195, 5521.033819081645, 5533.667979921218, 5546.084895992197, 5603.859903502445, 5615.831525054255, 5985.6408615483215, 5985.910211346833, 5994.790182343597, 5999.910001349983, 6001.909971350433, 5481.698506582096, 5563.332400111932, 5595.776168953196, 5603.35561410443, 5606.074997625427, 3147.2289289123855, 3174.2540502981783, 3205.743540516753, 3206.1824234820438, 3206.454902666506, 6039.0, 6160.784372546939, 6166.7224974876235, 6167.660778657217, 6180.381961803873, 6079.145860512586, 6094.299155597075, 6096.9390306096375, 6109.983705377215, 6112.113743507255, 6170.475509581646, 6173.259208894961, 6175.228096487939, 6183.907241391383, 6191.380861913863, 5782.942170578241, 5963.821085367446, 5974.551908606785, 5990.281166260077, 6015.6691381974415, 5826.533877289891, 5846.6784326862435, 5867.765289388377, 5877.735501902339, 5909.320428150646, 5975.970120149372, 6074.271087469532, 6102.359252278625, 6102.420270074336, 6128.701736848681, 4308.784560772012, 4327.091310824762, 4332.350147477903, 4337.5011873633675, 4341.934870976875, 5909.320428150646, 5934.228550288435, 5939.406059394199, 5939.4357536034, 5950.672713000653, 5556.0, 5762.193292939076, 5790.060329789568, 5853.326867410302, 5863.091220860773, 5813.505852002627, 5822.243108395882, 5828.6502809831545, 5834.795782147605, 5837.6497410155525, 5348.705821179872, 5535.0, 5737.397573254748, 5739.110437881968, 5745.8563535911935, 5841.707914604338, 5932.139839723302, 5996.2504686914135, 5998.1002849572915, 6008.429199226067, 5766.452187042224, 5795.7971471, 5837.883242335214, 5843.532517398683, 5851.970740146272], "value": 4427.771063690797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.748952845561, 797.7686470923433, 806.4153488720676, 834.9415540912134, 840.0759164918586, 14401.855981440196, 14893.77659335111, 14917.0, 14918.17950012749, 14960.476383326572, 13498.93250533746, 13534.796978045337, 13600.455981760742, 13821.447142114328, 13861.861381386183, 651.244556314675, 807.9232472915093, 814.8655471847153, 825.1500954017372, 828.4863384701493, 783.189398972064, 813.3777660090036, 826.3513142183388, 827.2802661684343, 827.4249396669318, 807.9878801817978, 855.5722138930535, 860.9569521523899, 866.7746385939638, 868.2055918834259, 681.8363592737757, 811.4644334739073, 836.4521238588734, 851.1998721202082, 853.0658928473312, 620.3672254300589, 623.510544222783, 628.8239292997968, 629.2417636747708, 629.8299459146051, 13908.721825563433, 13911.095778774346, 13916.0, 13925.721485570231, 13934.233617151052, 13839.515616953458, 14354.712905741932, 14484.927575362055, 14549.854501454956, 14590.124592524482, 11054.668359949215, 11388.202825802196, 11398.487068081957, 11561.364124973123, 11568.190226684135, 3848.1918797052654, 3875.8643447479485, 3878.9224215515815, 3932.0956180078456, 4000.0, 51939.48060519384, 52236.21645675318, 53314.20028699573, 53666.19500707492, 53825.73087134578, 11037.889621103686, 11045.723856903642, 11124.332540047622, 11166.0, 11201.775964480665, 19480.123394447284, 19632.70550941737, 19682.50793730168, 19896.70154947677, 19899.0, 7395.297446742551, 7552.433567482461, 7632.847343053108, 7818.3354414875375, 8068.233517815798, 4811.4707382187935, 4884.12085824555, 4909.361782968192, 4912.606991440676, 4975.154223781966, 3254.7558933080113, 3332.983335083309, 3333.6499667535045, 3337.132345590164, 3341.114604629775, 577.0680351232729, 582.4234008331721, 600.570592026703, 604.1994357476361, 669.2504395077447, 730.817295676081, 736.7716008037526, 744.3784439992559, 749.1272667342594, 749.2133260076897, 8704.909757036288, 9506.762330941643, 9551.188149007412, 9780.364276322016, 9922.900770992197, 587.3421767620207, 596.5198015597485, 643.9195100612424, 705.9058459387928, 735.3528894572742, 4197.874063778091, 4420.8673739787855, 4463.375127482155, 4521.796519156645, 4535.909281814411, 49137.508624913295, 61347.38652613417, 62136.68931655403, 62509.0, 62752.0, 44526.77736611296, 44955.77522112369, 45077.0, 46982.0, 49513.75243123761, 40051.99870003273, 43440.348394774104, 43656.3451548227, 43925.12149757051, 44779.0, 8908.73273801787, 9146.961512324218, 9169.908300917172, 9231.0, 9269.536523173949, 31153.0, 31420.0, 31962.52056219112, 32064.519032215, 32443.837780810944, 38602.6139738599, 39190.216195675355, 41783.373249400676, 42523.1495370097, 42781.0, 11137.387443690675, 11211.271267367594, 11738.70653233676, 12003.699907502383, 12312.0, 13222.537211197561, 13496.392662330023, 13516.662083447993, 13800.93099534496, 14699.779503307245, 12523.0, 12821.487140514275, 12902.225866448043, 12904.870951290366, 12907.419166137359, 11978.04175665962, 12113.75772484563, 12153.513859445524, 12386.0, 12809.295488748208, 13097.934510327388, 13372.398242079324, 13497.190168589916, 13756.724865502434, 13789.310534473036, 10524.105451036748, 10840.403777792297, 10843.945780271048, 11041.687394289062, 11428.71428214268, 10378.221633377376, 10903.618373356894, 11395.943020285176, 11603.883961160618, 11626.767464650491], "value": 6655.49955871549, "unit": "score"}], "name": "dromaeo_css", "value": 6940.47621456928, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 111.0, 112.0, 113.0, 99.0, 111.0, 114.0, 115.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 160.0, 190.0, 134.0, 152.0, 152.0, 128.0, 178.0, 129.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 160.0, 162.0, 160.0, 161.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 99.0, 131.0, 74.0, 76.0, 72.0, 122.0, 106.0, 73.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 93.0, 92.0, 93.0, 151.0, 92.0, 93.0, 152.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 75.0, 56.0, 55.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 75.0, 77.0, 77.0, 77.0, 77.0, 78.0, 77.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 131.0, 124.0, 125.0, 120.0, 122.0, 126.0, 124.0, 158.0, 124.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 174.0, 169.0, 168.0, 170.0, 166.0, 174.0, 164.0, 165.0, 167.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1540.6999999999998, "alertThreshold": 2.0}]} 06:08:49 INFO - Return code: 0 06:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:08:49 ERROR - # TBPL SUCCESS # 06:08:49 INFO - Running post-action listener: _resource_record_post_action 06:08:49 INFO - Running post-run listener: _resource_record_post_run 06:08:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 532262912; Read time: 0; Write time: 1189712 06:08:50 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 244244480; Read time: 0; Write time: 818868 06:08:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288018432; Read time: 0; Write time: 370844 06:08:50 INFO - Running post-run listener: _upload_blobber_files 06:08:50 INFO - Blob upload gear active. 06:08:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:50 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 06:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:08:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:52 INFO - (blobuploader) - INFO - Done attempting. 06:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:52 INFO - (blobuploader) - INFO - Done attempting. 06:08:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:52 INFO - Return code: 0 06:08:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba4542fd2e8c232c4717c3e122117bbd1113adb6da34923a75a64a2452d3e9e6f945c23ae3079baec7ef32ad9d8982c645dbc52ab012d7246c98418345087a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c82fc698111b5f15253e584c40737b8f820505428e7a0bbf46507a9f34720f93ca33a843b0fabdf993fd973d72ec46c73e63ebac448d050b8b9e229911ce0d"} 06:08:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:52 INFO - Contents: 06:08:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba4542fd2e8c232c4717c3e122117bbd1113adb6da34923a75a64a2452d3e9e6f945c23ae3079baec7ef32ad9d8982c645dbc52ab012d7246c98418345087a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c82fc698111b5f15253e584c40737b8f820505428e7a0bbf46507a9f34720f93ca33a843b0fabdf993fd973d72ec46c73e63ebac448d050b8b9e229911ce0d"} 06:08:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:52 INFO - Copying logs to upload dir... 06:08:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.291285 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-16 06:08:52.223535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 06:08:52.227732) ========= 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=df17445c3590ff7897617a0e00000225-1460809304.207617-399045168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba4542fd2e8c232c4717c3e122117bbd1113adb6da34923a75a64a2452d3e9e6f945c23ae3079baec7ef32ad9d8982c645dbc52ab012d7246c98418345087a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c82fc698111b5f15253e584c40737b8f820505428e7a0bbf46507a9f34720f93ca33a843b0fabdf993fd973d72ec46c73e63ebac448d050b8b9e229911ce0d"} build_url:https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/b7bT7cJ3RoGAvBAQC_8mmw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ba4542fd2e8c232c4717c3e122117bbd1113adb6da34923a75a64a2452d3e9e6f945c23ae3079baec7ef32ad9d8982c645dbc52ab012d7246c98418345087a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c82fc698111b5f15253e584c40737b8f820505428e7a0bbf46507a9f34720f93ca33a843b0fabdf993fd973d72ec46c73e63ebac448d050b8b9e229911ce0d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 06:08:52.252738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:08:52.253118) ========= 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=df17445c3590ff7897617a0e00000225-1460809304.207617-399045168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004350 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:08:52.336055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 06:08:52.336408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 06:08:52.336747) ========= ========= Total master_lag: 0.17 =========