builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1456745546.69 results: success (0) buildid: 20160229021614 builduid: d5cbe761dc354e12914fd85bf1aa64ca revision: 4972f77869de55becd41d6b726b25fca2f523232 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.694923) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.695268) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.695537) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009155 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.718813) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.719075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.742269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.742523) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.927000) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.927272) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.927592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:26.927853) ========= 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 03:32:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2016-02-29 03:32:27 (34.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104626 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.056781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.057236) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019474 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.116706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.117013) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4972f77869de55becd41d6b726b25fca2f523232 --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 4972f77869de55becd41d6b726b25fca2f523232 --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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 03:32:28,070 truncating revision to first 12 chars 2016-02-29 03:32:28,070 Setting DEBUG logging. 2016-02-29 03:32:28,070 attempt 1/10 2016-02-29 03:32:28,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4972f77869de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 03:32:28,431 unpacking tar archive at: mozilla-central-4972f77869de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.821598) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.821891) ========= echo 4972f77869de55becd41d6b726b25fca2f523232 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4972f77869de55becd41d6b726b25fca2f523232'] 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4972f77869de55becd41d6b726b25fca2f523232 program finished with exit code 0 elapsedTime=0.003814 script_repo_revision: '4972f77869de55becd41d6b726b25fca2f523232' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.870797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.871094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 03:32:27.889757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-02-29 03:32:27.890015) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:28 INFO - MultiFileLogger online at 20160229 03:32:28 in /builds/slave/test 03:32:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:32:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:28 INFO - {'append_to_log': False, 03:32:28 INFO - 'base_work_dir': '/builds/slave/test', 03:32:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:32:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:28 INFO - 'branch': 'Firefox-Non-PGO', 03:32:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:28 INFO - 'config_files': ('talos/linux_config.py',), 03:32:28 INFO - 'default_actions': ('clobber', 03:32:28 INFO - 'read-buildbot-config', 03:32:28 INFO - 'download-and-extract', 03:32:28 INFO - 'populate-webroot', 03:32:28 INFO - 'create-virtualenv', 03:32:28 INFO - 'install', 03:32:28 INFO - 'run-tests'), 03:32:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:28 INFO - 'download_minidump_stackwalk': True, 03:32:28 INFO - 'download_symbols': 'ondemand', 03:32:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:28 INFO - 'installer_path': 'installer.exe', 03:32:28 INFO - 'log_level': 'info', 03:32:28 INFO - 'log_name': 'talos', 03:32:28 INFO - 'log_to_console': True, 03:32:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:28 INFO - 'opt_config_files': (), 03:32:28 INFO - 'pip_index': False, 03:32:28 INFO - 'sps_profile': False, 03:32:28 INFO - 'sps_profile_interval': 0, 03:32:28 INFO - 'suite': 'dromaeojs', 03:32:28 INFO - 'system_bits': '32', 03:32:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:28 INFO - 'title': 'talos-linux64-ix-053', 03:32:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:28 INFO - 'use_talos_json': True, 03:32:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:28 INFO - 'work_dir': 'build'} 03:32:28 INFO - ##### 03:32:28 INFO - ##### Running clobber step. 03:32:28 INFO - ##### 03:32:28 INFO - Running pre-action listener: _resource_record_pre_action 03:32:28 INFO - Running main action method: clobber 03:32:28 INFO - rmtree: /builds/slave/test/build 03:32:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:29 INFO - Running post-action listener: _resource_record_post_action 03:32:29 INFO - ##### 03:32:29 INFO - ##### Running read-buildbot-config step. 03:32:29 INFO - ##### 03:32:29 INFO - Running pre-action listener: _resource_record_pre_action 03:32:29 INFO - Running main action method: read_buildbot_config 03:32:29 INFO - Using buildbot properties: 03:32:29 INFO - { 03:32:29 INFO - "project": "", 03:32:29 INFO - "product": "firefox", 03:32:29 INFO - "script_repo_revision": "production", 03:32:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:32:29 INFO - "repository": "", 03:32:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:32:29 INFO - "buildid": "20160229021614", 03:32:29 INFO - "pgo_build": "False", 03:32:29 INFO - "basedir": "/builds/slave/test", 03:32:29 INFO - "buildnumber": 0, 03:32:29 INFO - "slavename": "talos-linux64-ix-053", 03:32:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:32:29 INFO - "platform": "ubuntu64_hw", 03:32:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:32:29 INFO - "branch": "mozilla-central", 03:32:29 INFO - "repo_path": "mozilla-central", 03:32:29 INFO - "revision": "4972f77869de55becd41d6b726b25fca2f523232", 03:32:29 INFO - "stage_platform": "linux64", 03:32:29 INFO - "builduid": "d5cbe761dc354e12914fd85bf1aa64ca", 03:32:29 INFO - "slavebuilddir": "test" 03:32:29 INFO - } 03:32:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 03:32:29 INFO - Running post-action listener: _resource_record_post_action 03:32:29 INFO - ##### 03:32:29 INFO - ##### Running download-and-extract step. 03:32:29 INFO - ##### 03:32:29 INFO - Running pre-action listener: _resource_record_pre_action 03:32:29 INFO - Running main action method: download_and_extract 03:32:29 INFO - mkdir: /builds/slave/test/build/tests 03:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:29 INFO - https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/test_packages.json 03:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/test_packages.json 03:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:32:32 INFO - Downloaded 1448 bytes. 03:32:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:32:32 INFO - Using the following test package requirements: 03:32:32 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:32:32 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:32 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:32:32 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'jsshell-linux-x86_64.zip'], 03:32:32 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:32 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:32:32 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:32:32 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:32:32 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:32 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:32:32 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:32 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:32 INFO - https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:33 INFO - Downloaded 22056935 bytes. 03:32:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:34 INFO - Return code: 0 03:32:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:34 INFO - https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:37 INFO - Downloaded 22056935 bytes. 03:32:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:38 INFO - Return code: 0 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:39 INFO - Downloaded 10713410 bytes. 03:32:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:39 INFO - Return code: 0 03:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:39 INFO - https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:42 INFO - Downloaded 54837790 bytes. 03:32:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:32:42 INFO - mkdir: /builds/slave/test/properties 03:32:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:42 INFO - Contents: 03:32:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:32:43 INFO - Running post-action listener: _resource_record_post_action 03:32:43 INFO - Running post-action listener: set_extra_try_arguments 03:32:43 INFO - ##### 03:32:43 INFO - ##### Running populate-webroot step. 03:32:43 INFO - ##### 03:32:43 INFO - Running pre-action listener: _resource_record_pre_action 03:32:43 INFO - Running main action method: populate_webroot 03:32:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:43 INFO - '--tppagecycles', 03:32:43 INFO - '7'], 03:32:43 INFO - 'tests': ['tsvgm']}}, 03:32:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:32:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:32:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'tests': ['damp', 'tps']}, 03:32:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['damp', 'tps']}, 03:32:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:32:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:43 INFO - 'other': {'tests': ['a11yr', 03:32:43 INFO - 'ts_paint', 03:32:43 INFO - 'tpaint', 03:32:43 INFO - 'sessionrestore', 03:32:43 INFO - 'sessionrestore_no_auto_restore']}, 03:32:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['a11yr', 03:32:43 INFO - 'ts_paint', 03:32:43 INFO - 'tpaint', 03:32:43 INFO - 'sessionrestore', 03:32:43 INFO - 'sessionrestore_no_auto_restore']}, 03:32:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['a11yr', 03:32:43 INFO - 'ts_paint', 03:32:43 INFO - 'tpaint', 03:32:43 INFO - 'sessionrestore', 03:32:43 INFO - 'sessionrestore_no_auto_restore']}, 03:32:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['a11yr', 03:32:43 INFO - 'ts_paint', 03:32:43 INFO - 'tpaint', 03:32:43 INFO - 'sessionrestore', 03:32:43 INFO - 'sessionrestore_no_auto_restore']}, 03:32:43 INFO - 'other_l64': {'tests': ['a11yr', 03:32:43 INFO - 'ts_paint', 03:32:43 INFO - 'tpaint', 03:32:43 INFO - 'sessionrestore', 03:32:43 INFO - 'sessionrestore_no_auto_restore']}, 03:32:43 INFO - 'other_nol64': {'tests': ['a11yr', 03:32:43 INFO - 'ts_paint', 03:32:43 INFO - 'tpaint', 03:32:43 INFO - 'sessionrestore', 03:32:43 INFO - 'sessionrestore_no_auto_restore']}, 03:32:43 INFO - 'svgr': {'tests': ['tsvgx', 03:32:43 INFO - 'tsvgr_opacity', 03:32:43 INFO - 'tart', 03:32:43 INFO - 'tscrollx', 03:32:43 INFO - 'cart']}, 03:32:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['tsvgx', 03:32:43 INFO - 'tsvgr_opacity', 03:32:43 INFO - 'tart', 03:32:43 INFO - 'tscrollx', 03:32:43 INFO - 'cart']}, 03:32:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'tests': ['tp5o']}, 03:32:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'talos_options': ['--e10s'], 03:32:43 INFO - 'tests': ['tp5o']}, 03:32:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'talos_options': ['--xperf_path', 03:32:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:43 INFO - 'tests': ['tp5n']}, 03:32:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:43 INFO - 'talos_options': ['--e10s', 03:32:43 INFO - '--xperf_path', 03:32:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:43 INFO - 'tests': ['tp5n']}}, 03:32:43 INFO - 'talos.zip': {'path': '', 03:32:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:43 INFO - Running post-action listener: _resource_record_post_action 03:32:43 INFO - ##### 03:32:43 INFO - ##### Running create-virtualenv step. 03:32:43 INFO - ##### 03:32:43 INFO - Running pre-action listener: _resource_record_pre_action 03:32:43 INFO - Running main action method: create_virtualenv 03:32:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:32:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:43 INFO - Using real prefix '/usr' 03:32:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:46 INFO - Installing pip.................done. 03:32:46 INFO - Return code: 0 03:32:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:32:46 INFO - Using env: {'DISPLAY': ':0', 03:32:46 INFO - 'HOME': '/home/cltbld', 03:32:46 INFO - 'LANG': 'en_US.UTF-8', 03:32:46 INFO - 'LANGUAGE': 'en_US:en', 03:32:46 INFO - 'LOGNAME': 'cltbld', 03:32:46 INFO - 'MAIL': '/var/mail/cltbld', 03:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:46 INFO - 'MOZ_NO_REMOTE': '1', 03:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:46 INFO - 'NO_EM_RESTART': '1', 03:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:46 INFO - 'PWD': '/builds/slave/test', 03:32:46 INFO - 'SHELL': '/bin/bash', 03:32:46 INFO - 'SHLVL': '1', 03:32:46 INFO - 'TERM': 'linux', 03:32:46 INFO - 'TMOUT': '86400', 03:32:46 INFO - 'USER': 'cltbld', 03:32:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:46 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:32:46 INFO - Cleaning up... 03:32:46 INFO - Return code: 0 03:32:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:32:46 INFO - Using env: {'DISPLAY': ':0', 03:32:46 INFO - 'HOME': '/home/cltbld', 03:32:46 INFO - 'LANG': 'en_US.UTF-8', 03:32:46 INFO - 'LANGUAGE': 'en_US:en', 03:32:46 INFO - 'LOGNAME': 'cltbld', 03:32:46 INFO - 'MAIL': '/var/mail/cltbld', 03:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:46 INFO - 'MOZ_NO_REMOTE': '1', 03:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:46 INFO - 'NO_EM_RESTART': '1', 03:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:46 INFO - 'PWD': '/builds/slave/test', 03:32:46 INFO - 'SHELL': '/bin/bash', 03:32:46 INFO - 'SHLVL': '1', 03:32:46 INFO - 'TERM': 'linux', 03:32:46 INFO - 'TMOUT': '86400', 03:32:46 INFO - 'USER': 'cltbld', 03:32:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:46 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Downloading/unpacking psutil>=0.7.1 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:48 INFO - Installing collected packages: psutil 03:32:48 INFO - Running setup.py install for psutil 03:32:48 INFO - building 'psutil._psutil_linux' extension 03:32:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:32:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:32:48 INFO - building 'psutil._psutil_posix' extension 03:32:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:32:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:48 INFO - Successfully installed psutil 03:32:48 INFO - Cleaning up... 03:32:48 INFO - Return code: 0 03:32:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:32:48 INFO - Using env: {'DISPLAY': ':0', 03:32:48 INFO - 'HOME': '/home/cltbld', 03:32:48 INFO - 'LANG': 'en_US.UTF-8', 03:32:48 INFO - 'LANGUAGE': 'en_US:en', 03:32:48 INFO - 'LOGNAME': 'cltbld', 03:32:48 INFO - 'MAIL': '/var/mail/cltbld', 03:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:48 INFO - 'MOZ_NO_REMOTE': '1', 03:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:48 INFO - 'NO_EM_RESTART': '1', 03:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:48 INFO - 'PWD': '/builds/slave/test', 03:32:48 INFO - 'SHELL': '/bin/bash', 03:32:48 INFO - 'SHLVL': '1', 03:32:48 INFO - 'TERM': 'linux', 03:32:48 INFO - 'TMOUT': '86400', 03:32:48 INFO - 'USER': 'cltbld', 03:32:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:48 INFO - '_': '/tools/buildbot/bin/python'} 03:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:32:50 INFO - Installing collected packages: mozsystemmonitor 03:32:50 INFO - Running setup.py install for mozsystemmonitor 03:32:51 INFO - Successfully installed mozsystemmonitor 03:32:51 INFO - Cleaning up... 03:32:51 INFO - Return code: 0 03:32:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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', '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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:32: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 blobuploader==1.2.4 03:32:51 INFO - Using env: {'DISPLAY': ':0', 03:32:51 INFO - 'HOME': '/home/cltbld', 03:32:51 INFO - 'LANG': 'en_US.UTF-8', 03:32:51 INFO - 'LANGUAGE': 'en_US:en', 03:32:51 INFO - 'LOGNAME': 'cltbld', 03:32:51 INFO - 'MAIL': '/var/mail/cltbld', 03:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:51 INFO - 'MOZ_NO_REMOTE': '1', 03:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:51 INFO - 'NO_EM_RESTART': '1', 03:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:51 INFO - 'PWD': '/builds/slave/test', 03:32:51 INFO - 'SHELL': '/bin/bash', 03:32:51 INFO - 'SHLVL': '1', 03:32:51 INFO - 'TERM': 'linux', 03:32:51 INFO - 'TMOUT': '86400', 03:32:51 INFO - 'USER': 'cltbld', 03:32:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:51 INFO - '_': '/tools/buildbot/bin/python'} 03:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:53 INFO - Downloading docopt-0.6.1.tar.gz 03:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:53 INFO - Running setup.py install for blobuploader 03:32:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:54 INFO - Running setup.py install for requests 03:32:54 INFO - Running setup.py install for docopt 03:32:54 INFO - Successfully installed blobuploader requests docopt 03:32:54 INFO - Cleaning up... 03:32:54 INFO - Return code: 0 03:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:54 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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:54 INFO - Using env: {'DISPLAY': ':0', 03:32:54 INFO - 'HOME': '/home/cltbld', 03:32:54 INFO - 'LANG': 'en_US.UTF-8', 03:32:54 INFO - 'LANGUAGE': 'en_US:en', 03:32:54 INFO - 'LOGNAME': 'cltbld', 03:32:54 INFO - 'MAIL': '/var/mail/cltbld', 03:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:54 INFO - 'MOZ_NO_REMOTE': '1', 03:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:54 INFO - 'NO_EM_RESTART': '1', 03:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:54 INFO - 'PWD': '/builds/slave/test', 03:32:54 INFO - 'SHELL': '/bin/bash', 03:32:54 INFO - 'SHLVL': '1', 03:32:54 INFO - 'TERM': 'linux', 03:32:54 INFO - 'TMOUT': '86400', 03:32:54 INFO - 'USER': 'cltbld', 03:32:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:54 INFO - '_': '/tools/buildbot/bin/python'} 03:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:54 INFO - Running setup.py (path:/tmp/pip-etHPeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:54 INFO - Running setup.py (path:/tmp/pip-3kFTwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:54 INFO - Running setup.py (path:/tmp/pip-1Xiurj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:54 INFO - Running setup.py (path:/tmp/pip-hpQAoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:55 INFO - Running setup.py (path:/tmp/pip-btXQ4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:55 INFO - Running setup.py (path:/tmp/pip-YDhzsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:55 INFO - Running setup.py (path:/tmp/pip-TNU3zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:55 INFO - Running setup.py (path:/tmp/pip-H7cwiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:55 INFO - Running setup.py (path:/tmp/pip-RQ6JcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:55 INFO - Running setup.py (path:/tmp/pip-pu6jOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:55 INFO - Running setup.py (path:/tmp/pip-7rMw2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:55 INFO - Running setup.py (path:/tmp/pip-XzSUEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:55 INFO - Running setup.py (path:/tmp/pip-cqFZRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:55 INFO - Running setup.py (path:/tmp/pip-y1KWwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:55 INFO - Running setup.py (path:/tmp/pip-rJ1oiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:55 INFO - Running setup.py (path:/tmp/pip-VOhbeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:55 INFO - Running setup.py (path:/tmp/pip-GTIoHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:55 INFO - Running setup.py install for manifestparser 03:32:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Running setup.py install for mozcrash 03:32:56 INFO - Running setup.py install for mozdebug 03:32:56 INFO - Running setup.py install for mozdevice 03:32:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Running setup.py install for mozfile 03:32:56 INFO - Running setup.py install for mozhttpd 03:32:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Running setup.py install for mozinfo 03:32:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Running setup.py install for mozInstall 03:32:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Running setup.py install for mozleak 03:32:56 INFO - Running setup.py install for mozlog 03:32:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:56 INFO - Running setup.py install for moznetwork 03:32:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:57 INFO - Running setup.py install for mozprocess 03:32:57 INFO - Running setup.py install for mozprofile 03:32:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:57 INFO - Running setup.py install for mozrunner 03:32:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:57 INFO - Running setup.py install for mozscreenshot 03:32:57 INFO - Running setup.py install for moztest 03:32:57 INFO - Running setup.py install for mozversion 03:32:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:57 INFO - Cleaning up... 03:32:57 INFO - Return code: 0 03:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:57 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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:57 INFO - Using env: {'DISPLAY': ':0', 03:32:57 INFO - 'HOME': '/home/cltbld', 03:32:57 INFO - 'LANG': 'en_US.UTF-8', 03:32:57 INFO - 'LANGUAGE': 'en_US:en', 03:32:57 INFO - 'LOGNAME': 'cltbld', 03:32:57 INFO - 'MAIL': '/var/mail/cltbld', 03:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:57 INFO - 'MOZ_NO_REMOTE': '1', 03:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:57 INFO - 'NO_EM_RESTART': '1', 03:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:57 INFO - 'PWD': '/builds/slave/test', 03:32:57 INFO - 'SHELL': '/bin/bash', 03:32:57 INFO - 'SHLVL': '1', 03:32:57 INFO - 'TERM': 'linux', 03:32:57 INFO - 'TMOUT': '86400', 03:32:57 INFO - 'USER': 'cltbld', 03:32:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:57 INFO - '_': '/tools/buildbot/bin/python'} 03:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:57 INFO - Running setup.py (path:/tmp/pip-vCyZ6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:58 INFO - Running setup.py (path:/tmp/pip-lcHA4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:58 INFO - Running setup.py (path:/tmp/pip-zq16Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:58 INFO - Running setup.py (path:/tmp/pip-wy7KRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:58 INFO - Running setup.py (path:/tmp/pip-R5mcnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:58 INFO - Running setup.py (path:/tmp/pip-4ayDB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:58 INFO - Running setup.py (path:/tmp/pip-pTIRi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:58 INFO - Running setup.py (path:/tmp/pip-F7KTtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:58 INFO - Running setup.py (path:/tmp/pip-sSXhmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:58 INFO - Running setup.py (path:/tmp/pip-KtAHoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:58 INFO - Running setup.py (path:/tmp/pip-hzlCHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:58 INFO - Running setup.py (path:/tmp/pip-hgizqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:58 INFO - Running setup.py (path:/tmp/pip-D_kxMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:58 INFO - Running setup.py (path:/tmp/pip-MV0ZBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:58 INFO - Running setup.py (path:/tmp/pip-xvlKa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:59 INFO - Running setup.py (path:/tmp/pip-lcixhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:59 INFO - Running setup.py (path:/tmp/pip-BuBDee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:32:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:00 INFO - Downloading blessings-1.6.tar.gz 03:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:01 INFO - Installing collected packages: blessings 03:33:01 INFO - Running setup.py install for blessings 03:33:01 INFO - Successfully installed blessings 03:33:01 INFO - Cleaning up... 03:33:01 INFO - Return code: 0 03:33:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:01 INFO - Reading from file tmpfile_stdout 03:33:01 INFO - Current package versions: 03:33:01 INFO - argparse == 1.2.1 03:33:01 INFO - blessings == 1.6 03:33:01 INFO - blobuploader == 1.2.4 03:33:01 INFO - docopt == 0.6.1 03:33:01 INFO - manifestparser == 1.1 03:33:01 INFO - mozInstall == 1.12 03:33:01 INFO - mozcrash == 0.16 03:33:01 INFO - mozdebug == 0.1 03:33:01 INFO - mozdevice == 0.48 03:33:01 INFO - mozfile == 1.2 03:33:01 INFO - mozhttpd == 0.7 03:33:01 INFO - mozinfo == 0.9 03:33:01 INFO - mozleak == 0.1 03:33:01 INFO - mozlog == 3.1 03:33:01 INFO - moznetwork == 0.27 03:33:01 INFO - mozprocess == 0.22 03:33:01 INFO - mozprofile == 0.28 03:33:01 INFO - mozrunner == 6.11 03:33:01 INFO - mozscreenshot == 0.1 03:33:01 INFO - mozsystemmonitor == 0.0 03:33:01 INFO - moztest == 0.7 03:33:01 INFO - mozversion == 1.4 03:33:01 INFO - psutil == 3.1.1 03:33:01 INFO - requests == 1.2.3 03:33:01 INFO - wsgiref == 0.1.2 03:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:01 INFO - Using env: {'DISPLAY': ':0', 03:33:01 INFO - 'HOME': '/home/cltbld', 03:33:01 INFO - 'LANG': 'en_US.UTF-8', 03:33:01 INFO - 'LANGUAGE': 'en_US:en', 03:33:01 INFO - 'LOGNAME': 'cltbld', 03:33:01 INFO - 'MAIL': '/var/mail/cltbld', 03:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:01 INFO - 'MOZ_NO_REMOTE': '1', 03:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:01 INFO - 'NO_EM_RESTART': '1', 03:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:01 INFO - 'PWD': '/builds/slave/test', 03:33:01 INFO - 'SHELL': '/bin/bash', 03:33:01 INFO - 'SHLVL': '1', 03:33:01 INFO - 'TERM': 'linux', 03:33:01 INFO - 'TMOUT': '86400', 03:33:01 INFO - 'USER': 'cltbld', 03:33:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:01 INFO - '_': '/tools/buildbot/bin/python'} 03:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:33:01 INFO - Cleaning up... 03:33:01 INFO - Return code: 0 03:33:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:01 INFO - Using env: {'DISPLAY': ':0', 03:33:01 INFO - 'HOME': '/home/cltbld', 03:33:01 INFO - 'LANG': 'en_US.UTF-8', 03:33:01 INFO - 'LANGUAGE': 'en_US:en', 03:33:01 INFO - 'LOGNAME': 'cltbld', 03:33:01 INFO - 'MAIL': '/var/mail/cltbld', 03:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:01 INFO - 'MOZ_NO_REMOTE': '1', 03:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:01 INFO - 'NO_EM_RESTART': '1', 03:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:01 INFO - 'PWD': '/builds/slave/test', 03:33:01 INFO - 'SHELL': '/bin/bash', 03:33:01 INFO - 'SHLVL': '1', 03:33:01 INFO - 'TERM': 'linux', 03:33:01 INFO - 'TMOUT': '86400', 03:33:01 INFO - 'USER': 'cltbld', 03:33:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:01 INFO - '_': '/tools/buildbot/bin/python'} 03:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:01 INFO - Downloading/unpacking jsonschema 03:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:03 INFO - Downloading/unpacking functools32 (from jsonschema) 03:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:03 INFO - warning: no files found matching '*.txt' 03:33:03 INFO - no previously-included directories found matching 'build' 03:33:03 INFO - no previously-included directories found matching 'dist' 03:33:03 INFO - no previously-included directories found matching '.git*' 03:33:03 INFO - Installing collected packages: jsonschema, functools32 03:33:04 INFO - Running setup.py install for functools32 03:33:04 INFO - warning: no files found matching '*.txt' 03:33:04 INFO - no previously-included directories found matching 'build' 03:33:04 INFO - no previously-included directories found matching 'dist' 03:33:04 INFO - no previously-included directories found matching '.git*' 03:33:04 INFO - Successfully installed jsonschema functools32 03:33:04 INFO - Cleaning up... 03:33:04 INFO - Return code: 0 03:33:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 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 0x7faa988caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19103b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, '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': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:33:04 INFO - Using env: {'DISPLAY': ':0', 03:33:04 INFO - 'HOME': '/home/cltbld', 03:33:04 INFO - 'LANG': 'en_US.UTF-8', 03:33:04 INFO - 'LANGUAGE': 'en_US:en', 03:33:04 INFO - 'LOGNAME': 'cltbld', 03:33:04 INFO - 'MAIL': '/var/mail/cltbld', 03:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:04 INFO - 'MOZ_NO_REMOTE': '1', 03:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:04 INFO - 'NO_EM_RESTART': '1', 03:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:04 INFO - 'PWD': '/builds/slave/test', 03:33:04 INFO - 'SHELL': '/bin/bash', 03:33:04 INFO - 'SHLVL': '1', 03:33:04 INFO - 'TERM': 'linux', 03:33:04 INFO - 'TMOUT': '86400', 03:33:04 INFO - 'USER': 'cltbld', 03:33:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:04 INFO - '_': '/tools/buildbot/bin/python'} 03:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:04 INFO - Downloading/unpacking flake8 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:06 INFO - no previously-included directories found matching 'docs/_build' 03:33:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:06 INFO - Running setup.py install for pep8 03:33:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:07 INFO - no previously-included directories found matching 'docs/_build' 03:33:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:07 INFO - Cleaning up... 03:33:07 INFO - Return code: 0 03:33:07 INFO - Running post-action listener: _resource_record_post_action 03:33:07 INFO - Running post-action listener: _start_resource_monitoring 03:33:07 INFO - Starting resource monitoring. 03:33:07 INFO - ##### 03:33:07 INFO - ##### Running install step. 03:33:07 INFO - ##### 03:33:07 INFO - Running pre-action listener: _resource_record_pre_action 03:33:07 INFO - Running main action method: install 03:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:07 INFO - Reading from file tmpfile_stdout 03:33:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:07 INFO - Reading from file tmpfile_stdout 03:33:07 INFO - Output received: 03:33:07 INFO - Usage: mozinstall [options] installer 03:33:07 INFO - Options: 03:33:07 INFO - -h, --help show this help message and exit 03:33:07 INFO - -d DEST, --destination=DEST 03:33:07 INFO - Directory to install application into. [default: 03:33:07 INFO - "/builds/slave/test"] 03:33:07 INFO - --app=APP Application being installed. [default: firefox] 03:33:07 INFO - mkdir: /builds/slave/test/build/application 03:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:23 INFO - Reading from file tmpfile_stdout 03:33:23 INFO - Output received: 03:33:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:23 INFO - Running post-action listener: _resource_record_post_action 03:33:23 INFO - ##### 03:33:23 INFO - ##### Running run-tests step. 03:33:23 INFO - ##### 03:33:23 INFO - Running pre-action listener: _resource_record_pre_action 03:33:23 INFO - Running main action method: run_tests 03:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:23 INFO - Python 2.7.3 03:33:23 INFO - Return code: 0 03:33:23 INFO - grabbing minidump binary from tooltool 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:23 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 0x199f100>, '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 0x19a0000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:33:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:33:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:23 INFO - Return code: 0 03:33:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:24 INFO - Return code: 0 03:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:33:24 INFO - Using env: {'DISPLAY': ':0', 03:33:24 INFO - 'HOME': '/home/cltbld', 03:33:24 INFO - 'LANG': 'en_US.UTF-8', 03:33:24 INFO - 'LANGUAGE': 'en_US:en', 03:33:24 INFO - 'LOGNAME': 'cltbld', 03:33:24 INFO - 'MAIL': '/var/mail/cltbld', 03:33:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:24 INFO - 'MOZ_NO_REMOTE': '1', 03:33:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:24 INFO - 'NO_EM_RESTART': '1', 03:33:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:24 INFO - 'PWD': '/builds/slave/test', 03:33:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:24 INFO - 'SHELL': '/bin/bash', 03:33:24 INFO - 'SHLVL': '1', 03:33:24 INFO - 'TERM': 'linux', 03:33:24 INFO - 'TMOUT': '86400', 03:33:24 INFO - 'USER': 'cltbld', 03:33:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389', 03:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:24 INFO - '_': '/tools/buildbot/bin/python'} 03:33:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:33:24 INFO - mozversion application_buildid: 20160229021614 03:33:24 INFO - mozversion application_changeset: 4972f77869de55becd41d6b726b25fca2f523232 03:33:24 INFO - mozversion application_display_name: Nightly 03:33:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:24 INFO - mozversion application_name: Firefox 03:33:24 INFO - mozversion application_remotingname: firefox 03:33:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:33:24 INFO - mozversion application_vendor: Mozilla 03:33:24 INFO - mozversion application_version: 47.0a1 03:33:24 INFO - mozversion platform_buildid: 20160229021614 03:33:24 INFO - mozversion platform_changeset: 4972f77869de55becd41d6b726b25fca2f523232 03:33:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:33:24 INFO - mozversion platform_version: 47.0a1 03:33:24 INFO - using testdate: 1456745604 03:33:24 INFO - actual date: 1456745604 03:33:24 INFO - starting webserver on 'localhost:48355' 03:33:24 INFO - SUITE-START | Running 2 tests 03:33:24 INFO - TEST-START | dromaeo_css 03:33:24 INFO - operating with platform_type : linux_ 03:33:24 INFO - Initialising browser for dromaeo_css test... 03:33:24 INFO - TEST-INFO | started process 11386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXOgraR/profile http://localhost:48355/getInfo.html) 03:33:29 INFO - PROCESS | 11386 | __metrics Screen width/height:1600/1200 03:33:29 INFO - PROCESS | 11386 | colorDepth:24 03:33:29 INFO - PROCESS | 11386 | Browser inner width/height: 1024/697 03:33:29 INFO - PROCESS | 11386 | __metrics 03:33:30 INFO - PROCESS | 11386 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:33:30 INFO - PROCESS | 11386 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:33:30 INFO - PROCESS | 11386 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:33:30 INFO - PROCESS | 11386 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:33:30 INFO - PROCESS | 11386 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:33:30 INFO - PROCESS | 11386 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:33:30 INFO - PROCESS | 11386 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:33:30 INFO - PROCESS | 11386 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 03:33:31 INFO - TEST-INFO | 11386: exit 0 03:33:31 INFO - Browser initialized. 03:33:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:31 INFO - TEST-INFO | started process 11480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXOgraR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:43 INFO - PROCESS | 11480 | RSS: Main: 150663168 03:33:43 INFO - PROCESS | 11480 | 03:34:34 INFO - PROCESS | 11480 | 1456745674226 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:36:45 INFO - PROCESS | 11480 | Cycle 1(1): loaded http://localhost:48355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48355/tests/dromaeo/cssquery-ext.html) 03:36:46 INFO - PROCESS | 11480 | RSS: Main: 239263744 03:36:46 INFO - PROCESS | 11480 | 03:39:48 INFO - PROCESS | 11480 | Cycle 1(1): loaded http://localhost:48355/tests/dromaeo/cssquery-ext.html (next: http://localhost:48355/tests/dromaeo/cssquery-jquery.html) 03:39:49 INFO - PROCESS | 11480 | RSS: Main: 234917888 03:39:49 INFO - PROCESS | 11480 | 03:42:51 INFO - PROCESS | 11480 | Cycle 1(1): loaded http://localhost:48355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48355/tests/dromaeo/cssquery-mootools.html) 03:42:51 INFO - PROCESS | 11480 | RSS: Main: 228392960 03:42:51 INFO - PROCESS | 11480 | 03:45:53 INFO - PROCESS | 11480 | Cycle 1(1): loaded http://localhost:48355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48355/tests/dromaeo/cssquery-prototype.html) 03:45:54 INFO - PROCESS | 11480 | RSS: Main: 216326144 03:45:54 INFO - PROCESS | 11480 | 03:48:57 INFO - PROCESS | 11480 | Cycle 1(1): loaded http://localhost:48355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48355/tests/dromaeo/cssquery-yui.html) 03:48:57 INFO - PROCESS | 11480 | RSS: Main: 211222528 03:48:57 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | Cycle 1(1): loaded http://localhost:48355/tests/dromaeo/cssquery-yui.html (next: http://localhost:48355/tests/dromaeo/cssquery-dojo.html) 03:52:00 INFO - PROCESS | 11480 | RSS: Main: 267485184 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | __start_tp_report 03:52:00 INFO - PROCESS | 11480 | _x_x_mozilla_page_load 03:52:00 INFO - PROCESS | 11480 | _x_x_mozilla_page_load_details 03:52:00 INFO - PROCESS | 11480 | |i|pagename|runs| 03:52:00 INFO - PROCESS | 11480 | |0;dojo.html;2541.339251794533;2542.351700316419;2544.5928651415766;2548.1336345642476;2573.3052075939504;4276.379924910886;4343.956560434394;4360.6075453209205;4370.956290437099;4403.7798110094445;4393.428854248951;4395.934060989088;4410.228210063242;4428.844990425336;4444.4000059991895;4053.7770422626745;4058.9594104059024;4090.5295890972475;4096.528899176596;4209.494860616715;3966.7024973126986;4131.318332475138;4164.021454958082;4176.0395109124765;4191.7694526801015;3976.2842688315945;4023.959760402388;4042.8180731867137;4050.6151915567975;4076.408920706511;4037.6769858411258;4059.7158198926086;4067.2068946555432;4067.3898915162963;4117.21772863155;3915.8825235242703;3993.7004724645476;4044.737092089005;4044.8179831907637;4074.7555146691293;4328.523862375137;4368.257396242647;4377.037051848588;4411.867643970686;4423.181711383404;4670.252759558454;4670.929936050962;4678.461976872669;4679.344891715163;4721.716696998191;4534.319852022223;4686.43762748469;4687.5781179693995;4701.388819453483;4767.785449654774;4361.956380436155;4364.170807546556;4372.715773474714;4382.320740285261;4395.516493185747;4777.283407488835;4778.283257511401;4783.976080119577;4828.517148285214;4836.709797412166;4469.128519938581;4555.2256116460285;4604.516525764813;4609.055143695601;4615.469221039556;4637.768111594407;4641.396618439649;4644.8374306899095;4644.8374306899095;4663.883402914954;4613.377194078824;4614.077184563033;4615.676902616785;4616.053708989649;4657.278121891112;4517.457905051415;4572.9314060289125;4645.46577143626;4653.8371157010015;4655.441347038377;3985.6412922836503;3989.501312335958;3996.760194388346;4000.599940005976;4018.799060046986;3508.2808024354945;3509.280597477511;3540.5574303212097;3553.7157027437743;3568.1436455250555;3897.922041559153;3979.8607048753156;4000.6199411055904;4076.8573099941955;4078.3678529827926;4649.697769644962;4663.696859704176;4673.556012178838;4681.695689780154;4734.668573199911;4016.6786657067364;4028.194361127786;4031.5968403160036;4064.9187016260103;4071.4096456013713;4091.6931230157857;4191.559886211904;4219.0507135894795;4251.574842515785;4256.808443620044;4450.732956022649;4467.664925130628;4485.91028179428;4487.2147374210035;4530.569595888385;4498.2577874650315;4713.245880659215;4714.57568818808;4715.3869996900185;4744.881377965578;4423.845165419324;4459.331100334846;4467.419235499365;4496.842610508616;4502.707324023928;4630.374899388539;4640.791164397543;4653.302004699322;4656.068786242833;4713.481517033192;4510;4696.882577935579;4702.1536123496735;4702.482726900107;4711.952880471152;4567.566081222279;4575.9771201143785;4584.335271385564;4614.307853821953;4617;4549.226631472724;4560.6351491879905;4561.543845615544;4565.086982603559;4605.562471565196;4297.742135471882;4441.933370999503;4487.102579484051;4489.9775501122285;4521.9547804521535;4573.634109271316;4589.151007063704;4600.125976064537;4613.907721845477;4642.953570464252;4496.505384407778;4503.684742068024;4504.707194032378;4529.728216307032;4546.340780586863 03:52:00 INFO - PROCESS | 11480 | |1;ext.html;463.3466811795365;473.4815377162009;508.7583397886004;515.4253007896194;534.1080395739117;22112;32944.17639559012;33419;33502.8324858376;33537;35903.82048089762;36395.454068189;36533.634663653356;36541.26917461649;36561.81719091401;6625.403713665769;7672.117706463759;7851.332636725857;9517.714468565953;9728.221742260603;9581.281403894702;9684.418934863896;9698.612055517771;9705.951470242639;9780.364276322052;9393.859092113624;9516.286278529104;9529.142377186052;9541.71374858752;9542.952285238563;9619.903800962005;9740.269479789044;9748.610055597768;9760.999999999964;9774.5601447935;9228.676996305097;9501.2874034447;9504.04959504051;9740.75648108796;9761.853572196424;36286.81856590726;36721.265574688354;36943.26113477742;36963.81518092392;36986.81506592477;2708.404151086758;2737.083077169151;2877.395746893155;3070.155707180521;3549.378858699743;26624.264874741482;26727.198184054316;27521;28051.43897122046;28421.71578284232;2998.685138060516;3007.9248018799485;3023.9092827215;3044.086773967823;3063.816171029723;222426;223129;223382;223757.88121059453;224576;41363.586364135976;52432.737836310574;53187;53267.20099198515;53275.733621331645;39253;39356.80321598374;39375.40936885949;39461;39549.60450395459;9830.606775728891;11138;11201.27191732551;11205.551777928791;11207.103431725442;9924.553395097239;10089.192864570818;10095.293329466867;10101;10124.34191777532;13290.136141150795;13635.250061246528;13647.454101836014;13650.317484125953;13747.243901585309;5367.221752845816;5446.509814116748;5483.287172667528;5486.286782718221;5527.203658810822;832.7252006837729;857.9227869491775;871.5947084605689;940.5656374029522;1044.6552637629563;26288.342791429986;26565.203043908714;26569.335766605604;26905.192844214704;26945.865270673523;825.2366560931234;870.6125774030496;888.5823662878437;902.1519771414848;1012.1548506996593;13705.931470342584;15016.849831501764;15692.68614627701;15727.135007574694;15884.76172857408;316630;319117;323080;323501;323927;46871.76564117226;47007;47287.29069063967;47327.29009064867;47381.52618473771;957.0620791624248;1062.5643486170634;1170.8302296167008;1240.3054289597674;1256.0328547018744;23149;24220.03119875185;24458;24470.578847093566;24702.382440439134;30902.53646195264;30990.380192395576;31238.21904452407;31454;31520;162321;163382;164157;164389;164396;21573.352799416043;24762;28048.859755701906;28145.296367590974;28269.151925441445;32764;32905;32913.67086329202;32961.505577416836;33358.499622505195;27335.179944601692;27508.44983100367;27517;27553.72446275592;27710.307242318297;28397;28941;28969.63415484823;30554.541681874343;31040;27354.589681155197;27587.310317241427;27739.167824965283;27818.44363112686;27865.44269114647;30285;32475.512867307483;34385.656143438246;35529.1117722059;36168.45747313845;23139.190128345428;23215.767842321362;23393.41516462034;23485.647715284627;23530.88234558816 03:52:00 INFO - PROCESS | 11480 | |2;jquery.html;302.8758209134255;309.05583442582906;309.9907002789917;315.7316281161012;326.9901902942911;11106.4446777661;13972.161670299789;14660.633484162889;14670.413183472661;15076.547703568884;13794.655133621665;14027.43890244389;14076;14387.280635968213;14942.775858362133;4906.779194936236;5133.101707201244;5143.177091665334;5159.200323949775;5167.224916262572;3537.2925414917117;5065.79736810529;5131.204663277198;5609.439056094398;5823.67969761663;5749.971250143743;5775.682337471438;5776.220210271623;5779.190913272145;5779.306483221998;5594.552435805126;5736.598438109334;5737.282839645044;5901.557383196277;5911;5128.102582048126;5133.30700355451;5135.178371460585;5151.433342332378;5152.407473140562;18258.178381972844;18492.075396230135;18861.245550178115;19022.714659280122;19039.238430462763;1676.7652528646;1786.937457188992;1906.8379187769056;2339.415146213447;2436.610142377229;7990.920090799075;8837.823243535158;8958.955205223998;12055.457504412323;12212.816807747891;1767.734839774044;1784.5895444047812;1824.7445357649806;1830.9725354119698;1834.4058087858425;53313.46686533124;56516.71741641306;58446.41553584452;58646.70676646632;59166.40833591652;9406.623735050658;9474.90525094754;9516.619335226653;9587.712368628952;9623.951880240555;10229.59081636741;12164.209326393757;12208.450619722134;12210.450529726184;12215;6339.144215530844;6621.966890165615;6724.93275067243;6729.495287853332;6783.423409010191;6336.20797400325;6383.36166383358;6394.663790865296;6471.676416179266;6474.287828338879;4043.130726893732;4095.24238015968;4095.3856921461424;4149.37759336102;4163.958360416357;1669.991650041742;1704.8209937956583;1706.7525208844647;1709.829017098305;1715.2624371520367;717.3042149115349;766.769969009295;773.9264769846856;796.8764841449585;874.2481465939287;14501.20243386624;15259.08445493274;15313.387464501295;15388.538343849703;15925.681486370207;846.2383854530848;849.7493239494364;868.9739307820776;895.1630225738955;895.8656201569686;8306.584670766437;8679.956600217085;8759.956200218958;8794.516301603346;9057.728268151966;268303;270255;270783;360961;363690;64650.35349646537;65401.67299163474;66059;66588.33411665919;69106.65446672734;784.6625950841079;787.3504358903928;816.7059858450953;818.5497976113114;820.1757233979812;10363.844542332023;14010.369533370818;14121.717565648834;14417;14629.487967921072;28182.85908570444;28459.28851778722;29120.41759164847;29780.255493612833;30094.69905300919;39314.60685393224;40351.59648403478;40435.595644043184;40729.1854162921;40835;6766.1204043476;6783.898241526283;7037.472189585699;7181.461390395637;7283.417326613964;7183.317584829433;7473.663685134291;7837;8143.144969778088;8384.748457546284;7188.60462674537;7205.819854503469;7237.63811809418;7373.889391659237;7629.122650894996;7158.391536719437;7340.339369456775;7377.299156580117;7423.257674232534;7426.145993210634;7446.441516886363;7649.388048955959;7659.808504787425;7725.420593455401;7748.728794492165;9044.81910361776;9336.95331523338;9909.801803963735;10110.342827716175;10188.949055254676;9750.658726944523;10006.64246080689;10070.94964525202;10213.897861021593;10222.28444008942 03:52:00 INFO - PROCESS | 11480 | |3;mootools.html;1069.4118234970765;1339.8258226430564;1342.724741428007;1455.9927200363998;1733.2287132226156;5570.080936645454;6780.389764921156;6965.024896514492;6972.302769723025;6972.79081627552;6806.931930680692;6949.305069493048;6979.965100174492;6981.266966968458;6983.371496565308;1636.3454618152716;2004.4487765864358;2041.8570700051002;2064.1021155797275;2073.409078412653;2072.1504183284856;2078.698588704637;2081;2081.5212501124674;2082.6563617003253;1988.3239698502507;2015.5767288869356;2041.9591608167827;2044.2538473457155;2045.1103769860083;2005.8796472211714;2038.1439795285942;2044.5706401655596;2046.294028560152;2064.318774804311;2021.8685785424047;2022.7572691276994;2025.5543780368444;2025.9392218233477;2029.0260674875994;6612.107365505643;6649.76725814599;6656.800295991128;6664.300248473889;6672.566283191577;4105.44576482174;4217.536071032184;4243.936340954888;4250.978745106286;4251.914961700749;2485.155047283914;2582.690077190749;2594.0791019188105;2596.2730435478097;2605.9218223453136;743.049495075427;754.935830454412;779.1779672445624;798.441091236137;805.9435839491238;9276.536173191313;9280.582373793262;9308.488033158173;9368;9380.437173769596;3726.6087060858217;3831.5593706724085;3915.040815000343;3916.373380259145;3967;8120.187981201951;8135.959320203361;8143.592820358958;8151.388645851466;8167.795805104801;3365.6802603752603;4171.353440216772;4187.246295666749;4188.099558594917;4194.49666040071;3632.328019316435;3730.8321125549414;3736.962630373716;3752.6810221130963;3765.134019175605;3335.9166020849675;3356.328734253159;3389.847456864447;3415.7267418606452;3434.7767395119236;1064.2550214849637;1109.2401704832216;1115.1079136690614;1117.0449265877558;1124.2692250037542;913.6710784117712;914.1224424552371;921.7050543825911;933.9673111441067;1189.2864281431246;6685.832854178684;6712.127423434922;6718.496112791462;6723.294054124344;6738.494612904052;405.70991740905396;407.9408485769547;410.0405052177918;411.3890872054996;412.54825965567653;5211.42674305826;5227.712475813867;5308.708021058879;5313.442088580643;5314.202869569518;8167;8251.257386835214;8331.750047498585;8399.832003360021;8471.872921906053;8297.95851020753;8306.501609903426;8335.874961875577;8379.37154713399;8379.45533540318;6365.745370185234;6550.115734375799;6616.073749675049;6689.732410703615;6707.798766037026;6590.736370545316;6788.389044985975;6794.660266986532;6831.521793474608;6832.829179270558;7572.432067594842;7587.430942679432;7752.612369381621;7873.25204105609;7884.250996155356;7771.72798952034;8011.238932301422;8017.518948863087;8036.758897233092;8123.6750529978135;4974.204127339608;5077.289179514944;5081.161608334583;6076.66578338178;6152;5685.34618518859;5847.415258474119;6679.332066793476;6683.498737594603;6689.364510371702;5937.524998000236;5948.643081414956;6030.758769649165;6084.482818960438;6084.726187321493;5849.94150058511;5854.765809367577;5979.372165922516;6053.122297266784;6068.180795592715;6377.362263773585;6419.967900160469;6458;6458.095866578777;6517.185351831021;5980.760769569342;5981.521478281814;6023.156758053964;6024.759009639565;6041.184440100706;5973.701314934149;6005.789797357072;6005.849853753691;6015.368386319374;6024.3975602439405 03:52:00 INFO - PROCESS | 11480 | |4;prototype.html;285.63581433672067;293.8780406131456;297.18571115144505;298.7415885259251;299.57609981875635;5194.117000109981;5272.657277276974;5283.418823929364;5285.048691235581;5292.523672869441;5175.378954525462;5244.082285600024;5296.894062118765;5316.6544174628625;5322.600804939635;3802.182530755887;3891.571927088018;3969.940450893239;3975;3977.8408863645564;3978.4231286463446;3991.880243592697;3995.7802320872343;3996.500437445319;3998.2403343364813;3937.9803100984454;3957.515931525678;3958.2677204717074;3959.485266915297;3964.444977703124;3755;3876.3216437123533;3915.8629447969183;3945.191235796655;3953.2291203215386;3416.5558477398026;3418.8974330770116;3425.4519276915576;3429.2798512312443;3431.7769344992494;5009.949900500985;5018.121828679967;5046.243063540462;5089.109405853961;5092.541671249568;4545.749918772331;4568.451785785694;4571.245744452194;4575.565321294472;4582.862514124582;5491.615586908918;5496.285482887199;5497.39528651848;5500;5505.201745746885;3758;3758.3610786166146;3760.2479504099015;3762.1535154590274;3762.6237376262156;5565.638233514849;5715;5805.7387417566315;5808.622439541458;5834.6790926499025;3815.21788033458;3822.808859557011;3841.8079096045085;3847.019010152393;3851.1527463957887;3908.472356231929;3911.119998000484;3913.5519857652853;3915.9216815663526;3917.6082391761165;4535.387722657465;4535.863924082283;4536.364908912755;4543.863684089417;4544.318352247189;5523.088690366045;5526.861828454241;5527.53015993637;5534.280543529396;5536.280283563192;1359.592122363287;1381.702933869223;1383.4466213514675;1384.1279993603964;1384.4047059764398;841.9769979474968;889.7508697564692;927.8051609162017;939.9013103624158;940.830650482906;4652.232381656989;4653.371794807726;4662.184117779375;4663.020765639186;4665.510121437268;5575.581831362664;5699.316082070178;5705.971470142623;5707.200991861143;5709.143628455682;4764.118638051971;4786.64100192487;4790.520947905182;4795.592374648194;4797.784099715521;3016.7435767959532;3056.66376698563;3057.0370333344927;3057.220408795743;3062.938741225163;5375;5383.623146379716;5385.542228910586;5386.676799392049;5390.137577987582;5728.140778883201;5824.388439213822;5826.854328641818;5967.731452084667;5968;5473.507384335429;5476.17857321405;5483.533899618497;5496.395396506301;5502.58730595207;5786.884262314814;5798.478136967693;5798.623089499169;5798.6810725410505;5801.3038435388025;5646.3788983212635;5658.745356458887;5660.773569057192;5662.66024038559;5664.26364572603;5488.231647569263;5489.451054894638;5494.972525137348;5496.725163741717;5505.091659876076;3764.887053388403;3887.086534664295;3906.5507466640565;3914.6868250540456;3932.803359832054;5719.170720245625;5741.655500669973;5744.942550574441;5747;5748.597598168088;5505.366882808528;5510.779568817203;5520.585956053393;5521.309836270466;5524.06090964529;5311.44229855875;5373.623846330719;5477.096279113902;5499.175123731312;5504.2018907257425;5366.168243922199;5368.570514358764;5369.812056578001;5372.301600792029;5376.623636345418;5527.198556209408;5529.142982837667;5530;5531.778728850801;5534.308211473566;5374.838754837361;5392.460753924733;5401.378841433286;5403.5136837684795;5415.702136382537 03:52:00 INFO - PROCESS | 11480 | |5;yui.html;563.8054871069485;582.6504097541475;595.7021489255372;601.1373678770962;605.4097255176202;10159.034891685296;10163.39019658819;10278.845817312746;10310;10357.689269321914;10927.562897484091;11001.834972475399;11852.822207666892;11975.820362694567;12012.939935300312;389.8577019387917;756.2059837170976;770.6724642027116;772.119783446871;772.2162005564329;761.7714685594327;782.0693374883898;784.0356361675143;784.0747917457398;784.6586734770365;826.6652005937605;828.204923273658;828.8715249136394;829.4649950781742;829.6971605364029;421.0547321263752;431.0860974733585;819.0580832043139;819.8770184472347;821.1624143373725;307.27176591478116;600.3666132230495;608.9330173680892;609.0894113300644;609.9390060993909;11485.483153258123;11543.538258469735;11566.074714022858;11618.76762464746;11631.418429078596;10547.628808254954;10887.945560272226;10929.781404371868;11242.94378528102;11327.830082548768;8881.467111973303;9270.629174832999;9408.858867116998;9412.435253884789;9575.952120239424;2714.954717470954;2751.3946931675;2770.7783377329765;2797.5384061629807;2818.760405365526;39520.20959580821;39717.20565588672;39812.99999999971;39980.600193997976;40433;8830.646774128963;8947.955260223787;9173.44959302444;9263.351565390492;9371;15112;15130.319135638923;15136.318865651072;15143.394264229528;15260.542183734506;5550.306211723535;5683.232763576947;5760.94239057604;5829.650220986754;6046.18376519173;3183.4428974929297;3219.2595702987974;3222.0494953988627;3244.383567122239;3331.1339051846694;2539.441322908957;2561.3724637463943;2567.6020216866414;2577.6649035625624;2579.2262321303533;452.94791099023377;483.29439019032606;495.62332627203585;501.6563653897092;501.7315736081179;403.8364462392677;437.0886701227975;525.3144646236622;538.5099559400926;550.2736387967844;6883.7590684325805;6894.413974812097;6930.44556435484;7001.649917504104;7227.819304517429;525.1807180797967;537.5511447941013;551.737924485874;557.2310211907542;557.6626141184606;3277.901662950115;3381.239221175216;3436.810975396377;3452.741044421628;3484.4424892017664;45084.77457612691;45249.773751131695;45717.54282457133;45751.77124114425;46036.769816151376;37934.430983534716;38492.42261366082;38709;38714.41928371077;39106.413403798964;37536.62463375386;37829;38162.61837381591;38227.42658860119;39746.80126599348;7693.49992250502;7697.692092316244;7823.178566250689;7897.723579674684;8165.877511837446;27904.30239244035;28671.426571468037;28965.85517072401;29228.561571576018;29343.413131737674;33933.66066339305;33992.490112647836;36052.27895442024;36253.818730906176;36404.27191456103;8765.824683506422;9031.50326732036;9048.90951090507;9183.632654694005;9286.907130928605;10583.576656933636;10794.514246858753;10843.403612801372;10950.616728414787;10957.232993690364;9990.950045249727;10178.847317290394;10376.533056012346;10545.57817687284;10624.203184761329;9766.85349719769;9836.655717049869;9968.55141518619;10383.636572719919;10427.217958653284;9563.856542152012;9732.221422286342;9754.75613109678;9757.121859032437;9824.803503930025;8460.53467059293;8508;8508.796370004846;8607.612657430305;8856.335774817044;7994.5602991836;8144.267015968354;8270.2556769891;8345.874811877948;8374.413791034569 03:52:00 INFO - PROCESS | 11480 | __end_tp_report 03:52:00 INFO - PROCESS | 11480 | __start_cc_report 03:52:00 INFO - PROCESS | 11480 | _x_x_mozilla_cycle_collect,870 03:52:00 INFO - PROCESS | 11480 | __end_cc_report 03:52:00 INFO - PROCESS | 11480 | __startTimestamp1456746720402__endTimestamp 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | ------- Summary: start ------- 03:52:00 INFO - PROCESS | 11480 | Number of tests: 6 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | [#0] dojo.html Cycles:165 Average:4338.76 Median:4469.13 stddev:430.61 (9.6%) stddev-sans-first:408.19 03:52:00 INFO - PROCESS | 11480 | Values: 2541.3 2542.4 2544.6 2548.1 2573.3 4276.4 4344.0 4360.6 4371.0 4403.8 4393.4 4395.9 4410.2 4428.8 4444.4 4053.8 4059.0 4090.5 4096.5 4209.5 3966.7 4131.3 4164.0 4176.0 4191.8 3976.3 4024.0 4042.8 4050.6 4076.4 4037.7 4059.7 4067.2 4067.4 4117.2 3915.9 3993.7 4044.7 4044.8 4074.8 4328.5 4368.3 4377.0 4411.9 4423.2 4670.3 4670.9 4678.5 4679.3 4721.7 4534.3 4686.4 4687.6 4701.4 4767.8 4362.0 4364.2 4372.7 4382.3 4395.5 4777.3 4778.3 4784.0 4828.5 4836.7 4469.1 4555.2 4604.5 4609.1 4615.5 4637.8 4641.4 4644.8 4644.8 4663.9 4613.4 4614.1 4615.7 4616.1 4657.3 4517.5 4572.9 4645.5 4653.8 4655.4 3985.6 3989.5 3996.8 4000.6 4018.8 3508.3 3509.3 3540.6 3553.7 3568.1 3897.9 3979.9 4000.6 4076.9 4078.4 4649.7 4663.7 4673.6 4681.7 4734.7 4016.7 4028.2 4031.6 4064.9 4071.4 4091.7 4191.6 4219.1 4251.6 4256.8 4450.7 4467.7 4485.9 4487.2 4530.6 4498.3 4713.2 4714.6 4715.4 4744.9 4423.8 4459.3 4467.4 4496.8 4502.7 4630.4 4640.8 4653.3 4656.1 4713.5 4510.0 4696.9 4702.2 4702.5 4712.0 4567.6 4576.0 4584.3 4614.3 4617.0 4549.2 4560.6 4561.5 4565.1 4605.6 4297.7 4441.9 4487.1 4490.0 4522.0 4573.6 4589.2 4600.1 4613.9 4643.0 4496.5 4503.7 4504.7 4529.7 4546.3 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | [#1] ext.html Cycles:180 Average:38111.84 Median:317873.50 stddev:64235.84 (20.2%) stddev-sans-first:64353.84 03:52:00 INFO - PROCESS | 11480 | Values: 463.3 473.5 508.8 515.4 534.1 22112.0 32944.2 33419.0 33502.8 33537.0 35903.8 36395.5 36533.6 36541.3 36561.8 6625.4 7672.1 7851.3 9517.7 9728.2 9581.3 9684.4 9698.6 9706.0 9780.4 9393.9 9516.3 9529.1 9541.7 9543.0 9619.9 9740.3 9748.6 9761.0 9774.6 9228.7 9501.3 9504.0 9740.8 9761.9 36286.8 36721.3 36943.3 36963.8 36986.8 2708.4 2737.1 2877.4 3070.2 3549.4 26624.3 26727.2 27521.0 28051.4 28421.7 2998.7 3007.9 3023.9 3044.1 3063.8 222426.0 223129.0 223382.0 223757.9 224576.0 41363.6 52432.7 53187.0 53267.2 53275.7 39253.0 39356.8 39375.4 39461.0 39549.6 9830.6 11138.0 11201.3 11205.6 11207.1 9924.6 10089.2 10095.3 10101.0 10124.3 13290.1 13635.3 13647.5 13650.3 13747.2 5367.2 5446.5 5483.3 5486.3 5527.2 832.7 857.9 871.6 940.6 1044.7 26288.3 26565.2 26569.3 26905.2 26945.9 825.2 870.6 888.6 902.2 1012.2 13705.9 15016.8 15692.7 15727.1 15884.8 316630.0 319117.0 323080.0 323501.0 323927.0 46871.8 47007.0 47287.3 47327.3 47381.5 957.1 1062.6 1170.8 1240.3 1256.0 23149.0 24220.0 24458.0 24470.6 24702.4 30902.5 30990.4 31238.2 31454.0 31520.0 162321.0 163382.0 164157.0 164389.0 164396.0 21573.4 24762.0 28048.9 28145.3 28269.2 32764.0 32905.0 32913.7 32961.5 33358.5 27335.2 27508.4 27517.0 27553.7 27710.3 28397.0 28941.0 28969.6 30554.5 31040.0 27354.6 27587.3 27739.2 27818.4 27865.4 30285.0 32475.5 34385.7 35529.1 36168.5 23139.2 23215.8 23393.4 23485.6 23530.9 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | [#2] jquery.html Cycles:180 Average:20132.33 Median:29240.35 stddev:51258.37 (175.3%) stddev-sans-first:51380.54 03:52:00 INFO - PROCESS | 11480 | Values: 302.9 309.1 310.0 315.7 327.0 11106.4 13972.2 14660.6 14670.4 15076.5 13794.7 14027.4 14076.0 14387.3 14942.8 4906.8 5133.1 5143.2 5159.2 5167.2 3537.3 5065.8 5131.2 5609.4 5823.7 5750.0 5775.7 5776.2 5779.2 5779.3 5594.6 5736.6 5737.3 5901.6 5911.0 5128.1 5133.3 5135.2 5151.4 5152.4 18258.2 18492.1 18861.2 19022.7 19039.2 1676.8 1786.9 1906.8 2339.4 2436.6 7990.9 8837.8 8959.0 12055.5 12212.8 1767.7 1784.6 1824.7 1831.0 1834.4 53313.5 56516.7 58446.4 58646.7 59166.4 9406.6 9474.9 9516.6 9587.7 9624.0 10229.6 12164.2 12208.5 12210.5 12215.0 6339.1 6622.0 6724.9 6729.5 6783.4 6336.2 6383.4 6394.7 6471.7 6474.3 4043.1 4095.2 4095.4 4149.4 4164.0 1670.0 1704.8 1706.8 1709.8 1715.3 717.3 766.8 773.9 796.9 874.2 14501.2 15259.1 15313.4 15388.5 15925.7 846.2 849.7 869.0 895.2 895.9 8306.6 8680.0 8760.0 8794.5 9057.7 268303.0 270255.0 270783.0 360961.0 363690.0 64650.4 65401.7 66059.0 66588.3 69106.7 784.7 787.4 816.7 818.5 820.2 10363.8 14010.4 14121.7 14417.0 14629.5 28182.9 28459.3 29120.4 29780.3 30094.7 39314.6 40351.6 40435.6 40729.2 40835.0 6766.1 6783.9 7037.5 7181.5 7283.4 7183.3 7473.7 7837.0 8143.1 8384.7 7188.6 7205.8 7237.6 7373.9 7629.1 7158.4 7340.3 7377.3 7423.3 7426.1 7446.4 7649.4 7659.8 7725.4 7748.7 9044.8 9337.0 9909.8 10110.3 10188.9 9750.7 10006.6 10070.9 10213.9 10222.3 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | [#3] mootools.html Cycles:180 Average:4840.36 Median:6005.82 stddev:2555.44 (42.5%) stddev-sans-first:2546.88 03:52:00 INFO - PROCESS | 11480 | Values: 1069.4 1339.8 1342.7 1456.0 1733.2 5570.1 6780.4 6965.0 6972.3 6972.8 6806.9 6949.3 6980.0 6981.3 6983.4 1636.3 2004.4 2041.9 2064.1 2073.4 2072.2 2078.7 2081.0 2081.5 2082.7 1988.3 2015.6 2042.0 2044.3 2045.1 2005.9 2038.1 2044.6 2046.3 2064.3 2021.9 2022.8 2025.6 2025.9 2029.0 6612.1 6649.8 6656.8 6664.3 6672.6 4105.4 4217.5 4243.9 4251.0 4251.9 2485.2 2582.7 2594.1 2596.3 2605.9 743.0 754.9 779.2 798.4 805.9 9276.5 9280.6 9308.5 9368.0 9380.4 3726.6 3831.6 3915.0 3916.4 3967.0 8120.2 8136.0 8143.6 8151.4 8167.8 3365.7 4171.4 4187.2 4188.1 4194.5 3632.3 3730.8 3737.0 3752.7 3765.1 3335.9 3356.3 3389.8 3415.7 3434.8 1064.3 1109.2 1115.1 1117.0 1124.3 913.7 914.1 921.7 934.0 1189.3 6685.8 6712.1 6718.5 6723.3 6738.5 405.7 407.9 410.0 411.4 412.5 5211.4 5227.7 5308.7 5313.4 5314.2 8167.0 8251.3 8331.8 8399.8 8471.9 8298.0 8306.5 8335.9 8379.4 8379.5 6365.7 6550.1 6616.1 6689.7 6707.8 6590.7 6788.4 6794.7 6831.5 6832.8 7572.4 7587.4 7752.6 7873.3 7884.3 7771.7 8011.2 8017.5 8036.8 8123.7 4974.2 5077.3 5081.2 6076.7 6152.0 5685.3 5847.4 6679.3 6683.5 6689.4 5937.5 5948.6 6030.8 6084.5 6084.7 5849.9 5854.8 5979.4 6053.1 6068.2 6377.4 6420.0 6458.0 6458.1 6517.2 5980.8 5981.5 6023.2 6024.8 6041.2 5973.7 6005.8 6005.8 6015.4 6024.4 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | [#4] prototype.html Cycles:180 Average:4540.95 Median:5288.79 stddev:1366.43 (25.8%) stddev-sans-first:1332.41 03:52:00 INFO - PROCESS | 11480 | Values: 285.6 293.9 297.2 298.7 299.6 5194.1 5272.7 5283.4 5285.0 5292.5 5175.4 5244.1 5296.9 5316.7 5322.6 3802.2 3891.6 3969.9 3975.0 3977.8 3978.4 3991.9 3995.8 3996.5 3998.2 3938.0 3957.5 3958.3 3959.5 3964.4 3755.0 3876.3 3915.9 3945.2 3953.2 3416.6 3418.9 3425.5 3429.3 3431.8 5009.9 5018.1 5046.2 5089.1 5092.5 4545.7 4568.5 4571.2 4575.6 4582.9 5491.6 5496.3 5497.4 5500.0 5505.2 3758.0 3758.4 3760.2 3762.2 3762.6 5565.6 5715.0 5805.7 5808.6 5834.7 3815.2 3822.8 3841.8 3847.0 3851.2 3908.5 3911.1 3913.6 3915.9 3917.6 4535.4 4535.9 4536.4 4543.9 4544.3 5523.1 5526.9 5527.5 5534.3 5536.3 1359.6 1381.7 1383.4 1384.1 1384.4 842.0 889.8 927.8 939.9 940.8 4652.2 4653.4 4662.2 4663.0 4665.5 5575.6 5699.3 5706.0 5707.2 5709.1 4764.1 4786.6 4790.5 4795.6 4797.8 3016.7 3056.7 3057.0 3057.2 3062.9 5375.0 5383.6 5385.5 5386.7 5390.1 5728.1 5824.4 5826.9 5967.7 5968.0 5473.5 5476.2 5483.5 5496.4 5502.6 5786.9 5798.5 5798.6 5798.7 5801.3 5646.4 5658.7 5660.8 5662.7 5664.3 5488.2 5489.5 5495.0 5496.7 5505.1 3764.9 3887.1 3906.6 3914.7 3932.8 5719.2 5741.7 5744.9 5747.0 5748.6 5505.4 5510.8 5520.6 5521.3 5524.1 5311.4 5373.6 5477.1 5499.2 5504.2 5366.2 5368.6 5369.8 5372.3 5376.6 5527.2 5529.1 5530.0 5531.8 5534.3 5374.8 5392.5 5401.4 5403.5 5415.7 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | [#5] yui.html Cycles:180 Average:11375.65 Median:45734.66 stddev:12693.24 (27.8%) stddev-sans-first:12702.88 03:52:00 INFO - PROCESS | 11480 | Values: 563.8 582.7 595.7 601.1 605.4 10159.0 10163.4 10278.8 10310.0 10357.7 10927.6 11001.8 11852.8 11975.8 12012.9 389.9 756.2 770.7 772.1 772.2 761.8 782.1 784.0 784.1 784.7 826.7 828.2 828.9 829.5 829.7 421.1 431.1 819.1 819.9 821.2 307.3 600.4 608.9 609.1 609.9 11485.5 11543.5 11566.1 11618.8 11631.4 10547.6 10887.9 10929.8 11242.9 11327.8 8881.5 9270.6 9408.9 9412.4 9576.0 2715.0 2751.4 2770.8 2797.5 2818.8 39520.2 39717.2 39813.0 39980.6 40433.0 8830.6 8948.0 9173.4 9263.4 9371.0 15112.0 15130.3 15136.3 15143.4 15260.5 5550.3 5683.2 5760.9 5829.7 6046.2 3183.4 3219.3 3222.0 3244.4 3331.1 2539.4 2561.4 2567.6 2577.7 2579.2 452.9 483.3 495.6 501.7 501.7 403.8 437.1 525.3 538.5 550.3 6883.8 6894.4 6930.4 7001.6 7227.8 525.2 537.6 551.7 557.2 557.7 3277.9 3381.2 3436.8 3452.7 3484.4 45084.8 45249.8 45717.5 45751.8 46036.8 37934.4 38492.4 38709.0 38714.4 39106.4 37536.6 37829.0 38162.6 38227.4 39746.8 7693.5 7697.7 7823.2 7897.7 8165.9 27904.3 28671.4 28965.9 29228.6 29343.4 33933.7 33992.5 36052.3 36253.8 36404.3 8765.8 9031.5 9048.9 9183.6 9286.9 10583.6 10794.5 10843.4 10950.6 10957.2 9991.0 10178.8 10376.5 10545.6 10624.2 9766.9 9836.7 9968.6 10383.6 10427.2 9563.9 9732.2 9754.8 9757.1 9824.8 8460.5 8508.0 8508.8 8607.6 8856.3 7994.6 8144.3 8270.3 8345.9 8374.4 03:52:00 INFO - PROCESS | 11480 | -------- Summary: end -------- 03:52:00 INFO - PROCESS | 11480 | 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:00 INFO - PROCESS | 11480 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:01 INFO - TEST-INFO | 11480: exit 0 03:52:01 INFO - TEST-OK | dromaeo_css | took 1116454ms 03:52:01 INFO - TEST-START | kraken 03:52:01 INFO - operating with platform_type : linux_ 03:52:01 INFO - Initialising browser for kraken test... 03:52:01 INFO - TEST-INFO | started process 11663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv0qWYM/profile http://localhost:48355/getInfo.html) 03:52:05 INFO - PROCESS | 11663 | __metrics Screen width/height:1600/1200 03:52:05 INFO - PROCESS | 11663 | colorDepth:24 03:52:05 INFO - PROCESS | 11663 | Browser inner width/height: 1024/697 03:52:05 INFO - PROCESS | 11663 | __metrics 03:52:06 INFO - PROCESS | 11663 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:06 INFO - PROCESS | 11663 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:06 INFO - PROCESS | 11663 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:06 INFO - PROCESS | 11663 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:06 INFO - PROCESS | 11663 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:06 INFO - PROCESS | 11663 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:06 INFO - PROCESS | 11663 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:52:06 INFO - PROCESS | 11663 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 03:52:07 INFO - TEST-INFO | 11663: exit 0 03:52:07 INFO - Browser initialized. 03:52:07 INFO - Running cycle 1/1 for kraken test... 03:52:07 INFO - TEST-INFO | started process 11745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv0qWYM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:19 INFO - PROCESS | 11745 | RSS: Main: 150536192 03:52:19 INFO - PROCESS | 11745 | 03:52:21 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48355/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:22 INFO - PROCESS | 11745 | RSS: Main: 194097152 03:52:22 INFO - PROCESS | 11745 | 03:52:25 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48355/tests/kraken/driver.html?testName=audio-dft) 03:52:25 INFO - PROCESS | 11745 | RSS: Main: 183988224 03:52:25 INFO - PROCESS | 11745 | 03:52:28 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48355/tests/kraken/driver.html?testName=audio-fft) 03:52:29 INFO - PROCESS | 11745 | RSS: Main: 169406464 03:52:29 INFO - PROCESS | 11745 | 03:52:31 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48355/tests/kraken/driver.html?testName=audio-oscillator) 03:52:32 INFO - PROCESS | 11745 | RSS: Main: 170713088 03:52:32 INFO - PROCESS | 11745 | 03:52:34 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:34 INFO - PROCESS | 11745 | RSS: Main: 171417600 03:52:34 INFO - PROCESS | 11745 | 03:52:37 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48355/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:38 INFO - PROCESS | 11745 | RSS: Main: 171474944 03:52:38 INFO - PROCESS | 11745 | 03:52:41 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48355/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:42 INFO - PROCESS | 11745 | RSS: Main: 172081152 03:52:42 INFO - PROCESS | 11745 | 03:52:45 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48355/tests/kraken/driver.html?testName=json-parse-financial) 03:52:45 INFO - PROCESS | 11745 | RSS: Main: 172646400 03:52:45 INFO - PROCESS | 11745 | 03:52:47 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:48 INFO - PROCESS | 11745 | RSS: Main: 183803904 03:52:48 INFO - PROCESS | 11745 | 03:52:50 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:50 INFO - PROCESS | 11745 | RSS: Main: 180563968 03:52:50 INFO - PROCESS | 11745 | 03:52:52 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:53 INFO - PROCESS | 11745 | RSS: Main: 191488000 03:52:53 INFO - PROCESS | 11745 | 03:52:56 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:56 INFO - PROCESS | 11745 | RSS: Main: 195526656 03:52:56 INFO - PROCESS | 11745 | 03:52:59 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:59 INFO - PROCESS | 11745 | RSS: Main: 195035136 03:52:59 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | Cycle 1(1): loaded http://localhost:48355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48355/tests/kraken/driver.html?testName=ai-astar) 03:53:01 INFO - PROCESS | 11745 | RSS: Main: 255774720 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | __start_tp_report 03:53:01 INFO - PROCESS | 11745 | _x_x_mozilla_page_load 03:53:01 INFO - PROCESS | 11745 | _x_x_mozilla_page_load_details 03:53:01 INFO - PROCESS | 11745 | |i|pagename|runs| 03:53:01 INFO - PROCESS | 11745 | |0;ai-astar;114;114;112;116;116;117;109;116;114;117 03:53:01 INFO - PROCESS | 11745 | |1;audio-beat-detection;166;136;154;176;143;159;160;133;181;135 03:53:01 INFO - PROCESS | 11745 | |2;audio-dft;161;161;164;160;160;160;161;161;162;163 03:53:01 INFO - PROCESS | 11745 | |3;audio-fft;74;74;107;92;74;73;74;109;94;73 03:53:01 INFO - PROCESS | 11745 | |4;audio-oscillator;98;99;139;97;99;98;147;98;97;139 03:53:01 INFO - PROCESS | 11745 | |5;imaging-gaussian-blur;120;116;114;115;114;115;115;116;115;116 03:53:01 INFO - PROCESS | 11745 | |6;imaging-darkroom;147;147;147;146;146;147;147;146;147;147 03:53:01 INFO - PROCESS | 11745 | |7;imaging-desaturate;95;95;96;95;96;96;96;96;96;95 03:53:01 INFO - PROCESS | 11745 | |8;json-parse-financial;68;68;68;70;67;68;69;80;66;67 03:53:01 INFO - PROCESS | 11745 | |9;json-stringify-tinderbox;70;70;69;71;71;71;70;71;71;70 03:53:01 INFO - PROCESS | 11745 | |10;stanford-crypto-aes;82;83;84;83;85;86;83;85;83;84 03:53:01 INFO - PROCESS | 11745 | |11;stanford-crypto-ccm;121;130;127;121;120;125;136;120;128;121 03:53:01 INFO - PROCESS | 11745 | |12;stanford-crypto-pbkdf2;153;139;139;150;151;137;150;154;149;150 03:53:01 INFO - PROCESS | 11745 | |13;stanford-crypto-sha256-iterative;72;71;70;70;70;70;71;70;70;68 03:53:01 INFO - PROCESS | 11745 | __end_tp_report 03:53:01 INFO - PROCESS | 11745 | __start_cc_report 03:53:01 INFO - PROCESS | 11745 | _x_x_mozilla_cycle_collect,1161 03:53:01 INFO - PROCESS | 11745 | __end_cc_report 03:53:01 INFO - PROCESS | 11745 | __startTimestamp1456746781877__endTimestamp 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | ------- Summary: start ------- 03:53:01 INFO - PROCESS | 11745 | Number of tests: 14 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:2.51 (2.2%) stddev-sans-first:2.65 03:53:01 INFO - PROCESS | 11745 | Values: 114.0 114.0 112.0 116.0 116.0 117.0 109.0 116.0 114.0 117.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:159.50 stddev:17.20 (10.8%) stddev-sans-first:17.72 03:53:01 INFO - PROCESS | 11745 | Values: 166.0 136.0 154.0 176.0 143.0 159.0 160.0 133.0 181.0 135.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 03:53:01 INFO - PROCESS | 11745 | Values: 161.0 161.0 164.0 160.0 160.0 160.0 161.0 161.0 162.0 163.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#3] audio-fft Cycles:10 Average:84.40 Median:74.00 stddev:14.75 (19.9%) stddev-sans-first:15.16 03:53:01 INFO - PROCESS | 11745 | Values: 74.0 74.0 107.0 92.0 74.0 73.0 74.0 109.0 94.0 73.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:98.00 stddev:21.22 (21.6%) stddev-sans-first:21.97 03:53:01 INFO - PROCESS | 11745 | Values: 98.0 99.0 139.0 97.0 99.0 98.0 147.0 98.0 97.0 139.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:1.71 (1.5%) stddev-sans-first:0.78 03:53:01 INFO - PROCESS | 11745 | Values: 120.0 116.0 114.0 115.0 114.0 115.0 115.0 116.0 115.0 116.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:53:01 INFO - PROCESS | 11745 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:53:01 INFO - PROCESS | 11745 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:68.00 stddev:3.98 (5.9%) stddev-sans-first:4.21 03:53:01 INFO - PROCESS | 11745 | Values: 68.0 68.0 68.0 70.0 67.0 68.0 69.0 80.0 66.0 67.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 03:53:01 INFO - PROCESS | 11745 | Values: 70.0 70.0 69.0 71.0 71.0 71.0 70.0 71.0 71.0 70.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.12 03:53:01 INFO - PROCESS | 11745 | Values: 82.0 83.0 84.0 83.0 85.0 86.0 83.0 85.0 83.0 84.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.34 (4.2%) stddev-sans-first:5.48 03:53:01 INFO - PROCESS | 11745 | Values: 121.0 130.0 127.0 121.0 120.0 125.0 136.0 120.0 128.0 121.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:150.00 stddev:6.32 (4.2%) stddev-sans-first:6.35 03:53:01 INFO - PROCESS | 11745 | Values: 153.0 139.0 139.0 150.0 151.0 137.0 150.0 154.0 149.0 150.0 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:0.87 03:53:01 INFO - PROCESS | 11745 | Values: 72.0 71.0 70.0 70.0 70.0 70.0 71.0 70.0 70.0 68.0 03:53:01 INFO - PROCESS | 11745 | -------- Summary: end -------- 03:53:01 INFO - PROCESS | 11745 | 03:53:01 INFO - PROCESS | 11745 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:53:01 INFO - PROCESS | 11745 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:53:01 INFO - PROCESS | 11745 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:53:01 INFO - PROCESS | 11745 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:53:01 INFO - PROCESS | 11745 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:53:02 INFO - TEST-INFO | 11745: exit 0 03:53:02 INFO - TEST-OK | kraken | took 61799ms 03:53:02 INFO - SUITE-END | took 1178s 03:53:03 INFO - Completed test suite (00:19:38) 03:53:03 INFO - Working with test: dromaeo_css 03:53:03 INFO - Generating results file: dromaeo_css 03:53:03 INFO - Working with test: kraken 03:53:03 INFO - Generating results file: kraken 03:53:03 INFO - javascript benchmark 03:53:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:53:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 03:53:03 INFO - process_Request line: dromaeo_css 5906.87 graph.html#tests=[[72,94,35]] 03:53:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:53:03 INFO - process_Request line: kraken 1549.10 graph.html#tests=[[232,94,35]] 03:53:03 INFO - RETURN: dromaeo_css: 5906.87 03:53:03 INFO - RETURN: kraken: 1549.10 03:53:03 INFO - javascript benchmark 03:53:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2541.339251794533, 2542.351700316419, 2544.5928651415766, 2548.1336345642476, 2573.3052075939504, 4276.379924910886, 4343.956560434394, 4360.6075453209205, 4370.956290437099, 4403.7798110094445, 4393.428854248951, 4395.934060989088, 4410.228210063242, 4428.844990425336, 4444.4000059991895, 4053.7770422626745, 4058.9594104059024, 4090.5295890972475, 4096.528899176596, 4209.494860616715, 3966.7024973126986, 4131.318332475138, 4164.021454958082, 4176.0395109124765, 4191.7694526801015, 3976.2842688315945, 4023.959760402388, 4042.8180731867137, 4050.6151915567975, 4076.408920706511, 4037.6769858411258, 4059.7158198926086, 4067.2068946555432, 4067.3898915162963, 4117.21772863155, 3915.8825235242703, 3993.7004724645476, 4044.737092089005, 4044.8179831907637, 4074.7555146691293, 4328.523862375137, 4368.257396242647, 4377.037051848588, 4411.867643970686, 4423.181711383404, 4670.252759558454, 4670.929936050962, 4678.461976872669, 4679.344891715163, 4721.716696998191, 4534.319852022223, 4686.43762748469, 4687.5781179693995, 4701.388819453483, 4767.785449654774, 4361.956380436155, 4364.170807546556, 4372.715773474714, 4382.320740285261, 4395.516493185747, 4777.283407488835, 4778.283257511401, 4783.976080119577, 4828.517148285214, 4836.709797412166, 4469.128519938581, 4555.2256116460285, 4604.516525764813, 4609.055143695601, 4615.469221039556, 4637.768111594407, 4641.396618439649, 4644.8374306899095, 4644.8374306899095, 4663.883402914954, 4613.377194078824, 4614.077184563033, 4615.676902616785, 4616.053708989649, 4657.278121891112, 4517.457905051415, 4572.9314060289125, 4645.46577143626, 4653.8371157010015, 4655.441347038377, 3985.6412922836503, 3989.501312335958, 3996.760194388346, 4000.599940005976, 4018.799060046986, 3508.2808024354945, 3509.280597477511, 3540.5574303212097, 3553.7157027437743, 3568.1436455250555, 3897.922041559153, 3979.8607048753156, 4000.6199411055904, 4076.8573099941955, 4078.3678529827926, 4649.697769644962, 4663.696859704176, 4673.556012178838, 4681.695689780154, 4734.668573199911, 4016.6786657067364, 4028.194361127786, 4031.5968403160036, 4064.9187016260103, 4071.4096456013713, 4091.6931230157857, 4191.559886211904, 4219.0507135894795, 4251.574842515785, 4256.808443620044, 4450.732956022649, 4467.664925130628, 4485.91028179428, 4487.2147374210035, 4530.569595888385, 4498.2577874650315, 4713.245880659215, 4714.57568818808, 4715.3869996900185, 4744.881377965578, 4423.845165419324, 4459.331100334846, 4467.419235499365, 4496.842610508616, 4502.707324023928, 4630.374899388539, 4640.791164397543, 4653.302004699322, 4656.068786242833, 4713.481517033192, 4510.0, 4696.882577935579, 4702.1536123496735, 4702.482726900107, 4711.952880471152, 4567.566081222279, 4575.9771201143785, 4584.335271385564, 4614.307853821953, 4617.0, 4549.226631472724, 4560.6351491879905, 4561.543845615544, 4565.086982603559, 4605.562471565196, 4297.742135471882, 4441.933370999503, 4487.102579484051, 4489.9775501122285, 4521.9547804521535, 4573.634109271316, 4589.151007063704, 4600.125976064537, 4613.907721845477, 4642.953570464252, 4496.505384407778, 4503.684742068024, 4504.707194032378, 4529.728216307032, 4546.340780586863], "unit": "score", "name": "dojo.html", "value": 4313.130625101311}, {"lowerIsBetter": false, "replicates": [463.3466811795365, 473.4815377162009, 508.7583397886004, 515.4253007896194, 534.1080395739117, 22112.0, 32944.17639559012, 33419.0, 33502.8324858376, 33537.0, 35903.82048089762, 36395.454068189, 36533.634663653356, 36541.26917461649, 36561.81719091401, 6625.403713665769, 7672.117706463759, 7851.332636725857, 9517.714468565953, 9728.221742260603, 9581.281403894702, 9684.418934863896, 9698.612055517771, 9705.951470242639, 9780.364276322052, 9393.859092113624, 9516.286278529104, 9529.142377186052, 9541.71374858752, 9542.952285238563, 9619.903800962005, 9740.269479789044, 9748.610055597768, 9760.999999999964, 9774.5601447935, 9228.676996305097, 9501.2874034447, 9504.04959504051, 9740.75648108796, 9761.853572196424, 36286.81856590726, 36721.265574688354, 36943.26113477742, 36963.81518092392, 36986.81506592477, 2708.404151086758, 2737.083077169151, 2877.395746893155, 3070.155707180521, 3549.378858699743, 26624.264874741482, 26727.198184054316, 27521.0, 28051.43897122046, 28421.71578284232, 2998.685138060516, 3007.9248018799485, 3023.9092827215, 3044.086773967823, 3063.816171029723, 222426.0, 223129.0, 223382.0, 223757.88121059453, 224576.0, 41363.586364135976, 52432.737836310574, 53187.0, 53267.20099198515, 53275.733621331645, 39253.0, 39356.80321598374, 39375.40936885949, 39461.0, 39549.60450395459, 9830.606775728891, 11138.0, 11201.27191732551, 11205.551777928791, 11207.103431725442, 9924.553395097239, 10089.192864570818, 10095.293329466867, 10101.0, 10124.34191777532, 13290.136141150795, 13635.250061246528, 13647.454101836014, 13650.317484125953, 13747.243901585309, 5367.221752845816, 5446.509814116748, 5483.287172667528, 5486.286782718221, 5527.203658810822, 832.7252006837729, 857.9227869491775, 871.5947084605689, 940.5656374029522, 1044.6552637629563, 26288.342791429986, 26565.203043908714, 26569.335766605604, 26905.192844214704, 26945.865270673523, 825.2366560931234, 870.6125774030496, 888.5823662878437, 902.1519771414848, 1012.1548506996593, 13705.931470342584, 15016.849831501764, 15692.68614627701, 15727.135007574694, 15884.76172857408, 316630.0, 319117.0, 323080.0, 323501.0, 323927.0, 46871.76564117226, 47007.0, 47287.29069063967, 47327.29009064867, 47381.52618473771, 957.0620791624248, 1062.5643486170634, 1170.8302296167008, 1240.3054289597674, 1256.0328547018744, 23149.0, 24220.03119875185, 24458.0, 24470.578847093566, 24702.382440439134, 30902.53646195264, 30990.380192395576, 31238.21904452407, 31454.0, 31520.0, 162321.0, 163382.0, 164157.0, 164389.0, 164396.0, 21573.352799416043, 24762.0, 28048.859755701906, 28145.296367590974, 28269.151925441445, 32764.0, 32905.0, 32913.67086329202, 32961.505577416836, 33358.499622505195, 27335.179944601692, 27508.44983100367, 27517.0, 27553.72446275592, 27710.307242318297, 28397.0, 28941.0, 28969.63415484823, 30554.541681874343, 31040.0, 27354.589681155197, 27587.310317241427, 27739.167824965283, 27818.44363112686, 27865.44269114647, 30285.0, 32475.512867307483, 34385.656143438246, 35529.1117722059, 36168.45747313845, 23139.190128345428, 23215.767842321362, 23393.41516462034, 23485.647715284627, 23530.88234558816], "unit": "score", "name": "ext.html", "value": 15810.24111714296}, {"lowerIsBetter": false, "replicates": [302.8758209134255, 309.05583442582906, 309.9907002789917, 315.7316281161012, 326.9901902942911, 11106.4446777661, 13972.161670299789, 14660.633484162889, 14670.413183472661, 15076.547703568884, 13794.655133621665, 14027.43890244389, 14076.0, 14387.280635968213, 14942.775858362133, 4906.779194936236, 5133.101707201244, 5143.177091665334, 5159.200323949775, 5167.224916262572, 3537.2925414917117, 5065.79736810529, 5131.204663277198, 5609.439056094398, 5823.67969761663, 5749.971250143743, 5775.682337471438, 5776.220210271623, 5779.190913272145, 5779.306483221998, 5594.552435805126, 5736.598438109334, 5737.282839645044, 5901.557383196277, 5911.0, 5128.102582048126, 5133.30700355451, 5135.178371460585, 5151.433342332378, 5152.407473140562, 18258.178381972844, 18492.075396230135, 18861.245550178115, 19022.714659280122, 19039.238430462763, 1676.7652528646, 1786.937457188992, 1906.8379187769056, 2339.415146213447, 2436.610142377229, 7990.920090799075, 8837.823243535158, 8958.955205223998, 12055.457504412323, 12212.816807747891, 1767.734839774044, 1784.5895444047812, 1824.7445357649806, 1830.9725354119698, 1834.4058087858425, 53313.46686533124, 56516.71741641306, 58446.41553584452, 58646.70676646632, 59166.40833591652, 9406.623735050658, 9474.90525094754, 9516.619335226653, 9587.712368628952, 9623.951880240555, 10229.59081636741, 12164.209326393757, 12208.450619722134, 12210.450529726184, 12215.0, 6339.144215530844, 6621.966890165615, 6724.93275067243, 6729.495287853332, 6783.423409010191, 6336.20797400325, 6383.36166383358, 6394.663790865296, 6471.676416179266, 6474.287828338879, 4043.130726893732, 4095.24238015968, 4095.3856921461424, 4149.37759336102, 4163.958360416357, 1669.991650041742, 1704.8209937956583, 1706.7525208844647, 1709.829017098305, 1715.2624371520367, 717.3042149115349, 766.769969009295, 773.9264769846856, 796.8764841449585, 874.2481465939287, 14501.20243386624, 15259.08445493274, 15313.387464501295, 15388.538343849703, 15925.681486370207, 846.2383854530848, 849.7493239494364, 868.9739307820776, 895.1630225738955, 895.8656201569686, 8306.584670766437, 8679.956600217085, 8759.956200218958, 8794.516301603346, 9057.728268151966, 268303.0, 270255.0, 270783.0, 360961.0, 363690.0, 64650.35349646537, 65401.67299163474, 66059.0, 66588.33411665919, 69106.65446672734, 784.6625950841079, 787.3504358903928, 816.7059858450953, 818.5497976113114, 820.1757233979812, 10363.844542332023, 14010.369533370818, 14121.717565648834, 14417.0, 14629.487967921072, 28182.85908570444, 28459.28851778722, 29120.41759164847, 29780.255493612833, 30094.69905300919, 39314.60685393224, 40351.59648403478, 40435.595644043184, 40729.1854162921, 40835.0, 6766.1204043476, 6783.898241526283, 7037.472189585699, 7181.461390395637, 7283.417326613964, 7183.317584829433, 7473.663685134291, 7837.0, 8143.144969778088, 8384.748457546284, 7188.60462674537, 7205.819854503469, 7237.63811809418, 7373.889391659237, 7629.122650894996, 7158.391536719437, 7340.339369456775, 7377.299156580117, 7423.257674232534, 7426.145993210634, 7446.441516886363, 7649.388048955959, 7659.808504787425, 7725.420593455401, 7748.728794492165, 9044.81910361776, 9336.95331523338, 9909.801803963735, 10110.342827716175, 10188.949055254676, 9750.658726944523, 10006.64246080689, 10070.94964525202, 10213.897861021593, 10222.28444008942], "unit": "score", "name": "jquery.html", "value": 7392.334228042349}, {"lowerIsBetter": false, "replicates": [1069.4118234970765, 1339.8258226430564, 1342.724741428007, 1455.9927200363998, 1733.2287132226156, 5570.080936645454, 6780.389764921156, 6965.024896514492, 6972.302769723025, 6972.79081627552, 6806.931930680692, 6949.305069493048, 6979.965100174492, 6981.266966968458, 6983.371496565308, 1636.3454618152716, 2004.4487765864358, 2041.8570700051002, 2064.1021155797275, 2073.409078412653, 2072.1504183284856, 2078.698588704637, 2081.0, 2081.5212501124674, 2082.6563617003253, 1988.3239698502507, 2015.5767288869356, 2041.9591608167827, 2044.2538473457155, 2045.1103769860083, 2005.8796472211714, 2038.1439795285942, 2044.5706401655596, 2046.294028560152, 2064.318774804311, 2021.8685785424047, 2022.7572691276994, 2025.5543780368444, 2025.9392218233477, 2029.0260674875994, 6612.107365505643, 6649.76725814599, 6656.800295991128, 6664.300248473889, 6672.566283191577, 4105.44576482174, 4217.536071032184, 4243.936340954888, 4250.978745106286, 4251.914961700749, 2485.155047283914, 2582.690077190749, 2594.0791019188105, 2596.2730435478097, 2605.9218223453136, 743.049495075427, 754.935830454412, 779.1779672445624, 798.441091236137, 805.9435839491238, 9276.536173191313, 9280.582373793262, 9308.488033158173, 9368.0, 9380.437173769596, 3726.6087060858217, 3831.5593706724085, 3915.040815000343, 3916.373380259145, 3967.0, 8120.187981201951, 8135.959320203361, 8143.592820358958, 8151.388645851466, 8167.795805104801, 3365.6802603752603, 4171.353440216772, 4187.246295666749, 4188.099558594917, 4194.49666040071, 3632.328019316435, 3730.8321125549414, 3736.962630373716, 3752.6810221130963, 3765.134019175605, 3335.9166020849675, 3356.328734253159, 3389.847456864447, 3415.7267418606452, 3434.7767395119236, 1064.2550214849637, 1109.2401704832216, 1115.1079136690614, 1117.0449265877558, 1124.2692250037542, 913.6710784117712, 914.1224424552371, 921.7050543825911, 933.9673111441067, 1189.2864281431246, 6685.832854178684, 6712.127423434922, 6718.496112791462, 6723.294054124344, 6738.494612904052, 405.70991740905396, 407.9408485769547, 410.0405052177918, 411.3890872054996, 412.54825965567653, 5211.42674305826, 5227.712475813867, 5308.708021058879, 5313.442088580643, 5314.202869569518, 8167.0, 8251.257386835214, 8331.750047498585, 8399.832003360021, 8471.872921906053, 8297.95851020753, 8306.501609903426, 8335.874961875577, 8379.37154713399, 8379.45533540318, 6365.745370185234, 6550.115734375799, 6616.073749675049, 6689.732410703615, 6707.798766037026, 6590.736370545316, 6788.389044985975, 6794.660266986532, 6831.521793474608, 6832.829179270558, 7572.432067594842, 7587.430942679432, 7752.612369381621, 7873.25204105609, 7884.250996155356, 7771.72798952034, 8011.238932301422, 8017.518948863087, 8036.758897233092, 8123.6750529978135, 4974.204127339608, 5077.289179514944, 5081.161608334583, 6076.66578338178, 6152.0, 5685.34618518859, 5847.415258474119, 6679.332066793476, 6683.498737594603, 6689.364510371702, 5937.524998000236, 5948.643081414956, 6030.758769649165, 6084.482818960438, 6084.726187321493, 5849.94150058511, 5854.765809367577, 5979.372165922516, 6053.122297266784, 6068.180795592715, 6377.362263773585, 6419.967900160469, 6458.0, 6458.095866578777, 6517.185351831021, 5980.760769569342, 5981.521478281814, 6023.156758053964, 6024.759009639565, 6041.184440100706, 5973.701314934149, 6005.789797357072, 6005.849853753691, 6015.368386319374, 6024.3975602439405], "unit": "score", "name": "mootools.html", "value": 3880.462729751119}, {"lowerIsBetter": false, "replicates": [285.63581433672067, 293.8780406131456, 297.18571115144505, 298.7415885259251, 299.57609981875635, 5194.117000109981, 5272.657277276974, 5283.418823929364, 5285.048691235581, 5292.523672869441, 5175.378954525462, 5244.082285600024, 5296.894062118765, 5316.6544174628625, 5322.600804939635, 3802.182530755887, 3891.571927088018, 3969.940450893239, 3975.0, 3977.8408863645564, 3978.4231286463446, 3991.880243592697, 3995.7802320872343, 3996.500437445319, 3998.2403343364813, 3937.9803100984454, 3957.515931525678, 3958.2677204717074, 3959.485266915297, 3964.444977703124, 3755.0, 3876.3216437123533, 3915.8629447969183, 3945.191235796655, 3953.2291203215386, 3416.5558477398026, 3418.8974330770116, 3425.4519276915576, 3429.2798512312443, 3431.7769344992494, 5009.949900500985, 5018.121828679967, 5046.243063540462, 5089.109405853961, 5092.541671249568, 4545.749918772331, 4568.451785785694, 4571.245744452194, 4575.565321294472, 4582.862514124582, 5491.615586908918, 5496.285482887199, 5497.39528651848, 5500.0, 5505.201745746885, 3758.0, 3758.3610786166146, 3760.2479504099015, 3762.1535154590274, 3762.6237376262156, 5565.638233514849, 5715.0, 5805.7387417566315, 5808.622439541458, 5834.6790926499025, 3815.21788033458, 3822.808859557011, 3841.8079096045085, 3847.019010152393, 3851.1527463957887, 3908.472356231929, 3911.119998000484, 3913.5519857652853, 3915.9216815663526, 3917.6082391761165, 4535.387722657465, 4535.863924082283, 4536.364908912755, 4543.863684089417, 4544.318352247189, 5523.088690366045, 5526.861828454241, 5527.53015993637, 5534.280543529396, 5536.280283563192, 1359.592122363287, 1381.702933869223, 1383.4466213514675, 1384.1279993603964, 1384.4047059764398, 841.9769979474968, 889.7508697564692, 927.8051609162017, 939.9013103624158, 940.830650482906, 4652.232381656989, 4653.371794807726, 4662.184117779375, 4663.020765639186, 4665.510121437268, 5575.581831362664, 5699.316082070178, 5705.971470142623, 5707.200991861143, 5709.143628455682, 4764.118638051971, 4786.64100192487, 4790.520947905182, 4795.592374648194, 4797.784099715521, 3016.7435767959532, 3056.66376698563, 3057.0370333344927, 3057.220408795743, 3062.938741225163, 5375.0, 5383.623146379716, 5385.542228910586, 5386.676799392049, 5390.137577987582, 5728.140778883201, 5824.388439213822, 5826.854328641818, 5967.731452084667, 5968.0, 5473.507384335429, 5476.17857321405, 5483.533899618497, 5496.395396506301, 5502.58730595207, 5786.884262314814, 5798.478136967693, 5798.623089499169, 5798.6810725410505, 5801.3038435388025, 5646.3788983212635, 5658.745356458887, 5660.773569057192, 5662.66024038559, 5664.26364572603, 5488.231647569263, 5489.451054894638, 5494.972525137348, 5496.725163741717, 5505.091659876076, 3764.887053388403, 3887.086534664295, 3906.5507466640565, 3914.6868250540456, 3932.803359832054, 5719.170720245625, 5741.655500669973, 5744.942550574441, 5747.0, 5748.597598168088, 5505.366882808528, 5510.779568817203, 5520.585956053393, 5521.309836270466, 5524.06090964529, 5311.44229855875, 5373.623846330719, 5477.096279113902, 5499.175123731312, 5504.2018907257425, 5366.168243922199, 5368.570514358764, 5369.812056578001, 5372.301600792029, 5376.623636345418, 5527.198556209408, 5529.142982837667, 5530.0, 5531.778728850801, 5534.308211473566, 5374.838754837361, 5392.460753924733, 5401.378841433286, 5403.5136837684795, 5415.702136382537], "unit": "score", "name": "prototype.html", "value": 4098.302484852959}, {"lowerIsBetter": false, "replicates": [563.8054871069485, 582.6504097541475, 595.7021489255372, 601.1373678770962, 605.4097255176202, 10159.034891685296, 10163.39019658819, 10278.845817312746, 10310.0, 10357.689269321914, 10927.562897484091, 11001.834972475399, 11852.822207666892, 11975.820362694567, 12012.939935300312, 389.8577019387917, 756.2059837170976, 770.6724642027116, 772.119783446871, 772.2162005564329, 761.7714685594327, 782.0693374883898, 784.0356361675143, 784.0747917457398, 784.6586734770365, 826.6652005937605, 828.204923273658, 828.8715249136394, 829.4649950781742, 829.6971605364029, 421.0547321263752, 431.0860974733585, 819.0580832043139, 819.8770184472347, 821.1624143373725, 307.27176591478116, 600.3666132230495, 608.9330173680892, 609.0894113300644, 609.9390060993909, 11485.483153258123, 11543.538258469735, 11566.074714022858, 11618.76762464746, 11631.418429078596, 10547.628808254954, 10887.945560272226, 10929.781404371868, 11242.94378528102, 11327.830082548768, 8881.467111973303, 9270.629174832999, 9408.858867116998, 9412.435253884789, 9575.952120239424, 2714.954717470954, 2751.3946931675, 2770.7783377329765, 2797.5384061629807, 2818.760405365526, 39520.20959580821, 39717.20565588672, 39812.99999999971, 39980.600193997976, 40433.0, 8830.646774128963, 8947.955260223787, 9173.44959302444, 9263.351565390492, 9371.0, 15112.0, 15130.319135638923, 15136.318865651072, 15143.394264229528, 15260.542183734506, 5550.306211723535, 5683.232763576947, 5760.94239057604, 5829.650220986754, 6046.18376519173, 3183.4428974929297, 3219.2595702987974, 3222.0494953988627, 3244.383567122239, 3331.1339051846694, 2539.441322908957, 2561.3724637463943, 2567.6020216866414, 2577.6649035625624, 2579.2262321303533, 452.94791099023377, 483.29439019032606, 495.62332627203585, 501.6563653897092, 501.7315736081179, 403.8364462392677, 437.0886701227975, 525.3144646236622, 538.5099559400926, 550.2736387967844, 6883.7590684325805, 6894.413974812097, 6930.44556435484, 7001.649917504104, 7227.819304517429, 525.1807180797967, 537.5511447941013, 551.737924485874, 557.2310211907542, 557.6626141184606, 3277.901662950115, 3381.239221175216, 3436.810975396377, 3452.741044421628, 3484.4424892017664, 45084.77457612691, 45249.773751131695, 45717.54282457133, 45751.77124114425, 46036.769816151376, 37934.430983534716, 38492.42261366082, 38709.0, 38714.41928371077, 39106.413403798964, 37536.62463375386, 37829.0, 38162.61837381591, 38227.42658860119, 39746.80126599348, 7693.49992250502, 7697.692092316244, 7823.178566250689, 7897.723579674684, 8165.877511837446, 27904.30239244035, 28671.426571468037, 28965.85517072401, 29228.561571576018, 29343.413131737674, 33933.66066339305, 33992.490112647836, 36052.27895442024, 36253.818730906176, 36404.27191456103, 8765.824683506422, 9031.50326732036, 9048.90951090507, 9183.632654694005, 9286.907130928605, 10583.576656933636, 10794.514246858753, 10843.403612801372, 10950.616728414787, 10957.232993690364, 9990.950045249727, 10178.847317290394, 10376.533056012346, 10545.57817687284, 10624.203184761329, 9766.85349719769, 9836.655717049869, 9968.55141518619, 10383.636572719919, 10427.217958653284, 9563.856542152012, 9732.221422286342, 9754.75613109678, 9757.121859032437, 9824.803503930025, 8460.53467059293, 8508.0, 8508.796370004846, 8607.612657430305, 8856.335774817044, 7994.5602991836, 8144.267015968354, 8270.2556769891, 8345.874811877948, 8374.413791034569], "unit": "score", "name": "yui.html", "value": 5297.831364908226}], "name": "dromaeo_css", "value": 5906.868854419436}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 114.0, 112.0, 116.0, 116.0, 117.0, 109.0, 116.0, 114.0, 117.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [166.0, 136.0, 154.0, 176.0, 143.0, 159.0, 160.0, 133.0, 181.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 154.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 164.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 107.0, 92.0, 74.0, 73.0, 74.0, 109.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 139.0, 97.0, 99.0, 98.0, 147.0, 98.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 114.0, 115.0, 114.0, 115.0, 115.0, 116.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 67.0, 68.0, 69.0, 80.0, 66.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 71.0, 71.0, 71.0, 70.0, 71.0, 71.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 83.0, 85.0, 86.0, 83.0, 85.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [121.0, 130.0, 127.0, 121.0, 120.0, 125.0, 136.0, 120.0, 128.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [153.0, 139.0, 139.0, 150.0, 151.0, 137.0, 150.0, 154.0, 149.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1549.1000000000004}]} 03:53:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1549.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5906.87"}}} 03:53:03 INFO - Return code: 0 03:53:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:53:03 INFO - # TBPL SUCCESS # 03:53:03 INFO - Running post-action listener: _resource_record_post_action 03:53:03 INFO - Running post-run listener: _resource_record_post_run 03:53:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 536293376; Read time: 0; Write time: 425608 03:53:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 195129344; Read time: 0; Write time: 180192 03:53:04 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 291094528; Read time: 0; Write time: 202980 03:53:04 INFO - Running post-run listener: _upload_blobber_files 03:53:04 INFO - Blob upload gear active. 03:53:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:53:04 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:04 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:05 INFO - (blobuploader) - INFO - Done attempting. 03:53:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:53:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:06 INFO - (blobuploader) - INFO - Done attempting. 03:53:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:06 INFO - Return code: 0 03:53:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c473dcc0437d871f9838fef109f16be2d02c3fc7a835063ff4399d349ecec04082eeae3860ce051aee0dd8f4e416cdc3fff21435dfb93defc4de3d47bef342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87da194f89e4aece20898bbb84ffbef85d2bc18ceb64abc2bd11b4b293b8f18a46b9a9415f482f218fba4357dfdbee9f217199400895ba775d83e5b41fc30076"} 03:53:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:06 INFO - Contents: 03:53:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c473dcc0437d871f9838fef109f16be2d02c3fc7a835063ff4399d349ecec04082eeae3860ce051aee0dd8f4e416cdc3fff21435dfb93defc4de3d47bef342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87da194f89e4aece20898bbb84ffbef85d2bc18ceb64abc2bd11b4b293b8f18a46b9a9415f482f218fba4357dfdbee9f217199400895ba775d83e5b41fc30076"} 03:53:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:06 INFO - Copying logs to upload dir... 03:53:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.535400 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-02-29 03:53:05.436927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 03:53:05.440808) ========= 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 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-Non-PGO/sha512/c1c473dcc0437d871f9838fef109f16be2d02c3fc7a835063ff4399d349ecec04082eeae3860ce051aee0dd8f4e416cdc3fff21435dfb93defc4de3d47bef342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87da194f89e4aece20898bbb84ffbef85d2bc18ceb64abc2bd11b4b293b8f18a46b9a9415f482f218fba4357dfdbee9f217199400895ba775d83e5b41fc30076"} build_url:https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/YlN4fQ56SQShul-Wnsjzzg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c473dcc0437d871f9838fef109f16be2d02c3fc7a835063ff4399d349ecec04082eeae3860ce051aee0dd8f4e416cdc3fff21435dfb93defc4de3d47bef342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87da194f89e4aece20898bbb84ffbef85d2bc18ceb64abc2bd11b4b293b8f18a46b9a9415f482f218fba4357dfdbee9f217199400895ba775d83e5b41fc30076"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 03:53:05.465895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:53:05.466279) ========= 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=920470bf432669ad7e3a5387000001ca-1456733966.999568-1064951389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 03:53:05.550383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 03:53:05.550726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 03:53:05.551065) ========= ========= Total master_lag: 0.43 =========