builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1460562369.08 results: success (0) buildid: 20160413025454 builduid: 92a52cbcfb084946925fc427cda60a3b revision: 564b225d553547fe4aa9a1039278f695c9507db9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.077994) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.078409) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.078706) ========= 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006413 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.140040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.140380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.166550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.166811) ========= 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.219726) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.220044) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.220624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.220912) ========= 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 08:46:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-13 08:46:10 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.394655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.394938) ========= 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.447395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.447732) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 564b225d553547fe4aa9a1039278f695c9507db9 --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 564b225d553547fe4aa9a1039278f695c9507db9 --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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 08:46:10,118 truncating revision to first 12 chars 2016-04-13 08:46:10,118 Setting DEBUG logging. 2016-04-13 08:46:10,118 attempt 1/10 2016-04-13 08:46:10,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/564b225d5535?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 08:46:10,385 unpacking tar archive at: mozilla-central-564b225d5535/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.011907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.012254) ========= echo 564b225d553547fe4aa9a1039278f695c9507db9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'564b225d553547fe4aa9a1039278f695c9507db9'] 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 564b225d553547fe4aa9a1039278f695c9507db9 program finished with exit code 0 elapsedTime=0.004730 script_repo_revision: '564b225d553547fe4aa9a1039278f695c9507db9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.062444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.062724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.072390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-13 08:46:10.072671) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:10 INFO - MultiFileLogger online at 20160413 08:46:10 in /builds/slave/test 08:46:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 08:46:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:10 INFO - {'append_to_log': False, 08:46:10 INFO - 'base_work_dir': '/builds/slave/test', 08:46:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:46:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:10 INFO - 'branch': 'Firefox-Non-PGO', 08:46:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:10 INFO - 'config_files': ('talos/linux_config.py',), 08:46:10 INFO - 'default_actions': ('clobber', 08:46:10 INFO - 'read-buildbot-config', 08:46:10 INFO - 'download-and-extract', 08:46:10 INFO - 'populate-webroot', 08:46:10 INFO - 'create-virtualenv', 08:46:10 INFO - 'install', 08:46:10 INFO - 'run-tests'), 08:46:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:10 INFO - 'download_minidump_stackwalk': True, 08:46:10 INFO - 'download_symbols': 'ondemand', 08:46:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:10 INFO - 'installer_path': 'installer.exe', 08:46:10 INFO - 'log_level': 'info', 08:46:10 INFO - 'log_name': 'talos', 08:46:10 INFO - 'log_to_console': True, 08:46:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:10 INFO - 'opt_config_files': (), 08:46:10 INFO - 'pip_index': False, 08:46:10 INFO - 'sps_profile': False, 08:46:10 INFO - 'sps_profile_interval': 0, 08:46:10 INFO - 'suite': 'dromaeojs-e10s', 08:46:10 INFO - 'system_bits': '32', 08:46:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:10 INFO - 'title': 'talos-linux64-ix-065', 08:46:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:10 INFO - 'use_talos_json': True, 08:46:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:10 INFO - 'work_dir': 'build'} 08:46:10 INFO - ##### 08:46:10 INFO - ##### Running clobber step. 08:46:10 INFO - ##### 08:46:10 INFO - Running pre-action listener: _resource_record_pre_action 08:46:10 INFO - Running main action method: clobber 08:46:10 INFO - rmtree: /builds/slave/test/build 08:46:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:11 INFO - Running post-action listener: _resource_record_post_action 08:46:11 INFO - ##### 08:46:11 INFO - ##### Running read-buildbot-config step. 08:46:11 INFO - ##### 08:46:11 INFO - Running pre-action listener: _resource_record_pre_action 08:46:11 INFO - Running main action method: read_buildbot_config 08:46:11 INFO - Using buildbot properties: 08:46:11 INFO - { 08:46:11 INFO - "project": "", 08:46:11 INFO - "product": "firefox", 08:46:11 INFO - "script_repo_revision": "production", 08:46:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:46:11 INFO - "repository": "", 08:46:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:46:11 INFO - "buildid": "20160413025454", 08:46:11 INFO - "pgo_build": "False", 08:46:11 INFO - "basedir": "/builds/slave/test", 08:46:11 INFO - "buildnumber": 316, 08:46:11 INFO - "slavename": "talos-linux64-ix-065", 08:46:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:46:11 INFO - "platform": "ubuntu64_hw", 08:46:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:46:11 INFO - "branch": "mozilla-central", 08:46:11 INFO - "repo_path": "mozilla-central", 08:46:11 INFO - "revision": "564b225d553547fe4aa9a1039278f695c9507db9", 08:46:11 INFO - "stage_platform": "linux64", 08:46:11 INFO - "builduid": "92a52cbcfb084946925fc427cda60a3b", 08:46:11 INFO - "slavebuilddir": "test" 08:46:11 INFO - } 08:46:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:46:11 INFO - Running post-action listener: _resource_record_post_action 08:46:11 INFO - ##### 08:46:11 INFO - ##### Running download-and-extract step. 08:46:11 INFO - ##### 08:46:11 INFO - Running pre-action listener: _resource_record_pre_action 08:46:11 INFO - Running main action method: download_and_extract 08:46:11 INFO - mkdir: /builds/slave/test/build/tests 08:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:11 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:46:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:46:12 INFO - Downloaded 1361 bytes. 08:46:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:12 INFO - Using the following test package requirements: 08:46:12 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:46:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'jsshell-linux-x86_64.zip'], 08:46:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:12 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46:12 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')]} 08:46:12 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:46:13 INFO - Downloaded 22198810 bytes. 08:46:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:46:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:46:14 INFO - Return code: 0 08:46:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:14 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:46:22 INFO - Downloaded 22198810 bytes. 08:46:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:46:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:46:24 INFO - Return code: 0 08:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:24 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:46:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:46:25 INFO - Downloaded 10841076 bytes. 08:46:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:46:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:46:25 INFO - Return code: 0 08:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:25 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:46:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:46:27 INFO - Downloaded 54152078 bytes. 08:46:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:27 INFO - mkdir: /builds/slave/test/properties 08:46:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:27 INFO - Contents: 08:46:27 INFO - build_url:https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:28 INFO - Running post-action listener: _resource_record_post_action 08:46:28 INFO - Running post-action listener: set_extra_try_arguments 08:46:28 INFO - ##### 08:46:28 INFO - ##### Running populate-webroot step. 08:46:28 INFO - ##### 08:46:28 INFO - Running pre-action listener: _resource_record_pre_action 08:46:28 INFO - Running main action method: populate_webroot 08:46:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:28 INFO - '--tppagecycles', 08:46:28 INFO - '7'], 08:46:28 INFO - 'tests': ['tsvgm']}}, 08:46:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['damp', 'tps']}, 08:46:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'tests': ['damp', 'tps']}, 08:46:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['dromaeo_dom']}, 08:46:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['a11yr', 08:46:28 INFO - 'ts_paint', 08:46:28 INFO - 'tpaint', 08:46:28 INFO - 'sessionrestore', 08:46:28 INFO - 'sessionrestore_no_auto_restore', 08:46:28 INFO - 'tabpaint']}, 08:46:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:28 INFO - 'ts_paint', 08:46:28 INFO - 'tpaint', 08:46:28 INFO - 'sessionrestore', 08:46:28 INFO - 'sessionrestore_no_auto_restore', 08:46:28 INFO - 'tabpaint']}, 08:46:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:28 INFO - 'ts_paint', 08:46:28 INFO - 'tpaint', 08:46:28 INFO - 'sessionrestore', 08:46:28 INFO - 'sessionrestore_no_auto_restore', 08:46:28 INFO - 'tabpaint']}, 08:46:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:28 INFO - 'ts_paint', 08:46:28 INFO - 'tpaint', 08:46:28 INFO - 'sessionrestore', 08:46:28 INFO - 'sessionrestore_no_auto_restore', 08:46:28 INFO - 'tabpaint']}, 08:46:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['a11yr', 08:46:28 INFO - 'ts_paint', 08:46:28 INFO - 'tpaint', 08:46:28 INFO - 'sessionrestore', 08:46:28 INFO - 'sessionrestore_no_auto_restore', 08:46:28 INFO - 'tabpaint']}, 08:46:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['a11yr', 08:46:28 INFO - 'ts_paint', 08:46:28 INFO - 'tpaint', 08:46:28 INFO - 'sessionrestore', 08:46:28 INFO - 'sessionrestore_no_auto_restore', 08:46:28 INFO - 'tabpaint']}, 08:46:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['tsvgx', 08:46:28 INFO - 'tsvgr_opacity', 08:46:28 INFO - 'tart', 08:46:28 INFO - 'tscrollx', 08:46:28 INFO - 'cart']}, 08:46:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:28 INFO - 'tsvgr_opacity', 08:46:28 INFO - 'tart', 08:46:28 INFO - 'tscrollx', 08:46:28 INFO - 'cart']}, 08:46:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'talos_options': ['--disable-e10s'], 08:46:28 INFO - 'tests': ['tp5o']}, 08:46:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'tests': ['tp5o']}, 08:46:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'talos_options': ['--disable-e10s', 08:46:28 INFO - '--xperf_path', 08:46:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:28 INFO - 'tests': ['tp5n']}, 08:46:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:28 INFO - 'talos_options': ['--xperf_path', 08:46:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:28 INFO - 'tests': ['tp5n']}}, 08:46:28 INFO - 'talos.zip': {'path': '', 08:46:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:28 INFO - Running post-action listener: _resource_record_post_action 08:46:28 INFO - ##### 08:46:28 INFO - ##### Running create-virtualenv step. 08:46:28 INFO - ##### 08:46:28 INFO - Running pre-action listener: _resource_record_pre_action 08:46:28 INFO - Running main action method: create_virtualenv 08:46:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:28 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 08:46:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:28 INFO - Using real prefix '/usr' 08:46:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:30 INFO - Installing pip.................done. 08:46:30 INFO - Return code: 0 08:46:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:30 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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:30 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 08:46:30 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 08:46:30 INFO - Using env: {'DISPLAY': ':0', 08:46:30 INFO - 'HOME': '/home/cltbld', 08:46:30 INFO - 'LANG': 'en_US.UTF-8', 08:46:30 INFO - 'LANGUAGE': 'en_US:en', 08:46:30 INFO - 'LOGNAME': 'cltbld', 08:46:30 INFO - 'MAIL': '/var/mail/cltbld', 08:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:30 INFO - 'MOZ_NO_REMOTE': '1', 08:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:30 INFO - 'NO_EM_RESTART': '1', 08:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:30 INFO - 'PWD': '/builds/slave/test', 08:46:30 INFO - 'SHELL': '/bin/bash', 08:46:30 INFO - 'SHLVL': '1', 08:46:30 INFO - 'TERM': 'linux', 08:46:30 INFO - 'TMOUT': '86400', 08:46:30 INFO - 'USER': 'cltbld', 08:46:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:30 INFO - '_': '/tools/buildbot/bin/python'} 08:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:30 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 08:46:30 INFO - Cleaning up... 08:46:30 INFO - Return code: 0 08:46:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:30 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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:30 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 08:46:30 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 08:46:30 INFO - Using env: {'DISPLAY': ':0', 08:46:30 INFO - 'HOME': '/home/cltbld', 08:46:30 INFO - 'LANG': 'en_US.UTF-8', 08:46:30 INFO - 'LANGUAGE': 'en_US:en', 08:46:30 INFO - 'LOGNAME': 'cltbld', 08:46:30 INFO - 'MAIL': '/var/mail/cltbld', 08:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:30 INFO - 'MOZ_NO_REMOTE': '1', 08:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:30 INFO - 'NO_EM_RESTART': '1', 08:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:30 INFO - 'PWD': '/builds/slave/test', 08:46:30 INFO - 'SHELL': '/bin/bash', 08:46:30 INFO - 'SHLVL': '1', 08:46:30 INFO - 'TERM': 'linux', 08:46:30 INFO - 'TMOUT': '86400', 08:46:30 INFO - 'USER': 'cltbld', 08:46:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:30 INFO - '_': '/tools/buildbot/bin/python'} 08:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:31 INFO - Downloading/unpacking psutil>=0.7.1 08:46:31 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 08:46:31 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 08:46:31 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 08:46:31 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 08:46:31 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 08:46:31 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 08:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:33 INFO - Installing collected packages: psutil 08:46:33 INFO - Running setup.py install for psutil 08:46:33 INFO - building 'psutil._psutil_linux' extension 08:46:33 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 08:46:33 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 08:46:33 INFO - building 'psutil._psutil_posix' extension 08:46:33 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 08:46:33 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 08:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:33 INFO - Successfully installed psutil 08:46:33 INFO - Cleaning up... 08:46:33 INFO - Return code: 0 08:46:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:46:33 INFO - Using env: {'DISPLAY': ':0', 08:46:33 INFO - 'HOME': '/home/cltbld', 08:46:33 INFO - 'LANG': 'en_US.UTF-8', 08:46:33 INFO - 'LANGUAGE': 'en_US:en', 08:46:33 INFO - 'LOGNAME': 'cltbld', 08:46:33 INFO - 'MAIL': '/var/mail/cltbld', 08:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:33 INFO - 'MOZ_NO_REMOTE': '1', 08:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:33 INFO - 'NO_EM_RESTART': '1', 08:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:33 INFO - 'PWD': '/builds/slave/test', 08:46:33 INFO - 'SHELL': '/bin/bash', 08:46:33 INFO - 'SHLVL': '1', 08:46:33 INFO - 'TERM': 'linux', 08:46:33 INFO - 'TMOUT': '86400', 08:46:33 INFO - 'USER': 'cltbld', 08:46:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:33 INFO - '_': '/tools/buildbot/bin/python'} 08:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:46:35 INFO - Installing collected packages: mozsystemmonitor 08:46:35 INFO - Running setup.py install for mozsystemmonitor 08:46:35 INFO - Successfully installed mozsystemmonitor 08:46:35 INFO - Cleaning up... 08:46:35 INFO - Return code: 0 08:46:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:46:35 INFO - Using env: {'DISPLAY': ':0', 08:46:35 INFO - 'HOME': '/home/cltbld', 08:46:35 INFO - 'LANG': 'en_US.UTF-8', 08:46:35 INFO - 'LANGUAGE': 'en_US:en', 08:46:35 INFO - 'LOGNAME': 'cltbld', 08:46:35 INFO - 'MAIL': '/var/mail/cltbld', 08:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:35 INFO - 'MOZ_NO_REMOTE': '1', 08:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:35 INFO - 'NO_EM_RESTART': '1', 08:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:35 INFO - 'PWD': '/builds/slave/test', 08:46:35 INFO - 'SHELL': '/bin/bash', 08:46:35 INFO - 'SHLVL': '1', 08:46:35 INFO - 'TERM': 'linux', 08:46:35 INFO - 'TMOUT': '86400', 08:46:35 INFO - 'USER': 'cltbld', 08:46:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:35 INFO - '_': '/tools/buildbot/bin/python'} 08:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:38 INFO - Downloading docopt-0.6.1.tar.gz 08:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:38 INFO - Running setup.py install for blobuploader 08:46:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:38 INFO - Running setup.py install for requests 08:46:39 INFO - Running setup.py install for docopt 08:46:39 INFO - Successfully installed blobuploader requests docopt 08:46:39 INFO - Cleaning up... 08:46:39 INFO - Return code: 0 08:46:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:39 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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:39 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 08:46:39 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 08:46:39 INFO - Using env: {'DISPLAY': ':0', 08:46:39 INFO - 'HOME': '/home/cltbld', 08:46:39 INFO - 'LANG': 'en_US.UTF-8', 08:46:39 INFO - 'LANGUAGE': 'en_US:en', 08:46:39 INFO - 'LOGNAME': 'cltbld', 08:46:39 INFO - 'MAIL': '/var/mail/cltbld', 08:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:39 INFO - 'MOZ_NO_REMOTE': '1', 08:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:39 INFO - 'NO_EM_RESTART': '1', 08:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:39 INFO - 'PWD': '/builds/slave/test', 08:46:39 INFO - 'SHELL': '/bin/bash', 08:46:39 INFO - 'SHLVL': '1', 08:46:39 INFO - 'TERM': 'linux', 08:46:39 INFO - 'TMOUT': '86400', 08:46:39 INFO - 'USER': 'cltbld', 08:46:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:39 INFO - '_': '/tools/buildbot/bin/python'} 08:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:39 INFO - Running setup.py (path:/tmp/pip-yITXrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:39 INFO - Running setup.py (path:/tmp/pip-DXdpeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:39 INFO - Running setup.py (path:/tmp/pip-3Li45H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:39 INFO - Running setup.py (path:/tmp/pip-M5a_hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:39 INFO - Running setup.py (path:/tmp/pip-Ha1tZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:39 INFO - Running setup.py (path:/tmp/pip-4X49wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:40 INFO - Running setup.py (path:/tmp/pip-7DllHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:40 INFO - Running setup.py (path:/tmp/pip-tQ3u0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:40 INFO - Running setup.py (path:/tmp/pip-LLkfcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:40 INFO - Running setup.py (path:/tmp/pip-Pu6wAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:40 INFO - Running setup.py (path:/tmp/pip-P3taLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:40 INFO - Running setup.py (path:/tmp/pip-xfwzED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:40 INFO - Running setup.py (path:/tmp/pip-phnvrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:40 INFO - Running setup.py (path:/tmp/pip-RQhqBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:40 INFO - Running setup.py (path:/tmp/pip-quzmGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:40 INFO - Running setup.py (path:/tmp/pip-TIwUPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:40 INFO - Running setup.py (path:/tmp/pip-D6rtkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:40 INFO - Running setup.py install for manifestparser 08:46:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:40 INFO - Running setup.py install for mozcrash 08:46:41 INFO - Running setup.py install for mozdebug 08:46:41 INFO - Running setup.py install for mozdevice 08:46:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for mozfile 08:46:41 INFO - Running setup.py install for mozhttpd 08:46:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for mozinfo 08:46:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for mozInstall 08:46:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for mozleak 08:46:41 INFO - Running setup.py install for mozlog 08:46:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for moznetwork 08:46:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for mozprocess 08:46:42 INFO - Running setup.py install for mozprofile 08:46:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozrunner 08:46:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozscreenshot 08:46:42 INFO - Running setup.py install for moztest 08:46:42 INFO - Running setup.py install for mozversion 08:46:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:42 INFO - Cleaning up... 08:46:42 INFO - Return code: 0 08:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:42 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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:42 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 08:46:42 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 08:46:42 INFO - Using env: {'DISPLAY': ':0', 08:46:42 INFO - 'HOME': '/home/cltbld', 08:46:42 INFO - 'LANG': 'en_US.UTF-8', 08:46:42 INFO - 'LANGUAGE': 'en_US:en', 08:46:42 INFO - 'LOGNAME': 'cltbld', 08:46:42 INFO - 'MAIL': '/var/mail/cltbld', 08:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:42 INFO - 'MOZ_NO_REMOTE': '1', 08:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:42 INFO - 'NO_EM_RESTART': '1', 08:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:42 INFO - 'PWD': '/builds/slave/test', 08:46:42 INFO - 'SHELL': '/bin/bash', 08:46:42 INFO - 'SHLVL': '1', 08:46:42 INFO - 'TERM': 'linux', 08:46:42 INFO - 'TMOUT': '86400', 08:46:42 INFO - 'USER': 'cltbld', 08:46:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:42 INFO - '_': '/tools/buildbot/bin/python'} 08:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:42 INFO - Running setup.py (path:/tmp/pip-fVt1zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:42 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)) 08:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:42 INFO - Running setup.py (path:/tmp/pip-cD6yIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:43 INFO - Running setup.py (path:/tmp/pip-VrwZEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:43 INFO - Running setup.py (path:/tmp/pip-yxd2S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:43 INFO - Running setup.py (path:/tmp/pip-jmfLqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:43 INFO - Running setup.py (path:/tmp/pip-HdqoXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:43 INFO - Running setup.py (path:/tmp/pip-uZJtIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:43 INFO - Running setup.py (path:/tmp/pip-IbNByg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:43 INFO - Running setup.py (path:/tmp/pip-cq6l5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:43 INFO - Running setup.py (path:/tmp/pip-U_FAmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:43 INFO - Running setup.py (path:/tmp/pip-rmpUA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:43 INFO - Running setup.py (path:/tmp/pip-WWlTpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:43 INFO - Running setup.py (path:/tmp/pip-4ofv3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:43 INFO - Running setup.py (path:/tmp/pip-llxnXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:43 INFO - Running setup.py (path:/tmp/pip-6jjabk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:43 INFO - Running setup.py (path:/tmp/pip-qSsT1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:44 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)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:44 INFO - Running setup.py (path:/tmp/pip-T14x45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:44 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)) 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:44 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)) 08:46:44 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)) 08:46:44 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)) 08:46:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:45 INFO - Downloading blessings-1.6.tar.gz 08:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:46 INFO - Installing collected packages: blessings 08:46:46 INFO - Running setup.py install for blessings 08:46:46 INFO - Successfully installed blessings 08:46:46 INFO - Cleaning up... 08:46:46 INFO - Return code: 0 08:46:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:46 INFO - Reading from file tmpfile_stdout 08:46:46 INFO - Current package versions: 08:46:46 INFO - argparse == 1.2.1 08:46:46 INFO - blessings == 1.6 08:46:46 INFO - blobuploader == 1.2.4 08:46:46 INFO - docopt == 0.6.1 08:46:46 INFO - manifestparser == 1.1 08:46:46 INFO - mozInstall == 1.12 08:46:46 INFO - mozcrash == 0.17 08:46:46 INFO - mozdebug == 0.1 08:46:46 INFO - mozdevice == 0.48 08:46:46 INFO - mozfile == 1.2 08:46:46 INFO - mozhttpd == 0.7 08:46:46 INFO - mozinfo == 0.9 08:46:46 INFO - mozleak == 0.1 08:46:46 INFO - mozlog == 3.1 08:46:46 INFO - moznetwork == 0.27 08:46:46 INFO - mozprocess == 0.22 08:46:46 INFO - mozprofile == 0.28 08:46:46 INFO - mozrunner == 6.11 08:46:46 INFO - mozscreenshot == 0.1 08:46:46 INFO - mozsystemmonitor == 0.0 08:46:46 INFO - moztest == 0.7 08:46:46 INFO - mozversion == 1.4 08:46:46 INFO - psutil == 3.1.1 08:46:46 INFO - requests == 1.2.3 08:46:46 INFO - wsgiref == 0.1.2 08:46:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:46 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 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:46 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 08:46:46 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 08:46:46 INFO - Using env: {'DISPLAY': ':0', 08:46:46 INFO - 'HOME': '/home/cltbld', 08:46:46 INFO - 'LANG': 'en_US.UTF-8', 08:46:46 INFO - 'LANGUAGE': 'en_US:en', 08:46:46 INFO - 'LOGNAME': 'cltbld', 08:46:46 INFO - 'MAIL': '/var/mail/cltbld', 08:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:46 INFO - 'MOZ_NO_REMOTE': '1', 08:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:46 INFO - 'NO_EM_RESTART': '1', 08:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:46 INFO - 'PWD': '/builds/slave/test', 08:46:46 INFO - 'SHELL': '/bin/bash', 08:46:46 INFO - 'SHLVL': '1', 08:46:46 INFO - 'TERM': 'linux', 08:46:46 INFO - 'TMOUT': '86400', 08:46:46 INFO - 'USER': 'cltbld', 08:46:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:46 INFO - '_': '/tools/buildbot/bin/python'} 08:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 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)) 08:46:46 INFO - Cleaning up... 08:46:46 INFO - Return code: 0 08:46:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46: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', 'jsonschema'] in /builds/slave/test/build 08:46: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 jsonschema 08:46:46 INFO - Using env: {'DISPLAY': ':0', 08:46:46 INFO - 'HOME': '/home/cltbld', 08:46:46 INFO - 'LANG': 'en_US.UTF-8', 08:46:46 INFO - 'LANGUAGE': 'en_US:en', 08:46:46 INFO - 'LOGNAME': 'cltbld', 08:46:46 INFO - 'MAIL': '/var/mail/cltbld', 08:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:46 INFO - 'MOZ_NO_REMOTE': '1', 08:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:46 INFO - 'NO_EM_RESTART': '1', 08:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:46 INFO - 'PWD': '/builds/slave/test', 08:46:46 INFO - 'SHELL': '/bin/bash', 08:46:46 INFO - 'SHLVL': '1', 08:46:46 INFO - 'TERM': 'linux', 08:46:46 INFO - 'TMOUT': '86400', 08:46:46 INFO - 'USER': 'cltbld', 08:46:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:46 INFO - '_': '/tools/buildbot/bin/python'} 08:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:46 INFO - Downloading/unpacking jsonschema 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:48 INFO - Downloading/unpacking functools32 (from jsonschema) 08:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:49 INFO - warning: no files found matching '*.txt' 08:46:49 INFO - no previously-included directories found matching 'build' 08:46:49 INFO - no previously-included directories found matching 'dist' 08:46:49 INFO - no previously-included directories found matching '.git*' 08:46:49 INFO - Installing collected packages: jsonschema, functools32 08:46:49 INFO - Running setup.py install for functools32 08:46:49 INFO - warning: no files found matching '*.txt' 08:46:49 INFO - no previously-included directories found matching 'build' 08:46:49 INFO - no previously-included directories found matching 'dist' 08:46:49 INFO - no previously-included directories found matching '.git*' 08:46:49 INFO - Successfully installed jsonschema functools32 08:46:49 INFO - Cleaning up... 08:46:49 INFO - Return code: 0 08:46:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fad196f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', '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 08:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:46:49 INFO - Using env: {'DISPLAY': ':0', 08:46:49 INFO - 'HOME': '/home/cltbld', 08:46:49 INFO - 'LANG': 'en_US.UTF-8', 08:46:49 INFO - 'LANGUAGE': 'en_US:en', 08:46:49 INFO - 'LOGNAME': 'cltbld', 08:46:49 INFO - 'MAIL': '/var/mail/cltbld', 08:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:49 INFO - 'MOZ_NO_REMOTE': '1', 08:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:49 INFO - 'NO_EM_RESTART': '1', 08:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:49 INFO - 'PWD': '/builds/slave/test', 08:46:49 INFO - 'SHELL': '/bin/bash', 08:46:49 INFO - 'SHLVL': '1', 08:46:49 INFO - 'TERM': 'linux', 08:46:49 INFO - 'TMOUT': '86400', 08:46:49 INFO - 'USER': 'cltbld', 08:46:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:49 INFO - '_': '/tools/buildbot/bin/python'} 08:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:49 INFO - Downloading/unpacking flake8 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:46:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:46:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:46:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:52 INFO - no previously-included directories found matching 'docs/_build' 08:46:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:46:52 INFO - Running setup.py install for pep8 08:46:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:52 INFO - no previously-included directories found matching 'docs/_build' 08:46:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:46:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:46:52 INFO - Cleaning up... 08:46:52 INFO - Return code: 0 08:46:52 INFO - Running post-action listener: _resource_record_post_action 08:46:52 INFO - Running post-action listener: _start_resource_monitoring 08:46:52 INFO - Starting resource monitoring. 08:46:52 INFO - ##### 08:46:52 INFO - ##### Running install step. 08:46:52 INFO - ##### 08:46:52 INFO - Running pre-action listener: _resource_record_pre_action 08:46:52 INFO - Running main action method: install 08:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:52 INFO - Reading from file tmpfile_stdout 08:46:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:52 INFO - Reading from file tmpfile_stdout 08:46:52 INFO - Output received: 08:46:52 INFO - Usage: mozinstall [options] installer 08:46:52 INFO - Options: 08:46:52 INFO - -h, --help show this help message and exit 08:46:52 INFO - -d DEST, --destination=DEST 08:46:52 INFO - Directory to install application into. [default: 08:46:52 INFO - "/builds/slave/test"] 08:46:52 INFO - --app=APP Application being installed. [default: firefox] 08:46:52 INFO - mkdir: /builds/slave/test/build/application 08:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:47:08 INFO - Reading from file tmpfile_stdout 08:47:08 INFO - Output received: 08:47:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:08 INFO - Running post-action listener: _resource_record_post_action 08:47:08 INFO - ##### 08:47:08 INFO - ##### Running run-tests step. 08:47:08 INFO - ##### 08:47:08 INFO - Running pre-action listener: _resource_record_pre_action 08:47:08 INFO - Running main action method: run_tests 08:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:08 INFO - Python 2.7.3 08:47:08 INFO - Return code: 0 08:47:08 INFO - grabbing minidump binary from tooltool 08:47:08 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')]} 08:47:08 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 0x1449410>, '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 0x144a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:08 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 08:47:08 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 08:47:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:08 INFO - Return code: 0 08:47:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:09 INFO - Return code: 0 08:47:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:47:09 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:47:09 INFO - Using env: {'DISPLAY': ':0', 08:47:09 INFO - 'HOME': '/home/cltbld', 08:47:09 INFO - 'LANG': 'en_US.UTF-8', 08:47:09 INFO - 'LANGUAGE': 'en_US:en', 08:47:09 INFO - 'LOGNAME': 'cltbld', 08:47:09 INFO - 'MAIL': '/var/mail/cltbld', 08:47:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:09 INFO - 'MOZ_NO_REMOTE': '1', 08:47:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:09 INFO - 'NO_EM_RESTART': '1', 08:47:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:09 INFO - 'PWD': '/builds/slave/test', 08:47:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:09 INFO - 'SHELL': '/bin/bash', 08:47:09 INFO - 'SHLVL': '1', 08:47:09 INFO - 'TERM': 'linux', 08:47:09 INFO - 'TMOUT': '86400', 08:47:09 INFO - 'USER': 'cltbld', 08:47:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043', 08:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:09 INFO - '_': '/tools/buildbot/bin/python'} 08:47:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:47:09 INFO - mozversion application_buildid: 20160413025454 08:47:09 INFO - mozversion application_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 08:47:09 INFO - mozversion application_display_name: Nightly 08:47:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:09 INFO - mozversion application_name: Firefox 08:47:09 INFO - mozversion application_remotingname: firefox 08:47:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:09 INFO - mozversion application_vendor: Mozilla 08:47:09 INFO - mozversion application_version: 48.0a1 08:47:09 INFO - mozversion platform_buildid: 20160413025454 08:47:09 INFO - mozversion platform_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 08:47:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:09 INFO - mozversion platform_version: 48.0a1 08:47:09 INFO - using testdate: 1460562429 08:47:09 INFO - actual date: 1460562429 08:47:09 INFO - starting webserver on 'localhost:51109' 08:47:09 INFO - SUITE-START | Running 2 tests 08:47:09 INFO - TEST-START | dromaeo_css 08:47:09 INFO - operating with platform_type : linux_ 08:47:09 INFO - Initialising browser for dromaeo_css test... 08:47:09 INFO - TEST-INFO | started process 22642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjP44ch/profile http://localhost:51109/getInfo.html) 08:47:13 INFO - PROCESS | 22642 | 08:47:13 INFO - PROCESS | 22642 | (process:22712): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:47:13 INFO - PROCESS | 22642 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:47:14 INFO - PROCESS | 22642 | __metrics Screen width/height:1600/1200 08:47:14 INFO - PROCESS | 22642 | colorDepth:24 08:47:14 INFO - PROCESS | 22642 | Browser inner width/height: 1024/697 08:47:14 INFO - PROCESS | 22642 | __metrics 08:47:14 ERROR - PROCESS | 22642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:47:15 INFO - TEST-INFO | 22642: exit 0 08:47:15 INFO - Browser initialized. 08:47:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:15 INFO - TEST-INFO | started process 22763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjP44ch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:17 INFO - PROCESS | 22763 | 08:47:17 INFO - PROCESS | 22763 | (process:22820): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:47:27 INFO - PROCESS | 22763 | RSS: Main: 164450304 08:47:27 INFO - PROCESS | 22763 | 08:48:17 INFO - PROCESS | 22763 | 1460562497273 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] 08:50:29 INFO - PROCESS | 22763 | Cycle 1(1): loaded http://localhost:51109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51109/tests/dromaeo/cssquery-ext.html) 08:50:29 INFO - PROCESS | 22763 | RSS: Main: 168427520 08:50:29 INFO - PROCESS | 22763 | 08:53:32 INFO - PROCESS | 22763 | Cycle 1(1): loaded http://localhost:51109/tests/dromaeo/cssquery-ext.html (next: http://localhost:51109/tests/dromaeo/cssquery-jquery.html) 08:53:32 INFO - PROCESS | 22763 | RSS: Main: 165441536 08:53:32 INFO - PROCESS | 22763 | 08:56:34 INFO - PROCESS | 22763 | Cycle 1(1): loaded http://localhost:51109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51109/tests/dromaeo/cssquery-mootools.html) 08:56:35 INFO - PROCESS | 22763 | RSS: Main: 166367232 08:56:35 INFO - PROCESS | 22763 | 08:59:36 INFO - PROCESS | 22763 | Cycle 1(1): loaded http://localhost:51109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51109/tests/dromaeo/cssquery-prototype.html) 08:59:37 INFO - PROCESS | 22763 | RSS: Main: 164638720 08:59:37 INFO - PROCESS | 22763 | 09:02:40 INFO - PROCESS | 22763 | Cycle 1(1): loaded http://localhost:51109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51109/tests/dromaeo/cssquery-yui.html) 09:02:40 INFO - PROCESS | 22763 | RSS: Main: 165367808 09:02:40 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | Cycle 1(1): loaded http://localhost:51109/tests/dromaeo/cssquery-yui.html (next: http://localhost:51109/tests/dromaeo/cssquery-dojo.html) 09:05:43 INFO - PROCESS | 22763 | RSS: Main: 167583744 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | __start_tp_report 09:05:43 INFO - PROCESS | 22763 | _x_x_mozilla_page_load 09:05:43 INFO - PROCESS | 22763 | _x_x_mozilla_page_load_details 09:05:43 INFO - PROCESS | 22763 | |i|pagename|runs| 09:05:43 INFO - PROCESS | 22763 | |0;dojo.html;2607.556715358389;2619.842809431434;2686.489566982273;2693.3535951371678;2695.3126952627103;4606.953930460691;4653.790579423926;4676.158291507527;4696.835610753625;4710.78801453935;4626.236670949289;4638.466576343713;4714.104320179164;4727.432708075027;4736.668433209677;4306.354046892968;4335.241332766769;4369.300911854104;4379.956200437987;4410.470743510783;4339.978300108495;4410.382546443484;4431.135928493945;4451.955480445203;4463.24124898768;4204.411382406465;4312.116016216668;4335.869923902288;4341.565843415665;4396.274614688573;4287.185434767384;4290.377895205209;4301.333293339538;4324;4346.8043938022865;4264.061906380592;4299.462567179103;4308.246056940023;4310.4611923509565;4357.455318085239;4457.3091170868565;4588.311753237008;4605.355250264965;4641.837535686234;4673.6027437667835;5018.247262910592;5037.546620804145;5039.748012599355;5072.442031376546;5109.872253193663;5076.64463487556;5079.619028572872;5084.51697088776;5090.38915330159;5092.9236061459105;4583.954160458419;4698.600618947394;4740.786664600101;4761.785719642625;4785.641076919175;5089.3638295213095;5120.1039818031695;5125.154349532286;5149.433562308143;5221.921671174935;4871.391076115486;4890.315355850184;4928.704277743347;4953.529414705597;5006.724630145377;5059.848204553869;5087.3386459759995;5106.617003724736;5143.202803565453;5168.2764412982215;4825.5898248648555;4971.130052240916;4994.9750251248515;5001.724905130252;5049.899002019939;4887.731174785421;4960.801567937242;4962.751862406865;4979.128652485873;5030.949690503121;3889.1638297766117;3919.9608003920166;3953.7627742335553;3960.1089754805516;3963.6432721055244;3448.2413868948793;3458.4293591557616;3463.341965026637;3491.969868888684;3503.491993660905;4297.957020429818;4351.586599273064;4371.453568303962;4390.121975604892;4395.692301538862;5011.173156429221;5023.82416615424;5028.120078986163;5043.041822053798;5049.343585333883;4345.044090300129;4370.0604370059955;4376.737395756265;4396.450443694538;4411.4926783420315;4457.2199865023495;4489.506154323022;4495.9325610115875;4499.55004499554;4543.045960348364;4667.859964201148;4684.320773487893;4713.811447542197;4721.8903557663925;4732.31381449681;4966.056449274626;4971.950280497149;4982.078315511642;4985.725785081855;5004.799808007784;4697.741624210701;4753.120672675566;4770.499097594841;4815.686980346266;4831.95168048315;4969.602431805519;4976.303317535476;4979.203327467588;4986;4994.450610432922;5041.747912604282;5070.619703522177;5080.644354895122;5084.567811736044;5109.310243117132;4862.124817532878;4925.335079764186;4962.280469331999;4964.280179374043;5009.073321435546;4813.229883218668;4829.637777166657;4859.3682821233015;4880.902381952412;4921.089598424303;4749.691270067435;4788.138135135709;4790.9281360780315;4808.447028591617;4825.855224343275;4839.249916262985;4869.6591238612955;4887.218045112765;4951.9257211142585;4983.476734942924;4829.66192366531;4829.7585120743115;4853.126437241189;4855.465898751064;4919.311296418433 09:05:43 INFO - PROCESS | 22763 | |1;ext.html;585.5432762445291;602.3524710935744;617.1051974636778;623.6040114527274;638.7540796793234;33969.830150849244;34701.47947780779;34744.13139671509;34763.826180869124;34811.47782783257;36658.26683466329;37248.44127338092;37278.81360593193;37455.812720936425;37488.250234995285;7656.46404751669;7856.921430785676;7861.528308301492;7863.252990965878;7873.685052597889;7666.425018123635;7735.72924947627;7808.921910780877;7937.3650107991225;8009;7917.208279172066;7975.082865470458;8016.67933282668;8060.113387527367;8060.919390806105;7938.722144724936;7999.520028798291;8010.319122874563;8012.999999999971;8017.198280171936;7785.532868027936;7883.645235964338;7893.05283365994;7896.644650990719;7901.486403383762;37812.43281350782;38149.23701525954;38286.42570361447;38340.616593833984;38416.42375364372;2676.210517897225;3129.702678245563;3527.417976033951;3748.850045998157;3756.398976163801;25467.872660636764;25526;26156.215313540622;26614;27372.58941115885;3316.5522654441584;3320.4853247746637;3364.243045314809;3399.94601673482;3432.2792213635166;218408;218467;218557;219056;220592;32874.342513150084;33822.32355352879;34048.82975585106;50740.746296268284;51101.744491277306;32065.198370040936;32247.193820154684;32252.581056420862;32420.027399178063;32556.348873022405;13083.869161308456;13200.669983250496;13215.14101583394;13300;13338.333083345793;10888.292261003167;11032.779344413068;11046.392448415414;11073.169512286611;11078.446077696244;8180.795480112925;8192.5494097824;8231.547264900368;8262.380321475914;8271.048829384697;3175.22207059272;3218.5172224166563;3223.629282632527;3224.98387508061;3281.1797050737314;910.3536489092818;914.9130832570895;924.7734305095295;973.3721749471692;978.3640633588083;25421.49157016849;26772.9338008288;26889.327766805596;27075.458490830075;27084.864575676995;945.5603144537823;960.8606752020918;1003.9698809035741;1004.1264100232844;1017.9491025448698;13887.930560347335;14373.712525749426;14419.78370324446;14464.20446875411;14559.19924404168;364271;367996;369649;369905;373830;49184.75407623011;49621;49746.25380619294;49765.502344976085;49913.75043124761;1194.599809063956;1238.3808095952024;1239.7954337534386;1261.4008346035744;1271.2182008065158;25396;26137.477250455264;26583.867080664473;26763.05606383335;26964.865175673996;41103.38344924888;41505.58494415017;41529.79235103805;41617.37573936454;41826.1634767309;258001;259690;260222;311925;312032;24674.753252467963;25197.370065748502;25522.361940951625;25572.10497632574;25807.870960645076;41374.37938430986;41744.79127604343;41868.58131418647;42203;42573.14853702971;35676;35811.64188358187;35867.28265434729;36217.81891090528;36842.263154737295;36015.27969440649;36093.819530902176;36204.30220409128;36595.81702091473;36676.44985325276;30108;33603.66396336103;33853.49219761755;34419.827900860335;34729;30583.388332232786;32045;32060.358792823547;32076.5188522177;32254.516182256815;23364.415889602897;23663.408414789767;23744.643830342906;23784.286471405885;23861.403464913517 09:05:43 INFO - PROCESS | 22763 | |2;jquery.html;359.69605683197705;369.4126339120798;386.2506736930355;393.68111829418154;406.27277173858795;15633.530994070183;16442.83557164428;17335.479935601936;17370.565735856577;17433.82566174338;11258.493367798448;15651.295691693873;16545.834541654578;16624.418145364914;16641.50075497734;4647.907041859161;4796.376471058775;4835.15384807659;4836.97581512092;4841.951580484185;3529.876454324099;5288.867778305554;5588.524975377098;5590.804321848736;5608.831735047955;5512.779488820443;5583.441655834425;5591.860203494904;5599.41206173352;5600.18797274395;5340.172273297645;5437.700926449043;5459.645123066988;5470.835874923759;5554.72226388679;5239.659422137549;5290.994711004935;5329.227262046981;5341.145416733343;5388.703621300827;12454.377281135998;12761.936190319082;20499.89750051255;20731.378058658265;20738.274160404464;1838.7333836593752;1852.4905650945964;1928.4889504281377;2063.3397312859743;2311.91908283211;9170.724878253663;9176.632934682671;9455.10176533235;9567.37812042222;9568;1770.6016146367094;1781.4477511971202;1803.3057272949877;1813.4831573001632;1814.4465937888938;58157.12764308539;62112.68943655298;69147;72457.2754272461;74455.62772186159;9247.907520924704;9543.904560954441;9828.606855725691;10053.547590358305;10100.898991010143;13769.724605507834;13992.16047037181;14006.789898151535;14035.368408421646;14089.295535223198;6516.2506311773805;6686.899696504556;6796.4562834973085;6798.150231221098;6804.829879253059;6340.270868850049;6342.5243106767175;6350;6472.126262954441;6473.514486413538;4398.450193725785;4423.690341676116;4439.334099885043;4472.1502914446155;4483.036147228297;1753.509017475109;1798.2896755781394;1807.2319264312878;1808.7739032620923;1826.1964735516597;803.3934379543407;851.6295411496019;889.2441424788877;917.9672868023473;967.1199208720031;15292;15548.300326485336;15638.2180890955;15750.212489375486;15819.288132034086;813.5647428625657;862.4092496639822;867.7440155154245;872.358816270041;890.7594949363765;8910.331725120643;9113.316501262432;9157.49633770149;9365.297602679826;9393.765155871159;407739;409848;414268;420107;421280;67712;80895;84565;85257;86151.56924215339;993.9304248702522;997.7256254529917;1011.6813203840767;1056.9312994655322;1058.957641694339;15228.390864365301;15268.312925918139;15366.154861482726;15546.067235965878;15935.601609959844;33996.66003339935;34044.31911361709;34144.317113658086;35570.288594228485;35619.10952226215;48962.51037489579;49250.753746232476;49363.25955110748;49459.25811112908;49689.25466117939;7534.133574638768;7661.463697541119;7733.342665873463;7774.067111946602;7819.335356494534;8551.74344769658;10530.736731581464;11222.663320100084;11758;11882;9822.950885245527;9839.754006149904;9950.402975821475;10053.145482634058;10125.392476451436;10035.899641003789;10080.89919100829;10081.092701656886;10375.584976600852;10392.636257730943;9191.77020574491;9620.75948101303;9914.30599858003;10214.387136771817;10366.429846358522;7076.340819680377;7804.648790804541;7834.529928204326;7845.215478452109;7910.762677119696;9230;9401.658414364709;9480.715578532656;9925.404475731479;10152.340097893613 09:05:43 INFO - PROCESS | 22763 | |3;mootools.html;1461.6199788055105;1493.2160615676771;1650.224394534569;1780.0921530019702;1815.8832318124348;7027.051348068009;7609;7612.124605670349;7869.252421020001;7875.645595948182;7671.6547755351;7685.500442471235;7741;7795.415343849219;7805.960970195155;2248.3816950338623;2278.236790675126;2279.464325883416;2281.133169395627;2283.680284760135;2209.734831820184;2237.7314722233355;2250.8311876609237;2254.2786308381324;2254.7519772824976;2248.1119957616734;2266.6033444147292;2266.954660906781;2281.007761623699;2298.092253559851;2238.485148415857;2238.854474459155;2246.359787460574;2253.1550668499312;2254.1546919904954;2233.731952165734;2234.832387570939;2236.7763223677666;2245.2253972379503;2245.9438514037115;7777.105632852238;7846.725364612268;7910.762677119696;7922.524648521107;7954;4666.090112428078;4789.353437285957;4803.903921921542;4805.807767689288;4827.541383568555;2916.2271997920566;2977.5831383606096;2998.235449960246;2999.4001199760137;3003.039027511197;1767.9027653479054;1779.3238569343696;1813.1206364913007;1851.7777866655954;1863.3105750872128;10638;10810.243282970196;10833.67498975032;10874.347539147677;10901.890981090246;4103.4870641169855;4120.1553681495225;4234.343676730112;4262.637675797592;4300.204462174508;8492.957535212285;8530.402871799039;8534.487930724177;8559.443636163629;8564.400491965502;4691.085238378483;4710.764461776897;4719.126961512131;4726.645501587394;4729.0541891621815;3780.0549862534367;4195.91608167835;4377.9124417511475;4410.1400226956075;4417.911641767147;3465.1510379956567;3467.4452087665854;3490.6683865032783;3515.050936247199;3579.785212887235;1079.5573814735922;1102.9283096598695;1107.9113670906308;1111.127764704703;1122.085500317239;765.4603504529293;891.0999890111035;909.9909000909906;916.5096673279763;927.0636656976502;5581.413951535031;5596.356419011866;5642.774289028475;5708.31500219968;5722.456366645162;911.7128104647015;911.8905731312285;917.5962576466334;933.9906600934039;954.3510412919143;3520.982395088008;3622.166901612644;3623.4021386470936;3664.706823454117;3710.9072273193387;9351;9617.086376794194;9750.073742994404;9858.408495490294;10033.397996120257;9655.275854310954;9844.9015509844;9847;9893.258005649604;9926.602935882629;7115.466340024415;7160.498765086394;7171.856562868714;7209.495335326582;7241.167265764399;5354.2771725818075;5392.487713667196;5494.5054945055135;5546.528545073714;5579.860503487283;8723.08407617191;8893.421927574687;8900.243479304332;8916.242119419663;8975.416597921114;8618.655253789779;8909.643614255358;8946.68686595966;8954.462732236087;8984.371094023356;6715.4963377747845;6792.150981127359;6896.137982752156;6970.163580370388;6986.790396288119;7498.58757768328;7511.286427789351;7553.131389890233;7562.546247225184;7598.316151546387;6683.264840867403;6803.455723542006;6913.274106218774;6970.198427180939;7004.334588214111;6745.865082698417;6797.830054248683;6852.280510546321;6922.5154239204785;6942.06282151903;6174.413430724074;6400.295967443671;6401.231852177769;6497.18785151856;6501.609903405811;4729.196036673705;4777.402824646919;4781.713097214179;4821.421429428491;4826.58973987201;4806.711597304173;4837.854864354075;4880.487548807324;4921.188003979447;4985.675931064469 09:05:43 INFO - PROCESS | 22763 | |4;prototype.html;311.60581863942105;315.48890796909006;315.6417466175891;318.30609271787495;320.60725611126367;5184.870378240541;5223.085959957011;5244.632875698698;5329.920051199226;5343.038253114438;5196.272521846944;5212.582993360532;5219.399769026563;5220.981908527839;5221.921671174935;3825.9043523911914;3930.8231129599235;4075.572064933184;4078.4290199372113;4091.5703851095654;4051.4733084698946;4067.491563554556;4069.5930406959365;4079.6940229482757;4080.163566468867;4022.3162062449455;4033.1933613277315;4038.63652271297;4041;4057.0871553900283;3810.466534685146;4006.1155967703207;4011.2178125265586;4021.537523184842;4069.8052029157116;3492.7205823534055;3510.7893526388243;3520.9437168849245;3521.506989021539;3526.047967048908;4978.87552811179;4990.276409920578;4995.650304478651;4997.225430058346;5008.574271186953;4326.58897404746;4651.395318608559;4656.115338085753;4657.534246575349;4668.719876807402;5408.675479471205;5447.175196309241;5459.535939445152;5480.561555075585;5482.205080263339;3819.618038196158;3821.445890345912;3822.9235415291537;3824.101336185994;3824.349860523718;5474.835754927399;5742.511886489653;5761.769529218826;5769.798057068025;5814.360420353758;3922.7450215735885;3975.7813320267082;3980.840766369313;3982.4026396040827;3992.1416895367634;4064.7357921734992;4070.3690927906223;4071.3892916062828;4075.3275709507598;4079.85720499787;4654;4663.323818046364;4669.509701481364;4671.556202160789;4682.438107427062;5443.891122177534;5480.342358916876;5508.531774799107;5513.42109078549;5520.1443776214755;1383.6471699716508;1412.639776856895;1413.371049882813;1414;1419.219429313894;876.2639382918379;918.779492921694;944.7401964459829;944.9574769135405;965.546193289167;4767.308740232646;4795.232762757942;4821.228603423436;4835.597676673796;4850.563449289511;5663.122216056436;5672.971635141798;5678.97778399892;5692.8045110527255;5735.627184233012;4654.394928659321;4759.952400476021;4842.733649649233;4843.782029808667;4902.460729319772;3062.4487592233168;3064.5709600655928;3086.66046734859;3104.875804967776;3109.2693217093965;5452.509274165344;5455.372632147354;5493.890122197614;5500.50495455411;5501.202325662756;5817.778266564069;5870.706464676835;5900.881982360329;5909.23179986599;5924.8815023700145;5378.892422151614;5426.728663566806;5453.3455985281225;5458.208559758892;5462.481064298885;5614.157876318585;5754.280714910637;5765.221695071279;5784.537237021113;5815.476607105381;5684.147377893184;5694;5694.800681976111;5696.829095127153;5727.570432217683;5448.536874365724;5456.42707515721;5480.123180291134;5496.148097044965;5496.697681627549;3833.769973801581;3972.841086356629;3974.3044967131214;3981.2634662587516;4004.1190937993597;5749.137629355463;5750.6262092963825;5762;5762.538996880324;5765.3946335634155;5477.917831232615;5545.835374571224;5545.889082218414;5581.776728930798;5591.04952158126;5276.894462110659;5571.888562228652;5580.5535557156145;5626.549876009991;5636.549076073986;5199.792008319625;5454.918176227439;5504.146857237135;5533.142362933751;5535.086710692691;5399.379071406682;5572.804951826829;5611.57913156523;5625.184348269559;5669.54643628517;5379.112446446293;5453.481919217668;5455.18172274162;5500.28496295495;5519.399374181442 09:05:43 INFO - PROCESS | 22763 | |5;yui.html;670.048531085858;695.3012222716169;729.5950747335229;784.8116452051506;792.8216151365943;11753.764924701502;12128.514859405635;12176.573819916304;12222.938885305572;12248.203866748667;11184.664460066191;11239.269447485907;11243.269187502827;11279;11298.435078246095;648.7988723495707;807.1807115777491;820.7250571058703;843.1442086282428;846.4582667093065;817.2522142239873;821.1172989036779;827.3711978896022;828.2835347424465;829.6639860856363;876.5354362188051;879.3229213505597;881.9073997230295;884.6815146547237;888.6845169964666;874.1520724896808;874.4753148111146;875.1161327059684;877.8858748362704;878.7803049237691;643.0418676172516;646.0632083478974;647.0520687193284;647.8736646353963;648.7145655911431;12515.937420312932;12636.989040876708;12689.175203611736;12722.236665799988;12775.87224127756;12751.405093028536;12769.106162568623;12920;12972.545960891417;13202.4058917348;10039.648612298608;10210.08109270162;10309.587616495332;10336.018078282552;10343.689689309333;3347.0795531228864;3366.7138293245102;3409.147713071732;3413.4879768034743;3421.640727723578;45538.08923821538;45823.77088114538;46258.306125407806;47547;47921.76039119782;9633.32566720337;9686.612535498502;9769.462679552551;9838.60645574169;9861.359011664219;16895.408660697063;17318;17319.2206350712;17663.29346826138;17804.732929006077;6912.101426814583;7023.789286321418;7086.255943126001;7117.71529138839;7125.358717715327;3795.3358162321483;3902.2780785554764;3930.9606903931167;3937.8424863005157;3947.8815635530405;2889.6387951506063;2986.865591048408;2987.596674448965;2991.1923780579123;3003.519436890087;548.9560835133179;552.3565046720526;552.4806681719172;554.7032337699392;571.9771209151587;572.6306532286652;643.3630705601421;645.3707635055783;656.9146011018537;659.0279337976447;7721;8405.537695426689;8485.024222214524;8541.615627296787;8690.91309086901;603.2097951683309;629.4020680353682;633.6704913444983;652.5301782716436;652.6801867085094;3941.6649584785614;3971.62269584389;4031.395290706359;4046.7976601169826;4057.9044805612402;50476;51914.74042629763;52262;52296.477035229924;53706.73146634242;43654;43770.34344484835;44160;44296;44575.55424445714;40552;40582.79708601438;40848.624195643504;41034.38448423276;41513.37729934114;8056.798580035546;8146.877796832934;8186.631601577824;8299.170082991894;8425.873611895704;23685.763142369044;26654.20037398881;27269.45461090807;27988.16035518938;27990.44019119647;29761.702382975895;32933;36317;36491.817540912125;37111.628883710815;11021.669349919515;11070.335779853234;11074.501647425725;11164.274322169033;11415.885841141482;11712.824307635563;11865.762684746429;12065.457054432747;12273.631791046282;12412.81380779271;11489.655310340702;11776;12030.338331391857;12072.577459788865;12114.878851211375;11030.50362733695;11037.558497660004;11682.12384071181;11701.648950531498;11729.296242225493;10973.670789876316;11049.28179668319;11405.258658187191;11565.190436669352;11645.184837061324;9479.099485548863;9715.805683886425;9766.60933562678;9789.804203915739;10111.191104711459;9598;9797.951010244904;9927.503624818875;9988.151007164472;10000.749981250236 09:05:43 INFO - PROCESS | 22763 | __end_tp_report 09:05:43 INFO - PROCESS | 22763 | __start_cc_report 09:05:43 INFO - PROCESS | 22763 | _x_x_mozilla_cycle_collect,371 09:05:43 INFO - PROCESS | 22763 | __end_cc_report 09:05:43 INFO - PROCESS | 22763 | __startTimestamp1460563543834__endTimestamp 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | ------- Summary: start ------- 09:05:43 INFO - PROCESS | 22763 | Number of tests: 6 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | [#0] dojo.html Cycles:165 Average:4632.09 Median:4770.50 stddev:508.42 (10.7%) stddev-sans-first:484.54 09:05:43 INFO - PROCESS | 22763 | Values: 2607.6 2619.8 2686.5 2693.4 2695.3 4607.0 4653.8 4676.2 4696.8 4710.8 4626.2 4638.5 4714.1 4727.4 4736.7 4306.4 4335.2 4369.3 4380.0 4410.5 4340.0 4410.4 4431.1 4452.0 4463.2 4204.4 4312.1 4335.9 4341.6 4396.3 4287.2 4290.4 4301.3 4324.0 4346.8 4264.1 4299.5 4308.2 4310.5 4357.5 4457.3 4588.3 4605.4 4641.8 4673.6 5018.2 5037.5 5039.7 5072.4 5109.9 5076.6 5079.6 5084.5 5090.4 5092.9 4584.0 4698.6 4740.8 4761.8 4785.6 5089.4 5120.1 5125.2 5149.4 5221.9 4871.4 4890.3 4928.7 4953.5 5006.7 5059.8 5087.3 5106.6 5143.2 5168.3 4825.6 4971.1 4995.0 5001.7 5049.9 4887.7 4960.8 4962.8 4979.1 5030.9 3889.2 3920.0 3953.8 3960.1 3963.6 3448.2 3458.4 3463.3 3492.0 3503.5 4298.0 4351.6 4371.5 4390.1 4395.7 5011.2 5023.8 5028.1 5043.0 5049.3 4345.0 4370.1 4376.7 4396.5 4411.5 4457.2 4489.5 4495.9 4499.6 4543.0 4667.9 4684.3 4713.8 4721.9 4732.3 4966.1 4972.0 4982.1 4985.7 5004.8 4697.7 4753.1 4770.5 4815.7 4832.0 4969.6 4976.3 4979.2 4986.0 4994.5 5041.7 5070.6 5080.6 5084.6 5109.3 4862.1 4925.3 4962.3 4964.3 5009.1 4813.2 4829.6 4859.4 4880.9 4921.1 4749.7 4788.1 4790.9 4808.4 4825.9 4839.2 4869.7 4887.2 4951.9 4983.5 4829.7 4829.8 4853.1 4855.5 4919.3 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | [#1] ext.html Cycles:180 Average:43066.82 Median:34753.98 stddev:78115.87 (224.8%) stddev-sans-first:78269.89 09:05:43 INFO - PROCESS | 22763 | Values: 585.5 602.4 617.1 623.6 638.8 33969.8 34701.5 34744.1 34763.8 34811.5 36658.3 37248.4 37278.8 37455.8 37488.3 7656.5 7856.9 7861.5 7863.3 7873.7 7666.4 7735.7 7808.9 7937.4 8009.0 7917.2 7975.1 8016.7 8060.1 8060.9 7938.7 7999.5 8010.3 8013.0 8017.2 7785.5 7883.6 7893.1 7896.6 7901.5 37812.4 38149.2 38286.4 38340.6 38416.4 2676.2 3129.7 3527.4 3748.9 3756.4 25467.9 25526.0 26156.2 26614.0 27372.6 3316.6 3320.5 3364.2 3399.9 3432.3 218408.0 218467.0 218557.0 219056.0 220592.0 32874.3 33822.3 34048.8 50740.7 51101.7 32065.2 32247.2 32252.6 32420.0 32556.3 13083.9 13200.7 13215.1 13300.0 13338.3 10888.3 11032.8 11046.4 11073.2 11078.4 8180.8 8192.5 8231.5 8262.4 8271.0 3175.2 3218.5 3223.6 3225.0 3281.2 910.4 914.9 924.8 973.4 978.4 25421.5 26772.9 26889.3 27075.5 27084.9 945.6 960.9 1004.0 1004.1 1017.9 13887.9 14373.7 14419.8 14464.2 14559.2 364271.0 367996.0 369649.0 369905.0 373830.0 49184.8 49621.0 49746.3 49765.5 49913.8 1194.6 1238.4 1239.8 1261.4 1271.2 25396.0 26137.5 26583.9 26763.1 26964.9 41103.4 41505.6 41529.8 41617.4 41826.2 258001.0 259690.0 260222.0 311925.0 312032.0 24674.8 25197.4 25522.4 25572.1 25807.9 41374.4 41744.8 41868.6 42203.0 42573.1 35676.0 35811.6 35867.3 36217.8 36842.3 36015.3 36093.8 36204.3 36595.8 36676.4 30108.0 33603.7 33853.5 34419.8 34729.0 30583.4 32045.0 32060.4 32076.5 32254.5 23364.4 23663.4 23744.6 23784.3 23861.4 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | [#2] jquery.html Cycles:180 Average:24674.20 Median:49106.63 stddev:68405.22 (139.3%) stddev-sans-first:68572.76 09:05:43 INFO - PROCESS | 22763 | Values: 359.7 369.4 386.3 393.7 406.3 15633.5 16442.8 17335.5 17370.6 17433.8 11258.5 15651.3 16545.8 16624.4 16641.5 4647.9 4796.4 4835.2 4837.0 4842.0 3529.9 5288.9 5588.5 5590.8 5608.8 5512.8 5583.4 5591.9 5599.4 5600.2 5340.2 5437.7 5459.6 5470.8 5554.7 5239.7 5291.0 5329.2 5341.1 5388.7 12454.4 12761.9 20499.9 20731.4 20738.3 1838.7 1852.5 1928.5 2063.3 2311.9 9170.7 9176.6 9455.1 9567.4 9568.0 1770.6 1781.4 1803.3 1813.5 1814.4 58157.1 62112.7 69147.0 72457.3 74455.6 9247.9 9543.9 9828.6 10053.5 10100.9 13769.7 13992.2 14006.8 14035.4 14089.3 6516.3 6686.9 6796.5 6798.2 6804.8 6340.3 6342.5 6350.0 6472.1 6473.5 4398.5 4423.7 4439.3 4472.2 4483.0 1753.5 1798.3 1807.2 1808.8 1826.2 803.4 851.6 889.2 918.0 967.1 15292.0 15548.3 15638.2 15750.2 15819.3 813.6 862.4 867.7 872.4 890.8 8910.3 9113.3 9157.5 9365.3 9393.8 407739.0 409848.0 414268.0 420107.0 421280.0 67712.0 80895.0 84565.0 85257.0 86151.6 993.9 997.7 1011.7 1056.9 1059.0 15228.4 15268.3 15366.2 15546.1 15935.6 33996.7 34044.3 34144.3 35570.3 35619.1 48962.5 49250.8 49363.3 49459.3 49689.3 7534.1 7661.5 7733.3 7774.1 7819.3 8551.7 10530.7 11222.7 11758.0 11882.0 9823.0 9839.8 9950.4 10053.1 10125.4 10035.9 10080.9 10081.1 10375.6 10392.6 9191.8 9620.8 9914.3 10214.4 10366.4 7076.3 7804.6 7834.5 7845.2 7910.8 9230.0 9401.7 9480.7 9925.4 10152.3 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | [#3] mootools.html Cycles:180 Average:5224.76 Median:5169.98 stddev:2821.12 (54.6%) stddev-sans-first:2814.86 09:05:43 INFO - PROCESS | 22763 | Values: 1461.6 1493.2 1650.2 1780.1 1815.9 7027.1 7609.0 7612.1 7869.3 7875.6 7671.7 7685.5 7741.0 7795.4 7806.0 2248.4 2278.2 2279.5 2281.1 2283.7 2209.7 2237.7 2250.8 2254.3 2254.8 2248.1 2266.6 2267.0 2281.0 2298.1 2238.5 2238.9 2246.4 2253.2 2254.2 2233.7 2234.8 2236.8 2245.2 2245.9 7777.1 7846.7 7910.8 7922.5 7954.0 4666.1 4789.4 4803.9 4805.8 4827.5 2916.2 2977.6 2998.2 2999.4 3003.0 1767.9 1779.3 1813.1 1851.8 1863.3 10638.0 10810.2 10833.7 10874.3 10901.9 4103.5 4120.2 4234.3 4262.6 4300.2 8493.0 8530.4 8534.5 8559.4 8564.4 4691.1 4710.8 4719.1 4726.6 4729.1 3780.1 4195.9 4377.9 4410.1 4417.9 3465.2 3467.4 3490.7 3515.1 3579.8 1079.6 1102.9 1107.9 1111.1 1122.1 765.5 891.1 910.0 916.5 927.1 5581.4 5596.4 5642.8 5708.3 5722.5 911.7 911.9 917.6 934.0 954.4 3521.0 3622.2 3623.4 3664.7 3710.9 9351.0 9617.1 9750.1 9858.4 10033.4 9655.3 9844.9 9847.0 9893.3 9926.6 7115.5 7160.5 7171.9 7209.5 7241.2 5354.3 5392.5 5494.5 5546.5 5579.9 8723.1 8893.4 8900.2 8916.2 8975.4 8618.7 8909.6 8946.7 8954.5 8984.4 6715.5 6792.2 6896.1 6970.2 6986.8 7498.6 7511.3 7553.1 7562.5 7598.3 6683.3 6803.5 6913.3 6970.2 7004.3 6745.9 6797.8 6852.3 6922.5 6942.1 6174.4 6400.3 6401.2 6497.2 6501.6 4729.2 4777.4 4781.7 4821.4 4826.6 4806.7 4837.9 4880.5 4921.2 4985.7 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | [#4] prototype.html Cycles:180 Average:4580.98 Median:5221.45 stddev:1353.53 (25.9%) stddev-sans-first:1318.84 09:05:43 INFO - PROCESS | 22763 | Values: 311.6 315.5 315.6 318.3 320.6 5184.9 5223.1 5244.6 5329.9 5343.0 5196.3 5212.6 5219.4 5221.0 5221.9 3825.9 3930.8 4075.6 4078.4 4091.6 4051.5 4067.5 4069.6 4079.7 4080.2 4022.3 4033.2 4038.6 4041.0 4057.1 3810.5 4006.1 4011.2 4021.5 4069.8 3492.7 3510.8 3520.9 3521.5 3526.0 4978.9 4990.3 4995.7 4997.2 5008.6 4326.6 4651.4 4656.1 4657.5 4668.7 5408.7 5447.2 5459.5 5480.6 5482.2 3819.6 3821.4 3822.9 3824.1 3824.3 5474.8 5742.5 5761.8 5769.8 5814.4 3922.7 3975.8 3980.8 3982.4 3992.1 4064.7 4070.4 4071.4 4075.3 4079.9 4654.0 4663.3 4669.5 4671.6 4682.4 5443.9 5480.3 5508.5 5513.4 5520.1 1383.6 1412.6 1413.4 1414.0 1419.2 876.3 918.8 944.7 945.0 965.5 4767.3 4795.2 4821.2 4835.6 4850.6 5663.1 5673.0 5679.0 5692.8 5735.6 4654.4 4760.0 4842.7 4843.8 4902.5 3062.4 3064.6 3086.7 3104.9 3109.3 5452.5 5455.4 5493.9 5500.5 5501.2 5817.8 5870.7 5900.9 5909.2 5924.9 5378.9 5426.7 5453.3 5458.2 5462.5 5614.2 5754.3 5765.2 5784.5 5815.5 5684.1 5694.0 5694.8 5696.8 5727.6 5448.5 5456.4 5480.1 5496.1 5496.7 3833.8 3972.8 3974.3 3981.3 4004.1 5749.1 5750.6 5762.0 5762.5 5765.4 5477.9 5545.8 5545.9 5581.8 5591.0 5276.9 5571.9 5580.6 5626.5 5636.5 5199.8 5454.9 5504.1 5533.1 5535.1 5399.4 5572.8 5611.6 5625.2 5669.5 5379.1 5453.5 5455.2 5500.3 5519.4 09:05:43 INFO - PROCESS | 22763 | 09:05:43 INFO - PROCESS | 22763 | [#5] yui.html Cycles:180 Average:12593.17 Median:41273.88 stddev:13912.00 (33.7%) stddev-sans-first:13922.21 09:05:43 INFO - PROCESS | 22763 | Values: 670.0 695.3 729.6 784.8 792.8 11753.8 12128.5 12176.6 12222.9 12248.2 11184.7 11239.3 11243.3 11279.0 11298.4 648.8 807.2 820.7 843.1 846.5 817.3 821.1 827.4 828.3 829.7 876.5 879.3 881.9 884.7 888.7 874.2 874.5 875.1 877.9 878.8 643.0 646.1 647.1 647.9 648.7 12515.9 12637.0 12689.2 12722.2 12775.9 12751.4 12769.1 12920.0 12972.5 13202.4 10039.6 10210.1 10309.6 10336.0 10343.7 3347.1 3366.7 3409.1 3413.5 3421.6 45538.1 45823.8 46258.3 47547.0 47921.8 9633.3 9686.6 9769.5 9838.6 9861.4 16895.4 17318.0 17319.2 17663.3 17804.7 6912.1 7023.8 7086.3 7117.7 7125.4 3795.3 3902.3 3931.0 3937.8 3947.9 2889.6 2986.9 2987.6 2991.2 3003.5 549.0 552.4 552.5 554.7 572.0 572.6 643.4 645.4 656.9 659.0 7721.0 8405.5 8485.0 8541.6 8690.9 603.2 629.4 633.7 652.5 652.7 3941.7 3971.6 4031.4 4046.8 4057.9 50476.0 51914.7 52262.0 52296.5 53706.7 43654.0 43770.3 44160.0 44296.0 44575.6 40552.0 40582.8 40848.6 41034.4 41513.4 8056.8 8146.9 8186.6 8299.2 8425.9 23685.8 26654.2 27269.5 27988.2 27990.4 29761.7 32933.0 36317.0 36491.8 37111.6 11021.7 11070.3 11074.5 11164.3 11415.9 11712.8 11865.8 12065.5 12273.6 12412.8 11489.7 11776.0 12030.3 12072.6 12114.9 11030.5 11037.6 11682.1 11701.6 11729.3 10973.7 11049.3 11405.3 11565.2 11645.2 9479.1 9715.8 9766.6 9789.8 10111.2 9598.0 9798.0 9927.5 9988.2 10000.7 09:05:43 INFO - PROCESS | 22763 | -------- Summary: end -------- 09:05:43 INFO - PROCESS | 22763 | 09:05:44 INFO - TEST-INFO | 22763: exit 0 09:05:44 INFO - TEST-OK | dromaeo_css | took 1115054ms 09:05:44 INFO - TEST-START | kraken 09:05:44 INFO - operating with platform_type : linux_ 09:05:44 INFO - Initialising browser for kraken test... 09:05:44 INFO - TEST-INFO | started process 22997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlQTaB/profile http://localhost:51109/getInfo.html) 09:05:48 INFO - PROCESS | 22997 | 09:05:48 INFO - PROCESS | 22997 | (process:23064): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:05:48 INFO - PROCESS | 22997 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:05:49 INFO - PROCESS | 22997 | __metrics Screen width/height:1600/1200 09:05:49 INFO - PROCESS | 22997 | colorDepth:24 09:05:49 INFO - PROCESS | 22997 | Browser inner width/height: 1024/697 09:05:49 INFO - PROCESS | 22997 | __metrics 09:05:49 ERROR - PROCESS | 22997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:05:50 INFO - TEST-INFO | 22997: exit 0 09:05:50 INFO - Browser initialized. 09:05:50 INFO - Running cycle 1/1 for kraken test... 09:05:50 INFO - TEST-INFO | started process 23115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlQTaB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:52 INFO - PROCESS | 23115 | 09:05:52 INFO - PROCESS | 23115 | (process:23172): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:06:02 INFO - PROCESS | 23115 | RSS: Main: 164605952 09:06:02 INFO - PROCESS | 23115 | 09:06:05 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51109/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:06 INFO - PROCESS | 23115 | RSS: Main: 167620608 09:06:06 INFO - PROCESS | 23115 | 09:06:09 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51109/tests/kraken/driver.html?testName=audio-dft) 09:06:09 INFO - PROCESS | 23115 | RSS: Main: 170934272 09:06:09 INFO - PROCESS | 23115 | 09:06:12 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51109/tests/kraken/driver.html?testName=audio-fft) 09:06:13 INFO - PROCESS | 23115 | RSS: Main: 164425728 09:06:13 INFO - PROCESS | 23115 | 09:06:15 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51109/tests/kraken/driver.html?testName=audio-oscillator) 09:06:16 INFO - PROCESS | 23115 | RSS: Main: 165044224 09:06:16 INFO - PROCESS | 23115 | 09:06:18 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:19 INFO - PROCESS | 23115 | RSS: Main: 166035456 09:06:19 INFO - PROCESS | 23115 | 09:06:22 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51109/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:22 INFO - PROCESS | 23115 | RSS: Main: 165691392 09:06:22 INFO - PROCESS | 23115 | 09:06:26 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51109/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:27 INFO - PROCESS | 23115 | RSS: Main: 163069952 09:06:27 INFO - PROCESS | 23115 | 09:06:29 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51109/tests/kraken/driver.html?testName=json-parse-financial) 09:06:30 INFO - PROCESS | 23115 | RSS: Main: 163586048 09:06:30 INFO - PROCESS | 23115 | 09:06:32 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:32 INFO - PROCESS | 23115 | RSS: Main: 163807232 09:06:32 INFO - PROCESS | 23115 | 09:06:34 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:35 INFO - PROCESS | 23115 | RSS: Main: 163553280 09:06:35 INFO - PROCESS | 23115 | 09:06:37 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:38 INFO - PROCESS | 23115 | RSS: Main: 164126720 09:06:38 INFO - PROCESS | 23115 | 09:06:41 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:41 INFO - PROCESS | 23115 | RSS: Main: 164659200 09:06:41 INFO - PROCESS | 23115 | 09:06:44 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:45 INFO - PROCESS | 23115 | RSS: Main: 164630528 09:06:45 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | Cycle 1(1): loaded http://localhost:51109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51109/tests/kraken/driver.html?testName=ai-astar) 09:06:47 INFO - PROCESS | 23115 | RSS: Main: 166178816 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | __start_tp_report 09:06:47 INFO - PROCESS | 23115 | _x_x_mozilla_page_load 09:06:47 INFO - PROCESS | 23115 | _x_x_mozilla_page_load_details 09:06:47 INFO - PROCESS | 23115 | |i|pagename|runs| 09:06:47 INFO - PROCESS | 23115 | |0;ai-astar;115;108;113;114;114;125;114;115;114;113 09:06:47 INFO - PROCESS | 23115 | |1;audio-beat-detection;163;133;157;185;132;159;159;134;183;129 09:06:47 INFO - PROCESS | 23115 | |2;audio-dft;164;164;165;175;165;163;163;169;170;164 09:06:47 INFO - PROCESS | 23115 | |3;audio-fft;75;78;74;158;75;76;73;76;173;75 09:06:47 INFO - PROCESS | 23115 | |4;audio-oscillator;97;94;154;94;95;95;145;95;94;134 09:06:47 INFO - PROCESS | 23115 | |5;imaging-gaussian-blur;118;119;118;117;117;117;118;117;119;118 09:06:47 INFO - PROCESS | 23115 | |6;imaging-darkroom;147;149;147;148;147;149;148;147;150;148 09:06:47 INFO - PROCESS | 23115 | |7;imaging-desaturate;96;96;97;96;97;97;96;97;96;97 09:06:47 INFO - PROCESS | 23115 | |8;json-parse-financial;65;64;66;64;64;65;65;66;65;66 09:06:47 INFO - PROCESS | 23115 | |9;json-stringify-tinderbox;66;68;65;65;65;65;65;65;65;67 09:06:47 INFO - PROCESS | 23115 | |10;stanford-crypto-aes;83;86;85;91;84;87;88;99;114;85 09:06:47 INFO - PROCESS | 23115 | |11;stanford-crypto-ccm;148;154;148;161;149;147;149;145;149;147 09:06:47 INFO - PROCESS | 23115 | |12;stanford-crypto-pbkdf2;176;177;174;172;175;176;177;178;174;173 09:06:47 INFO - PROCESS | 23115 | |13;stanford-crypto-sha256-iterative;73;73;74;74;73;81;72;74;73;73 09:06:47 INFO - PROCESS | 23115 | __end_tp_report 09:06:47 INFO - PROCESS | 23115 | __start_cc_report 09:06:47 INFO - PROCESS | 23115 | _x_x_mozilla_cycle_collect,900 09:06:47 INFO - PROCESS | 23115 | __end_cc_report 09:06:47 INFO - PROCESS | 23115 | __startTimestamp1460563607450__endTimestamp 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | ------- Summary: start ------- 09:06:47 INFO - PROCESS | 23115 | Number of tests: 14 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:4.20 (3.7%) stddev-sans-first:4.45 09:06:47 INFO - PROCESS | 23115 | Values: 115.0 108.0 113.0 114.0 114.0 125.0 114.0 115.0 114.0 113.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:159.00 stddev:20.79 (13.1%) stddev-sans-first:21.75 09:06:47 INFO - PROCESS | 23115 | Values: 163.0 133.0 157.0 185.0 132.0 159.0 159.0 134.0 183.0 129.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:3.91 (2.4%) stddev-sans-first:4.07 09:06:47 INFO - PROCESS | 23115 | Values: 164.0 164.0 165.0 175.0 165.0 163.0 163.0 169.0 170.0 164.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:38.24 (51.0%) stddev-sans-first:39.98 09:06:47 INFO - PROCESS | 23115 | Values: 75.0 78.0 74.0 158.0 75.0 76.0 73.0 76.0 173.0 75.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.50 stddev:24.38 (25.8%) stddev-sans-first:25.42 09:06:47 INFO - PROCESS | 23115 | Values: 97.0 94.0 154.0 94.0 95.0 95.0 145.0 95.0 94.0 134.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:06:47 INFO - PROCESS | 23115 | Values: 118.0 119.0 118.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 09:06:47 INFO - PROCESS | 23115 | Values: 147.0 149.0 147.0 148.0 147.0 149.0 148.0 147.0 150.0 148.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:06:47 INFO - PROCESS | 23115 | Values: 96.0 96.0 97.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 09:06:47 INFO - PROCESS | 23115 | Values: 65.0 64.0 66.0 64.0 64.0 65.0 65.0 66.0 65.0 66.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 09:06:47 INFO - PROCESS | 23115 | Values: 66.0 68.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 67.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:86.50 stddev:9.55 (11.0%) stddev-sans-first:9.77 09:06:47 INFO - PROCESS | 23115 | Values: 83.0 86.0 85.0 91.0 84.0 87.0 88.0 99.0 114.0 85.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:149.00 stddev:4.60 (3.1%) stddev-sans-first:4.83 09:06:47 INFO - PROCESS | 23115 | Values: 148.0 154.0 148.0 161.0 149.0 147.0 149.0 145.0 149.0 147.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:176.00 stddev:1.93 (1.1%) stddev-sans-first:2.03 09:06:47 INFO - PROCESS | 23115 | Values: 176.0 177.0 174.0 172.0 175.0 176.0 177.0 178.0 174.0 173.0 09:06:47 INFO - PROCESS | 23115 | 09:06:47 INFO - PROCESS | 23115 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:73.50 stddev:2.54 (3.5%) stddev-sans-first:2.67 09:06:47 INFO - PROCESS | 23115 | Values: 73.0 73.0 74.0 74.0 73.0 81.0 72.0 74.0 73.0 73.0 09:06:47 INFO - PROCESS | 23115 | -------- Summary: end -------- 09:06:47 INFO - PROCESS | 23115 | 09:06:48 INFO - TEST-INFO | 23115: exit 0 09:06:48 INFO - TEST-OK | kraken | took 63900ms 09:06:48 INFO - SUITE-END | took 1178s 09:06:48 INFO - Completed test suite (00:19:39) 09:06:48 INFO - javascript benchmark 09:06:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.556715358389, 2619.842809431434, 2686.489566982273, 2693.3535951371678, 2695.3126952627103, 4606.953930460691, 4653.790579423926, 4676.158291507527, 4696.835610753625, 4710.78801453935, 4626.236670949289, 4638.466576343713, 4714.104320179164, 4727.432708075027, 4736.668433209677, 4306.354046892968, 4335.241332766769, 4369.300911854104, 4379.956200437987, 4410.470743510783, 4339.978300108495, 4410.382546443484, 4431.135928493945, 4451.955480445203, 4463.24124898768, 4204.411382406465, 4312.116016216668, 4335.869923902288, 4341.565843415665, 4396.274614688573, 4287.185434767384, 4290.377895205209, 4301.333293339538, 4324.0, 4346.8043938022865, 4264.061906380592, 4299.462567179103, 4308.246056940023, 4310.4611923509565, 4357.455318085239, 4457.3091170868565, 4588.311753237008, 4605.355250264965, 4641.837535686234, 4673.6027437667835, 5018.247262910592, 5037.546620804145, 5039.748012599355, 5072.442031376546, 5109.872253193663, 5076.64463487556, 5079.619028572872, 5084.51697088776, 5090.38915330159, 5092.9236061459105, 4583.954160458419, 4698.600618947394, 4740.786664600101, 4761.785719642625, 4785.641076919175, 5089.3638295213095, 5120.1039818031695, 5125.154349532286, 5149.433562308143, 5221.921671174935, 4871.391076115486, 4890.315355850184, 4928.704277743347, 4953.529414705597, 5006.724630145377, 5059.848204553869, 5087.3386459759995, 5106.617003724736, 5143.202803565453, 5168.2764412982215, 4825.5898248648555, 4971.130052240916, 4994.9750251248515, 5001.724905130252, 5049.899002019939, 4887.731174785421, 4960.801567937242, 4962.751862406865, 4979.128652485873, 5030.949690503121, 3889.1638297766117, 3919.9608003920166, 3953.7627742335553, 3960.1089754805516, 3963.6432721055244, 3448.2413868948793, 3458.4293591557616, 3463.341965026637, 3491.969868888684, 3503.491993660905, 4297.957020429818, 4351.586599273064, 4371.453568303962, 4390.121975604892, 4395.692301538862, 5011.173156429221, 5023.82416615424, 5028.120078986163, 5043.041822053798, 5049.343585333883, 4345.044090300129, 4370.0604370059955, 4376.737395756265, 4396.450443694538, 4411.4926783420315, 4457.2199865023495, 4489.506154323022, 4495.9325610115875, 4499.55004499554, 4543.045960348364, 4667.859964201148, 4684.320773487893, 4713.811447542197, 4721.8903557663925, 4732.31381449681, 4966.056449274626, 4971.950280497149, 4982.078315511642, 4985.725785081855, 5004.799808007784, 4697.741624210701, 4753.120672675566, 4770.499097594841, 4815.686980346266, 4831.95168048315, 4969.602431805519, 4976.303317535476, 4979.203327467588, 4986.0, 4994.450610432922, 5041.747912604282, 5070.619703522177, 5080.644354895122, 5084.567811736044, 5109.310243117132, 4862.124817532878, 4925.335079764186, 4962.280469331999, 4964.280179374043, 5009.073321435546, 4813.229883218668, 4829.637777166657, 4859.3682821233015, 4880.902381952412, 4921.089598424303, 4749.691270067435, 4788.138135135709, 4790.9281360780315, 4808.447028591617, 4825.855224343275, 4839.249916262985, 4869.6591238612955, 4887.218045112765, 4951.9257211142585, 4983.476734942924, 4829.66192366531, 4829.7585120743115, 4853.126437241189, 4855.465898751064, 4919.311296418433], "value": 4598.494513138402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5432762445291, 602.3524710935744, 617.1051974636778, 623.6040114527274, 638.7540796793234, 33969.830150849244, 34701.47947780779, 34744.13139671509, 34763.826180869124, 34811.47782783257, 36658.26683466329, 37248.44127338092, 37278.81360593193, 37455.812720936425, 37488.250234995285, 7656.46404751669, 7856.921430785676, 7861.528308301492, 7863.252990965878, 7873.685052597889, 7666.425018123635, 7735.72924947627, 7808.921910780877, 7937.3650107991225, 8009.0, 7917.208279172066, 7975.082865470458, 8016.67933282668, 8060.113387527367, 8060.919390806105, 7938.722144724936, 7999.520028798291, 8010.319122874563, 8012.999999999971, 8017.198280171936, 7785.532868027936, 7883.645235964338, 7893.05283365994, 7896.644650990719, 7901.486403383762, 37812.43281350782, 38149.23701525954, 38286.42570361447, 38340.616593833984, 38416.42375364372, 2676.210517897225, 3129.702678245563, 3527.417976033951, 3748.850045998157, 3756.398976163801, 25467.872660636764, 25526.0, 26156.215313540622, 26614.0, 27372.58941115885, 3316.5522654441584, 3320.4853247746637, 3364.243045314809, 3399.94601673482, 3432.2792213635166, 218408.0, 218467.0, 218557.0, 219056.0, 220592.0, 32874.342513150084, 33822.32355352879, 34048.82975585106, 50740.746296268284, 51101.744491277306, 32065.198370040936, 32247.193820154684, 32252.581056420862, 32420.027399178063, 32556.348873022405, 13083.869161308456, 13200.669983250496, 13215.14101583394, 13300.0, 13338.333083345793, 10888.292261003167, 11032.779344413068, 11046.392448415414, 11073.169512286611, 11078.446077696244, 8180.795480112925, 8192.5494097824, 8231.547264900368, 8262.380321475914, 8271.048829384697, 3175.22207059272, 3218.5172224166563, 3223.629282632527, 3224.98387508061, 3281.1797050737314, 910.3536489092818, 914.9130832570895, 924.7734305095295, 973.3721749471692, 978.3640633588083, 25421.49157016849, 26772.9338008288, 26889.327766805596, 27075.458490830075, 27084.864575676995, 945.5603144537823, 960.8606752020918, 1003.9698809035741, 1004.1264100232844, 1017.9491025448698, 13887.930560347335, 14373.712525749426, 14419.78370324446, 14464.20446875411, 14559.19924404168, 364271.0, 367996.0, 369649.0, 369905.0, 373830.0, 49184.75407623011, 49621.0, 49746.25380619294, 49765.502344976085, 49913.75043124761, 1194.599809063956, 1238.3808095952024, 1239.7954337534386, 1261.4008346035744, 1271.2182008065158, 25396.0, 26137.477250455264, 26583.867080664473, 26763.05606383335, 26964.865175673996, 41103.38344924888, 41505.58494415017, 41529.79235103805, 41617.37573936454, 41826.1634767309, 258001.0, 259690.0, 260222.0, 311925.0, 312032.0, 24674.753252467963, 25197.370065748502, 25522.361940951625, 25572.10497632574, 25807.870960645076, 41374.37938430986, 41744.79127604343, 41868.58131418647, 42203.0, 42573.14853702971, 35676.0, 35811.64188358187, 35867.28265434729, 36217.81891090528, 36842.263154737295, 36015.27969440649, 36093.819530902176, 36204.30220409128, 36595.81702091473, 36676.44985325276, 30108.0, 33603.66396336103, 33853.49219761755, 34419.827900860335, 34729.0, 30583.388332232786, 32045.0, 32060.358792823547, 32076.5188522177, 32254.516182256815, 23364.415889602897, 23663.408414789767, 23744.643830342906, 23784.286471405885, 23861.403464913517], "value": 16081.122688025722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.69605683197705, 369.4126339120798, 386.2506736930355, 393.68111829418154, 406.27277173858795, 15633.530994070183, 16442.83557164428, 17335.479935601936, 17370.565735856577, 17433.82566174338, 11258.493367798448, 15651.295691693873, 16545.834541654578, 16624.418145364914, 16641.50075497734, 4647.907041859161, 4796.376471058775, 4835.15384807659, 4836.97581512092, 4841.951580484185, 3529.876454324099, 5288.867778305554, 5588.524975377098, 5590.804321848736, 5608.831735047955, 5512.779488820443, 5583.441655834425, 5591.860203494904, 5599.41206173352, 5600.18797274395, 5340.172273297645, 5437.700926449043, 5459.645123066988, 5470.835874923759, 5554.72226388679, 5239.659422137549, 5290.994711004935, 5329.227262046981, 5341.145416733343, 5388.703621300827, 12454.377281135998, 12761.936190319082, 20499.89750051255, 20731.378058658265, 20738.274160404464, 1838.7333836593752, 1852.4905650945964, 1928.4889504281377, 2063.3397312859743, 2311.91908283211, 9170.724878253663, 9176.632934682671, 9455.10176533235, 9567.37812042222, 9568.0, 1770.6016146367094, 1781.4477511971202, 1803.3057272949877, 1813.4831573001632, 1814.4465937888938, 58157.12764308539, 62112.68943655298, 69147.0, 72457.2754272461, 74455.62772186159, 9247.907520924704, 9543.904560954441, 9828.606855725691, 10053.547590358305, 10100.898991010143, 13769.724605507834, 13992.16047037181, 14006.789898151535, 14035.368408421646, 14089.295535223198, 6516.2506311773805, 6686.899696504556, 6796.4562834973085, 6798.150231221098, 6804.829879253059, 6340.270868850049, 6342.5243106767175, 6350.0, 6472.126262954441, 6473.514486413538, 4398.450193725785, 4423.690341676116, 4439.334099885043, 4472.1502914446155, 4483.036147228297, 1753.509017475109, 1798.2896755781394, 1807.2319264312878, 1808.7739032620923, 1826.1964735516597, 803.3934379543407, 851.6295411496019, 889.2441424788877, 917.9672868023473, 967.1199208720031, 15292.0, 15548.300326485336, 15638.2180890955, 15750.212489375486, 15819.288132034086, 813.5647428625657, 862.4092496639822, 867.7440155154245, 872.358816270041, 890.7594949363765, 8910.331725120643, 9113.316501262432, 9157.49633770149, 9365.297602679826, 9393.765155871159, 407739.0, 409848.0, 414268.0, 420107.0, 421280.0, 67712.0, 80895.0, 84565.0, 85257.0, 86151.56924215339, 993.9304248702522, 997.7256254529917, 1011.6813203840767, 1056.9312994655322, 1058.957641694339, 15228.390864365301, 15268.312925918139, 15366.154861482726, 15546.067235965878, 15935.601609959844, 33996.66003339935, 34044.31911361709, 34144.317113658086, 35570.288594228485, 35619.10952226215, 48962.51037489579, 49250.753746232476, 49363.25955110748, 49459.25811112908, 49689.25466117939, 7534.133574638768, 7661.463697541119, 7733.342665873463, 7774.067111946602, 7819.335356494534, 8551.74344769658, 10530.736731581464, 11222.663320100084, 11758.0, 11882.0, 9822.950885245527, 9839.754006149904, 9950.402975821475, 10053.145482634058, 10125.392476451436, 10035.899641003789, 10080.89919100829, 10081.092701656886, 10375.584976600852, 10392.636257730943, 9191.77020574491, 9620.75948101303, 9914.30599858003, 10214.387136771817, 10366.429846358522, 7076.340819680377, 7804.648790804541, 7834.529928204326, 7845.215478452109, 7910.762677119696, 9230.0, 9401.658414364709, 9480.715578532656, 9925.404475731479, 10152.340097893613], "value": 8072.801586220984, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.6199788055105, 1493.2160615676771, 1650.224394534569, 1780.0921530019702, 1815.8832318124348, 7027.051348068009, 7609.0, 7612.124605670349, 7869.252421020001, 7875.645595948182, 7671.6547755351, 7685.500442471235, 7741.0, 7795.415343849219, 7805.960970195155, 2248.3816950338623, 2278.236790675126, 2279.464325883416, 2281.133169395627, 2283.680284760135, 2209.734831820184, 2237.7314722233355, 2250.8311876609237, 2254.2786308381324, 2254.7519772824976, 2248.1119957616734, 2266.6033444147292, 2266.954660906781, 2281.007761623699, 2298.092253559851, 2238.485148415857, 2238.854474459155, 2246.359787460574, 2253.1550668499312, 2254.1546919904954, 2233.731952165734, 2234.832387570939, 2236.7763223677666, 2245.2253972379503, 2245.9438514037115, 7777.105632852238, 7846.725364612268, 7910.762677119696, 7922.524648521107, 7954.0, 4666.090112428078, 4789.353437285957, 4803.903921921542, 4805.807767689288, 4827.541383568555, 2916.2271997920566, 2977.5831383606096, 2998.235449960246, 2999.4001199760137, 3003.039027511197, 1767.9027653479054, 1779.3238569343696, 1813.1206364913007, 1851.7777866655954, 1863.3105750872128, 10638.0, 10810.243282970196, 10833.67498975032, 10874.347539147677, 10901.890981090246, 4103.4870641169855, 4120.1553681495225, 4234.343676730112, 4262.637675797592, 4300.204462174508, 8492.957535212285, 8530.402871799039, 8534.487930724177, 8559.443636163629, 8564.400491965502, 4691.085238378483, 4710.764461776897, 4719.126961512131, 4726.645501587394, 4729.0541891621815, 3780.0549862534367, 4195.91608167835, 4377.9124417511475, 4410.1400226956075, 4417.911641767147, 3465.1510379956567, 3467.4452087665854, 3490.6683865032783, 3515.050936247199, 3579.785212887235, 1079.5573814735922, 1102.9283096598695, 1107.9113670906308, 1111.127764704703, 1122.085500317239, 765.4603504529293, 891.0999890111035, 909.9909000909906, 916.5096673279763, 927.0636656976502, 5581.413951535031, 5596.356419011866, 5642.774289028475, 5708.31500219968, 5722.456366645162, 911.7128104647015, 911.8905731312285, 917.5962576466334, 933.9906600934039, 954.3510412919143, 3520.982395088008, 3622.166901612644, 3623.4021386470936, 3664.706823454117, 3710.9072273193387, 9351.0, 9617.086376794194, 9750.073742994404, 9858.408495490294, 10033.397996120257, 9655.275854310954, 9844.9015509844, 9847.0, 9893.258005649604, 9926.602935882629, 7115.466340024415, 7160.498765086394, 7171.856562868714, 7209.495335326582, 7241.167265764399, 5354.2771725818075, 5392.487713667196, 5494.5054945055135, 5546.528545073714, 5579.860503487283, 8723.08407617191, 8893.421927574687, 8900.243479304332, 8916.242119419663, 8975.416597921114, 8618.655253789779, 8909.643614255358, 8946.68686595966, 8954.462732236087, 8984.371094023356, 6715.4963377747845, 6792.150981127359, 6896.137982752156, 6970.163580370388, 6986.790396288119, 7498.58757768328, 7511.286427789351, 7553.131389890233, 7562.546247225184, 7598.316151546387, 6683.264840867403, 6803.455723542006, 6913.274106218774, 6970.198427180939, 7004.334588214111, 6745.865082698417, 6797.830054248683, 6852.280510546321, 6922.5154239204785, 6942.06282151903, 6174.413430724074, 6400.295967443671, 6401.231852177769, 6497.18785151856, 6501.609903405811, 4729.196036673705, 4777.402824646919, 4781.713097214179, 4821.421429428491, 4826.58973987201, 4806.711597304173, 4837.854864354075, 4880.487548807324, 4921.188003979447, 4985.675931064469], "value": 4297.374704378913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.60581863942105, 315.48890796909006, 315.6417466175891, 318.30609271787495, 320.60725611126367, 5184.870378240541, 5223.085959957011, 5244.632875698698, 5329.920051199226, 5343.038253114438, 5196.272521846944, 5212.582993360532, 5219.399769026563, 5220.981908527839, 5221.921671174935, 3825.9043523911914, 3930.8231129599235, 4075.572064933184, 4078.4290199372113, 4091.5703851095654, 4051.4733084698946, 4067.491563554556, 4069.5930406959365, 4079.6940229482757, 4080.163566468867, 4022.3162062449455, 4033.1933613277315, 4038.63652271297, 4041.0, 4057.0871553900283, 3810.466534685146, 4006.1155967703207, 4011.2178125265586, 4021.537523184842, 4069.8052029157116, 3492.7205823534055, 3510.7893526388243, 3520.9437168849245, 3521.506989021539, 3526.047967048908, 4978.87552811179, 4990.276409920578, 4995.650304478651, 4997.225430058346, 5008.574271186953, 4326.58897404746, 4651.395318608559, 4656.115338085753, 4657.534246575349, 4668.719876807402, 5408.675479471205, 5447.175196309241, 5459.535939445152, 5480.561555075585, 5482.205080263339, 3819.618038196158, 3821.445890345912, 3822.9235415291537, 3824.101336185994, 3824.349860523718, 5474.835754927399, 5742.511886489653, 5761.769529218826, 5769.798057068025, 5814.360420353758, 3922.7450215735885, 3975.7813320267082, 3980.840766369313, 3982.4026396040827, 3992.1416895367634, 4064.7357921734992, 4070.3690927906223, 4071.3892916062828, 4075.3275709507598, 4079.85720499787, 4654.0, 4663.323818046364, 4669.509701481364, 4671.556202160789, 4682.438107427062, 5443.891122177534, 5480.342358916876, 5508.531774799107, 5513.42109078549, 5520.1443776214755, 1383.6471699716508, 1412.639776856895, 1413.371049882813, 1414.0, 1419.219429313894, 876.2639382918379, 918.779492921694, 944.7401964459829, 944.9574769135405, 965.546193289167, 4767.308740232646, 4795.232762757942, 4821.228603423436, 4835.597676673796, 4850.563449289511, 5663.122216056436, 5672.971635141798, 5678.97778399892, 5692.8045110527255, 5735.627184233012, 4654.394928659321, 4759.952400476021, 4842.733649649233, 4843.782029808667, 4902.460729319772, 3062.4487592233168, 3064.5709600655928, 3086.66046734859, 3104.875804967776, 3109.2693217093965, 5452.509274165344, 5455.372632147354, 5493.890122197614, 5500.50495455411, 5501.202325662756, 5817.778266564069, 5870.706464676835, 5900.881982360329, 5909.23179986599, 5924.8815023700145, 5378.892422151614, 5426.728663566806, 5453.3455985281225, 5458.208559758892, 5462.481064298885, 5614.157876318585, 5754.280714910637, 5765.221695071279, 5784.537237021113, 5815.476607105381, 5684.147377893184, 5694.0, 5694.800681976111, 5696.829095127153, 5727.570432217683, 5448.536874365724, 5456.42707515721, 5480.123180291134, 5496.148097044965, 5496.697681627549, 3833.769973801581, 3972.841086356629, 3974.3044967131214, 3981.2634662587516, 4004.1190937993597, 5749.137629355463, 5750.6262092963825, 5762.0, 5762.538996880324, 5765.3946335634155, 5477.917831232615, 5545.835374571224, 5545.889082218414, 5581.776728930798, 5591.04952158126, 5276.894462110659, 5571.888562228652, 5580.5535557156145, 5626.549876009991, 5636.549076073986, 5199.792008319625, 5454.918176227439, 5504.146857237135, 5533.142362933751, 5535.086710692691, 5399.379071406682, 5572.804951826829, 5611.57913156523, 5625.184348269559, 5669.54643628517, 5379.112446446293, 5453.481919217668, 5455.18172274162, 5500.28496295495, 5519.399374181442], "value": 4148.940895236694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.048531085858, 695.3012222716169, 729.5950747335229, 784.8116452051506, 792.8216151365943, 11753.764924701502, 12128.514859405635, 12176.573819916304, 12222.938885305572, 12248.203866748667, 11184.664460066191, 11239.269447485907, 11243.269187502827, 11279.0, 11298.435078246095, 648.7988723495707, 807.1807115777491, 820.7250571058703, 843.1442086282428, 846.4582667093065, 817.2522142239873, 821.1172989036779, 827.3711978896022, 828.2835347424465, 829.6639860856363, 876.5354362188051, 879.3229213505597, 881.9073997230295, 884.6815146547237, 888.6845169964666, 874.1520724896808, 874.4753148111146, 875.1161327059684, 877.8858748362704, 878.7803049237691, 643.0418676172516, 646.0632083478974, 647.0520687193284, 647.8736646353963, 648.7145655911431, 12515.937420312932, 12636.989040876708, 12689.175203611736, 12722.236665799988, 12775.87224127756, 12751.405093028536, 12769.106162568623, 12920.0, 12972.545960891417, 13202.4058917348, 10039.648612298608, 10210.08109270162, 10309.587616495332, 10336.018078282552, 10343.689689309333, 3347.0795531228864, 3366.7138293245102, 3409.147713071732, 3413.4879768034743, 3421.640727723578, 45538.08923821538, 45823.77088114538, 46258.306125407806, 47547.0, 47921.76039119782, 9633.32566720337, 9686.612535498502, 9769.462679552551, 9838.60645574169, 9861.359011664219, 16895.408660697063, 17318.0, 17319.2206350712, 17663.29346826138, 17804.732929006077, 6912.101426814583, 7023.789286321418, 7086.255943126001, 7117.71529138839, 7125.358717715327, 3795.3358162321483, 3902.2780785554764, 3930.9606903931167, 3937.8424863005157, 3947.8815635530405, 2889.6387951506063, 2986.865591048408, 2987.596674448965, 2991.1923780579123, 3003.519436890087, 548.9560835133179, 552.3565046720526, 552.4806681719172, 554.7032337699392, 571.9771209151587, 572.6306532286652, 643.3630705601421, 645.3707635055783, 656.9146011018537, 659.0279337976447, 7721.0, 8405.537695426689, 8485.024222214524, 8541.615627296787, 8690.91309086901, 603.2097951683309, 629.4020680353682, 633.6704913444983, 652.5301782716436, 652.6801867085094, 3941.6649584785614, 3971.62269584389, 4031.395290706359, 4046.7976601169826, 4057.9044805612402, 50476.0, 51914.74042629763, 52262.0, 52296.477035229924, 53706.73146634242, 43654.0, 43770.34344484835, 44160.0, 44296.0, 44575.55424445714, 40552.0, 40582.79708601438, 40848.624195643504, 41034.38448423276, 41513.37729934114, 8056.798580035546, 8146.877796832934, 8186.631601577824, 8299.170082991894, 8425.873611895704, 23685.763142369044, 26654.20037398881, 27269.45461090807, 27988.16035518938, 27990.44019119647, 29761.702382975895, 32933.0, 36317.0, 36491.817540912125, 37111.628883710815, 11021.669349919515, 11070.335779853234, 11074.501647425725, 11164.274322169033, 11415.885841141482, 11712.824307635563, 11865.762684746429, 12065.457054432747, 12273.631791046282, 12412.81380779271, 11489.655310340702, 11776.0, 12030.338331391857, 12072.577459788865, 12114.878851211375, 11030.50362733695, 11037.558497660004, 11682.12384071181, 11701.648950531498, 11729.296242225493, 10973.670789876316, 11049.28179668319, 11405.258658187191, 11565.190436669352, 11645.184837061324, 9479.099485548863, 9715.805683886425, 9766.60933562678, 9789.804203915739, 10111.191104711459, 9598.0, 9797.951010244904, 9927.503624818875, 9988.151007164472, 10000.749981250236], "value": 6039.185385924642, "unit": "score"}], "name": "dromaeo_css", "value": 6329.25687118296, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 113.0, 114.0, 114.0, 125.0, 114.0, 115.0, 114.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 157.0, 185.0, 132.0, 159.0, 159.0, 134.0, 183.0, 129.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 175.0, 165.0, 163.0, 163.0, 169.0, 170.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 158.0, 75.0, 76.0, 73.0, 76.0, 173.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 154.0, 94.0, 95.0, 95.0, 145.0, 95.0, 94.0, 134.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 150.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 85.0, 91.0, 84.0, 87.0, 88.0, 99.0, 114.0, 85.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 148.0, 161.0, 149.0, 147.0, 149.0, 145.0, 149.0, 147.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 174.0, 172.0, 175.0, 176.0, 177.0, 178.0, 174.0, 173.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 74.0, 73.0, 81.0, 72.0, 74.0, 73.0, 73.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1619.1000000000001, "alertThreshold": 2.0}]} 09:06:48 INFO - Return code: 0 09:06:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:06:48 ERROR - # TBPL SUCCESS # 09:06:48 INFO - Running post-action listener: _resource_record_post_action 09:06:48 INFO - Running post-run listener: _resource_record_post_run 09:06:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518451200; Read time: 12; Write time: 413312 09:06:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233541632; Read time: 0; Write time: 235908 09:06:49 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284909568; Read time: 12; Write time: 177404 09:06:49 INFO - Running post-run listener: _upload_blobber_files 09:06:49 INFO - Blob upload gear active. 09:06:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:49 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 09:06:49 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'] 09:06:49 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 09:06:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:50 INFO - (blobuploader) - INFO - Done attempting. 09:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:51 INFO - (blobuploader) - INFO - Done attempting. 09:06:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:51 INFO - Return code: 0 09:06:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/114eb021c471bb5b8ce7841564ebbd925336f8ad08f2f3a56e6765973c0b966542c2a5109ef8f71ca6c49555b730a51bedc767677babfd70bb69069971255715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dce24455e2dd34354ea4b3bae62ca781b73ce62dbc9020c150203f4f3c0c9cdf718eb2e48c41cf584dc185a437dc32f9d95beac8b99eb4a60a33c9bd69756f4"} 09:06:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:51 INFO - Contents: 09:06:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/114eb021c471bb5b8ce7841564ebbd925336f8ad08f2f3a56e6765973c0b966542c2a5109ef8f71ca6c49555b730a51bedc767677babfd70bb69069971255715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dce24455e2dd34354ea4b3bae62ca781b73ce62dbc9020c150203f4f3c0c9cdf718eb2e48c41cf584dc185a437dc32f9d95beac8b99eb4a60a33c9bd69756f4"} 09:06:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:51 INFO - Copying logs to upload dir... 09:06:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.016406 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-13 09:06:51.765229) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:06:51.769001) ========= 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/114eb021c471bb5b8ce7841564ebbd925336f8ad08f2f3a56e6765973c0b966542c2a5109ef8f71ca6c49555b730a51bedc767677babfd70bb69069971255715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dce24455e2dd34354ea4b3bae62ca781b73ce62dbc9020c150203f4f3c0c9cdf718eb2e48c41cf584dc185a437dc32f9d95beac8b99eb4a60a33c9bd69756f4"} build_url:https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/114eb021c471bb5b8ce7841564ebbd925336f8ad08f2f3a56e6765973c0b966542c2a5109ef8f71ca6c49555b730a51bedc767677babfd70bb69069971255715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dce24455e2dd34354ea4b3bae62ca781b73ce62dbc9020c150203f4f3c0c9cdf718eb2e48c41cf584dc185a437dc32f9d95beac8b99eb4a60a33c9bd69756f4"}' ========= master_lag: 0.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:06:52.018791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:06:52.022209) ========= 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=523ca41ca1e0623de333ad52000001bf-1460562132.442178-1792414043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:06:52.038277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:06:52.038600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:06:52.038886) ========= ========= Total master_lag: 1.14 =========