builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 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.084226) ========= 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.084589) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.084880) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.142738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.143466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.164322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.164584) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.214780) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.215061) ========= 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.215411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.215690) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-04-13 08:46:09 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.370560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.370847) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:09.419669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 08:46:09.420002) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 08:46:09,702 truncating revision to first 12 chars 2016-04-13 08:46:09,702 Setting DEBUG logging. 2016-04-13 08:46:09,702 attempt 1/10 2016-04-13 08:46:09,702 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,703 unpacking tar archive at: mozilla-central-564b225d5535/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278019 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 08:46:10.710806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.714196) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 564b225d553547fe4aa9a1039278f695c9507db9 program finished with exit code 0 elapsedTime=0.004727 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.765732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.766066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:10.777276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-13 08:46:10.777701) ========= /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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:11 INFO - MultiFileLogger online at 20160413 08:46:11 in /builds/slave/test 08:46:11 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:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:11 INFO - {'append_to_log': False, 08:46:11 INFO - 'base_work_dir': '/builds/slave/test', 08:46:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:46:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:11 INFO - 'branch': 'Firefox-Non-PGO', 08:46:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:11 INFO - 'config_files': ('talos/linux_config.py',), 08:46:11 INFO - 'default_actions': ('clobber', 08:46:11 INFO - 'read-buildbot-config', 08:46:11 INFO - 'download-and-extract', 08:46:11 INFO - 'populate-webroot', 08:46:11 INFO - 'create-virtualenv', 08:46:11 INFO - 'install', 08:46:11 INFO - 'run-tests'), 08:46:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:11 INFO - 'download_minidump_stackwalk': True, 08:46:11 INFO - 'download_symbols': 'ondemand', 08:46:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:11 INFO - 'installer_path': 'installer.exe', 08:46:11 INFO - 'log_level': 'info', 08:46:11 INFO - 'log_name': 'talos', 08:46:11 INFO - 'log_to_console': True, 08:46:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:11 INFO - 'opt_config_files': (), 08:46:11 INFO - 'pip_index': False, 08:46:11 INFO - 'sps_profile': False, 08:46:11 INFO - 'sps_profile_interval': 0, 08:46:11 INFO - 'suite': 'dromaeojs-e10s', 08:46:11 INFO - 'system_bits': '32', 08:46:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:11 INFO - 'title': 'talos-linux64-ix-032', 08:46:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:11 INFO - 'use_talos_json': True, 08:46:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:11 INFO - 'work_dir': 'build'} 08:46:11 INFO - ##### 08:46:11 INFO - ##### Running clobber 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: clobber 08:46:11 INFO - rmtree: /builds/slave/test/build 08:46:11 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": 317, 08:46:11 INFO - "slavename": "talos-linux64-ix-032", 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:18 INFO - Downloaded 1361 bytes. 08:46:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:18 INFO - Using the following test package requirements: 08:46:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:46:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'jsshell-linux-x86_64.zip'], 08:46:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46:18 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:18 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:18 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:18 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:18 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:18 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:32 INFO - Downloaded 22198810 bytes. 08:46:32 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:32 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:33 INFO - Return code: 0 08:46:33 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: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 - 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:33 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:33 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:33 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:33 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:34 INFO - Downloaded 22198810 bytes. 08:46:34 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:34 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:35 INFO - Return code: 0 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 - 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:35 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:35 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:35 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:35 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:36 INFO - Downloaded 10841076 bytes. 08:46:36 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:36 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:37 INFO - Return code: 0 08:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:37 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:37 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:37 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:37 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:37 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:38 INFO - Downloaded 54152078 bytes. 08:46:38 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:38 INFO - mkdir: /builds/slave/test/properties 08:46:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:38 INFO - Contents: 08:46:38 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:39 INFO - Running post-action listener: _resource_record_post_action 08:46:39 INFO - Running post-action listener: set_extra_try_arguments 08:46:39 INFO - ##### 08:46:39 INFO - ##### Running populate-webroot step. 08:46:39 INFO - ##### 08:46:39 INFO - Running pre-action listener: _resource_record_pre_action 08:46:39 INFO - Running main action method: populate_webroot 08:46:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:39 INFO - '--tppagecycles', 08:46:39 INFO - '7'], 08:46:39 INFO - 'tests': ['tsvgm']}}, 08:46:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['damp', 'tps']}, 08:46:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'tests': ['damp', 'tps']}, 08:46:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['dromaeo_dom']}, 08:46:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['a11yr', 08:46:39 INFO - 'ts_paint', 08:46:39 INFO - 'tpaint', 08:46:39 INFO - 'sessionrestore', 08:46:39 INFO - 'sessionrestore_no_auto_restore', 08:46:39 INFO - 'tabpaint']}, 08:46:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:39 INFO - 'ts_paint', 08:46:39 INFO - 'tpaint', 08:46:39 INFO - 'sessionrestore', 08:46:39 INFO - 'sessionrestore_no_auto_restore', 08:46:39 INFO - 'tabpaint']}, 08:46:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:39 INFO - 'ts_paint', 08:46:39 INFO - 'tpaint', 08:46:39 INFO - 'sessionrestore', 08:46:39 INFO - 'sessionrestore_no_auto_restore', 08:46:39 INFO - 'tabpaint']}, 08:46:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:39 INFO - 'ts_paint', 08:46:39 INFO - 'tpaint', 08:46:39 INFO - 'sessionrestore', 08:46:39 INFO - 'sessionrestore_no_auto_restore', 08:46:39 INFO - 'tabpaint']}, 08:46:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['a11yr', 08:46:39 INFO - 'ts_paint', 08:46:39 INFO - 'tpaint', 08:46:39 INFO - 'sessionrestore', 08:46:39 INFO - 'sessionrestore_no_auto_restore', 08:46:39 INFO - 'tabpaint']}, 08:46:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['a11yr', 08:46:39 INFO - 'ts_paint', 08:46:39 INFO - 'tpaint', 08:46:39 INFO - 'sessionrestore', 08:46:39 INFO - 'sessionrestore_no_auto_restore', 08:46:39 INFO - 'tabpaint']}, 08:46:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['tsvgx', 08:46:39 INFO - 'tsvgr_opacity', 08:46:39 INFO - 'tart', 08:46:39 INFO - 'tscrollx', 08:46:39 INFO - 'cart']}, 08:46:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:39 INFO - 'tsvgr_opacity', 08:46:39 INFO - 'tart', 08:46:39 INFO - 'tscrollx', 08:46:39 INFO - 'cart']}, 08:46:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'talos_options': ['--disable-e10s'], 08:46:39 INFO - 'tests': ['tp5o']}, 08:46:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'tests': ['tp5o']}, 08:46:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'talos_options': ['--disable-e10s', 08:46:39 INFO - '--xperf_path', 08:46:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:39 INFO - 'tests': ['tp5n']}, 08:46:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:39 INFO - 'talos_options': ['--xperf_path', 08:46:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:39 INFO - 'tests': ['tp5n']}}, 08:46:39 INFO - 'talos.zip': {'path': '', 08:46:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:39 INFO - Running post-action listener: _resource_record_post_action 08:46:39 INFO - ##### 08:46:39 INFO - ##### Running create-virtualenv step. 08:46:39 INFO - ##### 08:46:39 INFO - Running pre-action listener: _resource_record_pre_action 08:46:39 INFO - Running main action method: create_virtualenv 08:46:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:39 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:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:39 INFO - Using real prefix '/usr' 08:46:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:42 INFO - Installing pip.................done. 08:46:42 INFO - Return code: 0 08:46:42 INFO - Installing pip>=1.5 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', '--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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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', '--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:42 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: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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 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 - 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:42 INFO - Cleaning up... 08:46:42 INFO - Return code: 0 08:46:42 INFO - Installing psutil>=0.7.1 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', '--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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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', '--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:42 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: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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 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 - Downloading/unpacking psutil>=0.7.1 08:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:44 INFO - Installing collected packages: psutil 08:46:44 INFO - Running setup.py install for psutil 08:46:44 INFO - building 'psutil._psutil_linux' extension 08:46:44 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:44 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:44 INFO - building 'psutil._psutil_posix' extension 08:46:44 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:44 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:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:45 INFO - Successfully installed psutil 08:46:45 INFO - Cleaning up... 08:46:45 INFO - Return code: 0 08:46:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:45 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 08:46:45 INFO - 'HOME': '/home/cltbld', 08:46:45 INFO - 'LANG': 'en_US.UTF-8', 08:46:45 INFO - 'LANGUAGE': 'en_US:en', 08:46:45 INFO - 'LOGNAME': 'cltbld', 08:46:45 INFO - 'MAIL': '/var/mail/cltbld', 08:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:45 INFO - 'MOZ_NO_REMOTE': '1', 08:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:45 INFO - 'NO_EM_RESTART': '1', 08:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:45 INFO - 'PWD': '/builds/slave/test', 08:46:45 INFO - 'SHELL': '/bin/bash', 08:46:45 INFO - 'SHLVL': '1', 08:46:45 INFO - 'TERM': 'linux', 08:46:45 INFO - 'TMOUT': '86400', 08:46:45 INFO - 'USER': 'cltbld', 08:46:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:45 INFO - '_': '/tools/buildbot/bin/python'} 08:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:46:45 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:45 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 - 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:45 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:45 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:45 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:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:47 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:47 INFO - Installing collected packages: mozsystemmonitor 08:46:47 INFO - Running setup.py install for mozsystemmonitor 08:46:47 INFO - Successfully installed mozsystemmonitor 08:46:47 INFO - Cleaning up... 08:46:47 INFO - Return code: 0 08:46:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:47 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 08:46:47 INFO - 'HOME': '/home/cltbld', 08:46:47 INFO - 'LANG': 'en_US.UTF-8', 08:46:47 INFO - 'LANGUAGE': 'en_US:en', 08:46:47 INFO - 'LOGNAME': 'cltbld', 08:46:47 INFO - 'MAIL': '/var/mail/cltbld', 08:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:47 INFO - 'MOZ_NO_REMOTE': '1', 08:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:47 INFO - 'NO_EM_RESTART': '1', 08:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:47 INFO - 'PWD': '/builds/slave/test', 08:46:47 INFO - 'SHELL': '/bin/bash', 08:46:47 INFO - 'SHLVL': '1', 08:46:47 INFO - 'TERM': 'linux', 08:46:47 INFO - 'TMOUT': '86400', 08:46:47 INFO - 'USER': 'cltbld', 08:46:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:47 INFO - '_': '/tools/buildbot/bin/python'} 08:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:47 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:47 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:47 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:47 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:47 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:47 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 - Downloading blobuploader-1.2.4.tar.gz 08:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:50 INFO - Downloading docopt-0.6.1.tar.gz 08:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:50 INFO - Running setup.py install for blobuploader 08:46:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:50 INFO - Running setup.py install for requests 08:46:50 INFO - Running setup.py install for docopt 08:46:50 INFO - Successfully installed blobuploader requests docopt 08:46:50 INFO - Cleaning up... 08:46:50 INFO - Return code: 0 08:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:50 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 08:46:50 INFO - 'HOME': '/home/cltbld', 08:46:50 INFO - 'LANG': 'en_US.UTF-8', 08:46:50 INFO - 'LANGUAGE': 'en_US:en', 08:46:50 INFO - 'LOGNAME': 'cltbld', 08:46:50 INFO - 'MAIL': '/var/mail/cltbld', 08:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:50 INFO - 'MOZ_NO_REMOTE': '1', 08:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:50 INFO - 'NO_EM_RESTART': '1', 08:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:50 INFO - 'PWD': '/builds/slave/test', 08:46:50 INFO - 'SHELL': '/bin/bash', 08:46:50 INFO - 'SHLVL': '1', 08:46:50 INFO - 'TERM': 'linux', 08:46:50 INFO - 'TMOUT': '86400', 08:46:50 INFO - 'USER': 'cltbld', 08:46:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:50 INFO - '_': '/tools/buildbot/bin/python'} 08:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:51 INFO - Running setup.py (path:/tmp/pip-tlJjkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:51 INFO - Running setup.py (path:/tmp/pip-LD599r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:51 INFO - Running setup.py (path:/tmp/pip-NWb1ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:51 INFO - Running setup.py (path:/tmp/pip-OY0PDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:51 INFO - Running setup.py (path:/tmp/pip-JpCFWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:51 INFO - Running setup.py (path:/tmp/pip-pDJZlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:51 INFO - Running setup.py (path:/tmp/pip-kBIY5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:51 INFO - Running setup.py (path:/tmp/pip-hD4uXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:51 INFO - Running setup.py (path:/tmp/pip-g2ACZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:51 INFO - Running setup.py (path:/tmp/pip-xg38r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:51 INFO - Running setup.py (path:/tmp/pip-N_IfCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:51 INFO - Running setup.py (path:/tmp/pip-2M1S5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:51 INFO - Running setup.py (path:/tmp/pip-Kl2mms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:51 INFO - Running setup.py (path:/tmp/pip-urVQ96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:52 INFO - Running setup.py (path:/tmp/pip-W5p9pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:52 INFO - Running setup.py (path:/tmp/pip-J28kIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:52 INFO - Running setup.py (path:/tmp/pip-n7zX1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:52 INFO - Running setup.py install for manifestparser 08:46:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:52 INFO - Running setup.py install for mozcrash 08:46:52 INFO - Running setup.py install for mozdebug 08:46:52 INFO - Running setup.py install for mozdevice 08:46:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:52 INFO - Running setup.py install for mozfile 08:46:52 INFO - Running setup.py install for mozhttpd 08:46:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:52 INFO - Running setup.py install for mozinfo 08:46:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:52 INFO - Running setup.py install for mozInstall 08:46:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Running setup.py install for mozleak 08:46:53 INFO - Running setup.py install for mozlog 08:46:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Running setup.py install for moznetwork 08:46:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Running setup.py install for mozprocess 08:46:53 INFO - Running setup.py install for mozprofile 08:46:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Running setup.py install for mozrunner 08:46:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:53 INFO - Running setup.py install for mozscreenshot 08:46:53 INFO - Running setup.py install for moztest 08:46:53 INFO - Running setup.py install for mozversion 08:46:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:54 INFO - Cleaning up... 08:46:54 INFO - Return code: 0 08:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:54 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 08:46:54 INFO - 'HOME': '/home/cltbld', 08:46:54 INFO - 'LANG': 'en_US.UTF-8', 08:46:54 INFO - 'LANGUAGE': 'en_US:en', 08:46:54 INFO - 'LOGNAME': 'cltbld', 08:46:54 INFO - 'MAIL': '/var/mail/cltbld', 08:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:54 INFO - 'MOZ_NO_REMOTE': '1', 08:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:54 INFO - 'NO_EM_RESTART': '1', 08:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:54 INFO - 'PWD': '/builds/slave/test', 08:46:54 INFO - 'SHELL': '/bin/bash', 08:46:54 INFO - 'SHLVL': '1', 08:46:54 INFO - 'TERM': 'linux', 08:46:54 INFO - 'TMOUT': '86400', 08:46:54 INFO - 'USER': 'cltbld', 08:46:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:54 INFO - '_': '/tools/buildbot/bin/python'} 08:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:54 INFO - Running setup.py (path:/tmp/pip-Uc2Spf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:54 INFO - Running setup.py (path:/tmp/pip-6ruNFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:54 INFO - Running setup.py (path:/tmp/pip-oFw3ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:54 INFO - Running setup.py (path:/tmp/pip-U7ejkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:54 INFO - Running setup.py (path:/tmp/pip-8y89AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:54 INFO - Running setup.py (path:/tmp/pip-Xq9b79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:54 INFO - Running setup.py (path:/tmp/pip-z6rW2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:54 INFO - Running setup.py (path:/tmp/pip-BFTAwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:54 INFO - Running setup.py (path:/tmp/pip-6a21ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:54 INFO - Running setup.py (path:/tmp/pip-MOrzYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:54 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:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:54 INFO - Running setup.py (path:/tmp/pip-iFOgRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:55 INFO - Running setup.py (path:/tmp/pip-fgew53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:55 INFO - Running setup.py (path:/tmp/pip-ztWsO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:55 INFO - Running setup.py (path:/tmp/pip-h0LJx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:55 INFO - Running setup.py (path:/tmp/pip-V2Os2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:55 INFO - Running setup.py (path:/tmp/pip-0BFf_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:55 INFO - Running setup.py (path:/tmp/pip-XcRC9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:57 INFO - Downloading blessings-1.6.tar.gz 08:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:57 INFO - Installing collected packages: blessings 08:46:57 INFO - Running setup.py install for blessings 08:46:57 INFO - Successfully installed blessings 08:46:57 INFO - Cleaning up... 08:46:57 INFO - Return code: 0 08:46:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:57 INFO - Reading from file tmpfile_stdout 08:46:57 INFO - Current package versions: 08:46:57 INFO - argparse == 1.2.1 08:46:57 INFO - blessings == 1.6 08:46:57 INFO - blobuploader == 1.2.4 08:46:57 INFO - docopt == 0.6.1 08:46:57 INFO - manifestparser == 1.1 08:46:57 INFO - mozInstall == 1.12 08:46:57 INFO - mozcrash == 0.17 08:46:57 INFO - mozdebug == 0.1 08:46:57 INFO - mozdevice == 0.48 08:46:57 INFO - mozfile == 1.2 08:46:57 INFO - mozhttpd == 0.7 08:46:57 INFO - mozinfo == 0.9 08:46:57 INFO - mozleak == 0.1 08:46:57 INFO - mozlog == 3.1 08:46:57 INFO - moznetwork == 0.27 08:46:57 INFO - mozprocess == 0.22 08:46:57 INFO - mozprofile == 0.28 08:46:57 INFO - mozrunner == 6.11 08:46:57 INFO - mozscreenshot == 0.1 08:46:57 INFO - mozsystemmonitor == 0.0 08:46:57 INFO - moztest == 0.7 08:46:57 INFO - mozversion == 1.4 08:46:57 INFO - psutil == 3.1.1 08:46:57 INFO - requests == 1.2.3 08:46:57 INFO - wsgiref == 0.1.2 08:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:57 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 08:46:57 INFO - 'HOME': '/home/cltbld', 08:46:57 INFO - 'LANG': 'en_US.UTF-8', 08:46:57 INFO - 'LANGUAGE': 'en_US:en', 08:46:57 INFO - 'LOGNAME': 'cltbld', 08:46:57 INFO - 'MAIL': '/var/mail/cltbld', 08:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:57 INFO - 'MOZ_NO_REMOTE': '1', 08:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:57 INFO - 'NO_EM_RESTART': '1', 08:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:57 INFO - 'PWD': '/builds/slave/test', 08:46:57 INFO - 'SHELL': '/bin/bash', 08:46:57 INFO - 'SHLVL': '1', 08:46:57 INFO - 'TERM': 'linux', 08:46:57 INFO - 'TMOUT': '86400', 08:46:57 INFO - 'USER': 'cltbld', 08:46:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:57 INFO - '_': '/tools/buildbot/bin/python'} 08:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Cleaning up... 08:46:58 INFO - Return code: 0 08:46:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 08:46:58 INFO - 'HOME': '/home/cltbld', 08:46:58 INFO - 'LANG': 'en_US.UTF-8', 08:46:58 INFO - 'LANGUAGE': 'en_US:en', 08:46:58 INFO - 'LOGNAME': 'cltbld', 08:46:58 INFO - 'MAIL': '/var/mail/cltbld', 08:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:58 INFO - 'MOZ_NO_REMOTE': '1', 08:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:58 INFO - 'NO_EM_RESTART': '1', 08:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:58 INFO - 'PWD': '/builds/slave/test', 08:46:58 INFO - 'SHELL': '/bin/bash', 08:46:58 INFO - 'SHLVL': '1', 08:46:58 INFO - 'TERM': 'linux', 08:46:58 INFO - 'TMOUT': '86400', 08:46:58 INFO - 'USER': 'cltbld', 08:46:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:58 INFO - '_': '/tools/buildbot/bin/python'} 08:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:58 INFO - Downloading/unpacking jsonschema 08:46:58 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:58 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:58 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:58 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:58 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:58 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:47:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:00 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:00 INFO - warning: no files found matching '*.txt' 08:47:00 INFO - no previously-included directories found matching 'build' 08:47:00 INFO - no previously-included directories found matching 'dist' 08:47:00 INFO - no previously-included directories found matching '.git*' 08:47:00 INFO - Installing collected packages: jsonschema, functools32 08:47:00 INFO - Running setup.py install for functools32 08:47:00 INFO - warning: no files found matching '*.txt' 08:47:00 INFO - no previously-included directories found matching 'build' 08:47:00 INFO - no previously-included directories found matching 'dist' 08:47:00 INFO - no previously-included directories found matching '.git*' 08:47:00 INFO - Successfully installed jsonschema functools32 08:47:00 INFO - Cleaning up... 08:47:00 INFO - Return code: 0 08:47:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:00 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 0x7ff808526f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, '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': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', '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:47:00 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:47:00 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:47:00 INFO - Using env: {'DISPLAY': ':0', 08:47:00 INFO - 'HOME': '/home/cltbld', 08:47:00 INFO - 'LANG': 'en_US.UTF-8', 08:47:00 INFO - 'LANGUAGE': 'en_US:en', 08:47:00 INFO - 'LOGNAME': 'cltbld', 08:47:00 INFO - 'MAIL': '/var/mail/cltbld', 08:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:00 INFO - 'MOZ_NO_REMOTE': '1', 08:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:00 INFO - 'NO_EM_RESTART': '1', 08:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:00 INFO - 'PWD': '/builds/slave/test', 08:47:00 INFO - 'SHELL': '/bin/bash', 08:47:00 INFO - 'SHLVL': '1', 08:47:00 INFO - 'TERM': 'linux', 08:47:00 INFO - 'TMOUT': '86400', 08:47:00 INFO - 'USER': 'cltbld', 08:47:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:00 INFO - '_': '/tools/buildbot/bin/python'} 08:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:00 INFO - Downloading/unpacking flake8 08:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:03 INFO - no previously-included directories found matching 'docs/_build' 08:47:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:03 INFO - Running setup.py install for pep8 08:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:03 INFO - no previously-included directories found matching 'docs/_build' 08:47:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:03 INFO - Cleaning up... 08:47:03 INFO - Return code: 0 08:47:03 INFO - Running post-action listener: _resource_record_post_action 08:47:03 INFO - Running post-action listener: _start_resource_monitoring 08:47:03 INFO - Starting resource monitoring. 08:47:03 INFO - ##### 08:47:03 INFO - ##### Running install step. 08:47:03 INFO - ##### 08:47:03 INFO - Running pre-action listener: _resource_record_pre_action 08:47:03 INFO - Running main action method: install 08:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:03 INFO - Reading from file tmpfile_stdout 08:47:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:03 INFO - Reading from file tmpfile_stdout 08:47:03 INFO - Output received: 08:47:03 INFO - Usage: mozinstall [options] installer 08:47:03 INFO - Options: 08:47:03 INFO - -h, --help show this help message and exit 08:47:03 INFO - -d DEST, --destination=DEST 08:47:03 INFO - Directory to install application into. [default: 08:47:03 INFO - "/builds/slave/test"] 08:47:03 INFO - --app=APP Application being installed. [default: firefox] 08:47:03 INFO - mkdir: /builds/slave/test/build/application 08:47:03 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:47:03 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:20 INFO - Reading from file tmpfile_stdout 08:47:20 INFO - Output received: 08:47:20 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:20 INFO - Running post-action listener: _resource_record_post_action 08:47:20 INFO - ##### 08:47:20 INFO - ##### Running run-tests step. 08:47:20 INFO - ##### 08:47:20 INFO - Running pre-action listener: _resource_record_pre_action 08:47:20 INFO - Running main action method: run_tests 08:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:20 INFO - Python 2.7.3 08:47:20 INFO - Return code: 0 08:47:20 INFO - grabbing minidump binary from tooltool 08:47:20 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:20 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 0x2aeb410>, '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 0x2aec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aec7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:20 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:20 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:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:20 INFO - Return code: 0 08:47:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:21 INFO - Return code: 0 08:47:21 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-032', '--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:21 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-032 --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:21 INFO - Using env: {'DISPLAY': ':0', 08:47:21 INFO - 'HOME': '/home/cltbld', 08:47:21 INFO - 'LANG': 'en_US.UTF-8', 08:47:21 INFO - 'LANGUAGE': 'en_US:en', 08:47:21 INFO - 'LOGNAME': 'cltbld', 08:47:21 INFO - 'MAIL': '/var/mail/cltbld', 08:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:21 INFO - 'MOZ_NO_REMOTE': '1', 08:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:21 INFO - 'NO_EM_RESTART': '1', 08:47:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:21 INFO - 'PWD': '/builds/slave/test', 08:47:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:21 INFO - 'SHELL': '/bin/bash', 08:47:21 INFO - 'SHLVL': '1', 08:47:21 INFO - 'TERM': 'linux', 08:47:21 INFO - 'TMOUT': '86400', 08:47:21 INFO - 'USER': 'cltbld', 08:47:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460561313.992332-1331379723', 08:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:21 INFO - '_': '/tools/buildbot/bin/python'} 08:47:21 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-032', '--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:21 INFO - mozversion application_buildid: 20160413025454 08:47:21 INFO - mozversion application_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 08:47:21 INFO - mozversion application_display_name: Nightly 08:47:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:21 INFO - mozversion application_name: Firefox 08:47:21 INFO - mozversion application_remotingname: firefox 08:47:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:21 INFO - mozversion application_vendor: Mozilla 08:47:21 INFO - mozversion application_version: 48.0a1 08:47:21 INFO - mozversion platform_buildid: 20160413025454 08:47:21 INFO - mozversion platform_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 08:47:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:21 INFO - mozversion platform_version: 48.0a1 08:47:21 INFO - using testdate: 1460562441 08:47:21 INFO - actual date: 1460562441 08:47:21 INFO - starting webserver on 'localhost:34383' 08:47:21 INFO - SUITE-START | Running 2 tests 08:47:21 INFO - TEST-START | dromaeo_css 08:47:21 INFO - operating with platform_type : linux_ 08:47:21 INFO - Initialising browser for dromaeo_css test... 08:47:21 INFO - TEST-INFO | started process 28939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDoucLV/profile http://localhost:34383/getInfo.html) 08:47:26 INFO - PROCESS | 28939 | 08:47:26 INFO - PROCESS | 28939 | (process:29006): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:47:26 INFO - PROCESS | 28939 | 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:27 INFO - PROCESS | 28939 | __metrics Screen width/height:1600/1200 08:47:27 INFO - PROCESS | 28939 | colorDepth:24 08:47:27 INFO - PROCESS | 28939 | Browser inner width/height: 1024/697 08:47:27 INFO - PROCESS | 28939 | __metrics 08:47:28 ERROR - PROCESS | 28939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:47:29 INFO - TEST-INFO | 28939: exit 0 08:47:29 INFO - Browser initialized. 08:47:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:29 INFO - TEST-INFO | started process 29057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDoucLV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:31 INFO - PROCESS | 29057 | 08:47:31 INFO - PROCESS | 29057 | (process:29115): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:47:41 INFO - PROCESS | 29057 | RSS: Main: 164421632 08:47:41 INFO - PROCESS | 29057 | 08:48:31 INFO - PROCESS | 29057 | 1460562511234 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:43 INFO - PROCESS | 29057 | Cycle 1(1): loaded http://localhost:34383/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34383/tests/dromaeo/cssquery-ext.html) 08:50:44 INFO - PROCESS | 29057 | RSS: Main: 168579072 08:50:44 INFO - PROCESS | 29057 | 08:53:46 INFO - PROCESS | 29057 | Cycle 1(1): loaded http://localhost:34383/tests/dromaeo/cssquery-ext.html (next: http://localhost:34383/tests/dromaeo/cssquery-jquery.html) 08:53:47 INFO - PROCESS | 29057 | RSS: Main: 165556224 08:53:47 INFO - PROCESS | 29057 | 08:56:49 INFO - PROCESS | 29057 | Cycle 1(1): loaded http://localhost:34383/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34383/tests/dromaeo/cssquery-mootools.html) 08:56:49 INFO - PROCESS | 29057 | RSS: Main: 166432768 08:56:49 INFO - PROCESS | 29057 | 08:59:51 INFO - PROCESS | 29057 | Cycle 1(1): loaded http://localhost:34383/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34383/tests/dromaeo/cssquery-prototype.html) 08:59:52 INFO - PROCESS | 29057 | RSS: Main: 163856384 08:59:52 INFO - PROCESS | 29057 | 09:02:54 INFO - PROCESS | 29057 | Cycle 1(1): loaded http://localhost:34383/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34383/tests/dromaeo/cssquery-yui.html) 09:02:55 INFO - PROCESS | 29057 | RSS: Main: 164532224 09:02:55 INFO - PROCESS | 29057 | 09:05:57 INFO - PROCESS | 29057 | Cycle 1(1): loaded http://localhost:34383/tests/dromaeo/cssquery-yui.html (next: http://localhost:34383/tests/dromaeo/cssquery-dojo.html) 09:05:58 INFO - PROCESS | 29057 | RSS: Main: 167731200 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | __start_tp_report 09:05:58 INFO - PROCESS | 29057 | _x_x_mozilla_page_load 09:05:58 INFO - PROCESS | 29057 | _x_x_mozilla_page_load_details 09:05:58 INFO - PROCESS | 29057 | |i|pagename|runs| 09:05:58 INFO - PROCESS | 29057 | |0;dojo.html;2614.738526147385;2681.772049375803;2706.106984695051;2713.7693296069833;2722.142525104592;4739.739314337714;4774.498677638846;4783.784729687164;4789.137955168068;4794.113089078514;4656.883577910554;4689.7655117244085;4746.857594272177;4774.68964517307;4807.6153907687385;4317.805698743564;4334.854681603548;4367.781610919457;4415.602595766381;4452.688311818158;4389.100234451929;4408.272635015219;4422.159789639958;4426.402435671175;4488;4210.578942105795;4234.597713217239;4289.335153051282;4363.890902727426;4424.491183513905;4309.418228539138;4315.287977483711;4319.352097185416;4341.4790225172865;4358.455193100863;4276.935845962313;4284.057507348379;4305.268104422255;4308.095299987007;4374.825006999717;4562.224421848294;4601;4622.8150873965005;4695.553922377403;4718.079974404993;5029.974850125763;5050.191969284933;5067.695938243717;5069.594432445396;5145.974270128663;5097.8215762448135;5109.821156259551;5113.258577506241;5114.718690472023;5127.051495473312;4628.930566041512;4716.646251531149;4747.098051370229;4790.065937142223;4792.233242681224;5169.663971841818;5172.844814655567;5177.068127736969;5201.193814958688;5244.685318880879;4903.387076615423;4945.134601444733;4947.158982972904;4959.82640607577;4964.379452568429;4971.875703107451;5018.623603229772;5023;5120.7951681933055;5140.1004824155625;5080.390353157644;5083.593312534988;5088.389393272831;5099;5112.667676601009;4898.436679781799;4995.600351971833;5014.824481143142;5050.393952725696;5092.414372347153;3873.5158105236846;3894.4547763313158;3935.153941902505;3941.6649584785614;3941.9014524637114;3429.8628054878022;3451.516787649731;3468.393031219577;3469.340825243196;3504.3341765064556;4295.871123866226;4345.044090300129;4381.123775244963;4422.358757980075;4453.265211240109;5125.897482050338;5129.333186685782;5130.358705161855;5142.922856157161;5187.844364669066;4409.14021765759;4421.447319085114;4422.933655995163;4435.3125265583885;4451.132029254329;4440;4482.798274077609;4537.455505339314;4540.046590216091;4542.318652202196;4839.927401088916;4855.101806165871;4859.684120532224;4885.95114048855;4894.167991441393;5081;5088.313077734459;5122.282880396822;5133.101707201299;5149.098907691214;4698.600618947291;4773.355596994361;4818.180909245507;4842.564169224786;4844.031193761191;5014.7994080236385;5021.397432308147;5027.069992051483;5035.59715222774;5073.670211436245;5093.23601459784;5095.770690319018;5103.004914041726;5114.71869047206;5129.102407078672;4787.8563643090765;4788.11419887322;4845.878853028703;4853.684510506947;4876.317315575751;4878.63410244226;4946.777395017305;4965.0318187953;4968.776405061853;4984.775685094107;4829.348038014823;4869.780859861244;4898.510148985073;4910.656254062182;4938.456769755396;4820.614350851994;4933.1613625683;4965.900681986413;4992.725400102884;5016.122178618654;4859.586935110555;4882.652551682727;4904.362432883702;4905.583025442877;4942.3080768693135 09:05:58 INFO - PROCESS | 29057 | |1;ext.html;561.5823878204332;575.873307872268;590.2710152961095;624.3756243756244;645.515863102673;33074.33851322972;34392.56074392563;34396.82801585995;34424.1393965151;34426;34280.65719342806;34567;34783;34819.129521761904;34872.65127348726;7453.70185192593;7625.961870190641;7651.120121186052;7654.808629784272;7655.349295309906;7485.887711684329;7740.651670674805;7752.26353496417;7768.300852923236;7771.339436147906;7772.650230739602;7817.921820781805;7852;7856.1751016143335;7857.6856925722905;7678.654460549261;7757.612119394036;7792.376609871197;7804.882926756103;7815.0231221097365;7707.884381734279;7723.7682869514;7775.028121484815;7793.96103019487;7800.219978002211;29515.852420737974;34321.313573728636;34597.827010864785;34766.826165869265;35052;3075.600171977651;3086.0124760076783;3312.4700047992446;3718.535183102112;3806.410006449005;27324.726752732615;27528.174154775388;27631;28510.42979140426;28591.714082859322;3415.214500664861;3444.896653100411;3469.2887957968555;3490.5636795400574;3549.361114999299;109998;110884;111674;112474.43762781215;113321.4333928325;35530;58503.70748146232;59318;59426;59434;36424.27151456956;36864.44703329452;36911.44632830509;36927;36992;13322.200667959953;13489;13694.041417100907;13694.65763355924;13737.381817818223;11008.669739907815;11143.72140696489;11144.387058711849;11184.496697648463;11212.831807522894;8334.541600212047;8378.078411374743;8378.162183781695;8380.868582741374;8498.235158835734;3332.716719078857;3338.2322065924973;3347.7656564040285;3379.341028499419;3407.539982102434;857.4865362634954;861.573521107056;912.397817440486;919.2783664823082;956.8421210500189;25871.61192582113;26026.34934126662;26727.331816704736;26861;27011;916.4409710076848;940.5532372123187;972.9854052189223;1057.8201705710048;1063.9202059845543;13671;14096.154230746188;14392.35234414454;14406;14447.927760361132;361583;369469;369767;370856;371869;48021.279680804815;48663;48831;49007.264891026665;49066.264006039935;1222.4193508083767;1251.046692451866;1252.0922331309728;1260.3635164241998;1264.4815625593462;24746.628800567647;25739.742602574483;26388.340291492867;26521.07176248822;26752.331191719582;42470.78764606157;42976;43020.13959720851;43252.78373608112;43276.35085473784;309227;309297;311445;312523;312799;25897.22308330753;25925.222243331977;26364.20907372782;26524.734752652228;26528;41769;42453.363199551415;42475;43397.278274980694;46846.29730553976;35286.29427411386;35363.64636353707;35474.82262588671;35553.46669800007;36118.63881361153;34397.48403773995;34830.47754283738;34860.65139348574;35064.82467587646;35324.470132947514;29090.7090929088;33465.16337091592;33918.321633566695;34733;35098;28690.56964145581;28927.42145157127;29516.704832951396;29772.255693607833;31144;21912.342629721134;22402.551948961256;22449.551008980055;22517.324480264964;22547 09:05:58 INFO - PROCESS | 29057 | |2;jquery.html;387.550441487874;389.108940526195;389.8927794856415;391.9196564704236;406.09846141565714;13322.533711320106;14299.78550321746;15810.84189158108;16572.088535130577;17028.57428564288;15707.84292157078;15793.447229346946;16483.340666373362;16484.34062637493;16663.25015374308;5046.873828154307;5221.921671174935;5234.6335756497065;5252.973735131319;5273.789048438058;5081.898362032757;5175.637705360627;5222.294990176335;5371.194320851864;5384.40771515133;5257.106291930381;5361.303030606015;5364.973175134119;5374.596905232123;5398.649087809299;5522.061249587579;5546.639468434539;5566.777328906859;5567.582431317667;5572.024895643266;5200.76596553156;5350.3312085989255;5372.247885296062;5381.515663590296;5396.622236443451;11932.940335298268;12295.385230738428;20004.299849505343;20814;20965.371038868707;1834.5413646588354;1905.3236101184157;1940.3402843033437;2122.777108403611;2512.371907023244;8607.784805379853;8943.731688049369;9126.863097053549;9285.675001374988;9520.619175232983;1780.7685000949793;1798.0470350714143;1884.2274667386305;1913.1677720191622;1927.60484100759;65539.3446065538;66544.3345566543;67241.66379168122;67743.66128169377;69552.30447695509;9649.758756031155;10109.725311804785;10385.84421233682;10416.895831041593;10522.894771052192;14376.209308488134;14432.628900254458;14447.133172009502;14525.201113938623;14589.124652520883;7233.45749068822;7329.780106596811;7334.596597187206;7461.962690186514;7463;6805.489588280899;6827.897581536281;6909.654517274116;6927.545215504801;7022.929770702228;4301.849075462269;4362.781860906942;4376.8905777355185;4395.978020109879;4418.359337895987;1848.7689038870142;1857.7677790276216;1863.7390765292869;1886.6226754649126;1887.1885089411685;901.2024358442825;905.7554460295684;925.4632313258294;927.1007123090591;938.6620816506053;15479.690406192038;16490.58773530647;16569.171541422882;16784.006475758397;16902.40841570539;836.9874451883227;841.1714461255658;845.3068483843313;851.3317046118767;863.7754183912228;8894.644214231488;9146.679312152119;9323.160915517636;9348.859767103362;9361.204297634642;137938;138650;390598;391288;396531;57932;69200;70240.64879675569;76594.23405765872;78665;916.2944532709777;925.2551695884742;932.1657116880355;938.4885237545554;943.6225509796;14635.724990167197;15157.848421515644;15219.239038048274;15254.313555890234;15488.612784680474;33358.33283334368;33473;34560.65439345675;34897.30205395827;34981.65018349886;45570.08859822851;46021.53978460172;47091.29363059488;47446.28830567475;47852.28221576749;5004.049230646166;7639.923600763921;7706.113796913427;7717.151113377412;7791.610419479117;6253.3121356651645;9956.701298961043;11064.944675276573;11550.306981581132;11585.768284634429;9789.902100979183;10144.746381340525;10161.237907156845;10179.49102544855;10266.486675666038;9617.422954622745;9747.220222382335;9942.353747006711;10224.846627300745;10254.128399086161;9774.755631108994;10056.748581285527;10302.690919272434;10424.947875260576;10550.919197518951;6770.627615481196;7003.754868579779;7325.523840950321;7779.183185765413;7937.32532734724;9942.254330925065;10050.296479246383;10126.696199114038;10290.588376464857;10311.278210525192 09:05:58 INFO - PROCESS | 29057 | |3;mootools.html;1486.3088663771348;1502.7971223884774;1675.103819456591;1806.4580625812268;1828.2230052227808;7112.85774284514;7739.26476984687;7742.651580678869;8060.113387527382;8072.152423995484;7846.646900889459;7874.094479134887;7900.367970562355;7941.880871786928;7966.362690984722;2251.819854411647;2281.543691261746;2285.268714011517;2301.8043466305385;2307.792298693117;2218.134927378324;2232.6092933736613;2255.571441426124;2263.196565219348;2275.681404603357;2240.215924426446;2259.344790010895;2269.024319542596;2270.8410411271216;2295.2081531871477;2229.687843701883;2237.3176181264707;2240.0815665577115;2242.529068895534;2242.7645097264876;2181.094845639058;2183.2031308572414;2191.594555007329;2192.6382146945734;2195;7939.483933544301;7960.800979975489;7994.880076798852;8074.717384891501;8112.107668156498;4743.952560474386;4816.783244753994;4849.806007759686;4887.486813884562;4895.485973972753;3044.497657886446;3057.8929737459302;3171.270607760228;3181.284211052518;3222.436073687119;1020.3928662445833;1026.2303272545591;1029.4852573713144;1034.8310190597936;1041.2971244409994;11153.386563738992;11234.775304493945;11257.718557036058;11262.211645184758;11278.266912650652;4225.091605304874;4316.115196384733;4457.175422546839;4465.709728867613;4512.390827238347;9450.57472413743;9452.385594936308;9458.90541094594;9502.192313653417;9547.856782148274;4840.782164802592;4863.270509423544;4872.317875497433;4877.244027175793;4884.584810291094;3768.4724138620613;4320.697551171451;4435.6229720473475;4439.755813430228;4452.287633978613;3724.329620668306;3750.1187221003042;3826.253880493333;3849.730518863653;3856.7107466940092;1241.422738426636;1248.5442813373054;1255.604484587352;1256.9434375453127;1275.9043071769654;763.2024534361606;845.8350621628723;876.5222953490363;880.7754022724164;932.4312169576552;5642.746076426571;5727.570432217601;5732.283464566929;5839.649621022752;5896.233489646319;942.1567696911226;959.7072892767633;975.5756943994169;978.0659470205936;1006.4062203300089;3586.569611646567;3783.886483405502;3811.1615444602144;3815.9427608585893;3846.000039989623;9758.609655613838;9964.05341492557;10156.136728378024;10209;10237.692869213786;10030.64892728751;10084.49577521121;10121.139703125316;10122.139618132542;10154.949225253975;7472.626368681653;7475.36459400957;7487.812804679927;7493.288137626917;7549.131849837229;5418.756155973069;5486.149646804752;5590.2453168821685;5614.185943038318;5706.457886500776;8562.315014798925;8710.47737135774;8720.389572729848;8755.430896991675;8815.294776417742;8639.784005399915;8808.955955220183;8853.73438796837;9199.724008279762;9245.121713437213;6325.272593651789;6928.930710692828;7016.438684905297;7035.22612512613;7133.037039999534;7631.8855217172895;7686.423518236043;7708.691652334068;7741.7677469676;7755.030621172354;6927.58434493932;7177.1746249182015;7215.71137154529;7291.30732580404;7294.234105418855;7017.859642807218;7024.262452442625;7031.261717519586;7051.365377116084;7179.9641001796745;6525.282218956006;6726.327367263235;6726.8654626908165;6728.05807187004;6751.088603038724;4822.927656085091;4907.288443175648;4945.653804233669;4966.180580204225;5002.899942001212;4838.806447742051;4912.091263116335;4927.802887884444;4930.063287975273;4953.18272485036 09:05:58 INFO - PROCESS | 29057 | |4;prototype.html;307.3530218889238;319.3660583741273;321.89055721054854;326.43852573573446;328.61880218946027;5232.241325007881;5234.895302093956;5249.973750131248;5274;5320.707361095138;5187.325647665808;5204.609654275925;5215.765290561924;5216.765245563949;5247.737613119348;3805.467234587153;3953.545342285631;4080.3063479208604;4093.8157782899693;4113.958860411402;4078.714489985702;4088.8568900088503;4093.079057212118;4110.856120035799;4118.382242663594;4029.9798501007454;4044.2518134145275;4044.939325910114;4060.553339132693;4078.1232035112444;3769.2838360711376;3994.7802870842092;4000.19996000801;4055.371417430303;4065.87802365928;3516.0682419158943;3521.630228825962;3525.3207562252614;3527.400341941876;3527.9294414111573;4924.089043526959;4958.578520825734;4967.403911530603;4976.278439626234;4982.377202849644;4375.2124617568825;4613.515580863995;4640.373549570832;4655.883602909955;4663.370444989917;5463.453654634544;5482.396936337;5483.314585676791;5496.890062198733;5497.257870187514;3824.8852534424013;3854.113553882623;3862.4978752761963;3872.206197729459;3886.9028274293087;5554.861128471821;5728.656280623176;5747.3677895431465;5797.652140871562;5808.2449281593545;3942.743721658083;3962.7027972902147;3984.5816189300285;3990.4213888985932;4007.8396864125693;4001.019750161171;4009.1781184857036;4021.055052062763;4034.11249525104;4035.233305671913;4619.745913974763;4629.51390104041;4638.582527572535;4656.348111264426;4657.74382408964;5253.343332083489;5498.697571633518;5521.282233309644;5532.225488431623;5532.6680399176175;1385.1066062389702;1393.540131756518;1394.4770710983382;1399.9930000349932;1402.2287741742205;875.9956200218958;912.3066469483108;941.9340646154703;952.4285428742699;956.9808603828023;4803.5916947059195;4850.151223535938;4850.1997170466475;4860.635452341018;4866.148424025781;5503.229547863302;5536.446355364431;5591.916121258185;5615.326160860723;5631.7747290108755;4633.930491042637;4741.407324084489;4783.6651434399955;4784.186688263004;4817;2968.3469636679897;3001.1896787867154;3015.20097174249;3016.6078409806587;3031.575579418883;5284.154535274338;5287.814926477555;5296.549793267538;5308.018016666929;5321.281626980308;5604.346717718283;5724.742386592613;5756.683382414008;5761.761221337432;5763.596548241583;5242.9814521409535;5254.474552544715;5282.788688452419;5293.364796224478;5332.840014799563;5411.594130440154;5517.200005999028;5565.499105080562;5577.860553486195;5617.241672374341;5468.179773033918;5512.3660779010925;5517.089680202722;5517.889642207053;5530.115181570929;5264.6314757966575;5279.366476022902;5315.069862774077;5320.255164276927;5334.706591137525;3869.7871617061332;3894.084890050892;3951.407288906687;3953.367461206193;3968.563458019558;5551.555875529867;5554.6944918028275;5560.805371811967;5584.274044374368;5594.272744543347;5368.382635996911;5380.650257733235;5395.3525576931015;5408.648437851527;5426.7829286829665;5323.0950738373795;5345.412004679404;5378.19327100938;5395.325584301962;5440.510354068153;5324.733763311897;5351.9464805351445;5359.088954877758;5361.5231281878505;5378.354597448331;5238.738063096754;5431.5926305526455;5575.135853942646;5577.191307260506;5595.230360971345;5458.399576046711;5459.918101228405;5460.672359658433;5468;5482.42434544383 09:05:58 INFO - PROCESS | 29057 | |5;yui.html;676.4655921821759;689.6586189836029;706.0574133531733;759.1562067957362;800.6757263308363;11327.207095503298;11728.472218750156;11980.940095299522;12020.57927972521;12993.61019169424;12851.678708032305;12917.80623290649;12958.48166073356;12964.35178241089;13024.934875325634;831.0941074229089;836.5608055770708;838.8741688746707;839.3075712537151;842.9199226073513;827.3629305434841;839.9160083991613;840.1766269056328;840.5671079394117;840.6805413942693;856.1737922904396;867.3104881619097;871.1114663043692;872.0538216035577;875.4265955798962;855.2815634866741;859.1065292096243;860.7891066688638;866.0257210638032;868.8218915122417;619.4455961914061;638.5753473939825;638.7349250061219;639.4021589813493;639.808057582728;13126.081174317802;13225;13262.73474530504;13281.468741250339;13289.401976911062;11204.887951120547;11896;11950.462229199708;12633.557825476157;12934.741305173939;10088.445135517544;10105.191584673208;10165.847512287322;10201.642942496977;10599.947000265027;3322.7041453833026;3364.562606861117;3383.086566626997;3407.727381809449;3463.0476618929742;46244.999999999665;46374.76812615949;46506;46556.5344346559;46797;9688.854667179998;9768.316217864682;9785.559649815776;9814.852777208347;9919.355241909398;16784.664306713796;16795.328186872634;16952.15239238058;17289.48131556055;17319.134043297785;6964.199117101497;7030.261822508665;7119.786406407816;7188.892166617505;7337.3029562191505;3758.8496460141837;3890.7471014383973;3892.065904182976;3906.9218615628097;3923.8234279457492;2900.5649152627275;2984.6716861145255;2988.9701102989125;2996.310848504856;3000.9099727008224;554.8945700317007;557.0363271540258;568.3350479938399;570.349801226602;571.2830397850671;624.6345887655682;627.2660986645635;629.4649547884262;636.9777057803047;656.5371413153715;7851.9214807851195;8113.107558168596;8117.431779775359;8216.21945915137;8226.465279756796;501.8845665496883;573.1259828761173;593.3384276531723;618.7555915413386;642.7653906324158;3933.9803300983313;4025.75845449274;4069.8168582413864;4084.387341898739;4222.113356195234;49125.50874491209;50150.996980060925;50186.74906625444;50195.74902125539;50462.49537504578;43988.3401748974;44486.33270500945;45201.773991129834;45922.77038614786;46350.76824615923;40799.388009179886;41027.38458923119;41625.1674966499;41864.790676046425;42735.786321068816;7915.485493442908;7922.235480311618;7947.403944704055;8043.276105150565;8048.83902321962;28419.289517762223;28923.56614650824;29524.852375737984;29688.554671680373;30064.84967575148;36199.27601448009;36805.44791828178;37474.625253747115;37553.812230939766;37732;9597.664081757104;9673.274504412339;9866.605335786488;9871.753206169904;9871.950640246752;10065.849012264676;10243.692689219335;10277.640282590073;10346.120579750504;10407.21945854079;9671.129598336183;9896.505174741378;9899.653512127328;10486.003829636173;10721.35671859691;9689.515524223902;9710.17463515609;9829.655962041581;9849;9946.651867184613;10180.898191017995;10194.43930583825;10200;10318.793624127326;10375.377477351383;8595;8691.304695624209;8729.345299102466;8773.605187766438;9087.36388452802;8602.268807151462;8870.112988701336;8982.236509896471;9073.546322683971;9075.909240907506 09:05:58 INFO - PROCESS | 29057 | __end_tp_report 09:05:58 INFO - PROCESS | 29057 | __start_cc_report 09:05:58 INFO - PROCESS | 29057 | _x_x_mozilla_cycle_collect,361 09:05:58 INFO - PROCESS | 29057 | __end_cc_report 09:05:58 INFO - PROCESS | 29057 | __startTimestamp1460563558050__endTimestamp 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | ------- Summary: start ------- 09:05:58 INFO - PROCESS | 29057 | Number of tests: 6 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | [#0] dojo.html Cycles:165 Average:4668.95 Median:4839.93 stddev:522.31 (10.8%) stddev-sans-first:498.44 09:05:58 INFO - PROCESS | 29057 | Values: 2614.7 2681.8 2706.1 2713.8 2722.1 4739.7 4774.5 4783.8 4789.1 4794.1 4656.9 4689.8 4746.9 4774.7 4807.6 4317.8 4334.9 4367.8 4415.6 4452.7 4389.1 4408.3 4422.2 4426.4 4488.0 4210.6 4234.6 4289.3 4363.9 4424.5 4309.4 4315.3 4319.4 4341.5 4358.5 4276.9 4284.1 4305.3 4308.1 4374.8 4562.2 4601.0 4622.8 4695.6 4718.1 5030.0 5050.2 5067.7 5069.6 5146.0 5097.8 5109.8 5113.3 5114.7 5127.1 4628.9 4716.6 4747.1 4790.1 4792.2 5169.7 5172.8 5177.1 5201.2 5244.7 4903.4 4945.1 4947.2 4959.8 4964.4 4971.9 5018.6 5023.0 5120.8 5140.1 5080.4 5083.6 5088.4 5099.0 5112.7 4898.4 4995.6 5014.8 5050.4 5092.4 3873.5 3894.5 3935.2 3941.7 3941.9 3429.9 3451.5 3468.4 3469.3 3504.3 4295.9 4345.0 4381.1 4422.4 4453.3 5125.9 5129.3 5130.4 5142.9 5187.8 4409.1 4421.4 4422.9 4435.3 4451.1 4440.0 4482.8 4537.5 4540.0 4542.3 4839.9 4855.1 4859.7 4886.0 4894.2 5081.0 5088.3 5122.3 5133.1 5149.1 4698.6 4773.4 4818.2 4842.6 4844.0 5014.8 5021.4 5027.1 5035.6 5073.7 5093.2 5095.8 5103.0 5114.7 5129.1 4787.9 4788.1 4845.9 4853.7 4876.3 4878.6 4946.8 4965.0 4968.8 4984.8 4829.3 4869.8 4898.5 4910.7 4938.5 4820.6 4933.2 4965.9 4992.7 5016.1 4859.6 4882.7 4904.4 4905.6 4942.3 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | [#1] ext.html Cycles:180 Average:41184.03 Median:34824.80 stddev:76020.40 (218.3%) stddev-sans-first:76172.47 09:05:58 INFO - PROCESS | 29057 | Values: 561.6 575.9 590.3 624.4 645.5 33074.3 34392.6 34396.8 34424.1 34426.0 34280.7 34567.0 34783.0 34819.1 34872.7 7453.7 7626.0 7651.1 7654.8 7655.3 7485.9 7740.7 7752.3 7768.3 7771.3 7772.7 7817.9 7852.0 7856.2 7857.7 7678.7 7757.6 7792.4 7804.9 7815.0 7707.9 7723.8 7775.0 7794.0 7800.2 29515.9 34321.3 34597.8 34766.8 35052.0 3075.6 3086.0 3312.5 3718.5 3806.4 27324.7 27528.2 27631.0 28510.4 28591.7 3415.2 3444.9 3469.3 3490.6 3549.4 109998.0 110884.0 111674.0 112474.4 113321.4 35530.0 58503.7 59318.0 59426.0 59434.0 36424.3 36864.4 36911.4 36927.0 36992.0 13322.2 13489.0 13694.0 13694.7 13737.4 11008.7 11143.7 11144.4 11184.5 11212.8 8334.5 8378.1 8378.2 8380.9 8498.2 3332.7 3338.2 3347.8 3379.3 3407.5 857.5 861.6 912.4 919.3 956.8 25871.6 26026.3 26727.3 26861.0 27011.0 916.4 940.6 973.0 1057.8 1063.9 13671.0 14096.2 14392.4 14406.0 14447.9 361583.0 369469.0 369767.0 370856.0 371869.0 48021.3 48663.0 48831.0 49007.3 49066.3 1222.4 1251.0 1252.1 1260.4 1264.5 24746.6 25739.7 26388.3 26521.1 26752.3 42470.8 42976.0 43020.1 43252.8 43276.4 309227.0 309297.0 311445.0 312523.0 312799.0 25897.2 25925.2 26364.2 26524.7 26528.0 41769.0 42453.4 42475.0 43397.3 46846.3 35286.3 35363.6 35474.8 35553.5 36118.6 34397.5 34830.5 34860.7 35064.8 35324.5 29090.7 33465.2 33918.3 34733.0 35098.0 28690.6 28927.4 29516.7 29772.3 31144.0 21912.3 22402.6 22449.6 22517.3 22547.0 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | [#2] jquery.html Cycles:180 Average:20905.68 Median:26428.17 stddev:52883.66 (200.1%) stddev-sans-first:53009.57 09:05:58 INFO - PROCESS | 29057 | Values: 387.6 389.1 389.9 391.9 406.1 13322.5 14299.8 15810.8 16572.1 17028.6 15707.8 15793.4 16483.3 16484.3 16663.3 5046.9 5221.9 5234.6 5253.0 5273.8 5081.9 5175.6 5222.3 5371.2 5384.4 5257.1 5361.3 5365.0 5374.6 5398.6 5522.1 5546.6 5566.8 5567.6 5572.0 5200.8 5350.3 5372.2 5381.5 5396.6 11932.9 12295.4 20004.3 20814.0 20965.4 1834.5 1905.3 1940.3 2122.8 2512.4 8607.8 8943.7 9126.9 9285.7 9520.6 1780.8 1798.0 1884.2 1913.2 1927.6 65539.3 66544.3 67241.7 67743.7 69552.3 9649.8 10109.7 10385.8 10416.9 10522.9 14376.2 14432.6 14447.1 14525.2 14589.1 7233.5 7329.8 7334.6 7462.0 7463.0 6805.5 6827.9 6909.7 6927.5 7022.9 4301.8 4362.8 4376.9 4396.0 4418.4 1848.8 1857.8 1863.7 1886.6 1887.2 901.2 905.8 925.5 927.1 938.7 15479.7 16490.6 16569.2 16784.0 16902.4 837.0 841.2 845.3 851.3 863.8 8894.6 9146.7 9323.2 9348.9 9361.2 137938.0 138650.0 390598.0 391288.0 396531.0 57932.0 69200.0 70240.6 76594.2 78665.0 916.3 925.3 932.2 938.5 943.6 14635.7 15157.8 15219.2 15254.3 15488.6 33358.3 33473.0 34560.7 34897.3 34981.7 45570.1 46021.5 47091.3 47446.3 47852.3 5004.0 7639.9 7706.1 7717.2 7791.6 6253.3 9956.7 11064.9 11550.3 11585.8 9789.9 10144.7 10161.2 10179.5 10266.5 9617.4 9747.2 9942.4 10224.8 10254.1 9774.8 10056.7 10302.7 10424.9 10550.9 6770.6 7003.8 7325.5 7779.2 7937.3 9942.3 10050.3 10126.7 10290.6 10311.3 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | [#3] mootools.html Cycles:180 Average:5347.47 Median:4901.39 stddev:2946.32 (60.1%) stddev-sans-first:2940.30 09:05:58 INFO - PROCESS | 29057 | Values: 1486.3 1502.8 1675.1 1806.5 1828.2 7112.9 7739.3 7742.7 8060.1 8072.2 7846.6 7874.1 7900.4 7941.9 7966.4 2251.8 2281.5 2285.3 2301.8 2307.8 2218.1 2232.6 2255.6 2263.2 2275.7 2240.2 2259.3 2269.0 2270.8 2295.2 2229.7 2237.3 2240.1 2242.5 2242.8 2181.1 2183.2 2191.6 2192.6 2195.0 7939.5 7960.8 7994.9 8074.7 8112.1 4744.0 4816.8 4849.8 4887.5 4895.5 3044.5 3057.9 3171.3 3181.3 3222.4 1020.4 1026.2 1029.5 1034.8 1041.3 11153.4 11234.8 11257.7 11262.2 11278.3 4225.1 4316.1 4457.2 4465.7 4512.4 9450.6 9452.4 9458.9 9502.2 9547.9 4840.8 4863.3 4872.3 4877.2 4884.6 3768.5 4320.7 4435.6 4439.8 4452.3 3724.3 3750.1 3826.3 3849.7 3856.7 1241.4 1248.5 1255.6 1256.9 1275.9 763.2 845.8 876.5 880.8 932.4 5642.7 5727.6 5732.3 5839.6 5896.2 942.2 959.7 975.6 978.1 1006.4 3586.6 3783.9 3811.2 3815.9 3846.0 9758.6 9964.1 10156.1 10209.0 10237.7 10030.6 10084.5 10121.1 10122.1 10154.9 7472.6 7475.4 7487.8 7493.3 7549.1 5418.8 5486.1 5590.2 5614.2 5706.5 8562.3 8710.5 8720.4 8755.4 8815.3 8639.8 8809.0 8853.7 9199.7 9245.1 6325.3 6928.9 7016.4 7035.2 7133.0 7631.9 7686.4 7708.7 7741.8 7755.0 6927.6 7177.2 7215.7 7291.3 7294.2 7017.9 7024.3 7031.3 7051.4 7180.0 6525.3 6726.3 6726.9 6728.1 6751.1 4822.9 4907.3 4945.7 4966.2 5002.9 4838.8 4912.1 4927.8 4930.1 4953.2 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | [#4] prototype.html Cycles:180 Average:4525.46 Median:5236.82 stddev:1317.71 (25.2%) stddev-sans-first:1282.81 09:05:58 INFO - PROCESS | 29057 | Values: 307.4 319.4 321.9 326.4 328.6 5232.2 5234.9 5250.0 5274.0 5320.7 5187.3 5204.6 5215.8 5216.8 5247.7 3805.5 3953.5 4080.3 4093.8 4114.0 4078.7 4088.9 4093.1 4110.9 4118.4 4030.0 4044.3 4044.9 4060.6 4078.1 3769.3 3994.8 4000.2 4055.4 4065.9 3516.1 3521.6 3525.3 3527.4 3527.9 4924.1 4958.6 4967.4 4976.3 4982.4 4375.2 4613.5 4640.4 4655.9 4663.4 5463.5 5482.4 5483.3 5496.9 5497.3 3824.9 3854.1 3862.5 3872.2 3886.9 5554.9 5728.7 5747.4 5797.7 5808.2 3942.7 3962.7 3984.6 3990.4 4007.8 4001.0 4009.2 4021.1 4034.1 4035.2 4619.7 4629.5 4638.6 4656.3 4657.7 5253.3 5498.7 5521.3 5532.2 5532.7 1385.1 1393.5 1394.5 1400.0 1402.2 876.0 912.3 941.9 952.4 957.0 4803.6 4850.2 4850.2 4860.6 4866.1 5503.2 5536.4 5591.9 5615.3 5631.8 4633.9 4741.4 4783.7 4784.2 4817.0 2968.3 3001.2 3015.2 3016.6 3031.6 5284.2 5287.8 5296.5 5308.0 5321.3 5604.3 5724.7 5756.7 5761.8 5763.6 5243.0 5254.5 5282.8 5293.4 5332.8 5411.6 5517.2 5565.5 5577.9 5617.2 5468.2 5512.4 5517.1 5517.9 5530.1 5264.6 5279.4 5315.1 5320.3 5334.7 3869.8 3894.1 3951.4 3953.4 3968.6 5551.6 5554.7 5560.8 5584.3 5594.3 5368.4 5380.7 5395.4 5408.6 5426.8 5323.1 5345.4 5378.2 5395.3 5440.5 5324.7 5351.9 5359.1 5361.5 5378.4 5238.7 5431.6 5575.1 5577.2 5595.2 5458.4 5459.9 5460.7 5468.0 5482.4 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - PROCESS | 29057 | [#5] yui.html Cycles:180 Average:12476.89 Median:50191.25 stddev:14082.96 (28.1%) stddev-sans-first:14094.59 09:05:58 INFO - PROCESS | 29057 | Values: 676.5 689.7 706.1 759.2 800.7 11327.2 11728.5 11980.9 12020.6 12993.6 12851.7 12917.8 12958.5 12964.4 13024.9 831.1 836.6 838.9 839.3 842.9 827.4 839.9 840.2 840.6 840.7 856.2 867.3 871.1 872.1 875.4 855.3 859.1 860.8 866.0 868.8 619.4 638.6 638.7 639.4 639.8 13126.1 13225.0 13262.7 13281.5 13289.4 11204.9 11896.0 11950.5 12633.6 12934.7 10088.4 10105.2 10165.8 10201.6 10599.9 3322.7 3364.6 3383.1 3407.7 3463.0 46245.0 46374.8 46506.0 46556.5 46797.0 9688.9 9768.3 9785.6 9814.9 9919.4 16784.7 16795.3 16952.2 17289.5 17319.1 6964.2 7030.3 7119.8 7188.9 7337.3 3758.8 3890.7 3892.1 3906.9 3923.8 2900.6 2984.7 2989.0 2996.3 3000.9 554.9 557.0 568.3 570.3 571.3 624.6 627.3 629.5 637.0 656.5 7851.9 8113.1 8117.4 8216.2 8226.5 501.9 573.1 593.3 618.8 642.8 3934.0 4025.8 4069.8 4084.4 4222.1 49125.5 50151.0 50186.7 50195.7 50462.5 43988.3 44486.3 45201.8 45922.8 46350.8 40799.4 41027.4 41625.2 41864.8 42735.8 7915.5 7922.2 7947.4 8043.3 8048.8 28419.3 28923.6 29524.9 29688.6 30064.8 36199.3 36805.4 37474.6 37553.8 37732.0 9597.7 9673.3 9866.6 9871.8 9872.0 10065.8 10243.7 10277.6 10346.1 10407.2 9671.1 9896.5 9899.7 10486.0 10721.4 9689.5 9710.2 9829.7 9849.0 9946.7 10180.9 10194.4 10200.0 10318.8 10375.4 8595.0 8691.3 8729.3 8773.6 9087.4 8602.3 8870.1 8982.2 9073.5 9075.9 09:05:58 INFO - PROCESS | 29057 | -------- Summary: end -------- 09:05:58 INFO - PROCESS | 29057 | 09:05:58 INFO - TEST-INFO | 29057: exit 0 09:05:58 INFO - TEST-OK | dromaeo_css | took 1117314ms 09:05:58 INFO - TEST-START | kraken 09:05:58 INFO - operating with platform_type : linux_ 09:05:58 INFO - Initialising browser for kraken test... 09:05:58 INFO - TEST-INFO | started process 29291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp55HpKm/profile http://localhost:34383/getInfo.html) 09:06:03 INFO - PROCESS | 29291 | 09:06:03 INFO - PROCESS | 29291 | (process:29358): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:06:03 INFO - PROCESS | 29291 | 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:06:04 INFO - PROCESS | 29291 | __metrics Screen width/height:1600/1200 09:06:04 INFO - PROCESS | 29291 | colorDepth:24 09:06:04 INFO - PROCESS | 29291 | Browser inner width/height: 1024/697 09:06:04 INFO - PROCESS | 29291 | __metrics 09:06:04 ERROR - PROCESS | 29291 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:06:05 INFO - TEST-INFO | 29291: exit 0 09:06:05 INFO - Browser initialized. 09:06:05 INFO - Running cycle 1/1 for kraken test... 09:06:05 INFO - TEST-INFO | started process 29410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp55HpKm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:07 INFO - PROCESS | 29410 | 09:06:07 INFO - PROCESS | 29410 | (process:29469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:06:17 INFO - PROCESS | 29410 | RSS: Main: 164106240 09:06:17 INFO - PROCESS | 29410 | 09:06:20 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34383/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:21 INFO - PROCESS | 29410 | RSS: Main: 168509440 09:06:21 INFO - PROCESS | 29410 | 09:06:24 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34383/tests/kraken/driver.html?testName=audio-dft) 09:06:24 INFO - PROCESS | 29410 | RSS: Main: 171737088 09:06:24 INFO - PROCESS | 29410 | 09:06:27 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34383/tests/kraken/driver.html?testName=audio-fft) 09:06:28 INFO - PROCESS | 29410 | RSS: Main: 163532800 09:06:28 INFO - PROCESS | 29410 | 09:06:30 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34383/tests/kraken/driver.html?testName=audio-oscillator) 09:06:31 INFO - PROCESS | 29410 | RSS: Main: 164384768 09:06:31 INFO - PROCESS | 29410 | 09:06:33 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34383/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:34 INFO - PROCESS | 29410 | RSS: Main: 164720640 09:06:34 INFO - PROCESS | 29410 | 09:06:37 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34383/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:37 INFO - PROCESS | 29410 | RSS: Main: 164626432 09:06:37 INFO - PROCESS | 29410 | 09:06:41 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34383/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:42 INFO - PROCESS | 29410 | RSS: Main: 163848192 09:06:42 INFO - PROCESS | 29410 | 09:06:44 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34383/tests/kraken/driver.html?testName=json-parse-financial) 09:06:45 INFO - PROCESS | 29410 | RSS: Main: 164569088 09:06:45 INFO - PROCESS | 29410 | 09:06:47 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34383/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:47 INFO - PROCESS | 29410 | RSS: Main: 165105664 09:06:47 INFO - PROCESS | 29410 | 09:06:49 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:50 INFO - PROCESS | 29410 | RSS: Main: 164929536 09:06:50 INFO - PROCESS | 29410 | 09:06:52 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:53 INFO - PROCESS | 29410 | RSS: Main: 165371904 09:06:53 INFO - PROCESS | 29410 | 09:06:56 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:56 INFO - PROCESS | 29410 | RSS: Main: 165548032 09:06:56 INFO - PROCESS | 29410 | 09:06:59 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:00 INFO - PROCESS | 29410 | RSS: Main: 165474304 09:07:00 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:34383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34383/tests/kraken/driver.html?testName=ai-astar) 09:07:02 INFO - PROCESS | 29410 | RSS: Main: 166764544 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | __start_tp_report 09:07:02 INFO - PROCESS | 29410 | _x_x_mozilla_page_load 09:07:02 INFO - PROCESS | 29410 | _x_x_mozilla_page_load_details 09:07:02 INFO - PROCESS | 29410 | |i|pagename|runs| 09:07:02 INFO - PROCESS | 29410 | |0;ai-astar;113;108;113;113;113;126;113;114;114;113 09:07:02 INFO - PROCESS | 29410 | |1;audio-beat-detection;167;135;157;183;134;165;159;144;192;136 09:07:02 INFO - PROCESS | 29410 | |2;audio-dft;164;163;166;167;170;163;162;165;167;165 09:07:02 INFO - PROCESS | 29410 | |3;audio-fft;74;76;74;158;75;74;73;74;159;74 09:07:02 INFO - PROCESS | 29410 | |4;audio-oscillator;95;94;147;94;96;95;139;98;94;142 09:07:02 INFO - PROCESS | 29410 | |5;imaging-gaussian-blur;120;118;118;117;118;117;118;118;118;118 09:07:02 INFO - PROCESS | 29410 | |6;imaging-darkroom;147;147;146;147;147;148;147;147;146;148 09:07:02 INFO - PROCESS | 29410 | |7;imaging-desaturate;96;97;95;96;96;95;97;96;96;96 09:07:02 INFO - PROCESS | 29410 | |8;json-parse-financial;65;66;65;67;64;65;70;89;62;63 09:07:02 INFO - PROCESS | 29410 | |9;json-stringify-tinderbox;65;66;65;65;64;65;65;65;66;65 09:07:02 INFO - PROCESS | 29410 | |10;stanford-crypto-aes;85;84;84;84;87;85;86;88;86;85 09:07:02 INFO - PROCESS | 29410 | |11;stanford-crypto-ccm;140;143;142;140;141;152;139;142;179;146 09:07:02 INFO - PROCESS | 29410 | |12;stanford-crypto-pbkdf2;175;176;179;180;179;174;185;170;176;172 09:07:02 INFO - PROCESS | 29410 | |13;stanford-crypto-sha256-iterative;74;73;73;73;73;76;73;78;73;72 09:07:02 INFO - PROCESS | 29410 | __end_tp_report 09:07:02 INFO - PROCESS | 29410 | __start_cc_report 09:07:02 INFO - PROCESS | 29410 | _x_x_mozilla_cycle_collect,888 09:07:02 INFO - PROCESS | 29410 | __end_cc_report 09:07:02 INFO - PROCESS | 29410 | __startTimestamp1460563622382__endTimestamp 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | ------- Summary: start ------- 09:07:02 INFO - PROCESS | 29410 | Number of tests: 14 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.55 (4.0%) stddev-sans-first:4.81 09:07:02 INFO - PROCESS | 29410 | Values: 113.0 108.0 113.0 113.0 113.0 126.0 113.0 114.0 114.0 113.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:162.00 stddev:20.25 (12.5%) stddev-sans-first:21.17 09:07:02 INFO - PROCESS | 29410 | Values: 167.0 135.0 157.0 183.0 134.0 165.0 159.0 144.0 192.0 136.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:2.39 (1.4%) stddev-sans-first:2.50 09:07:02 INFO - PROCESS | 29410 | Values: 164.0 163.0 166.0 167.0 170.0 163.0 162.0 165.0 167.0 165.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#3] audio-fft Cycles:10 Average:91.10 Median:74.00 stddev:35.53 (48.0%) stddev-sans-first:37.14 09:07:02 INFO - PROCESS | 29410 | Values: 74.0 76.0 74.0 158.0 75.0 74.0 73.0 74.0 159.0 74.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.50 stddev:23.07 (24.4%) stddev-sans-first:23.87 09:07:02 INFO - PROCESS | 29410 | Values: 95.0 94.0 147.0 94.0 96.0 95.0 139.0 98.0 94.0 142.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 09:07:02 INFO - PROCESS | 29410 | Values: 120.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:07:02 INFO - PROCESS | 29410 | Values: 147.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 146.0 148.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:07:02 INFO - PROCESS | 29410 | Values: 96.0 97.0 95.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:65.50 stddev:7.83 (12.0%) stddev-sans-first:8.25 09:07:02 INFO - PROCESS | 29410 | Values: 65.0 66.0 65.0 67.0 64.0 65.0 70.0 89.0 62.0 63.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:07:02 INFO - PROCESS | 29410 | Values: 65.0 66.0 65.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:1.35 (1.6%) stddev-sans-first:1.42 09:07:02 INFO - PROCESS | 29410 | Values: 85.0 84.0 84.0 84.0 87.0 85.0 86.0 88.0 86.0 85.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:142.50 stddev:12.07 (8.5%) stddev-sans-first:12.57 09:07:02 INFO - PROCESS | 29410 | Values: 140.0 143.0 142.0 140.0 141.0 152.0 139.0 142.0 179.0 146.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.50 stddev:4.33 (2.4%) stddev-sans-first:4.55 09:07:02 INFO - PROCESS | 29410 | Values: 175.0 176.0 179.0 180.0 179.0 174.0 185.0 170.0 176.0 172.0 09:07:02 INFO - PROCESS | 29410 | 09:07:02 INFO - PROCESS | 29410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:73.00 stddev:1.81 (2.5%) stddev-sans-first:1.92 09:07:02 INFO - PROCESS | 29410 | Values: 74.0 73.0 73.0 73.0 73.0 76.0 73.0 78.0 73.0 72.0 09:07:02 INFO - PROCESS | 29410 | -------- Summary: end -------- 09:07:02 INFO - PROCESS | 29410 | 09:07:03 INFO - TEST-INFO | 29410: exit 0 09:07:03 INFO - TEST-OK | kraken | took 64663ms 09:07:03 INFO - SUITE-END | took 1181s 09:07:03 INFO - Completed test suite (00:19:42) 09:07:03 INFO - javascript benchmark 09:07:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.738526147385, 2681.772049375803, 2706.106984695051, 2713.7693296069833, 2722.142525104592, 4739.739314337714, 4774.498677638846, 4783.784729687164, 4789.137955168068, 4794.113089078514, 4656.883577910554, 4689.7655117244085, 4746.857594272177, 4774.68964517307, 4807.6153907687385, 4317.805698743564, 4334.854681603548, 4367.781610919457, 4415.602595766381, 4452.688311818158, 4389.100234451929, 4408.272635015219, 4422.159789639958, 4426.402435671175, 4488.0, 4210.578942105795, 4234.597713217239, 4289.335153051282, 4363.890902727426, 4424.491183513905, 4309.418228539138, 4315.287977483711, 4319.352097185416, 4341.4790225172865, 4358.455193100863, 4276.935845962313, 4284.057507348379, 4305.268104422255, 4308.095299987007, 4374.825006999717, 4562.224421848294, 4601.0, 4622.8150873965005, 4695.553922377403, 4718.079974404993, 5029.974850125763, 5050.191969284933, 5067.695938243717, 5069.594432445396, 5145.974270128663, 5097.8215762448135, 5109.821156259551, 5113.258577506241, 5114.718690472023, 5127.051495473312, 4628.930566041512, 4716.646251531149, 4747.098051370229, 4790.065937142223, 4792.233242681224, 5169.663971841818, 5172.844814655567, 5177.068127736969, 5201.193814958688, 5244.685318880879, 4903.387076615423, 4945.134601444733, 4947.158982972904, 4959.82640607577, 4964.379452568429, 4971.875703107451, 5018.623603229772, 5023.0, 5120.7951681933055, 5140.1004824155625, 5080.390353157644, 5083.593312534988, 5088.389393272831, 5099.0, 5112.667676601009, 4898.436679781799, 4995.600351971833, 5014.824481143142, 5050.393952725696, 5092.414372347153, 3873.5158105236846, 3894.4547763313158, 3935.153941902505, 3941.6649584785614, 3941.9014524637114, 3429.8628054878022, 3451.516787649731, 3468.393031219577, 3469.340825243196, 3504.3341765064556, 4295.871123866226, 4345.044090300129, 4381.123775244963, 4422.358757980075, 4453.265211240109, 5125.897482050338, 5129.333186685782, 5130.358705161855, 5142.922856157161, 5187.844364669066, 4409.14021765759, 4421.447319085114, 4422.933655995163, 4435.3125265583885, 4451.132029254329, 4440.0, 4482.798274077609, 4537.455505339314, 4540.046590216091, 4542.318652202196, 4839.927401088916, 4855.101806165871, 4859.684120532224, 4885.95114048855, 4894.167991441393, 5081.0, 5088.313077734459, 5122.282880396822, 5133.101707201299, 5149.098907691214, 4698.600618947291, 4773.355596994361, 4818.180909245507, 4842.564169224786, 4844.031193761191, 5014.7994080236385, 5021.397432308147, 5027.069992051483, 5035.59715222774, 5073.670211436245, 5093.23601459784, 5095.770690319018, 5103.004914041726, 5114.71869047206, 5129.102407078672, 4787.8563643090765, 4788.11419887322, 4845.878853028703, 4853.684510506947, 4876.317315575751, 4878.63410244226, 4946.777395017305, 4965.0318187953, 4968.776405061853, 4984.775685094107, 4829.348038014823, 4869.780859861244, 4898.510148985073, 4910.656254062182, 4938.456769755396, 4820.614350851994, 4933.1613625683, 4965.900681986413, 4992.725400102884, 5016.122178618654, 4859.586935110555, 4882.652551682727, 4904.362432883702, 4905.583025442877, 4942.3080768693135], "value": 4633.931312797275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.5823878204332, 575.873307872268, 590.2710152961095, 624.3756243756244, 645.515863102673, 33074.33851322972, 34392.56074392563, 34396.82801585995, 34424.1393965151, 34426.0, 34280.65719342806, 34567.0, 34783.0, 34819.129521761904, 34872.65127348726, 7453.70185192593, 7625.961870190641, 7651.120121186052, 7654.808629784272, 7655.349295309906, 7485.887711684329, 7740.651670674805, 7752.26353496417, 7768.300852923236, 7771.339436147906, 7772.650230739602, 7817.921820781805, 7852.0, 7856.1751016143335, 7857.6856925722905, 7678.654460549261, 7757.612119394036, 7792.376609871197, 7804.882926756103, 7815.0231221097365, 7707.884381734279, 7723.7682869514, 7775.028121484815, 7793.96103019487, 7800.219978002211, 29515.852420737974, 34321.313573728636, 34597.827010864785, 34766.826165869265, 35052.0, 3075.600171977651, 3086.0124760076783, 3312.4700047992446, 3718.535183102112, 3806.410006449005, 27324.726752732615, 27528.174154775388, 27631.0, 28510.42979140426, 28591.714082859322, 3415.214500664861, 3444.896653100411, 3469.2887957968555, 3490.5636795400574, 3549.361114999299, 109998.0, 110884.0, 111674.0, 112474.43762781215, 113321.4333928325, 35530.0, 58503.70748146232, 59318.0, 59426.0, 59434.0, 36424.27151456956, 36864.44703329452, 36911.44632830509, 36927.0, 36992.0, 13322.200667959953, 13489.0, 13694.041417100907, 13694.65763355924, 13737.381817818223, 11008.669739907815, 11143.72140696489, 11144.387058711849, 11184.496697648463, 11212.831807522894, 8334.541600212047, 8378.078411374743, 8378.162183781695, 8380.868582741374, 8498.235158835734, 3332.716719078857, 3338.2322065924973, 3347.7656564040285, 3379.341028499419, 3407.539982102434, 857.4865362634954, 861.573521107056, 912.397817440486, 919.2783664823082, 956.8421210500189, 25871.61192582113, 26026.34934126662, 26727.331816704736, 26861.0, 27011.0, 916.4409710076848, 940.5532372123187, 972.9854052189223, 1057.8201705710048, 1063.9202059845543, 13671.0, 14096.154230746188, 14392.35234414454, 14406.0, 14447.927760361132, 361583.0, 369469.0, 369767.0, 370856.0, 371869.0, 48021.279680804815, 48663.0, 48831.0, 49007.264891026665, 49066.264006039935, 1222.4193508083767, 1251.046692451866, 1252.0922331309728, 1260.3635164241998, 1264.4815625593462, 24746.628800567647, 25739.742602574483, 26388.340291492867, 26521.07176248822, 26752.331191719582, 42470.78764606157, 42976.0, 43020.13959720851, 43252.78373608112, 43276.35085473784, 309227.0, 309297.0, 311445.0, 312523.0, 312799.0, 25897.22308330753, 25925.222243331977, 26364.20907372782, 26524.734752652228, 26528.0, 41769.0, 42453.363199551415, 42475.0, 43397.278274980694, 46846.29730553976, 35286.29427411386, 35363.64636353707, 35474.82262588671, 35553.46669800007, 36118.63881361153, 34397.48403773995, 34830.47754283738, 34860.65139348574, 35064.82467587646, 35324.470132947514, 29090.7090929088, 33465.16337091592, 33918.321633566695, 34733.0, 35098.0, 28690.56964145581, 28927.42145157127, 29516.704832951396, 29772.255693607833, 31144.0, 21912.342629721134, 22402.551948961256, 22449.551008980055, 22517.324480264964, 22547.0], "value": 15882.719655008714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.550441487874, 389.108940526195, 389.8927794856415, 391.9196564704236, 406.09846141565714, 13322.533711320106, 14299.78550321746, 15810.84189158108, 16572.088535130577, 17028.57428564288, 15707.84292157078, 15793.447229346946, 16483.340666373362, 16484.34062637493, 16663.25015374308, 5046.873828154307, 5221.921671174935, 5234.6335756497065, 5252.973735131319, 5273.789048438058, 5081.898362032757, 5175.637705360627, 5222.294990176335, 5371.194320851864, 5384.40771515133, 5257.106291930381, 5361.303030606015, 5364.973175134119, 5374.596905232123, 5398.649087809299, 5522.061249587579, 5546.639468434539, 5566.777328906859, 5567.582431317667, 5572.024895643266, 5200.76596553156, 5350.3312085989255, 5372.247885296062, 5381.515663590296, 5396.622236443451, 11932.940335298268, 12295.385230738428, 20004.299849505343, 20814.0, 20965.371038868707, 1834.5413646588354, 1905.3236101184157, 1940.3402843033437, 2122.777108403611, 2512.371907023244, 8607.784805379853, 8943.731688049369, 9126.863097053549, 9285.675001374988, 9520.619175232983, 1780.7685000949793, 1798.0470350714143, 1884.2274667386305, 1913.1677720191622, 1927.60484100759, 65539.3446065538, 66544.3345566543, 67241.66379168122, 67743.66128169377, 69552.30447695509, 9649.758756031155, 10109.725311804785, 10385.84421233682, 10416.895831041593, 10522.894771052192, 14376.209308488134, 14432.628900254458, 14447.133172009502, 14525.201113938623, 14589.124652520883, 7233.45749068822, 7329.780106596811, 7334.596597187206, 7461.962690186514, 7463.0, 6805.489588280899, 6827.897581536281, 6909.654517274116, 6927.545215504801, 7022.929770702228, 4301.849075462269, 4362.781860906942, 4376.8905777355185, 4395.978020109879, 4418.359337895987, 1848.7689038870142, 1857.7677790276216, 1863.7390765292869, 1886.6226754649126, 1887.1885089411685, 901.2024358442825, 905.7554460295684, 925.4632313258294, 927.1007123090591, 938.6620816506053, 15479.690406192038, 16490.58773530647, 16569.171541422882, 16784.006475758397, 16902.40841570539, 836.9874451883227, 841.1714461255658, 845.3068483843313, 851.3317046118767, 863.7754183912228, 8894.644214231488, 9146.679312152119, 9323.160915517636, 9348.859767103362, 9361.204297634642, 137938.0, 138650.0, 390598.0, 391288.0, 396531.0, 57932.0, 69200.0, 70240.64879675569, 76594.23405765872, 78665.0, 916.2944532709777, 925.2551695884742, 932.1657116880355, 938.4885237545554, 943.6225509796, 14635.724990167197, 15157.848421515644, 15219.239038048274, 15254.313555890234, 15488.612784680474, 33358.33283334368, 33473.0, 34560.65439345675, 34897.30205395827, 34981.65018349886, 45570.08859822851, 46021.53978460172, 47091.29363059488, 47446.28830567475, 47852.28221576749, 5004.049230646166, 7639.923600763921, 7706.113796913427, 7717.151113377412, 7791.610419479117, 6253.3121356651645, 9956.701298961043, 11064.944675276573, 11550.306981581132, 11585.768284634429, 9789.902100979183, 10144.746381340525, 10161.237907156845, 10179.49102544855, 10266.486675666038, 9617.422954622745, 9747.220222382335, 9942.353747006711, 10224.846627300745, 10254.128399086161, 9774.755631108994, 10056.748581285527, 10302.690919272434, 10424.947875260576, 10550.919197518951, 6770.627615481196, 7003.754868579779, 7325.523840950321, 7779.183185765413, 7937.32532734724, 9942.254330925065, 10050.296479246383, 10126.696199114038, 10290.588376464857, 10311.278210525192], "value": 7999.707481578917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.3088663771348, 1502.7971223884774, 1675.103819456591, 1806.4580625812268, 1828.2230052227808, 7112.85774284514, 7739.26476984687, 7742.651580678869, 8060.113387527382, 8072.152423995484, 7846.646900889459, 7874.094479134887, 7900.367970562355, 7941.880871786928, 7966.362690984722, 2251.819854411647, 2281.543691261746, 2285.268714011517, 2301.8043466305385, 2307.792298693117, 2218.134927378324, 2232.6092933736613, 2255.571441426124, 2263.196565219348, 2275.681404603357, 2240.215924426446, 2259.344790010895, 2269.024319542596, 2270.8410411271216, 2295.2081531871477, 2229.687843701883, 2237.3176181264707, 2240.0815665577115, 2242.529068895534, 2242.7645097264876, 2181.094845639058, 2183.2031308572414, 2191.594555007329, 2192.6382146945734, 2195.0, 7939.483933544301, 7960.800979975489, 7994.880076798852, 8074.717384891501, 8112.107668156498, 4743.952560474386, 4816.783244753994, 4849.806007759686, 4887.486813884562, 4895.485973972753, 3044.497657886446, 3057.8929737459302, 3171.270607760228, 3181.284211052518, 3222.436073687119, 1020.3928662445833, 1026.2303272545591, 1029.4852573713144, 1034.8310190597936, 1041.2971244409994, 11153.386563738992, 11234.775304493945, 11257.718557036058, 11262.211645184758, 11278.266912650652, 4225.091605304874, 4316.115196384733, 4457.175422546839, 4465.709728867613, 4512.390827238347, 9450.57472413743, 9452.385594936308, 9458.90541094594, 9502.192313653417, 9547.856782148274, 4840.782164802592, 4863.270509423544, 4872.317875497433, 4877.244027175793, 4884.584810291094, 3768.4724138620613, 4320.697551171451, 4435.6229720473475, 4439.755813430228, 4452.287633978613, 3724.329620668306, 3750.1187221003042, 3826.253880493333, 3849.730518863653, 3856.7107466940092, 1241.422738426636, 1248.5442813373054, 1255.604484587352, 1256.9434375453127, 1275.9043071769654, 763.2024534361606, 845.8350621628723, 876.5222953490363, 880.7754022724164, 932.4312169576552, 5642.746076426571, 5727.570432217601, 5732.283464566929, 5839.649621022752, 5896.233489646319, 942.1567696911226, 959.7072892767633, 975.5756943994169, 978.0659470205936, 1006.4062203300089, 3586.569611646567, 3783.886483405502, 3811.1615444602144, 3815.9427608585893, 3846.000039989623, 9758.609655613838, 9964.05341492557, 10156.136728378024, 10209.0, 10237.692869213786, 10030.64892728751, 10084.49577521121, 10121.139703125316, 10122.139618132542, 10154.949225253975, 7472.626368681653, 7475.36459400957, 7487.812804679927, 7493.288137626917, 7549.131849837229, 5418.756155973069, 5486.149646804752, 5590.2453168821685, 5614.185943038318, 5706.457886500776, 8562.315014798925, 8710.47737135774, 8720.389572729848, 8755.430896991675, 8815.294776417742, 8639.784005399915, 8808.955955220183, 8853.73438796837, 9199.724008279762, 9245.121713437213, 6325.272593651789, 6928.930710692828, 7016.438684905297, 7035.22612512613, 7133.037039999534, 7631.8855217172895, 7686.423518236043, 7708.691652334068, 7741.7677469676, 7755.030621172354, 6927.58434493932, 7177.1746249182015, 7215.71137154529, 7291.30732580404, 7294.234105418855, 7017.859642807218, 7024.262452442625, 7031.261717519586, 7051.365377116084, 7179.9641001796745, 6525.282218956006, 6726.327367263235, 6726.8654626908165, 6728.05807187004, 6751.088603038724, 4822.927656085091, 4907.288443175648, 4945.653804233669, 4966.180580204225, 5002.899942001212, 4838.806447742051, 4912.091263116335, 4927.802887884444, 4930.063287975273, 4953.18272485036], "value": 4339.991983143644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.3530218889238, 319.3660583741273, 321.89055721054854, 326.43852573573446, 328.61880218946027, 5232.241325007881, 5234.895302093956, 5249.973750131248, 5274.0, 5320.707361095138, 5187.325647665808, 5204.609654275925, 5215.765290561924, 5216.765245563949, 5247.737613119348, 3805.467234587153, 3953.545342285631, 4080.3063479208604, 4093.8157782899693, 4113.958860411402, 4078.714489985702, 4088.8568900088503, 4093.079057212118, 4110.856120035799, 4118.382242663594, 4029.9798501007454, 4044.2518134145275, 4044.939325910114, 4060.553339132693, 4078.1232035112444, 3769.2838360711376, 3994.7802870842092, 4000.19996000801, 4055.371417430303, 4065.87802365928, 3516.0682419158943, 3521.630228825962, 3525.3207562252614, 3527.400341941876, 3527.9294414111573, 4924.089043526959, 4958.578520825734, 4967.403911530603, 4976.278439626234, 4982.377202849644, 4375.2124617568825, 4613.515580863995, 4640.373549570832, 4655.883602909955, 4663.370444989917, 5463.453654634544, 5482.396936337, 5483.314585676791, 5496.890062198733, 5497.257870187514, 3824.8852534424013, 3854.113553882623, 3862.4978752761963, 3872.206197729459, 3886.9028274293087, 5554.861128471821, 5728.656280623176, 5747.3677895431465, 5797.652140871562, 5808.2449281593545, 3942.743721658083, 3962.7027972902147, 3984.5816189300285, 3990.4213888985932, 4007.8396864125693, 4001.019750161171, 4009.1781184857036, 4021.055052062763, 4034.11249525104, 4035.233305671913, 4619.745913974763, 4629.51390104041, 4638.582527572535, 4656.348111264426, 4657.74382408964, 5253.343332083489, 5498.697571633518, 5521.282233309644, 5532.225488431623, 5532.6680399176175, 1385.1066062389702, 1393.540131756518, 1394.4770710983382, 1399.9930000349932, 1402.2287741742205, 875.9956200218958, 912.3066469483108, 941.9340646154703, 952.4285428742699, 956.9808603828023, 4803.5916947059195, 4850.151223535938, 4850.1997170466475, 4860.635452341018, 4866.148424025781, 5503.229547863302, 5536.446355364431, 5591.916121258185, 5615.326160860723, 5631.7747290108755, 4633.930491042637, 4741.407324084489, 4783.6651434399955, 4784.186688263004, 4817.0, 2968.3469636679897, 3001.1896787867154, 3015.20097174249, 3016.6078409806587, 3031.575579418883, 5284.154535274338, 5287.814926477555, 5296.549793267538, 5308.018016666929, 5321.281626980308, 5604.346717718283, 5724.742386592613, 5756.683382414008, 5761.761221337432, 5763.596548241583, 5242.9814521409535, 5254.474552544715, 5282.788688452419, 5293.364796224478, 5332.840014799563, 5411.594130440154, 5517.200005999028, 5565.499105080562, 5577.860553486195, 5617.241672374341, 5468.179773033918, 5512.3660779010925, 5517.089680202722, 5517.889642207053, 5530.115181570929, 5264.6314757966575, 5279.366476022902, 5315.069862774077, 5320.255164276927, 5334.706591137525, 3869.7871617061332, 3894.084890050892, 3951.407288906687, 3953.367461206193, 3968.563458019558, 5551.555875529867, 5554.6944918028275, 5560.805371811967, 5584.274044374368, 5594.272744543347, 5368.382635996911, 5380.650257733235, 5395.3525576931015, 5408.648437851527, 5426.7829286829665, 5323.0950738373795, 5345.412004679404, 5378.19327100938, 5395.325584301962, 5440.510354068153, 5324.733763311897, 5351.9464805351445, 5359.088954877758, 5361.5231281878505, 5378.354597448331, 5238.738063096754, 5431.5926305526455, 5575.135853942646, 5577.191307260506, 5595.230360971345, 5458.399576046711, 5459.918101228405, 5460.672359658433, 5468.0, 5482.42434544383], "value": 4106.5737062764265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.4655921821759, 689.6586189836029, 706.0574133531733, 759.1562067957362, 800.6757263308363, 11327.207095503298, 11728.472218750156, 11980.940095299522, 12020.57927972521, 12993.61019169424, 12851.678708032305, 12917.80623290649, 12958.48166073356, 12964.35178241089, 13024.934875325634, 831.0941074229089, 836.5608055770708, 838.8741688746707, 839.3075712537151, 842.9199226073513, 827.3629305434841, 839.9160083991613, 840.1766269056328, 840.5671079394117, 840.6805413942693, 856.1737922904396, 867.3104881619097, 871.1114663043692, 872.0538216035577, 875.4265955798962, 855.2815634866741, 859.1065292096243, 860.7891066688638, 866.0257210638032, 868.8218915122417, 619.4455961914061, 638.5753473939825, 638.7349250061219, 639.4021589813493, 639.808057582728, 13126.081174317802, 13225.0, 13262.73474530504, 13281.468741250339, 13289.401976911062, 11204.887951120547, 11896.0, 11950.462229199708, 12633.557825476157, 12934.741305173939, 10088.445135517544, 10105.191584673208, 10165.847512287322, 10201.642942496977, 10599.947000265027, 3322.7041453833026, 3364.562606861117, 3383.086566626997, 3407.727381809449, 3463.0476618929742, 46244.999999999665, 46374.76812615949, 46506.0, 46556.5344346559, 46797.0, 9688.854667179998, 9768.316217864682, 9785.559649815776, 9814.852777208347, 9919.355241909398, 16784.664306713796, 16795.328186872634, 16952.15239238058, 17289.48131556055, 17319.134043297785, 6964.199117101497, 7030.261822508665, 7119.786406407816, 7188.892166617505, 7337.3029562191505, 3758.8496460141837, 3890.7471014383973, 3892.065904182976, 3906.9218615628097, 3923.8234279457492, 2900.5649152627275, 2984.6716861145255, 2988.9701102989125, 2996.310848504856, 3000.9099727008224, 554.8945700317007, 557.0363271540258, 568.3350479938399, 570.349801226602, 571.2830397850671, 624.6345887655682, 627.2660986645635, 629.4649547884262, 636.9777057803047, 656.5371413153715, 7851.9214807851195, 8113.107558168596, 8117.431779775359, 8216.21945915137, 8226.465279756796, 501.8845665496883, 573.1259828761173, 593.3384276531723, 618.7555915413386, 642.7653906324158, 3933.9803300983313, 4025.75845449274, 4069.8168582413864, 4084.387341898739, 4222.113356195234, 49125.50874491209, 50150.996980060925, 50186.74906625444, 50195.74902125539, 50462.49537504578, 43988.3401748974, 44486.33270500945, 45201.773991129834, 45922.77038614786, 46350.76824615923, 40799.388009179886, 41027.38458923119, 41625.1674966499, 41864.790676046425, 42735.786321068816, 7915.485493442908, 7922.235480311618, 7947.403944704055, 8043.276105150565, 8048.83902321962, 28419.289517762223, 28923.56614650824, 29524.852375737984, 29688.554671680373, 30064.84967575148, 36199.27601448009, 36805.44791828178, 37474.625253747115, 37553.812230939766, 37732.0, 9597.664081757104, 9673.274504412339, 9866.605335786488, 9871.753206169904, 9871.950640246752, 10065.849012264676, 10243.692689219335, 10277.640282590073, 10346.120579750504, 10407.21945854079, 9671.129598336183, 9896.505174741378, 9899.653512127328, 10486.003829636173, 10721.35671859691, 9689.515524223902, 9710.17463515609, 9829.655962041581, 9849.0, 9946.651867184613, 10180.898191017995, 10194.43930583825, 10200.0, 10318.793624127326, 10375.377477351383, 8595.0, 8691.304695624209, 8729.345299102466, 8773.605187766438, 9087.36388452802, 8602.268807151462, 8870.112988701336, 8982.236509896471, 9073.546322683971, 9075.909240907506], "value": 5913.34614749017, "unit": "score"}], "name": "dromaeo_css", "value": 6292.14153480604, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 113.0, 113.0, 126.0, 113.0, 114.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 135.0, 157.0, 183.0, 134.0, 165.0, 159.0, 144.0, 192.0, 136.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 167.0, 170.0, 163.0, 162.0, 165.0, 167.0, 165.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 158.0, 75.0, 74.0, 73.0, 74.0, 159.0, 74.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 147.0, 94.0, 96.0, 95.0, 139.0, 98.0, 94.0, 142.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 64.0, 65.0, 70.0, 89.0, 62.0, 63.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 87.0, 85.0, 86.0, 88.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 142.0, 140.0, 141.0, 152.0, 139.0, 142.0, 179.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 179.0, 180.0, 179.0, 174.0, 185.0, 170.0, 176.0, 172.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 76.0, 73.0, 78.0, 73.0, 72.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1612.8, "alertThreshold": 2.0}]} 09:07:03 INFO - Return code: 0 09:07:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:07:03 ERROR - # TBPL SUCCESS # 09:07:03 INFO - Running post-action listener: _resource_record_post_action 09:07:03 INFO - Running post-run listener: _resource_record_post_run 09:07:04 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519069696; Read time: 12; Write time: 1202628 09:07:04 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 233705472; Read time: 0; Write time: 721096 09:07:04 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285364224; Read time: 12; Write time: 481532 09:07:04 INFO - Running post-run listener: _upload_blobber_files 09:07:04 INFO - Blob upload gear active. 09:07:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:07:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:05 INFO - (blobuploader) - INFO - Done attempting. 09:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:06 INFO - (blobuploader) - INFO - Done attempting. 09:07:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:06 INFO - Return code: 0 09:07:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05bebbfdd0daed8852198ce7d93633a429f3c74d491cd7b990d70163d4a3404d7def11ec8f15ef4d5b604f1e969a061ed764a1634214f9840a0f35eeb2803592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc0e3b9a975d7e6d7db2e5c62dcfc3c5c91a04c2988666dd2af7516be119709d5f4c90b9a4c2a589529ed70c41a9014423803f1b94ae95d6ed9707b87b50da3f"} 09:07:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:06 INFO - Contents: 09:07:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05bebbfdd0daed8852198ce7d93633a429f3c74d491cd7b990d70163d4a3404d7def11ec8f15ef4d5b604f1e969a061ed764a1634214f9840a0f35eeb2803592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc0e3b9a975d7e6d7db2e5c62dcfc3c5c91a04c2988666dd2af7516be119709d5f4c90b9a4c2a589529ed70c41a9014423803f1b94ae95d6ed9707b87b50da3f"} 09:07:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:06 INFO - Copying logs to upload dir... 09:07:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.711967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-13 09:07:06.508508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:06.512456) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 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/05bebbfdd0daed8852198ce7d93633a429f3c74d491cd7b990d70163d4a3404d7def11ec8f15ef4d5b604f1e969a061ed764a1634214f9840a0f35eeb2803592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc0e3b9a975d7e6d7db2e5c62dcfc3c5c91a04c2988666dd2af7516be119709d5f4c90b9a4c2a589529ed70c41a9014423803f1b94ae95d6ed9707b87b50da3f"} 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.011182 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/05bebbfdd0daed8852198ce7d93633a429f3c74d491cd7b990d70163d4a3404d7def11ec8f15ef4d5b604f1e969a061ed764a1634214f9840a0f35eeb2803592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc0e3b9a975d7e6d7db2e5c62dcfc3c5c91a04c2988666dd2af7516be119709d5f4c90b9a4c2a589529ed70c41a9014423803f1b94ae95d6ed9707b87b50da3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:06.537121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:06.537474) ========= 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=745a4373a2a16df560f216e000000264-1460561313.992332-1331379723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:06.623258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:07:06.623646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:07:06.623959) ========= ========= Total master_lag: 0.31 =========