builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1451996545.61 results: success (0) buildid: 20160105025940 builduid: 261a684aaaf843b9811a1c1a3aae878a revision: 29258f59e5456a1a518ccce6b473b50c1173477e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.610644) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.612235) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.612688) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.649971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.650337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.695824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.696129) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.754397) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.754701) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.755107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.755432) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 04:22:25-- 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% 43.7M=0s 2016-01-05 04:22:25 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.887686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.888060) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.938275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:25.938674) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29258f59e5456a1a518ccce6b473b50c1173477e --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 29258f59e5456a1a518ccce6b473b50c1173477e --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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 04:22:26,109 truncating revision to first 12 chars 2016-01-05 04:22:26,109 Setting DEBUG logging. 2016-01-05 04:22:26,109 attempt 1/10 2016-01-05 04:22:26,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29258f59e545?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 04:22:26,785 unpacking tar archive at: mozilla-central-29258f59e545/testing/mozharness/ program finished with exit code 0 elapsedTime=0.966732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:26.923200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:26.923556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:26.933259) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:26.933727) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 04:22:26.934373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-05 04:22:26.934801) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:27 INFO - MultiFileLogger online at 20160105 04:22:27 in /builds/slave/test 04:22:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:22:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:27 INFO - {'append_to_log': False, 04:22:27 INFO - 'base_work_dir': '/builds/slave/test', 04:22:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:27 INFO - 'branch': 'Firefox-Non-PGO', 04:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:27 INFO - 'config_files': ('talos/linux_config.py',), 04:22:27 INFO - 'default_actions': ('clobber', 04:22:27 INFO - 'read-buildbot-config', 04:22:27 INFO - 'download-and-extract', 04:22:27 INFO - 'populate-webroot', 04:22:27 INFO - 'create-virtualenv', 04:22:27 INFO - 'install', 04:22:27 INFO - 'run-tests'), 04:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:27 INFO - 'download_minidump_stackwalk': True, 04:22:27 INFO - 'download_symbols': 'ondemand', 04:22:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:27 INFO - 'installer_path': 'installer.exe', 04:22:27 INFO - 'log_level': 'info', 04:22:27 INFO - 'log_name': 'talos', 04:22:27 INFO - 'log_to_console': True, 04:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:27 INFO - 'opt_config_files': (), 04:22:27 INFO - 'pip_index': False, 04:22:27 INFO - 'sps_profile': False, 04:22:27 INFO - 'sps_profile_interval': 0, 04:22:27 INFO - 'suite': 'dromaeojs', 04:22:27 INFO - 'system_bits': '32', 04:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:27 INFO - 'title': 'talos-linux64-ix-036', 04:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:27 INFO - 'use_talos_json': True, 04:22:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:27 INFO - 'work_dir': 'build'} 04:22:27 INFO - ##### 04:22:27 INFO - ##### Running clobber step. 04:22:27 INFO - ##### 04:22:27 INFO - Running pre-action listener: _resource_record_pre_action 04:22:27 INFO - Running main action method: clobber 04:22:27 INFO - rmtree: /builds/slave/test/build 04:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:27 INFO - Running post-action listener: _resource_record_post_action 04:22:27 INFO - ##### 04:22:27 INFO - ##### Running read-buildbot-config step. 04:22:27 INFO - ##### 04:22:27 INFO - Running pre-action listener: _resource_record_pre_action 04:22:27 INFO - Running main action method: read_buildbot_config 04:22:27 INFO - Using buildbot properties: 04:22:27 INFO - { 04:22:27 INFO - "project": "", 04:22:27 INFO - "product": "firefox", 04:22:27 INFO - "script_repo_revision": "production", 04:22:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:22:27 INFO - "repository": "", 04:22:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:22:27 INFO - "buildid": "20160105025940", 04:22:27 INFO - "pgo_build": "False", 04:22:27 INFO - "basedir": "/builds/slave/test", 04:22:27 INFO - "buildnumber": 424, 04:22:27 INFO - "slavename": "talos-linux64-ix-036", 04:22:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:22:27 INFO - "platform": "ubuntu64_hw", 04:22:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:22:27 INFO - "branch": "mozilla-central", 04:22:27 INFO - "repo_path": "mozilla-central", 04:22:27 INFO - "revision": "29258f59e5456a1a518ccce6b473b50c1173477e", 04:22:27 INFO - "stage_platform": "linux64", 04:22:27 INFO - "builduid": "261a684aaaf843b9811a1c1a3aae878a", 04:22:27 INFO - "slavebuilddir": "test" 04:22:27 INFO - } 04:22:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:22:27 INFO - Running post-action listener: _resource_record_post_action 04:22:27 INFO - ##### 04:22:27 INFO - ##### Running download-and-extract step. 04:22:27 INFO - ##### 04:22:27 INFO - Running pre-action listener: _resource_record_pre_action 04:22:27 INFO - Running main action method: download_and_extract 04:22:27 INFO - mkdir: /builds/slave/test/build/tests 04:22:27 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')]} 04:22:27 INFO - https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/test_packages.json 04:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/test_packages.json 04:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:22:29 INFO - Downloaded 1302 bytes. 04:22:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:22:29 INFO - Using the following test package requirements: 04:22:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'jsshell-linux-x86_64.zip'], 04:22:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:29 INFO - https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:30 INFO - Downloaded 22783955 bytes. 04:22:30 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 04:22:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:30 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 04:22:31 INFO - Return code: 0 04:22:31 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 04:22: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')]} 04:22:31 INFO - https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:39 INFO - Downloaded 22783955 bytes. 04:22: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 04:22:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22: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 04:22:41 INFO - Return code: 0 04:22: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')]} 04:22:41 INFO - https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:42 INFO - Downloaded 11132285 bytes. 04:22: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 04:22:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22: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 04:22:42 INFO - Return code: 0 04:22: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')]} 04:22:42 INFO - https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOHdJ4XPRXC8rvcvKBmovg/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 04:22:43 INFO - Downloaded 53379959 bytes. 04:22:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:43 INFO - mkdir: /builds/slave/test/properties 04:22:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:43 INFO - Contents: 04:22:43 INFO - build_url:https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:43 INFO - Running post-action listener: _resource_record_post_action 04:22:43 INFO - Running post-action listener: set_extra_try_arguments 04:22:43 INFO - ##### 04:22:43 INFO - ##### Running populate-webroot step. 04:22:43 INFO - ##### 04:22:43 INFO - Running pre-action listener: _resource_record_pre_action 04:22:43 INFO - Running main action method: populate_webroot 04:22:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:43 INFO - '--tppagecycles', 04:22:43 INFO - '7'], 04:22:43 INFO - 'tests': ['tsvgm']}}, 04:22:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:22:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:22:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:22:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'tests': ['damp', 'tps']}, 04:22:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['damp', 'tps']}, 04:22:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:22:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:43 INFO - 'other': {'tests': ['a11yr', 04:22:43 INFO - 'ts_paint', 04:22:43 INFO - 'tpaint', 04:22:43 INFO - 'sessionrestore', 04:22:43 INFO - 'sessionrestore_no_auto_restore']}, 04:22:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['a11yr', 04:22:43 INFO - 'ts_paint', 04:22:43 INFO - 'tpaint', 04:22:43 INFO - 'sessionrestore', 04:22:43 INFO - 'sessionrestore_no_auto_restore']}, 04:22:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['a11yr', 04:22:43 INFO - 'ts_paint', 04:22:43 INFO - 'tpaint', 04:22:43 INFO - 'sessionrestore', 04:22:43 INFO - 'sessionrestore_no_auto_restore']}, 04:22:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['a11yr', 04:22:43 INFO - 'ts_paint', 04:22:43 INFO - 'tpaint', 04:22:43 INFO - 'sessionrestore', 04:22:43 INFO - 'sessionrestore_no_auto_restore']}, 04:22:43 INFO - 'other_l64': {'tests': ['a11yr', 04:22:43 INFO - 'ts_paint', 04:22:43 INFO - 'tpaint', 04:22:43 INFO - 'sessionrestore', 04:22:43 INFO - 'sessionrestore_no_auto_restore']}, 04:22:43 INFO - 'other_nol64': {'tests': ['a11yr', 04:22:43 INFO - 'ts_paint', 04:22:43 INFO - 'tpaint', 04:22:43 INFO - 'sessionrestore', 04:22:43 INFO - 'sessionrestore_no_auto_restore']}, 04:22:43 INFO - 'svgr': {'tests': ['tsvgx', 04:22:43 INFO - 'tsvgr_opacity', 04:22:43 INFO - 'tart', 04:22:43 INFO - 'tscrollx', 04:22:43 INFO - 'cart']}, 04:22:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['tsvgx', 04:22:43 INFO - 'tsvgr_opacity', 04:22:43 INFO - 'tart', 04:22:43 INFO - 'tscrollx', 04:22:43 INFO - 'cart']}, 04:22:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'tests': ['tp5o']}, 04:22:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'talos_options': ['--e10s'], 04:22:43 INFO - 'tests': ['tp5o']}, 04:22:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'talos_options': ['--xperf_path', 04:22:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:43 INFO - 'tests': ['tp5n']}, 04:22:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:43 INFO - 'talos_options': ['--e10s', 04:22:43 INFO - '--xperf_path', 04:22:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:43 INFO - 'tests': ['tp5n']}}, 04:22:43 INFO - 'talos.zip': {'path': '', 04:22:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:43 INFO - Running post-action listener: _resource_record_post_action 04:22:43 INFO - ##### 04:22:43 INFO - ##### Running create-virtualenv step. 04:22:43 INFO - ##### 04:22:43 INFO - Running pre-action listener: _resource_record_pre_action 04:22:43 INFO - Running main action method: create_virtualenv 04:22:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:22:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:43 INFO - Using real prefix '/usr' 04:22:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:46 INFO - Installing pip.................done. 04:22:46 INFO - Return code: 0 04:22:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:22:46 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 04:22:46 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 04:22:46 INFO - Using env: {'DISPLAY': ':0', 04:22:46 INFO - 'HOME': '/home/cltbld', 04:22:46 INFO - 'LANG': 'en_US.UTF-8', 04:22:46 INFO - 'LANGUAGE': 'en_US:en', 04:22:46 INFO - 'LOGNAME': 'cltbld', 04:22:46 INFO - 'MAIL': '/var/mail/cltbld', 04:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:46 INFO - 'MOZ_NO_REMOTE': '1', 04:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:46 INFO - 'NO_EM_RESTART': '1', 04:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:46 INFO - 'PWD': '/builds/slave/test', 04:22:46 INFO - 'SHELL': '/bin/bash', 04:22:46 INFO - 'SHLVL': '1', 04:22:46 INFO - 'TERM': 'linux', 04:22:46 INFO - 'TMOUT': '86400', 04:22:46 INFO - 'USER': 'cltbld', 04:22:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:46 INFO - '_': '/tools/buildbot/bin/python'} 04:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:22:46 INFO - Cleaning up... 04:22:46 INFO - Return code: 0 04:22:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:22:46 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 04:22:46 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 04:22:46 INFO - Using env: {'DISPLAY': ':0', 04:22:46 INFO - 'HOME': '/home/cltbld', 04:22:46 INFO - 'LANG': 'en_US.UTF-8', 04:22:46 INFO - 'LANGUAGE': 'en_US:en', 04:22:46 INFO - 'LOGNAME': 'cltbld', 04:22:46 INFO - 'MAIL': '/var/mail/cltbld', 04:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:46 INFO - 'MOZ_NO_REMOTE': '1', 04:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:46 INFO - 'NO_EM_RESTART': '1', 04:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:46 INFO - 'PWD': '/builds/slave/test', 04:22:46 INFO - 'SHELL': '/bin/bash', 04:22:46 INFO - 'SHLVL': '1', 04:22:46 INFO - 'TERM': 'linux', 04:22:46 INFO - 'TMOUT': '86400', 04:22:46 INFO - 'USER': 'cltbld', 04:22:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:46 INFO - '_': '/tools/buildbot/bin/python'} 04:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:46 INFO - Downloading/unpacking psutil>=0.7.1 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:48 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:22:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:48 INFO - Installing collected packages: psutil 04:22:48 INFO - Running setup.py install for psutil 04:22:48 INFO - building 'psutil._psutil_linux' extension 04:22:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:22:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:22:48 INFO - building 'psutil._psutil_posix' extension 04:22:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:22:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:48 INFO - Successfully installed psutil 04:22:48 INFO - Cleaning up... 04:22:49 INFO - Return code: 0 04:22:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:49 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:22:49 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 04:22:49 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 04:22:49 INFO - Using env: {'DISPLAY': ':0', 04:22:49 INFO - 'HOME': '/home/cltbld', 04:22:49 INFO - 'LANG': 'en_US.UTF-8', 04:22:49 INFO - 'LANGUAGE': 'en_US:en', 04:22:49 INFO - 'LOGNAME': 'cltbld', 04:22:49 INFO - 'MAIL': '/var/mail/cltbld', 04:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:49 INFO - 'MOZ_NO_REMOTE': '1', 04:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:49 INFO - 'NO_EM_RESTART': '1', 04:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:49 INFO - 'PWD': '/builds/slave/test', 04:22:49 INFO - 'SHELL': '/bin/bash', 04:22:49 INFO - 'SHLVL': '1', 04:22:49 INFO - 'TERM': 'linux', 04:22:49 INFO - 'TMOUT': '86400', 04:22:49 INFO - 'USER': 'cltbld', 04:22:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:49 INFO - '_': '/tools/buildbot/bin/python'} 04:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:22:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:22:50 INFO - Installing collected packages: mozsystemmonitor 04:22:50 INFO - Running setup.py install for mozsystemmonitor 04:22:51 INFO - Successfully installed mozsystemmonitor 04:22:51 INFO - Cleaning up... 04:22:51 INFO - Return code: 0 04:22:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22: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 blobuploader==1.2.4 04:22:51 INFO - Using env: {'DISPLAY': ':0', 04:22:51 INFO - 'HOME': '/home/cltbld', 04:22:51 INFO - 'LANG': 'en_US.UTF-8', 04:22:51 INFO - 'LANGUAGE': 'en_US:en', 04:22:51 INFO - 'LOGNAME': 'cltbld', 04:22:51 INFO - 'MAIL': '/var/mail/cltbld', 04:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:51 INFO - 'MOZ_NO_REMOTE': '1', 04:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:51 INFO - 'NO_EM_RESTART': '1', 04:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:51 INFO - 'PWD': '/builds/slave/test', 04:22:51 INFO - 'SHELL': '/bin/bash', 04:22:51 INFO - 'SHLVL': '1', 04:22:51 INFO - 'TERM': 'linux', 04:22:51 INFO - 'TMOUT': '86400', 04:22:51 INFO - 'USER': 'cltbld', 04:22:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:51 INFO - '_': '/tools/buildbot/bin/python'} 04:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:53 INFO - Downloading docopt-0.6.1.tar.gz 04:22:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:53 INFO - Running setup.py install for blobuploader 04:22:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:53 INFO - Running setup.py install for requests 04:22:54 INFO - Running setup.py install for docopt 04:22:54 INFO - Successfully installed blobuploader requests docopt 04:22:54 INFO - Cleaning up... 04:22:54 INFO - Return code: 0 04:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:54 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:22:54 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 04:22:54 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 04:22:54 INFO - Using env: {'DISPLAY': ':0', 04:22:54 INFO - 'HOME': '/home/cltbld', 04:22:54 INFO - 'LANG': 'en_US.UTF-8', 04:22:54 INFO - 'LANGUAGE': 'en_US:en', 04:22:54 INFO - 'LOGNAME': 'cltbld', 04:22:54 INFO - 'MAIL': '/var/mail/cltbld', 04:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:54 INFO - 'MOZ_NO_REMOTE': '1', 04:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:54 INFO - 'NO_EM_RESTART': '1', 04:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:54 INFO - 'PWD': '/builds/slave/test', 04:22:54 INFO - 'SHELL': '/bin/bash', 04:22:54 INFO - 'SHLVL': '1', 04:22:54 INFO - 'TERM': 'linux', 04:22:54 INFO - 'TMOUT': '86400', 04:22:54 INFO - 'USER': 'cltbld', 04:22:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:54 INFO - '_': '/tools/buildbot/bin/python'} 04:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:54 INFO - Running setup.py (path:/tmp/pip-6ssDw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:54 INFO - Running setup.py (path:/tmp/pip-kHbVjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:54 INFO - Running setup.py (path:/tmp/pip-kpcBPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:54 INFO - Running setup.py (path:/tmp/pip-24igPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:54 INFO - Running setup.py (path:/tmp/pip-paupLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:54 INFO - Running setup.py (path:/tmp/pip-HDNpMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:54 INFO - Running setup.py (path:/tmp/pip-7gawv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:55 INFO - Running setup.py (path:/tmp/pip-x5BeyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:55 INFO - Running setup.py (path:/tmp/pip-SsZNqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:55 INFO - Running setup.py (path:/tmp/pip-POCUsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:55 INFO - Running setup.py (path:/tmp/pip-mdUEMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:55 INFO - Running setup.py (path:/tmp/pip-eNC6YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:55 INFO - Running setup.py (path:/tmp/pip-fcPCDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:55 INFO - Running setup.py (path:/tmp/pip-LKW4GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:55 INFO - Running setup.py (path:/tmp/pip-SdBfEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:55 INFO - Running setup.py (path:/tmp/pip-0FT4rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:55 INFO - Running setup.py (path:/tmp/pip-8tPYk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:55 INFO - Running setup.py install for manifestparser 04:22:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:55 INFO - Running setup.py install for mozcrash 04:22:55 INFO - Running setup.py install for mozdebug 04:22:56 INFO - Running setup.py install for mozdevice 04:22:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Running setup.py install for mozfile 04:22:56 INFO - Running setup.py install for mozhttpd 04:22:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Running setup.py install for mozinfo 04:22:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Running setup.py install for mozInstall 04:22:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Running setup.py install for mozleak 04:22:56 INFO - Running setup.py install for mozlog 04:22:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Running setup.py install for moznetwork 04:22:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:56 INFO - Running setup.py install for mozprocess 04:22:56 INFO - Running setup.py install for mozprofile 04:22:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:57 INFO - Running setup.py install for mozrunner 04:22:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:57 INFO - Running setup.py install for mozscreenshot 04:22:57 INFO - Running setup.py install for moztest 04:22:57 INFO - Running setup.py install for mozversion 04:22:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:57 INFO - Cleaning up... 04:22:57 INFO - Return code: 0 04:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:57 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:22:57 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 04:22:57 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 04:22:57 INFO - Using env: {'DISPLAY': ':0', 04:22:57 INFO - 'HOME': '/home/cltbld', 04:22:57 INFO - 'LANG': 'en_US.UTF-8', 04:22:57 INFO - 'LANGUAGE': 'en_US:en', 04:22:57 INFO - 'LOGNAME': 'cltbld', 04:22:57 INFO - 'MAIL': '/var/mail/cltbld', 04:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:57 INFO - 'MOZ_NO_REMOTE': '1', 04:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:57 INFO - 'NO_EM_RESTART': '1', 04:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:57 INFO - 'PWD': '/builds/slave/test', 04:22:57 INFO - 'SHELL': '/bin/bash', 04:22:57 INFO - 'SHLVL': '1', 04:22:57 INFO - 'TERM': 'linux', 04:22:57 INFO - 'TMOUT': '86400', 04:22:57 INFO - 'USER': 'cltbld', 04:22:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:57 INFO - '_': '/tools/buildbot/bin/python'} 04:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:57 INFO - Running setup.py (path:/tmp/pip-Oy7ByD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:57 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)) 04:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:57 INFO - Running setup.py (path:/tmp/pip-mZ3RIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:57 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)) 04:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:57 INFO - Running setup.py (path:/tmp/pip-Nny7GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:57 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)) 04:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:57 INFO - Running setup.py (path:/tmp/pip-Zlv8nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:58 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)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:58 INFO - Running setup.py (path:/tmp/pip-jI9dez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:58 INFO - Running setup.py (path:/tmp/pip-oKao44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:58 INFO - Running setup.py (path:/tmp/pip-JH623J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:58 INFO - Running setup.py (path:/tmp/pip-vDNkCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:58 INFO - Running setup.py (path:/tmp/pip-HGlfFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:58 INFO - Running setup.py (path:/tmp/pip-uTGtRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:58 INFO - Running setup.py (path:/tmp/pip-ePZH4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:58 INFO - Running setup.py (path:/tmp/pip-35dq8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:58 INFO - Running setup.py (path:/tmp/pip-WjVHHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:58 INFO - Running setup.py (path:/tmp/pip-9qh9R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:58 INFO - Running setup.py (path:/tmp/pip-O4OPUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:58 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)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:58 INFO - Running setup.py (path:/tmp/pip-jmpYuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:58 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)) 04:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:58 INFO - Running setup.py (path:/tmp/pip-aJMMf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Downloading blessings-1.5.1.tar.gz 04:23:00 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 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:00 INFO - Installing collected packages: blessings 04:23:00 INFO - Running setup.py install for blessings 04:23:00 INFO - Successfully installed blessings 04:23:00 INFO - Cleaning up... 04:23:00 INFO - Return code: 0 04:23:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:01 INFO - Reading from file tmpfile_stdout 04:23:01 INFO - Current package versions: 04:23:01 INFO - argparse == 1.2.1 04:23:01 INFO - blessings == 1.5.1 04:23:01 INFO - blobuploader == 1.2.4 04:23:01 INFO - docopt == 0.6.1 04:23:01 INFO - manifestparser == 1.1 04:23:01 INFO - mozInstall == 1.12 04:23:01 INFO - mozcrash == 0.16 04:23:01 INFO - mozdebug == 0.1 04:23:01 INFO - mozdevice == 0.47 04:23:01 INFO - mozfile == 1.2 04:23:01 INFO - mozhttpd == 0.7 04:23:01 INFO - mozinfo == 0.9 04:23:01 INFO - mozleak == 0.1 04:23:01 INFO - mozlog == 3.1 04:23:01 INFO - moznetwork == 0.27 04:23:01 INFO - mozprocess == 0.22 04:23:01 INFO - mozprofile == 0.28 04:23:01 INFO - mozrunner == 6.11 04:23:01 INFO - mozscreenshot == 0.1 04:23:01 INFO - mozsystemmonitor == 0.0 04:23:01 INFO - moztest == 0.7 04:23:01 INFO - mozversion == 1.4 04:23:01 INFO - psutil == 3.1.1 04:23:01 INFO - requests == 1.2.3 04:23:01 INFO - wsgiref == 0.1.2 04:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:01 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:23:01 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 04:23:01 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 04:23:01 INFO - Using env: {'DISPLAY': ':0', 04:23:01 INFO - 'HOME': '/home/cltbld', 04:23:01 INFO - 'LANG': 'en_US.UTF-8', 04:23:01 INFO - 'LANGUAGE': 'en_US:en', 04:23:01 INFO - 'LOGNAME': 'cltbld', 04:23:01 INFO - 'MAIL': '/var/mail/cltbld', 04:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:01 INFO - 'MOZ_NO_REMOTE': '1', 04:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:01 INFO - 'NO_EM_RESTART': '1', 04:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:01 INFO - 'PWD': '/builds/slave/test', 04:23:01 INFO - 'SHELL': '/bin/bash', 04:23:01 INFO - 'SHLVL': '1', 04:23:01 INFO - 'TERM': 'linux', 04:23:01 INFO - 'TMOUT': '86400', 04:23:01 INFO - 'USER': 'cltbld', 04:23:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:01 INFO - '_': '/tools/buildbot/bin/python'} 04:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:01 INFO - Cleaning up... 04:23:01 INFO - Return code: 0 04:23:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:01 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 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:23:01 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 04:23:01 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 04:23:01 INFO - Using env: {'DISPLAY': ':0', 04:23:01 INFO - 'HOME': '/home/cltbld', 04:23:01 INFO - 'LANG': 'en_US.UTF-8', 04:23:01 INFO - 'LANGUAGE': 'en_US:en', 04:23:01 INFO - 'LOGNAME': 'cltbld', 04:23:01 INFO - 'MAIL': '/var/mail/cltbld', 04:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:01 INFO - 'MOZ_NO_REMOTE': '1', 04:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:01 INFO - 'NO_EM_RESTART': '1', 04:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:01 INFO - 'PWD': '/builds/slave/test', 04:23:01 INFO - 'SHELL': '/bin/bash', 04:23:01 INFO - 'SHLVL': '1', 04:23:01 INFO - 'TERM': 'linux', 04:23:01 INFO - 'TMOUT': '86400', 04:23:01 INFO - 'USER': 'cltbld', 04:23:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:01 INFO - '_': '/tools/buildbot/bin/python'} 04:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:01 INFO - Downloading/unpacking jsonschema 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:03 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 04:23:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:03 INFO - warning: no files found matching '*.txt' 04:23:03 INFO - no previously-included directories found matching 'build' 04:23:03 INFO - no previously-included directories found matching 'dist' 04:23:03 INFO - no previously-included directories found matching '.git*' 04:23:03 INFO - Installing collected packages: jsonschema, functools32 04:23:03 INFO - Running setup.py install for functools32 04:23:03 INFO - warning: no files found matching '*.txt' 04:23:03 INFO - no previously-included directories found matching 'build' 04:23:03 INFO - no previously-included directories found matching 'dist' 04:23:03 INFO - no previously-included directories found matching '.git*' 04:23:03 INFO - Successfully installed jsonschema functools32 04:23:03 INFO - Cleaning up... 04:23:03 INFO - Return code: 0 04:23:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34e03c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c5dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, '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': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', '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 04:23: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', 'flake8'] in /builds/slave/test/build 04:23: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 flake8 04:23:03 INFO - Using env: {'DISPLAY': ':0', 04:23:03 INFO - 'HOME': '/home/cltbld', 04:23:03 INFO - 'LANG': 'en_US.UTF-8', 04:23:03 INFO - 'LANGUAGE': 'en_US:en', 04:23:03 INFO - 'LOGNAME': 'cltbld', 04:23:03 INFO - 'MAIL': '/var/mail/cltbld', 04:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:03 INFO - 'MOZ_NO_REMOTE': '1', 04:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:03 INFO - 'NO_EM_RESTART': '1', 04:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:03 INFO - 'PWD': '/builds/slave/test', 04:23:03 INFO - 'SHELL': '/bin/bash', 04:23:03 INFO - 'SHLVL': '1', 04:23:03 INFO - 'TERM': 'linux', 04:23:03 INFO - 'TMOUT': '86400', 04:23:03 INFO - 'USER': 'cltbld', 04:23:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:03 INFO - '_': '/tools/buildbot/bin/python'} 04:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:03 INFO - Downloading/unpacking flake8 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:05 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 04:23:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:05 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 04:23:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:06 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 04:23:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:06 INFO - no previously-included directories found matching 'docs/_build' 04:23:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:06 INFO - Running setup.py install for pep8 04:23:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:06 INFO - no previously-included directories found matching 'docs/_build' 04:23:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:06 INFO - Cleaning up... 04:23:06 INFO - Return code: 0 04:23:06 INFO - Running post-action listener: _resource_record_post_action 04:23:06 INFO - Running post-action listener: _start_resource_monitoring 04:23:06 INFO - Starting resource monitoring. 04:23:06 INFO - ##### 04:23:06 INFO - ##### Running install step. 04:23:06 INFO - ##### 04:23:06 INFO - Running pre-action listener: _resource_record_pre_action 04:23:06 INFO - Running main action method: install 04:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:06 INFO - Reading from file tmpfile_stdout 04:23:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:06 INFO - Reading from file tmpfile_stdout 04:23:06 INFO - Output received: 04:23:06 INFO - Usage: mozinstall [options] installer 04:23:06 INFO - Options: 04:23:06 INFO - -h, --help show this help message and exit 04:23:06 INFO - -d DEST, --destination=DEST 04:23:06 INFO - Directory to install application into. [default: 04:23:06 INFO - "/builds/slave/test"] 04:23:06 INFO - --app=APP Application being installed. [default: firefox] 04:23:06 INFO - mkdir: /builds/slave/test/build/application 04:23:06 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'] 04:23:06 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 04:23:22 INFO - Reading from file tmpfile_stdout 04:23:22 INFO - Output received: 04:23:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:22 INFO - Running post-action listener: _resource_record_post_action 04:23:22 INFO - ##### 04:23:22 INFO - ##### Running run-tests step. 04:23:22 INFO - ##### 04:23:22 INFO - Running pre-action listener: _resource_record_pre_action 04:23:22 INFO - Running main action method: run_tests 04:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:22 INFO - Python 2.7.3 04:23:22 INFO - Return code: 0 04:23:22 INFO - grabbing minidump binary from tooltool 04:23:22 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')]} 04:23:22 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 0x24583d0>, '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 0x23c3ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c4360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:22 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 04:23:22 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 04:23:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:22 INFO - Return code: 0 04:23:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:23 INFO - Return code: 0 04:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:23:23 INFO - Using env: {'DISPLAY': ':0', 04:23:23 INFO - 'HOME': '/home/cltbld', 04:23:23 INFO - 'LANG': 'en_US.UTF-8', 04:23:23 INFO - 'LANGUAGE': 'en_US:en', 04:23:23 INFO - 'LOGNAME': 'cltbld', 04:23:23 INFO - 'MAIL': '/var/mail/cltbld', 04:23:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:23 INFO - 'MOZ_NO_REMOTE': '1', 04:23:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:23 INFO - 'NO_EM_RESTART': '1', 04:23:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:23 INFO - 'PWD': '/builds/slave/test', 04:23:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:23 INFO - 'SHELL': '/bin/bash', 04:23:23 INFO - 'SHLVL': '1', 04:23:23 INFO - 'TERM': 'linux', 04:23:23 INFO - 'TMOUT': '86400', 04:23:23 INFO - 'USER': 'cltbld', 04:23:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241', 04:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:23 INFO - '_': '/tools/buildbot/bin/python'} 04:23:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:23:23 INFO - mozversion application_buildid: 20160105025940 04:23:23 INFO - mozversion application_changeset: 29258f59e5456a1a518ccce6b473b50c1173477e 04:23:23 INFO - mozversion application_display_name: Nightly 04:23:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:23 INFO - mozversion application_name: Firefox 04:23:23 INFO - mozversion application_remotingname: firefox 04:23:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:23 INFO - mozversion application_vendor: Mozilla 04:23:23 INFO - mozversion application_version: 46.0a1 04:23:23 INFO - mozversion platform_buildid: 20160105025940 04:23:23 INFO - mozversion platform_changeset: 29258f59e5456a1a518ccce6b473b50c1173477e 04:23:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:23 INFO - mozversion platform_version: 46.0a1 04:23:23 INFO - using testdate: 1451996603 04:23:23 INFO - actual date: 1451996603 04:23:23 INFO - starting webserver on 'localhost:53387' 04:23:23 INFO - SUITE-START | Running 3 tests 04:23:23 INFO - TEST-START | dromaeo_css 04:23:23 INFO - operating with platform_type : linux_ 04:23:23 INFO - Initialising browser for dromaeo_css test... 04:23:23 INFO - TEST-INFO | started process 30059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjJY989/profile http://localhost:53387/getInfo.html) 04:23:28 INFO - PROCESS | 30059 | __metrics Screen width/height:1600/1200 04:23:28 INFO - PROCESS | 30059 | colorDepth:24 04:23:28 INFO - PROCESS | 30059 | Browser inner width/height: 1024/697 04:23:28 INFO - PROCESS | 30059 | __metrics 04:23:28 INFO - PROCESS | 30059 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:23:28 INFO - PROCESS | 30059 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:23:29 INFO - TEST-INFO | 30059: exit 0 04:23:29 INFO - Browser initialized. 04:23:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:29 INFO - TEST-INFO | started process 30152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjJY989/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:41 INFO - PROCESS | 30152 | RSS: Main: 149430272 04:23:41 INFO - PROCESS | 30152 | 04:24:32 INFO - PROCESS | 30152 | 1451996672467 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] 04:26:45 INFO - PROCESS | 30152 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53387/tests/dromaeo/cssquery-ext.html) 04:26:46 INFO - PROCESS | 30152 | RSS: Main: 234426368 04:26:46 INFO - PROCESS | 30152 | 04:29:49 INFO - PROCESS | 30152 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-ext.html (next: http://localhost:53387/tests/dromaeo/cssquery-jquery.html) 04:29:49 INFO - PROCESS | 30152 | RSS: Main: 232775680 04:29:49 INFO - PROCESS | 30152 | 04:32:51 INFO - PROCESS | 30152 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53387/tests/dromaeo/cssquery-mootools.html) 04:32:52 INFO - PROCESS | 30152 | RSS: Main: 233140224 04:32:52 INFO - PROCESS | 30152 | 04:35:54 INFO - PROCESS | 30152 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53387/tests/dromaeo/cssquery-prototype.html) 04:35:55 INFO - PROCESS | 30152 | RSS: Main: 214523904 04:35:55 INFO - PROCESS | 30152 | 04:38:57 INFO - PROCESS | 30152 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53387/tests/dromaeo/cssquery-yui.html) 04:38:58 INFO - PROCESS | 30152 | RSS: Main: 219795456 04:38:58 INFO - PROCESS | 30152 | 04:42:00 INFO - PROCESS | 30152 | Cycle 1(1): loaded http://localhost:53387/tests/dromaeo/cssquery-yui.html (next: http://localhost:53387/tests/dromaeo/cssquery-dojo.html) 04:42:01 INFO - PROCESS | 30152 | RSS: Main: 257441792 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | __start_tp_report 04:42:01 INFO - PROCESS | 30152 | _x_x_mozilla_page_load 04:42:01 INFO - PROCESS | 30152 | _x_x_mozilla_page_load_details 04:42:01 INFO - PROCESS | 30152 | |i|pagename|runs| 04:42:01 INFO - PROCESS | 30152 | |0;dojo.html;2587.9870600646996;2652.1247988163896;2669.079167687147;2674.4116294415235;2696.2046196372075;4437.600615944564;4568.177728008957;4601.240795268776;4609.539046095389;4612.031473390588;4591.035882464678;4634.791434385453;4669.789859456324;4681.227597446417;4763.595094416979;4026.697997650188;4140.275451795938;4182.226288136704;4214.641755450791;4284.935725964097;4244.236037513247;4289.957100428987;4308.482982042159;4315.180115777992;4349.521552629209;4121.567235440296;4153.958460415387;4216.9578304217175;4225.15496900618;4251.2347777400055;4213.115245798386;4216.198922204802;4250.872473825791;4264.765437900915;4283.614474697292;4198.748075115503;4228.281192197333;4251.213525497793;4275.294576394891;4303.870883873489;4427.53510881356;4523.457185137804;4534.841280555164;4556.088782243532;4567.497575266718;4879.8780030499165;4971.701697898137;4975.850724478271;5008.749562521859;5008.9499105008845;4936.703797772145;4942.851714448572;4944.728039957801;4949.381327334083;4985.252212168204;4405.823767049282;4600.194965880957;4602.056578401453;4617.37665415168;4640.559146881041;4977.701337919736;5013.974930125326;5059.924101138486;5179.922301165486;5186.377634683787;4869.513048695102;4872.610191184696;4873.171560834667;4873.707577545359;4913.041956818458;4950.9009819803405;4957.851264462072;4961.355023846949;4964.826231081895;4997.7251251180805;4733.408323959505;4793.688410253322;4847.903041939141;4854.514548545118;4953.702777833341;4884.8290309839695;4888.6577939543895;4898.14282500561;4923.212286034217;4931.013797240566;4101.774402407897;4125.133721918431;4129.359949207877;4138.627523522898;4169.624733773914;3538.7345949053924;3595.94606080909;3636.5272514573467;3640.4357324614725;3680.4479328100997;4293.5706429356815;4294.398784170218;4299.634531064895;4322.070754787673;4322.481302243688;4971.925421118686;4977.626677999092;4984.875378115504;5009.699418034929;5018.197088465828;4118.897027574335;4157.501099868035;4212.957870421256;4217.894552636209;4260.44614200152;4371.912561748811;4400.075984043323;4406.713563618418;4412.801423935931;4432.113577284556;4716.481187069419;4727.3145393917;4741.051789642016;4745.406824146981;4765.380500534909;4710.387649605529;4830.806767729392;4833.782479788489;4927.827526036572;4971.130052240771;4717.646176536705;4732.645051621073;4741;4756.619470442287;4772.0455908817685;4883.780229889592;4891.192953162688;4904.141775189256;4904.485029072039;4934.580560652241;4767.213409787346;4829.541193586604;4882.340883980759;4892.021595680807;4974.651774375759;4652.046330502307;4697.271922851964;4839.104765618372;4846.709197448165;4890.046440943982;4788.449328327287;4797.304390863375;4798.2082956311815;4798.424189097331;4855.320255164209;4569.1547063793305;4661.976690116528;4681.321208424827;4706.599939005086;4757.215059515142;4637.698549594265;4785.760711964457;4844.563989240985;4859.975700121477;4878.463369029333;4746.145693775154;4763.428388593391;4766.356541866804;4767.904641907212;4808.711477311373 04:42:01 INFO - PROCESS | 30152 | |1;ext.html;474.08265007211025;481.2925000249632;502.8466317773079;507.0012076209865;523.8035736598775;22047.889760551196;32356.514652280235;32555.51166732495;32594.67405325946;32720.181995450068;35570.82214588924;35950.460743088806;36024.459633105456;36068.2786344273;36135.81932090342;6606.768763093292;6701.128853249071;7644.808879778008;7823.569703666296;7830;9765.609375625001;9972.700818975442;9984.351017183895;9991.75020624483;10000.749981250454;9736.123748862601;9843.163331116864;9844.261680373966;9847.458389788559;9850.359726617782;6791.762288319935;6948.305169483062;6950.061741664912;6953.687084081178;9680.90319096807;9718.659846905324;9951.55218015191;9961.85057224135;9970.451625160613;9971.80056398868;33231.50152747711;33712.15719607029;33744.325113497835;33761.83119084413;33767.83116084428;2582.5996970469605;2636.973630263692;2727.1273192578383;2895.247235718707;3072.9078127656207;26069.739302606922;26211.213663590122;27002.324941876414;28352.432951341063;28477.430451390857;3345.3476572068457;3350.731941444703;3358.983205083983;3380.1975763306446;3407.9488807667904;159544;159570;159682;159756;160053;41248.79375603103;54977.1753423699;55276;55345.1698224527;55346;35386.64613353885;58056;58807.411925881046;58916;58918.70540647269;12306.81539776904;12581.937090314674;12589;12596.307203103734;12628.05289603265;9511.524423778921;9575.425474471414;9623.663171789094;9643.27675424346;9663.758406039906;18571.350002749838;18790.436286911416;18793.1543080559;18794.436166915013;18837.340693075676;6906.309369063053;7012.789616311519;7082.752103676449;7083.433325333961;7151.177614574391;759.4835511851883;863.6113748812934;949.4682977532603;1021.2442792333619;1045.1116550931647;26124.477510449684;26675.733242667713;27226.455470890472;28728.145697017084;29503.704962950524;933.5192375926404;942.9198518126036;990.6136606723384;1013.7364285285879;1054.2672842374477;13037.56586775454;13323;13345.399457024263;13364.30105811941;13468.730625387438;261024;264811;264926;267061;267131;43693;44638.33042504365;44708;44734.776326118816;44740.10519789586;1038.6676263595728;1087.4127970895786;1173.3898372846243;1180.5336891927811;1187.441902305915;21221.7877821226;21536.56926861423;22094.779052209273;22096.779032209473;22304;31719.524207137372;32243;32265.35469290648;32277.51583726199;32300.515492268103;207299;214828;326300;332048;332564;27774.305642358293;27872.88508459639;27923.860380697966;27977;27982.58026129569;34110;38556.614433855306;38653.226935461695;39313.60686393214;39419;31469;31561.36877262396;32507.512387314684;33034.83482582572;33128.33743325168;33459.83270083634;33516.832415837765;33650.32699346048;33698.49452258169;34042.31915361728;33888.322233554696;33968;34073.148171295914;34187.14532136716;34290.48564271588;29149;30246;30574.694253057183;30720.539191912587;30774.230644234074;23206.1877834275;23528.411789705395;23579.64630530509;23701.407464813517;23729.28812135639 04:42:01 INFO - PROCESS | 30152 | |2;jquery.html;317.1753441053263;317.4365501235307;324.16042450054357;325.5686215764113;327.95900512435946;11189.272697274671;11456.427178641075;14155.292235388228;14852.628684282898;15045;11929.642110736691;12363.938180309086;12367.814482782765;13609.591712248648;13631.591052268423;4833.202521583935;4835.1296766582;4954.851354459354;4956.306117143603;4957.702537847723;3600.3159399713973;3694.501242332291;4917.582005529534;5428.240046393488;5658.236138121362;5572.554195664337;5579.69311687857;5586.329640443152;5608.6073974821775;5609.439056094398;5566.081596536566;5940.52475801937;6208.099825525273;6209.192804935329;6210.13058171854;5833.533317334645;5964.940350596482;6273.905891411632;6280.560360774748;6300.527460440439;19288.32490862827;19307.324243651405;20300.18799248028;20840;20840.47898802527;1884.7078702801089;1924.5477312831474;1935.7483527141521;1947.7565304336958;2006.237629700719;12148.57479988205;12564.395255347696;13192;13461.865381346159;13802.723945521133;1748.8338607832236;1749.8512626426768;1801.189464740872;1849.8150184981528;1912.7895931447529;49168.75415622935;52717.47282527164;53783.19325210164;54474.72762636201;54485;14050.929745351412;14143.43426262938;14162.221077840612;14191.219482928538;14330.426782928775;21375.57248855014;21389;21411.571768564852;22030.88984555099;22570;8013.719519816778;8064.798380040428;8071.636776345079;8189.631466584018;8230.09468958414;6664.233613134552;6664.533482656265;6683.933160668428;6718.160229971254;6736.360045795642;7322.597257150908;7323;7379.262073792578;7403.777886663409;7412.147603025721;1680.2186983052939;1696.397778788537;1703.9659206815795;2061.6082944240547;2852.557853532706;803.9115697273412;806.6652339279134;823.7693445835175;825.5418242875141;839.0812060793421;14519.78220326696;14536.345864436125;14607.269636518131;14812.851871481364;14878.330475128645;778.6379333609899;805.1746959366579;810.4974915552395;823.7117009046906;846.272205902923;6492.640546162026;8761;8851.734447966572;8902.243309318781;9040.367174297868;448961;463522;468965;470723;474311;61434.38565614287;70810.64594676993;71941.28058719345;75605.62197189088;75608.62195688987;1003.4029752297372;1021.836506159011;1027.6197806811676;1035;1037.7613148975777;13839;13998.650033749238;14112.153270803785;14320.283985800459;14589.124652520883;28551;29057;30256.394872101995;30886.227844303172;32589.674103258665;34772.130696732784;34797.82601086979;35094.82452587721;35775.64224357723;35900.461493078146;8070.435069545076;8339.874901876356;8374.748757537283;8687.04442511336;8696.913030869864;14667.339969701176;15502.379904804133;15543;15562.533124006299;15756;12687.80968285495;12987.610371688865;13117.409716562968;13254.734905302033;13399.598012059654;12582.811257830957;12710.428030738454;12765.170263932814;13109.213447193199;13221.669458263621;13109.475620975054;13109.475620975436;13185.736285274432;13460;13513.324333783468;8536.530490823065;8542.658293668432;8553.401261911606;8937.06160853127;8962.507062111647;8996.86504702443;12666.936665316614;13095.279759613313;13363.1313964592;13665.453381865012 04:42:01 INFO - PROCESS | 30152 | |3;mootools.html;1046.001068979125;1295.656650987488;1297.8118172864931;1370.876621104101;1652.6529428819947;5573.526250268727;6469.223693156822;6516.055172000057;6550.410463058324;6580.374864387882;6450.387213214749;6637.469002479802;6649.168853893263;6651.800445986616;6654.73381064758;1964.9901750491229;2005.418428655688;2008.4476768888526;2009.1260301768705;2009.9196032158695;1951.9512012199666;1984.394759598329;1990.4327266728985;1991.8107779760899;2014.6272939506166;1964.8428125749977;1990.3531352310486;2019.868708533948;2021;2021.1713197588992;1962.3622322745093;1986.02684684505;1986.5530255692497;1986.8112529309692;1987.9701804472945;1968.0651690447066;1998.800119988004;2006.3379084901946;2008.839292856568;2011.8491113166424;6646.435053020499;6720.66396680169;6721.227058888193;6738.629375384352;6743.797686069426;3750.6624403803517;3829.5213098362706;3835.405512145594;3838.5777564467885;3843.1737176507186;2412.8311018228733;2462.482878595497;2462.7660372264604;2469.5060987802512;2570.3574106473384;761.6686741267566;766.7239793674273;774.3185996323256;777.1606664802057;778.1129512355918;8989.865152022725;8996.685116020908;9007.324450666227;9015.504147271897;9044.276457883354;3477.9304413912087;3498.0904964709357;3518.964810351915;3541.415666415064;3546.042568506489;7753.883691744629;7777.922220777833;7793.766187014398;7805.492642978188;7845.862349959338;3790.7346485746284;3796.088938654703;3797.1266608680157;3797.5632802227547;3811.866584669523;2899.0288253434915;2945.3520225550346;3380.3408335374857;3493.12671832042;3496.42309019009;3210.3900258950725;3240.3681282149755;3269.4278501262183;3284.7700660953983;3293.818839963777;995.9452230127267;1019.7246743379246;1022.6216299969059;1057.476549108181;1060.2154405739698;873.5894129759004;931.8043210925646;1109.4619109731773;1120.9327440353604;1121.4841173060483;6314.179156709598;6406.071119687619;6412.583182093149;6441;6470.288268290485;962.3119469579144;972.2610815779917;981.9018098190267;989.475577943691;989.9604015839429;4585.426821647294;4654.138984287918;4661.207594708908;4672.392588963481;4676.50896655853;7916.287534121957;8000.8799868002025;8129.390295727844;8208.917910820936;8219.342452603778;8037;8037.7588672339925;8130.268275855202;8133.2680058794995;8135.918640813635;6098.207233059674;6221.222347206599;6261.68691565429;6388.616682999035;6412.070249813751;6248.094026366242;6269.68651567429;6284.717187726655;6343;6343.460805831556;7038.40173585251;7123.074000379917;7201.927980720126;7248.275172482709;7355.8161045974275;7272.927270727437;7418;7441.330280274801;7453.850922981618;7553.848923021619;5018.172001619692;5127.384713834214;5886.293644762656;6003.249593800775;6078.878422431615;6019.097135429721;6037.09443583466;6041.791641671771;6064.029755239317;6096.786612468542;5701.914471283017;5759.71201439918;5764.798232061858;5835.912461312999;5844.444777746107;5571.331440227199;5624.240727501735;5628.324601047737;5643.71781410936;5724.084146536534;5887.52899768009;5897.321807992136;5933.703314834154;5963.7912673056235;6049.122877182872;5410.431904649955;5427.077396842467;5446.400895901368;5446.727663616724;5448.673079615236;5599.468050535193;5630.8029218977135;5634.887302254014;5642.887142257214;5644.88710225785 04:42:01 INFO - PROCESS | 30152 | |4;prototype.html;285.7642444982889;291.31104936824414;292.2722421171284;294.8849948520079;295.787033335998;5314.256004159421;5383.031054410205;5414.485623865731;5420.295361602996;5539.750711217995;5337.653052551582;5377.354717433904;5395.7032363220005;5402.162664786954;5413.242146099549;4112.6709863210945;4116.094459218967;4118.4028315894175;4120.114175452277;4130.277201489742;3866.516685414323;3959.4654721612646;3969.364901615742;3975.662068724162;4059.451973983504;4009.2983727847654;4015.678745700337;4018.63832255097;4019.819108140126;4022.798860057;3999.280129576675;4006.5392479864895;4008.839646414125;4014.0165659413337;4016.7790771507557;3304.306095719902;3371.9157021074425;3379.8817041403677;3381.070205693429;3386.5936087669393;4991.176455884811;5024.698518088926;5143.639945203838;5169;5205.843824685266;4648.651351148677;4651.813927442899;4655.534446555317;4657.743824089674;4658.254679251304;5623.297087864017;5627.184058311563;5628.099504079328;5634.943650563483;5643.6049476536655;3683.2633473305445;3804.2011177652726;3804.6766024887916;3805.6574908258112;3808.2383523295175;5774.769009239625;5884.705764711747;5898.115282707586;5900.468957793819;5900.557458190653;3967.6429121379215;3974.264761019163;3974.682025437958;3978.0850404407147;3980.86066987654;4034.1931613677384;4042.4744783178;4044.1507283470214;4046.8988275293354;4048.332025215865;4446.3108218226225;4591.977040114778;4612.584867361954;4653.278741795028;4653.790579423934;5602.13166959122;5603.3836278009385;5606.943930560724;5609.943900560942;5612.07400778875;1383.522684673786;1405.3886559346513;1406.7678832992442;1420.6448387903024;1421.722764060998;932.7668082979255;939.182910867536;940.948247846375;944.8015916657579;945.0738276489079;4949.133901567211;4955.331030310934;4965.255211718271;4966.230234313687;4969.82605608802;5834.387389324144;5835.854103647443;5840.2115714378015;5849.853753656107;5850.970745146332;4940.925886111711;4958.9008219835405;4960.950390496121;4965.3048573199785;4968.527989840959;3043.3761078978755;3095.674954129829;3142.308692087737;3144.3554071415306;3146.8741250350186;5312.867178320573;5371.194320851825;5493.527912439418;5526.613137080446;5575.860603484864;6007.3992600739575;6024.096385542204;6029.8191054268445;6032.426919442733;6040.244969378828;5511.917321240185;5552.139418390156;5554.527865131347;5558.055130627803;5561.054620714488;5660.575456840836;5841.415858414294;5859.648421094748;5876.647401155944;5879.676617785892;5691.800786972436;5693.8291851242875;5694;5701.258836351248;5771.884562308815;5571.275734154534;5576.052071147834;5579.218909352613;5581.888362232651;5596.496315331639;4059.4316795649224;4112.074783173762;4112.753234805921;4114.629683328515;4117.97941010293;5671.43285671446;5835.183074369506;5890;5893.292804863272;5895.970520147372;5577.107662773937;5600.8879822402505;5611.074172761449;5614.606977511535;5615.859603509945;5601.271834661468;5603.74783134768;5611.158326251095;5612.130119831432;5619.494245517923;5379.892402152013;5448;5490.3411590609385;5499.340079190522;5501.477359650827;5603.299587551556;5616.915746263728;5632.408597097246;5645.830625081254;5651.350094739158;5497.945020549743;5501.5323697486165;5506.5870059746485;5539.307586551681;5568.359638641446 04:42:01 INFO - PROCESS | 30152 | |5;yui.html;635.4757325206706;650.0866282872565;692.4702602509082;694.8262934266432;711.4912837321316;8788.209061184492;8906.51014194219;8935.240504557105;8937.50843703596;8945.418547794388;8887.155720206587;8970.3272254581;8985.056569060253;8999.325050621213;9022.593983270752;414.0931360320903;415.1240881739527;419.56994081066847;736.120336198242;753.8266198774285;493.3512431153022;496.1119595923311;500.20966872341796;727.3562896836312;748.8726916424221;786.7679034684753;787.1459466478877;792.7978365516785;793.0364607002491;793.2305663506389;783;783.1502819440914;783.4320117914494;783.8118851475662;783.9725609603665;351.67470090166495;355.95728512578654;564.0946281218626;575.7437940116649;576.4034224577542;8569.785755356104;8613.569321533962;8635.481871087755;8647.221750042527;8659.004214515347;10097;10429;10667.306625069423;10778.29941053829;10802.67591972242;7828.452008359417;8015.398845086642;8042.477238979448;8101.189881011852;8104.5542495162745;2595.377109493727;2608.1393140263667;2645.933851653705;2646.4971655385607;2673.679158500973;37911.431328530096;39056.21887562261;39080.60919390827;39132.41301380481;39160.41259381112;8177.836443271221;8218.917810821815;8235.95882020586;8262.793430164294;8316.542590157478;14212.21832799206;14237.78643320351;14245.430182792572;14254.144751314747;14262.072965257224;5520.392756796749;5750.88498230033;6018.307894592178;6092.664903430265;6166.753329866755;3387.6951074402928;3391.0844072100394;3403.7957722536726;3443.2941247044296;3471.687548120681;2616.7383261674063;2684.973150268472;2689.5562232231855;2692.6095716121054;2694.609281654188;457.51274892239655;469.59614731331027;470.6470147389458;472.11242863416555;474.1252389341728;395.4444006171334;409.1285561753446;414.82162670051565;416.6978940268281;425.73604365293716;6388.584741991755;6606.801795946033;6681.797276490279;6736.730530778812;6849.589024658537;417.8015442664771;435.83002628974725;453.3607613265346;462.69693350855243;468.4378745505407;3070.3398769264268;3140.262038420969;3146.889858854975;3250.723688486505;3293.2919422324317;48693;48707.512924870294;48737;48871.511284887405;49060;40982;40989.18021639551;43724.78137609355;43993.34009989853;44322.55677443249;42427.1514569713;42655;42842.571574284484;43842.780786095864;43870.122597547874;7169.713211471482;7274.199838017919;7520.699172033057;7649.464537482323;7839.647215875413;29124.854375727984;29456.263593410335;30948.381032379675;31189.220269493446;31218.375632487678;37173.814130929175;37377.62622373742;37614.435783463814;37841.24317513689;38395.23209535738;8948.060453652533;9676.9032309676;9696.030396960248;9846.852182741923;9878.802423951625;10266;10350.637727679496;10381.065704086668;10387.428691422045;10396.324238924446;9371.250299975849;9663.9033609663;9779.608815647294;9830.967748386316;9836.803263934538;9220.631174753204;9373.25013998892;9481.146696797321;9504;9624;9581.233501320017;9757.80484390294;9779.168770654574;9786.902130978599;9800.264980126662;8176.550289733884;8412.71187709239;8470.534120623424;8581.184787445183;8751.606177722146;8011.158828323175;8075.475094118863;8382.16178382157;8419.200175983271;8564.400491965502 04:42:01 INFO - PROCESS | 30152 | __end_tp_report 04:42:01 INFO - PROCESS | 30152 | __start_cc_report 04:42:01 INFO - PROCESS | 30152 | _x_x_mozilla_cycle_collect,921 04:42:01 INFO - PROCESS | 30152 | __end_cc_report 04:42:01 INFO - PROCESS | 30152 | __startTimestamp1451997721083__endTimestamp 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | ------- Summary: start ------- 04:42:01 INFO - PROCESS | 30152 | Number of tests: 6 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | [#0] dojo.html Cycles:165 Average:4555.73 Median:4716.48 stddev:475.16 (10.1%) stddev-sans-first:450.85 04:42:01 INFO - PROCESS | 30152 | Values: 2588.0 2652.1 2669.1 2674.4 2696.2 4437.6 4568.2 4601.2 4609.5 4612.0 4591.0 4634.8 4669.8 4681.2 4763.6 4026.7 4140.3 4182.2 4214.6 4284.9 4244.2 4290.0 4308.5 4315.2 4349.5 4121.6 4154.0 4217.0 4225.2 4251.2 4213.1 4216.2 4250.9 4264.8 4283.6 4198.7 4228.3 4251.2 4275.3 4303.9 4427.5 4523.5 4534.8 4556.1 4567.5 4879.9 4971.7 4975.9 5008.7 5008.9 4936.7 4942.9 4944.7 4949.4 4985.3 4405.8 4600.2 4602.1 4617.4 4640.6 4977.7 5014.0 5059.9 5179.9 5186.4 4869.5 4872.6 4873.2 4873.7 4913.0 4950.9 4957.9 4961.4 4964.8 4997.7 4733.4 4793.7 4847.9 4854.5 4953.7 4884.8 4888.7 4898.1 4923.2 4931.0 4101.8 4125.1 4129.4 4138.6 4169.6 3538.7 3595.9 3636.5 3640.4 3680.4 4293.6 4294.4 4299.6 4322.1 4322.5 4971.9 4977.6 4984.9 5009.7 5018.2 4118.9 4157.5 4213.0 4217.9 4260.4 4371.9 4400.1 4406.7 4412.8 4432.1 4716.5 4727.3 4741.1 4745.4 4765.4 4710.4 4830.8 4833.8 4927.8 4971.1 4717.6 4732.6 4741.0 4756.6 4772.0 4883.8 4891.2 4904.1 4904.5 4934.6 4767.2 4829.5 4882.3 4892.0 4974.7 4652.0 4697.3 4839.1 4846.7 4890.0 4788.4 4797.3 4798.2 4798.4 4855.3 4569.2 4662.0 4681.3 4706.6 4757.2 4637.7 4785.8 4844.6 4860.0 4878.5 4746.1 4763.4 4766.4 4767.9 4808.7 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | [#1] ext.html Cycles:180 Average:38958.02 Median:167954.67 stddev:64044.61 (38.1%) stddev-sans-first:64159.09 04:42:01 INFO - PROCESS | 30152 | Values: 474.1 481.3 502.8 507.0 523.8 22047.9 32356.5 32555.5 32594.7 32720.2 35570.8 35950.5 36024.5 36068.3 36135.8 6606.8 6701.1 7644.8 7823.6 7830.0 9765.6 9972.7 9984.4 9991.8 10000.7 9736.1 9843.2 9844.3 9847.5 9850.4 6791.8 6948.3 6950.1 6953.7 9680.9 9718.7 9951.6 9961.9 9970.5 9971.8 33231.5 33712.2 33744.3 33761.8 33767.8 2582.6 2637.0 2727.1 2895.2 3072.9 26069.7 26211.2 27002.3 28352.4 28477.4 3345.3 3350.7 3359.0 3380.2 3407.9 159544.0 159570.0 159682.0 159756.0 160053.0 41248.8 54977.2 55276.0 55345.2 55346.0 35386.6 58056.0 58807.4 58916.0 58918.7 12306.8 12581.9 12589.0 12596.3 12628.1 9511.5 9575.4 9623.7 9643.3 9663.8 18571.4 18790.4 18793.2 18794.4 18837.3 6906.3 7012.8 7082.8 7083.4 7151.2 759.5 863.6 949.5 1021.2 1045.1 26124.5 26675.7 27226.5 28728.1 29503.7 933.5 942.9 990.6 1013.7 1054.3 13037.6 13323.0 13345.4 13364.3 13468.7 261024.0 264811.0 264926.0 267061.0 267131.0 43693.0 44638.3 44708.0 44734.8 44740.1 1038.7 1087.4 1173.4 1180.5 1187.4 21221.8 21536.6 22094.8 22096.8 22304.0 31719.5 32243.0 32265.4 32277.5 32300.5 207299.0 214828.0 326300.0 332048.0 332564.0 27774.3 27872.9 27923.9 27977.0 27982.6 34110.0 38556.6 38653.2 39313.6 39419.0 31469.0 31561.4 32507.5 33034.8 33128.3 33459.8 33516.8 33650.3 33698.5 34042.3 33888.3 33968.0 34073.1 34187.1 34290.5 29149.0 30246.0 30574.7 30720.5 30774.2 23206.2 23528.4 23579.6 23701.4 23729.3 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | [#2] jquery.html Cycles:180 Average:25823.93 Median:324.86 stddev:75872.07 (23355.0%) stddev-sans-first:76060.74 04:42:01 INFO - PROCESS | 30152 | Values: 317.2 317.4 324.2 325.6 328.0 11189.3 11456.4 14155.3 14852.6 15045.0 11929.6 12363.9 12367.8 13609.6 13631.6 4833.2 4835.1 4954.9 4956.3 4957.7 3600.3 3694.5 4917.6 5428.2 5658.2 5572.6 5579.7 5586.3 5608.6 5609.4 5566.1 5940.5 6208.1 6209.2 6210.1 5833.5 5964.9 6273.9 6280.6 6300.5 19288.3 19307.3 20300.2 20840.0 20840.5 1884.7 1924.5 1935.7 1947.8 2006.2 12148.6 12564.4 13192.0 13461.9 13802.7 1748.8 1749.9 1801.2 1849.8 1912.8 49168.8 52717.5 53783.2 54474.7 54485.0 14050.9 14143.4 14162.2 14191.2 14330.4 21375.6 21389.0 21411.6 22030.9 22570.0 8013.7 8064.8 8071.6 8189.6 8230.1 6664.2 6664.5 6683.9 6718.2 6736.4 7322.6 7323.0 7379.3 7403.8 7412.1 1680.2 1696.4 1704.0 2061.6 2852.6 803.9 806.7 823.8 825.5 839.1 14519.8 14536.3 14607.3 14812.9 14878.3 778.6 805.2 810.5 823.7 846.3 6492.6 8761.0 8851.7 8902.2 9040.4 448961.0 463522.0 468965.0 470723.0 474311.0 61434.4 70810.6 71941.3 75605.6 75608.6 1003.4 1021.8 1027.6 1035.0 1037.8 13839.0 13998.7 14112.2 14320.3 14589.1 28551.0 29057.0 30256.4 30886.2 32589.7 34772.1 34797.8 35094.8 35775.6 35900.5 8070.4 8339.9 8374.7 8687.0 8696.9 14667.3 15502.4 15543.0 15562.5 15756.0 12687.8 12987.6 13117.4 13254.7 13399.6 12582.8 12710.4 12765.2 13109.2 13221.7 13109.5 13109.5 13185.7 13460.0 13513.3 8536.5 8542.7 8553.4 8937.1 8962.5 8996.9 12666.9 13095.3 13363.1 13665.5 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | [#3] mootools.html Cycles:180 Average:4617.98 Median:5741.90 stddev:2407.50 (41.9%) stddev-sans-first:2399.28 04:42:01 INFO - PROCESS | 30152 | Values: 1046.0 1295.7 1297.8 1370.9 1652.7 5573.5 6469.2 6516.1 6550.4 6580.4 6450.4 6637.5 6649.2 6651.8 6654.7 1965.0 2005.4 2008.4 2009.1 2009.9 1952.0 1984.4 1990.4 1991.8 2014.6 1964.8 1990.4 2019.9 2021.0 2021.2 1962.4 1986.0 1986.6 1986.8 1988.0 1968.1 1998.8 2006.3 2008.8 2011.8 6646.4 6720.7 6721.2 6738.6 6743.8 3750.7 3829.5 3835.4 3838.6 3843.2 2412.8 2462.5 2462.8 2469.5 2570.4 761.7 766.7 774.3 777.2 778.1 8989.9 8996.7 9007.3 9015.5 9044.3 3477.9 3498.1 3519.0 3541.4 3546.0 7753.9 7777.9 7793.8 7805.5 7845.9 3790.7 3796.1 3797.1 3797.6 3811.9 2899.0 2945.4 3380.3 3493.1 3496.4 3210.4 3240.4 3269.4 3284.8 3293.8 995.9 1019.7 1022.6 1057.5 1060.2 873.6 931.8 1109.5 1120.9 1121.5 6314.2 6406.1 6412.6 6441.0 6470.3 962.3 972.3 981.9 989.5 990.0 4585.4 4654.1 4661.2 4672.4 4676.5 7916.3 8000.9 8129.4 8208.9 8219.3 8037.0 8037.8 8130.3 8133.3 8135.9 6098.2 6221.2 6261.7 6388.6 6412.1 6248.1 6269.7 6284.7 6343.0 6343.5 7038.4 7123.1 7201.9 7248.3 7355.8 7272.9 7418.0 7441.3 7453.9 7553.8 5018.2 5127.4 5886.3 6003.2 6078.9 6019.1 6037.1 6041.8 6064.0 6096.8 5701.9 5759.7 5764.8 5835.9 5844.4 5571.3 5624.2 5628.3 5643.7 5724.1 5887.5 5897.3 5933.7 5963.8 6049.1 5410.4 5427.1 5446.4 5446.7 5448.7 5599.5 5630.8 5634.9 5642.9 5644.9 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | [#4] prototype.html Cycles:180 Average:4638.10 Median:5381.46 stddev:1392.65 (25.9%) stddev-sans-first:1357.70 04:42:01 INFO - PROCESS | 30152 | Values: 285.8 291.3 292.3 294.9 295.8 5314.3 5383.0 5414.5 5420.3 5539.8 5337.7 5377.4 5395.7 5402.2 5413.2 4112.7 4116.1 4118.4 4120.1 4130.3 3866.5 3959.5 3969.4 3975.7 4059.5 4009.3 4015.7 4018.6 4019.8 4022.8 3999.3 4006.5 4008.8 4014.0 4016.8 3304.3 3371.9 3379.9 3381.1 3386.6 4991.2 5024.7 5143.6 5169.0 5205.8 4648.7 4651.8 4655.5 4657.7 4658.3 5623.3 5627.2 5628.1 5634.9 5643.6 3683.3 3804.2 3804.7 3805.7 3808.2 5774.8 5884.7 5898.1 5900.5 5900.6 3967.6 3974.3 3974.7 3978.1 3980.9 4034.2 4042.5 4044.2 4046.9 4048.3 4446.3 4592.0 4612.6 4653.3 4653.8 5602.1 5603.4 5606.9 5609.9 5612.1 1383.5 1405.4 1406.8 1420.6 1421.7 932.8 939.2 940.9 944.8 945.1 4949.1 4955.3 4965.3 4966.2 4969.8 5834.4 5835.9 5840.2 5849.9 5851.0 4940.9 4958.9 4961.0 4965.3 4968.5 3043.4 3095.7 3142.3 3144.4 3146.9 5312.9 5371.2 5493.5 5526.6 5575.9 6007.4 6024.1 6029.8 6032.4 6040.2 5511.9 5552.1 5554.5 5558.1 5561.1 5660.6 5841.4 5859.6 5876.6 5879.7 5691.8 5693.8 5694.0 5701.3 5771.9 5571.3 5576.1 5579.2 5581.9 5596.5 4059.4 4112.1 4112.8 4114.6 4118.0 5671.4 5835.2 5890.0 5893.3 5896.0 5577.1 5600.9 5611.1 5614.6 5615.9 5601.3 5603.7 5611.2 5612.1 5619.5 5379.9 5448.0 5490.3 5499.3 5501.5 5603.3 5616.9 5632.4 5645.8 5651.4 5497.9 5501.5 5506.6 5539.3 5568.4 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - PROCESS | 30152 | [#5] yui.html Cycles:180 Average:11444.98 Median:3163.31 stddev:13670.99 (432.2%) stddev-sans-first:13685.24 04:42:01 INFO - PROCESS | 30152 | Values: 635.5 650.1 692.5 694.8 711.5 8788.2 8906.5 8935.2 8937.5 8945.4 8887.2 8970.3 8985.1 8999.3 9022.6 414.1 415.1 419.6 736.1 753.8 493.4 496.1 500.2 727.4 748.9 786.8 787.1 792.8 793.0 793.2 783.0 783.2 783.4 783.8 784.0 351.7 356.0 564.1 575.7 576.4 8569.8 8613.6 8635.5 8647.2 8659.0 10097.0 10429.0 10667.3 10778.3 10802.7 7828.5 8015.4 8042.5 8101.2 8104.6 2595.4 2608.1 2645.9 2646.5 2673.7 37911.4 39056.2 39080.6 39132.4 39160.4 8177.8 8218.9 8236.0 8262.8 8316.5 14212.2 14237.8 14245.4 14254.1 14262.1 5520.4 5750.9 6018.3 6092.7 6166.8 3387.7 3391.1 3403.8 3443.3 3471.7 2616.7 2685.0 2689.6 2692.6 2694.6 457.5 469.6 470.6 472.1 474.1 395.4 409.1 414.8 416.7 425.7 6388.6 6606.8 6681.8 6736.7 6849.6 417.8 435.8 453.4 462.7 468.4 3070.3 3140.3 3146.9 3250.7 3293.3 48693.0 48707.5 48737.0 48871.5 49060.0 40982.0 40989.2 43724.8 43993.3 44322.6 42427.2 42655.0 42842.6 43842.8 43870.1 7169.7 7274.2 7520.7 7649.5 7839.6 29124.9 29456.3 30948.4 31189.2 31218.4 37173.8 37377.6 37614.4 37841.2 38395.2 8948.1 9676.9 9696.0 9846.9 9878.8 10266.0 10350.6 10381.1 10387.4 10396.3 9371.3 9663.9 9779.6 9831.0 9836.8 9220.6 9373.3 9481.1 9504.0 9624.0 9581.2 9757.8 9779.2 9786.9 9800.3 8176.6 8412.7 8470.5 8581.2 8751.6 8011.2 8075.5 8382.2 8419.2 8564.4 04:42:01 INFO - PROCESS | 30152 | -------- Summary: end -------- 04:42:01 INFO - PROCESS | 30152 | 04:42:01 INFO - TEST-INFO | 30152: exit 0 04:42:01 INFO - TEST-OK | dromaeo_css | took 1118209ms 04:42:01 INFO - TEST-START | kraken 04:42:01 INFO - operating with platform_type : linux_ 04:42:01 INFO - Initialising browser for kraken test... 04:42:01 INFO - TEST-INFO | started process 30336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpJEZL/profile http://localhost:53387/getInfo.html) 04:42:05 INFO - PROCESS | 30336 | __metrics Screen width/height:1600/1200 04:42:05 INFO - PROCESS | 30336 | colorDepth:24 04:42:05 INFO - PROCESS | 30336 | Browser inner width/height: 1024/697 04:42:05 INFO - PROCESS | 30336 | __metrics 04:42:06 INFO - PROCESS | 30336 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:42:06 INFO - PROCESS | 30336 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:07 INFO - TEST-INFO | 30336: exit 0 04:42:07 INFO - Browser initialized. 04:42:07 INFO - Running cycle 1/1 for kraken test... 04:42:07 INFO - TEST-INFO | started process 30416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYpJEZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:19 INFO - PROCESS | 30416 | RSS: Main: 150601728 04:42:19 INFO - PROCESS | 30416 | 04:42:21 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:22 INFO - PROCESS | 30416 | RSS: Main: 187371520 04:42:22 INFO - PROCESS | 30416 | 04:42:25 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-dft) 04:42:25 INFO - PROCESS | 30416 | RSS: Main: 176320512 04:42:25 INFO - PROCESS | 30416 | 04:42:28 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-fft) 04:42:29 INFO - PROCESS | 30416 | RSS: Main: 162140160 04:42:29 INFO - PROCESS | 30416 | 04:42:31 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53387/tests/kraken/driver.html?testName=audio-oscillator) 04:42:31 INFO - PROCESS | 30416 | RSS: Main: 163672064 04:42:31 INFO - PROCESS | 30416 | 04:42:34 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:34 INFO - PROCESS | 30416 | RSS: Main: 165015552 04:42:34 INFO - PROCESS | 30416 | 04:42:37 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53387/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:38 INFO - PROCESS | 30416 | RSS: Main: 166506496 04:42:38 INFO - PROCESS | 30416 | 04:42:41 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53387/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:42 INFO - PROCESS | 30416 | RSS: Main: 165306368 04:42:42 INFO - PROCESS | 30416 | 04:42:45 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53387/tests/kraken/driver.html?testName=json-parse-financial) 04:42:45 INFO - PROCESS | 30416 | RSS: Main: 166010880 04:42:45 INFO - PROCESS | 30416 | 04:42:47 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:48 INFO - PROCESS | 30416 | RSS: Main: 176771072 04:42:48 INFO - PROCESS | 30416 | 04:42:49 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:50 INFO - PROCESS | 30416 | RSS: Main: 173350912 04:42:50 INFO - PROCESS | 30416 | 04:42:52 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:53 INFO - PROCESS | 30416 | RSS: Main: 185180160 04:42:53 INFO - PROCESS | 30416 | 04:42:55 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:56 INFO - PROCESS | 30416 | RSS: Main: 190140416 04:42:56 INFO - PROCESS | 30416 | 04:42:59 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:59 INFO - PROCESS | 30416 | RSS: Main: 187355136 04:42:59 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:53387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53387/tests/kraken/driver.html?testName=ai-astar) 04:43:01 INFO - PROCESS | 30416 | RSS: Main: 245669888 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | __start_tp_report 04:43:01 INFO - PROCESS | 30416 | _x_x_mozilla_page_load 04:43:01 INFO - PROCESS | 30416 | _x_x_mozilla_page_load_details 04:43:01 INFO - PROCESS | 30416 | |i|pagename|runs| 04:43:01 INFO - PROCESS | 30416 | |0;ai-astar;113;113;108;112;115;115;103;114;114;122 04:43:01 INFO - PROCESS | 30416 | |1;audio-beat-detection;164;132;152;170;133;155;156;130;169;131 04:43:01 INFO - PROCESS | 30416 | |2;audio-dft;160;160;160;159;161;158;163;162;161;161 04:43:01 INFO - PROCESS | 30416 | |3;audio-fft;72;72;87;101;75;71;71;86;89;71 04:43:01 INFO - PROCESS | 30416 | |4;audio-oscillator;98;99;146;99;97;98;140;99;98;143 04:43:01 INFO - PROCESS | 30416 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;111 04:43:01 INFO - PROCESS | 30416 | |6;imaging-darkroom;147;146;146;146;147;147;148;148;148;147 04:43:01 INFO - PROCESS | 30416 | |7;imaging-desaturate;96;95;95;95;96;95;96;96;96;96 04:43:01 INFO - PROCESS | 30416 | |8;json-parse-financial;71;70;71;69;70;70;70;80;68;68 04:43:01 INFO - PROCESS | 30416 | |9;json-stringify-tinderbox;67;67;66;67;67;69;66;68;68;67 04:43:01 INFO - PROCESS | 30416 | |10;stanford-crypto-aes;86;85;85;85;85;94;85;87;88;93 04:43:01 INFO - PROCESS | 30416 | |11;stanford-crypto-ccm;129;120;122;116;120;123;130;122;132;123 04:43:01 INFO - PROCESS | 30416 | |12;stanford-crypto-pbkdf2;138;137;155;148;164;140;147;161;150;139 04:43:01 INFO - PROCESS | 30416 | |13;stanford-crypto-sha256-iterative;70;70;70;71;70;70;72;72;70;72 04:43:01 INFO - PROCESS | 30416 | __end_tp_report 04:43:01 INFO - PROCESS | 30416 | __start_cc_report 04:43:01 INFO - PROCESS | 30416 | _x_x_mozilla_cycle_collect,984 04:43:01 INFO - PROCESS | 30416 | __end_cc_report 04:43:01 INFO - PROCESS | 30416 | __startTimestamp1451997781641__endTimestamp 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | ------- Summary: start ------- 04:43:01 INFO - PROCESS | 30416 | Number of tests: 14 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:4.91 (4.3%) stddev-sans-first:5.21 04:43:01 INFO - PROCESS | 30416 | Values: 113.0 113.0 108.0 112.0 115.0 115.0 103.0 114.0 114.0 122.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:155.50 stddev:16.29 (10.5%) stddev-sans-first:16.38 04:43:01 INFO - PROCESS | 30416 | Values: 164.0 132.0 152.0 170.0 133.0 155.0 156.0 130.0 169.0 131.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 04:43:01 INFO - PROCESS | 30416 | Values: 160.0 160.0 160.0 159.0 161.0 158.0 163.0 162.0 161.0 161.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#3] audio-fft Cycles:10 Average:79.50 Median:73.50 stddev:10.54 (14.3%) stddev-sans-first:10.83 04:43:01 INFO - PROCESS | 30416 | Values: 72.0 72.0 87.0 101.0 75.0 71.0 71.0 86.0 89.0 71.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:98.00 stddev:21.65 (22.1%) stddev-sans-first:22.39 04:43:01 INFO - PROCESS | 30416 | Values: 98.0 99.0 146.0 99.0 97.0 98.0 140.0 99.0 98.0 143.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:43:01 INFO - PROCESS | 30416 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:43:01 INFO - PROCESS | 30416 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 148.0 148.0 148.0 147.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:43:01 INFO - PROCESS | 30416 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.00 stddev:3.43 (4.9%) stddev-sans-first:3.64 04:43:01 INFO - PROCESS | 30416 | Values: 71.0 70.0 71.0 69.0 70.0 70.0 70.0 80.0 68.0 68.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 04:43:01 INFO - PROCESS | 30416 | Values: 67.0 67.0 66.0 67.0 67.0 69.0 66.0 68.0 68.0 67.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.50 stddev:3.43 (4.0%) stddev-sans-first:3.61 04:43:01 INFO - PROCESS | 30416 | Values: 86.0 85.0 85.0 85.0 85.0 94.0 85.0 87.0 88.0 93.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.00 stddev:5.06 (4.1%) stddev-sans-first:4.99 04:43:01 INFO - PROCESS | 30416 | Values: 129.0 120.0 122.0 116.0 120.0 123.0 130.0 122.0 132.0 123.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.00 stddev:9.69 (6.5%) stddev-sans-first:9.59 04:43:01 INFO - PROCESS | 30416 | Values: 138.0 137.0 155.0 148.0 164.0 140.0 147.0 161.0 150.0 139.0 04:43:01 INFO - PROCESS | 30416 | 04:43:01 INFO - PROCESS | 30416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 04:43:01 INFO - PROCESS | 30416 | Values: 70.0 70.0 70.0 71.0 70.0 70.0 72.0 72.0 70.0 72.0 04:43:01 INFO - PROCESS | 30416 | -------- Summary: end -------- 04:43:01 INFO - PROCESS | 30416 | 04:43:02 INFO - TEST-INFO | 30416: exit 0 04:43:02 INFO - TEST-OK | kraken | took 60734ms 04:43:02 INFO - TEST-START | v8_7 04:43:02 INFO - operating with platform_type : linux_ 04:43:02 INFO - Initialising browser for v8_7 test... 04:43:02 INFO - TEST-INFO | started process 30668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJSpV_i/profile http://localhost:53387/getInfo.html) 04:43:06 INFO - PROCESS | 30668 | __metrics Screen width/height:1600/1200 04:43:06 INFO - PROCESS | 30668 | colorDepth:24 04:43:06 INFO - PROCESS | 30668 | Browser inner width/height: 1024/697 04:43:06 INFO - PROCESS | 30668 | __metrics 04:43:06 INFO - PROCESS | 30668 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:43:06 INFO - PROCESS | 30668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:08 INFO - TEST-INFO | 30668: exit 0 04:43:08 INFO - Browser initialized. 04:43:08 INFO - Running cycle 1/1 for v8_7 test... 04:43:08 INFO - TEST-INFO | started process 30752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJSpV_i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:20 INFO - PROCESS | 30752 | RSS: Main: 150327296 04:43:20 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:53387/tests/v8_7/run.html (next: http://localhost:53387/tests/v8_7/run.html) 04:43:41 INFO - PROCESS | 30752 | RSS: Main: 445902848 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | __start_tp_report 04:43:41 INFO - PROCESS | 30752 | _x_x_mozilla_page_load 04:43:41 INFO - PROCESS | 30752 | _x_x_mozilla_page_load_details 04:43:41 INFO - PROCESS | 30752 | |i|pagename|runs| 04:43:41 INFO - PROCESS | 30752 | |0;Richards;167.897918065816 04:43:41 INFO - PROCESS | 30752 | |1;DeltaBlue;189.7173211914248 04:43:41 INFO - PROCESS | 30752 | |2;Encrypt;278.70680044593087 04:43:41 INFO - PROCESS | 30752 | |3;Decrypt;5154.639175257732 04:43:41 INFO - PROCESS | 30752 | |4;RayTrace;2016.1290322580646 04:43:41 INFO - PROCESS | 30752 | |5;Earley;806.4516129032259 04:43:41 INFO - PROCESS | 30752 | |6;Boyer;12256.09756097561 04:43:41 INFO - PROCESS | 30752 | |7;RegExp;26552.63157894737 04:43:41 INFO - PROCESS | 30752 | |8;Splay;602.1505376344086 04:43:41 INFO - PROCESS | 30752 | |9;NavierStokes;4845.410628019324 04:43:41 INFO - PROCESS | 30752 | __end_tp_report 04:43:41 INFO - PROCESS | 30752 | __startTimestamp1451997821795__endTimestamp 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | ------- Summary: start ------- 04:43:41 INFO - PROCESS | 30752 | Number of tests: 10 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 167.9 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#1] DeltaBlue Cycles:1 Average:189.72 Median:189.72 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 189.7 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 278.7 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 5154.6 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 2016.1 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#5] Earley Cycles:1 Average:806.45 Median:806.45 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 806.5 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 12256.1 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 26552.6 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#8] Splay Cycles:1 Average:602.15 Median:602.15 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 602.2 04:43:41 INFO - PROCESS | 30752 | 04:43:41 INFO - PROCESS | 30752 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:43:41 INFO - PROCESS | 30752 | Values: 4845.4 04:43:41 INFO - PROCESS | 30752 | -------- Summary: end -------- 04:43:41 INFO - PROCESS | 30752 | 04:43:42 INFO - TEST-INFO | 30752: exit 0 04:43:42 INFO - TEST-OK | v8_7 | took 40157ms 04:43:42 INFO - SUITE-END | took 1219s 04:43:42 INFO - Completed test suite (00:20:19) 04:43:42 INFO - Working with test: dromaeo_css 04:43:42 INFO - Generating results file: dromaeo_css 04:43:42 INFO - Working with test: kraken 04:43:42 INFO - Generating results file: kraken 04:43:42 INFO - javascript benchmark 04:43:42 INFO - Working with test: v8_7 04:43:42 INFO - Generating results file: v8_7 04:43:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:43:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:43:42 INFO - process_Request line: dromaeo_css 6090.12 graph.html#tests=[[72,94,35]] 04:43:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:43:42 INFO - process_Request line: kraken 1534.10 graph.html#tests=[[232,94,35]] 04:43:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:43:42 INFO - process_Request line: v8_7 19701.66 graph.html#tests=[[230,94,35]] 04:43:42 INFO - RETURN: dromaeo_css: 6090.12 04:43:42 INFO - RETURN: kraken: 1534.10 04:43:42 INFO - RETURN: v8_7: 19701.66 04:43:42 INFO - javascript benchmark 04:43:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2587.9870600646996, 2652.1247988163896, 2669.079167687147, 2674.4116294415235, 2696.2046196372075, 4437.600615944564, 4568.177728008957, 4601.240795268776, 4609.539046095389, 4612.031473390588, 4591.035882464678, 4634.791434385453, 4669.789859456324, 4681.227597446417, 4763.595094416979, 4026.697997650188, 4140.275451795938, 4182.226288136704, 4214.641755450791, 4284.935725964097, 4244.236037513247, 4289.957100428987, 4308.482982042159, 4315.180115777992, 4349.521552629209, 4121.567235440296, 4153.958460415387, 4216.9578304217175, 4225.15496900618, 4251.2347777400055, 4213.115245798386, 4216.198922204802, 4250.872473825791, 4264.765437900915, 4283.614474697292, 4198.748075115503, 4228.281192197333, 4251.213525497793, 4275.294576394891, 4303.870883873489, 4427.53510881356, 4523.457185137804, 4534.841280555164, 4556.088782243532, 4567.497575266718, 4879.8780030499165, 4971.701697898137, 4975.850724478271, 5008.749562521859, 5008.9499105008845, 4936.703797772145, 4942.851714448572, 4944.728039957801, 4949.381327334083, 4985.252212168204, 4405.823767049282, 4600.194965880957, 4602.056578401453, 4617.37665415168, 4640.559146881041, 4977.701337919736, 5013.974930125326, 5059.924101138486, 5179.922301165486, 5186.377634683787, 4869.513048695102, 4872.610191184696, 4873.171560834667, 4873.707577545359, 4913.041956818458, 4950.9009819803405, 4957.851264462072, 4961.355023846949, 4964.826231081895, 4997.7251251180805, 4733.408323959505, 4793.688410253322, 4847.903041939141, 4854.514548545118, 4953.702777833341, 4884.8290309839695, 4888.6577939543895, 4898.14282500561, 4923.212286034217, 4931.013797240566, 4101.774402407897, 4125.133721918431, 4129.359949207877, 4138.627523522898, 4169.624733773914, 3538.7345949053924, 3595.94606080909, 3636.5272514573467, 3640.4357324614725, 3680.4479328100997, 4293.5706429356815, 4294.398784170218, 4299.634531064895, 4322.070754787673, 4322.481302243688, 4971.925421118686, 4977.626677999092, 4984.875378115504, 5009.699418034929, 5018.197088465828, 4118.897027574335, 4157.501099868035, 4212.957870421256, 4217.894552636209, 4260.44614200152, 4371.912561748811, 4400.075984043323, 4406.713563618418, 4412.801423935931, 4432.113577284556, 4716.481187069419, 4727.3145393917, 4741.051789642016, 4745.406824146981, 4765.380500534909, 4710.387649605529, 4830.806767729392, 4833.782479788489, 4927.827526036572, 4971.130052240771, 4717.646176536705, 4732.645051621073, 4741.0, 4756.619470442287, 4772.0455908817685, 4883.780229889592, 4891.192953162688, 4904.141775189256, 4904.485029072039, 4934.580560652241, 4767.213409787346, 4829.541193586604, 4882.340883980759, 4892.021595680807, 4974.651774375759, 4652.046330502307, 4697.271922851964, 4839.104765618372, 4846.709197448165, 4890.046440943982, 4788.449328327287, 4797.304390863375, 4798.2082956311815, 4798.424189097331, 4855.320255164209, 4569.1547063793305, 4661.976690116528, 4681.321208424827, 4706.599939005086, 4757.215059515142, 4637.698549594265, 4785.760711964457, 4844.563989240985, 4859.975700121477, 4878.463369029333, 4746.145693775154, 4763.428388593391, 4766.356541866804, 4767.904641907212, 4808.711477311373], "unit": "score", "name": "dojo.html", "value": 4526.257707079361}, {"lowerIsBetter": false, "replicates": [474.08265007211025, 481.2925000249632, 502.8466317773079, 507.0012076209865, 523.8035736598775, 22047.889760551196, 32356.514652280235, 32555.51166732495, 32594.67405325946, 32720.181995450068, 35570.82214588924, 35950.460743088806, 36024.459633105456, 36068.2786344273, 36135.81932090342, 6606.768763093292, 6701.128853249071, 7644.808879778008, 7823.569703666296, 7830.0, 9765.609375625001, 9972.700818975442, 9984.351017183895, 9991.75020624483, 10000.749981250454, 9736.123748862601, 9843.163331116864, 9844.261680373966, 9847.458389788559, 9850.359726617782, 6791.762288319935, 6948.305169483062, 6950.061741664912, 6953.687084081178, 9680.90319096807, 9718.659846905324, 9951.55218015191, 9961.85057224135, 9970.451625160613, 9971.80056398868, 33231.50152747711, 33712.15719607029, 33744.325113497835, 33761.83119084413, 33767.83116084428, 2582.5996970469605, 2636.973630263692, 2727.1273192578383, 2895.247235718707, 3072.9078127656207, 26069.739302606922, 26211.213663590122, 27002.324941876414, 28352.432951341063, 28477.430451390857, 3345.3476572068457, 3350.731941444703, 3358.983205083983, 3380.1975763306446, 3407.9488807667904, 159544.0, 159570.0, 159682.0, 159756.0, 160053.0, 41248.79375603103, 54977.1753423699, 55276.0, 55345.1698224527, 55346.0, 35386.64613353885, 58056.0, 58807.411925881046, 58916.0, 58918.70540647269, 12306.81539776904, 12581.937090314674, 12589.0, 12596.307203103734, 12628.05289603265, 9511.524423778921, 9575.425474471414, 9623.663171789094, 9643.27675424346, 9663.758406039906, 18571.350002749838, 18790.436286911416, 18793.1543080559, 18794.436166915013, 18837.340693075676, 6906.309369063053, 7012.789616311519, 7082.752103676449, 7083.433325333961, 7151.177614574391, 759.4835511851883, 863.6113748812934, 949.4682977532603, 1021.2442792333619, 1045.1116550931647, 26124.477510449684, 26675.733242667713, 27226.455470890472, 28728.145697017084, 29503.704962950524, 933.5192375926404, 942.9198518126036, 990.6136606723384, 1013.7364285285879, 1054.2672842374477, 13037.56586775454, 13323.0, 13345.399457024263, 13364.30105811941, 13468.730625387438, 261024.0, 264811.0, 264926.0, 267061.0, 267131.0, 43693.0, 44638.33042504365, 44708.0, 44734.776326118816, 44740.10519789586, 1038.6676263595728, 1087.4127970895786, 1173.3898372846243, 1180.5336891927811, 1187.441902305915, 21221.7877821226, 21536.56926861423, 22094.779052209273, 22096.779032209473, 22304.0, 31719.524207137372, 32243.0, 32265.35469290648, 32277.51583726199, 32300.515492268103, 207299.0, 214828.0, 326300.0, 332048.0, 332564.0, 27774.305642358293, 27872.88508459639, 27923.860380697966, 27977.0, 27982.58026129569, 34110.0, 38556.614433855306, 38653.226935461695, 39313.60686393214, 39419.0, 31469.0, 31561.36877262396, 32507.512387314684, 33034.83482582572, 33128.33743325168, 33459.83270083634, 33516.832415837765, 33650.32699346048, 33698.49452258169, 34042.31915361728, 33888.322233554696, 33968.0, 34073.148171295914, 34187.14532136716, 34290.48564271588, 29149.0, 30246.0, 30574.694253057183, 30720.539191912587, 30774.230644234074, 23206.1877834275, 23528.411789705395, 23579.64630530509, 23701.407464813517, 23729.28812135639], "unit": "score", "name": "ext.html", "value": 16315.549201201218}, {"lowerIsBetter": false, "replicates": [317.1753441053263, 317.4365501235307, 324.16042450054357, 325.5686215764113, 327.95900512435946, 11189.272697274671, 11456.427178641075, 14155.292235388228, 14852.628684282898, 15045.0, 11929.642110736691, 12363.938180309086, 12367.814482782765, 13609.591712248648, 13631.591052268423, 4833.202521583935, 4835.1296766582, 4954.851354459354, 4956.306117143603, 4957.702537847723, 3600.3159399713973, 3694.501242332291, 4917.582005529534, 5428.240046393488, 5658.236138121362, 5572.554195664337, 5579.69311687857, 5586.329640443152, 5608.6073974821775, 5609.439056094398, 5566.081596536566, 5940.52475801937, 6208.099825525273, 6209.192804935329, 6210.13058171854, 5833.533317334645, 5964.940350596482, 6273.905891411632, 6280.560360774748, 6300.527460440439, 19288.32490862827, 19307.324243651405, 20300.18799248028, 20840.0, 20840.47898802527, 1884.7078702801089, 1924.5477312831474, 1935.7483527141521, 1947.7565304336958, 2006.237629700719, 12148.57479988205, 12564.395255347696, 13192.0, 13461.865381346159, 13802.723945521133, 1748.8338607832236, 1749.8512626426768, 1801.189464740872, 1849.8150184981528, 1912.7895931447529, 49168.75415622935, 52717.47282527164, 53783.19325210164, 54474.72762636201, 54485.0, 14050.929745351412, 14143.43426262938, 14162.221077840612, 14191.219482928538, 14330.426782928775, 21375.57248855014, 21389.0, 21411.571768564852, 22030.88984555099, 22570.0, 8013.719519816778, 8064.798380040428, 8071.636776345079, 8189.631466584018, 8230.09468958414, 6664.233613134552, 6664.533482656265, 6683.933160668428, 6718.160229971254, 6736.360045795642, 7322.597257150908, 7323.0, 7379.262073792578, 7403.777886663409, 7412.147603025721, 1680.2186983052939, 1696.397778788537, 1703.9659206815795, 2061.6082944240547, 2852.557853532706, 803.9115697273412, 806.6652339279134, 823.7693445835175, 825.5418242875141, 839.0812060793421, 14519.78220326696, 14536.345864436125, 14607.269636518131, 14812.851871481364, 14878.330475128645, 778.6379333609899, 805.1746959366579, 810.4974915552395, 823.7117009046906, 846.272205902923, 6492.640546162026, 8761.0, 8851.734447966572, 8902.243309318781, 9040.367174297868, 448961.0, 463522.0, 468965.0, 470723.0, 474311.0, 61434.38565614287, 70810.64594676993, 71941.28058719345, 75605.62197189088, 75608.62195688987, 1003.4029752297372, 1021.836506159011, 1027.6197806811676, 1035.0, 1037.7613148975777, 13839.0, 13998.650033749238, 14112.153270803785, 14320.283985800459, 14589.124652520883, 28551.0, 29057.0, 30256.394872101995, 30886.227844303172, 32589.674103258665, 34772.130696732784, 34797.82601086979, 35094.82452587721, 35775.64224357723, 35900.461493078146, 8070.435069545076, 8339.874901876356, 8374.748757537283, 8687.04442511336, 8696.913030869864, 14667.339969701176, 15502.379904804133, 15543.0, 15562.533124006299, 15756.0, 12687.80968285495, 12987.610371688865, 13117.409716562968, 13254.734905302033, 13399.598012059654, 12582.811257830957, 12710.428030738454, 12765.170263932814, 13109.213447193199, 13221.669458263621, 13109.475620975054, 13109.475620975436, 13185.736285274432, 13460.0, 13513.324333783468, 8536.530490823065, 8542.658293668432, 8553.401261911606, 8937.06160853127, 8962.507062111647, 8996.86504702443, 12666.936665316614, 13095.279759613313, 13363.1313964592, 13665.453381865012], "unit": "score", "name": "jquery.html", "value": 8586.911376947659}, {"lowerIsBetter": false, "replicates": [1046.001068979125, 1295.656650987488, 1297.8118172864931, 1370.876621104101, 1652.6529428819947, 5573.526250268727, 6469.223693156822, 6516.055172000057, 6550.410463058324, 6580.374864387882, 6450.387213214749, 6637.469002479802, 6649.168853893263, 6651.800445986616, 6654.73381064758, 1964.9901750491229, 2005.418428655688, 2008.4476768888526, 2009.1260301768705, 2009.9196032158695, 1951.9512012199666, 1984.394759598329, 1990.4327266728985, 1991.8107779760899, 2014.6272939506166, 1964.8428125749977, 1990.3531352310486, 2019.868708533948, 2021.0, 2021.1713197588992, 1962.3622322745093, 1986.02684684505, 1986.5530255692497, 1986.8112529309692, 1987.9701804472945, 1968.0651690447066, 1998.800119988004, 2006.3379084901946, 2008.839292856568, 2011.8491113166424, 6646.435053020499, 6720.66396680169, 6721.227058888193, 6738.629375384352, 6743.797686069426, 3750.6624403803517, 3829.5213098362706, 3835.405512145594, 3838.5777564467885, 3843.1737176507186, 2412.8311018228733, 2462.482878595497, 2462.7660372264604, 2469.5060987802512, 2570.3574106473384, 761.6686741267566, 766.7239793674273, 774.3185996323256, 777.1606664802057, 778.1129512355918, 8989.865152022725, 8996.685116020908, 9007.324450666227, 9015.504147271897, 9044.276457883354, 3477.9304413912087, 3498.0904964709357, 3518.964810351915, 3541.415666415064, 3546.042568506489, 7753.883691744629, 7777.922220777833, 7793.766187014398, 7805.492642978188, 7845.862349959338, 3790.7346485746284, 3796.088938654703, 3797.1266608680157, 3797.5632802227547, 3811.866584669523, 2899.0288253434915, 2945.3520225550346, 3380.3408335374857, 3493.12671832042, 3496.42309019009, 3210.3900258950725, 3240.3681282149755, 3269.4278501262183, 3284.7700660953983, 3293.818839963777, 995.9452230127267, 1019.7246743379246, 1022.6216299969059, 1057.476549108181, 1060.2154405739698, 873.5894129759004, 931.8043210925646, 1109.4619109731773, 1120.9327440353604, 1121.4841173060483, 6314.179156709598, 6406.071119687619, 6412.583182093149, 6441.0, 6470.288268290485, 962.3119469579144, 972.2610815779917, 981.9018098190267, 989.475577943691, 989.9604015839429, 4585.426821647294, 4654.138984287918, 4661.207594708908, 4672.392588963481, 4676.50896655853, 7916.287534121957, 8000.8799868002025, 8129.390295727844, 8208.917910820936, 8219.342452603778, 8037.0, 8037.7588672339925, 8130.268275855202, 8133.2680058794995, 8135.918640813635, 6098.207233059674, 6221.222347206599, 6261.68691565429, 6388.616682999035, 6412.070249813751, 6248.094026366242, 6269.68651567429, 6284.717187726655, 6343.0, 6343.460805831556, 7038.40173585251, 7123.074000379917, 7201.927980720126, 7248.275172482709, 7355.8161045974275, 7272.927270727437, 7418.0, 7441.330280274801, 7453.850922981618, 7553.848923021619, 5018.172001619692, 5127.384713834214, 5886.293644762656, 6003.249593800775, 6078.878422431615, 6019.097135429721, 6037.09443583466, 6041.791641671771, 6064.029755239317, 6096.786612468542, 5701.914471283017, 5759.71201439918, 5764.798232061858, 5835.912461312999, 5844.444777746107, 5571.331440227199, 5624.240727501735, 5628.324601047737, 5643.71781410936, 5724.084146536534, 5887.52899768009, 5897.321807992136, 5933.703314834154, 5963.7912673056235, 6049.122877182872, 5410.431904649955, 5427.077396842467, 5446.400895901368, 5446.727663616724, 5448.673079615236, 5599.468050535193, 5630.8029218977135, 5634.887302254014, 5642.887142257214, 5644.88710225785], "unit": "score", "name": "mootools.html", "value": 3799.7951804832774}, {"lowerIsBetter": false, "replicates": [285.7642444982889, 291.31104936824414, 292.2722421171284, 294.8849948520079, 295.787033335998, 5314.256004159421, 5383.031054410205, 5414.485623865731, 5420.295361602996, 5539.750711217995, 5337.653052551582, 5377.354717433904, 5395.7032363220005, 5402.162664786954, 5413.242146099549, 4112.6709863210945, 4116.094459218967, 4118.4028315894175, 4120.114175452277, 4130.277201489742, 3866.516685414323, 3959.4654721612646, 3969.364901615742, 3975.662068724162, 4059.451973983504, 4009.2983727847654, 4015.678745700337, 4018.63832255097, 4019.819108140126, 4022.798860057, 3999.280129576675, 4006.5392479864895, 4008.839646414125, 4014.0165659413337, 4016.7790771507557, 3304.306095719902, 3371.9157021074425, 3379.8817041403677, 3381.070205693429, 3386.5936087669393, 4991.176455884811, 5024.698518088926, 5143.639945203838, 5169.0, 5205.843824685266, 4648.651351148677, 4651.813927442899, 4655.534446555317, 4657.743824089674, 4658.254679251304, 5623.297087864017, 5627.184058311563, 5628.099504079328, 5634.943650563483, 5643.6049476536655, 3683.2633473305445, 3804.2011177652726, 3804.6766024887916, 3805.6574908258112, 3808.2383523295175, 5774.769009239625, 5884.705764711747, 5898.115282707586, 5900.468957793819, 5900.557458190653, 3967.6429121379215, 3974.264761019163, 3974.682025437958, 3978.0850404407147, 3980.86066987654, 4034.1931613677384, 4042.4744783178, 4044.1507283470214, 4046.8988275293354, 4048.332025215865, 4446.3108218226225, 4591.977040114778, 4612.584867361954, 4653.278741795028, 4653.790579423934, 5602.13166959122, 5603.3836278009385, 5606.943930560724, 5609.943900560942, 5612.07400778875, 1383.522684673786, 1405.3886559346513, 1406.7678832992442, 1420.6448387903024, 1421.722764060998, 932.7668082979255, 939.182910867536, 940.948247846375, 944.8015916657579, 945.0738276489079, 4949.133901567211, 4955.331030310934, 4965.255211718271, 4966.230234313687, 4969.82605608802, 5834.387389324144, 5835.854103647443, 5840.2115714378015, 5849.853753656107, 5850.970745146332, 4940.925886111711, 4958.9008219835405, 4960.950390496121, 4965.3048573199785, 4968.527989840959, 3043.3761078978755, 3095.674954129829, 3142.308692087737, 3144.3554071415306, 3146.8741250350186, 5312.867178320573, 5371.194320851825, 5493.527912439418, 5526.613137080446, 5575.860603484864, 6007.3992600739575, 6024.096385542204, 6029.8191054268445, 6032.426919442733, 6040.244969378828, 5511.917321240185, 5552.139418390156, 5554.527865131347, 5558.055130627803, 5561.054620714488, 5660.575456840836, 5841.415858414294, 5859.648421094748, 5876.647401155944, 5879.676617785892, 5691.800786972436, 5693.8291851242875, 5694.0, 5701.258836351248, 5771.884562308815, 5571.275734154534, 5576.052071147834, 5579.218909352613, 5581.888362232651, 5596.496315331639, 4059.4316795649224, 4112.074783173762, 4112.753234805921, 4114.629683328515, 4117.97941010293, 5671.43285671446, 5835.183074369506, 5890.0, 5893.292804863272, 5895.970520147372, 5577.107662773937, 5600.8879822402505, 5611.074172761449, 5614.606977511535, 5615.859603509945, 5601.271834661468, 5603.74783134768, 5611.158326251095, 5612.130119831432, 5619.494245517923, 5379.892402152013, 5448.0, 5490.3411590609385, 5499.340079190522, 5501.477359650827, 5603.299587551556, 5616.915746263728, 5632.408597097246, 5645.830625081254, 5651.350094739158, 5497.945020549743, 5501.5323697486165, 5506.5870059746485, 5539.307586551681, 5568.359638641446], "unit": "score", "name": "prototype.html", "value": 4184.168439915431}, {"lowerIsBetter": false, "replicates": [635.4757325206706, 650.0866282872565, 692.4702602509082, 694.8262934266432, 711.4912837321316, 8788.209061184492, 8906.51014194219, 8935.240504557105, 8937.50843703596, 8945.418547794388, 8887.155720206587, 8970.3272254581, 8985.056569060253, 8999.325050621213, 9022.593983270752, 414.0931360320903, 415.1240881739527, 419.56994081066847, 736.120336198242, 753.8266198774285, 493.3512431153022, 496.1119595923311, 500.20966872341796, 727.3562896836312, 748.8726916424221, 786.7679034684753, 787.1459466478877, 792.7978365516785, 793.0364607002491, 793.2305663506389, 783.0, 783.1502819440914, 783.4320117914494, 783.8118851475662, 783.9725609603665, 351.67470090166495, 355.95728512578654, 564.0946281218626, 575.7437940116649, 576.4034224577542, 8569.785755356104, 8613.569321533962, 8635.481871087755, 8647.221750042527, 8659.004214515347, 10097.0, 10429.0, 10667.306625069423, 10778.29941053829, 10802.67591972242, 7828.452008359417, 8015.398845086642, 8042.477238979448, 8101.189881011852, 8104.5542495162745, 2595.377109493727, 2608.1393140263667, 2645.933851653705, 2646.4971655385607, 2673.679158500973, 37911.431328530096, 39056.21887562261, 39080.60919390827, 39132.41301380481, 39160.41259381112, 8177.836443271221, 8218.917810821815, 8235.95882020586, 8262.793430164294, 8316.542590157478, 14212.21832799206, 14237.78643320351, 14245.430182792572, 14254.144751314747, 14262.072965257224, 5520.392756796749, 5750.88498230033, 6018.307894592178, 6092.664903430265, 6166.753329866755, 3387.6951074402928, 3391.0844072100394, 3403.7957722536726, 3443.2941247044296, 3471.687548120681, 2616.7383261674063, 2684.973150268472, 2689.5562232231855, 2692.6095716121054, 2694.609281654188, 457.51274892239655, 469.59614731331027, 470.6470147389458, 472.11242863416555, 474.1252389341728, 395.4444006171334, 409.1285561753446, 414.82162670051565, 416.6978940268281, 425.73604365293716, 6388.584741991755, 6606.801795946033, 6681.797276490279, 6736.730530778812, 6849.589024658537, 417.8015442664771, 435.83002628974725, 453.3607613265346, 462.69693350855243, 468.4378745505407, 3070.3398769264268, 3140.262038420969, 3146.889858854975, 3250.723688486505, 3293.2919422324317, 48693.0, 48707.512924870294, 48737.0, 48871.511284887405, 49060.0, 40982.0, 40989.18021639551, 43724.78137609355, 43993.34009989853, 44322.55677443249, 42427.1514569713, 42655.0, 42842.571574284484, 43842.780786095864, 43870.122597547874, 7169.713211471482, 7274.199838017919, 7520.699172033057, 7649.464537482323, 7839.647215875413, 29124.854375727984, 29456.263593410335, 30948.381032379675, 31189.220269493446, 31218.375632487678, 37173.814130929175, 37377.62622373742, 37614.435783463814, 37841.24317513689, 38395.23209535738, 8948.060453652533, 9676.9032309676, 9696.030396960248, 9846.852182741923, 9878.802423951625, 10266.0, 10350.637727679496, 10381.065704086668, 10387.428691422045, 10396.324238924446, 9371.250299975849, 9663.9033609663, 9779.608815647294, 9830.967748386316, 9836.803263934538, 9220.631174753204, 9373.25013998892, 9481.146696797321, 9504.0, 9624.0, 9581.233501320017, 9757.80484390294, 9779.168770654574, 9786.902130978599, 9800.264980126662, 8176.550289733884, 8412.71187709239, 8470.534120623424, 8581.184787445183, 8751.606177722146, 8011.158828323175, 8075.475094118863, 8382.16178382157, 8419.200175983271, 8564.400491965502], "unit": "score", "name": "yui.html", "value": 5060.071963309622}], "name": "dromaeo_css", "value": 6090.115496523366}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 108.0, 112.0, 115.0, 115.0, 103.0, 114.0, 114.0, 122.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [164.0, 132.0, 152.0, 170.0, 133.0, 155.0, 156.0, 130.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 159.0, 161.0, 158.0, 163.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 87.0, 101.0, 75.0, 71.0, 71.0, 86.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 146.0, 99.0, 97.0, 98.0, 140.0, 99.0, 98.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 69.0, 70.0, 70.0, 70.0, 80.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 69.0, 66.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 94.0, 85.0, 87.0, 88.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [129.0, 120.0, 122.0, 116.0, 120.0, 123.0, 130.0, 122.0, 132.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [138.0, 137.0, 155.0, 148.0, 164.0, 140.0, 147.0, 161.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 72.0, 72.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1534.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [189.7173211914248], "unit": "score", "name": "DeltaBlue", "value": 348.507978}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [2016.1290322580646], "unit": "score", "name": "RayTrace", "value": 367.03454399999987}, {"lowerIsBetter": false, "replicates": [806.4516129032259], "unit": "score", "name": "Earley", "value": 826.4141199999997}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [602.1505376344086], "unit": "score", "name": "Splay", "value": 135.3332678571428}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19701.65842183818}]} 04:43:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19701.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1534.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6090.12"}}} 04:43:43 INFO - Return code: 0 04:43:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:43:43 INFO - # TBPL SUCCESS # 04:43:43 INFO - Running post-action listener: _resource_record_post_action 04:43:43 INFO - Running post-run listener: _resource_record_post_run 04:43:44 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 547196928; Read time: 0; Write time: 639076 04:43:44 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 230764544; Read time: 0; Write time: 346392 04:43:44 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 315568128; Read time: 0; Write time: 292636 04:43:44 INFO - Running post-run listener: _upload_blobber_files 04:43:44 INFO - Blob upload gear active. 04:43:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:44 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 04:43:44 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'] 04:43:44 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 04:43:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:45 INFO - (blobuploader) - INFO - Done attempting. 04:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:46 INFO - (blobuploader) - INFO - Done attempting. 04:43:46 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:46 INFO - Return code: 0 04:43:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc58efd75a0c2efd10f0458adf6f3c4d307aff7244c67e61fc2319f3b3c99c48337aca3731f142e7e252fa5930d90604f9f944da6db6eb9cf29da8e67e9a7e7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9213cce40558f7cdc1304997f6f0ef0566759a5167bf6ee515f0db53c443fbffbb9f8c0772c75bbac0e812a05d41bdb098137170b5b42e38aca410587686949"} 04:43:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:46 INFO - Contents: 04:43:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc58efd75a0c2efd10f0458adf6f3c4d307aff7244c67e61fc2319f3b3c99c48337aca3731f142e7e252fa5930d90604f9f944da6db6eb9cf29da8e67e9a7e7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9213cce40558f7cdc1304997f6f0ef0566759a5167bf6ee515f0db53c443fbffbb9f8c0772c75bbac0e812a05d41bdb098137170b5b42e38aca410587686949"} 04:43:46 INFO - Copying logs to upload dir... 04:43:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.370212 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-05 04:43:46.330728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 04:43:46.334557) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc58efd75a0c2efd10f0458adf6f3c4d307aff7244c67e61fc2319f3b3c99c48337aca3731f142e7e252fa5930d90604f9f944da6db6eb9cf29da8e67e9a7e7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9213cce40558f7cdc1304997f6f0ef0566759a5167bf6ee515f0db53c443fbffbb9f8c0772c75bbac0e812a05d41bdb098137170b5b42e38aca410587686949"} build_url:https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/YOHdJ4XPRXC8rvcvKBmovg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc58efd75a0c2efd10f0458adf6f3c4d307aff7244c67e61fc2319f3b3c99c48337aca3731f142e7e252fa5930d90604f9f944da6db6eb9cf29da8e67e9a7e7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9213cce40558f7cdc1304997f6f0ef0566759a5167bf6ee515f0db53c443fbffbb9f8c0772c75bbac0e812a05d41bdb098137170b5b42e38aca410587686949"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 04:43:46.360182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:43:46.360578) ========= 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=14ef55db36f7623abb31b9cf000001d5-1451995892.308410-1408531241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 04:43:46.447436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 04:43:46.447970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 04:43:46.448524) ========= ========= Total master_lag: 0.28 =========