builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1471567314.76 results: success (0) buildid: 20160818163358 builduid: d6e5e62a7203429ca8850e6861aa6aa4 revision: abac53d4d2476c4ab1816844091989456b8993bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.761285) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.761832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.762101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.777582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.777945) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 17:41:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-08-18 17:41:55 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.912257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.912565) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.963338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:54.963818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev abac53d4d2476c4ab1816844091989456b8993bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev abac53d4d2476c4ab1816844091989456b8993bf --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=9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 17:41:55,145 truncating revision to first 12 chars 2016-08-18 17:41:55,145 Setting DEBUG logging. 2016-08-18 17:41:55,145 attempt 1/10 2016-08-18 17:41:55,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/abac53d4d247?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 17:41:55,457 unpacking tar archive at: fx-team-abac53d4d247/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:55.628203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:55.628518) ========= script_repo_revision: abac53d4d2476c4ab1816844091989456b8993bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:55.628916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:55.629177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 17:41:55.640234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-18 17:41:55.640498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:41:55 INFO - MultiFileLogger online at 20160818 17:41:55 in /builds/slave/test 17:41:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:41:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:55 INFO - {'append_to_log': False, 17:41:55 INFO - 'base_work_dir': '/builds/slave/test', 17:41:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:41:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:55 INFO - 'branch': 'Fx-Team-Non-PGO', 17:41:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:55 INFO - 'config_files': ('talos/linux_config.py',), 17:41:55 INFO - 'default_actions': ('clobber', 17:41:55 INFO - 'read-buildbot-config', 17:41:55 INFO - 'download-and-extract', 17:41:55 INFO - 'populate-webroot', 17:41:55 INFO - 'create-virtualenv', 17:41:55 INFO - 'install', 17:41:55 INFO - 'run-tests'), 17:41:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:55 INFO - 'download_minidump_stackwalk': True, 17:41:55 INFO - 'download_symbols': 'ondemand', 17:41:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:41:55 INFO - 'tooltool.py': '/tools/tooltool.py', 17:41:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:41:55 INFO - '/tools/misc-python/virtualenv.py')}, 17:41:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:55 INFO - 'installer_path': 'installer.exe', 17:41:55 INFO - 'log_level': 'info', 17:41:55 INFO - 'log_name': 'talos', 17:41:55 INFO - 'log_to_console': True, 17:41:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:41:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:41:55 INFO - 'opt_config_files': (), 17:41:55 INFO - 'pip_index': False, 17:41:55 INFO - 'sps_profile': False, 17:41:55 INFO - 'sps_profile_interval': 0, 17:41:55 INFO - 'suite': 'dromaeojs-e10s', 17:41:55 INFO - 'system_bits': '32', 17:41:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:55 INFO - 'title': 'talos-linux64-ix-029', 17:41:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:55 INFO - 'use_talos_json': True, 17:41:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:55 INFO - 'work_dir': 'build'} 17:41:55 INFO - [mozharness: 2016-08-19 00:41:55.915688Z] Running clobber step. 17:41:55 INFO - Running pre-action listener: _resource_record_pre_action 17:41:55 INFO - Running main action method: clobber 17:41:55 INFO - rmtree: /builds/slave/test/build 17:41:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:56 INFO - Running post-action listener: _resource_record_post_action 17:41:56 INFO - [mozharness: 2016-08-19 00:41:56.942459Z] Finished clobber step (success) 17:41:56 INFO - [mozharness: 2016-08-19 00:41:56.942560Z] Running read-buildbot-config step. 17:41:56 INFO - Running pre-action listener: _resource_record_pre_action 17:41:56 INFO - Running main action method: read_buildbot_config 17:41:56 INFO - Using buildbot properties: 17:41:56 INFO - { 17:41:56 INFO - "project": "", 17:41:56 INFO - "product": "firefox", 17:41:56 INFO - "script_repo_revision": "production", 17:41:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:41:56 INFO - "repository": "", 17:41:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:41:56 INFO - "buildid": "20160818163358", 17:41:56 INFO - "pgo_build": "False", 17:41:56 INFO - "basedir": "/builds/slave/test", 17:41:56 INFO - "buildnumber": 1762, 17:41:56 INFO - "slavename": "talos-linux64-ix-029", 17:41:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:41:56 INFO - "platform": "ubuntu64_hw", 17:41:56 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 17:41:56 INFO - "branch": "fx-team", 17:41:56 INFO - "repo_path": "integration/fx-team", 17:41:56 INFO - "revision": "abac53d4d2476c4ab1816844091989456b8993bf", 17:41:56 INFO - "stage_platform": "linux64", 17:41:56 INFO - "builduid": "d6e5e62a7203429ca8850e6861aa6aa4", 17:41:56 INFO - "slavebuilddir": "test" 17:41:56 INFO - } 17:41:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:41:56 INFO - Running post-action listener: _resource_record_post_action 17:41:56 INFO - [mozharness: 2016-08-19 00:41:56.945002Z] Finished read-buildbot-config step (success) 17:41:56 INFO - [mozharness: 2016-08-19 00:41:56.945091Z] Running download-and-extract step. 17:41:56 INFO - Running pre-action listener: _resource_record_pre_action 17:41:56 INFO - Running main action method: download_and_extract 17:41:56 INFO - mkdir: /builds/slave/test/build/tests 17:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:56 INFO - trying https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:41:56 INFO - Downloading https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:41:57 INFO - Downloaded 1361 bytes. 17:41:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:41:57 INFO - Using the following test package requirements: 17:41:57 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:41:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:41:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:41:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'jsshell-linux-x86_64.zip'], 17:41:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:41:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:41:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:41:57 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:41:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:41:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:41:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:41:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:57 INFO - trying https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:41:57 INFO - Downloading https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:41:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:41:58 INFO - Downloaded 20317595 bytes. 17:41:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:42:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:42:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:02 INFO - trying https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:42:02 INFO - Downloading https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:03 INFO - Downloaded 20317595 bytes. 17:42:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:08 INFO - trying https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:42:08 INFO - Downloaded 14413981 bytes. 17:42:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:42:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:09 INFO - trying https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:42:09 INFO - Downloading https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:42:10 INFO - Downloaded 55764192 bytes. 17:42:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:42:10 INFO - mkdir: /builds/slave/test/properties 17:42:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:10 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:10 INFO - Contents: 17:42:10 INFO - build_url:https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:42:11 INFO - Running post-action listener: _resource_record_post_action 17:42:11 INFO - Running post-action listener: set_extra_try_arguments 17:42:11 INFO - [mozharness: 2016-08-19 00:42:11.317160Z] Finished download-and-extract step (success) 17:42:11 INFO - [mozharness: 2016-08-19 00:42:11.317385Z] Running populate-webroot step. 17:42:11 INFO - Running pre-action listener: _resource_record_pre_action 17:42:11 INFO - Running main action method: populate_webroot 17:42:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:11 INFO - '--tppagecycles', 17:42:11 INFO - '7'], 17:42:11 INFO - 'tests': ['tsvgm']}}, 17:42:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['damp', 'tps']}, 17:42:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'tests': ['damp', 'tps']}, 17:42:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['dromaeo_dom']}, 17:42:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['basic_compositor_video']}, 17:42:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:42:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['a11yr', 17:42:11 INFO - 'ts_paint', 17:42:11 INFO - 'tpaint', 17:42:11 INFO - 'sessionrestore', 17:42:11 INFO - 'sessionrestore_no_auto_restore', 17:42:11 INFO - 'tabpaint']}, 17:42:11 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:11 INFO - 'ts_paint', 17:42:11 INFO - 'tpaint', 17:42:11 INFO - 'sessionrestore', 17:42:11 INFO - 'sessionrestore_no_auto_restore', 17:42:11 INFO - 'tabpaint']}, 17:42:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:11 INFO - 'ts_paint', 17:42:11 INFO - 'tpaint', 17:42:11 INFO - 'sessionrestore', 17:42:11 INFO - 'sessionrestore_no_auto_restore', 17:42:11 INFO - 'tabpaint']}, 17:42:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:11 INFO - 'ts_paint', 17:42:11 INFO - 'tpaint', 17:42:11 INFO - 'sessionrestore', 17:42:11 INFO - 'sessionrestore_no_auto_restore', 17:42:11 INFO - 'tabpaint']}, 17:42:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['a11yr', 17:42:11 INFO - 'ts_paint', 17:42:11 INFO - 'tpaint', 17:42:11 INFO - 'sessionrestore', 17:42:11 INFO - 'sessionrestore_no_auto_restore', 17:42:11 INFO - 'tabpaint']}, 17:42:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['a11yr', 17:42:11 INFO - 'ts_paint', 17:42:11 INFO - 'tpaint', 17:42:11 INFO - 'sessionrestore', 17:42:11 INFO - 'sessionrestore_no_auto_restore', 17:42:11 INFO - 'tabpaint']}, 17:42:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['tsvgx', 17:42:11 INFO - 'tsvgr_opacity', 17:42:11 INFO - 'tart', 17:42:11 INFO - 'tscrollx', 17:42:11 INFO - 'cart']}, 17:42:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:11 INFO - 'tsvgr_opacity', 17:42:11 INFO - 'tart', 17:42:11 INFO - 'tscrollx', 17:42:11 INFO - 'cart']}, 17:42:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'talos_options': ['--disable-e10s'], 17:42:11 INFO - 'tests': ['tp5o']}, 17:42:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'tests': ['tp5o']}, 17:42:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'talos_options': ['--disable-e10s', 17:42:11 INFO - '--xperf_path', 17:42:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:11 INFO - 'tests': ['tp5n']}, 17:42:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:11 INFO - 'talos_options': ['--xperf_path', 17:42:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:11 INFO - 'tests': ['tp5n']}}, 17:42:11 INFO - 'talos.zip': {'path': '', 17:42:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:11 INFO - Running post-action listener: _resource_record_post_action 17:42:11 INFO - [mozharness: 2016-08-19 00:42:11.333480Z] Finished populate-webroot step (success) 17:42:11 INFO - [mozharness: 2016-08-19 00:42:11.333587Z] Running create-virtualenv step. 17:42:11 INFO - Running pre-action listener: _resource_record_pre_action 17:42:11 INFO - Running main action method: create_virtualenv 17:42:11 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:11 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 17:42:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:11 INFO - Using real prefix '/usr' 17:42:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:11 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:13 INFO - Installing pip.................done. 17:42:13 INFO - Return code: 0 17:42:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:42:13 INFO - Using env: {'DISPLAY': ':0', 17:42:13 INFO - 'HOME': '/home/cltbld', 17:42:13 INFO - 'LANG': 'en_US.UTF-8', 17:42:13 INFO - 'LANGUAGE': 'en_US:en', 17:42:13 INFO - 'LOGNAME': 'cltbld', 17:42:13 INFO - 'MAIL': '/var/mail/cltbld', 17:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:13 INFO - 'MOZ_NO_REMOTE': '1', 17:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:13 INFO - 'NO_EM_RESTART': '1', 17:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:13 INFO - 'PWD': '/builds/slave/test', 17:42:13 INFO - 'SHELL': '/bin/bash', 17:42:13 INFO - 'SHLVL': '1', 17:42:13 INFO - 'TERM': 'linux', 17:42:13 INFO - 'TMOUT': '86400', 17:42:13 INFO - 'USER': 'cltbld', 17:42:13 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:13 INFO - '_': '/tools/buildbot/bin/python'} 17:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:14 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 17:42:14 INFO - Cleaning up... 17:42:14 INFO - Return code: 0 17:42:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:42:14 INFO - Using env: {'DISPLAY': ':0', 17:42:14 INFO - 'HOME': '/home/cltbld', 17:42:14 INFO - 'LANG': 'en_US.UTF-8', 17:42:14 INFO - 'LANGUAGE': 'en_US:en', 17:42:14 INFO - 'LOGNAME': 'cltbld', 17:42:14 INFO - 'MAIL': '/var/mail/cltbld', 17:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:14 INFO - 'MOZ_NO_REMOTE': '1', 17:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:14 INFO - 'NO_EM_RESTART': '1', 17:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:14 INFO - 'PWD': '/builds/slave/test', 17:42:14 INFO - 'SHELL': '/bin/bash', 17:42:14 INFO - 'SHLVL': '1', 17:42:14 INFO - 'TERM': 'linux', 17:42:14 INFO - 'TMOUT': '86400', 17:42:14 INFO - 'USER': 'cltbld', 17:42:14 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:14 INFO - '_': '/tools/buildbot/bin/python'} 17:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:14 INFO - Downloading/unpacking psutil>=3.1.1 17:42:14 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 17:42:14 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 17:42:14 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 17:42:14 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 17:42:14 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 17:42:14 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 17:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:16 INFO - Installing collected packages: psutil 17:42:16 INFO - Running setup.py install for psutil 17:42:16 INFO - building 'psutil._psutil_linux' extension 17:42:16 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 17:42:16 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 17:42:16 INFO - building 'psutil._psutil_posix' extension 17:42:16 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 17:42:16 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 17:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:16 INFO - Successfully installed psutil 17:42:16 INFO - Cleaning up... 17:42:16 INFO - Return code: 0 17:42:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:42:16 INFO - Using env: {'DISPLAY': ':0', 17:42:16 INFO - 'HOME': '/home/cltbld', 17:42:16 INFO - 'LANG': 'en_US.UTF-8', 17:42:16 INFO - 'LANGUAGE': 'en_US:en', 17:42:16 INFO - 'LOGNAME': 'cltbld', 17:42:16 INFO - 'MAIL': '/var/mail/cltbld', 17:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:16 INFO - 'MOZ_NO_REMOTE': '1', 17:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:16 INFO - 'NO_EM_RESTART': '1', 17:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:16 INFO - 'PWD': '/builds/slave/test', 17:42:16 INFO - 'SHELL': '/bin/bash', 17:42:16 INFO - 'SHLVL': '1', 17:42:16 INFO - 'TERM': 'linux', 17:42:16 INFO - 'TMOUT': '86400', 17:42:16 INFO - 'USER': 'cltbld', 17:42:16 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:16 INFO - '_': '/tools/buildbot/bin/python'} 17:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:17 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 17:42:17 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 17:42:17 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 17:42:17 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 17:42:17 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 17:42:17 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 17:42:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:19 INFO - Installing collected packages: mozsystemmonitor 17:42:19 INFO - Running setup.py install for mozsystemmonitor 17:42:19 INFO - Successfully installed mozsystemmonitor 17:42:19 INFO - Cleaning up... 17:42:19 INFO - Return code: 0 17:42:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:42:19 INFO - Using env: {'DISPLAY': ':0', 17:42:19 INFO - 'HOME': '/home/cltbld', 17:42:19 INFO - 'LANG': 'en_US.UTF-8', 17:42:19 INFO - 'LANGUAGE': 'en_US:en', 17:42:19 INFO - 'LOGNAME': 'cltbld', 17:42:19 INFO - 'MAIL': '/var/mail/cltbld', 17:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:19 INFO - 'MOZ_NO_REMOTE': '1', 17:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:19 INFO - 'NO_EM_RESTART': '1', 17:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:19 INFO - 'PWD': '/builds/slave/test', 17:42:19 INFO - 'SHELL': '/bin/bash', 17:42:19 INFO - 'SHLVL': '1', 17:42:19 INFO - 'TERM': 'linux', 17:42:19 INFO - 'TMOUT': '86400', 17:42:19 INFO - 'USER': 'cltbld', 17:42:19 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:19 INFO - '_': '/tools/buildbot/bin/python'} 17:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:19 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 17:42:19 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 17:42:19 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 17:42:19 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 17:42:19 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 17:42:19 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 17:42:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:21 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 17:42:21 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 17:42:21 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 17:42:21 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 17:42:21 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 17:42:21 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 17:42:21 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:21 INFO - warning: no files found matching '*.txt' 17:42:21 INFO - no previously-included directories found matching 'build' 17:42:21 INFO - no previously-included directories found matching 'dist' 17:42:21 INFO - no previously-included directories found matching '.git*' 17:42:21 INFO - Installing collected packages: jsonschema, functools32 17:42:21 INFO - Running setup.py install for functools32 17:42:21 INFO - warning: no files found matching '*.txt' 17:42:21 INFO - no previously-included directories found matching 'build' 17:42:21 INFO - no previously-included directories found matching 'dist' 17:42:21 INFO - no previously-included directories found matching '.git*' 17:42:21 INFO - Successfully installed jsonschema functools32 17:42:21 INFO - Cleaning up... 17:42:21 INFO - Return code: 0 17:42:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:42:21 INFO - Using env: {'DISPLAY': ':0', 17:42:21 INFO - 'HOME': '/home/cltbld', 17:42:21 INFO - 'LANG': 'en_US.UTF-8', 17:42:21 INFO - 'LANGUAGE': 'en_US:en', 17:42:21 INFO - 'LOGNAME': 'cltbld', 17:42:21 INFO - 'MAIL': '/var/mail/cltbld', 17:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:21 INFO - 'MOZ_NO_REMOTE': '1', 17:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:21 INFO - 'NO_EM_RESTART': '1', 17:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:21 INFO - 'PWD': '/builds/slave/test', 17:42:21 INFO - 'SHELL': '/bin/bash', 17:42:21 INFO - 'SHLVL': '1', 17:42:21 INFO - 'TERM': 'linux', 17:42:21 INFO - 'TMOUT': '86400', 17:42:21 INFO - 'USER': 'cltbld', 17:42:21 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:21 INFO - '_': '/tools/buildbot/bin/python'} 17:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:21 INFO - Cleaning up... 17:42:21 INFO - Return code: 0 17:42:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:42:21 INFO - Using env: {'DISPLAY': ':0', 17:42:21 INFO - 'HOME': '/home/cltbld', 17:42:21 INFO - 'LANG': 'en_US.UTF-8', 17:42:21 INFO - 'LANGUAGE': 'en_US:en', 17:42:21 INFO - 'LOGNAME': 'cltbld', 17:42:21 INFO - 'MAIL': '/var/mail/cltbld', 17:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:21 INFO - 'MOZ_NO_REMOTE': '1', 17:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:21 INFO - 'NO_EM_RESTART': '1', 17:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:21 INFO - 'PWD': '/builds/slave/test', 17:42:21 INFO - 'SHELL': '/bin/bash', 17:42:21 INFO - 'SHLVL': '1', 17:42:21 INFO - 'TERM': 'linux', 17:42:21 INFO - 'TMOUT': '86400', 17:42:21 INFO - 'USER': 'cltbld', 17:42:21 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:21 INFO - '_': '/tools/buildbot/bin/python'} 17:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:22 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 17:42:22 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 17:42:22 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 17:42:22 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 17:42:22 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 17:42:22 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 17:42:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 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 17:42:24 INFO - Downloading docopt-0.6.1.tar.gz 17:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:24 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:24 INFO - Running setup.py install for blobuploader 17:42:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:24 INFO - Running setup.py install for requests 17:42:25 INFO - Running setup.py install for docopt 17:42:25 INFO - Successfully installed blobuploader requests docopt 17:42:25 INFO - Cleaning up... 17:42:25 INFO - Return code: 0 17:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:25 INFO - Using env: {'DISPLAY': ':0', 17:42:25 INFO - 'HOME': '/home/cltbld', 17:42:25 INFO - 'LANG': 'en_US.UTF-8', 17:42:25 INFO - 'LANGUAGE': 'en_US:en', 17:42:25 INFO - 'LOGNAME': 'cltbld', 17:42:25 INFO - 'MAIL': '/var/mail/cltbld', 17:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:25 INFO - 'MOZ_NO_REMOTE': '1', 17:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:25 INFO - 'NO_EM_RESTART': '1', 17:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:25 INFO - 'PWD': '/builds/slave/test', 17:42:25 INFO - 'SHELL': '/bin/bash', 17:42:25 INFO - 'SHLVL': '1', 17:42:25 INFO - 'TERM': 'linux', 17:42:25 INFO - 'TMOUT': '86400', 17:42:25 INFO - 'USER': 'cltbld', 17:42:25 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:25 INFO - '_': '/tools/buildbot/bin/python'} 17:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:25 INFO - Running setup.py (path:/tmp/pip-IkkT4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:25 INFO - Running setup.py (path:/tmp/pip-kbbal_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:25 INFO - Running setup.py (path:/tmp/pip-Uk9Va9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:25 INFO - Running setup.py (path:/tmp/pip-evfpH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:25 INFO - Running setup.py (path:/tmp/pip-QbPDfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:26 INFO - Running setup.py (path:/tmp/pip-0E35pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:26 INFO - Running setup.py (path:/tmp/pip-eIG41j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:26 INFO - Running setup.py (path:/tmp/pip-tCs2GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:26 INFO - Running setup.py (path:/tmp/pip-8LkblZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:26 INFO - Running setup.py (path:/tmp/pip-HEH5Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:26 INFO - Running setup.py (path:/tmp/pip-6_z7cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:26 INFO - Running setup.py (path:/tmp/pip-qfFDd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:26 INFO - Running setup.py (path:/tmp/pip-bVGTiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:26 INFO - Running setup.py (path:/tmp/pip-WpcO5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:26 INFO - Running setup.py (path:/tmp/pip-VoQ__Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:26 INFO - Running setup.py (path:/tmp/pip-iN3JOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:26 INFO - Running setup.py (path:/tmp/pip-545xdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:26 INFO - Running setup.py install for manifestparser 17:42:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:26 INFO - Running setup.py install for mozcrash 17:42:27 INFO - Running setup.py install for mozdebug 17:42:27 INFO - Running setup.py install for mozdevice 17:42:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Running setup.py install for mozfile 17:42:27 INFO - Running setup.py install for mozhttpd 17:42:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Running setup.py install for mozinfo 17:42:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Running setup.py install for mozInstall 17:42:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Running setup.py install for mozleak 17:42:27 INFO - Running setup.py install for mozlog 17:42:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Running setup.py install for moznetwork 17:42:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:27 INFO - Running setup.py install for mozprocess 17:42:28 INFO - Running setup.py install for mozprofile 17:42:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:28 INFO - Running setup.py install for mozrunner 17:42:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:28 INFO - Running setup.py install for mozscreenshot 17:42:28 INFO - Running setup.py install for moztest 17:42:28 INFO - Running setup.py install for mozversion 17:42:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:28 INFO - Cleaning up... 17:42:28 INFO - Return code: 0 17:42:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:28 INFO - Using env: {'DISPLAY': ':0', 17:42:28 INFO - 'HOME': '/home/cltbld', 17:42:28 INFO - 'LANG': 'en_US.UTF-8', 17:42:28 INFO - 'LANGUAGE': 'en_US:en', 17:42:28 INFO - 'LOGNAME': 'cltbld', 17:42:28 INFO - 'MAIL': '/var/mail/cltbld', 17:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:28 INFO - 'MOZ_NO_REMOTE': '1', 17:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:28 INFO - 'NO_EM_RESTART': '1', 17:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:28 INFO - 'PWD': '/builds/slave/test', 17:42:28 INFO - 'SHELL': '/bin/bash', 17:42:28 INFO - 'SHLVL': '1', 17:42:28 INFO - 'TERM': 'linux', 17:42:28 INFO - 'TMOUT': '86400', 17:42:28 INFO - 'USER': 'cltbld', 17:42:28 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:28 INFO - '_': '/tools/buildbot/bin/python'} 17:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:28 INFO - Running setup.py (path:/tmp/pip-zKwhSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:28 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)) 17:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:28 INFO - Running setup.py (path:/tmp/pip-arZrSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:29 INFO - Running setup.py (path:/tmp/pip-qJCBHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:29 INFO - Running setup.py (path:/tmp/pip-8N38s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:29 INFO - Running setup.py (path:/tmp/pip-dc15iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:29 INFO - Running setup.py (path:/tmp/pip-uzVEOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:29 INFO - Running setup.py (path:/tmp/pip-wSAMED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:29 INFO - Running setup.py (path:/tmp/pip-zMWFEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:29 INFO - Running setup.py (path:/tmp/pip-kHDV1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:29 INFO - Running setup.py (path:/tmp/pip-9lnlAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:29 INFO - Running setup.py (path:/tmp/pip-SoJb3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:29 INFO - Running setup.py (path:/tmp/pip-TarCVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:29 INFO - Running setup.py (path:/tmp/pip-IF8gHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:29 INFO - Running setup.py (path:/tmp/pip-8h5WYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:29 INFO - Running setup.py (path:/tmp/pip-_EaLN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:29 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)) 17:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:29 INFO - Running setup.py (path:/tmp/pip-lPxa_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:30 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)) 17:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:30 INFO - Running setup.py (path:/tmp/pip-ElgtOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:30 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)) 17:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:42:30 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)) 17:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:30 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 17:42:30 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 17:42:30 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 17:42:30 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 17:42:30 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 17:42:30 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 17:42:31 INFO - Downloading blessings-1.6.tar.gz 17:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:31 INFO - Installing collected packages: blessings 17:42:31 INFO - Running setup.py install for blessings 17:42:31 INFO - Successfully installed blessings 17:42:31 INFO - Cleaning up... 17:42:31 INFO - Return code: 0 17:42:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:31 INFO - Reading from file tmpfile_stdout 17:42:31 INFO - Current package versions: 17:42:31 INFO - argparse == 1.2.1 17:42:31 INFO - blessings == 1.6 17:42:31 INFO - blobuploader == 1.2.4 17:42:31 INFO - docopt == 0.6.1 17:42:31 INFO - functools32 == 3.2.3-2 17:42:31 INFO - jsonschema == 2.5.1 17:42:31 INFO - manifestparser == 1.1 17:42:31 INFO - mozInstall == 1.12 17:42:31 INFO - mozcrash == 0.17 17:42:31 INFO - mozdebug == 0.1 17:42:31 INFO - mozdevice == 0.48 17:42:31 INFO - mozfile == 1.2 17:42:31 INFO - mozhttpd == 0.7 17:42:31 INFO - mozinfo == 0.9 17:42:31 INFO - mozleak == 0.1 17:42:31 INFO - mozlog == 3.3 17:42:31 INFO - moznetwork == 0.27 17:42:31 INFO - mozprocess == 0.23 17:42:31 INFO - mozprofile == 0.28 17:42:31 INFO - mozrunner == 6.12 17:42:31 INFO - mozscreenshot == 0.1 17:42:31 INFO - mozsystemmonitor == 0.3 17:42:31 INFO - moztest == 0.7 17:42:31 INFO - mozversion == 1.4 17:42:31 INFO - psutil == 3.1.1 17:42:31 INFO - requests == 1.2.3 17:42:31 INFO - wsgiref == 0.1.2 17:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:42:31 INFO - Using env: {'DISPLAY': ':0', 17:42:31 INFO - 'HOME': '/home/cltbld', 17:42:31 INFO - 'LANG': 'en_US.UTF-8', 17:42:31 INFO - 'LANGUAGE': 'en_US:en', 17:42:31 INFO - 'LOGNAME': 'cltbld', 17:42:31 INFO - 'MAIL': '/var/mail/cltbld', 17:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:31 INFO - 'MOZ_NO_REMOTE': '1', 17:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:31 INFO - 'NO_EM_RESTART': '1', 17:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:31 INFO - 'PWD': '/builds/slave/test', 17:42:31 INFO - 'SHELL': '/bin/bash', 17:42:31 INFO - 'SHLVL': '1', 17:42:31 INFO - 'TERM': 'linux', 17:42:31 INFO - 'TMOUT': '86400', 17:42:31 INFO - 'USER': 'cltbld', 17:42:31 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:31 INFO - '_': '/tools/buildbot/bin/python'} 17:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 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)) 17:42:31 INFO - Cleaning up... 17:42:31 INFO - Return code: 0 17:42:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658d3c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, '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': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', '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 17:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:42:31 INFO - Using env: {'DISPLAY': ':0', 17:42:31 INFO - 'HOME': '/home/cltbld', 17:42:31 INFO - 'LANG': 'en_US.UTF-8', 17:42:31 INFO - 'LANGUAGE': 'en_US:en', 17:42:31 INFO - 'LOGNAME': 'cltbld', 17:42:31 INFO - 'MAIL': '/var/mail/cltbld', 17:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:31 INFO - 'MOZ_NO_REMOTE': '1', 17:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:31 INFO - 'NO_EM_RESTART': '1', 17:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:31 INFO - 'PWD': '/builds/slave/test', 17:42:31 INFO - 'SHELL': '/bin/bash', 17:42:31 INFO - 'SHLVL': '1', 17:42:31 INFO - 'TERM': 'linux', 17:42:31 INFO - 'TMOUT': '86400', 17:42:31 INFO - 'USER': 'cltbld', 17:42:31 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:31 INFO - '_': '/tools/buildbot/bin/python'} 17:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:42:31 INFO - Cleaning up... 17:42:31 INFO - Return code: 0 17:42:31 INFO - Running post-action listener: _resource_record_post_action 17:42:31 INFO - Running post-action listener: _start_resource_monitoring 17:42:32 INFO - Starting resource monitoring. 17:42:32 INFO - [mozharness: 2016-08-19 00:42:32.013256Z] Finished create-virtualenv step (success) 17:42:32 INFO - [mozharness: 2016-08-19 00:42:32.013977Z] Running install step. 17:42:32 INFO - Running pre-action listener: _resource_record_pre_action 17:42:32 INFO - Running main action method: install 17:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:32 INFO - Reading from file tmpfile_stdout 17:42:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:32 INFO - Reading from file tmpfile_stdout 17:42:32 INFO - Output received: 17:42:32 INFO - Usage: mozinstall [options] installer 17:42:32 INFO - Options: 17:42:32 INFO - -h, --help show this help message and exit 17:42:32 INFO - -d DEST, --destination=DEST 17:42:32 INFO - Directory to install application into. [default: 17:42:32 INFO - "/builds/slave/test"] 17:42:32 INFO - --app=APP Application being installed. [default: firefox] 17:42:32 INFO - mkdir: /builds/slave/test/build/application 17:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:42:48 INFO - Reading from file tmpfile_stdout 17:42:48 INFO - Output received: 17:42:48 INFO - /builds/slave/test/build/application/firefox/firefox 17:42:48 INFO - Running post-action listener: _resource_record_post_action 17:42:48 INFO - [mozharness: 2016-08-19 00:42:48.441384Z] Finished install step (success) 17:42:48 INFO - [mozharness: 2016-08-19 00:42:48.441705Z] Running run-tests step. 17:42:48 INFO - Running pre-action listener: _resource_record_pre_action 17:42:48 INFO - Running main action method: run_tests 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:48 INFO - Python 2.7.3 17:42:48 INFO - Return code: 0 17:42:48 INFO - grabbing minidump binary from tooltool 17:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1486090>, '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 0x14899b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1489e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:48 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 17:42:48 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 17:42:48 INFO - Calling ['/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'] with output_timeout 600 17:42:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:48 INFO - Return code: 0 17:42:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:42:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:42:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:42:48 INFO - Using env: {'DISPLAY': ':0', 17:42:48 INFO - 'HOME': '/home/cltbld', 17:42:48 INFO - 'LANG': 'en_US.UTF-8', 17:42:48 INFO - 'LANGUAGE': 'en_US:en', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MAIL': '/var/mail/cltbld', 17:42:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SHLVL': '1', 17:42:48 INFO - 'TERM': 'linux', 17:42:48 INFO - 'TMOUT': '86400', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - '_': '/tools/buildbot/bin/python'} 17:42:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:42:48 INFO - mozversion application_buildid: 20160818163358 17:42:48 INFO - mozversion application_changeset: abac53d4d2476c4ab1816844091989456b8993bf 17:42:48 INFO - mozversion application_display_name: Nightly 17:42:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:48 INFO - mozversion application_name: Firefox 17:42:48 INFO - mozversion application_remotingname: firefox 17:42:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:42:48 INFO - mozversion application_vendor: Mozilla 17:42:48 INFO - mozversion application_version: 51.0a1 17:42:48 INFO - mozversion platform_buildid: 20160818163358 17:42:48 INFO - mozversion platform_changeset: abac53d4d2476c4ab1816844091989456b8993bf 17:42:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:42:48 INFO - mozversion platform_version: 51.0a1 17:42:48 INFO - using testdate: 1471567368 17:42:48 INFO - actual date: 1471567368 17:42:48 INFO - starting webserver on 'localhost:59578' 17:42:48 INFO - SUITE-START | Running 2 tests 17:42:48 INFO - TEST-START | dromaeo_css 17:42:48 INFO - operating with platform_type : linux_ 17:42:48 INFO - Initialising browser for dromaeo_css test... 17:42:48 INFO - TEST-INFO | started process 7772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCO_4na/profile http://localhost:59578/getInfo.html) 17:42:53 INFO - PROCESS | 7772 | __metrics Screen width/height:1600/1200 17:42:53 INFO - PROCESS | 7772 | colorDepth:24 17:42:53 INFO - PROCESS | 7772 | Browser inner width/height: 1024/697 17:42:53 INFO - PROCESS | 7772 | __metrics 17:42:54 ERROR - PROCESS | 7772 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:42:54 INFO - TEST-INFO | 7772: exit 0 17:42:54 INFO - Browser initialized. 17:42:54 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:54 INFO - TEST-INFO | started process 7890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCO_4na/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:06 INFO - PROCESS | 7890 | RSS: Main: 164118528 17:43:06 INFO - PROCESS | 7890 | 17:43:56 INFO - PROCESS | 7890 | 1471567436450 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] 17:46:09 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:59578/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59578/tests/dromaeo/cssquery-ext.html) 17:46:10 INFO - PROCESS | 7890 | RSS: Main: 164323328 17:46:10 INFO - PROCESS | 7890 | 17:49:12 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:59578/tests/dromaeo/cssquery-ext.html (next: http://localhost:59578/tests/dromaeo/cssquery-jquery.html) 17:49:13 INFO - PROCESS | 7890 | RSS: Main: 166068224 17:49:13 INFO - PROCESS | 7890 | 17:52:15 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:59578/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59578/tests/dromaeo/cssquery-mootools.html) 17:52:16 INFO - PROCESS | 7890 | RSS: Main: 166674432 17:52:16 INFO - PROCESS | 7890 | 17:55:18 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:59578/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59578/tests/dromaeo/cssquery-prototype.html) 17:55:18 INFO - PROCESS | 7890 | RSS: Main: 164196352 17:55:18 INFO - PROCESS | 7890 | 17:58:21 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:59578/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59578/tests/dromaeo/cssquery-yui.html) 17:58:22 INFO - PROCESS | 7890 | RSS: Main: 165548032 17:58:22 INFO - PROCESS | 7890 | 18:01:24 INFO - PROCESS | 7890 | Cycle 1(1): loaded http://localhost:59578/tests/dromaeo/cssquery-yui.html (next: http://localhost:59578/tests/dromaeo/cssquery-dojo.html) 18:01:25 INFO - PROCESS | 7890 | RSS: Main: 166969344 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | __start_tp_report 18:01:25 INFO - PROCESS | 7890 | _x_x_mozilla_page_load 18:01:25 INFO - PROCESS | 7890 | _x_x_mozilla_page_load_details 18:01:25 INFO - PROCESS | 7890 | |i|pagename|runs| 18:01:25 INFO - PROCESS | 7890 | |0;dojo.html;2576.6521519594853;2636.3804505941102;2650.0062476571275;2650.350664087299;2664.600309953508;4513.503514613398;4672.439307283126;4684.391029166208;4741.786619602118;4779.378680771503;4577.679562430623;4631.606313463351;4640.930386044212;4645.001324715186;4668.649851261161;4266.210751011057;4326.113146804905;4347.673924455663;4351.934720979188;4372.27857403528;4269.978650106745;4395.560443955611;4403.471583409995;4423.491298500665;4449.532799056101;4339.500957389878;4406.669499787513;4431.468223813131;4431.6233120184825;4433.334999750031;4214.726042807208;4276.166147601219;4285.485741711014;4311.1593239318345;4413.624841888443;4282.614564689193;4286.185624731323;4297.634701050414;4302.526722060571;4345.435093437864;4704.835330763407;4710.3405523226775;4718.905621887543;4738.526147385269;4757.048590281923;4951.950480495185;5008.073506401327;5015.523525265094;5047.242913562958;5065.11360511909;5043.899122017576;5065.696058236481;5074.771635276385;5093.668911520739;5126.051680439094;4500.819967201341;4706.9764651176865;4719.669623126349;4727.078219747116;4763.428388593322;5108.591312694975;5145.76844042019;5178.300929374562;5182.144946083854;5234.450382709837;4952.777125029383;4963.652544321935;4989.650724449326;4994.300797888299;5024.79900803971;4822.059698358787;5072.619553533426;5076.238564215323;5076.340075790197;5079.161938280143;4736.076465089343;4877.073356062337;4884.7069175849565;4922.507749225048;4934.5312195341385;4919.0899683558655;4926.630502712311;4947.183714687037;4947.5794557462295;4965.255211718271;4204.642605378516;4206.47419072616;4213.894652633648;4224.028473451062;4232.428622135973;3593.6047034826147;3623.166671665479;3650.79920604364;3670.33933891902;3676.9448458273146;4269.829206831754;4321.0709697415205;4336.067745434747;4337.9132417351475;4368.104538569585;4988.850334489971;5035.345405097387;5036.823711170092;5037.0681423936685;5081;4212.136512015029;4285.0358669299785;4316.352547117957;4338.262495375794;4350.477942646902;4538.591526762607;4543.045960348298;4553.977230113828;4569.95430045702;4572.725636461756;4769;4771.23660214364;4785.066911952275;4790.089882922233;4827.034593081468;4895.069936712013;4989.975050124726;5047.394312682502;5058.443571207091;5076.568491678248;4765.642576806684;4778.522147785194;4784.976075119741;4814.109389762905;4822.565969062801;4988.900221995467;4992.350994370854;4992.850214493571;5004.049230646166;5051.74741262928;4914.238293064581;4917.950820491749;4983.651144419856;4996.2755400466;5061.063703214917;4857.732824694675;4865.464798872051;4872.634552408513;4875.1224779540025;4912.361393018885;4849.199882019428;4863.829765958175;4866.926996095132;4869.70781753096;4913.950860491493;4548.909021819612;4609.193391156467;4649.0469453761225;4691.225947718588;4774.594159496482;4795.640326975421;4862.805487780449;4921.384826896638;4951.059298733229;5012.548870601663;4813.4945830687275;4814.422269327703;4828.275758636232;4836.782344794563;4878.609711223165 18:01:25 INFO - PROCESS | 7890 | |1;ext.html;557.1197507937459;563.6505366672662;580.4137820800989;583.2301362201893;591.1753104419333;35313.11717207068;39378;39414.802925985365;39466;39466;38981;39398.606013939854;39412.40881386774;39417.8029109854;39421;7554.055743032121;7682.923170768305;7734.651940662656;7747.728829490969;7750.612469376537;7549.584772837492;7604.885926711104;7656.961715191416;7675.577843218621;7679.616019199046;7615.086189657249;7637.618119094051;7649.732259370923;7677.155512893605;7694.499857509272;7607.315341619225;7652;7676.385889128912;7679.846403071907;7684.807879802994;7533.322001019879;7574.8485030299635;7590.278923502258;7622.5426474411715;7640.701080816275;37110.07224819401;37299.81350093259;37516.43725344122;37658.246835063146;37674.623253767386;2928.560715892612;3048.5731997520365;3061.9081427557207;3068.6471055828642;3116.719495245439;29397.412051758845;29524.40951180986;29810.55284170739;30275.848620756977;31346.373072538423;3164.0982320038906;3204.1829333520036;3227.4029304578494;3291.9835400822844;3308.9172770680684;263097;263323;263623;263798.0682704423;264212;31217.375652486822;31991.20021999422;32165.195870102965;33390;51963.22055169175;32984.175395615304;33162.83418582891;33173.17067073294;33187.66812331894;33223.16942076419;12260.14179007461;12281.815772763415;12291.56979505713;12300.692482688004;12369.257844529357;10527.420991845369;10616.681499555025;10627.84058239127;10648.467576621293;10653.307535010199;7725.266099720518;7735.7679269622;7801.765947021599;7822.1786712395515;7844.921550784533;3093.3040065984974;3111.8910838120555;3117.3297740985795;3177.0468859342104;3209.0533292678715;831.2850948184556;870.9608067636972;875.3216257400438;916.9729902509099;941.0824446165071;27208.31979200496;27991.72008279932;28027.60098617477;28199.57700634492;28536.571951420745;894.351595093552;923.4136323434667;924.5515924776478;942.5381563034064;957.4494665567327;13927;14783.704325913637;14813.703725925636;15120;15151.393944242327;125930;126169.36915315365;126247;126475.36762316314;377474;48945.75527122342;49028.75485622549;49087.26369104466;49337.50662493401;49510.75244623754;1142.4744617476053;1158.0330424095805;1170.5317872850758;1174.4010554617037;1177.988220117788;26106.608400874382;26796.866015669795;27867.44265114646;27932;28145.859270703517;41588.79205603953;42035.579644203164;42042.369364458944;42118;42135.578644214394;307312;309447.31908511434;309753.3172677891;310094;310372;24649.260522184362;24914.626280606168;24988;25071.87464062668;25098.62352064757;38996.220075598896;42262.5773742271;42833;42867.57132428761;42932.570674294104;35109.648903510635;35293.82353088321;36089.27821443504;36338;36426.4536031965;35770;35793.64206357903;35894;35995.46006809952;36099;35013.47479787754;35282.11794705153;35363.46954795731;35587.82206089057;35609.64390356167;31354.21614459657;32737.34525309433;32823.83588082044;32989.17527061843;33122.83438582792;25437.236882893543;25492.23523294304;25562.23313300604;25692.357691057874;25822.87088564545 18:01:25 INFO - PROCESS | 7890 | |2;jquery.html;359.98020108894;367.2214904402667;374.23469005882964;378.75381002348485;391.2175648702595;16189.190540472973;16903.91548042258;17158.65682686347;17348.566285842844;17548.385806496775;14101.929490352533;14379.92810035951;15833;16389.67220655586;16429.507114786546;4781.40232470942;5061.898762024757;5074.923876141861;5075.340205773245;5076.086304465195;3681.7606855554304;5054.342935418391;5589.245451863987;5768.336641286264;5811.331696854873;5892.705364731768;5893.705314734268;5895.115732640095;5905.468507834294;5907.704614769265;5728.77084916605;5969.164316995624;5995.6702381369005;6006.489448396892;6008.279006519202;5206.062908676437;5222.451642577551;5227.268182454422;5253.711045892513;6427.807165785034;21617;22285.888570557207;23417;23453.179138730233;23641.172558960527;1897.5634806280045;1910.2263583248669;1927.5662975830467;1945.066368143285;1945.8929758863258;13754.518591849337;13990.720185596332;14703.852961470355;14704.705905881823;14811.851881481263;1751.8773685841995;1759.6744602248625;1794.865385096123;1801.639672065592;1860.5069656541027;81016;82230;83019.5849020757;85061.57469212676;85758;16080.597985050468;16416.917915410584;16727;16810.411635592696;16909.985400875987;28418.857905710753;28503.429931401257;28547;28606.570901436495;28693.426131477252;8441.198086181927;8540.184671039497;8628.050914399411;8877.467351958903;8926.241269492037;7295.088113985752;7376.561570493702;7394.630268486554;7533.359664428475;7548.698052077965;8108.9594552026865;8280.751577452686;8555.657773689107;8560.785980350542;8606.225439710455;1490.8509149085005;1578.3449868304524;1620.1089400829496;3045.8629361678777;3236.0453666168537;804.9154838741965;841.0790184747691;895.6148855991855;929.0848514213494;966.087047739879;15597.766033509506;16175.838241617434;16211.351545938267;16377.67244655124;16917.7462338065;813.589137485566;854.0903937306748;866.956652167389;871.1549796697194;871.6861929705301;8979.416337938013;9529.428234305964;9570.808583828284;9600.903990960142;9619.615215391446;388670;392349;393149.4452860555;396206;396749;78800;79100.20899791043;79166;79225;83612.58193708993;897.4839467306325;901.8602116671926;944.4003058058045;950.0309684122157;963.734972882477;15583.532494025198;15780.447684330993;16017.199140043183;16045.19774011318;16256.67486650284;39401.60598393979;39657.80171099126;39710.205795884496;39727.40408893926;40250.59749402585;52818;53859.461405385446;54854.177187341425;55601.605815330135;56009.71995140161;7409.259074092548;7425.220351862977;7609.847803044019;7613.733519326797;7871.685132594632;11620.360880151673;11898.167128300936;11977.341246231192;12022;12292;10042.849357259793;10048.69853904384;10197.337173083726;10265.743356415851;10504.842427363443;10145.898541014496;10227.43749093807;10279.486025698834;10330.535125919501;10692.679219623424;10085.142762865238;10134.695959121238;10182.134518566005;10192.949035254776;10370.896291036994;7201.063861697946;7226.421886248982;7256.564606123649;7412.962185294171;7788.182240864628;8398.622062007347;9550.570224339783;9723.319367644197;10110.848337275094;10165.54255058539 18:01:25 INFO - PROCESS | 7890 | |3;mootools.html;1364.9454021839126;1405.0235086614803;1475.333795518138;1626.642138729479;1676.3629820668152;6570.802875913719;7220;7472.887906681391;7825.178356272595;7889.053313602369;7570.31867131958;7805.843883122334;7820.92179078209;7826.608669566527;7841.4118941079505;2171.978280217197;2215.1360969222014;2216.8780717060554;2217.6784366266884;2222.0778376973617;2139.743230812305;2173.880436575988;2225.143319821872;2238.149503188786;2239.608068587999;2178.2485042660337;2187.212603462752;2191.791779780918;2200.713907192063;2238.6977758002704;2138.1661152150673;2141.3682963525644;2141.496748264157;2144.8176904963098;2149.1188612668807;2127.5000374911883;2147.3879944215823;2171.4245724882917;2173.8586991845636;2175.380016695234;7933.563653999027;8004.159563245892;8013.759587212393;8028.919710802876;8043.356531477526;4207.1375368049785;4301.677374196916;4309.396684464177;4313.352997050468;4317.633001194871;2756.986215068912;2839.858007099637;2859.1136747608307;2896.884124635012;2898.043645596948;927.1331305229564;948.5684013773786;954.0221273194961;981.3277904635277;986.1223511075149;9991.900080999098;10047.045530674573;10084.445355505444;10098.646547370807;10100;3813.4470501777087;4022.1754540319166;4047.4738284022887;4110.383442483651;4160.771157586301;8761.123887611187;8764.5179515126;8766.824663506693;8774.341924355698;8777;4409.845655402046;4433.556644335606;4439.045605194834;4439.445069366329;4441.0673758511075;3567.6967457765863;3996.120853412303;4051.9392209116886;4053.635172834459;4094;3653.1415117447377;3675.301692678436;3736.439534069857;3756.9436458453147;3765.3975363941636;1192.3025030357164;1194.4087676600138;1202.9699257518632;1203.4764877278412;1207.885250901163;642.3961476212345;819.3649921311031;824.7731873734651;825.8183199696057;850.9361797865184;5273.578113750891;5374.435684253175;5393.110136827379;5460.180972854024;5496.80761173357;392.09817419934035;394.41429477226296;401.80512451461016;406.4837656176698;409.15917788944006;3654.9817250913575;3693.242885208526;3733.6826369758332;3744.8127593620757;3826.043489127718;9426.811463770824;9652.806943861084;9767.365121267238;9768.951155244178;9787.559559819825;9726.076022777825;9754.804903902024;9764.121229089274;9764.9023509764;9770.462624555717;7273.381762550137;7300.707971681073;7331.816704582321;7354.889676654854;7504.887426688604;5284.682919024871;5310.468953104659;5315.521603055744;5458.181272809111;5480;8805;8831.69089081879;8948.73153805387;8995.910040899507;9112.863307050533;8365;8738.956305218688;8758.386912916034;8974.596143173443;9006.639734410812;6085.2393450818645;6456.709448074942;6577.473802095917;6587.308332625005;6693.732250709917;7321.74373896911;7368.263173682589;7374.815629609303;7391.704331826667;7415.925840741524;6406.519511036784;6517.576357536745;6519.478441724746;6736.157980252468;6753.561018533779;6461.353864613501;6532.379423954717;6548.116004339353;6594.142761440982;6654.534182607171;6248.312685604489;6338.556301058881;6339.587926784744;6347.587406818542;6354.078658594571;4440;4540;4562;4570.748608826547;4582.266837306149;4682.906341873076;4700.694454860423;4745.264484004984;4805.9038819224115;4973.179425394769 18:01:25 INFO - PROCESS | 7890 | |4;prototype.html;293.99265018374535;294.34214530524275;303.95592639067337;306.598356153439;311.22504962643023;4786.856394308167;4850.660453768238;4912.975435122824;5014.373203349586;5022.874428139298;4852.878678033051;4887.169181239189;4896.436909755379;4896.53482919123;4917.21324588066;3901.9369794711015;3902.57555992063;3920.8039598020127;3932.5280966284085;3935.8782746917136;3643.344198044351;3912.2762288976633;3917.745346552479;3949.1904159647347;3959.9802000989953;3805.7526260793097;3817.1602247505502;3824.7513911595797;3833.71247156463;3846.403807409842;3812.504374431334;3828.8659896903614;3834.0798208430056;3835.1974571951137;3856.749311294785;3382.4631526355233;3385.8814941477176;3397.8640854365794;3398.3373242217776;3398.5072164536004;4731.810727570893;4854.49027852074;4862.17343051682;4919.926201106986;4933.827316043921;4318.568143185687;4345.7624070068005;4357.237483440385;4359.237133501624;4373.715708478939;5149.433562308181;5159.561437277798;5162.870928226825;5185.740712964337;5206.891209060336;3457.619661837196;3670.3943849265106;3672.1003354178397;3678.9448158277646;3687.2441149564543;5365.3293338332705;5370.4629537045985;5395.190721391783;5413.565405167634;5472.616916815825;3709.8330575123646;3715.721320900889;3730.7388482806487;3746.925061498755;3752.305823422621;3813.599572044951;3816.1985982943893;3830.8659196927974;3835.386338185933;3841.193349396602;4136.834526618962;4325.870223893288;4330.307150855848;4384.386185933972;4397.9560204398185;5092.294081482744;5142.1772516397195;5142.280080788692;5149.48505149482;5163.690178589297;1210.2617403383929;1281.6091092216964;1284.3064745037761;1305.9542915998084;1306.9542566010143;865.6494119881459;879.9164079412445;897.3852910756153;904.1636486250193;904.8280826642916;4444.444444444444;4452.8218871245435;4466.240739074366;4473.373727678128;4489.281714925596;5253.3958594761325;5262.052830490472;5290.730224746033;5293.497117773805;5303.840884773463;4479.731216127043;4486.910261794811;4488.955110448919;4489;4493.73037617744;2706.6346043284298;2800.0899707595113;2848.700886406939;2849.6437945256844;2861.5993760873494;5038.2190760432195;5041.571466425322;5044.823431179964;5046.44489106198;5054.898902021939;5291.232771248147;5428.782848686087;5430.782768689287;5463.579469338;5464.961657285103;5000.774655278439;5008.347245409006;5011.874703132451;5024.246363045572;5036.496350364934;5314.060367965588;5352.384475785335;5355.277037599874;5366.785328586813;5415.404305526467;4999.725728191657;5211.296474975981;5213.921791173211;5243.528082472596;5256.500632439912;4997.1260777208545;5005.674631148963;5016.247562865599;5023.718951667302;5043.739065233692;3723.6090210527504;3728.4034554471154;3759.3233218019923;3764.811759412073;3771.905702357463;5090.440051594248;5271.762770675406;5338.866528336823;5358.919616205682;5378.489043540857;5107.923381149211;5123.666961647481;5136.794528218829;5142.665726727751;5151.5363617274625;5136.9743151284;5142.794288228579;5188.7405629719115;5232.88068332326;5257.4216836147225;4783.473817879961;4979.402471703419;5062.797488100435;5097.108006098992;5108.770105345194;5219.677243626702;5222.7127507987425;5223.373195216598;5246.842594722164;5259.921716048278;5090.898182036264;5114.4374118847645;5128.923066153936;5164.870878228075;5174.818881339135 18:01:25 INFO - PROCESS | 7890 | |5;yui.html;625.4121126141426;640.7981485831965;672.5561129654426;702.3713776170327;747.1706405889463;11353.432328383578;12244.81632775508;12247.816282755766;12249.326287054208;12309.507619695223;11951.760964780698;12051.216670916385;12055.33695646739;12066.215695979756;12070.51717931284;624.9750009999594;755.5315704263364;757.9810504737399;770.4799260499169;783.5494590610422;767.5624893810531;769.5805785846699;770.7071312901118;773.5745340062942;776.7242628866755;804.6901942752024;812.687115460549;813.3046245460135;813.5240884082818;814.4624547798425;801.519088546873;802;803.1566854802434;805.005817814998;805.2068712318362;586.7740919745886;587.1808826686748;589.3222793787179;589.6786251492904;590.6928397233414;11589.188756787029;11688.941555292255;11691.415429228504;11692.883071169264;11729;12991.415386307639;13295.734085318336;13511.256880871548;13595.388207530685;13753.724925501434;10039.196864250842;10150.99631800901;10153.949230253875;10181.796364072678;10199.235057370726;3198.440272952224;3207.615086189649;3227.4351988401936;3282.113829266085;3291.654376290479;69547.65226173887;69637.95543066908;70092;70448;71538.64230678813;10074.848877266846;10156.890176876217;10249.590016399261;10263.884551128496;10268.537915793808;20023.499412514804;20225.49436264076;20289.391318260477;20377;20918.686219706717;6357.467980835904;6460.289368169498;6535.313792051861;6537.444317233088;6549.705263263165;3378.5607870976614;3412.9829350853583;3427.5544179257035;3453.3611281912927;3669.541307336583;3029.1669790807705;3147.8111313320815;3157.700018498239;3159.462891308483;3165.9050228493184;510.8544064941474;519.9870003249949;525.4876495417014;529.428217525072;536.4260241541591;493.67910857941905;511.575392424287;543.4321134414546;555.5694336888944;570.1020892094967;7535.095788505414;8087.595620218965;8367.958160209282;8543.743687689379;8561.957190214009;492.6600645554627;577.9190913272146;600.7897235967464;616.8149555133532;624.8937680594219;3819.1979684266616;3904.6876249899938;3964.364589928569;4008.158286759755;4173.269677806372;88558;95568;103949.48025259825;110101;110253.44873275582;52005.73997130066;53123.093997780816;62513.68743156346;63679;82664.17335826685;48408;72192;79743.60128199206;80184.5990770054;80569.19430805734;7087.043249161297;7104.264858029593;7338.192798792235;7450.776476705708;7682.462227644011;45473.31790023086;46459;47632.5236747642;47775.76112119417;48148;63862.68068659627;64137.67931160314;68288.6585567069;68927.65536172286;69934.30065699278;9676.371035882645;9982.550785214538;10134.543945522617;10198.133158681298;10240.64157754475;10446.477676116012;10717.14262858985;10721;10752.677419677422;11139.944300278446;9789.951050244703;10382.117520010883;10545.209109316678;10705.304155229886;10982.341059536453;9262.44425334482;9563.330566860253;9578.664746733832;9864.654737084455;9937.900620993698;10057.29598928068;10203.846942295722;10245.897541024495;10326;10364.792704145724;8471;8550.1449855014;8818.91181088181;8980;8982.32632552548;8600.354973377147;8671.90031152648;8807.427517211361;9378.624855005723;9390.859137112811 18:01:25 INFO - PROCESS | 7890 | __end_tp_report 18:01:25 INFO - PROCESS | 7890 | __start_cc_report 18:01:25 INFO - PROCESS | 7890 | _x_x_mozilla_cycle_collect,344 18:01:25 INFO - PROCESS | 7890 | __end_cc_report 18:01:25 INFO - PROCESS | 7890 | __startTimestamp1471568485158__endTimestamp 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | ------- Summary: start ------- 18:01:25 INFO - PROCESS | 7890 | Number of tests: 6 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | [#0] dojo.html Cycles:165 Average:4635.77 Median:4774.59 stddev:486.94 (10.2%) stddev-sans-first:460.86 18:01:25 INFO - PROCESS | 7890 | Values: 2576.7 2636.4 2650.0 2650.4 2664.6 4513.5 4672.4 4684.4 4741.8 4779.4 4577.7 4631.6 4640.9 4645.0 4668.6 4266.2 4326.1 4347.7 4351.9 4372.3 4270.0 4395.6 4403.5 4423.5 4449.5 4339.5 4406.7 4431.5 4431.6 4433.3 4214.7 4276.2 4285.5 4311.2 4413.6 4282.6 4286.2 4297.6 4302.5 4345.4 4704.8 4710.3 4718.9 4738.5 4757.0 4952.0 5008.1 5015.5 5047.2 5065.1 5043.9 5065.7 5074.8 5093.7 5126.1 4500.8 4707.0 4719.7 4727.1 4763.4 5108.6 5145.8 5178.3 5182.1 5234.5 4952.8 4963.7 4989.7 4994.3 5024.8 4822.1 5072.6 5076.2 5076.3 5079.2 4736.1 4877.1 4884.7 4922.5 4934.5 4919.1 4926.6 4947.2 4947.6 4965.3 4204.6 4206.5 4213.9 4224.0 4232.4 3593.6 3623.2 3650.8 3670.3 3676.9 4269.8 4321.1 4336.1 4337.9 4368.1 4988.9 5035.3 5036.8 5037.1 5081.0 4212.1 4285.0 4316.4 4338.3 4350.5 4538.6 4543.0 4554.0 4570.0 4572.7 4769.0 4771.2 4785.1 4790.1 4827.0 4895.1 4990.0 5047.4 5058.4 5076.6 4765.6 4778.5 4785.0 4814.1 4822.6 4988.9 4992.4 4992.9 5004.0 5051.7 4914.2 4918.0 4983.7 4996.3 5061.1 4857.7 4865.5 4872.6 4875.1 4912.4 4849.2 4863.8 4866.9 4869.7 4914.0 4548.9 4609.2 4649.0 4691.2 4774.6 4795.6 4862.8 4921.4 4951.1 5012.5 4813.5 4814.4 4828.3 4836.8 4878.6 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | [#1] ext.html Cycles:180 Average:39991.15 Median:35287.97 stddev:69155.60 (196.0%) stddev-sans-first:69286.21 18:01:25 INFO - PROCESS | 7890 | Values: 557.1 563.7 580.4 583.2 591.2 35313.1 39378.0 39414.8 39466.0 39466.0 38981.0 39398.6 39412.4 39417.8 39421.0 7554.1 7682.9 7734.7 7747.7 7750.6 7549.6 7604.9 7657.0 7675.6 7679.6 7615.1 7637.6 7649.7 7677.2 7694.5 7607.3 7652.0 7676.4 7679.8 7684.8 7533.3 7574.8 7590.3 7622.5 7640.7 37110.1 37299.8 37516.4 37658.2 37674.6 2928.6 3048.6 3061.9 3068.6 3116.7 29397.4 29524.4 29810.6 30275.8 31346.4 3164.1 3204.2 3227.4 3292.0 3308.9 263097.0 263323.0 263623.0 263798.1 264212.0 31217.4 31991.2 32165.2 33390.0 51963.2 32984.2 33162.8 33173.2 33187.7 33223.2 12260.1 12281.8 12291.6 12300.7 12369.3 10527.4 10616.7 10627.8 10648.5 10653.3 7725.3 7735.8 7801.8 7822.2 7844.9 3093.3 3111.9 3117.3 3177.0 3209.1 831.3 871.0 875.3 917.0 941.1 27208.3 27991.7 28027.6 28199.6 28536.6 894.4 923.4 924.6 942.5 957.4 13927.0 14783.7 14813.7 15120.0 15151.4 125930.0 126169.4 126247.0 126475.4 377474.0 48945.8 49028.8 49087.3 49337.5 49510.8 1142.5 1158.0 1170.5 1174.4 1178.0 26106.6 26796.9 27867.4 27932.0 28145.9 41588.8 42035.6 42042.4 42118.0 42135.6 307312.0 309447.3 309753.3 310094.0 310372.0 24649.3 24914.6 24988.0 25071.9 25098.6 38996.2 42262.6 42833.0 42867.6 42932.6 35109.6 35293.8 36089.3 36338.0 36426.5 35770.0 35793.6 35894.0 35995.5 36099.0 35013.5 35282.1 35363.5 35587.8 35609.6 31354.2 32737.3 32823.8 32989.2 33122.8 25437.2 25492.2 25562.2 25692.4 25822.9 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | [#2] jquery.html Cycles:180 Average:25999.54 Median:39718.80 stddev:65240.27 (164.3%) stddev-sans-first:65394.88 18:01:25 INFO - PROCESS | 7890 | Values: 360.0 367.2 374.2 378.8 391.2 16189.2 16903.9 17158.7 17348.6 17548.4 14101.9 14379.9 15833.0 16389.7 16429.5 4781.4 5061.9 5074.9 5075.3 5076.1 3681.8 5054.3 5589.2 5768.3 5811.3 5892.7 5893.7 5895.1 5905.5 5907.7 5728.8 5969.2 5995.7 6006.5 6008.3 5206.1 5222.5 5227.3 5253.7 6427.8 21617.0 22285.9 23417.0 23453.2 23641.2 1897.6 1910.2 1927.6 1945.1 1945.9 13754.5 13990.7 14703.9 14704.7 14811.9 1751.9 1759.7 1794.9 1801.6 1860.5 81016.0 82230.0 83019.6 85061.6 85758.0 16080.6 16416.9 16727.0 16810.4 16910.0 28418.9 28503.4 28547.0 28606.6 28693.4 8441.2 8540.2 8628.1 8877.5 8926.2 7295.1 7376.6 7394.6 7533.4 7548.7 8109.0 8280.8 8555.7 8560.8 8606.2 1490.9 1578.3 1620.1 3045.9 3236.0 804.9 841.1 895.6 929.1 966.1 15597.8 16175.8 16211.4 16377.7 16917.7 813.6 854.1 867.0 871.2 871.7 8979.4 9529.4 9570.8 9600.9 9619.6 388670.0 392349.0 393149.4 396206.0 396749.0 78800.0 79100.2 79166.0 79225.0 83612.6 897.5 901.9 944.4 950.0 963.7 15583.5 15780.4 16017.2 16045.2 16256.7 39401.6 39657.8 39710.2 39727.4 40250.6 52818.0 53859.5 54854.2 55601.6 56009.7 7409.3 7425.2 7609.8 7613.7 7871.7 11620.4 11898.2 11977.3 12022.0 12292.0 10042.8 10048.7 10197.3 10265.7 10504.8 10145.9 10227.4 10279.5 10330.5 10692.7 10085.1 10134.7 10182.1 10192.9 10370.9 7201.1 7226.4 7256.6 7413.0 7788.2 8398.6 9550.6 9723.3 10110.8 10165.5 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | [#3] mootools.html Cycles:180 Average:5074.98 Median:5297.58 stddev:2844.80 (53.7%) stddev-sans-first:2839.12 18:01:25 INFO - PROCESS | 7890 | Values: 1364.9 1405.0 1475.3 1626.6 1676.4 6570.8 7220.0 7472.9 7825.2 7889.1 7570.3 7805.8 7820.9 7826.6 7841.4 2172.0 2215.1 2216.9 2217.7 2222.1 2139.7 2173.9 2225.1 2238.1 2239.6 2178.2 2187.2 2191.8 2200.7 2238.7 2138.2 2141.4 2141.5 2144.8 2149.1 2127.5 2147.4 2171.4 2173.9 2175.4 7933.6 8004.2 8013.8 8028.9 8043.4 4207.1 4301.7 4309.4 4313.4 4317.6 2757.0 2839.9 2859.1 2896.9 2898.0 927.1 948.6 954.0 981.3 986.1 9991.9 10047.0 10084.4 10098.6 10100.0 3813.4 4022.2 4047.5 4110.4 4160.8 8761.1 8764.5 8766.8 8774.3 8777.0 4409.8 4433.6 4439.0 4439.4 4441.1 3567.7 3996.1 4051.9 4053.6 4094.0 3653.1 3675.3 3736.4 3756.9 3765.4 1192.3 1194.4 1203.0 1203.5 1207.9 642.4 819.4 824.8 825.8 850.9 5273.6 5374.4 5393.1 5460.2 5496.8 392.1 394.4 401.8 406.5 409.2 3655.0 3693.2 3733.7 3744.8 3826.0 9426.8 9652.8 9767.4 9769.0 9787.6 9726.1 9754.8 9764.1 9764.9 9770.5 7273.4 7300.7 7331.8 7354.9 7504.9 5284.7 5310.5 5315.5 5458.2 5480.0 8805.0 8831.7 8948.7 8995.9 9112.9 8365.0 8739.0 8758.4 8974.6 9006.6 6085.2 6456.7 6577.5 6587.3 6693.7 7321.7 7368.3 7374.8 7391.7 7415.9 6406.5 6517.6 6519.5 6736.2 6753.6 6461.4 6532.4 6548.1 6594.1 6654.5 6248.3 6338.6 6339.6 6347.6 6354.1 4440.0 4540.0 4562.0 4570.7 4582.3 4682.9 4700.7 4745.3 4805.9 4973.2 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | [#4] prototype.html Cycles:180 Average:4288.39 Median:4915.09 stddev:1250.18 (25.4%) stddev-sans-first:1217.20 18:01:25 INFO - PROCESS | 7890 | Values: 294.0 294.3 304.0 306.6 311.2 4786.9 4850.7 4913.0 5014.4 5022.9 4852.9 4887.2 4896.4 4896.5 4917.2 3901.9 3902.6 3920.8 3932.5 3935.9 3643.3 3912.3 3917.7 3949.2 3960.0 3805.8 3817.2 3824.8 3833.7 3846.4 3812.5 3828.9 3834.1 3835.2 3856.7 3382.5 3385.9 3397.9 3398.3 3398.5 4731.8 4854.5 4862.2 4919.9 4933.8 4318.6 4345.8 4357.2 4359.2 4373.7 5149.4 5159.6 5162.9 5185.7 5206.9 3457.6 3670.4 3672.1 3678.9 3687.2 5365.3 5370.5 5395.2 5413.6 5472.6 3709.8 3715.7 3730.7 3746.9 3752.3 3813.6 3816.2 3830.9 3835.4 3841.2 4136.8 4325.9 4330.3 4384.4 4398.0 5092.3 5142.2 5142.3 5149.5 5163.7 1210.3 1281.6 1284.3 1306.0 1307.0 865.6 879.9 897.4 904.2 904.8 4444.4 4452.8 4466.2 4473.4 4489.3 5253.4 5262.1 5290.7 5293.5 5303.8 4479.7 4486.9 4489.0 4489.0 4493.7 2706.6 2800.1 2848.7 2849.6 2861.6 5038.2 5041.6 5044.8 5046.4 5054.9 5291.2 5428.8 5430.8 5463.6 5465.0 5000.8 5008.3 5011.9 5024.2 5036.5 5314.1 5352.4 5355.3 5366.8 5415.4 4999.7 5211.3 5213.9 5243.5 5256.5 4997.1 5005.7 5016.2 5023.7 5043.7 3723.6 3728.4 3759.3 3764.8 3771.9 5090.4 5271.8 5338.9 5358.9 5378.5 5107.9 5123.7 5136.8 5142.7 5151.5 5137.0 5142.8 5188.7 5232.9 5257.4 4783.5 4979.4 5062.8 5097.1 5108.8 5219.7 5222.7 5223.4 5246.8 5259.9 5090.9 5114.4 5128.9 5164.9 5174.8 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - PROCESS | 7890 | [#5] yui.html Cycles:180 Average:17272.48 Median:539.93 stddev:25283.61 (4682.8%) stddev-sans-first:25323.64 18:01:25 INFO - PROCESS | 7890 | Values: 625.4 640.8 672.6 702.4 747.2 11353.4 12244.8 12247.8 12249.3 12309.5 11951.8 12051.2 12055.3 12066.2 12070.5 625.0 755.5 758.0 770.5 783.5 767.6 769.6 770.7 773.6 776.7 804.7 812.7 813.3 813.5 814.5 801.5 802.0 803.2 805.0 805.2 586.8 587.2 589.3 589.7 590.7 11589.2 11688.9 11691.4 11692.9 11729.0 12991.4 13295.7 13511.3 13595.4 13753.7 10039.2 10151.0 10153.9 10181.8 10199.2 3198.4 3207.6 3227.4 3282.1 3291.7 69547.7 69638.0 70092.0 70448.0 71538.6 10074.8 10156.9 10249.6 10263.9 10268.5 20023.5 20225.5 20289.4 20377.0 20918.7 6357.5 6460.3 6535.3 6537.4 6549.7 3378.6 3413.0 3427.6 3453.4 3669.5 3029.2 3147.8 3157.7 3159.5 3165.9 510.9 520.0 525.5 529.4 536.4 493.7 511.6 543.4 555.6 570.1 7535.1 8087.6 8368.0 8543.7 8562.0 492.7 577.9 600.8 616.8 624.9 3819.2 3904.7 3964.4 4008.2 4173.3 88558.0 95568.0 103949.5 110101.0 110253.4 52005.7 53123.1 62513.7 63679.0 82664.2 48408.0 72192.0 79743.6 80184.6 80569.2 7087.0 7104.3 7338.2 7450.8 7682.5 45473.3 46459.0 47632.5 47775.8 48148.0 63862.7 64137.7 68288.7 68927.7 69934.3 9676.4 9982.6 10134.5 10198.1 10240.6 10446.5 10717.1 10721.0 10752.7 11139.9 9790.0 10382.1 10545.2 10705.3 10982.3 9262.4 9563.3 9578.7 9864.7 9937.9 10057.3 10203.8 10245.9 10326.0 10364.8 8471.0 8550.1 8818.9 8980.0 8982.3 8600.4 8671.9 8807.4 9378.6 9390.9 18:01:25 INFO - PROCESS | 7890 | -------- Summary: end -------- 18:01:25 INFO - PROCESS | 7890 | 18:01:25 INFO - TEST-INFO | 7890: exit 0 18:01:25 INFO - TEST-OK | dromaeo_css | took 1117244ms 18:01:25 INFO - TEST-START | kraken 18:01:25 INFO - operating with platform_type : linux_ 18:01:25 INFO - Initialising browser for kraken test... 18:01:25 INFO - TEST-INFO | started process 8246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0ZGbo/profile http://localhost:59578/getInfo.html) 18:01:30 INFO - PROCESS | 8246 | __metrics Screen width/height:1600/1200 18:01:30 INFO - PROCESS | 8246 | colorDepth:24 18:01:30 INFO - PROCESS | 8246 | Browser inner width/height: 1024/697 18:01:30 INFO - PROCESS | 8246 | __metrics 18:01:31 ERROR - PROCESS | 8246 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:01:32 INFO - TEST-INFO | 8246: exit 0 18:01:32 INFO - Browser initialized. 18:01:32 INFO - Running cycle 1/1 for kraken test... 18:01:32 INFO - TEST-INFO | started process 8366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0ZGbo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:44 INFO - PROCESS | 8366 | RSS: Main: 164016128 18:01:44 INFO - PROCESS | 8366 | 18:01:46 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59578/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:47 INFO - PROCESS | 8366 | RSS: Main: 168632320 18:01:47 INFO - PROCESS | 8366 | 18:01:50 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59578/tests/kraken/driver.html?testName=audio-dft) 18:01:51 INFO - PROCESS | 8366 | RSS: Main: 168067072 18:01:51 INFO - PROCESS | 8366 | 18:01:54 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59578/tests/kraken/driver.html?testName=audio-fft) 18:01:54 INFO - PROCESS | 8366 | RSS: Main: 164454400 18:01:54 INFO - PROCESS | 8366 | 18:01:57 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59578/tests/kraken/driver.html?testName=audio-oscillator) 18:01:57 INFO - PROCESS | 8366 | RSS: Main: 164851712 18:01:57 INFO - PROCESS | 8366 | 18:02:00 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59578/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:00 INFO - PROCESS | 8366 | RSS: Main: 165351424 18:02:00 INFO - PROCESS | 8366 | 18:02:03 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59578/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:04 INFO - PROCESS | 8366 | RSS: Main: 165572608 18:02:04 INFO - PROCESS | 8366 | 18:02:08 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59578/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:08 INFO - PROCESS | 8366 | RSS: Main: 163164160 18:02:08 INFO - PROCESS | 8366 | 18:02:11 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59578/tests/kraken/driver.html?testName=json-parse-financial) 18:02:12 INFO - PROCESS | 8366 | RSS: Main: 164270080 18:02:12 INFO - PROCESS | 8366 | 18:02:14 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59578/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:14 INFO - PROCESS | 8366 | RSS: Main: 165224448 18:02:14 INFO - PROCESS | 8366 | 18:02:16 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:17 INFO - PROCESS | 8366 | RSS: Main: 164794368 18:02:17 INFO - PROCESS | 8366 | 18:02:19 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:20 INFO - PROCESS | 8366 | RSS: Main: 165085184 18:02:20 INFO - PROCESS | 8366 | 18:02:23 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:23 INFO - PROCESS | 8366 | RSS: Main: 164958208 18:02:23 INFO - PROCESS | 8366 | 18:02:26 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:27 INFO - PROCESS | 8366 | RSS: Main: 164937728 18:02:27 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | Cycle 1(1): loaded http://localhost:59578/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59578/tests/kraken/driver.html?testName=ai-astar) 18:02:29 INFO - PROCESS | 8366 | RSS: Main: 166019072 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | __start_tp_report 18:02:29 INFO - PROCESS | 8366 | _x_x_mozilla_page_load 18:02:29 INFO - PROCESS | 8366 | _x_x_mozilla_page_load_details 18:02:29 INFO - PROCESS | 8366 | |i|pagename|runs| 18:02:29 INFO - PROCESS | 8366 | |0;ai-astar;105;115;112;116;116;115;120;113;115;115 18:02:29 INFO - PROCESS | 8366 | |1;audio-beat-detection;155;128;146;191;122;164;148;130;189;124 18:02:29 INFO - PROCESS | 8366 | |2;audio-dft;166;165;166;171;163;163;164;165;164;163 18:02:29 INFO - PROCESS | 8366 | |3;audio-fft;76;76;78;165;77;76;78;76;165;78 18:02:29 INFO - PROCESS | 8366 | |4;audio-oscillator;88;87;149;90;91;87;137;88;86;143 18:02:29 INFO - PROCESS | 8366 | |5;imaging-gaussian-blur;117;117;118;118;117;119;118;118;118;118 18:02:29 INFO - PROCESS | 8366 | |6;imaging-darkroom;154;147;147;148;149;148;148;149;148;149 18:02:29 INFO - PROCESS | 8366 | |7;imaging-desaturate;95;97;96;96;96;98;96;95;96;96 18:02:29 INFO - PROCESS | 8366 | |8;json-parse-financial;66;66;70;74;66;70;67;67;67;72 18:02:29 INFO - PROCESS | 8366 | |9;json-stringify-tinderbox;65;66;65;66;66;65;66;65;66;66 18:02:29 INFO - PROCESS | 8366 | |10;stanford-crypto-aes;100;93;85;83;86;87;86;83;86;82 18:02:29 INFO - PROCESS | 8366 | |11;stanford-crypto-ccm;136;139;137;141;151;135;133;144;147;135 18:02:29 INFO - PROCESS | 8366 | |12;stanford-crypto-pbkdf2;177;171;173;172;175;172;169;171;170;172 18:02:29 INFO - PROCESS | 8366 | |13;stanford-crypto-sha256-iterative;69;68;70;70;73;72;68;69;68;72 18:02:29 INFO - PROCESS | 8366 | __end_tp_report 18:02:29 INFO - PROCESS | 8366 | __start_cc_report 18:02:29 INFO - PROCESS | 8366 | _x_x_mozilla_cycle_collect,914 18:02:29 INFO - PROCESS | 8366 | __end_cc_report 18:02:29 INFO - PROCESS | 8366 | __startTimestamp1471568549314__endTimestamp 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | ------- Summary: start ------- 18:02:29 INFO - PROCESS | 8366 | Number of tests: 14 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:3.85 (3.4%) stddev-sans-first:2.22 18:02:29 INFO - PROCESS | 8366 | Values: 105.0 115.0 112.0 116.0 116.0 115.0 120.0 113.0 115.0 115.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:151.50 stddev:25.36 (16.7%) stddev-sans-first:26.82 18:02:29 INFO - PROCESS | 8366 | Values: 155.0 128.0 146.0 191.0 122.0 164.0 148.0 130.0 189.0 124.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.40 (1.5%) stddev-sans-first:2.52 18:02:29 INFO - PROCESS | 8366 | Values: 166.0 165.0 166.0 171.0 163.0 163.0 164.0 165.0 164.0 163.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.50 stddev:37.17 (48.6%) stddev-sans-first:38.81 18:02:29 INFO - PROCESS | 8366 | Values: 76.0 76.0 78.0 165.0 77.0 76.0 78.0 76.0 165.0 78.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:87.50 stddev:26.69 (30.5%) stddev-sans-first:27.62 18:02:29 INFO - PROCESS | 8366 | Values: 88.0 87.0 149.0 90.0 91.0 87.0 137.0 88.0 86.0 143.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 18:02:29 INFO - PROCESS | 8366 | Values: 117.0 117.0 118.0 118.0 117.0 119.0 118.0 118.0 118.0 118.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:2.00 (1.3%) stddev-sans-first:0.78 18:02:29 INFO - PROCESS | 8366 | Values: 154.0 147.0 147.0 148.0 149.0 148.0 148.0 149.0 148.0 149.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 18:02:29 INFO - PROCESS | 8366 | Values: 95.0 97.0 96.0 96.0 96.0 98.0 96.0 95.0 96.0 96.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:68.50 stddev:2.84 (4.1%) stddev-sans-first:2.86 18:02:29 INFO - PROCESS | 8366 | Values: 66.0 66.0 70.0 74.0 66.0 70.0 67.0 67.0 67.0 72.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 18:02:29 INFO - PROCESS | 8366 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:5.47 (6.4%) stddev-sans-first:3.24 18:02:29 INFO - PROCESS | 8366 | Values: 100.0 93.0 85.0 83.0 86.0 87.0 86.0 83.0 86.0 82.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:140.00 stddev:5.88 (4.2%) stddev-sans-first:6.08 18:02:29 INFO - PROCESS | 8366 | Values: 136.0 139.0 137.0 141.0 151.0 135.0 133.0 144.0 147.0 135.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:2.35 (1.4%) stddev-sans-first:1.73 18:02:29 INFO - PROCESS | 8366 | Values: 177.0 171.0 173.0 172.0 175.0 172.0 169.0 171.0 170.0 172.0 18:02:29 INFO - PROCESS | 8366 | 18:02:29 INFO - PROCESS | 8366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.85 (2.6%) stddev-sans-first:1.94 18:02:29 INFO - PROCESS | 8366 | Values: 69.0 68.0 70.0 70.0 73.0 72.0 68.0 69.0 68.0 72.0 18:02:29 INFO - PROCESS | 8366 | -------- Summary: end -------- 18:02:29 INFO - PROCESS | 8366 | 18:02:30 INFO - TEST-INFO | 8366: exit 0 18:02:30 INFO - TEST-OK | kraken | took 64473ms 18:02:30 INFO - SUITE-END | took 1181s 18:02:30 INFO - Completed test suite (00:19:41) 18:02:30 INFO - javascript benchmark 18:02:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6328.707884941421, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.6521519594853, 2636.3804505941102, 2650.0062476571275, 2650.350664087299, 2664.600309953508, 4513.503514613398, 4672.439307283126, 4684.391029166208, 4741.786619602118, 4779.378680771503, 4577.679562430623, 4631.606313463351, 4640.930386044212, 4645.001324715186, 4668.649851261161, 4266.210751011057, 4326.113146804905, 4347.673924455663, 4351.934720979188, 4372.27857403528, 4269.978650106745, 4395.560443955611, 4403.471583409995, 4423.491298500665, 4449.532799056101, 4339.500957389878, 4406.669499787513, 4431.468223813131, 4431.6233120184825, 4433.334999750031, 4214.726042807208, 4276.166147601219, 4285.485741711014, 4311.1593239318345, 4413.624841888443, 4282.614564689193, 4286.185624731323, 4297.634701050414, 4302.526722060571, 4345.435093437864, 4704.835330763407, 4710.3405523226775, 4718.905621887543, 4738.526147385269, 4757.048590281923, 4951.950480495185, 5008.073506401327, 5015.523525265094, 5047.242913562958, 5065.11360511909, 5043.899122017576, 5065.696058236481, 5074.771635276385, 5093.668911520739, 5126.051680439094, 4500.819967201341, 4706.9764651176865, 4719.669623126349, 4727.078219747116, 4763.428388593322, 5108.591312694975, 5145.76844042019, 5178.300929374562, 5182.144946083854, 5234.450382709837, 4952.777125029383, 4963.652544321935, 4989.650724449326, 4994.300797888299, 5024.79900803971, 4822.059698358787, 5072.619553533426, 5076.238564215323, 5076.340075790197, 5079.161938280143, 4736.076465089343, 4877.073356062337, 4884.7069175849565, 4922.507749225048, 4934.5312195341385, 4919.0899683558655, 4926.630502712311, 4947.183714687037, 4947.5794557462295, 4965.255211718271, 4204.642605378516, 4206.47419072616, 4213.894652633648, 4224.028473451062, 4232.428622135973, 3593.6047034826147, 3623.166671665479, 3650.79920604364, 3670.33933891902, 3676.9448458273146, 4269.829206831754, 4321.0709697415205, 4336.067745434747, 4337.9132417351475, 4368.104538569585, 4988.850334489971, 5035.345405097387, 5036.823711170092, 5037.0681423936685, 5081.0, 4212.136512015029, 4285.0358669299785, 4316.352547117957, 4338.262495375794, 4350.477942646902, 4538.591526762607, 4543.045960348298, 4553.977230113828, 4569.95430045702, 4572.725636461756, 4769.0, 4771.23660214364, 4785.066911952275, 4790.089882922233, 4827.034593081468, 4895.069936712013, 4989.975050124726, 5047.394312682502, 5058.443571207091, 5076.568491678248, 4765.642576806684, 4778.522147785194, 4784.976075119741, 4814.109389762905, 4822.565969062801, 4988.900221995467, 4992.350994370854, 4992.850214493571, 5004.049230646166, 5051.74741262928, 4914.238293064581, 4917.950820491749, 4983.651144419856, 4996.2755400466, 5061.063703214917, 4857.732824694675, 4865.464798872051, 4872.634552408513, 4875.1224779540025, 4912.361393018885, 4849.199882019428, 4863.829765958175, 4866.926996095132, 4869.70781753096, 4913.950860491493, 4548.909021819612, 4609.193391156467, 4649.0469453761225, 4691.225947718588, 4774.594159496482, 4795.640326975421, 4862.805487780449, 4921.384826896638, 4951.059298733229, 5012.548870601663, 4813.4945830687275, 4814.422269327703, 4828.275758636232, 4836.782344794563, 4878.609711223165], "value": 4604.7052505182255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1197507937459, 563.6505366672662, 580.4137820800989, 583.2301362201893, 591.1753104419333, 35313.11717207068, 39378.0, 39414.802925985365, 39466.0, 39466.0, 38981.0, 39398.606013939854, 39412.40881386774, 39417.8029109854, 39421.0, 7554.055743032121, 7682.923170768305, 7734.651940662656, 7747.728829490969, 7750.612469376537, 7549.584772837492, 7604.885926711104, 7656.961715191416, 7675.577843218621, 7679.616019199046, 7615.086189657249, 7637.618119094051, 7649.732259370923, 7677.155512893605, 7694.499857509272, 7607.315341619225, 7652.0, 7676.385889128912, 7679.846403071907, 7684.807879802994, 7533.322001019879, 7574.8485030299635, 7590.278923502258, 7622.5426474411715, 7640.701080816275, 37110.07224819401, 37299.81350093259, 37516.43725344122, 37658.246835063146, 37674.623253767386, 2928.560715892612, 3048.5731997520365, 3061.9081427557207, 3068.6471055828642, 3116.719495245439, 29397.412051758845, 29524.40951180986, 29810.55284170739, 30275.848620756977, 31346.373072538423, 3164.0982320038906, 3204.1829333520036, 3227.4029304578494, 3291.9835400822844, 3308.9172770680684, 263097.0, 263323.0, 263623.0, 263798.0682704423, 264212.0, 31217.375652486822, 31991.20021999422, 32165.195870102965, 33390.0, 51963.22055169175, 32984.175395615304, 33162.83418582891, 33173.17067073294, 33187.66812331894, 33223.16942076419, 12260.14179007461, 12281.815772763415, 12291.56979505713, 12300.692482688004, 12369.257844529357, 10527.420991845369, 10616.681499555025, 10627.84058239127, 10648.467576621293, 10653.307535010199, 7725.266099720518, 7735.7679269622, 7801.765947021599, 7822.1786712395515, 7844.921550784533, 3093.3040065984974, 3111.8910838120555, 3117.3297740985795, 3177.0468859342104, 3209.0533292678715, 831.2850948184556, 870.9608067636972, 875.3216257400438, 916.9729902509099, 941.0824446165071, 27208.31979200496, 27991.72008279932, 28027.60098617477, 28199.57700634492, 28536.571951420745, 894.351595093552, 923.4136323434667, 924.5515924776478, 942.5381563034064, 957.4494665567327, 13927.0, 14783.704325913637, 14813.703725925636, 15120.0, 15151.393944242327, 125930.0, 126169.36915315365, 126247.0, 126475.36762316314, 377474.0, 48945.75527122342, 49028.75485622549, 49087.26369104466, 49337.50662493401, 49510.75244623754, 1142.4744617476053, 1158.0330424095805, 1170.5317872850758, 1174.4010554617037, 1177.988220117788, 26106.608400874382, 26796.866015669795, 27867.44265114646, 27932.0, 28145.859270703517, 41588.79205603953, 42035.579644203164, 42042.369364458944, 42118.0, 42135.578644214394, 307312.0, 309447.31908511434, 309753.3172677891, 310094.0, 310372.0, 24649.260522184362, 24914.626280606168, 24988.0, 25071.87464062668, 25098.62352064757, 38996.220075598896, 42262.5773742271, 42833.0, 42867.57132428761, 42932.570674294104, 35109.648903510635, 35293.82353088321, 36089.27821443504, 36338.0, 36426.4536031965, 35770.0, 35793.64206357903, 35894.0, 35995.46006809952, 36099.0, 35013.47479787754, 35282.11794705153, 35363.46954795731, 35587.82206089057, 35609.64390356167, 31354.21614459657, 32737.34525309433, 32823.83588082044, 32989.17527061843, 33122.83438582792, 25437.236882893543, 25492.23523294304, 25562.23313300604, 25692.357691057874, 25822.87088564545], "value": 15745.292404680427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.98020108894, 367.2214904402667, 374.23469005882964, 378.75381002348485, 391.2175648702595, 16189.190540472973, 16903.91548042258, 17158.65682686347, 17348.566285842844, 17548.385806496775, 14101.929490352533, 14379.92810035951, 15833.0, 16389.67220655586, 16429.507114786546, 4781.40232470942, 5061.898762024757, 5074.923876141861, 5075.340205773245, 5076.086304465195, 3681.7606855554304, 5054.342935418391, 5589.245451863987, 5768.336641286264, 5811.331696854873, 5892.705364731768, 5893.705314734268, 5895.115732640095, 5905.468507834294, 5907.704614769265, 5728.77084916605, 5969.164316995624, 5995.6702381369005, 6006.489448396892, 6008.279006519202, 5206.062908676437, 5222.451642577551, 5227.268182454422, 5253.711045892513, 6427.807165785034, 21617.0, 22285.888570557207, 23417.0, 23453.179138730233, 23641.172558960527, 1897.5634806280045, 1910.2263583248669, 1927.5662975830467, 1945.066368143285, 1945.8929758863258, 13754.518591849337, 13990.720185596332, 14703.852961470355, 14704.705905881823, 14811.851881481263, 1751.8773685841995, 1759.6744602248625, 1794.865385096123, 1801.639672065592, 1860.5069656541027, 81016.0, 82230.0, 83019.5849020757, 85061.57469212676, 85758.0, 16080.597985050468, 16416.917915410584, 16727.0, 16810.411635592696, 16909.985400875987, 28418.857905710753, 28503.429931401257, 28547.0, 28606.570901436495, 28693.426131477252, 8441.198086181927, 8540.184671039497, 8628.050914399411, 8877.467351958903, 8926.241269492037, 7295.088113985752, 7376.561570493702, 7394.630268486554, 7533.359664428475, 7548.698052077965, 8108.9594552026865, 8280.751577452686, 8555.657773689107, 8560.785980350542, 8606.225439710455, 1490.8509149085005, 1578.3449868304524, 1620.1089400829496, 3045.8629361678777, 3236.0453666168537, 804.9154838741965, 841.0790184747691, 895.6148855991855, 929.0848514213494, 966.087047739879, 15597.766033509506, 16175.838241617434, 16211.351545938267, 16377.67244655124, 16917.7462338065, 813.589137485566, 854.0903937306748, 866.956652167389, 871.1549796697194, 871.6861929705301, 8979.416337938013, 9529.428234305964, 9570.808583828284, 9600.903990960142, 9619.615215391446, 388670.0, 392349.0, 393149.4452860555, 396206.0, 396749.0, 78800.0, 79100.20899791043, 79166.0, 79225.0, 83612.58193708993, 897.4839467306325, 901.8602116671926, 944.4003058058045, 950.0309684122157, 963.734972882477, 15583.532494025198, 15780.447684330993, 16017.199140043183, 16045.19774011318, 16256.67486650284, 39401.60598393979, 39657.80171099126, 39710.205795884496, 39727.40408893926, 40250.59749402585, 52818.0, 53859.461405385446, 54854.177187341425, 55601.605815330135, 56009.71995140161, 7409.259074092548, 7425.220351862977, 7609.847803044019, 7613.733519326797, 7871.685132594632, 11620.360880151673, 11898.167128300936, 11977.341246231192, 12022.0, 12292.0, 10042.849357259793, 10048.69853904384, 10197.337173083726, 10265.743356415851, 10504.842427363443, 10145.898541014496, 10227.43749093807, 10279.486025698834, 10330.535125919501, 10692.679219623424, 10085.142762865238, 10134.695959121238, 10182.134518566005, 10192.949035254776, 10370.896291036994, 7201.063861697946, 7226.421886248982, 7256.564606123649, 7412.962185294171, 7788.182240864628, 8398.622062007347, 9550.570224339783, 9723.319367644197, 10110.848337275094, 10165.54255058539], "value": 8989.27070249294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.9454021839126, 1405.0235086614803, 1475.333795518138, 1626.642138729479, 1676.3629820668152, 6570.802875913719, 7220.0, 7472.887906681391, 7825.178356272595, 7889.053313602369, 7570.31867131958, 7805.843883122334, 7820.92179078209, 7826.608669566527, 7841.4118941079505, 2171.978280217197, 2215.1360969222014, 2216.8780717060554, 2217.6784366266884, 2222.0778376973617, 2139.743230812305, 2173.880436575988, 2225.143319821872, 2238.149503188786, 2239.608068587999, 2178.2485042660337, 2187.212603462752, 2191.791779780918, 2200.713907192063, 2238.6977758002704, 2138.1661152150673, 2141.3682963525644, 2141.496748264157, 2144.8176904963098, 2149.1188612668807, 2127.5000374911883, 2147.3879944215823, 2171.4245724882917, 2173.8586991845636, 2175.380016695234, 7933.563653999027, 8004.159563245892, 8013.759587212393, 8028.919710802876, 8043.356531477526, 4207.1375368049785, 4301.677374196916, 4309.396684464177, 4313.352997050468, 4317.633001194871, 2756.986215068912, 2839.858007099637, 2859.1136747608307, 2896.884124635012, 2898.043645596948, 927.1331305229564, 948.5684013773786, 954.0221273194961, 981.3277904635277, 986.1223511075149, 9991.900080999098, 10047.045530674573, 10084.445355505444, 10098.646547370807, 10100.0, 3813.4470501777087, 4022.1754540319166, 4047.4738284022887, 4110.383442483651, 4160.771157586301, 8761.123887611187, 8764.5179515126, 8766.824663506693, 8774.341924355698, 8777.0, 4409.845655402046, 4433.556644335606, 4439.045605194834, 4439.445069366329, 4441.0673758511075, 3567.6967457765863, 3996.120853412303, 4051.9392209116886, 4053.635172834459, 4094.0, 3653.1415117447377, 3675.301692678436, 3736.439534069857, 3756.9436458453147, 3765.3975363941636, 1192.3025030357164, 1194.4087676600138, 1202.9699257518632, 1203.4764877278412, 1207.885250901163, 642.3961476212345, 819.3649921311031, 824.7731873734651, 825.8183199696057, 850.9361797865184, 5273.578113750891, 5374.435684253175, 5393.110136827379, 5460.180972854024, 5496.80761173357, 392.09817419934035, 394.41429477226296, 401.80512451461016, 406.4837656176698, 409.15917788944006, 3654.9817250913575, 3693.242885208526, 3733.6826369758332, 3744.8127593620757, 3826.043489127718, 9426.811463770824, 9652.806943861084, 9767.365121267238, 9768.951155244178, 9787.559559819825, 9726.076022777825, 9754.804903902024, 9764.121229089274, 9764.9023509764, 9770.462624555717, 7273.381762550137, 7300.707971681073, 7331.816704582321, 7354.889676654854, 7504.887426688604, 5284.682919024871, 5310.468953104659, 5315.521603055744, 5458.181272809111, 5480.0, 8805.0, 8831.69089081879, 8948.73153805387, 8995.910040899507, 9112.863307050533, 8365.0, 8738.956305218688, 8758.386912916034, 8974.596143173443, 9006.639734410812, 6085.2393450818645, 6456.709448074942, 6577.473802095917, 6587.308332625005, 6693.732250709917, 7321.74373896911, 7368.263173682589, 7374.815629609303, 7391.704331826667, 7415.925840741524, 6406.519511036784, 6517.576357536745, 6519.478441724746, 6736.157980252468, 6753.561018533779, 6461.353864613501, 6532.379423954717, 6548.116004339353, 6594.142761440982, 6654.534182607171, 6248.312685604489, 6338.556301058881, 6339.587926784744, 6347.587406818542, 6354.078658594571, 4440.0, 4540.0, 4562.0, 4570.748608826547, 4582.266837306149, 4682.906341873076, 4700.694454860423, 4745.264484004984, 4805.9038819224115, 4973.179425394769], "value": 4026.2147602357936, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.99265018374535, 294.34214530524275, 303.95592639067337, 306.598356153439, 311.22504962643023, 4786.856394308167, 4850.660453768238, 4912.975435122824, 5014.373203349586, 5022.874428139298, 4852.878678033051, 4887.169181239189, 4896.436909755379, 4896.53482919123, 4917.21324588066, 3901.9369794711015, 3902.57555992063, 3920.8039598020127, 3932.5280966284085, 3935.8782746917136, 3643.344198044351, 3912.2762288976633, 3917.745346552479, 3949.1904159647347, 3959.9802000989953, 3805.7526260793097, 3817.1602247505502, 3824.7513911595797, 3833.71247156463, 3846.403807409842, 3812.504374431334, 3828.8659896903614, 3834.0798208430056, 3835.1974571951137, 3856.749311294785, 3382.4631526355233, 3385.8814941477176, 3397.8640854365794, 3398.3373242217776, 3398.5072164536004, 4731.810727570893, 4854.49027852074, 4862.17343051682, 4919.926201106986, 4933.827316043921, 4318.568143185687, 4345.7624070068005, 4357.237483440385, 4359.237133501624, 4373.715708478939, 5149.433562308181, 5159.561437277798, 5162.870928226825, 5185.740712964337, 5206.891209060336, 3457.619661837196, 3670.3943849265106, 3672.1003354178397, 3678.9448158277646, 3687.2441149564543, 5365.3293338332705, 5370.4629537045985, 5395.190721391783, 5413.565405167634, 5472.616916815825, 3709.8330575123646, 3715.721320900889, 3730.7388482806487, 3746.925061498755, 3752.305823422621, 3813.599572044951, 3816.1985982943893, 3830.8659196927974, 3835.386338185933, 3841.193349396602, 4136.834526618962, 4325.870223893288, 4330.307150855848, 4384.386185933972, 4397.9560204398185, 5092.294081482744, 5142.1772516397195, 5142.280080788692, 5149.48505149482, 5163.690178589297, 1210.2617403383929, 1281.6091092216964, 1284.3064745037761, 1305.9542915998084, 1306.9542566010143, 865.6494119881459, 879.9164079412445, 897.3852910756153, 904.1636486250193, 904.8280826642916, 4444.444444444444, 4452.8218871245435, 4466.240739074366, 4473.373727678128, 4489.281714925596, 5253.3958594761325, 5262.052830490472, 5290.730224746033, 5293.497117773805, 5303.840884773463, 4479.731216127043, 4486.910261794811, 4488.955110448919, 4489.0, 4493.73037617744, 2706.6346043284298, 2800.0899707595113, 2848.700886406939, 2849.6437945256844, 2861.5993760873494, 5038.2190760432195, 5041.571466425322, 5044.823431179964, 5046.44489106198, 5054.898902021939, 5291.232771248147, 5428.782848686087, 5430.782768689287, 5463.579469338, 5464.961657285103, 5000.774655278439, 5008.347245409006, 5011.874703132451, 5024.246363045572, 5036.496350364934, 5314.060367965588, 5352.384475785335, 5355.277037599874, 5366.785328586813, 5415.404305526467, 4999.725728191657, 5211.296474975981, 5213.921791173211, 5243.528082472596, 5256.500632439912, 4997.1260777208545, 5005.674631148963, 5016.247562865599, 5023.718951667302, 5043.739065233692, 3723.6090210527504, 3728.4034554471154, 3759.3233218019923, 3764.811759412073, 3771.905702357463, 5090.440051594248, 5271.762770675406, 5338.866528336823, 5358.919616205682, 5378.489043540857, 5107.923381149211, 5123.666961647481, 5136.794528218829, 5142.665726727751, 5151.5363617274625, 5136.9743151284, 5142.794288228579, 5188.7405629719115, 5232.88068332326, 5257.4216836147225, 4783.473817879961, 4979.402471703419, 5062.797488100435, 5097.108006098992, 5108.770105345194, 5219.677243626702, 5222.7127507987425, 5223.373195216598, 5246.842594722164, 5259.921716048278, 5090.898182036264, 5114.4374118847645, 5128.923066153936, 5164.870878228075, 5174.818881339135], "value": 3889.5695889321455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.4121126141426, 640.7981485831965, 672.5561129654426, 702.3713776170327, 747.1706405889463, 11353.432328383578, 12244.81632775508, 12247.816282755766, 12249.326287054208, 12309.507619695223, 11951.760964780698, 12051.216670916385, 12055.33695646739, 12066.215695979756, 12070.51717931284, 624.9750009999594, 755.5315704263364, 757.9810504737399, 770.4799260499169, 783.5494590610422, 767.5624893810531, 769.5805785846699, 770.7071312901118, 773.5745340062942, 776.7242628866755, 804.6901942752024, 812.687115460549, 813.3046245460135, 813.5240884082818, 814.4624547798425, 801.519088546873, 802.0, 803.1566854802434, 805.005817814998, 805.2068712318362, 586.7740919745886, 587.1808826686748, 589.3222793787179, 589.6786251492904, 590.6928397233414, 11589.188756787029, 11688.941555292255, 11691.415429228504, 11692.883071169264, 11729.0, 12991.415386307639, 13295.734085318336, 13511.256880871548, 13595.388207530685, 13753.724925501434, 10039.196864250842, 10150.99631800901, 10153.949230253875, 10181.796364072678, 10199.235057370726, 3198.440272952224, 3207.615086189649, 3227.4351988401936, 3282.113829266085, 3291.654376290479, 69547.65226173887, 69637.95543066908, 70092.0, 70448.0, 71538.64230678813, 10074.848877266846, 10156.890176876217, 10249.590016399261, 10263.884551128496, 10268.537915793808, 20023.499412514804, 20225.49436264076, 20289.391318260477, 20377.0, 20918.686219706717, 6357.467980835904, 6460.289368169498, 6535.313792051861, 6537.444317233088, 6549.705263263165, 3378.5607870976614, 3412.9829350853583, 3427.5544179257035, 3453.3611281912927, 3669.541307336583, 3029.1669790807705, 3147.8111313320815, 3157.700018498239, 3159.462891308483, 3165.9050228493184, 510.8544064941474, 519.9870003249949, 525.4876495417014, 529.428217525072, 536.4260241541591, 493.67910857941905, 511.575392424287, 543.4321134414546, 555.5694336888944, 570.1020892094967, 7535.095788505414, 8087.595620218965, 8367.958160209282, 8543.743687689379, 8561.957190214009, 492.6600645554627, 577.9190913272146, 600.7897235967464, 616.8149555133532, 624.8937680594219, 3819.1979684266616, 3904.6876249899938, 3964.364589928569, 4008.158286759755, 4173.269677806372, 88558.0, 95568.0, 103949.48025259825, 110101.0, 110253.44873275582, 52005.73997130066, 53123.093997780816, 62513.68743156346, 63679.0, 82664.17335826685, 48408.0, 72192.0, 79743.60128199206, 80184.5990770054, 80569.19430805734, 7087.043249161297, 7104.264858029593, 7338.192798792235, 7450.776476705708, 7682.462227644011, 45473.31790023086, 46459.0, 47632.5236747642, 47775.76112119417, 48148.0, 63862.68068659627, 64137.67931160314, 68288.6585567069, 68927.65536172286, 69934.30065699278, 9676.371035882645, 9982.550785214538, 10134.543945522617, 10198.133158681298, 10240.64157754475, 10446.477676116012, 10717.14262858985, 10721.0, 10752.677419677422, 11139.944300278446, 9789.951050244703, 10382.117520010883, 10545.209109316678, 10705.304155229886, 10982.341059536453, 9262.44425334482, 9563.330566860253, 9578.664746733832, 9864.654737084455, 9937.900620993698, 10057.29598928068, 10203.846942295722, 10245.897541024495, 10326.0, 10364.792704145724, 8471.0, 8550.1449855014, 8818.91181088181, 8980.0, 8982.32632552548, 8600.354973377147, 8671.90031152648, 8807.427517211361, 9378.624855005723, 9390.859137112811], "value": 6294.595373624612, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 112.0, 116.0, 116.0, 115.0, 120.0, 113.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 146.0, 191.0, 122.0, 164.0, 148.0, 130.0, 189.0, 124.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 171.0, 163.0, 163.0, 164.0, 165.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 165.0, 77.0, 76.0, 78.0, 76.0, 165.0, 78.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 149.0, 90.0, 91.0, 87.0, 137.0, 88.0, 86.0, 143.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 74.0, 66.0, 70.0, 67.0, 67.0, 67.0, 72.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 93.0, 85.0, 83.0, 86.0, 87.0, 86.0, 83.0, 86.0, 82.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 137.0, 141.0, 151.0, 135.0, 133.0, 144.0, 147.0, 135.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 171.0, 173.0, 172.0, 175.0, 172.0, 169.0, 171.0, 170.0, 172.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 70.0, 73.0, 72.0, 68.0, 69.0, 68.0, 72.0], "value": 69.9, "unit": "score"}]}]} 18:02:30 INFO - Return code: 0 18:02:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:30 ERROR - # TBPL SUCCESS # 18:02:30 INFO - Running post-action listener: _resource_record_post_action 18:02:30 INFO - [mozharness: 2016-08-19 01:02:30.629980Z] Finished run-tests step (success) 18:02:30 INFO - Running post-run listener: _resource_record_post_run 18:02:30 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 409317376; Read time: 0; Write time: 323476 18:02:30 INFO - TinderboxPrint: CPU usage
13.4% 18:02:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:02:30 INFO - TinderboxPrint: I/O write bytes / time
409,317,376 / 323,476 18:02:30 INFO - TinderboxPrint: CPU idle
8,280.7 (86.6%) 18:02:30 INFO - TinderboxPrint: CPU user
1,220.2 (12.8%) 18:02:30 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113328128; Read time: 0; Write time: 114620 18:02:30 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 295989248; Read time: 0; Write time: 208856 18:02:31 INFO - Running post-run listener: _upload_blobber_files 18:02:31 INFO - Blob upload gear active. 18:02:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:31 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 18:02:31 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:02:31 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:02:31 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:32 INFO - (blobuploader) - INFO - Done attempting. 18:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:36 INFO - (blobuploader) - INFO - Done attempting. 18:02:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:02:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:36 INFO - (blobuploader) - INFO - Done attempting. 18:02:36 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:36 INFO - Return code: 0 18:02:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cf9f579992b353c123a75b853419a18189e55a8e28be071356f8726d824a34b476f271ec6e85fb35a9b6000d6d23719181aeac9612c7b63e41cfeda018c2b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b9892edf45508cb7153ac823b10e3d279d7b553e02eef6b7a5b24e1ab3d48a0d7a5e63de8e62eb5c82f706edf7a900012fcb9a008a572f9326c83f56d89e5aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1018e2517fdd15bb8d9f2f0b88e96c81ec6dd81941d18d22929d81c9894918acc727eb4dc245e081e60a063e5492b3f6a48558aff85351f9d74343bda1568233"} 18:02:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:36 INFO - Contents: 18:02:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cf9f579992b353c123a75b853419a18189e55a8e28be071356f8726d824a34b476f271ec6e85fb35a9b6000d6d23719181aeac9612c7b63e41cfeda018c2b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b9892edf45508cb7153ac823b10e3d279d7b553e02eef6b7a5b24e1ab3d48a0d7a5e63de8e62eb5c82f706edf7a900012fcb9a008a572f9326c83f56d89e5aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1018e2517fdd15bb8d9f2f0b88e96c81ec6dd81941d18d22929d81c9894918acc727eb4dc245e081e60a063e5492b3f6a48558aff85351f9d74343bda1568233"} 18:02:36 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:36 INFO - Copying logs to upload dir... 18:02:36 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.210765 ========= master_lag: 35.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-18 18:03:12.139727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 18:03:12.143049) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cf9f579992b353c123a75b853419a18189e55a8e28be071356f8726d824a34b476f271ec6e85fb35a9b6000d6d23719181aeac9612c7b63e41cfeda018c2b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b9892edf45508cb7153ac823b10e3d279d7b553e02eef6b7a5b24e1ab3d48a0d7a5e63de8e62eb5c82f706edf7a900012fcb9a008a572f9326c83f56d89e5aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1018e2517fdd15bb8d9f2f0b88e96c81ec6dd81941d18d22929d81c9894918acc727eb4dc245e081e60a063e5492b3f6a48558aff85351f9d74343bda1568233"} build_url:https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/NYqXxdA8Tw653S9RRDcy1w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41cf9f579992b353c123a75b853419a18189e55a8e28be071356f8726d824a34b476f271ec6e85fb35a9b6000d6d23719181aeac9612c7b63e41cfeda018c2b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b9892edf45508cb7153ac823b10e3d279d7b553e02eef6b7a5b24e1ab3d48a0d7a5e63de8e62eb5c82f706edf7a900012fcb9a008a572f9326c83f56d89e5aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1018e2517fdd15bb8d9f2f0b88e96c81ec6dd81941d18d22929d81c9894918acc727eb4dc245e081e60a063e5492b3f6a48558aff85351f9d74343bda1568233"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 18:03:12.168941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 18:03:12.169235) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1471567314.134439-1794789042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 18:03:12.218056) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 18:03:12.218342) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 18:03:12.218652) ========= ========= Total master_lag: 35.41 =========