builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1451137049.33 results: success (0) buildid: 20151226040553 builduid: 8a05de8260a945f88717345ddabe6ef4 revision: c39a71cf41460924d2988d2d63be2f5d267db82a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.331345) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.331850) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.332141) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004842 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.382706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.383012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.418247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.418548) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.468796) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.469067) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.469397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.469699) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 05:37:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-26 05:37:29 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.209796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.693090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.693532) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020259 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.744706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:29.745010) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c39a71cf41460924d2988d2d63be2f5d267db82a --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 c39a71cf41460924d2988d2d63be2f5d267db82a --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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 05:37:29,956 truncating revision to first 12 chars 2015-12-26 05:37:29,956 Setting DEBUG logging. 2015-12-26 05:37:29,956 attempt 1/10 2015-12-26 05:37:29,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c39a71cf4146?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 05:37:30,195 unpacking tar archive at: mozilla-central-c39a71cf4146/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:30.302349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:30.302653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:30.316699) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:30.316948) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 05:37:30.317342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-26 05:37:30.317619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:30 INFO - MultiFileLogger online at 20151226 05:37:30 in /builds/slave/test 05:37:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:37:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:30 INFO - {'append_to_log': False, 05:37:30 INFO - 'base_work_dir': '/builds/slave/test', 05:37:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:37:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:30 INFO - 'branch': 'Firefox-Non-PGO', 05:37:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:30 INFO - 'config_files': ('talos/linux_config.py',), 05:37:30 INFO - 'default_actions': ('clobber', 05:37:30 INFO - 'read-buildbot-config', 05:37:30 INFO - 'download-and-extract', 05:37:30 INFO - 'populate-webroot', 05:37:30 INFO - 'create-virtualenv', 05:37:30 INFO - 'install', 05:37:30 INFO - 'run-tests'), 05:37:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:30 INFO - 'download_minidump_stackwalk': True, 05:37:30 INFO - 'download_symbols': 'ondemand', 05:37:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:30 INFO - 'installer_path': 'installer.exe', 05:37:30 INFO - 'log_level': 'info', 05:37:30 INFO - 'log_name': 'talos', 05:37:30 INFO - 'log_to_console': True, 05:37:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:30 INFO - 'opt_config_files': (), 05:37:30 INFO - 'pip_index': False, 05:37:30 INFO - 'sps_profile': False, 05:37:30 INFO - 'sps_profile_interval': 0, 05:37:30 INFO - 'suite': 'dromaeojs-e10s', 05:37:30 INFO - 'system_bits': '64', 05:37:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:30 INFO - 'title': 'talos-linux64-ix-057', 05:37:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:30 INFO - 'use_talos_json': True, 05:37:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:30 INFO - 'work_dir': 'build'} 05:37:30 INFO - ##### 05:37:30 INFO - ##### Running clobber step. 05:37:30 INFO - ##### 05:37:30 INFO - Running pre-action listener: _resource_record_pre_action 05:37:30 INFO - Running main action method: clobber 05:37:30 INFO - rmtree: /builds/slave/test/build 05:37:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:31 INFO - Running post-action listener: _resource_record_post_action 05:37:31 INFO - ##### 05:37:31 INFO - ##### Running read-buildbot-config step. 05:37:31 INFO - ##### 05:37:31 INFO - Running pre-action listener: _resource_record_pre_action 05:37:31 INFO - Running main action method: read_buildbot_config 05:37:31 INFO - Using buildbot properties: 05:37:31 INFO - { 05:37:31 INFO - "project": "", 05:37:31 INFO - "product": "firefox", 05:37:31 INFO - "script_repo_revision": "production", 05:37:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:37:31 INFO - "repository": "", 05:37:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:37:31 INFO - "buildid": "20151226040553", 05:37:31 INFO - "pgo_build": "False", 05:37:31 INFO - "basedir": "/builds/slave/test", 05:37:31 INFO - "buildnumber": 131, 05:37:31 INFO - "slavename": "talos-linux64-ix-057", 05:37:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:37:31 INFO - "platform": "ubuntu64_hw", 05:37:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:37:31 INFO - "branch": "mozilla-central", 05:37:31 INFO - "repo_path": "mozilla-central", 05:37:31 INFO - "revision": "c39a71cf41460924d2988d2d63be2f5d267db82a", 05:37:31 INFO - "stage_platform": "linux64", 05:37:31 INFO - "builduid": "8a05de8260a945f88717345ddabe6ef4", 05:37:31 INFO - "slavebuilddir": "test" 05:37:31 INFO - } 05:37:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:37:31 INFO - Running post-action listener: _resource_record_post_action 05:37:31 INFO - ##### 05:37:31 INFO - ##### Running download-and-extract step. 05:37:31 INFO - ##### 05:37:31 INFO - Running pre-action listener: _resource_record_pre_action 05:37:31 INFO - Running main action method: download_and_extract 05:37:31 INFO - mkdir: /builds/slave/test/build/tests 05:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:31 INFO - https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:37:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/test_packages.json 05:37:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/test_packages.json 05:37:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:37:33 INFO - Downloaded 1302 bytes. 05:37:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:37:33 INFO - Using the following test package requirements: 05:37:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'jsshell-linux-x86_64.zip'], 05:37:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37: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')]} 05:37:33 INFO - https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:34 INFO - Downloaded 21942092 bytes. 05:37:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:37:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:37:35 INFO - Return code: 0 05:37:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:35 INFO - https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:39 INFO - Downloaded 21942092 bytes. 05:37:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:37:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:37:41 INFO - Return code: 0 05:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:41 INFO - https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:37:42 INFO - Downloaded 11132270 bytes. 05:37:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:37:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:37:42 INFO - Return code: 0 05:37: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')]} 05:37:42 INFO - https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:37:44 INFO - Downloaded 53335456 bytes. 05:37:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:44 INFO - mkdir: /builds/slave/test/properties 05:37:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:44 INFO - Contents: 05:37:44 INFO - build_url:https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:44 INFO - Running post-action listener: _resource_record_post_action 05:37:44 INFO - Running post-action listener: set_extra_try_arguments 05:37:44 INFO - ##### 05:37:44 INFO - ##### Running populate-webroot step. 05:37:44 INFO - ##### 05:37:44 INFO - Running pre-action listener: _resource_record_pre_action 05:37:44 INFO - Running main action method: populate_webroot 05:37:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:44 INFO - '--tppagecycles', 05:37:44 INFO - '7'], 05:37:44 INFO - 'tests': ['tsvgm']}}, 05:37:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:37:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'tests': ['damp', 'tps']}, 05:37:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['damp', 'tps']}, 05:37:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:37:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:44 INFO - 'other': {'tests': ['a11yr', 05:37:44 INFO - 'ts_paint', 05:37:44 INFO - 'tpaint', 05:37:44 INFO - 'sessionrestore', 05:37:44 INFO - 'sessionrestore_no_auto_restore']}, 05:37:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['a11yr', 05:37:44 INFO - 'ts_paint', 05:37:44 INFO - 'tpaint', 05:37:44 INFO - 'sessionrestore', 05:37:44 INFO - 'sessionrestore_no_auto_restore']}, 05:37:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['a11yr', 05:37:44 INFO - 'ts_paint', 05:37:44 INFO - 'tpaint', 05:37:44 INFO - 'sessionrestore', 05:37:44 INFO - 'sessionrestore_no_auto_restore']}, 05:37:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['a11yr', 05:37:44 INFO - 'ts_paint', 05:37:44 INFO - 'tpaint', 05:37:44 INFO - 'sessionrestore', 05:37:44 INFO - 'sessionrestore_no_auto_restore']}, 05:37:44 INFO - 'other_l64': {'tests': ['a11yr', 05:37:44 INFO - 'ts_paint', 05:37:44 INFO - 'tpaint', 05:37:44 INFO - 'sessionrestore', 05:37:44 INFO - 'sessionrestore_no_auto_restore']}, 05:37:44 INFO - 'other_nol64': {'tests': ['a11yr', 05:37:44 INFO - 'ts_paint', 05:37:44 INFO - 'tpaint', 05:37:44 INFO - 'sessionrestore', 05:37:44 INFO - 'sessionrestore_no_auto_restore']}, 05:37:44 INFO - 'svgr': {'tests': ['tsvgx', 05:37:44 INFO - 'tsvgr_opacity', 05:37:44 INFO - 'tart', 05:37:44 INFO - 'tscrollx', 05:37:44 INFO - 'cart']}, 05:37:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['tsvgx', 05:37:44 INFO - 'tsvgr_opacity', 05:37:44 INFO - 'tart', 05:37:44 INFO - 'tscrollx', 05:37:44 INFO - 'cart']}, 05:37:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'tests': ['tp5o']}, 05:37:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'talos_options': ['--e10s'], 05:37:44 INFO - 'tests': ['tp5o']}, 05:37:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'talos_options': ['--xperf_path', 05:37:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:44 INFO - 'tests': ['tp5n']}, 05:37:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:44 INFO - 'talos_options': ['--e10s', 05:37:44 INFO - '--xperf_path', 05:37:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:44 INFO - 'tests': ['tp5n']}}, 05:37:44 INFO - 'talos.zip': {'path': '', 05:37:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:44 INFO - Running post-action listener: _resource_record_post_action 05:37:44 INFO - ##### 05:37:44 INFO - ##### Running create-virtualenv step. 05:37:44 INFO - ##### 05:37:44 INFO - Running pre-action listener: _resource_record_pre_action 05:37:44 INFO - Running main action method: create_virtualenv 05:37:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:37:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:44 INFO - Using real prefix '/usr' 05:37:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:47 INFO - Installing pip.................done. 05:37:47 INFO - Return code: 0 05:37:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:47 INFO - Using env: {'DISPLAY': ':0', 05:37:47 INFO - 'HOME': '/home/cltbld', 05:37:47 INFO - 'LANG': 'en_US.UTF-8', 05:37:47 INFO - 'LANGUAGE': 'en_US:en', 05:37:47 INFO - 'LOGNAME': 'cltbld', 05:37:47 INFO - 'MAIL': '/var/mail/cltbld', 05:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:47 INFO - 'MOZ_NO_REMOTE': '1', 05:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:47 INFO - 'NO_EM_RESTART': '1', 05:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:47 INFO - 'PWD': '/builds/slave/test', 05:37:47 INFO - 'SHELL': '/bin/bash', 05:37:47 INFO - 'SHLVL': '1', 05:37:47 INFO - 'TERM': 'linux', 05:37:47 INFO - 'TMOUT': '86400', 05:37:47 INFO - 'USER': 'cltbld', 05:37:47 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:47 INFO - '_': '/tools/buildbot/bin/python'} 05:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:37:47 INFO - Cleaning up... 05:37:47 INFO - Return code: 0 05:37:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:37:47 INFO - Using env: {'DISPLAY': ':0', 05:37:47 INFO - 'HOME': '/home/cltbld', 05:37:47 INFO - 'LANG': 'en_US.UTF-8', 05:37:47 INFO - 'LANGUAGE': 'en_US:en', 05:37:47 INFO - 'LOGNAME': 'cltbld', 05:37:47 INFO - 'MAIL': '/var/mail/cltbld', 05:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:47 INFO - 'MOZ_NO_REMOTE': '1', 05:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:47 INFO - 'NO_EM_RESTART': '1', 05:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:47 INFO - 'PWD': '/builds/slave/test', 05:37:47 INFO - 'SHELL': '/bin/bash', 05:37:47 INFO - 'SHLVL': '1', 05:37:47 INFO - 'TERM': 'linux', 05:37:47 INFO - 'TMOUT': '86400', 05:37:47 INFO - 'USER': 'cltbld', 05:37:47 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:47 INFO - '_': '/tools/buildbot/bin/python'} 05:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:47 INFO - Downloading/unpacking psutil>=0.7.1 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:37:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:49 INFO - Installing collected packages: psutil 05:37:49 INFO - Running setup.py install for psutil 05:37:49 INFO - building 'psutil._psutil_linux' extension 05:37:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:37:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:37:50 INFO - building 'psutil._psutil_posix' extension 05:37:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:37:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:37:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:51 INFO - Successfully installed psutil 05:37:51 INFO - Cleaning up... 05:37:51 INFO - Return code: 0 05:37:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:37:51 INFO - Using env: {'DISPLAY': ':0', 05:37:51 INFO - 'HOME': '/home/cltbld', 05:37:51 INFO - 'LANG': 'en_US.UTF-8', 05:37:51 INFO - 'LANGUAGE': 'en_US:en', 05:37:51 INFO - 'LOGNAME': 'cltbld', 05:37:51 INFO - 'MAIL': '/var/mail/cltbld', 05:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:51 INFO - 'MOZ_NO_REMOTE': '1', 05:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:51 INFO - 'NO_EM_RESTART': '1', 05:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:51 INFO - 'PWD': '/builds/slave/test', 05:37:51 INFO - 'SHELL': '/bin/bash', 05:37:51 INFO - 'SHLVL': '1', 05:37:51 INFO - 'TERM': 'linux', 05:37:51 INFO - 'TMOUT': '86400', 05:37:51 INFO - 'USER': 'cltbld', 05:37:51 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:51 INFO - '_': '/tools/buildbot/bin/python'} 05:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:37:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:37:53 INFO - Installing collected packages: mozsystemmonitor 05:37:53 INFO - Running setup.py install for mozsystemmonitor 05:37:53 INFO - Successfully installed mozsystemmonitor 05:37:53 INFO - Cleaning up... 05:37:53 INFO - Return code: 0 05:37:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:37:53 INFO - Using env: {'DISPLAY': ':0', 05:37:53 INFO - 'HOME': '/home/cltbld', 05:37:53 INFO - 'LANG': 'en_US.UTF-8', 05:37:53 INFO - 'LANGUAGE': 'en_US:en', 05:37:53 INFO - 'LOGNAME': 'cltbld', 05:37:53 INFO - 'MAIL': '/var/mail/cltbld', 05:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:53 INFO - 'MOZ_NO_REMOTE': '1', 05:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:53 INFO - 'NO_EM_RESTART': '1', 05:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:53 INFO - 'PWD': '/builds/slave/test', 05:37:53 INFO - 'SHELL': '/bin/bash', 05:37:53 INFO - 'SHLVL': '1', 05:37:53 INFO - 'TERM': 'linux', 05:37:53 INFO - 'TMOUT': '86400', 05:37:53 INFO - 'USER': 'cltbld', 05:37:53 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:53 INFO - '_': '/tools/buildbot/bin/python'} 05:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - Downloading docopt-0.6.1.tar.gz 05:37:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:55 INFO - Running setup.py install for blobuploader 05:37:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:55 INFO - Running setup.py install for requests 05:37:56 INFO - Running setup.py install for docopt 05:37:56 INFO - Successfully installed blobuploader requests docopt 05:37:56 INFO - Cleaning up... 05:37:56 INFO - Return code: 0 05:37:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:37:56 INFO - Using env: {'DISPLAY': ':0', 05:37:56 INFO - 'HOME': '/home/cltbld', 05:37:56 INFO - 'LANG': 'en_US.UTF-8', 05:37:56 INFO - 'LANGUAGE': 'en_US:en', 05:37:56 INFO - 'LOGNAME': 'cltbld', 05:37:56 INFO - 'MAIL': '/var/mail/cltbld', 05:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:56 INFO - 'MOZ_NO_REMOTE': '1', 05:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:56 INFO - 'NO_EM_RESTART': '1', 05:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:56 INFO - 'PWD': '/builds/slave/test', 05:37:56 INFO - 'SHELL': '/bin/bash', 05:37:56 INFO - 'SHLVL': '1', 05:37:56 INFO - 'TERM': 'linux', 05:37:56 INFO - 'TMOUT': '86400', 05:37:56 INFO - 'USER': 'cltbld', 05:37:56 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:56 INFO - '_': '/tools/buildbot/bin/python'} 05:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:56 INFO - Running setup.py (path:/tmp/pip-iXnEHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:56 INFO - Running setup.py (path:/tmp/pip-rVFHBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:56 INFO - Running setup.py (path:/tmp/pip-Vr2aUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:56 INFO - Running setup.py (path:/tmp/pip-Z04aOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:56 INFO - Running setup.py (path:/tmp/pip-4ecTba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:56 INFO - Running setup.py (path:/tmp/pip-zPSB7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:57 INFO - Running setup.py (path:/tmp/pip-lzQEME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:57 INFO - Running setup.py (path:/tmp/pip-mwXT1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:57 INFO - Running setup.py (path:/tmp/pip-_mrXm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:57 INFO - Running setup.py (path:/tmp/pip-CwCTvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:57 INFO - Running setup.py (path:/tmp/pip-Oii2j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:57 INFO - Running setup.py (path:/tmp/pip-zQONti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:57 INFO - Running setup.py (path:/tmp/pip-yds3xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:57 INFO - Running setup.py (path:/tmp/pip-s4LS3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:57 INFO - Running setup.py (path:/tmp/pip-yHg5Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:57 INFO - Running setup.py (path:/tmp/pip-zfwpMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:57 INFO - Running setup.py (path:/tmp/pip-y3GgUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:57 INFO - Running setup.py install for manifestparser 05:37:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:57 INFO - Running setup.py install for mozcrash 05:37:57 INFO - Running setup.py install for mozdebug 05:37:58 INFO - Running setup.py install for mozdevice 05:37:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Running setup.py install for mozfile 05:37:58 INFO - Running setup.py install for mozhttpd 05:37:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Running setup.py install for mozinfo 05:37:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Running setup.py install for mozInstall 05:37:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Running setup.py install for mozleak 05:37:58 INFO - Running setup.py install for mozlog 05:37:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Running setup.py install for moznetwork 05:37:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:58 INFO - Running setup.py install for mozprocess 05:37:59 INFO - Running setup.py install for mozprofile 05:37:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:59 INFO - Running setup.py install for mozrunner 05:37:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:59 INFO - Running setup.py install for mozscreenshot 05:37:59 INFO - Running setup.py install for moztest 05:37:59 INFO - Running setup.py install for mozversion 05:37:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:59 INFO - Cleaning up... 05:37:59 INFO - Return code: 0 05:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:37:59 INFO - Using env: {'DISPLAY': ':0', 05:37:59 INFO - 'HOME': '/home/cltbld', 05:37:59 INFO - 'LANG': 'en_US.UTF-8', 05:37:59 INFO - 'LANGUAGE': 'en_US:en', 05:37:59 INFO - 'LOGNAME': 'cltbld', 05:37:59 INFO - 'MAIL': '/var/mail/cltbld', 05:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:59 INFO - 'MOZ_NO_REMOTE': '1', 05:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:59 INFO - 'NO_EM_RESTART': '1', 05:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:59 INFO - 'PWD': '/builds/slave/test', 05:37:59 INFO - 'SHELL': '/bin/bash', 05:37:59 INFO - 'SHLVL': '1', 05:37:59 INFO - 'TERM': 'linux', 05:37:59 INFO - 'TMOUT': '86400', 05:37:59 INFO - 'USER': 'cltbld', 05:37:59 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:59 INFO - '_': '/tools/buildbot/bin/python'} 05:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:59 INFO - Running setup.py (path:/tmp/pip-2s5f8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:59 INFO - Running setup.py (path:/tmp/pip-8WMwb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:59 INFO - Running setup.py (path:/tmp/pip-3CYPFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:00 INFO - Running setup.py (path:/tmp/pip-Y_gJIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:00 INFO - Running setup.py (path:/tmp/pip-A2eccW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:00 INFO - Running setup.py (path:/tmp/pip-Bwq_wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:00 INFO - Running setup.py (path:/tmp/pip-euomoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:00 INFO - Running setup.py (path:/tmp/pip-lpJLcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:00 INFO - Running setup.py (path:/tmp/pip-ZxqMbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:00 INFO - Running setup.py (path:/tmp/pip-RlwrUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:00 INFO - Running setup.py (path:/tmp/pip-eQZGer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:00 INFO - Running setup.py (path:/tmp/pip-5w7yUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:00 INFO - Running setup.py (path:/tmp/pip-R7KAxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:00 INFO - Running setup.py (path:/tmp/pip-2gPh8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:00 INFO - Running setup.py (path:/tmp/pip-GsrAO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:00 INFO - Running setup.py (path:/tmp/pip-3JZ2jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:00 INFO - Running setup.py (path:/tmp/pip-WznUbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:01 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:01 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:02 INFO - Downloading blessings-1.5.1.tar.gz 05:38:02 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:02 INFO - Installing collected packages: blessings 05:38:02 INFO - Running setup.py install for blessings 05:38:02 INFO - Successfully installed blessings 05:38:02 INFO - Cleaning up... 05:38:02 INFO - Return code: 0 05:38:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:03 INFO - Reading from file tmpfile_stdout 05:38:03 INFO - Current package versions: 05:38:03 INFO - argparse == 1.2.1 05:38:03 INFO - blessings == 1.5.1 05:38:03 INFO - blobuploader == 1.2.4 05:38:03 INFO - docopt == 0.6.1 05:38:03 INFO - manifestparser == 1.1 05:38:03 INFO - mozInstall == 1.12 05:38:03 INFO - mozcrash == 0.16 05:38:03 INFO - mozdebug == 0.1 05:38:03 INFO - mozdevice == 0.47 05:38:03 INFO - mozfile == 1.2 05:38:03 INFO - mozhttpd == 0.7 05:38:03 INFO - mozinfo == 0.9 05:38:03 INFO - mozleak == 0.1 05:38:03 INFO - mozlog == 3.1 05:38:03 INFO - moznetwork == 0.27 05:38:03 INFO - mozprocess == 0.22 05:38:03 INFO - mozprofile == 0.28 05:38:03 INFO - mozrunner == 6.11 05:38:03 INFO - mozscreenshot == 0.1 05:38:03 INFO - mozsystemmonitor == 0.0 05:38:03 INFO - moztest == 0.7 05:38:03 INFO - mozversion == 1.4 05:38:03 INFO - psutil == 3.1.1 05:38:03 INFO - requests == 1.2.3 05:38:03 INFO - wsgiref == 0.1.2 05:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:03 INFO - Using env: {'DISPLAY': ':0', 05:38:03 INFO - 'HOME': '/home/cltbld', 05:38:03 INFO - 'LANG': 'en_US.UTF-8', 05:38:03 INFO - 'LANGUAGE': 'en_US:en', 05:38:03 INFO - 'LOGNAME': 'cltbld', 05:38:03 INFO - 'MAIL': '/var/mail/cltbld', 05:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:03 INFO - 'MOZ_NO_REMOTE': '1', 05:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:03 INFO - 'NO_EM_RESTART': '1', 05:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:03 INFO - 'PWD': '/builds/slave/test', 05:38:03 INFO - 'SHELL': '/bin/bash', 05:38:03 INFO - 'SHLVL': '1', 05:38:03 INFO - 'TERM': 'linux', 05:38:03 INFO - 'TMOUT': '86400', 05:38:03 INFO - 'USER': 'cltbld', 05:38:03 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:03 INFO - '_': '/tools/buildbot/bin/python'} 05:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:03 INFO - Cleaning up... 05:38:03 INFO - Return code: 0 05:38:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:38:03 INFO - Using env: {'DISPLAY': ':0', 05:38:03 INFO - 'HOME': '/home/cltbld', 05:38:03 INFO - 'LANG': 'en_US.UTF-8', 05:38:03 INFO - 'LANGUAGE': 'en_US:en', 05:38:03 INFO - 'LOGNAME': 'cltbld', 05:38:03 INFO - 'MAIL': '/var/mail/cltbld', 05:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:03 INFO - 'MOZ_NO_REMOTE': '1', 05:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:03 INFO - 'NO_EM_RESTART': '1', 05:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:03 INFO - 'PWD': '/builds/slave/test', 05:38:03 INFO - 'SHELL': '/bin/bash', 05:38:03 INFO - 'SHLVL': '1', 05:38:03 INFO - 'TERM': 'linux', 05:38:03 INFO - 'TMOUT': '86400', 05:38:03 INFO - 'USER': 'cltbld', 05:38:03 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:03 INFO - '_': '/tools/buildbot/bin/python'} 05:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:03 INFO - Downloading/unpacking jsonschema 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:38:05 INFO - Downloading/unpacking functools32 (from jsonschema) 05:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:05 INFO - warning: no files found matching '*.txt' 05:38:05 INFO - no previously-included directories found matching 'build' 05:38:05 INFO - no previously-included directories found matching 'dist' 05:38:05 INFO - no previously-included directories found matching '.git*' 05:38:05 INFO - Installing collected packages: jsonschema, functools32 05:38:05 INFO - Running setup.py install for functools32 05:38:05 INFO - warning: no files found matching '*.txt' 05:38:05 INFO - no previously-included directories found matching 'build' 05:38:05 INFO - no previously-included directories found matching 'dist' 05:38:05 INFO - no previously-included directories found matching '.git*' 05:38:05 INFO - Successfully installed jsonschema functools32 05:38:05 INFO - Cleaning up... 05:38:05 INFO - Return code: 0 05:38:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fbafd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:38:05 INFO - Using env: {'DISPLAY': ':0', 05:38:05 INFO - 'HOME': '/home/cltbld', 05:38:05 INFO - 'LANG': 'en_US.UTF-8', 05:38:05 INFO - 'LANGUAGE': 'en_US:en', 05:38:05 INFO - 'LOGNAME': 'cltbld', 05:38:05 INFO - 'MAIL': '/var/mail/cltbld', 05:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:05 INFO - 'MOZ_NO_REMOTE': '1', 05:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:05 INFO - 'NO_EM_RESTART': '1', 05:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:05 INFO - 'PWD': '/builds/slave/test', 05:38:05 INFO - 'SHELL': '/bin/bash', 05:38:05 INFO - 'SHLVL': '1', 05:38:05 INFO - 'TERM': 'linux', 05:38:05 INFO - 'TMOUT': '86400', 05:38:05 INFO - 'USER': 'cltbld', 05:38:05 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:05 INFO - '_': '/tools/buildbot/bin/python'} 05:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:05 INFO - Downloading/unpacking flake8 05:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:38:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:38:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:38:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:08 INFO - no previously-included directories found matching 'docs/_build' 05:38:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:08 INFO - Running setup.py install for pep8 05:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:08 INFO - no previously-included directories found matching 'docs/_build' 05:38:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:38:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:08 INFO - Cleaning up... 05:38:08 INFO - Return code: 0 05:38:08 INFO - Running post-action listener: _resource_record_post_action 05:38:08 INFO - Running post-action listener: _start_resource_monitoring 05:38:08 INFO - Starting resource monitoring. 05:38:08 INFO - ##### 05:38:08 INFO - ##### Running install step. 05:38:08 INFO - ##### 05:38:08 INFO - Running pre-action listener: _resource_record_pre_action 05:38:08 INFO - Running main action method: install 05:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:08 INFO - Reading from file tmpfile_stdout 05:38:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:08 INFO - Reading from file tmpfile_stdout 05:38:08 INFO - Output received: 05:38:08 INFO - Usage: mozinstall [options] installer 05:38:08 INFO - Options: 05:38:08 INFO - -h, --help show this help message and exit 05:38:08 INFO - -d DEST, --destination=DEST 05:38:08 INFO - Directory to install application into. [default: 05:38:08 INFO - "/builds/slave/test"] 05:38:08 INFO - --app=APP Application being installed. [default: firefox] 05:38:08 INFO - mkdir: /builds/slave/test/build/application 05:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:38:24 INFO - Reading from file tmpfile_stdout 05:38:24 INFO - Output received: 05:38:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:38:24 INFO - Running post-action listener: _resource_record_post_action 05:38:24 INFO - ##### 05:38:24 INFO - ##### Running run-tests step. 05:38:24 INFO - ##### 05:38:24 INFO - Running pre-action listener: _resource_record_pre_action 05:38:24 INFO - Running main action method: run_tests 05:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:24 INFO - Python 2.7.3 05:38:24 INFO - Return code: 0 05:38:24 INFO - grabbing minidump binary from tooltool 05:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:24 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 0xf883d0>, '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 0xef3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef4360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:38:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:38:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:24 INFO - Return code: 0 05:38:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:38:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:38:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:38:25 INFO - Return code: 0 05:38:25 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/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 05:38:25 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/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 05:38:25 INFO - Using env: {'DISPLAY': ':0', 05:38:25 INFO - 'HOME': '/home/cltbld', 05:38:25 INFO - 'LANG': 'en_US.UTF-8', 05:38:25 INFO - 'LANGUAGE': 'en_US:en', 05:38:25 INFO - 'LOGNAME': 'cltbld', 05:38:25 INFO - 'MAIL': '/var/mail/cltbld', 05:38:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:25 INFO - 'MOZ_NO_REMOTE': '1', 05:38:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:25 INFO - 'NO_EM_RESTART': '1', 05:38:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:25 INFO - 'PWD': '/builds/slave/test', 05:38:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:25 INFO - 'SHELL': '/bin/bash', 05:38:25 INFO - 'SHLVL': '1', 05:38:25 INFO - 'TERM': 'linux', 05:38:25 INFO - 'TMOUT': '86400', 05:38:25 INFO - 'USER': 'cltbld', 05:38:25 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188', 05:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:25 INFO - '_': '/tools/buildbot/bin/python'} 05:38:25 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/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 05:38:25 INFO - mozversion application_buildid: 20151226040553 05:38:25 INFO - mozversion application_changeset: c39a71cf41460924d2988d2d63be2f5d267db82a 05:38:25 INFO - mozversion application_display_name: Nightly 05:38:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:25 INFO - mozversion application_name: Firefox 05:38:25 INFO - mozversion application_remotingname: firefox 05:38:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:38:25 INFO - mozversion application_vendor: Mozilla 05:38:25 INFO - mozversion application_version: 46.0a1 05:38:25 INFO - mozversion platform_buildid: 20151226040553 05:38:25 INFO - mozversion platform_changeset: c39a71cf41460924d2988d2d63be2f5d267db82a 05:38:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:38:25 INFO - mozversion platform_version: 46.0a1 05:38:25 INFO - using testdate: 1451137105 05:38:25 INFO - actual date: 1451137105 05:38:25 INFO - starting webserver on 'localhost:41979' 05:38:25 INFO - SUITE-START | Running 3 tests 05:38:25 INFO - TEST-START | dromaeo_css 05:38:25 INFO - operating with platform_type : linux_ 05:38:25 INFO - Initialising browser for dromaeo_css test... 05:38:25 INFO - TEST-INFO | started process 3388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GVQBm/profile http://localhost:41979/getInfo.html) 05:38:32 INFO - PROCESS | 3388 | __metrics Screen width/height:1600/1200 05:38:32 INFO - PROCESS | 3388 | colorDepth:24 05:38:32 INFO - PROCESS | 3388 | Browser inner width/height: 1024/697 05:38:32 INFO - PROCESS | 3388 | __metrics 05:38:33 INFO - PROCESS | 3388 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:38:34 INFO - TEST-INFO | 3388: exit 0 05:38:34 INFO - Browser initialized. 05:38:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:34 INFO - TEST-INFO | started process 3520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GVQBm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:46 INFO - PROCESS | 3520 | RSS: Main: 149032960 05:38:46 INFO - PROCESS | 3520 | 05:39:36 INFO - PROCESS | 3520 | 1451137176219 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:41:47 INFO - PROCESS | 3520 | Cycle 1(1): loaded http://localhost:41979/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41979/tests/dromaeo/cssquery-ext.html) 05:41:48 INFO - PROCESS | 3520 | RSS: Main: 153341952 05:41:48 INFO - PROCESS | 3520 | 05:44:50 INFO - PROCESS | 3520 | Cycle 1(1): loaded http://localhost:41979/tests/dromaeo/cssquery-ext.html (next: http://localhost:41979/tests/dromaeo/cssquery-jquery.html) 05:44:51 INFO - PROCESS | 3520 | RSS: Main: 151838720 05:44:51 INFO - PROCESS | 3520 | 05:47:53 INFO - PROCESS | 3520 | Cycle 1(1): loaded http://localhost:41979/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41979/tests/dromaeo/cssquery-mootools.html) 05:47:53 INFO - PROCESS | 3520 | RSS: Main: 154689536 05:47:53 INFO - PROCESS | 3520 | 05:50:55 INFO - PROCESS | 3520 | Cycle 1(1): loaded http://localhost:41979/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41979/tests/dromaeo/cssquery-prototype.html) 05:50:56 INFO - PROCESS | 3520 | RSS: Main: 151040000 05:50:56 INFO - PROCESS | 3520 | 05:53:58 INFO - PROCESS | 3520 | Cycle 1(1): loaded http://localhost:41979/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41979/tests/dromaeo/cssquery-yui.html) 05:53:59 INFO - PROCESS | 3520 | RSS: Main: 153092096 05:53:59 INFO - PROCESS | 3520 | 05:57:01 INFO - PROCESS | 3520 | Cycle 1(1): loaded http://localhost:41979/tests/dromaeo/cssquery-yui.html (next: http://localhost:41979/tests/dromaeo/cssquery-dojo.html) 05:57:02 INFO - PROCESS | 3520 | RSS: Main: 154402816 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | __start_tp_report 05:57:02 INFO - PROCESS | 3520 | _x_x_mozilla_page_load 05:57:02 INFO - PROCESS | 3520 | _x_x_mozilla_page_load_details 05:57:02 INFO - PROCESS | 3520 | |i|pagename|runs| 05:57:02 INFO - PROCESS | 3520 | |0;dojo.html;2570.447353818929;2649.403884126071;2679.571268597024;2690.0315886280937;2694.6496955395783;4471.843485478009;4600.79296431661;4616.146012987591;4635.490096089427;4640.605548528375;4578.839740609079;4607.539246075391;4615.423072115986;4714.740689262089;4726.149293127236;4255.787210639463;4317.2228998780365;4368.650507959372;4389.209942210401;4432.290833466646;4305.50486694031;4343.2182207202695;4378.8029538670835;4439.422875026242;4447.599716025557;4154.273002224629;4246.7027308088445;4249.702520823544;4273.444452221207;4291.549387314319;4281.229378711831;4318.69769116162;4340.023494713696;4346.587074227943;4351.608355248043;4290.592393722592;4297.634701050414;4297.828086876521;4304.096139810644;4348.130373925228;4305.418768466248;4394.824207031715;4513.909721805579;4580.610648094883;4636.5131661175765;4969.229769385751;4975.402951645826;4985.551300382983;4996.684498910631;5016.698998060128;4995.900081998339;4996.050750357421;5009.373828271466;5016.347874776256;5061.367329083864;4451.1097780443715;4566.908661826745;4575.862724118315;4640.582347588733;4754.5245475452175;5100.209467532539;5106.106431374495;5112.565431938253;5113.718745469035;5169.948300517022;4908.460069392364;4911.386076740408;4912.852614421573;4917.188663870421;4960.627952903546;4733.502982186889;4848.903021939612;4911.386076740408;4981.775820088104;5036.219385995177;4898.24077268024;4905.23968784839;4920.778564964585;4926.187179115477;4965.428975667773;4656.604188643935;4848.248521479177;4868.14807408702;4896.167651499253;4908.141075311806;3993.900152496211;4106.240345536025;4139.834406623701;4155.729877557949;4199.97900010498;3647.0882279430143;3670.6145854685406;3677.9632203678157;3694.833732481991;3699;4171.374293855885;4277.871663850089;4291.399204111427;4334.263175260214;4344.587264209895;4843.975780121077;4871.853844384674;4884.267359895973;4900.828471003498;4958.057968985953;4274.153262064167;4308.612224899774;4312.568743125662;4317.136572685476;4336.176126536011;4220.556841531657;4395.384646149478;4415.1611193873705;4456;4463.553644635511;4545.272756358901;4579.015511665008;4580.519045500241;4585.908281834411;4660.510646382081;5022.347094877642;5032.949670503248;5033.899322013466;5037.370328708911;5066.797328106834;4752.239641657318;4758.500357462555;4761.928571071506;4766.428028636586;4790.7365094920115;4722.740249286322;4846.103470857903;4875.9512404875495;4908.312836203006;4986.775595098156;5001.049800537886;5013.348264725562;5022.899542009066;5024.196128619404;5046.495350464924;4861.562459378673;4865.464798872051;4865.659403841839;4867.075255701406;4907.312976183266;4609.953900460952;4711.128441238382;4766.976165119291;4849.442314133919;4908.895498512806;4662.696924699883;4694.64790140734;4699.694519856198;4714.38712967312;4734.384530011076;4843.95156048435;4844.8304309350415;4847.321375007431;4848.684835485682;4890.975545122252;4506.391637128946;4645.907081858276;4685.906281874275;4773.64197685182;4782.378290822171 05:57:02 INFO - PROCESS | 3520 | |1;ext.html;533.2321457101773;543.6765124750773;551.8261747549521;566.3798141035564;582.4583137681957;31678.524822127656;32326.515102273454;32335.029949101536;32362;32379.67620323796;34359.65640343596;34840.65159348406;34978.3004339913;34986.475202871974;35080.47379289313;7529.472936894406;7635.465517413783;7676.270754278335;7683.692652293901;7690.15408305086;7497.550146991198;7565.13001004886;7604.771856844276;7608.087029556461;7618.695252189934;7613.352865006481;7633.389328853678;7643.273888980566;7650.579218143;7651.464397492177;7802.76591702247;7894.6447409866405;7909.644066017015;7912.80217994549;7925.524468531907;7657.195994420617;7767.572783496906;7785.688572457095;7793.376529877596;7797.025371828521;34893.651063489546;35211.4718279226;35260.294794103975;35365;35370;2717.3342531079816;2727.4136060746837;2762.5165596020615;2769.3353595137223;2907.345847184388;26977.73022269772;27211.45577088467;27392.315192120157;27538.17385478439;27839.443211135866;3324.4514655081884;3324.6841550052704;3333.4999750037446;3382.763206575516;3423.4351332030187;203261;203449.98275008678;204056;204155;204224.74651520955;43814.56185438169;44635.33047004297;50603.74698126559;52805.7359713199;54038;52385;52507;52840.471595283554;52960;52970;12262.754744905053;12423.689407764698;12443.626691199279;12449.875501245053;12452.501899924082;9243.630254789867;9280;9290.303227257982;9309.72070837876;9399.295052871063;17854.642907141784;17926.91036544809;18177.09114544294;18183.818161818213;18220.90889545544;7041.894371584431;7337.74317898871;7379.631018449056;7410.444216683771;7471.813204669818;771.2711487644123;836.7782537627534;850.2900078434576;851.4848516647339;864.5245115186622;23441.41396465102;25966.35084122874;26897.596536051973;27249.455010900067;28281.744435005952;911.5578944212052;944.6221511395497;945.1824172091092;974.9567962280292;976.1507488485064;12920.353982300847;13052.54316098951;13069.542566010145;13148.013898957617;13191.472341106248;263235;267563;268831;269030;269667;42873;43096;43145;43149.78425107854;43153;1158.8261760735788;1162.6744511536783;1173.2491205628405;1187.1571184458958;1199.8080307150815;24962.251132466055;25471.490570188864;25559.872200638878;25718.742812571636;25721.485570288864;38783.806080969414;39144.217115658095;39216.64700118002;39219.607803922736;39407.60592394039;251935;253281;253443;253819;253951;27481.31296717598;28130.2967425816;28541.571876421454;28687;28744.425111498073;32802.17994550155;32819.17952051122;33289.83355083209;33762.662373375955;33767.32465350728;30479.84760076274;30812;31313.217169570944;31939.201519962186;32156.67843321537;30485.847570762005;30674.539881901343;30680.693193068677;30697.079087627408;30874;27400.725992740616;27869.58195627108;27964.860175698992;28048.85975570109;28086;26079.478410431304;27032.425395752864;28203.858980704965;28435.431291373643;28606.42787144287;22651.660225096966;22926.19758308451;23108.191213307455;23284.417889552897;23653.881730591926 05:57:02 INFO - PROCESS | 3520 | |2;jquery.html;329.8565124170985;330.7056719519627;331.1357357297455;331.46302989157556;332.09007319943333;14944.103353798766;15398.153101579423;15955.68088638228;16717.66564668706;17393.304267829302;10559.155267578595;10560.0495955364;10591.25861189717;12206.206596571239;15993.120378379184;4378.430803995476;4408.757518336491;4499.1901457737595;4508.120916421282;4536.455625324949;4468.776561171945;4475.418195634579;4476.910461790762;4478.193925093482;4482.932756008662;4462.330650402433;4477.820887164526;4951.8514444566545;5104.64267501275;5123.871903202431;5044.192929131358;5072.213806859906;5073.213651883964;5110.105731496992;5112;5086.338775959101;5132.820351287724;5141.460146684619;5149.407818100929;5150.098732721759;11390.886091139066;11570.479328430241;14426.711465770732;18316.450506484827;18435.72346414805;1673.8075121361078;1693.6612677464434;1755.4207111653125;1769.6549172911286;1870;9044.276457883354;9613.471259080748;11553.884461155365;12567.937160314232;13000.934995325057;1670.2400407814416;1707.0611163859828;1761.462753860072;1767;1822.8541716662635;56239;56967.43032569663;57206;57322.42677573213;57852.71073644647;9462.810743785085;9516.143547080796;9572.9042709572;9635.22918166545;9707.514624268899;12228.694282643006;12231.082668799698;12235.816462753066;12256.264624122581;12264.570740024057;6734.46124310054;6755.121834161528;6757.222919364336;6782.966085169543;6843;6325.367463253638;6400.935990640127;6438.163038804925;6466.450351720063;6476.676166191672;4088.570700076449;4128.380742888591;4152.5432202457705;4161.750294982311;4176.206520761046;1672.5985763416936;1688.577855536116;1703.923323450423;1719.4841547535689;1722.113111747451;365.6398447529182;378.18501130064203;383.25456986161646;385.35837830013276;389.9239648268617;9584.808303833885;9845.753856153653;9974.950125249326;10003.749906252402;10131.594736210616;391.18242872396826;392.33695055356355;395.41873446034856;396.49842948669954;418.053109706515;5447.4552544746;5486.972565137149;5576.302962129734;5576.414476479992;5592.161175823578;470568;474634;479086;485423;532597;71220.28779712241;73342.63328683322;74113.62943185249;75229;76211;1024.6874703215442;1059.7191744187796;1069.25152393325;1071.6570697376922;1078.1698092468598;13478.393472293574;13807.102538334975;14125.717485650435;14308;14345.713085738436;19810.50473738168;32655.836720816245;32747.181320466225;33116.33767324688;34397.968060958214;41711.79144104382;42296.788516057226;42425.1514969705;42903.02439999026;44357.33463997978;8725.127487251224;8906.554672266491;8993.055729148346;9188.310876684409;9285.6285748572;16113.436029738903;16183.514494565183;16415.26131324117;16492.25784839661;16590.83409165893;10749.301295415773;13205.075644705163;13523.932380338036;13551.72896542044;13999.44002239899;12355.135140540076;12528.310942897864;12825.615231543068;12886.806697899352;12992.415341309852;12880.35598220104;12902;13041.804372934603;13669.111507751964;13738.86261137376;8165.755027349189;8532.957335213285;8599.828003440021;8660.263877570225;8677.349198809989;8818.29453643694;10174.694759157237;13229;13343.466261349826;13419.932900335436 05:57:02 INFO - PROCESS | 3520 | |3;mootools.html;1342.1410297409657;1369.301656155361;1472.9926350368246;1664.5172899859042;1685.7639930409737;5901.675407852566;5976.19321391612;6894.000369946355;7038.049863268458;7049.682764275607;6713.362230588098;6779.220389655191;6864.450843932486;6907.68915398807;6947.096877405943;2063.226290141201;2115.7778433264516;2117.491801967532;2117.692934524493;2121.7029615853794;2114.7356580427445;2116.6719158530454;2119.2900378373265;2136.3697709175754;2147.45239963809;2029.6245194638966;2055.1595662547334;2055.54777948851;2063.1850419084453;2064.225915281769;2122.129926730041;2152.698622192902;2155.795199456049;2159.157928407922;2160.503084290614;2125.128697234127;2163.9783602164093;2168.7072245246845;2175.1082056356818;2175.445261458334;7151.713931442736;7200.171980222289;7256.854862902713;7275.017872587186;7296.197418283985;4220.240356735786;4275.3800698898485;4292.1630282095;4294.613484786384;4297.5702429756775;2234.8547344422723;2289.290320000805;2658.162678756205;2733.084416720401;2739.2740923655247;752.879539273719;793.9364850811921;798.9680412783482;1595.8324375940592;1628.991855040729;9271.953640231823;9331.580078896466;9366.20387267083;9409.529523523797;9421.858672119992;3775.716821238363;3791.829367678461;3817.828197731053;3877;3913.92172156561;7663.19536448676;7666.8849967250535;7708.730194443167;7715.768526944201;7746;3988.12261302513;4060.2082593893906;4061.2892743770312;4075.5313138988804;4080.653144482693;3688;3709.9814500927323;3723.162288485069;3734.738568300193;3747.793871337048;3147.464930961742;3154.2587491939375;3186.1078897908624;3191.138392633976;3196.328770958078;933.8599210118537;938.8737493286595;945.2107490245585;949.5157469690507;950.4154944708954;873.7073080517971;887.8046829697456;892.3931726426092;892.9508877011697;894.7136916186888;6661.966690166518;6789.796306110726;6791.151106111736;6793.184817821794;6806.217285012287;924.4083786376724;930.6696122876417;1031.852848811138;1033.4006276359694;1047.0942634621;5264.789408423697;5289.047971365191;5387.353517577916;5388.568914486832;5390.029794637003;7050.471214658921;7279.417646588367;8219.630116644765;8351.540665263468;8463.49219046859;8224.342052635775;8259.380546458919;8283.544405057779;8327.625256863455;8355.415120941476;6493.70778314977;6594.505412094016;6646.268910419946;6694.698738556776;6751.291114433012;6600.075989361397;6640.103586015826;6644.767433139817;6650.235222949423;6677.399034086956;7410.11078670563;7486.101667799681;7852.882206767017;7944.960275198587;7963.243491868263;7819.726309579138;7965.800854978672;8032.799180020546;8053.395995300259;8094.757157285291;6038.5169186465855;6091.659834836329;6167.259928808572;6170.259568851767;6192.349803270592;6776.392053403536;6805.319468053155;6831.795046148623;6871.244163141951;6881.724731010703;6307.117003619405;6324.177856878577;6341;6400.903986440114;6457.515686323451;6285.622862628257;6400.487960963019;6446.9032964506505;6475.384838440341;6496.350364963466;6184.5980011299125;6245.437910588069;6245.469135123565;6246.219222597176;6259.874802504016;5912;5913.2608423947;5914.467697907037;5920.223932820223;5962.701864906824;6047.365026672136;6049.848753781191;6137.324894261538;6140.754369825336;6147.815565533041 05:57:02 INFO - PROCESS | 3520 | |4;prototype.html;296.173675445507;302.2654948475206;305.77525518743727;306.75306378365406;307.58476057322605;5536.307961504812;5544.6673199608;5657.632253903504;5667.773289068432;5668.57485688574;5546.528545073674;5547.25112109865;5549.223108764766;5554.666719996803;5565.777368905239;4144.564820693829;4280.892977675568;4286.185624731306;4313.698041137121;4315.654747620199;4219.957800422003;4237.322028475444;4239.597238262376;4243.448351714273;4247.596478334569;4175.0397408596045;4181.874543763692;4183.937240941388;4184;4187.225363307783;4186.853460128896;4196.643285320752;4237.7669228192435;4242.130363275521;4243.618074373321;3668.211334563082;3673.8714145004797;3675.4119340905327;3681.245344704329;3685.00504863688;5281.498257665516;5425;5432.158015507603;5432.565394768409;5439.809606663787;4869.586085182764;4875.024995001014;4876.853694389174;4880.853574392774;4883;5841.620294680833;5856.882862342729;5903.055511118243;5904;5917.408259174092;3981.880543583697;3985.342418500944;3988.561258261589;3992.2215168042244;3999.0402303447254;5960.105984102376;6096.634201947897;6103.450689437972;6166.321704612489;6180.783672571439;4056.716029877939;4088.814243869245;4088.8773336799945;4093.5497095319492;4095.5085389752826;4155.293600087993;4155.542890282127;4157.3140431829015;4157.854475093357;4158.106007208465;4816.036792641486;4825.734584597881;4828.830990915301;4837;4837.105135549864;5714.771409143671;5816.069428891357;5855.912161317584;5866.73599688015;5888.205092312569;1450.361840790049;1459.8613131752466;1462.656275775192;1464.0044769556591;1470.0958910270108;965.9806803863884;967.6564819489121;972.1299437003984;986.5264672956878;987.1609132237684;5120.92318615221;5131.846044618667;5137.948620513822;5140.948590514122;5145.4597267287145;6017.796440711875;6105.267367915879;6122.602030868068;6195.81412557624;6201.565890387629;5126.53861152498;5148.485151484896;5172.379314482287;5174.456682048406;5177.042247184283;3301.125201821519;3324.351751408452;3324.484704870749;3325.534425180477;3331.0506505645776;5671.829845104653;5756.251687280626;5772.336181339199;5791.218185544982;5791.652500849962;6305.747770089145;6342.334054924167;6347.079673447324;6358.650274234869;6368.968155159195;5791.681457519792;5798.130280457881;5806.187133801272;5806.970965145148;5810.5351571875;6106;6142.662153581417;6158.414950579688;6161.630302181883;6163.907541386972;5845.3570107289015;6002.969985150046;6006.729697163551;6007.128966299774;6028.4272994065495;5782.450667186778;5789.539445735461;5791.478766910998;5798.623089499169;5798.652080875161;4048.6356227939627;4071.9389209161295;4083.2037752637953;4087.162131763041;4094.754314741125;5953.077273022515;6133.969330153499;6179.443850053517;6186.566940314135;6205.410486003822;5913.29040515141;5915;5944.851378715567;5959.553033522417;5972.223610930551;5931.851703707442;5943.554233432596;5944.524438045032;5945.048792193228;5945.702714864153;5668.971655141698;5730.398308177581;5733.627314224729;5791.218185544897;5807.157962095557;5996.850078748066;6005.489533389536;6009.819705408845;6014.398560143951;6017.3681763414215;5752;5795.76816927335;5807.535397168132;5836.182934389274;5839 05:57:02 INFO - PROCESS | 3520 | |5;yui.html;718.3534818663205;718.9496735228533;722.349885103407;722.6170129831191;728.4427413029034;10779.407132607703;10927.617533386334;10942;10947.616833410832;10969.616063437781;9895.257855660819;10878.401687907162;10967.670969870896;10981.780364392727;11004.174686898494;757.6779868555856;762.8664983627843;774.1832366852968;774.9380049596019;775.53080386366;769.86142494351;772.7758949904521;773.4237992695449;773.9883901741479;774.8837674348864;804.3163311185475;811.9878201826948;812.2486699802658;815.4699445360504;816.8325493273865;788.8422315536858;793.6230290611913;796.2714116583348;800.8398320335926;802.4583406200791;590.6633219065135;591.5711109445617;592.2123575644425;592.5674257791836;593.1221791748194;11644.825327620092;11675.708107297301;11747.177697561174;11781.11641626873;11812.704682382922;10890.673279801618;10917;10922.453877306103;11206.271592346471;11215.719607009809;8712.912870871274;8865.645374185026;8932.776680582972;9106.40808347462;9204.769880752969;2913.7377636012648;2920.386718789057;2967.3620171663197;2987.5518672199128;3024.4404785114602;37691.246175076616;38165.618343816765;38370.616293837265;40717.59282407197;40958;8907.821843563092;8966.282697384193;9030.051844556227;9088.500132492776;9123.77190570241;15487.922560387125;15653.452129175424;15812.130332831575;15885.920570397075;15887.52337429879;6056.6971651418135;6171.722272497748;6228.128062071313;6272.372762723691;6296.685165741695;3567.3935430976794;3590.6409359063887;3621.9637803621627;3659.9817000914827;3669.7429397552014;2700.2844246274753;2725.0462338181874;2732.1393760965234;2733.876975536106;2734.931626709348;466.2889094131409;473.2333619536373;475.7169484156921;485.65518481878263;490.31600916720976;507.16064912569755;551.5780427972604;561.0335773115205;592.3720855892767;600.4925837667164;7253;7501.212372700897;7616.8476630467085;7618.390528757686;7678.884816727754;486.4989061266901;492.9507049295042;585.1135529672549;592.4608606168366;611.736574673709;3549.3256281306467;3562.928741425157;3594.2452085061905;3749.6250374962287;3810.809459527068;50404.24393634099;50451.495485045416;50626;50756.49243507592;51572.74213628983;44438.77780611076;44677.55322446734;44824.43114490977;44884.77557612191;45032.3245151323;41107;41415.58584414177;41605.375919361235;41766.79116604398;42351.57648423538;7461.030066091374;7577.318041376303;8117.878231826409;8303.6678532858;8347.85735331575;30934.69065309318;31273.843630782612;31762.682373175972;32027;32204.83897580497;38862.4170637435;39446;39656.60343396529;39777;39884.401733973435;9805.362651427635;9824.348939591822;9827.459489727848;10053.04496072872;10323;10883.727906802076;11055.668329949793;11113.666590002313;11318.151138664469;11859.05127589808;10746.516406761559;10943.945280273547;11018.283811552223;11034.117270618492;11343.886561134283;9909.306348555532;9980.750481238027;10036.548355323883;10106.444145572064;10387.68836934893;10691.572337106429;10703.090237329914;10923.071538919281;11253.943730281297;11402.771944560896;9159.450432974043;9267.6292948284;9311.953440233026;9334.299927505328;9457.527123643928;8822.779430514289;8992.505412202392;9180.516441235946;9290;9412.388194767593 05:57:02 INFO - PROCESS | 3520 | __end_tp_report 05:57:02 INFO - PROCESS | 3520 | __start_cc_report 05:57:02 INFO - PROCESS | 3520 | _x_x_mozilla_cycle_collect,328 05:57:02 INFO - PROCESS | 3520 | __end_cc_report 05:57:02 INFO - PROCESS | 3520 | __startTimestamp1451138222117__endTimestamp 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | ------- Summary: start ------- 05:57:02 INFO - PROCESS | 3520 | Number of tests: 6 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | [#0] dojo.html Cycles:165 Average:4579.98 Median:4685.91 stddev:471.42 (10.1%) stddev-sans-first:445.73 05:57:02 INFO - PROCESS | 3520 | Values: 2570.4 2649.4 2679.6 2690.0 2694.6 4471.8 4600.8 4616.1 4635.5 4640.6 4578.8 4607.5 4615.4 4714.7 4726.1 4255.8 4317.2 4368.7 4389.2 4432.3 4305.5 4343.2 4378.8 4439.4 4447.6 4154.3 4246.7 4249.7 4273.4 4291.5 4281.2 4318.7 4340.0 4346.6 4351.6 4290.6 4297.6 4297.8 4304.1 4348.1 4305.4 4394.8 4513.9 4580.6 4636.5 4969.2 4975.4 4985.6 4996.7 5016.7 4995.9 4996.1 5009.4 5016.3 5061.4 4451.1 4566.9 4575.9 4640.6 4754.5 5100.2 5106.1 5112.6 5113.7 5169.9 4908.5 4911.4 4912.9 4917.2 4960.6 4733.5 4848.9 4911.4 4981.8 5036.2 4898.2 4905.2 4920.8 4926.2 4965.4 4656.6 4848.2 4868.1 4896.2 4908.1 3993.9 4106.2 4139.8 4155.7 4200.0 3647.1 3670.6 3678.0 3694.8 3699.0 4171.4 4277.9 4291.4 4334.3 4344.6 4844.0 4871.9 4884.3 4900.8 4958.1 4274.2 4308.6 4312.6 4317.1 4336.2 4220.6 4395.4 4415.2 4456.0 4463.6 4545.3 4579.0 4580.5 4585.9 4660.5 5022.3 5032.9 5033.9 5037.4 5066.8 4752.2 4758.5 4761.9 4766.4 4790.7 4722.7 4846.1 4876.0 4908.3 4986.8 5001.0 5013.3 5022.9 5024.2 5046.5 4861.6 4865.5 4865.7 4867.1 4907.3 4610.0 4711.1 4767.0 4849.4 4908.9 4662.7 4694.6 4699.7 4714.4 4734.4 4844.0 4844.8 4847.3 4848.7 4891.0 4506.4 4645.9 4685.9 4773.6 4782.4 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | [#1] ext.html Cycles:180 Average:38919.71 Median:32810.68 stddev:63431.02 (193.3%) stddev-sans-first:63543.48 05:57:02 INFO - PROCESS | 3520 | Values: 533.2 543.7 551.8 566.4 582.5 31678.5 32326.5 32335.0 32362.0 32379.7 34359.7 34840.7 34978.3 34986.5 35080.5 7529.5 7635.5 7676.3 7683.7 7690.2 7497.6 7565.1 7604.8 7608.1 7618.7 7613.4 7633.4 7643.3 7650.6 7651.5 7802.8 7894.6 7909.6 7912.8 7925.5 7657.2 7767.6 7785.7 7793.4 7797.0 34893.7 35211.5 35260.3 35365.0 35370.0 2717.3 2727.4 2762.5 2769.3 2907.3 26977.7 27211.5 27392.3 27538.2 27839.4 3324.5 3324.7 3333.5 3382.8 3423.4 203261.0 203450.0 204056.0 204155.0 204224.7 43814.6 44635.3 50603.7 52805.7 54038.0 52385.0 52507.0 52840.5 52960.0 52970.0 12262.8 12423.7 12443.6 12449.9 12452.5 9243.6 9280.0 9290.3 9309.7 9399.3 17854.6 17926.9 18177.1 18183.8 18220.9 7041.9 7337.7 7379.6 7410.4 7471.8 771.3 836.8 850.3 851.5 864.5 23441.4 25966.4 26897.6 27249.5 28281.7 911.6 944.6 945.2 975.0 976.2 12920.4 13052.5 13069.5 13148.0 13191.5 263235.0 267563.0 268831.0 269030.0 269667.0 42873.0 43096.0 43145.0 43149.8 43153.0 1158.8 1162.7 1173.2 1187.2 1199.8 24962.3 25471.5 25559.9 25718.7 25721.5 38783.8 39144.2 39216.6 39219.6 39407.6 251935.0 253281.0 253443.0 253819.0 253951.0 27481.3 28130.3 28541.6 28687.0 28744.4 32802.2 32819.2 33289.8 33762.7 33767.3 30479.8 30812.0 31313.2 31939.2 32156.7 30485.8 30674.5 30680.7 30697.1 30874.0 27400.7 27869.6 27964.9 28048.9 28086.0 26079.5 27032.4 28203.9 28435.4 28606.4 22651.7 22926.2 23108.2 23284.4 23653.9 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | [#2] jquery.html Cycles:180 Average:25877.12 Median:393.88 stddev:80008.36 (20313.0%) stddev-sans-first:80209.81 05:57:02 INFO - PROCESS | 3520 | Values: 329.9 330.7 331.1 331.5 332.1 14944.1 15398.2 15955.7 16717.7 17393.3 10559.2 10560.0 10591.3 12206.2 15993.1 4378.4 4408.8 4499.2 4508.1 4536.5 4468.8 4475.4 4476.9 4478.2 4482.9 4462.3 4477.8 4951.9 5104.6 5123.9 5044.2 5072.2 5073.2 5110.1 5112.0 5086.3 5132.8 5141.5 5149.4 5150.1 11390.9 11570.5 14426.7 18316.5 18435.7 1673.8 1693.7 1755.4 1769.7 1870.0 9044.3 9613.5 11553.9 12567.9 13000.9 1670.2 1707.1 1761.5 1767.0 1822.9 56239.0 56967.4 57206.0 57322.4 57852.7 9462.8 9516.1 9572.9 9635.2 9707.5 12228.7 12231.1 12235.8 12256.3 12264.6 6734.5 6755.1 6757.2 6783.0 6843.0 6325.4 6400.9 6438.2 6466.5 6476.7 4088.6 4128.4 4152.5 4161.8 4176.2 1672.6 1688.6 1703.9 1719.5 1722.1 365.6 378.2 383.3 385.4 389.9 9584.8 9845.8 9975.0 10003.7 10131.6 391.2 392.3 395.4 396.5 418.1 5447.5 5487.0 5576.3 5576.4 5592.2 470568.0 474634.0 479086.0 485423.0 532597.0 71220.3 73342.6 74113.6 75229.0 76211.0 1024.7 1059.7 1069.3 1071.7 1078.2 13478.4 13807.1 14125.7 14308.0 14345.7 19810.5 32655.8 32747.2 33116.3 34398.0 41711.8 42296.8 42425.2 42903.0 44357.3 8725.1 8906.6 8993.1 9188.3 9285.6 16113.4 16183.5 16415.3 16492.3 16590.8 10749.3 13205.1 13523.9 13551.7 13999.4 12355.1 12528.3 12825.6 12886.8 12992.4 12880.4 12902.0 13041.8 13669.1 13738.9 8165.8 8533.0 8599.8 8660.3 8677.3 8818.3 10174.7 13229.0 13343.5 13419.9 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | [#3] mootools.html Cycles:180 Average:4906.78 Median:6253.05 stddev:2513.19 (40.2%) stddev-sans-first:2505.95 05:57:02 INFO - PROCESS | 3520 | Values: 1342.1 1369.3 1473.0 1664.5 1685.8 5901.7 5976.2 6894.0 7038.0 7049.7 6713.4 6779.2 6864.5 6907.7 6947.1 2063.2 2115.8 2117.5 2117.7 2121.7 2114.7 2116.7 2119.3 2136.4 2147.5 2029.6 2055.2 2055.5 2063.2 2064.2 2122.1 2152.7 2155.8 2159.2 2160.5 2125.1 2164.0 2168.7 2175.1 2175.4 7151.7 7200.2 7256.9 7275.0 7296.2 4220.2 4275.4 4292.2 4294.6 4297.6 2234.9 2289.3 2658.2 2733.1 2739.3 752.9 793.9 799.0 1595.8 1629.0 9272.0 9331.6 9366.2 9409.5 9421.9 3775.7 3791.8 3817.8 3877.0 3913.9 7663.2 7666.9 7708.7 7715.8 7746.0 3988.1 4060.2 4061.3 4075.5 4080.7 3688.0 3710.0 3723.2 3734.7 3747.8 3147.5 3154.3 3186.1 3191.1 3196.3 933.9 938.9 945.2 949.5 950.4 873.7 887.8 892.4 893.0 894.7 6662.0 6789.8 6791.2 6793.2 6806.2 924.4 930.7 1031.9 1033.4 1047.1 5264.8 5289.0 5387.4 5388.6 5390.0 7050.5 7279.4 8219.6 8351.5 8463.5 8224.3 8259.4 8283.5 8327.6 8355.4 6493.7 6594.5 6646.3 6694.7 6751.3 6600.1 6640.1 6644.8 6650.2 6677.4 7410.1 7486.1 7852.9 7945.0 7963.2 7819.7 7965.8 8032.8 8053.4 8094.8 6038.5 6091.7 6167.3 6170.3 6192.3 6776.4 6805.3 6831.8 6871.2 6881.7 6307.1 6324.2 6341.0 6400.9 6457.5 6285.6 6400.5 6446.9 6475.4 6496.4 6184.6 6245.4 6245.5 6246.2 6259.9 5912.0 5913.3 5914.5 5920.2 5962.7 6047.4 6049.8 6137.3 6140.8 6147.8 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | [#4] prototype.html Cycles:180 Average:4857.43 Median:5560.22 stddev:1462.38 (26.3%) stddev-sans-first:1425.85 05:57:02 INFO - PROCESS | 3520 | Values: 296.2 302.3 305.8 306.8 307.6 5536.3 5544.7 5657.6 5667.8 5668.6 5546.5 5547.3 5549.2 5554.7 5565.8 4144.6 4280.9 4286.2 4313.7 4315.7 4220.0 4237.3 4239.6 4243.4 4247.6 4175.0 4181.9 4183.9 4184.0 4187.2 4186.9 4196.6 4237.8 4242.1 4243.6 3668.2 3673.9 3675.4 3681.2 3685.0 5281.5 5425.0 5432.2 5432.6 5439.8 4869.6 4875.0 4876.9 4880.9 4883.0 5841.6 5856.9 5903.1 5904.0 5917.4 3981.9 3985.3 3988.6 3992.2 3999.0 5960.1 6096.6 6103.5 6166.3 6180.8 4056.7 4088.8 4088.9 4093.5 4095.5 4155.3 4155.5 4157.3 4157.9 4158.1 4816.0 4825.7 4828.8 4837.0 4837.1 5714.8 5816.1 5855.9 5866.7 5888.2 1450.4 1459.9 1462.7 1464.0 1470.1 966.0 967.7 972.1 986.5 987.2 5120.9 5131.8 5137.9 5140.9 5145.5 6017.8 6105.3 6122.6 6195.8 6201.6 5126.5 5148.5 5172.4 5174.5 5177.0 3301.1 3324.4 3324.5 3325.5 3331.1 5671.8 5756.3 5772.3 5791.2 5791.7 6305.7 6342.3 6347.1 6358.7 6369.0 5791.7 5798.1 5806.2 5807.0 5810.5 6106.0 6142.7 6158.4 6161.6 6163.9 5845.4 6003.0 6006.7 6007.1 6028.4 5782.5 5789.5 5791.5 5798.6 5798.7 4048.6 4071.9 4083.2 4087.2 4094.8 5953.1 6134.0 6179.4 6186.6 6205.4 5913.3 5915.0 5944.9 5959.6 5972.2 5931.9 5943.6 5944.5 5945.0 5945.7 5669.0 5730.4 5733.6 5791.2 5807.2 5996.9 6005.5 6009.8 6014.4 6017.4 5752.0 5795.8 5807.5 5836.2 5839.0 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - PROCESS | 3520 | [#5] yui.html Cycles:180 Average:12171.17 Median:474.48 stddev:13917.12 (2933.2%) stddev-sans-first:13929.58 05:57:02 INFO - PROCESS | 3520 | Values: 718.4 718.9 722.3 722.6 728.4 10779.4 10927.6 10942.0 10947.6 10969.6 9895.3 10878.4 10967.7 10981.8 11004.2 757.7 762.9 774.2 774.9 775.5 769.9 772.8 773.4 774.0 774.9 804.3 812.0 812.2 815.5 816.8 788.8 793.6 796.3 800.8 802.5 590.7 591.6 592.2 592.6 593.1 11644.8 11675.7 11747.2 11781.1 11812.7 10890.7 10917.0 10922.5 11206.3 11215.7 8712.9 8865.6 8932.8 9106.4 9204.8 2913.7 2920.4 2967.4 2987.6 3024.4 37691.2 38165.6 38370.6 40717.6 40958.0 8907.8 8966.3 9030.1 9088.5 9123.8 15487.9 15653.5 15812.1 15885.9 15887.5 6056.7 6171.7 6228.1 6272.4 6296.7 3567.4 3590.6 3622.0 3660.0 3669.7 2700.3 2725.0 2732.1 2733.9 2734.9 466.3 473.2 475.7 485.7 490.3 507.2 551.6 561.0 592.4 600.5 7253.0 7501.2 7616.8 7618.4 7678.9 486.5 493.0 585.1 592.5 611.7 3549.3 3562.9 3594.2 3749.6 3810.8 50404.2 50451.5 50626.0 50756.5 51572.7 44438.8 44677.6 44824.4 44884.8 45032.3 41107.0 41415.6 41605.4 41766.8 42351.6 7461.0 7577.3 8117.9 8303.7 8347.9 30934.7 31273.8 31762.7 32027.0 32204.8 38862.4 39446.0 39656.6 39777.0 39884.4 9805.4 9824.3 9827.5 10053.0 10323.0 10883.7 11055.7 11113.7 11318.2 11859.1 10746.5 10943.9 11018.3 11034.1 11343.9 9909.3 9980.8 10036.5 10106.4 10387.7 10691.6 10703.1 10923.1 11253.9 11402.8 9159.5 9267.6 9312.0 9334.3 9457.5 8822.8 8992.5 9180.5 9290.0 9412.4 05:57:02 INFO - PROCESS | 3520 | -------- Summary: end -------- 05:57:02 INFO - PROCESS | 3520 | 05:57:02 INFO - TEST-INFO | 3520: exit 0 05:57:02 INFO - TEST-OK | dromaeo_css | took 1117148ms 05:57:02 INFO - TEST-START | kraken 05:57:02 INFO - operating with platform_type : linux_ 05:57:02 INFO - Initialising browser for kraken test... 05:57:02 INFO - TEST-INFO | started process 3757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDqM9S9/profile http://localhost:41979/getInfo.html) 05:57:07 INFO - PROCESS | 3757 | __metrics Screen width/height:1600/1200 05:57:07 INFO - PROCESS | 3757 | colorDepth:24 05:57:07 INFO - PROCESS | 3757 | Browser inner width/height: 1024/697 05:57:07 INFO - PROCESS | 3757 | __metrics 05:57:07 INFO - PROCESS | 3757 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:57:08 INFO - TEST-INFO | 3757: exit 0 05:57:08 INFO - Browser initialized. 05:57:08 INFO - Running cycle 1/1 for kraken test... 05:57:08 INFO - TEST-INFO | started process 3878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDqM9S9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:20 INFO - PROCESS | 3878 | RSS: Main: 149340160 05:57:20 INFO - PROCESS | 3878 | 05:57:23 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41979/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:23 INFO - PROCESS | 3878 | RSS: Main: 149426176 05:57:23 INFO - PROCESS | 3878 | 05:57:26 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41979/tests/kraken/driver.html?testName=audio-dft) 05:57:26 INFO - PROCESS | 3878 | RSS: Main: 150790144 05:57:26 INFO - PROCESS | 3878 | 05:57:29 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41979/tests/kraken/driver.html?testName=audio-fft) 05:57:30 INFO - PROCESS | 3878 | RSS: Main: 145547264 05:57:30 INFO - PROCESS | 3878 | 05:57:32 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41979/tests/kraken/driver.html?testName=audio-oscillator) 05:57:33 INFO - PROCESS | 3878 | RSS: Main: 146186240 05:57:33 INFO - PROCESS | 3878 | 05:57:35 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41979/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:35 INFO - PROCESS | 3878 | RSS: Main: 146870272 05:57:35 INFO - PROCESS | 3878 | 05:57:39 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41979/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:39 INFO - PROCESS | 3878 | RSS: Main: 146776064 05:57:39 INFO - PROCESS | 3878 | 05:57:43 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41979/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:43 INFO - PROCESS | 3878 | RSS: Main: 146386944 05:57:43 INFO - PROCESS | 3878 | 05:57:46 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41979/tests/kraken/driver.html?testName=json-parse-financial) 05:57:47 INFO - PROCESS | 3878 | RSS: Main: 146804736 05:57:47 INFO - PROCESS | 3878 | 05:57:48 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41979/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:49 INFO - PROCESS | 3878 | RSS: Main: 148672512 05:57:49 INFO - PROCESS | 3878 | 05:57:51 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:51 INFO - PROCESS | 3878 | RSS: Main: 148635648 05:57:51 INFO - PROCESS | 3878 | 05:57:54 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:54 INFO - PROCESS | 3878 | RSS: Main: 148455424 05:57:54 INFO - PROCESS | 3878 | 05:57:57 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:57 INFO - PROCESS | 3878 | RSS: Main: 148512768 05:57:57 INFO - PROCESS | 3878 | 05:58:00 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:01 INFO - PROCESS | 3878 | RSS: Main: 147869696 05:58:01 INFO - PROCESS | 3878 | 05:58:02 INFO - PROCESS | 3878 | Cycle 1(1): loaded http://localhost:41979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41979/tests/kraken/driver.html?testName=ai-astar) 05:58:03 INFO - PROCESS | 3878 | RSS: Main: 148074496 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | __start_tp_report 05:58:03 INFO - PROCESS | 3878 | _x_x_mozilla_page_load 05:58:03 INFO - PROCESS | 3878 | _x_x_mozilla_page_load_details 05:58:03 INFO - PROCESS | 3878 | |i|pagename|runs| 05:58:03 INFO - PROCESS | 3878 | |0;ai-astar;119;109;113;113;114;125;112;114;113;113 05:58:03 INFO - PROCESS | 3878 | |1;audio-beat-detection;167;133;162;174;133;154;155;150;182;137 05:58:03 INFO - PROCESS | 3878 | |2;audio-dft;162;163;164;162;160;166;167;160;166;165 05:58:03 INFO - PROCESS | 3878 | |3;audio-fft;73;73;73;143;73;73;72;72;154;72 05:58:03 INFO - PROCESS | 3878 | |4;audio-oscillator;97;98;132;98;99;98;137;96;97;135 05:58:03 INFO - PROCESS | 3878 | |5;imaging-gaussian-blur;109;111;110;110;111;110;110;109;111;110 05:58:03 INFO - PROCESS | 3878 | |6;imaging-darkroom;148;148;148;147;147;149;148;148;147;147 05:58:03 INFO - PROCESS | 3878 | |7;imaging-desaturate;98;96;101;96;96;96;97;97;96;95 05:58:03 INFO - PROCESS | 3878 | |8;json-parse-financial;71;71;72;72;73;71;73;72;71;71 05:58:03 INFO - PROCESS | 3878 | |9;json-stringify-tinderbox;70;69;69;70;70;70;69;68;69;69 05:58:03 INFO - PROCESS | 3878 | |10;stanford-crypto-aes;91;92;86;85;86;86;86;94;95;99 05:58:03 INFO - PROCESS | 3878 | |11;stanford-crypto-ccm;125;118;119;130;132;128;133;123;128;124 05:58:03 INFO - PROCESS | 3878 | |12;stanford-crypto-pbkdf2;142;149;143;149;148;139;147;148;147;168 05:58:03 INFO - PROCESS | 3878 | |13;stanford-crypto-sha256-iterative;71;73;71;70;70;72;72;69;71;69 05:58:03 INFO - PROCESS | 3878 | __end_tp_report 05:58:03 INFO - PROCESS | 3878 | __start_cc_report 05:58:03 INFO - PROCESS | 3878 | _x_x_mozilla_cycle_collect,798 05:58:03 INFO - PROCESS | 3878 | __end_cc_report 05:58:03 INFO - PROCESS | 3878 | __startTimestamp1451138283214__endTimestamp 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | ------- Summary: start ------- 05:58:03 INFO - PROCESS | 3878 | Number of tests: 14 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.50 stddev:4.43 (3.9%) stddev-sans-first:4.39 05:58:03 INFO - PROCESS | 3878 | Values: 119.0 109.0 113.0 113.0 114.0 125.0 112.0 114.0 113.0 113.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:158.50 stddev:17.00 (10.7%) stddev-sans-first:17.44 05:58:03 INFO - PROCESS | 3878 | Values: 167.0 133.0 162.0 174.0 133.0 154.0 155.0 150.0 182.0 137.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.50 stddev:2.51 (1.5%) stddev-sans-first:2.60 05:58:03 INFO - PROCESS | 3878 | Values: 162.0 163.0 164.0 162.0 160.0 166.0 167.0 160.0 166.0 165.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#3] audio-fft Cycles:10 Average:87.80 Median:73.00 stddev:32.10 (44.0%) stddev-sans-first:33.60 05:58:03 INFO - PROCESS | 3878 | Values: 73.0 73.0 73.0 143.0 73.0 73.0 72.0 72.0 154.0 72.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:97.50 stddev:17.98 (18.4%) stddev-sans-first:18.56 05:58:03 INFO - PROCESS | 3878 | Values: 97.0 98.0 132.0 98.0 99.0 98.0 137.0 96.0 97.0 135.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 05:58:03 INFO - PROCESS | 3878 | Values: 109.0 111.0 110.0 110.0 111.0 110.0 110.0 109.0 111.0 110.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:58:03 INFO - PROCESS | 3878 | Values: 148.0 148.0 148.0 147.0 147.0 149.0 148.0 148.0 147.0 147.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.69 (1.8%) stddev-sans-first:1.73 05:58:03 INFO - PROCESS | 3878 | Values: 98.0 96.0 101.0 96.0 96.0 96.0 97.0 97.0 96.0 95.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:72.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 05:58:03 INFO - PROCESS | 3878 | Values: 71.0 71.0 72.0 72.0 73.0 71.0 73.0 72.0 71.0 71.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 05:58:03 INFO - PROCESS | 3878 | Values: 70.0 69.0 69.0 70.0 70.0 70.0 69.0 68.0 69.0 69.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:91.50 stddev:4.90 (5.4%) stddev-sans-first:5.18 05:58:03 INFO - PROCESS | 3878 | Values: 91.0 92.0 86.0 85.0 86.0 86.0 86.0 94.0 95.0 99.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:128.00 stddev:5.12 (4.0%) stddev-sans-first:5.42 05:58:03 INFO - PROCESS | 3878 | Values: 125.0 118.0 119.0 130.0 132.0 128.0 133.0 123.0 128.0 124.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:148.00 stddev:7.79 (5.3%) stddev-sans-first:7.95 05:58:03 INFO - PROCESS | 3878 | Values: 142.0 149.0 143.0 149.0 148.0 139.0 147.0 148.0 147.0 168.0 05:58:03 INFO - PROCESS | 3878 | 05:58:03 INFO - PROCESS | 3878 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.32 (1.9%) stddev-sans-first:1.39 05:58:03 INFO - PROCESS | 3878 | Values: 71.0 73.0 71.0 70.0 70.0 72.0 72.0 69.0 71.0 69.0 05:58:03 INFO - PROCESS | 3878 | -------- Summary: end -------- 05:58:03 INFO - PROCESS | 3878 | 05:58:04 INFO - TEST-INFO | 3878: exit 0 05:58:04 INFO - TEST-OK | kraken | took 61481ms 05:58:04 INFO - TEST-START | v8_7 05:58:04 INFO - operating with platform_type : linux_ 05:58:04 INFO - Initialising browser for v8_7 test... 05:58:04 INFO - TEST-INFO | started process 4163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJX86SQ/profile http://localhost:41979/getInfo.html) 05:58:09 INFO - PROCESS | 4163 | __metrics Screen width/height:1600/1200 05:58:09 INFO - PROCESS | 4163 | colorDepth:24 05:58:09 INFO - PROCESS | 4163 | Browser inner width/height: 1024/697 05:58:09 INFO - PROCESS | 4163 | __metrics 05:58:09 INFO - PROCESS | 4163 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:58:10 INFO - TEST-INFO | 4163: exit 0 05:58:10 INFO - Browser initialized. 05:58:10 INFO - Running cycle 1/1 for v8_7 test... 05:58:10 INFO - TEST-INFO | started process 4282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJX86SQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:22 INFO - PROCESS | 4282 | RSS: Main: 149049344 05:58:22 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | Cycle 1(1): loaded http://localhost:41979/tests/v8_7/run.html (next: http://localhost:41979/tests/v8_7/run.html) 05:58:43 INFO - PROCESS | 4282 | RSS: Main: 145211392 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | __start_tp_report 05:58:43 INFO - PROCESS | 4282 | _x_x_mozilla_page_load 05:58:43 INFO - PROCESS | 4282 | _x_x_mozilla_page_load_details 05:58:43 INFO - PROCESS | 4282 | |i|pagename|runs| 05:58:43 INFO - PROCESS | 4282 | |0;Richards;165.56291390728478 05:58:43 INFO - PROCESS | 4282 | |1;DeltaBlue;188.07598269700958 05:58:43 INFO - PROCESS | 4282 | |2;Encrypt;277.0083102493075 05:58:43 INFO - PROCESS | 4282 | |3;Decrypt;5246.073298429319 05:58:43 INFO - PROCESS | 4282 | |4;RayTrace;1075.268817204301 05:58:43 INFO - PROCESS | 4282 | |5;Earley;706.7137809187279 05:58:43 INFO - PROCESS | 4282 | |6;Boyer;12317.073170731708 05:58:43 INFO - PROCESS | 4282 | |7;RegExp;28555.555555555555 05:58:43 INFO - PROCESS | 4282 | |8;Splay;599.5203836930456 05:58:43 INFO - PROCESS | 4282 | |9;NavierStokes;4840.579710144928 05:58:43 INFO - PROCESS | 4282 | __end_tp_report 05:58:43 INFO - PROCESS | 4282 | __startTimestamp1451138323701__endTimestamp 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | ------- Summary: start ------- 05:58:43 INFO - PROCESS | 4282 | Number of tests: 10 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 165.6 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#1] DeltaBlue Cycles:1 Average:188.08 Median:188.08 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 188.1 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#2] Encrypt Cycles:1 Average:277.01 Median:277.01 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 277.0 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 5246.1 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 1075.3 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#5] Earley Cycles:1 Average:706.71 Median:706.71 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 706.7 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 12317.1 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#7] RegExp Cycles:1 Average:28555.56 Median:28555.56 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 28555.6 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#8] Splay Cycles:1 Average:599.52 Median:599.52 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 599.5 05:58:43 INFO - PROCESS | 4282 | 05:58:43 INFO - PROCESS | 4282 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:58:43 INFO - PROCESS | 4282 | Values: 4840.6 05:58:43 INFO - PROCESS | 4282 | -------- Summary: end -------- 05:58:43 INFO - PROCESS | 4282 | 05:58:44 INFO - TEST-INFO | 4282: exit 0 05:58:44 INFO - TEST-OK | v8_7 | took 40273ms 05:58:44 INFO - SUITE-END | took 1218s 05:58:44 INFO - Completed test suite (00:20:18) 05:58:44 INFO - Working with test: dromaeo_css 05:58:44 INFO - Generating results file: dromaeo_css 05:58:44 INFO - Working with test: kraken 05:58:44 INFO - Generating results file: kraken 05:58:44 INFO - javascript benchmark 05:58:44 INFO - Working with test: v8_7 05:58:44 INFO - Generating results file: v8_7 05:58:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 05:58:44 INFO - process_Request line: dromaeo_css 6151.20 graph.html#tests=[[72,94,43]] 05:58:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:44 INFO - process_Request line: kraken 1559.60 graph.html#tests=[[232,94,43]] 05:58:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:44 INFO - process_Request line: v8_7 21138.61 graph.html#tests=[[230,94,43]] 05:58:44 INFO - RETURN: dromaeo_css: 6151.20 05:58:44 INFO - RETURN: kraken: 1559.60 05:58:44 INFO - RETURN: v8_7: 21138.61 05:58:44 INFO - javascript benchmark 05:58:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2570.447353818929, 2649.403884126071, 2679.571268597024, 2690.0315886280937, 2694.6496955395783, 4471.843485478009, 4600.79296431661, 4616.146012987591, 4635.490096089427, 4640.605548528375, 4578.839740609079, 4607.539246075391, 4615.423072115986, 4714.740689262089, 4726.149293127236, 4255.787210639463, 4317.2228998780365, 4368.650507959372, 4389.209942210401, 4432.290833466646, 4305.50486694031, 4343.2182207202695, 4378.8029538670835, 4439.422875026242, 4447.599716025557, 4154.273002224629, 4246.7027308088445, 4249.702520823544, 4273.444452221207, 4291.549387314319, 4281.229378711831, 4318.69769116162, 4340.023494713696, 4346.587074227943, 4351.608355248043, 4290.592393722592, 4297.634701050414, 4297.828086876521, 4304.096139810644, 4348.130373925228, 4305.418768466248, 4394.824207031715, 4513.909721805579, 4580.610648094883, 4636.5131661175765, 4969.229769385751, 4975.402951645826, 4985.551300382983, 4996.684498910631, 5016.698998060128, 4995.900081998339, 4996.050750357421, 5009.373828271466, 5016.347874776256, 5061.367329083864, 4451.1097780443715, 4566.908661826745, 4575.862724118315, 4640.582347588733, 4754.5245475452175, 5100.209467532539, 5106.106431374495, 5112.565431938253, 5113.718745469035, 5169.948300517022, 4908.460069392364, 4911.386076740408, 4912.852614421573, 4917.188663870421, 4960.627952903546, 4733.502982186889, 4848.903021939612, 4911.386076740408, 4981.775820088104, 5036.219385995177, 4898.24077268024, 4905.23968784839, 4920.778564964585, 4926.187179115477, 4965.428975667773, 4656.604188643935, 4848.248521479177, 4868.14807408702, 4896.167651499253, 4908.141075311806, 3993.900152496211, 4106.240345536025, 4139.834406623701, 4155.729877557949, 4199.97900010498, 3647.0882279430143, 3670.6145854685406, 3677.9632203678157, 3694.833732481991, 3699.0, 4171.374293855885, 4277.871663850089, 4291.399204111427, 4334.263175260214, 4344.587264209895, 4843.975780121077, 4871.853844384674, 4884.267359895973, 4900.828471003498, 4958.057968985953, 4274.153262064167, 4308.612224899774, 4312.568743125662, 4317.136572685476, 4336.176126536011, 4220.556841531657, 4395.384646149478, 4415.1611193873705, 4456.0, 4463.553644635511, 4545.272756358901, 4579.015511665008, 4580.519045500241, 4585.908281834411, 4660.510646382081, 5022.347094877642, 5032.949670503248, 5033.899322013466, 5037.370328708911, 5066.797328106834, 4752.239641657318, 4758.500357462555, 4761.928571071506, 4766.428028636586, 4790.7365094920115, 4722.740249286322, 4846.103470857903, 4875.9512404875495, 4908.312836203006, 4986.775595098156, 5001.049800537886, 5013.348264725562, 5022.899542009066, 5024.196128619404, 5046.495350464924, 4861.562459378673, 4865.464798872051, 4865.659403841839, 4867.075255701406, 4907.312976183266, 4609.953900460952, 4711.128441238382, 4766.976165119291, 4849.442314133919, 4908.895498512806, 4662.696924699883, 4694.64790140734, 4699.694519856198, 4714.38712967312, 4734.384530011076, 4843.95156048435, 4844.8304309350415, 4847.321375007431, 4848.684835485682, 4890.975545122252, 4506.391637128946, 4645.907081858276, 4685.906281874275, 4773.64197685182, 4782.378290822171], "unit": "score", "name": "dojo.html", "value": 4551.078702682875}, {"lowerIsBetter": false, "replicates": [533.2321457101773, 543.6765124750773, 551.8261747549521, 566.3798141035564, 582.4583137681957, 31678.524822127656, 32326.515102273454, 32335.029949101536, 32362.0, 32379.67620323796, 34359.65640343596, 34840.65159348406, 34978.3004339913, 34986.475202871974, 35080.47379289313, 7529.472936894406, 7635.465517413783, 7676.270754278335, 7683.692652293901, 7690.15408305086, 7497.550146991198, 7565.13001004886, 7604.771856844276, 7608.087029556461, 7618.695252189934, 7613.352865006481, 7633.389328853678, 7643.273888980566, 7650.579218143, 7651.464397492177, 7802.76591702247, 7894.6447409866405, 7909.644066017015, 7912.80217994549, 7925.524468531907, 7657.195994420617, 7767.572783496906, 7785.688572457095, 7793.376529877596, 7797.025371828521, 34893.651063489546, 35211.4718279226, 35260.294794103975, 35365.0, 35370.0, 2717.3342531079816, 2727.4136060746837, 2762.5165596020615, 2769.3353595137223, 2907.345847184388, 26977.73022269772, 27211.45577088467, 27392.315192120157, 27538.17385478439, 27839.443211135866, 3324.4514655081884, 3324.6841550052704, 3333.4999750037446, 3382.763206575516, 3423.4351332030187, 203261.0, 203449.98275008678, 204056.0, 204155.0, 204224.74651520955, 43814.56185438169, 44635.33047004297, 50603.74698126559, 52805.7359713199, 54038.0, 52385.0, 52507.0, 52840.471595283554, 52960.0, 52970.0, 12262.754744905053, 12423.689407764698, 12443.626691199279, 12449.875501245053, 12452.501899924082, 9243.630254789867, 9280.0, 9290.303227257982, 9309.72070837876, 9399.295052871063, 17854.642907141784, 17926.91036544809, 18177.09114544294, 18183.818161818213, 18220.90889545544, 7041.894371584431, 7337.74317898871, 7379.631018449056, 7410.444216683771, 7471.813204669818, 771.2711487644123, 836.7782537627534, 850.2900078434576, 851.4848516647339, 864.5245115186622, 23441.41396465102, 25966.35084122874, 26897.596536051973, 27249.455010900067, 28281.744435005952, 911.5578944212052, 944.6221511395497, 945.1824172091092, 974.9567962280292, 976.1507488485064, 12920.353982300847, 13052.54316098951, 13069.542566010145, 13148.013898957617, 13191.472341106248, 263235.0, 267563.0, 268831.0, 269030.0, 269667.0, 42873.0, 43096.0, 43145.0, 43149.78425107854, 43153.0, 1158.8261760735788, 1162.6744511536783, 1173.2491205628405, 1187.1571184458958, 1199.8080307150815, 24962.251132466055, 25471.490570188864, 25559.872200638878, 25718.742812571636, 25721.485570288864, 38783.806080969414, 39144.217115658095, 39216.64700118002, 39219.607803922736, 39407.60592394039, 251935.0, 253281.0, 253443.0, 253819.0, 253951.0, 27481.31296717598, 28130.2967425816, 28541.571876421454, 28687.0, 28744.425111498073, 32802.17994550155, 32819.17952051122, 33289.83355083209, 33762.662373375955, 33767.32465350728, 30479.84760076274, 30812.0, 31313.217169570944, 31939.201519962186, 32156.67843321537, 30485.847570762005, 30674.539881901343, 30680.693193068677, 30697.079087627408, 30874.0, 27400.725992740616, 27869.58195627108, 27964.860175698992, 28048.85975570109, 28086.0, 26079.478410431304, 27032.425395752864, 28203.858980704965, 28435.431291373643, 28606.42787144287, 22651.660225096966, 22926.19758308451, 23108.191213307455, 23284.417889552897, 23653.881730591926], "unit": "score", "name": "ext.html", "value": 15922.381488082545}, {"lowerIsBetter": false, "replicates": [329.8565124170985, 330.7056719519627, 331.1357357297455, 331.46302989157556, 332.09007319943333, 14944.103353798766, 15398.153101579423, 15955.68088638228, 16717.66564668706, 17393.304267829302, 10559.155267578595, 10560.0495955364, 10591.25861189717, 12206.206596571239, 15993.120378379184, 4378.430803995476, 4408.757518336491, 4499.1901457737595, 4508.120916421282, 4536.455625324949, 4468.776561171945, 4475.418195634579, 4476.910461790762, 4478.193925093482, 4482.932756008662, 4462.330650402433, 4477.820887164526, 4951.8514444566545, 5104.64267501275, 5123.871903202431, 5044.192929131358, 5072.213806859906, 5073.213651883964, 5110.105731496992, 5112.0, 5086.338775959101, 5132.820351287724, 5141.460146684619, 5149.407818100929, 5150.098732721759, 11390.886091139066, 11570.479328430241, 14426.711465770732, 18316.450506484827, 18435.72346414805, 1673.8075121361078, 1693.6612677464434, 1755.4207111653125, 1769.6549172911286, 1870.0, 9044.276457883354, 9613.471259080748, 11553.884461155365, 12567.937160314232, 13000.934995325057, 1670.2400407814416, 1707.0611163859828, 1761.462753860072, 1767.0, 1822.8541716662635, 56239.0, 56967.43032569663, 57206.0, 57322.42677573213, 57852.71073644647, 9462.810743785085, 9516.143547080796, 9572.9042709572, 9635.22918166545, 9707.514624268899, 12228.694282643006, 12231.082668799698, 12235.816462753066, 12256.264624122581, 12264.570740024057, 6734.46124310054, 6755.121834161528, 6757.222919364336, 6782.966085169543, 6843.0, 6325.367463253638, 6400.935990640127, 6438.163038804925, 6466.450351720063, 6476.676166191672, 4088.570700076449, 4128.380742888591, 4152.5432202457705, 4161.750294982311, 4176.206520761046, 1672.5985763416936, 1688.577855536116, 1703.923323450423, 1719.4841547535689, 1722.113111747451, 365.6398447529182, 378.18501130064203, 383.25456986161646, 385.35837830013276, 389.9239648268617, 9584.808303833885, 9845.753856153653, 9974.950125249326, 10003.749906252402, 10131.594736210616, 391.18242872396826, 392.33695055356355, 395.41873446034856, 396.49842948669954, 418.053109706515, 5447.4552544746, 5486.972565137149, 5576.302962129734, 5576.414476479992, 5592.161175823578, 470568.0, 474634.0, 479086.0, 485423.0, 532597.0, 71220.28779712241, 73342.63328683322, 74113.62943185249, 75229.0, 76211.0, 1024.6874703215442, 1059.7191744187796, 1069.25152393325, 1071.6570697376922, 1078.1698092468598, 13478.393472293574, 13807.102538334975, 14125.717485650435, 14308.0, 14345.713085738436, 19810.50473738168, 32655.836720816245, 32747.181320466225, 33116.33767324688, 34397.968060958214, 41711.79144104382, 42296.788516057226, 42425.1514969705, 42903.02439999026, 44357.33463997978, 8725.127487251224, 8906.554672266491, 8993.055729148346, 9188.310876684409, 9285.6285748572, 16113.436029738903, 16183.514494565183, 16415.26131324117, 16492.25784839661, 16590.83409165893, 10749.301295415773, 13205.075644705163, 13523.932380338036, 13551.72896542044, 13999.44002239899, 12355.135140540076, 12528.310942897864, 12825.615231543068, 12886.806697899352, 12992.415341309852, 12880.35598220104, 12902.0, 13041.804372934603, 13669.111507751964, 13738.86261137376, 8165.755027349189, 8532.957335213285, 8599.828003440021, 8660.263877570225, 8677.349198809989, 8818.29453643694, 10174.694759157237, 13229.0, 13343.466261349826, 13419.932900335436], "unit": "score", "name": "jquery.html", "value": 7501.0857724579155}, {"lowerIsBetter": false, "replicates": [1342.1410297409657, 1369.301656155361, 1472.9926350368246, 1664.5172899859042, 1685.7639930409737, 5901.675407852566, 5976.19321391612, 6894.000369946355, 7038.049863268458, 7049.682764275607, 6713.362230588098, 6779.220389655191, 6864.450843932486, 6907.68915398807, 6947.096877405943, 2063.226290141201, 2115.7778433264516, 2117.491801967532, 2117.692934524493, 2121.7029615853794, 2114.7356580427445, 2116.6719158530454, 2119.2900378373265, 2136.3697709175754, 2147.45239963809, 2029.6245194638966, 2055.1595662547334, 2055.54777948851, 2063.1850419084453, 2064.225915281769, 2122.129926730041, 2152.698622192902, 2155.795199456049, 2159.157928407922, 2160.503084290614, 2125.128697234127, 2163.9783602164093, 2168.7072245246845, 2175.1082056356818, 2175.445261458334, 7151.713931442736, 7200.171980222289, 7256.854862902713, 7275.017872587186, 7296.197418283985, 4220.240356735786, 4275.3800698898485, 4292.1630282095, 4294.613484786384, 4297.5702429756775, 2234.8547344422723, 2289.290320000805, 2658.162678756205, 2733.084416720401, 2739.2740923655247, 752.879539273719, 793.9364850811921, 798.9680412783482, 1595.8324375940592, 1628.991855040729, 9271.953640231823, 9331.580078896466, 9366.20387267083, 9409.529523523797, 9421.858672119992, 3775.716821238363, 3791.829367678461, 3817.828197731053, 3877.0, 3913.92172156561, 7663.19536448676, 7666.8849967250535, 7708.730194443167, 7715.768526944201, 7746.0, 3988.12261302513, 4060.2082593893906, 4061.2892743770312, 4075.5313138988804, 4080.653144482693, 3688.0, 3709.9814500927323, 3723.162288485069, 3734.738568300193, 3747.793871337048, 3147.464930961742, 3154.2587491939375, 3186.1078897908624, 3191.138392633976, 3196.328770958078, 933.8599210118537, 938.8737493286595, 945.2107490245585, 949.5157469690507, 950.4154944708954, 873.7073080517971, 887.8046829697456, 892.3931726426092, 892.9508877011697, 894.7136916186888, 6661.966690166518, 6789.796306110726, 6791.151106111736, 6793.184817821794, 6806.217285012287, 924.4083786376724, 930.6696122876417, 1031.852848811138, 1033.4006276359694, 1047.0942634621, 5264.789408423697, 5289.047971365191, 5387.353517577916, 5388.568914486832, 5390.029794637003, 7050.471214658921, 7279.417646588367, 8219.630116644765, 8351.540665263468, 8463.49219046859, 8224.342052635775, 8259.380546458919, 8283.544405057779, 8327.625256863455, 8355.415120941476, 6493.70778314977, 6594.505412094016, 6646.268910419946, 6694.698738556776, 6751.291114433012, 6600.075989361397, 6640.103586015826, 6644.767433139817, 6650.235222949423, 6677.399034086956, 7410.11078670563, 7486.101667799681, 7852.882206767017, 7944.960275198587, 7963.243491868263, 7819.726309579138, 7965.800854978672, 8032.799180020546, 8053.395995300259, 8094.757157285291, 6038.5169186465855, 6091.659834836329, 6167.259928808572, 6170.259568851767, 6192.349803270592, 6776.392053403536, 6805.319468053155, 6831.795046148623, 6871.244163141951, 6881.724731010703, 6307.117003619405, 6324.177856878577, 6341.0, 6400.903986440114, 6457.515686323451, 6285.622862628257, 6400.487960963019, 6446.9032964506505, 6475.384838440341, 6496.350364963466, 6184.5980011299125, 6245.437910588069, 6245.469135123565, 6246.219222597176, 6259.874802504016, 5912.0, 5913.2608423947, 5914.467697907037, 5920.223932820223, 5962.701864906824, 6047.365026672136, 6049.848753781191, 6137.324894261538, 6140.754369825336, 6147.815565533041], "unit": "score", "name": "mootools.html", "value": 4043.0848110154257}, {"lowerIsBetter": false, "replicates": [296.173675445507, 302.2654948475206, 305.77525518743727, 306.75306378365406, 307.58476057322605, 5536.307961504812, 5544.6673199608, 5657.632253903504, 5667.773289068432, 5668.57485688574, 5546.528545073674, 5547.25112109865, 5549.223108764766, 5554.666719996803, 5565.777368905239, 4144.564820693829, 4280.892977675568, 4286.185624731306, 4313.698041137121, 4315.654747620199, 4219.957800422003, 4237.322028475444, 4239.597238262376, 4243.448351714273, 4247.596478334569, 4175.0397408596045, 4181.874543763692, 4183.937240941388, 4184.0, 4187.225363307783, 4186.853460128896, 4196.643285320752, 4237.7669228192435, 4242.130363275521, 4243.618074373321, 3668.211334563082, 3673.8714145004797, 3675.4119340905327, 3681.245344704329, 3685.00504863688, 5281.498257665516, 5425.0, 5432.158015507603, 5432.565394768409, 5439.809606663787, 4869.586085182764, 4875.024995001014, 4876.853694389174, 4880.853574392774, 4883.0, 5841.620294680833, 5856.882862342729, 5903.055511118243, 5904.0, 5917.408259174092, 3981.880543583697, 3985.342418500944, 3988.561258261589, 3992.2215168042244, 3999.0402303447254, 5960.105984102376, 6096.634201947897, 6103.450689437972, 6166.321704612489, 6180.783672571439, 4056.716029877939, 4088.814243869245, 4088.8773336799945, 4093.5497095319492, 4095.5085389752826, 4155.293600087993, 4155.542890282127, 4157.3140431829015, 4157.854475093357, 4158.106007208465, 4816.036792641486, 4825.734584597881, 4828.830990915301, 4837.0, 4837.105135549864, 5714.771409143671, 5816.069428891357, 5855.912161317584, 5866.73599688015, 5888.205092312569, 1450.361840790049, 1459.8613131752466, 1462.656275775192, 1464.0044769556591, 1470.0958910270108, 965.9806803863884, 967.6564819489121, 972.1299437003984, 986.5264672956878, 987.1609132237684, 5120.92318615221, 5131.846044618667, 5137.948620513822, 5140.948590514122, 5145.4597267287145, 6017.796440711875, 6105.267367915879, 6122.602030868068, 6195.81412557624, 6201.565890387629, 5126.53861152498, 5148.485151484896, 5172.379314482287, 5174.456682048406, 5177.042247184283, 3301.125201821519, 3324.351751408452, 3324.484704870749, 3325.534425180477, 3331.0506505645776, 5671.829845104653, 5756.251687280626, 5772.336181339199, 5791.218185544982, 5791.652500849962, 6305.747770089145, 6342.334054924167, 6347.079673447324, 6358.650274234869, 6368.968155159195, 5791.681457519792, 5798.130280457881, 5806.187133801272, 5806.970965145148, 5810.5351571875, 6106.0, 6142.662153581417, 6158.414950579688, 6161.630302181883, 6163.907541386972, 5845.3570107289015, 6002.969985150046, 6006.729697163551, 6007.128966299774, 6028.4272994065495, 5782.450667186778, 5789.539445735461, 5791.478766910998, 5798.623089499169, 5798.652080875161, 4048.6356227939627, 4071.9389209161295, 4083.2037752637953, 4087.162131763041, 4094.754314741125, 5953.077273022515, 6133.969330153499, 6179.443850053517, 6186.566940314135, 6205.410486003822, 5913.29040515141, 5915.0, 5944.851378715567, 5959.553033522417, 5972.223610930551, 5931.851703707442, 5943.554233432596, 5944.524438045032, 5945.048792193228, 5945.702714864153, 5668.971655141698, 5730.398308177581, 5733.627314224729, 5791.218185544897, 5807.157962095557, 5996.850078748066, 6005.489533389536, 6009.819705408845, 6014.398560143951, 6017.3681763414215, 5752.0, 5795.76816927335, 5807.535397168132, 5836.182934389274, 5839.0], "unit": "score", "name": "prototype.html", "value": 4379.601038178059}, {"lowerIsBetter": false, "replicates": [718.3534818663205, 718.9496735228533, 722.349885103407, 722.6170129831191, 728.4427413029034, 10779.407132607703, 10927.617533386334, 10942.0, 10947.616833410832, 10969.616063437781, 9895.257855660819, 10878.401687907162, 10967.670969870896, 10981.780364392727, 11004.174686898494, 757.6779868555856, 762.8664983627843, 774.1832366852968, 774.9380049596019, 775.53080386366, 769.86142494351, 772.7758949904521, 773.4237992695449, 773.9883901741479, 774.8837674348864, 804.3163311185475, 811.9878201826948, 812.2486699802658, 815.4699445360504, 816.8325493273865, 788.8422315536858, 793.6230290611913, 796.2714116583348, 800.8398320335926, 802.4583406200791, 590.6633219065135, 591.5711109445617, 592.2123575644425, 592.5674257791836, 593.1221791748194, 11644.825327620092, 11675.708107297301, 11747.177697561174, 11781.11641626873, 11812.704682382922, 10890.673279801618, 10917.0, 10922.453877306103, 11206.271592346471, 11215.719607009809, 8712.912870871274, 8865.645374185026, 8932.776680582972, 9106.40808347462, 9204.769880752969, 2913.7377636012648, 2920.386718789057, 2967.3620171663197, 2987.5518672199128, 3024.4404785114602, 37691.246175076616, 38165.618343816765, 38370.616293837265, 40717.59282407197, 40958.0, 8907.821843563092, 8966.282697384193, 9030.051844556227, 9088.500132492776, 9123.77190570241, 15487.922560387125, 15653.452129175424, 15812.130332831575, 15885.920570397075, 15887.52337429879, 6056.6971651418135, 6171.722272497748, 6228.128062071313, 6272.372762723691, 6296.685165741695, 3567.3935430976794, 3590.6409359063887, 3621.9637803621627, 3659.9817000914827, 3669.7429397552014, 2700.2844246274753, 2725.0462338181874, 2732.1393760965234, 2733.876975536106, 2734.931626709348, 466.2889094131409, 473.2333619536373, 475.7169484156921, 485.65518481878263, 490.31600916720976, 507.16064912569755, 551.5780427972604, 561.0335773115205, 592.3720855892767, 600.4925837667164, 7253.0, 7501.212372700897, 7616.8476630467085, 7618.390528757686, 7678.884816727754, 486.4989061266901, 492.9507049295042, 585.1135529672549, 592.4608606168366, 611.736574673709, 3549.3256281306467, 3562.928741425157, 3594.2452085061905, 3749.6250374962287, 3810.809459527068, 50404.24393634099, 50451.495485045416, 50626.0, 50756.49243507592, 51572.74213628983, 44438.77780611076, 44677.55322446734, 44824.43114490977, 44884.77557612191, 45032.3245151323, 41107.0, 41415.58584414177, 41605.375919361235, 41766.79116604398, 42351.57648423538, 7461.030066091374, 7577.318041376303, 8117.878231826409, 8303.6678532858, 8347.85735331575, 30934.69065309318, 31273.843630782612, 31762.682373175972, 32027.0, 32204.83897580497, 38862.4170637435, 39446.0, 39656.60343396529, 39777.0, 39884.401733973435, 9805.362651427635, 9824.348939591822, 9827.459489727848, 10053.04496072872, 10323.0, 10883.727906802076, 11055.668329949793, 11113.666590002313, 11318.151138664469, 11859.05127589808, 10746.516406761559, 10943.945280273547, 11018.283811552223, 11034.117270618492, 11343.886561134283, 9909.306348555532, 9980.750481238027, 10036.548355323883, 10106.444145572064, 10387.68836934893, 10691.572337106429, 10703.090237329914, 10923.071538919281, 11253.943730281297, 11402.771944560896, 9159.450432974043, 9267.6292948284, 9311.953440233026, 9334.299927505328, 9457.527123643928, 8822.779430514289, 8992.505412202392, 9180.516441235946, 9290.0, 9412.388194767593], "unit": "score", "name": "yui.html", "value": 5627.641377243518}], "name": "dromaeo_css", "value": 6151.2046054032}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [119.0, 109.0, 113.0, 113.0, 114.0, 125.0, 112.0, 114.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [167.0, 133.0, 162.0, 174.0, 133.0, 154.0, 155.0, 150.0, 182.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 154.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 162.0, 160.0, 166.0, 167.0, 160.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 143.0, 73.0, 73.0, 72.0, 72.0, 154.0, 72.0], "unit": "score", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 132.0, 98.0, 99.0, 98.0, 137.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 101.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 72.0, 73.0, 71.0, 73.0, 72.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 86.0, 85.0, 86.0, 86.0, 86.0, 94.0, 95.0, 99.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.0}, {"lowerIsBetter": true, "replicates": [125.0, 118.0, 119.0, 130.0, 132.0, 128.0, 133.0, 123.0, 128.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [142.0, 149.0, 143.0, 149.0, 148.0, 139.0, 147.0, 148.0, 147.0, 168.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 70.0, 70.0, 72.0, 72.0, 69.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1559.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [188.07598269700958], "unit": "score", "name": "DeltaBlue", "value": 351.549406}, {"lowerIsBetter": false, "replicates": [277.0083102493075], "unit": "score", "name": "Encrypt", "value": 960.9134100000001}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [706.7137809187279], "unit": "score", "name": "Earley", "value": 943.0451449999999}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [28555.555555555555], "unit": "score", "name": "RegExp", "value": 31.90219844357977}, {"lowerIsBetter": false, "replicates": [599.5203836930456], "unit": "score", "name": "Splay", "value": 135.92698800000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21138.610505227793}]} 05:58:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21138.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1559.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6151.20"}}} 05:58:44 INFO - Return code: 0 05:58:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:44 INFO - # TBPL SUCCESS # 05:58:44 INFO - Running post-action listener: _resource_record_post_action 05:58:44 INFO - Running post-run listener: _resource_record_post_run 05:58:46 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10268672; Write bytes: 484282368; Read time: 2104; Write time: 413996 05:58:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 11964416; Read time: 0; Write time: 2064 05:58:46 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8507392; Write bytes: 472317952; Read time: 2056; Write time: 411932 05:58:46 INFO - Running post-run listener: _upload_blobber_files 05:58:46 INFO - Blob upload gear active. 05:58:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:47 INFO - (blobuploader) - INFO - Done attempting. 05:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:48 INFO - (blobuploader) - INFO - Done attempting. 05:58:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:48 INFO - Return code: 0 05:58:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89482a175515a8b5c74405cb33de7936c3bda1df7ff86a572a503cacb23a692f418c6020e80a58e0881a2c17e529ccd8cf50a6f29a2f5dbe8bd471ad050c9f38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42e51e98ccbd987fe503ac32ef9ae748e6ce3a7671a3b7e2c3012f611ed2875900f61a7591ecfd155df58b8e78a1e98a56d27d4dc16d976d3237f1371018c840"} 05:58:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:48 INFO - Contents: 05:58:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89482a175515a8b5c74405cb33de7936c3bda1df7ff86a572a503cacb23a692f418c6020e80a58e0881a2c17e529ccd8cf50a6f29a2f5dbe8bd471ad050c9f38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42e51e98ccbd987fe503ac32ef9ae748e6ce3a7671a3b7e2c3012f611ed2875900f61a7591ecfd155df58b8e78a1e98a56d27d4dc16d976d3237f1371018c840"} 05:58:48 INFO - Copying logs to upload dir... 05:58:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.561582 ========= master_lag: 0.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-26 05:58:48.452073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 05:58:48.459774) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 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/89482a175515a8b5c74405cb33de7936c3bda1df7ff86a572a503cacb23a692f418c6020e80a58e0881a2c17e529ccd8cf50a6f29a2f5dbe8bd471ad050c9f38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42e51e98ccbd987fe503ac32ef9ae748e6ce3a7671a3b7e2c3012f611ed2875900f61a7591ecfd155df58b8e78a1e98a56d27d4dc16d976d3237f1371018c840"} build_url:https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/sL2uWNQHQMytDmLbNRc6sQ/artifacts/public/build/firefox-46.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/89482a175515a8b5c74405cb33de7936c3bda1df7ff86a572a503cacb23a692f418c6020e80a58e0881a2c17e529ccd8cf50a6f29a2f5dbe8bd471ad050c9f38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42e51e98ccbd987fe503ac32ef9ae748e6ce3a7671a3b7e2c3012f611ed2875900f61a7591ecfd155df58b8e78a1e98a56d27d4dc16d976d3237f1371018c840"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 05:58:48.490451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:58:48.490884) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1451125287.114917-90783188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 05:58:48.546476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 05:58:48.546838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 05:58:48.547173) ========= ========= Total master_lag: 0.79 =========