builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1472713098.06 results: success (0) buildid: 20160831203012 builduid: ac0101aac8484daca6913ddc6a387a51 revision: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.061689) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.062143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.062413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.076785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.077053) ========= 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=8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 23:58:18-- 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% 114M=0s 2016-08-31 23:58:18 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130025 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.220358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.220655) ========= 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=8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:18.269500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 23:58:18.269840) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 --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 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 --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=8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 23:58:18,638 truncating revision to first 12 chars 2016-08-31 23:58:18,638 Setting DEBUG logging. 2016-08-31 23:58:18,638 attempt 1/10 2016-08-31 23:58:18,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f33ab9fd502?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 23:58:19,881 unpacking tar archive at: fx-team-9f33ab9fd502/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 23:58:19.864716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:19.865072) ========= script_repo_revision: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:19.865468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:19.865731) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 23:58:19.875210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-31 23:58:19.875475) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:58:20 INFO - MultiFileLogger online at 20160831 23:58:20 in /builds/slave/test 23:58:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:58:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:58:20 INFO - {'append_to_log': False, 23:58:20 INFO - 'base_work_dir': '/builds/slave/test', 23:58:20 INFO - 'blob_upload_branch': 'Fx-Team', 23:58:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:58:20 INFO - 'branch': 'Fx-Team', 23:58:20 INFO - 'buildbot_json_path': 'buildprops.json', 23:58:20 INFO - 'config_files': ('talos/linux_config.py',), 23:58:20 INFO - 'default_actions': ('clobber', 23:58:20 INFO - 'read-buildbot-config', 23:58:20 INFO - 'download-and-extract', 23:58:20 INFO - 'populate-webroot', 23:58:20 INFO - 'create-virtualenv', 23:58:20 INFO - 'install', 23:58:20 INFO - 'run-tests'), 23:58:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:58:20 INFO - 'download_minidump_stackwalk': True, 23:58:20 INFO - 'download_symbols': 'ondemand', 23:58:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:58:20 INFO - 'tooltool.py': '/tools/tooltool.py', 23:58:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:58:20 INFO - '/tools/misc-python/virtualenv.py')}, 23:58:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:58:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:58:20 INFO - 'installer_path': 'installer.exe', 23:58:20 INFO - 'log_level': 'info', 23:58:20 INFO - 'log_name': 'talos', 23:58:20 INFO - 'log_to_console': True, 23:58:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:58:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:58:20 INFO - 'opt_config_files': (), 23:58:20 INFO - 'pip_index': False, 23:58:20 INFO - 'sps_profile': False, 23:58:20 INFO - 'sps_profile_interval': 0, 23:58:20 INFO - 'suite': 'dromaeojs-e10s', 23:58:20 INFO - 'system_bits': '32', 23:58:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:58:20 INFO - 'title': 'talos-linux64-ix-001', 23:58:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:58:20 INFO - 'use_talos_json': True, 23:58:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:58:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:58:20 INFO - 'work_dir': 'build'} 23:58:20 INFO - [mozharness: 2016-09-01 06:58:20.335450Z] Running clobber step. 23:58:20 INFO - Running pre-action listener: _resource_record_pre_action 23:58:20 INFO - Running main action method: clobber 23:58:20 INFO - rmtree: /builds/slave/test/build 23:58:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:58:21 INFO - Running post-action listener: _resource_record_post_action 23:58:21 INFO - [mozharness: 2016-09-01 06:58:21.317092Z] Finished clobber step (success) 23:58:21 INFO - [mozharness: 2016-09-01 06:58:21.317193Z] Running read-buildbot-config step. 23:58:21 INFO - Running pre-action listener: _resource_record_pre_action 23:58:21 INFO - Running main action method: read_buildbot_config 23:58:21 INFO - Using buildbot properties: 23:58:21 INFO - { 23:58:21 INFO - "project": "", 23:58:21 INFO - "product": "firefox", 23:58:21 INFO - "script_repo_revision": "production", 23:58:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:58:21 INFO - "repository": "", 23:58:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:58:21 INFO - "buildid": "20160831203012", 23:58:21 INFO - "pgo_build": "True", 23:58:21 INFO - "basedir": "/builds/slave/test", 23:58:21 INFO - "buildnumber": 742, 23:58:21 INFO - "slavename": "talos-linux64-ix-001", 23:58:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:58:21 INFO - "platform": "ubuntu64_hw", 23:58:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:58:21 INFO - "branch": "fx-team", 23:58:21 INFO - "repo_path": "integration/fx-team", 23:58:21 INFO - "revision": "9f33ab9fd502d2a4c38aef7744ab68c0aaa78234", 23:58:21 INFO - "stage_platform": "linux64-pgo", 23:58:21 INFO - "builduid": "ac0101aac8484daca6913ddc6a387a51", 23:58:21 INFO - "slavebuilddir": "test" 23:58:21 INFO - } 23:58:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:58:21 INFO - Running post-action listener: _resource_record_post_action 23:58:21 INFO - [mozharness: 2016-09-01 06:58:21.319631Z] Finished read-buildbot-config step (success) 23:58:21 INFO - [mozharness: 2016-09-01 06:58:21.319723Z] Running download-and-extract step. 23:58:21 INFO - Running pre-action listener: _resource_record_pre_action 23:58:21 INFO - Running main action method: download_and_extract 23:58:21 INFO - mkdir: /builds/slave/test/build/tests 23:58: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')]} 23:58:21 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:58:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:21 INFO - Downloaded 1361 bytes. 23:58:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:58:21 INFO - Using the following test package requirements: 23:58:21 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:58:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:58:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:58:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'jsshell-linux-x86_64.zip'], 23:58:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:58:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:58:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:58:21 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:58:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:58:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:58:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:58: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')]} 23:58:21 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:58:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:22 INFO - Downloaded 21906704 bytes. 23:58:22 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 23:58:27 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 23:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:27 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:58:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:27 INFO - Downloaded 21906704 bytes. 23:58:27 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 23:58:32 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')]} 23:58:32 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:58:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:33 INFO - Downloaded 14413998 bytes. 23:58:33 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 23:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:33 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:58:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:58:34 INFO - Downloaded 59735366 bytes. 23:58:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:58:34 INFO - mkdir: /builds/slave/test/properties 23:58:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:58:34 INFO - Writing to file /builds/slave/test/properties/build_url 23:58:34 INFO - Contents: 23:58:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:58:35 INFO - Running post-action listener: _resource_record_post_action 23:58:35 INFO - Running post-action listener: set_extra_try_arguments 23:58:35 INFO - [mozharness: 2016-09-01 06:58:35.460452Z] Finished download-and-extract step (success) 23:58:35 INFO - [mozharness: 2016-09-01 06:58:35.460679Z] Running populate-webroot step. 23:58:35 INFO - Running pre-action listener: _resource_record_pre_action 23:58:35 INFO - Running main action method: populate_webroot 23:58:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:58:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:58:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:58:35 INFO - '--tppagecycles', 23:58:35 INFO - '7'], 23:58:35 INFO - 'tests': ['tsvgm']}}, 23:58:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:58:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:58:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:58:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:58:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:58:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:58:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['damp', 'tps']}, 23:58:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'tests': ['damp', 'tps']}, 23:58:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['dromaeo_dom']}, 23:58:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:58:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['basic_compositor_video']}, 23:58:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:58:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['a11yr', 23:58:35 INFO - 'ts_paint', 23:58:35 INFO - 'tpaint', 23:58:35 INFO - 'sessionrestore', 23:58:35 INFO - 'sessionrestore_no_auto_restore', 23:58:35 INFO - 'tabpaint']}, 23:58:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:58:35 INFO - 'ts_paint', 23:58:35 INFO - 'tpaint', 23:58:35 INFO - 'sessionrestore', 23:58:35 INFO - 'sessionrestore_no_auto_restore', 23:58:35 INFO - 'tabpaint']}, 23:58:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:58:35 INFO - 'ts_paint', 23:58:35 INFO - 'tpaint', 23:58:35 INFO - 'sessionrestore', 23:58:35 INFO - 'sessionrestore_no_auto_restore', 23:58:35 INFO - 'tabpaint']}, 23:58:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:58:35 INFO - 'ts_paint', 23:58:35 INFO - 'tpaint', 23:58:35 INFO - 'sessionrestore', 23:58:35 INFO - 'sessionrestore_no_auto_restore', 23:58:35 INFO - 'tabpaint']}, 23:58:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['a11yr', 23:58:35 INFO - 'ts_paint', 23:58:35 INFO - 'tpaint', 23:58:35 INFO - 'sessionrestore', 23:58:35 INFO - 'sessionrestore_no_auto_restore', 23:58:35 INFO - 'tabpaint']}, 23:58:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['a11yr', 23:58:35 INFO - 'ts_paint', 23:58:35 INFO - 'tpaint', 23:58:35 INFO - 'sessionrestore', 23:58:35 INFO - 'sessionrestore_no_auto_restore', 23:58:35 INFO - 'tabpaint']}, 23:58:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['tsvgx', 23:58:35 INFO - 'tsvgr_opacity', 23:58:35 INFO - 'tart', 23:58:35 INFO - 'tscrollx', 23:58:35 INFO - 'cart']}, 23:58:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:58:35 INFO - 'tsvgr_opacity', 23:58:35 INFO - 'tart', 23:58:35 INFO - 'tscrollx', 23:58:35 INFO - 'cart']}, 23:58:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'talos_options': ['--disable-e10s'], 23:58:35 INFO - 'tests': ['tp5o']}, 23:58:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'tests': ['tp5o']}, 23:58:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'talos_options': ['--disable-e10s', 23:58:35 INFO - '--xperf_path', 23:58:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:58:35 INFO - 'tests': ['tp5n']}, 23:58:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:35 INFO - 'talos_options': ['--xperf_path', 23:58:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:58:35 INFO - 'tests': ['tp5n']}}, 23:58:35 INFO - 'talos.zip': {'path': '', 23:58:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:58:35 INFO - Running post-action listener: _resource_record_post_action 23:58:35 INFO - [mozharness: 2016-09-01 06:58:35.476905Z] Finished populate-webroot step (success) 23:58:35 INFO - [mozharness: 2016-09-01 06:58:35.476995Z] Running create-virtualenv step. 23:58:35 INFO - Running pre-action listener: _resource_record_pre_action 23:58:35 INFO - Running main action method: create_virtualenv 23:58:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:58:35 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 23:58:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:58:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:58:35 INFO - Using real prefix '/usr' 23:58:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:58:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:58:38 INFO - Installing pip.................done. 23:58:38 INFO - Return code: 0 23:58:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:58:38 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')]} 23:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:38 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')]} 23:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:38 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:38 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 23:58:38 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 23:58:38 INFO - Using env: {'DISPLAY': ':0', 23:58:38 INFO - 'HOME': '/home/cltbld', 23:58:38 INFO - 'LANG': 'en_US.UTF-8', 23:58:38 INFO - 'LANGUAGE': 'en_US:en', 23:58:38 INFO - 'LOGNAME': 'cltbld', 23:58:38 INFO - 'MAIL': '/var/mail/cltbld', 23:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:38 INFO - 'MOZ_NO_REMOTE': '1', 23:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:38 INFO - 'NO_EM_RESTART': '1', 23:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:38 INFO - 'PWD': '/builds/slave/test', 23:58:38 INFO - 'SHELL': '/bin/bash', 23:58:38 INFO - 'SHLVL': '1', 23:58:38 INFO - 'TERM': 'linux', 23:58:38 INFO - 'TMOUT': '86400', 23:58:38 INFO - 'USER': 'cltbld', 23:58:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:38 INFO - '_': '/tools/buildbot/bin/python'} 23:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:38 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 23:58:38 INFO - Cleaning up... 23:58:38 INFO - Return code: 0 23:58:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:58:38 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')]} 23:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:38 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')]} 23:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:38 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:38 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 23:58:38 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 23:58:38 INFO - Using env: {'DISPLAY': ':0', 23:58:38 INFO - 'HOME': '/home/cltbld', 23:58:38 INFO - 'LANG': 'en_US.UTF-8', 23:58:38 INFO - 'LANGUAGE': 'en_US:en', 23:58:38 INFO - 'LOGNAME': 'cltbld', 23:58:38 INFO - 'MAIL': '/var/mail/cltbld', 23:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:38 INFO - 'MOZ_NO_REMOTE': '1', 23:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:38 INFO - 'NO_EM_RESTART': '1', 23:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:38 INFO - 'PWD': '/builds/slave/test', 23:58:38 INFO - 'SHELL': '/bin/bash', 23:58:38 INFO - 'SHLVL': '1', 23:58:38 INFO - 'TERM': 'linux', 23:58:38 INFO - 'TMOUT': '86400', 23:58:38 INFO - 'USER': 'cltbld', 23:58:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:38 INFO - '_': '/tools/buildbot/bin/python'} 23:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:38 INFO - Downloading/unpacking psutil>=3.1.1 23:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:40 INFO - Installing collected packages: psutil 23:58:40 INFO - Running setup.py install for psutil 23:58:40 INFO - building 'psutil._psutil_linux' extension 23:58:40 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 23:58:40 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 23:58:40 INFO - building 'psutil._psutil_posix' extension 23:58:40 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 23:58:40 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 23:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:40 INFO - Successfully installed psutil 23:58:40 INFO - Cleaning up... 23:58:41 INFO - Return code: 0 23:58:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:41 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:41 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 23:58:41 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 23:58:41 INFO - Using env: {'DISPLAY': ':0', 23:58:41 INFO - 'HOME': '/home/cltbld', 23:58:41 INFO - 'LANG': 'en_US.UTF-8', 23:58:41 INFO - 'LANGUAGE': 'en_US:en', 23:58:41 INFO - 'LOGNAME': 'cltbld', 23:58:41 INFO - 'MAIL': '/var/mail/cltbld', 23:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:41 INFO - 'MOZ_NO_REMOTE': '1', 23:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:41 INFO - 'NO_EM_RESTART': '1', 23:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:41 INFO - 'PWD': '/builds/slave/test', 23:58:41 INFO - 'SHELL': '/bin/bash', 23:58:41 INFO - 'SHLVL': '1', 23:58:41 INFO - 'TERM': 'linux', 23:58:41 INFO - 'TMOUT': '86400', 23:58:41 INFO - 'USER': 'cltbld', 23:58:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:41 INFO - '_': '/tools/buildbot/bin/python'} 23:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:58:41 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 23:58:41 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 23:58:41 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 23:58:41 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 23:58:41 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 23:58:41 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 23:58:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:58:43 INFO - Installing collected packages: mozsystemmonitor 23:58:43 INFO - Running setup.py install for mozsystemmonitor 23:58:43 INFO - Successfully installed mozsystemmonitor 23:58:43 INFO - Cleaning up... 23:58:43 INFO - Return code: 0 23:58:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:58:43 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')]} 23:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:43 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')]} 23:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:43 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:43 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 23:58:43 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 23:58:43 INFO - Using env: {'DISPLAY': ':0', 23:58:43 INFO - 'HOME': '/home/cltbld', 23:58:43 INFO - 'LANG': 'en_US.UTF-8', 23:58:43 INFO - 'LANGUAGE': 'en_US:en', 23:58:43 INFO - 'LOGNAME': 'cltbld', 23:58:43 INFO - 'MAIL': '/var/mail/cltbld', 23:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:43 INFO - 'MOZ_NO_REMOTE': '1', 23:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:43 INFO - 'NO_EM_RESTART': '1', 23:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:43 INFO - 'PWD': '/builds/slave/test', 23:58:43 INFO - 'SHELL': '/bin/bash', 23:58:43 INFO - 'SHLVL': '1', 23:58:43 INFO - 'TERM': 'linux', 23:58:43 INFO - 'TMOUT': '86400', 23:58:43 INFO - 'USER': 'cltbld', 23:58:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:43 INFO - '_': '/tools/buildbot/bin/python'} 23:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:43 INFO - Downloading/unpacking jsonschema==2.5.1 23:58:43 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 23:58:43 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 23:58:43 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 23:58:43 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 23:58:43 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 23:58:43 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 23:58:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:58:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:45 INFO - Downloading functools32-3.2.3-2.tar.gz 23:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:58:45 INFO - warning: no files found matching '*.txt' 23:58:45 INFO - no previously-included directories found matching 'build' 23:58:45 INFO - no previously-included directories found matching 'dist' 23:58:45 INFO - no previously-included directories found matching '.git*' 23:58:45 INFO - Installing collected packages: jsonschema, functools32 23:58:45 INFO - Running setup.py install for functools32 23:58:45 INFO - warning: no files found matching '*.txt' 23:58:45 INFO - no previously-included directories found matching 'build' 23:58:45 INFO - no previously-included directories found matching 'dist' 23:58:45 INFO - no previously-included directories found matching '.git*' 23:58:45 INFO - Successfully installed jsonschema functools32 23:58:45 INFO - Cleaning up... 23:58:45 INFO - Return code: 0 23:58:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:58:45 INFO - Using env: {'DISPLAY': ':0', 23:58:45 INFO - 'HOME': '/home/cltbld', 23:58:45 INFO - 'LANG': 'en_US.UTF-8', 23:58:45 INFO - 'LANGUAGE': 'en_US:en', 23:58:45 INFO - 'LOGNAME': 'cltbld', 23:58:45 INFO - 'MAIL': '/var/mail/cltbld', 23:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:45 INFO - 'MOZ_NO_REMOTE': '1', 23:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:45 INFO - 'NO_EM_RESTART': '1', 23:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:45 INFO - 'PWD': '/builds/slave/test', 23:58:45 INFO - 'SHELL': '/bin/bash', 23:58:45 INFO - 'SHLVL': '1', 23:58:45 INFO - 'TERM': 'linux', 23:58:45 INFO - 'TMOUT': '86400', 23:58:45 INFO - 'USER': 'cltbld', 23:58:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:45 INFO - '_': '/tools/buildbot/bin/python'} 23:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:58:46 INFO - Cleaning up... 23:58:46 INFO - Return code: 0 23:58:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:58:46 INFO - Using env: {'DISPLAY': ':0', 23:58:46 INFO - 'HOME': '/home/cltbld', 23:58:46 INFO - 'LANG': 'en_US.UTF-8', 23:58:46 INFO - 'LANGUAGE': 'en_US:en', 23:58:46 INFO - 'LOGNAME': 'cltbld', 23:58:46 INFO - 'MAIL': '/var/mail/cltbld', 23:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:46 INFO - 'MOZ_NO_REMOTE': '1', 23:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:46 INFO - 'NO_EM_RESTART': '1', 23:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:46 INFO - 'PWD': '/builds/slave/test', 23:58:46 INFO - 'SHELL': '/bin/bash', 23:58:46 INFO - 'SHLVL': '1', 23:58:46 INFO - 'TERM': 'linux', 23:58:46 INFO - 'TMOUT': '86400', 23:58:46 INFO - 'USER': 'cltbld', 23:58:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:46 INFO - '_': '/tools/buildbot/bin/python'} 23:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:46 INFO - Downloading/unpacking blobuploader==1.2.4 23:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:58:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:58:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:48 INFO - Downloading docopt-0.6.1.tar.gz 23:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:58:48 INFO - Installing collected packages: blobuploader, requests, docopt 23:58:48 INFO - Running setup.py install for blobuploader 23:58:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:58:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:58:49 INFO - Running setup.py install for requests 23:58:49 INFO - Running setup.py install for docopt 23:58:49 INFO - Successfully installed blobuploader requests docopt 23:58:49 INFO - Cleaning up... 23:58:49 INFO - Return code: 0 23:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:49 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:49 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 23:58:49 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 23:58:49 INFO - Using env: {'DISPLAY': ':0', 23:58:49 INFO - 'HOME': '/home/cltbld', 23:58:49 INFO - 'LANG': 'en_US.UTF-8', 23:58:49 INFO - 'LANGUAGE': 'en_US:en', 23:58:49 INFO - 'LOGNAME': 'cltbld', 23:58:49 INFO - 'MAIL': '/var/mail/cltbld', 23:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:49 INFO - 'MOZ_NO_REMOTE': '1', 23:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:49 INFO - 'NO_EM_RESTART': '1', 23:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:49 INFO - 'PWD': '/builds/slave/test', 23:58:49 INFO - 'SHELL': '/bin/bash', 23:58:49 INFO - 'SHLVL': '1', 23:58:49 INFO - 'TERM': 'linux', 23:58:49 INFO - 'TMOUT': '86400', 23:58:49 INFO - 'USER': 'cltbld', 23:58:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:49 INFO - '_': '/tools/buildbot/bin/python'} 23:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:49 INFO - Running setup.py (path:/tmp/pip-xbv8Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:49 INFO - Running setup.py (path:/tmp/pip-g3gIKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:49 INFO - Running setup.py (path:/tmp/pip-vDMMOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:50 INFO - Running setup.py (path:/tmp/pip-Uk6VHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:50 INFO - Running setup.py (path:/tmp/pip-x2EG4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:50 INFO - Running setup.py (path:/tmp/pip-80lBFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:50 INFO - Running setup.py (path:/tmp/pip-isQNCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:50 INFO - Running setup.py (path:/tmp/pip-QR0aeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:50 INFO - Running setup.py (path:/tmp/pip-b_1L1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:50 INFO - Running setup.py (path:/tmp/pip-i6gqMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:50 INFO - Running setup.py (path:/tmp/pip-g02M7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:50 INFO - Running setup.py (path:/tmp/pip-lMUrqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:50 INFO - Running setup.py (path:/tmp/pip-2n113r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:50 INFO - Running setup.py (path:/tmp/pip-P5Zz91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:50 INFO - Running setup.py (path:/tmp/pip-lsgORm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:50 INFO - Running setup.py (path:/tmp/pip-SLgoUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:50 INFO - Running setup.py (path:/tmp/pip-iLgwAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:58:50 INFO - Running setup.py install for manifestparser 23:58:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Running setup.py install for mozcrash 23:58:51 INFO - Running setup.py install for mozdebug 23:58:51 INFO - Running setup.py install for mozdevice 23:58:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Running setup.py install for mozfile 23:58:51 INFO - Running setup.py install for mozhttpd 23:58:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Running setup.py install for mozinfo 23:58:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Running setup.py install for mozInstall 23:58:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:58:51 INFO - Running setup.py install for mozleak 23:58:51 INFO - Running setup.py install for mozlog 23:58:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Running setup.py install for moznetwork 23:58:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Running setup.py install for mozprocess 23:58:52 INFO - Running setup.py install for mozprofile 23:58:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Running setup.py install for mozrunner 23:58:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Running setup.py install for mozscreenshot 23:58:52 INFO - Running setup.py install for moztest 23:58:52 INFO - Running setup.py install for mozversion 23:58:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:58:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:58:52 INFO - Cleaning up... 23:58:52 INFO - Return code: 0 23:58:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:52 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')]} 23:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:52 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')]} 23:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:52 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:52 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 23:58:52 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 23:58:52 INFO - Using env: {'DISPLAY': ':0', 23:58:52 INFO - 'HOME': '/home/cltbld', 23:58:52 INFO - 'LANG': 'en_US.UTF-8', 23:58:52 INFO - 'LANGUAGE': 'en_US:en', 23:58:52 INFO - 'LOGNAME': 'cltbld', 23:58:52 INFO - 'MAIL': '/var/mail/cltbld', 23:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:52 INFO - 'MOZ_NO_REMOTE': '1', 23:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:52 INFO - 'NO_EM_RESTART': '1', 23:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:52 INFO - 'PWD': '/builds/slave/test', 23:58:52 INFO - 'SHELL': '/bin/bash', 23:58:52 INFO - 'SHLVL': '1', 23:58:52 INFO - 'TERM': 'linux', 23:58:52 INFO - 'TMOUT': '86400', 23:58:52 INFO - 'USER': 'cltbld', 23:58:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:52 INFO - '_': '/tools/buildbot/bin/python'} 23:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:53 INFO - Running setup.py (path:/tmp/pip-nzFDSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:53 INFO - Running setup.py (path:/tmp/pip-kpslZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:53 INFO - Running setup.py (path:/tmp/pip-8GLQXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:53 INFO - Running setup.py (path:/tmp/pip-1k38JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:53 INFO - Running setup.py (path:/tmp/pip-LgkdUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:53 INFO - Running setup.py (path:/tmp/pip-DjGAGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:53 INFO - Running setup.py (path:/tmp/pip-Ux0sIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:53 INFO - Running setup.py (path:/tmp/pip-1Xgtvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:53 INFO - Running setup.py (path:/tmp/pip-fH5Yel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:53 INFO - Running setup.py (path:/tmp/pip-ciN4n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:53 INFO - Running setup.py (path:/tmp/pip-dCqwtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:53 INFO - Running setup.py (path:/tmp/pip-e5T02c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:53 INFO - Running setup.py (path:/tmp/pip-VOih6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:53 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)) 23:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:53 INFO - Running setup.py (path:/tmp/pip-q1TPzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:54 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)) 23:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:54 INFO - Running setup.py (path:/tmp/pip-Xhpy3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:54 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)) 23:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:54 INFO - Running setup.py (path:/tmp/pip-WLY6DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:54 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)) 23:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:54 INFO - Running setup.py (path:/tmp/pip-HXlpX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:54 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)) 23:58:54 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)) 23:58:54 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)) 23:58:54 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)) 23:58:54 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)) 23:58:54 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)) 23:58:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:58:54 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 23:58:54 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 23:58:54 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 23:58:54 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 23:58:54 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 23:58:54 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 23:58:56 INFO - Downloading blessings-1.6.tar.gz 23:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:58:56 INFO - Installing collected packages: blessings 23:58:56 INFO - Running setup.py install for blessings 23:58:56 INFO - Successfully installed blessings 23:58:56 INFO - Cleaning up... 23:58:56 INFO - Return code: 0 23:58:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:56 INFO - Reading from file tmpfile_stdout 23:58:56 INFO - Current package versions: 23:58:56 INFO - argparse == 1.2.1 23:58:56 INFO - blessings == 1.6 23:58:56 INFO - blobuploader == 1.2.4 23:58:56 INFO - docopt == 0.6.1 23:58:56 INFO - functools32 == 3.2.3-2 23:58:56 INFO - jsonschema == 2.5.1 23:58:56 INFO - manifestparser == 1.1 23:58:56 INFO - mozInstall == 1.12 23:58:56 INFO - mozcrash == 0.17 23:58:56 INFO - mozdebug == 0.1 23:58:56 INFO - mozdevice == 0.48 23:58:56 INFO - mozfile == 1.2 23:58:56 INFO - mozhttpd == 0.7 23:58:56 INFO - mozinfo == 0.9 23:58:56 INFO - mozleak == 0.1 23:58:56 INFO - mozlog == 3.3 23:58:56 INFO - moznetwork == 0.27 23:58:56 INFO - mozprocess == 0.23 23:58:56 INFO - mozprofile == 0.28 23:58:56 INFO - mozrunner == 6.12 23:58:56 INFO - mozscreenshot == 0.1 23:58:56 INFO - mozsystemmonitor == 0.3 23:58:56 INFO - moztest == 0.7 23:58:56 INFO - mozversion == 1.4 23:58:56 INFO - psutil == 3.1.1 23:58:56 INFO - requests == 1.2.3 23:58:56 INFO - wsgiref == 0.1.2 23:58:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58: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')]} 23:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58: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')]} 23:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:56 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:56 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 23:58:56 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 23:58:56 INFO - Using env: {'DISPLAY': ':0', 23:58:56 INFO - 'HOME': '/home/cltbld', 23:58:56 INFO - 'LANG': 'en_US.UTF-8', 23:58:56 INFO - 'LANGUAGE': 'en_US:en', 23:58:56 INFO - 'LOGNAME': 'cltbld', 23:58:56 INFO - 'MAIL': '/var/mail/cltbld', 23:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:56 INFO - 'MOZ_NO_REMOTE': '1', 23:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:56 INFO - 'NO_EM_RESTART': '1', 23:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:56 INFO - 'PWD': '/builds/slave/test', 23:58:56 INFO - 'SHELL': '/bin/bash', 23:58:56 INFO - 'SHLVL': '1', 23:58:56 INFO - 'TERM': 'linux', 23:58:56 INFO - 'TMOUT': '86400', 23:58:56 INFO - 'USER': 'cltbld', 23:58:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:56 INFO - '_': '/tools/buildbot/bin/python'} 23:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 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)) 23:58:56 INFO - Cleaning up... 23:58:56 INFO - Return code: 0 23:58:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:58: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')]} 23:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58: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')]} 23:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:56 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 0x7ffd0c516f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, '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': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', '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 23:58:56 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 23:58:56 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 23:58:56 INFO - Using env: {'DISPLAY': ':0', 23:58:56 INFO - 'HOME': '/home/cltbld', 23:58:56 INFO - 'LANG': 'en_US.UTF-8', 23:58:56 INFO - 'LANGUAGE': 'en_US:en', 23:58:56 INFO - 'LOGNAME': 'cltbld', 23:58:56 INFO - 'MAIL': '/var/mail/cltbld', 23:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:56 INFO - 'MOZ_NO_REMOTE': '1', 23:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:56 INFO - 'NO_EM_RESTART': '1', 23:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:56 INFO - 'PWD': '/builds/slave/test', 23:58:56 INFO - 'SHELL': '/bin/bash', 23:58:56 INFO - 'SHLVL': '1', 23:58:56 INFO - 'TERM': 'linux', 23:58:56 INFO - 'TMOUT': '86400', 23:58:56 INFO - 'USER': 'cltbld', 23:58:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:56 INFO - '_': '/tools/buildbot/bin/python'} 23:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:58:57 INFO - Cleaning up... 23:58:57 INFO - Return code: 0 23:58:57 INFO - Running post-action listener: _resource_record_post_action 23:58:57 INFO - Running post-action listener: _start_resource_monitoring 23:58:57 INFO - Starting resource monitoring. 23:58:57 INFO - [mozharness: 2016-09-01 06:58:57.166260Z] Finished create-virtualenv step (success) 23:58:57 INFO - [mozharness: 2016-09-01 06:58:57.166766Z] Running install step. 23:58:57 INFO - Running pre-action listener: _resource_record_pre_action 23:58:57 INFO - Running main action method: install 23:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:57 INFO - Reading from file tmpfile_stdout 23:58:57 INFO - Detecting whether we're running mozinstall >=1.0... 23:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:58:57 INFO - Reading from file tmpfile_stdout 23:58:57 INFO - Output received: 23:58:57 INFO - Usage: mozinstall [options] installer 23:58:57 INFO - Options: 23:58:57 INFO - -h, --help show this help message and exit 23:58:57 INFO - -d DEST, --destination=DEST 23:58:57 INFO - Directory to install application into. [default: 23:58:57 INFO - "/builds/slave/test"] 23:58:57 INFO - --app=APP Application being installed. [default: firefox] 23:58:57 INFO - mkdir: /builds/slave/test/build/application 23:58:57 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'] 23:58:57 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 23:59:14 INFO - Reading from file tmpfile_stdout 23:59:14 INFO - Output received: 23:59:14 INFO - /builds/slave/test/build/application/firefox/firefox 23:59:14 INFO - Running post-action listener: _resource_record_post_action 23:59:14 INFO - [mozharness: 2016-09-01 06:59:14.471401Z] Finished install step (success) 23:59:14 INFO - [mozharness: 2016-09-01 06:59:14.471743Z] Running run-tests step. 23:59:14 INFO - Running pre-action listener: _resource_record_pre_action 23:59:14 INFO - Running main action method: run_tests 23:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:59:14 INFO - Python 2.7.3 23:59:14 INFO - Return code: 0 23:59:14 INFO - grabbing minidump binary from tooltool 23:59: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')]} 23:59:14 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 0x14c9370>, '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 0x14cc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ccd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:59:14 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 23:59:14 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 23:59:14 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 23:59:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:59:14 INFO - Return code: 0 23:59:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:59:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:59:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:59:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:59:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 23:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 23:59:14 INFO - Using env: {'DISPLAY': ':0', 23:59:14 INFO - 'HOME': '/home/cltbld', 23:59:14 INFO - 'LANG': 'en_US.UTF-8', 23:59:14 INFO - 'LANGUAGE': 'en_US:en', 23:59:14 INFO - 'LOGNAME': 'cltbld', 23:59:14 INFO - 'MAIL': '/var/mail/cltbld', 23:59:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:59:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:14 INFO - 'MOZ_NO_REMOTE': '1', 23:59:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:14 INFO - 'NO_EM_RESTART': '1', 23:59:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:14 INFO - 'PWD': '/builds/slave/test', 23:59:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:59:14 INFO - 'SHELL': '/bin/bash', 23:59:14 INFO - 'SHLVL': '1', 23:59:14 INFO - 'TERM': 'linux', 23:59:14 INFO - 'TMOUT': '86400', 23:59:14 INFO - 'USER': 'cltbld', 23:59:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064', 23:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:14 INFO - '_': '/tools/buildbot/bin/python'} 23:59:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 23:59:14 INFO - mozversion application_buildid: 20160831203012 23:59:14 INFO - mozversion application_changeset: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 23:59:14 INFO - mozversion application_display_name: Nightly 23:59:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:59:14 INFO - mozversion application_name: Firefox 23:59:14 INFO - mozversion application_remotingname: firefox 23:59:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:59:14 INFO - mozversion application_vendor: Mozilla 23:59:14 INFO - mozversion application_version: 51.0a1 23:59:14 INFO - mozversion platform_buildid: 20160831203012 23:59:14 INFO - mozversion platform_changeset: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 23:59:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:59:14 INFO - mozversion platform_version: 51.0a1 23:59:14 INFO - using testdate: 1472713154 23:59:14 INFO - actual date: 1472713154 23:59:14 INFO - starting webserver on 'localhost:34385' 23:59:14 INFO - SUITE-START | Running 2 tests 23:59:14 INFO - TEST-START | dromaeo_css 23:59:14 INFO - operating with platform_type : linux_ 23:59:14 INFO - Initialising browser for dromaeo_css test... 23:59:14 INFO - TEST-INFO | started process 20775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalQ6EK/profile http://localhost:34385/getInfo.html) 23:59:19 INFO - PROCESS | 20775 | __metrics Screen width/height:1600/1200 23:59:19 INFO - PROCESS | 20775 | colorDepth:24 23:59:19 INFO - PROCESS | 20775 | Browser inner width/height: 1024/697 23:59:19 INFO - PROCESS | 20775 | __metrics 23:59:20 ERROR - PROCESS | 20775 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 23:59:21 INFO - TEST-INFO | 20775: exit 0 23:59:21 INFO - Browser initialized. 23:59:21 INFO - Running cycle 1/1 for dromaeo_css test... 23:59:21 INFO - TEST-INFO | started process 20893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalQ6EK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:59:33 INFO - PROCESS | 20893 | RSS: Main: 191393792 23:59:33 INFO - PROCESS | 20893 | 00:00:22 INFO - PROCESS | 20893 | 1472713222893 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] 00:02:33 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:34385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34385/tests/dromaeo/cssquery-ext.html) 00:02:34 INFO - PROCESS | 20893 | RSS: Main: 198905856 00:02:34 INFO - PROCESS | 20893 | 00:05:36 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:34385/tests/dromaeo/cssquery-ext.html (next: http://localhost:34385/tests/dromaeo/cssquery-jquery.html) 00:05:37 INFO - PROCESS | 20893 | RSS: Main: 194740224 00:05:37 INFO - PROCESS | 20893 | 00:08:39 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:34385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34385/tests/dromaeo/cssquery-mootools.html) 00:08:39 INFO - PROCESS | 20893 | RSS: Main: 193798144 00:08:39 INFO - PROCESS | 20893 | 00:11:41 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:34385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34385/tests/dromaeo/cssquery-prototype.html) 00:11:42 INFO - PROCESS | 20893 | RSS: Main: 196857856 00:11:42 INFO - PROCESS | 20893 | 00:14:44 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:34385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34385/tests/dromaeo/cssquery-yui.html) 00:14:45 INFO - PROCESS | 20893 | RSS: Main: 195641344 00:14:45 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:34385/tests/dromaeo/cssquery-yui.html (next: http://localhost:34385/tests/dromaeo/cssquery-dojo.html) 00:17:48 INFO - PROCESS | 20893 | RSS: Main: 198144000 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | __start_tp_report 00:17:48 INFO - PROCESS | 20893 | _x_x_mozilla_page_load 00:17:48 INFO - PROCESS | 20893 | _x_x_mozilla_page_load_details 00:17:48 INFO - PROCESS | 20893 | |i|pagename|runs| 00:17:48 INFO - PROCESS | 20893 | |0;dojo.html;3104.8913288034914;3116.53252012198;3136.5452009458627;3152.4956007038872;3161.588993430855;5399.892002159954;5517.089680202766;5546.611737178399;5581.553475721943;5658.1229909364065;5484.725763711808;5492.450754924505;5513.145462453306;5524.364698059714;5560.221568980346;4906.509349065101;4996.900061998758;5028.572571331423;5037.168867136918;5045.217991211368;4632.606228470567;5040.848774536751;5092.770825312869;5097.6941383517105;5146.716930568818;4916.43461001984;4972.428170760372;4975.577075948549;4976.104301225778;5069.366329208849;4986.5761410280165;4998;5002.6748261363255;5016.871203979112;5074.340335756328;4873.463918968911;4936.234883593049;4958.380202474691;4969.130402179604;5031.471695471996;5326.36083669962;5359.115745901921;5411.485908838654;5414.269073675043;5515.779368825242;5846.210761547221;5846.3861294563885;5866.735996880108;5875.059990401558;5878.382769809194;5884.529237660977;5892.941070589325;5893.499052580536;5895.439933206381;5901.557383196235;5346.358436987547;5493.697846618435;5565.415631358689;5609.411011843697;5611.466910643482;6025.307089684742;6041.72812223451;6053.697315134314;6069.635821850615;6083.300420451616;5753.683547404933;5756.539476841843;5784.248047753765;5791.102379131242;5807.419258074243;5665.291838520185;5678.119891416837;5798.797042103591;5842.386549412336;5852.561057920673;5721.199032135504;5734.197212390269;5740.081586946152;5814.418558144236;5815.5929084963645;5823.213866128103;5834.970825145847;5922.585419020714;5927.081302398135;5930.169776231331;4408.470983482002;4497.662675299365;4514.074614703978;4530.977345113253;4543.977280113579;3995.7402768819934;4005.938426317028;4051.4125451809323;4069.613386728256;4070.816813243411;5570.777168913279;5636.746346414421;5643.5767317451355;5661.971690141605;5676.631018983753;5782.161586569924;5904.586678932519;5909.113632955091;5914.112883067574;5980.953333166678;5623.690697011703;5665.1502274658305;5667.886642267132;5698;5712.400197979152;5109.156989096758;5159.7678104485385;5162.432132465426;5163.915577728644;5221.347331583552;5984.521238300926;5997.370276121119;6043.848903777265;6132.202813634199;6148.723307451175;5872.148538461985;5883.2057672213705;5937.970310148422;5998.190244317136;6011.068284415923;5995.700214989321;6008.008678567988;6057.606255593372;6068.757249709962;6084.787032453843;5664.376918538875;5763.337216220189;5764.711764411846;5784.739686714024;5801.390853960443;5904.789518148683;5952.672603006876;5958.1360702697;5986.970065149646;6026.186464827192;5750.568707346882;5765.711714414347;5773.971130144322;5778.27771528559;5779.826605201851;5584.357798853184;5593.161025846156;5690.658560486384;5735.598508104559;5739.368669446441;5743.4256574342235;5743.511801496919;5754.19441278213;5772.538196944319;5827.155062515827;5754.367019627922;5783.16144159103;5833.125031245348;5848.941510584839;5850.5027072699295;5464.8360549182;5641.887162256649;5671.6597004179885;5672.262605861211;5692.743826527733 00:17:48 INFO - PROCESS | 20893 | |1;ext.html;565.9660420374778;587.2805812879224;588.5468189494089;595.5325069820191;612.9785457508982;40072;43608.34587481182;43683.344749828735;43729.12541749163;43783.78108109463;44501.332480012825;44719.77640111803;44750.55249447504;45066.32400513995;45081.77459112708;8929.41958772681;9092.590833412512;9104.31717621181;9108.817823643523;9109.726708198732;8982.59578318974;9031.864522032174;9037.27701783859;9058.728238152866;9067.818643627124;9050.728478145666;9071.727848164566;9144.405613635092;9171.678991235309;9171.862422063674;9020.54897255138;9049.457032578033;9058.773530661787;9068.138526839939;9077.727668169966;8902.154295341932;8935.240504557121;8944.195022448012;8980.371374003822;8989.190972812477;41275.793621032004;41617.167656647;41640.1671966562;41650.583494164974;41784.58215417837;3381.1378098584705;3470.895873123785;3586.3544561978833;3860.2279544091293;4052.9392059119136;31901.202469938205;32537.349253015043;32899.835500822344;33449;34286.14284642879;4003.6596889264156;4060.309747342959;4075.7490947458023;4092.4066010428323;4093.263212621727;336566;337601;338267.99999999756;338755;340878;56402.43597563972;56740;56765.71617141888;56774.43225567774;56809.7159514208;32628;33137.83431082829;33184;33205.66794332026;59118.70440647769;16122.516324510283;16210.675786484204;16236.431724889808;16248.837511624732;16319.673606527804;13236.470541178438;13349;13381.799273010913;13417.597472075853;13440.529581464602;18611.627767444847;18681.53296167607;18763.718544221847;18958.241670333307;19202.423927282205;6757.797266082025;7144.821379465555;7246.673899674527;7251.383632391306;7362.595057271901;934.5467448287575;1014.1582486536157;1050.2438244463974;1067.0183431243274;1119.4458742922307;31468.21329466736;31908.361832763214;32208.677913220567;32469.675303246666;32477.675223247938;1048.826943554305;1083.5828206140534;1096.8464414981909;1116.5198964445367;1138.4933704501582;15110.697786044218;16424.425145119865;16551.510364067293;16887.49337519852;16940;552126;560634;562534;563130;564605.5309170366;57136;58025.41974580284;58182;58208;58270;1299.7985312276612;1319.6832760137497;1360.7210521842999;1372.4647387518876;1375.9793603095761;28763;30600;30723;31089.82371233992;31439.68560314459;51060;51368.22947655863;51444;51601.22598161106;51635.2254716172;432441;432546;434718;434766;436357;27290.590641140796;27745.722542774314;27837.721622783512;28241.43517129605;28338;44189.77905110454;44295.77852110719;46615.766921165174;47895;48262.51737482721;39656.206875862896;40285.194296113325;40334;41131.58868411277;41585.96035099147;40035.199296013336;40426.79786601048;40769.388459172544;41648.16703665849;42060.36909446299;32638.83680581582;39603.80198098991;39605;39648.2070358597;40831;32760.836195819822;37273.6272637281;37333;37758.244835103695;37865.242695146495;27851.860740696167;27942.32346059243;27976.30059248535;28334;28574 00:17:48 INFO - PROCESS | 20893 | |2;jquery.html;379.3304816998001;386.8336615255439;402.34217055114885;403.6669747458347;416.3297091682393;13786.517471888486;18380.90809545952;19393.12730927108;19927.900360498195;19945.501362465944;19097.618047639073;19258;19484;19550;19628.214871405125;5534.640248383862;5587.916181257285;5750.137479378106;5800.651960882361;5814.622049566765;5724.284464441945;5825.213596164527;5835.824925252249;5848.970755146218;5853.443922827346;5629.943700563003;5751.827445176651;5775.10485874688;5786.82639520813;5794.6812925289305;5706.4864162225185;5736.11090281005;5809.854753631151;5810.128480727883;5816.680082595455;5153.922691159635;5429.56563474925;5455.972720136374;5537.640053396557;5547.0570003099165;14104;14306.713865722731;18886.43340699781;22789;22931.656025159635;2375.845570037942;2399.448126930798;2506.636537702023;2536.4927014597156;2855.9718501339503;9912.35569687968;10098.343607665553;10157.644482443078;10605.522751476203;10770.922907709166;1724.5860993361628;1797.9640407191782;1800.7478952946467;1809.095452273863;1813.3562585282166;76926.23073769303;80643;81300.9999999994;82856;86620.56689716574;10917.126629869592;11061.225714200089;11291.830622540669;11305.886941130484;11438.656840294638;15555.22223888801;15562.688746225012;15564.844351556567;15588;15599.610009749847;7993.880091798627;8109.270165685117;8280.089190189074;8292.295154911779;8369.079401265855;7719.768406947801;7749.651265693057;7993.9200607994335;8008;8065.39509536787;4669.276262179367;4686.36734040907;4714.316424118484;4776.283557466408;4811.109944660179;1996.2015193922548;2023.5244717491378;2043.1418804102314;2062.236972320251;2090.404234793107;870.825834833036;951.6145960885714;974.28390133252;1007.2495990486988;1033.9069483746498;18329;18509.907450462662;19281.22875084981;19336.616092184093;19344.70982935257;954.4321128928276;989.2728844299434;990.1336330710628;1002.0530598584268;1048.9929667519114;10078.395296282246;10171.830239522402;10941.781164376667;11092;11229.775404491864;485544;486954;496925;497625;503532;91663;92382.53808730913;93419.53290233505;95276;96528.51735741417;1037.984430233547;1056.7569459024467;1075.166745772033;1080.8919108089128;1082.182951871332;16612.2524486396;17031.65936681284;18031.909840451237;18141;18168.000759957802;43240.35139472973;44316.55683443253;44619;44660;44937;58807.70596146992;59165.40834591599;59638.10542841774;60739.69630151821;61377;7975;8182.509049457051;8314.916850831414;8386.538740369338;8776.956115219384;11548.653540393801;12648.494060237488;13227.011264680219;13665.726685466434;13800.171989680652;11358.148138889781;11384.772304554028;11571.826422603835;11577;12033.338166400932;11196.776064478829;11453.427328633701;11538.423078846192;11845.526178952745;11910.52357905674;11084.113270938467;11377.146713996317;11575.652730418102;11647.767044658889;12024.458899349374;8337.624806883583;8393.24460798531;8521.786955325919;8689.348298877736;8840.381173317806;10523.210759192938;11174.161937854531;11287.887121128684;11340.94329528347;11347.262427942487 00:17:48 INFO - PROCESS | 20893 | |3;mootools.html;1470.62499062739;1479.9186044767537;1647.8681705463557;1774.175008620991;1801.8018018018008;7888.329491993173;8505;8688.913110868889;9201.26389888809;9210.171084602385;8685.522296273703;9061.864072038908;9071.682491112811;9115;9162.862557061633;2465.2604218734355;2491.8006559475198;2492.950140997179;2494.463690306584;2500.4124030852736;2397.1250493569896;2483.4412257242157;2485.1177831869695;2485.6023036314195;2489.7634724701124;2463.6674049003423;2469.172827102923;2513.1455305196228;2518.697756269241;2518.937026574341;2344.097522453859;2394.1381102802975;2405.56699794037;2457.299669594157;2457.3733697907096;2437.8049756019477;2448.1309135256906;2449.3754092706245;2458.459138989437;2460.803135749136;9062.864057039149;9139.634414623408;9143.725688229364;9180.357374983754;9184.173424391836;5384.219288203228;5575.749091290902;5575.832725018256;5584.441555844423;5603.159526071081;3204.6635103314047;3392.7794693344854;3408.9147771305666;3425.760196786226;3439.5872495300723;1110.5779803674632;1134.33641319828;1138.9088872890231;1141.4749215360944;1166.4692564882957;12433.93783031079;12447.3776311185;12485.375731213402;12509.999999999909;12549.184303020274;4807.567318941242;4840.346553215341;4910.754462276872;4994.900101998012;5046.722430266297;10604.787904241872;10618.36289822613;10621.84067238992;10632.574697012187;10662.466876656135;5416.756245968941;5452.182172674051;5472.72636368188;5481.862953426116;5489.204065410493;4557.92888671162;4931.630127740434;4945.381827271591;5032.899342013213;5079.466656001141;4038.715696182818;4155.10665206982;4218.915621687549;4225.19721252961;4236.639885609696;1369.6781256404936;1375.8761711445818;1403;1415.101410604253;1415.1579810013027;831.3930830493773;865.7359505350928;893.2585953658578;936.6721647423348;940.2571968145089;5982.760689572456;5993.730282137314;6044.972354699712;6051.0923361496125;6168.19813424252;895.543272930797;900.0909081827401;936.5364144748393;944.6504793226413;960.2366118935463;3883.980580097081;4094.140230551558;4110.835566577363;4115.5678653741525;4120.896977575525;11164.162687798447;11358.204925655291;11401;11417.37204453763;11619.36093514848;11381.829272560919;11401.543938242543;11442.370669613085;11445.198836081394;11454.59908903201;7555.206703296185;8017.0379554452675;8030.919690803017;8218.301444377175;8252.752417427488;5853.443922827325;6043.879122417439;6110.541709371726;6135.785247516315;6172.69136543162;10279.691609251735;10366;10402.219833512365;10486.213533984828;10589.205809564159;10124.088832005154;10459.895401046197;10493.632722854663;10634.41510716918;10641.627543035956;7271;7732.961335193288;7815.179406162271;7931.920680793118;8019.478733882279;8529.82940341202;8580.828383432421;8620.52587107715;8628.094050124646;8641.438306510057;7791.92208077912;8088.352931765562;8096.554689491899;8169.183081692021;8229.46508476971;7637.968874201912;7828.921710783047;7955.443118981847;7969.362451004022;8002.439829212132;6913;7066.04608377883;7129.607871566906;7144.892826607501;7147;5179.715115668674;5259.316288882421;5294.444083371191;5298.841034768963;5326.760295786621;4717.457492388419;4734.4081989751285;4819.7108173509705;4848.12733707936;4909.459959404391 00:17:48 INFO - PROCESS | 20893 | |4;prototype.html;304.25609385053536;314.8111133320008;321.8181727324062;322.8708516593363;327.56106816865395;5411.567074634029;5483.533899618537;5573.077288335523;5597.804076857311;5635.9154612680795;5425.9728701356435;5540.2243685884005;5544.556435485161;5551.9722401387935;5555.805546805863;4361.716488428257;4375;4377.08081302926;4384.758838263894;4392.428984232045;4188.685848561355;4296.398504209413;4304.203722311367;4320.783960801963;4363.127374525092;4182.916341673164;4226.45056142701;4230.471191101113;4241.406203131564;4254.723442976212;4271.572842715735;4273.871783846474;4281.165172791307;4311.590398912098;4322.2436073687295;3725.776453412804;3807.752496087773;3815.4086116651965;3824.2217368923584;3832.50177476929;5391.649542779746;5396;5403.51368376844;5414.10667239905;5455.754491047913;4943.678660887031;4952.455229924705;4962.851114466572;4966.15575352191;4981.800727970877;5570.832875013756;5743.167240750068;5783.739731712083;5796.797112101099;5845.912311315334;4186.832526698929;4188.246115699173;4189.183109293689;4191.350340697197;4221.514525829538;6066.696665166768;6087.604305720114;6091.253878864511;6107.603005804608;6114.205153330038;4164.167166566699;4224.260754367973;4235.767032813224;4323.459567554056;4343.565643435694;4336.739795612273;4346;4357.8256869724855;4364.406991448162;4371.076726240444;4939.975300123477;4944.456109827916;4945.653804233741;4947.282644016597;4952.331435256195;5487.725613719298;5757.581815637443;5832.679202643895;5842.707864606753;5858.619189752652;1440.0351764317932;1463.9707205855823;1466.2595389328321;1472.904261223017;1481.2149560732828;892.607252808775;926.6849271247808;931.2968708624945;940.9529523523796;954.8949615542285;4918.43438004634;4919.262110683426;4934.654574179773;4948.802047918115;4953.637749618883;5212.609054320941;5233.790648374023;5257.579393648499;5260.868478287997;5324.1747529133045;4580.3050874530445;4885.462599114095;4923.729194894244;4945.282933974553;4996.625253106032;2751.2434080627586;2758.7517123458983;2760.3927136030043;2774.3631257558136;2801.3696918193245;5350.431792739507;5359.812406565829;5382.650127741685;5389.730513474311;5413.458654134555;5320.600954928396;5347.572194224453;5590.636608620427;6050;6093.786717464867;6118.60229085108;6166.290876549165;6205.6586887721605;6212.347703491158;6228.626282423069;5724.398938111605;6033.75864965414;6038.279090459198;6043;6048.032314829607;5873.207117039145;5938.6436813791315;5944.821655350346;5964.731587078679;5977.1034344846885;6206.193194884636;6235.095911092775;6243.37566243372;6285.874282514415;6336.17629708135;4010.7192496524963;4103.794810259535;4172.749635021787;4222.0500387412585;4231.28068228408;6004.9282997365835;6016.969915150396;6032.54755893301;6055.757769689163;6061.333253342041;5689.715514224355;5791.206759572487;5869.295684517885;5872.970635146797;5919.4080591940465;5737.627054241461;5752.232287851464;5777;5781.94218057814;5784.161296612052;5742.397048309867;5841.561882858718;5853.721915727207;5859.355470898283;5868.471837534642;5651.265335506358;5668.995432420824;5735.254416925773;5759.9136012959;5843.474087332161;5615.550755939434;5636.267285253055;5743.167240749985;5745.741441635053;5762.711864406679 00:17:48 INFO - PROCESS | 20893 | |5;yui.html;720.3696765330336;762.9084509858818;798.7803354077627;836.1596595421596;836.8786525953733;15259.465918692847;16580.75128873068;16597.83402165978;16628.085455299955;16648.250828712706;14693.632659183526;14717.92641036796;15380;15430.537083887473;15515.68968620627;638.7381173718776;774.6010804435706;791.3510921044746;795.7294519863245;795.7771823889291;772.4592785050459;798.2456578533288;801.4790386248926;802.8314054048657;803.4978138663336;828.9917100828975;836.2181360427988;837.7821766340734;838.2037064788445;840.6091167607061;824.0893812337341;824.72371755462;825.5294482145209;830.5930094253803;831.1107115386538;615.3169981320731;616.2789536242562;616.5406771954922;618.3908849782961;619.6560908695673;15523;15570.221488925508;15638.765418518731;15643.843561564352;15657.765133523006;15371.308291126927;15412.533994560928;15606.29771660278;15720.68558628821;15837.524874253791;11652.766944661143;11786.88213117875;11935.462904169246;12077.396130193456;12122.757544849143;3750.099976005766;3853.499045124116;3891.1439483313625;3993.3011722948368;3994.6817550208652;81623.5918820408;83643.5817820907;85123;85159;86127;11905.464254108585;11964.222325548812;12116;12181.780138098646;12204.267743935392;23127.653085203736;23177.88411057934;23331.18340858062;23352.18267360634;23437.648435273484;8021.93932962057;8208.425410221347;8444.577771111542;8638.611262493203;8986.775330616787;4477.843275485342;4730;4885.828995985124;4941.234108713155;5043.747812609355;3553.289342131584;3701.444783282529;3706.184639379332;3713.090292878262;3716.089558058239;593.468845383388;606.7330374635146;626.9655168965751;628.434409031875;642.8264368620539;655.9901601475982;656.7569999100268;671.375620672779;680.9503394781644;683.6308393467572;9169.587368568431;9199.724008279762;9473.526323683789;9599.184069354043;9705.708828735149;612.8804883047762;658.720043981306;665.8235567574596;705.9788206353818;706.9399101076364;4274.508431530414;4325.365729487457;4389.934150987738;4562.794674239667;4723.220668589644;124727;126345;126859.73140268664;128513;129925;107497.46251268694;111873;112060;112145.58908081926;113296;95883.52058239804;97367;99809.50095249477;100262.99737002683;101165.49417252866;8455.661773529237;8655.17775811297;8782;8790.296776257755;8912.73261802147;54236.45763542472;54400;54681;54696;56164;72670.27329726635;79596.2040379612;79608.60195698985;79791.60104199442;83838.16161838548;11697.88302117002;11712.414379281172;11847.763044738884;12002.519899203933;12031.819522706992;12444.440000200193;12460.813087803872;12646.494140234288;12686.365681716063;13098.148620339647;12408.441620127296;12619.30593817349;12729.363531823557;12879.35603219854;13142.145760525535;12089.939550302191;12092.697682558006;12939.288339141438;13007.739845203232;13088.803667944798;11530.82703759461;11827.479323373767;11984.28094314344;12061.698457538281;12311.076669250022;10096.380870957011;10136;10287.177025837766;10329.074024199464;10592.417417042137;9591.42451452915;10499.842502362624;10534.315269507764;10538.789224215627;10741 00:17:48 INFO - PROCESS | 20893 | __end_tp_report 00:17:48 INFO - PROCESS | 20893 | __start_cc_report 00:17:48 INFO - PROCESS | 20893 | _x_x_mozilla_cycle_collect,315 00:17:48 INFO - PROCESS | 20893 | __end_cc_report 00:17:48 INFO - PROCESS | 20893 | __startTimestamp1472714268505__endTimestamp 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | ------- Summary: start ------- 00:17:48 INFO - PROCESS | 20893 | Number of tests: 6 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | [#0] dojo.html Cycles:165 Average:5467.05 Median:5690.66 stddev:624.21 (11.0%) stddev-sans-first:597.99 00:17:48 INFO - PROCESS | 20893 | Values: 3104.9 3116.5 3136.5 3152.5 3161.6 5399.9 5517.1 5546.6 5581.6 5658.1 5484.7 5492.5 5513.1 5524.4 5560.2 4906.5 4996.9 5028.6 5037.2 5045.2 4632.6 5040.8 5092.8 5097.7 5146.7 4916.4 4972.4 4975.6 4976.1 5069.4 4986.6 4998.0 5002.7 5016.9 5074.3 4873.5 4936.2 4958.4 4969.1 5031.5 5326.4 5359.1 5411.5 5414.3 5515.8 5846.2 5846.4 5866.7 5875.1 5878.4 5884.5 5892.9 5893.5 5895.4 5901.6 5346.4 5493.7 5565.4 5609.4 5611.5 6025.3 6041.7 6053.7 6069.6 6083.3 5753.7 5756.5 5784.2 5791.1 5807.4 5665.3 5678.1 5798.8 5842.4 5852.6 5721.2 5734.2 5740.1 5814.4 5815.6 5823.2 5835.0 5922.6 5927.1 5930.2 4408.5 4497.7 4514.1 4531.0 4544.0 3995.7 4005.9 4051.4 4069.6 4070.8 5570.8 5636.7 5643.6 5662.0 5676.6 5782.2 5904.6 5909.1 5914.1 5981.0 5623.7 5665.2 5667.9 5698.0 5712.4 5109.2 5159.8 5162.4 5163.9 5221.3 5984.5 5997.4 6043.8 6132.2 6148.7 5872.1 5883.2 5938.0 5998.2 6011.1 5995.7 6008.0 6057.6 6068.8 6084.8 5664.4 5763.3 5764.7 5784.7 5801.4 5904.8 5952.7 5958.1 5987.0 6026.2 5750.6 5765.7 5774.0 5778.3 5779.8 5584.4 5593.2 5690.7 5735.6 5739.4 5743.4 5743.5 5754.2 5772.5 5827.2 5754.4 5783.2 5833.1 5848.9 5850.5 5464.8 5641.9 5671.7 5672.3 5692.7 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | [#1] ext.html Cycles:180 Average:59736.07 Median:22422.57 stddev:120489.15 (537.4%) stddev-sans-first:120745.25 00:17:48 INFO - PROCESS | 20893 | Values: 566.0 587.3 588.5 595.5 613.0 40072.0 43608.3 43683.3 43729.1 43783.8 44501.3 44719.8 44750.6 45066.3 45081.8 8929.4 9092.6 9104.3 9108.8 9109.7 8982.6 9031.9 9037.3 9058.7 9067.8 9050.7 9071.7 9144.4 9171.7 9171.9 9020.5 9049.5 9058.8 9068.1 9077.7 8902.2 8935.2 8944.2 8980.4 8989.2 41275.8 41617.2 41640.2 41650.6 41784.6 3381.1 3470.9 3586.4 3860.2 4052.9 31901.2 32537.3 32899.8 33449.0 34286.1 4003.7 4060.3 4075.7 4092.4 4093.3 336566.0 337601.0 338268.0 338755.0 340878.0 56402.4 56740.0 56765.7 56774.4 56809.7 32628.0 33137.8 33184.0 33205.7 59118.7 16122.5 16210.7 16236.4 16248.8 16319.7 13236.5 13349.0 13381.8 13417.6 13440.5 18611.6 18681.5 18763.7 18958.2 19202.4 6757.8 7144.8 7246.7 7251.4 7362.6 934.5 1014.2 1050.2 1067.0 1119.4 31468.2 31908.4 32208.7 32469.7 32477.7 1048.8 1083.6 1096.8 1116.5 1138.5 15110.7 16424.4 16551.5 16887.5 16940.0 552126.0 560634.0 562534.0 563130.0 564605.5 57136.0 58025.4 58182.0 58208.0 58270.0 1299.8 1319.7 1360.7 1372.5 1376.0 28763.0 30600.0 30723.0 31089.8 31439.7 51060.0 51368.2 51444.0 51601.2 51635.2 432441.0 432546.0 434718.0 434766.0 436357.0 27290.6 27745.7 27837.7 28241.4 28338.0 44189.8 44295.8 46615.8 47895.0 48262.5 39656.2 40285.2 40334.0 41131.6 41586.0 40035.2 40426.8 40769.4 41648.2 42060.4 32638.8 39603.8 39605.0 39648.2 40831.0 32760.8 37273.6 37333.0 37758.2 37865.2 27851.9 27942.3 27976.3 28334.0 28574.0 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | [#2] jquery.html Cycles:180 Average:29149.96 Median:2521.56 stddev:81564.13 (3234.7%) stddev-sans-first:81764.34 00:17:48 INFO - PROCESS | 20893 | Values: 379.3 386.8 402.3 403.7 416.3 13786.5 18380.9 19393.1 19927.9 19945.5 19097.6 19258.0 19484.0 19550.0 19628.2 5534.6 5587.9 5750.1 5800.7 5814.6 5724.3 5825.2 5835.8 5849.0 5853.4 5629.9 5751.8 5775.1 5786.8 5794.7 5706.5 5736.1 5809.9 5810.1 5816.7 5153.9 5429.6 5456.0 5537.6 5547.1 14104.0 14306.7 18886.4 22789.0 22931.7 2375.8 2399.4 2506.6 2536.5 2856.0 9912.4 10098.3 10157.6 10605.5 10770.9 1724.6 1798.0 1800.7 1809.1 1813.4 76926.2 80643.0 81301.0 82856.0 86620.6 10917.1 11061.2 11291.8 11305.9 11438.7 15555.2 15562.7 15564.8 15588.0 15599.6 7993.9 8109.3 8280.1 8292.3 8369.1 7719.8 7749.7 7993.9 8008.0 8065.4 4669.3 4686.4 4714.3 4776.3 4811.1 1996.2 2023.5 2043.1 2062.2 2090.4 870.8 951.6 974.3 1007.2 1033.9 18329.0 18509.9 19281.2 19336.6 19344.7 954.4 989.3 990.1 1002.1 1049.0 10078.4 10171.8 10941.8 11092.0 11229.8 485544.0 486954.0 496925.0 497625.0 503532.0 91663.0 92382.5 93419.5 95276.0 96528.5 1038.0 1056.8 1075.2 1080.9 1082.2 16612.3 17031.7 18031.9 18141.0 18168.0 43240.4 44316.6 44619.0 44660.0 44937.0 58807.7 59165.4 59638.1 60739.7 61377.0 7975.0 8182.5 8314.9 8386.5 8777.0 11548.7 12648.5 13227.0 13665.7 13800.2 11358.1 11384.8 11571.8 11577.0 12033.3 11196.8 11453.4 11538.4 11845.5 11910.5 11084.1 11377.1 11575.7 11647.8 12024.5 8337.6 8393.2 8521.8 8689.3 8840.4 10523.2 11174.2 11287.9 11340.9 11347.3 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | [#3] mootools.html Cycles:180 Average:5945.43 Median:4844.24 stddev:3377.06 (69.7%) stddev-sans-first:3369.79 00:17:48 INFO - PROCESS | 20893 | Values: 1470.6 1479.9 1647.9 1774.2 1801.8 7888.3 8505.0 8688.9 9201.3 9210.2 8685.5 9061.9 9071.7 9115.0 9162.9 2465.3 2491.8 2493.0 2494.5 2500.4 2397.1 2483.4 2485.1 2485.6 2489.8 2463.7 2469.2 2513.1 2518.7 2518.9 2344.1 2394.1 2405.6 2457.3 2457.4 2437.8 2448.1 2449.4 2458.5 2460.8 9062.9 9139.6 9143.7 9180.4 9184.2 5384.2 5575.7 5575.8 5584.4 5603.2 3204.7 3392.8 3408.9 3425.8 3439.6 1110.6 1134.3 1138.9 1141.5 1166.5 12433.9 12447.4 12485.4 12510.0 12549.2 4807.6 4840.3 4910.8 4994.9 5046.7 10604.8 10618.4 10621.8 10632.6 10662.5 5416.8 5452.2 5472.7 5481.9 5489.2 4557.9 4931.6 4945.4 5032.9 5079.5 4038.7 4155.1 4218.9 4225.2 4236.6 1369.7 1375.9 1403.0 1415.1 1415.2 831.4 865.7 893.3 936.7 940.3 5982.8 5993.7 6045.0 6051.1 6168.2 895.5 900.1 936.5 944.7 960.2 3884.0 4094.1 4110.8 4115.6 4120.9 11164.2 11358.2 11401.0 11417.4 11619.4 11381.8 11401.5 11442.4 11445.2 11454.6 7555.2 8017.0 8030.9 8218.3 8252.8 5853.4 6043.9 6110.5 6135.8 6172.7 10279.7 10366.0 10402.2 10486.2 10589.2 10124.1 10459.9 10493.6 10634.4 10641.6 7271.0 7733.0 7815.2 7931.9 8019.5 8529.8 8580.8 8620.5 8628.1 8641.4 7791.9 8088.4 8096.6 8169.2 8229.5 7638.0 7828.9 7955.4 7969.4 8002.4 6913.0 7066.0 7129.6 7144.9 7147.0 5179.7 5259.3 5294.4 5298.8 5326.8 4717.5 4734.4 4819.7 4848.1 4909.5 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | [#4] prototype.html Cycles:180 Average:4799.77 Median:5390.69 stddev:1429.66 (26.5%) stddev-sans-first:1393.29 00:17:48 INFO - PROCESS | 20893 | Values: 304.3 314.8 321.8 322.9 327.6 5411.6 5483.5 5573.1 5597.8 5635.9 5426.0 5540.2 5544.6 5552.0 5555.8 4361.7 4375.0 4377.1 4384.8 4392.4 4188.7 4296.4 4304.2 4320.8 4363.1 4182.9 4226.5 4230.5 4241.4 4254.7 4271.6 4273.9 4281.2 4311.6 4322.2 3725.8 3807.8 3815.4 3824.2 3832.5 5391.6 5396.0 5403.5 5414.1 5455.8 4943.7 4952.5 4962.9 4966.2 4981.8 5570.8 5743.2 5783.7 5796.8 5845.9 4186.8 4188.2 4189.2 4191.4 4221.5 6066.7 6087.6 6091.3 6107.6 6114.2 4164.2 4224.3 4235.8 4323.5 4343.6 4336.7 4346.0 4357.8 4364.4 4371.1 4940.0 4944.5 4945.7 4947.3 4952.3 5487.7 5757.6 5832.7 5842.7 5858.6 1440.0 1464.0 1466.3 1472.9 1481.2 892.6 926.7 931.3 941.0 954.9 4918.4 4919.3 4934.7 4948.8 4953.6 5212.6 5233.8 5257.6 5260.9 5324.2 4580.3 4885.5 4923.7 4945.3 4996.6 2751.2 2758.8 2760.4 2774.4 2801.4 5350.4 5359.8 5382.7 5389.7 5413.5 5320.6 5347.6 5590.6 6050.0 6093.8 6118.6 6166.3 6205.7 6212.3 6228.6 5724.4 6033.8 6038.3 6043.0 6048.0 5873.2 5938.6 5944.8 5964.7 5977.1 6206.2 6235.1 6243.4 6285.9 6336.2 4010.7 4103.8 4172.7 4222.1 4231.3 6004.9 6017.0 6032.5 6055.8 6061.3 5689.7 5791.2 5869.3 5873.0 5919.4 5737.6 5752.2 5777.0 5781.9 5784.2 5742.4 5841.6 5853.7 5859.4 5868.5 5651.3 5669.0 5735.3 5759.9 5843.5 5615.6 5636.3 5743.2 5745.7 5762.7 00:17:48 INFO - PROCESS | 20893 | 00:17:48 INFO - PROCESS | 20893 | [#5] yui.html Cycles:180 Average:22176.59 Median:4134.60 stddev:33505.47 (810.4%) stddev-sans-first:33560.73 00:17:48 INFO - PROCESS | 20893 | Values: 720.4 762.9 798.8 836.2 836.9 15259.5 16580.8 16597.8 16628.1 16648.3 14693.6 14717.9 15380.0 15430.5 15515.7 638.7 774.6 791.4 795.7 795.8 772.5 798.2 801.5 802.8 803.5 829.0 836.2 837.8 838.2 840.6 824.1 824.7 825.5 830.6 831.1 615.3 616.3 616.5 618.4 619.7 15523.0 15570.2 15638.8 15643.8 15657.8 15371.3 15412.5 15606.3 15720.7 15837.5 11652.8 11786.9 11935.5 12077.4 12122.8 3750.1 3853.5 3891.1 3993.3 3994.7 81623.6 83643.6 85123.0 85159.0 86127.0 11905.5 11964.2 12116.0 12181.8 12204.3 23127.7 23177.9 23331.2 23352.2 23437.6 8021.9 8208.4 8444.6 8638.6 8986.8 4477.8 4730.0 4885.8 4941.2 5043.7 3553.3 3701.4 3706.2 3713.1 3716.1 593.5 606.7 627.0 628.4 642.8 656.0 656.8 671.4 681.0 683.6 9169.6 9199.7 9473.5 9599.2 9705.7 612.9 658.7 665.8 706.0 706.9 4274.5 4325.4 4389.9 4562.8 4723.2 124727.0 126345.0 126859.7 128513.0 129925.0 107497.5 111873.0 112060.0 112145.6 113296.0 95883.5 97367.0 99809.5 100263.0 101165.5 8455.7 8655.2 8782.0 8790.3 8912.7 54236.5 54400.0 54681.0 54696.0 56164.0 72670.3 79596.2 79608.6 79791.6 83838.2 11697.9 11712.4 11847.8 12002.5 12031.8 12444.4 12460.8 12646.5 12686.4 13098.1 12408.4 12619.3 12729.4 12879.4 13142.1 12089.9 12092.7 12939.3 13007.7 13088.8 11530.8 11827.5 11984.3 12061.7 12311.1 10096.4 10136.0 10287.2 10329.1 10592.4 9591.4 10499.8 10534.3 10538.8 10741.0 00:17:48 INFO - PROCESS | 20893 | -------- Summary: end -------- 00:17:48 INFO - PROCESS | 20893 | 00:17:49 INFO - TEST-INFO | 20893: exit 0 00:17:49 INFO - TEST-OK | dromaeo_css | took 1114760ms 00:17:49 INFO - TEST-START | kraken 00:17:49 INFO - operating with platform_type : linux_ 00:17:49 INFO - Initialising browser for kraken test... 00:17:49 INFO - TEST-INFO | started process 21247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwYWRh/profile http://localhost:34385/getInfo.html) 00:17:54 INFO - PROCESS | 21247 | __metrics Screen width/height:1600/1200 00:17:54 INFO - PROCESS | 21247 | colorDepth:24 00:17:54 INFO - PROCESS | 21247 | Browser inner width/height: 1024/697 00:17:54 INFO - PROCESS | 21247 | __metrics 00:17:54 ERROR - PROCESS | 21247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 00:17:55 INFO - TEST-INFO | 21247: exit 0 00:17:55 INFO - Browser initialized. 00:17:55 INFO - Running cycle 1/1 for kraken test... 00:17:55 INFO - TEST-INFO | started process 21367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwYWRh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:18:07 INFO - PROCESS | 21367 | RSS: Main: 191827968 00:18:07 INFO - PROCESS | 21367 | 00:18:10 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34385/tests/kraken/driver.html?testName=audio-beat-detection) 00:18:11 INFO - PROCESS | 21367 | RSS: Main: 204898304 00:18:11 INFO - PROCESS | 21367 | 00:18:14 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34385/tests/kraken/driver.html?testName=audio-dft) 00:18:14 INFO - PROCESS | 21367 | RSS: Main: 204136448 00:18:14 INFO - PROCESS | 21367 | 00:18:17 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34385/tests/kraken/driver.html?testName=audio-fft) 00:18:18 INFO - PROCESS | 21367 | RSS: Main: 195600384 00:18:18 INFO - PROCESS | 21367 | 00:18:20 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34385/tests/kraken/driver.html?testName=audio-oscillator) 00:18:20 INFO - PROCESS | 21367 | RSS: Main: 196419584 00:18:20 INFO - PROCESS | 21367 | 00:18:23 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:18:23 INFO - PROCESS | 21367 | RSS: Main: 196931584 00:18:23 INFO - PROCESS | 21367 | 00:18:26 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34385/tests/kraken/driver.html?testName=imaging-darkroom) 00:18:27 INFO - PROCESS | 21367 | RSS: Main: 197562368 00:18:27 INFO - PROCESS | 21367 | 00:18:30 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34385/tests/kraken/driver.html?testName=imaging-desaturate) 00:18:31 INFO - PROCESS | 21367 | RSS: Main: 194453504 00:18:31 INFO - PROCESS | 21367 | 00:18:34 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34385/tests/kraken/driver.html?testName=json-parse-financial) 00:18:35 INFO - PROCESS | 21367 | RSS: Main: 196694016 00:18:35 INFO - PROCESS | 21367 | 00:18:36 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:18:37 INFO - PROCESS | 21367 | RSS: Main: 197111808 00:18:37 INFO - PROCESS | 21367 | 00:18:39 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:18:39 INFO - PROCESS | 21367 | RSS: Main: 197144576 00:18:39 INFO - PROCESS | 21367 | 00:18:41 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:18:42 INFO - PROCESS | 21367 | RSS: Main: 197615616 00:18:42 INFO - PROCESS | 21367 | 00:18:45 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:18:45 INFO - PROCESS | 21367 | RSS: Main: 197619712 00:18:45 INFO - PROCESS | 21367 | 00:18:48 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:18:49 INFO - PROCESS | 21367 | RSS: Main: 197672960 00:18:49 INFO - PROCESS | 21367 | 00:18:50 INFO - PROCESS | 21367 | Cycle 1(1): loaded http://localhost:34385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34385/tests/kraken/driver.html?testName=ai-astar) 00:18:51 INFO - PROCESS | 21367 | RSS: Main: 199655424 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | __start_tp_report 00:18:51 INFO - PROCESS | 21367 | _x_x_mozilla_page_load 00:18:51 INFO - PROCESS | 21367 | _x_x_mozilla_page_load_details 00:18:51 INFO - PROCESS | 21367 | |i|pagename|runs| 00:18:51 INFO - PROCESS | 21367 | |0;ai-astar;109;115;113;112;114;111;112;113;112;129 00:18:51 INFO - PROCESS | 21367 | |1;audio-beat-detection;154;122;151;185;122;146;150;122;185;120 00:18:51 INFO - PROCESS | 21367 | |2;audio-dft;163;164;166;174;163;163;165;165;164;162 00:18:51 INFO - PROCESS | 21367 | |3;audio-fft;76;78;75;178;79;77;75;76;165;77 00:18:51 INFO - PROCESS | 21367 | |4;audio-oscillator;83;82;141;82;82;87;139;83;82;136 00:18:51 INFO - PROCESS | 21367 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;117;117;117 00:18:51 INFO - PROCESS | 21367 | |6;imaging-darkroom;147;147;147;147;147;147;146;148;147;148 00:18:51 INFO - PROCESS | 21367 | |7;imaging-desaturate;98;95;96;96;95;96;95;95;96;96 00:18:51 INFO - PROCESS | 21367 | |8;json-parse-financial;55;55;55;55;56;54;57;54;54;54 00:18:51 INFO - PROCESS | 21367 | |9;json-stringify-tinderbox;63;63;63;63;63;66;63;61;63;63 00:18:51 INFO - PROCESS | 21367 | |10;stanford-crypto-aes;81;80;81;80;80;80;80;79;83;79 00:18:51 INFO - PROCESS | 21367 | |11;stanford-crypto-ccm;135;126;136;135;128;136;134;126;166;127 00:18:51 INFO - PROCESS | 21367 | |12;stanford-crypto-pbkdf2;161;167;166;167;165;165;162;165;163;166 00:18:51 INFO - PROCESS | 21367 | |13;stanford-crypto-sha256-iterative;71;67;65;66;64;66;65;64;65;65 00:18:51 INFO - PROCESS | 21367 | __end_tp_report 00:18:51 INFO - PROCESS | 21367 | __start_cc_report 00:18:51 INFO - PROCESS | 21367 | _x_x_mozilla_cycle_collect,841 00:18:51 INFO - PROCESS | 21367 | __end_cc_report 00:18:51 INFO - PROCESS | 21367 | __startTimestamp1472714331210__endTimestamp 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | ------- Summary: start ------- 00:18:51 INFO - PROCESS | 21367 | Number of tests: 14 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:5.52 (4.9%) stddev-sans-first:5.55 00:18:51 INFO - PROCESS | 21367 | Values: 109.0 115.0 113.0 112.0 114.0 111.0 112.0 113.0 112.0 129.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:150.50 stddev:24.83 (16.5%) stddev-sans-first:26.16 00:18:51 INFO - PROCESS | 21367 | Values: 154.0 122.0 151.0 185.0 122.0 146.0 150.0 122.0 185.0 120.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.41 (2.1%) stddev-sans-first:3.55 00:18:51 INFO - PROCESS | 21367 | Values: 163.0 164.0 166.0 174.0 163.0 163.0 165.0 165.0 164.0 162.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:40.14 (52.5%) stddev-sans-first:41.94 00:18:51 INFO - PROCESS | 21367 | Values: 76.0 78.0 75.0 178.0 79.0 77.0 75.0 76.0 165.0 77.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#4] audio-oscillator Cycles:10 Average:99.70 Median:82.00 stddev:26.96 (32.9%) stddev-sans-first:27.91 00:18:51 INFO - PROCESS | 21367 | Values: 83.0 82.0 141.0 82.0 82.0 87.0 139.0 83.0 82.0 136.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 00:18:51 INFO - PROCESS | 21367 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 00:18:51 INFO - PROCESS | 21367 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 148.0 147.0 148.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.53 00:18:51 INFO - PROCESS | 21367 | Values: 98.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 00:18:51 INFO - PROCESS | 21367 | Values: 55.0 55.0 55.0 55.0 56.0 54.0 57.0 54.0 54.0 54.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 00:18:51 INFO - PROCESS | 21367 | Values: 63.0 63.0 63.0 63.0 63.0 66.0 63.0 61.0 63.0 63.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.16 (1.4%) stddev-sans-first:1.20 00:18:51 INFO - PROCESS | 21367 | Values: 81.0 80.0 81.0 80.0 80.0 80.0 80.0 79.0 83.0 79.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:135.00 stddev:11.73 (8.7%) stddev-sans-first:12.44 00:18:51 INFO - PROCESS | 21367 | Values: 135.0 126.0 136.0 135.0 128.0 136.0 134.0 126.0 166.0 127.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:2.06 (1.2%) stddev-sans-first:1.69 00:18:51 INFO - PROCESS | 21367 | Values: 161.0 167.0 166.0 167.0 165.0 165.0 162.0 165.0 163.0 166.0 00:18:51 INFO - PROCESS | 21367 | 00:18:51 INFO - PROCESS | 21367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:2.04 (3.1%) stddev-sans-first:0.97 00:18:51 INFO - PROCESS | 21367 | Values: 71.0 67.0 65.0 66.0 64.0 66.0 65.0 64.0 65.0 65.0 00:18:51 INFO - PROCESS | 21367 | -------- Summary: end -------- 00:18:51 INFO - PROCESS | 21367 | 00:18:52 INFO - TEST-INFO | 21367: exit 0 00:18:52 INFO - TEST-OK | kraken | took 62815ms 00:18:52 INFO - SUITE-END | took 1177s 00:18:52 INFO - Completed test suite (00:19:37) 00:18:52 INFO - javascript benchmark 00:18:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7316.926729083684, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.8913288034914, 3116.53252012198, 3136.5452009458627, 3152.4956007038872, 3161.588993430855, 5399.892002159954, 5517.089680202766, 5546.611737178399, 5581.553475721943, 5658.1229909364065, 5484.725763711808, 5492.450754924505, 5513.145462453306, 5524.364698059714, 5560.221568980346, 4906.509349065101, 4996.900061998758, 5028.572571331423, 5037.168867136918, 5045.217991211368, 4632.606228470567, 5040.848774536751, 5092.770825312869, 5097.6941383517105, 5146.716930568818, 4916.43461001984, 4972.428170760372, 4975.577075948549, 4976.104301225778, 5069.366329208849, 4986.5761410280165, 4998.0, 5002.6748261363255, 5016.871203979112, 5074.340335756328, 4873.463918968911, 4936.234883593049, 4958.380202474691, 4969.130402179604, 5031.471695471996, 5326.36083669962, 5359.115745901921, 5411.485908838654, 5414.269073675043, 5515.779368825242, 5846.210761547221, 5846.3861294563885, 5866.735996880108, 5875.059990401558, 5878.382769809194, 5884.529237660977, 5892.941070589325, 5893.499052580536, 5895.439933206381, 5901.557383196235, 5346.358436987547, 5493.697846618435, 5565.415631358689, 5609.411011843697, 5611.466910643482, 6025.307089684742, 6041.72812223451, 6053.697315134314, 6069.635821850615, 6083.300420451616, 5753.683547404933, 5756.539476841843, 5784.248047753765, 5791.102379131242, 5807.419258074243, 5665.291838520185, 5678.119891416837, 5798.797042103591, 5842.386549412336, 5852.561057920673, 5721.199032135504, 5734.197212390269, 5740.081586946152, 5814.418558144236, 5815.5929084963645, 5823.213866128103, 5834.970825145847, 5922.585419020714, 5927.081302398135, 5930.169776231331, 4408.470983482002, 4497.662675299365, 4514.074614703978, 4530.977345113253, 4543.977280113579, 3995.7402768819934, 4005.938426317028, 4051.4125451809323, 4069.613386728256, 4070.816813243411, 5570.777168913279, 5636.746346414421, 5643.5767317451355, 5661.971690141605, 5676.631018983753, 5782.161586569924, 5904.586678932519, 5909.113632955091, 5914.112883067574, 5980.953333166678, 5623.690697011703, 5665.1502274658305, 5667.886642267132, 5698.0, 5712.400197979152, 5109.156989096758, 5159.7678104485385, 5162.432132465426, 5163.915577728644, 5221.347331583552, 5984.521238300926, 5997.370276121119, 6043.848903777265, 6132.202813634199, 6148.723307451175, 5872.148538461985, 5883.2057672213705, 5937.970310148422, 5998.190244317136, 6011.068284415923, 5995.700214989321, 6008.008678567988, 6057.606255593372, 6068.757249709962, 6084.787032453843, 5664.376918538875, 5763.337216220189, 5764.711764411846, 5784.739686714024, 5801.390853960443, 5904.789518148683, 5952.672603006876, 5958.1360702697, 5986.970065149646, 6026.186464827192, 5750.568707346882, 5765.711714414347, 5773.971130144322, 5778.27771528559, 5779.826605201851, 5584.357798853184, 5593.161025846156, 5690.658560486384, 5735.598508104559, 5739.368669446441, 5743.4256574342235, 5743.511801496919, 5754.19441278213, 5772.538196944319, 5827.155062515827, 5754.367019627922, 5783.16144159103, 5833.125031245348, 5848.941510584839, 5850.5027072699295, 5464.8360549182, 5641.887162256649, 5671.6597004179885, 5672.262605861211, 5692.743826527733], "value": 5424.379689921244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9660420374778, 587.2805812879224, 588.5468189494089, 595.5325069820191, 612.9785457508982, 40072.0, 43608.34587481182, 43683.344749828735, 43729.12541749163, 43783.78108109463, 44501.332480012825, 44719.77640111803, 44750.55249447504, 45066.32400513995, 45081.77459112708, 8929.41958772681, 9092.590833412512, 9104.31717621181, 9108.817823643523, 9109.726708198732, 8982.59578318974, 9031.864522032174, 9037.27701783859, 9058.728238152866, 9067.818643627124, 9050.728478145666, 9071.727848164566, 9144.405613635092, 9171.678991235309, 9171.862422063674, 9020.54897255138, 9049.457032578033, 9058.773530661787, 9068.138526839939, 9077.727668169966, 8902.154295341932, 8935.240504557121, 8944.195022448012, 8980.371374003822, 8989.190972812477, 41275.793621032004, 41617.167656647, 41640.1671966562, 41650.583494164974, 41784.58215417837, 3381.1378098584705, 3470.895873123785, 3586.3544561978833, 3860.2279544091293, 4052.9392059119136, 31901.202469938205, 32537.349253015043, 32899.835500822344, 33449.0, 34286.14284642879, 4003.6596889264156, 4060.309747342959, 4075.7490947458023, 4092.4066010428323, 4093.263212621727, 336566.0, 337601.0, 338267.99999999756, 338755.0, 340878.0, 56402.43597563972, 56740.0, 56765.71617141888, 56774.43225567774, 56809.7159514208, 32628.0, 33137.83431082829, 33184.0, 33205.66794332026, 59118.70440647769, 16122.516324510283, 16210.675786484204, 16236.431724889808, 16248.837511624732, 16319.673606527804, 13236.470541178438, 13349.0, 13381.799273010913, 13417.597472075853, 13440.529581464602, 18611.627767444847, 18681.53296167607, 18763.718544221847, 18958.241670333307, 19202.423927282205, 6757.797266082025, 7144.821379465555, 7246.673899674527, 7251.383632391306, 7362.595057271901, 934.5467448287575, 1014.1582486536157, 1050.2438244463974, 1067.0183431243274, 1119.4458742922307, 31468.21329466736, 31908.361832763214, 32208.677913220567, 32469.675303246666, 32477.675223247938, 1048.826943554305, 1083.5828206140534, 1096.8464414981909, 1116.5198964445367, 1138.4933704501582, 15110.697786044218, 16424.425145119865, 16551.510364067293, 16887.49337519852, 16940.0, 552126.0, 560634.0, 562534.0, 563130.0, 564605.5309170366, 57136.0, 58025.41974580284, 58182.0, 58208.0, 58270.0, 1299.7985312276612, 1319.6832760137497, 1360.7210521842999, 1372.4647387518876, 1375.9793603095761, 28763.0, 30600.0, 30723.0, 31089.82371233992, 31439.68560314459, 51060.0, 51368.22947655863, 51444.0, 51601.22598161106, 51635.2254716172, 432441.0, 432546.0, 434718.0, 434766.0, 436357.0, 27290.590641140796, 27745.722542774314, 27837.721622783512, 28241.43517129605, 28338.0, 44189.77905110454, 44295.77852110719, 46615.766921165174, 47895.0, 48262.51737482721, 39656.206875862896, 40285.194296113325, 40334.0, 41131.58868411277, 41585.96035099147, 40035.199296013336, 40426.79786601048, 40769.388459172544, 41648.16703665849, 42060.36909446299, 32638.83680581582, 39603.80198098991, 39605.0, 39648.2070358597, 40831.0, 32760.836195819822, 37273.6272637281, 37333.0, 37758.244835103695, 37865.242695146495, 27851.860740696167, 27942.32346059243, 27976.30059248535, 28334.0, 28574.0], "value": 19779.344652707605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3304816998001, 386.8336615255439, 402.34217055114885, 403.6669747458347, 416.3297091682393, 13786.517471888486, 18380.90809545952, 19393.12730927108, 19927.900360498195, 19945.501362465944, 19097.618047639073, 19258.0, 19484.0, 19550.0, 19628.214871405125, 5534.640248383862, 5587.916181257285, 5750.137479378106, 5800.651960882361, 5814.622049566765, 5724.284464441945, 5825.213596164527, 5835.824925252249, 5848.970755146218, 5853.443922827346, 5629.943700563003, 5751.827445176651, 5775.10485874688, 5786.82639520813, 5794.6812925289305, 5706.4864162225185, 5736.11090281005, 5809.854753631151, 5810.128480727883, 5816.680082595455, 5153.922691159635, 5429.56563474925, 5455.972720136374, 5537.640053396557, 5547.0570003099165, 14104.0, 14306.713865722731, 18886.43340699781, 22789.0, 22931.656025159635, 2375.845570037942, 2399.448126930798, 2506.636537702023, 2536.4927014597156, 2855.9718501339503, 9912.35569687968, 10098.343607665553, 10157.644482443078, 10605.522751476203, 10770.922907709166, 1724.5860993361628, 1797.9640407191782, 1800.7478952946467, 1809.095452273863, 1813.3562585282166, 76926.23073769303, 80643.0, 81300.9999999994, 82856.0, 86620.56689716574, 10917.126629869592, 11061.225714200089, 11291.830622540669, 11305.886941130484, 11438.656840294638, 15555.22223888801, 15562.688746225012, 15564.844351556567, 15588.0, 15599.610009749847, 7993.880091798627, 8109.270165685117, 8280.089190189074, 8292.295154911779, 8369.079401265855, 7719.768406947801, 7749.651265693057, 7993.9200607994335, 8008.0, 8065.39509536787, 4669.276262179367, 4686.36734040907, 4714.316424118484, 4776.283557466408, 4811.109944660179, 1996.2015193922548, 2023.5244717491378, 2043.1418804102314, 2062.236972320251, 2090.404234793107, 870.825834833036, 951.6145960885714, 974.28390133252, 1007.2495990486988, 1033.9069483746498, 18329.0, 18509.907450462662, 19281.22875084981, 19336.616092184093, 19344.70982935257, 954.4321128928276, 989.2728844299434, 990.1336330710628, 1002.0530598584268, 1048.9929667519114, 10078.395296282246, 10171.830239522402, 10941.781164376667, 11092.0, 11229.775404491864, 485544.0, 486954.0, 496925.0, 497625.0, 503532.0, 91663.0, 92382.53808730913, 93419.53290233505, 95276.0, 96528.51735741417, 1037.984430233547, 1056.7569459024467, 1075.166745772033, 1080.8919108089128, 1082.182951871332, 16612.2524486396, 17031.65936681284, 18031.909840451237, 18141.0, 18168.000759957802, 43240.35139472973, 44316.55683443253, 44619.0, 44660.0, 44937.0, 58807.70596146992, 59165.40834591599, 59638.10542841774, 60739.69630151821, 61377.0, 7975.0, 8182.509049457051, 8314.916850831414, 8386.538740369338, 8776.956115219384, 11548.653540393801, 12648.494060237488, 13227.011264680219, 13665.726685466434, 13800.171989680652, 11358.148138889781, 11384.772304554028, 11571.826422603835, 11577.0, 12033.338166400932, 11196.776064478829, 11453.427328633701, 11538.423078846192, 11845.526178952745, 11910.52357905674, 11084.113270938467, 11377.146713996317, 11575.652730418102, 11647.767044658889, 12024.458899349374, 8337.624806883583, 8393.24460798531, 8521.786955325919, 8689.348298877736, 8840.381173317806, 10523.210759192938, 11174.161937854531, 11287.887121128684, 11340.94329528347, 11347.262427942487], "value": 9189.08602407093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.62499062739, 1479.9186044767537, 1647.8681705463557, 1774.175008620991, 1801.8018018018008, 7888.329491993173, 8505.0, 8688.913110868889, 9201.26389888809, 9210.171084602385, 8685.522296273703, 9061.864072038908, 9071.682491112811, 9115.0, 9162.862557061633, 2465.2604218734355, 2491.8006559475198, 2492.950140997179, 2494.463690306584, 2500.4124030852736, 2397.1250493569896, 2483.4412257242157, 2485.1177831869695, 2485.6023036314195, 2489.7634724701124, 2463.6674049003423, 2469.172827102923, 2513.1455305196228, 2518.697756269241, 2518.937026574341, 2344.097522453859, 2394.1381102802975, 2405.56699794037, 2457.299669594157, 2457.3733697907096, 2437.8049756019477, 2448.1309135256906, 2449.3754092706245, 2458.459138989437, 2460.803135749136, 9062.864057039149, 9139.634414623408, 9143.725688229364, 9180.357374983754, 9184.173424391836, 5384.219288203228, 5575.749091290902, 5575.832725018256, 5584.441555844423, 5603.159526071081, 3204.6635103314047, 3392.7794693344854, 3408.9147771305666, 3425.760196786226, 3439.5872495300723, 1110.5779803674632, 1134.33641319828, 1138.9088872890231, 1141.4749215360944, 1166.4692564882957, 12433.93783031079, 12447.3776311185, 12485.375731213402, 12509.999999999909, 12549.184303020274, 4807.567318941242, 4840.346553215341, 4910.754462276872, 4994.900101998012, 5046.722430266297, 10604.787904241872, 10618.36289822613, 10621.84067238992, 10632.574697012187, 10662.466876656135, 5416.756245968941, 5452.182172674051, 5472.72636368188, 5481.862953426116, 5489.204065410493, 4557.92888671162, 4931.630127740434, 4945.381827271591, 5032.899342013213, 5079.466656001141, 4038.715696182818, 4155.10665206982, 4218.915621687549, 4225.19721252961, 4236.639885609696, 1369.6781256404936, 1375.8761711445818, 1403.0, 1415.101410604253, 1415.1579810013027, 831.3930830493773, 865.7359505350928, 893.2585953658578, 936.6721647423348, 940.2571968145089, 5982.760689572456, 5993.730282137314, 6044.972354699712, 6051.0923361496125, 6168.19813424252, 895.543272930797, 900.0909081827401, 936.5364144748393, 944.6504793226413, 960.2366118935463, 3883.980580097081, 4094.140230551558, 4110.835566577363, 4115.5678653741525, 4120.896977575525, 11164.162687798447, 11358.204925655291, 11401.0, 11417.37204453763, 11619.36093514848, 11381.829272560919, 11401.543938242543, 11442.370669613085, 11445.198836081394, 11454.59908903201, 7555.206703296185, 8017.0379554452675, 8030.919690803017, 8218.301444377175, 8252.752417427488, 5853.443922827325, 6043.879122417439, 6110.541709371726, 6135.785247516315, 6172.69136543162, 10279.691609251735, 10366.0, 10402.219833512365, 10486.213533984828, 10589.205809564159, 10124.088832005154, 10459.895401046197, 10493.632722854663, 10634.41510716918, 10641.627543035956, 7271.0, 7732.961335193288, 7815.179406162271, 7931.920680793118, 8019.478733882279, 8529.82940341202, 8580.828383432421, 8620.52587107715, 8628.094050124646, 8641.438306510057, 7791.92208077912, 8088.352931765562, 8096.554689491899, 8169.183081692021, 8229.46508476971, 7637.968874201912, 7828.921710783047, 7955.443118981847, 7969.362451004022, 8002.439829212132, 6913.0, 7066.04608377883, 7129.607871566906, 7144.892826607501, 7147.0, 5179.715115668674, 5259.316288882421, 5294.444083371191, 5298.841034768963, 5326.760295786621, 4717.457492388419, 4734.4081989751285, 4819.7108173509705, 4848.12733707936, 4909.459959404391], "value": 4760.169926789852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.25609385053536, 314.8111133320008, 321.8181727324062, 322.8708516593363, 327.56106816865395, 5411.567074634029, 5483.533899618537, 5573.077288335523, 5597.804076857311, 5635.9154612680795, 5425.9728701356435, 5540.2243685884005, 5544.556435485161, 5551.9722401387935, 5555.805546805863, 4361.716488428257, 4375.0, 4377.08081302926, 4384.758838263894, 4392.428984232045, 4188.685848561355, 4296.398504209413, 4304.203722311367, 4320.783960801963, 4363.127374525092, 4182.916341673164, 4226.45056142701, 4230.471191101113, 4241.406203131564, 4254.723442976212, 4271.572842715735, 4273.871783846474, 4281.165172791307, 4311.590398912098, 4322.2436073687295, 3725.776453412804, 3807.752496087773, 3815.4086116651965, 3824.2217368923584, 3832.50177476929, 5391.649542779746, 5396.0, 5403.51368376844, 5414.10667239905, 5455.754491047913, 4943.678660887031, 4952.455229924705, 4962.851114466572, 4966.15575352191, 4981.800727970877, 5570.832875013756, 5743.167240750068, 5783.739731712083, 5796.797112101099, 5845.912311315334, 4186.832526698929, 4188.246115699173, 4189.183109293689, 4191.350340697197, 4221.514525829538, 6066.696665166768, 6087.604305720114, 6091.253878864511, 6107.603005804608, 6114.205153330038, 4164.167166566699, 4224.260754367973, 4235.767032813224, 4323.459567554056, 4343.565643435694, 4336.739795612273, 4346.0, 4357.8256869724855, 4364.406991448162, 4371.076726240444, 4939.975300123477, 4944.456109827916, 4945.653804233741, 4947.282644016597, 4952.331435256195, 5487.725613719298, 5757.581815637443, 5832.679202643895, 5842.707864606753, 5858.619189752652, 1440.0351764317932, 1463.9707205855823, 1466.2595389328321, 1472.904261223017, 1481.2149560732828, 892.607252808775, 926.6849271247808, 931.2968708624945, 940.9529523523796, 954.8949615542285, 4918.43438004634, 4919.262110683426, 4934.654574179773, 4948.802047918115, 4953.637749618883, 5212.609054320941, 5233.790648374023, 5257.579393648499, 5260.868478287997, 5324.1747529133045, 4580.3050874530445, 4885.462599114095, 4923.729194894244, 4945.282933974553, 4996.625253106032, 2751.2434080627586, 2758.7517123458983, 2760.3927136030043, 2774.3631257558136, 2801.3696918193245, 5350.431792739507, 5359.812406565829, 5382.650127741685, 5389.730513474311, 5413.458654134555, 5320.600954928396, 5347.572194224453, 5590.636608620427, 6050.0, 6093.786717464867, 6118.60229085108, 6166.290876549165, 6205.6586887721605, 6212.347703491158, 6228.626282423069, 5724.398938111605, 6033.75864965414, 6038.279090459198, 6043.0, 6048.032314829607, 5873.207117039145, 5938.6436813791315, 5944.821655350346, 5964.731587078679, 5977.1034344846885, 6206.193194884636, 6235.095911092775, 6243.37566243372, 6285.874282514415, 6336.17629708135, 4010.7192496524963, 4103.794810259535, 4172.749635021787, 4222.0500387412585, 4231.28068228408, 6004.9282997365835, 6016.969915150396, 6032.54755893301, 6055.757769689163, 6061.333253342041, 5689.715514224355, 5791.206759572487, 5869.295684517885, 5872.970635146797, 5919.4080591940465, 5737.627054241461, 5752.232287851464, 5777.0, 5781.94218057814, 5784.161296612052, 5742.397048309867, 5841.561882858718, 5853.721915727207, 5859.355470898283, 5868.471837534642, 5651.265335506358, 5668.995432420824, 5735.254416925773, 5759.9136012959, 5843.474087332161, 5615.550755939434, 5636.267285253055, 5743.167240749985, 5745.741441635053, 5762.711864406679], "value": 4333.916444677362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.3696765330336, 762.9084509858818, 798.7803354077627, 836.1596595421596, 836.8786525953733, 15259.465918692847, 16580.75128873068, 16597.83402165978, 16628.085455299955, 16648.250828712706, 14693.632659183526, 14717.92641036796, 15380.0, 15430.537083887473, 15515.68968620627, 638.7381173718776, 774.6010804435706, 791.3510921044746, 795.7294519863245, 795.7771823889291, 772.4592785050459, 798.2456578533288, 801.4790386248926, 802.8314054048657, 803.4978138663336, 828.9917100828975, 836.2181360427988, 837.7821766340734, 838.2037064788445, 840.6091167607061, 824.0893812337341, 824.72371755462, 825.5294482145209, 830.5930094253803, 831.1107115386538, 615.3169981320731, 616.2789536242562, 616.5406771954922, 618.3908849782961, 619.6560908695673, 15523.0, 15570.221488925508, 15638.765418518731, 15643.843561564352, 15657.765133523006, 15371.308291126927, 15412.533994560928, 15606.29771660278, 15720.68558628821, 15837.524874253791, 11652.766944661143, 11786.88213117875, 11935.462904169246, 12077.396130193456, 12122.757544849143, 3750.099976005766, 3853.499045124116, 3891.1439483313625, 3993.3011722948368, 3994.6817550208652, 81623.5918820408, 83643.5817820907, 85123.0, 85159.0, 86127.0, 11905.464254108585, 11964.222325548812, 12116.0, 12181.780138098646, 12204.267743935392, 23127.653085203736, 23177.88411057934, 23331.18340858062, 23352.18267360634, 23437.648435273484, 8021.93932962057, 8208.425410221347, 8444.577771111542, 8638.611262493203, 8986.775330616787, 4477.843275485342, 4730.0, 4885.828995985124, 4941.234108713155, 5043.747812609355, 3553.289342131584, 3701.444783282529, 3706.184639379332, 3713.090292878262, 3716.089558058239, 593.468845383388, 606.7330374635146, 626.9655168965751, 628.434409031875, 642.8264368620539, 655.9901601475982, 656.7569999100268, 671.375620672779, 680.9503394781644, 683.6308393467572, 9169.587368568431, 9199.724008279762, 9473.526323683789, 9599.184069354043, 9705.708828735149, 612.8804883047762, 658.720043981306, 665.8235567574596, 705.9788206353818, 706.9399101076364, 4274.508431530414, 4325.365729487457, 4389.934150987738, 4562.794674239667, 4723.220668589644, 124727.0, 126345.0, 126859.73140268664, 128513.0, 129925.0, 107497.46251268694, 111873.0, 112060.0, 112145.58908081926, 113296.0, 95883.52058239804, 97367.0, 99809.50095249477, 100262.99737002683, 101165.49417252866, 8455.661773529237, 8655.17775811297, 8782.0, 8790.296776257755, 8912.73261802147, 54236.45763542472, 54400.0, 54681.0, 54696.0, 56164.0, 72670.27329726635, 79596.2040379612, 79608.60195698985, 79791.60104199442, 83838.16161838548, 11697.88302117002, 11712.414379281172, 11847.763044738884, 12002.519899203933, 12031.819522706992, 12444.440000200193, 12460.813087803872, 12646.494140234288, 12686.365681716063, 13098.148620339647, 12408.441620127296, 12619.30593817349, 12729.363531823557, 12879.35603219854, 13142.145760525535, 12089.939550302191, 12092.697682558006, 12939.288339141438, 13007.739845203232, 13088.803667944798, 11530.82703759461, 11827.479323373767, 11984.28094314344, 12061.698457538281, 12311.076669250022, 10096.380870957011, 10136.0, 10287.177025837766, 10329.074024199464, 10592.417417042137, 9591.42451452915, 10499.842502362624, 10534.315269507764, 10538.789224215627, 10741.0], "value": 7543.845652646539, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 113.0, 112.0, 114.0, 111.0, 112.0, 113.0, 112.0, 129.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 151.0, 185.0, 122.0, 146.0, 150.0, 122.0, 185.0, 120.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 174.0, 163.0, 163.0, 165.0, 165.0, 164.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 178.0, 79.0, 77.0, 75.0, 76.0, 165.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 141.0, 82.0, 82.0, 87.0, 139.0, 83.0, 82.0, 136.0], "value": 99.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 54.0, 57.0, 54.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 66.0, 63.0, 61.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 80.0, 80.0, 80.0, 80.0, 79.0, 83.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 136.0, 135.0, 128.0, 136.0, 134.0, 126.0, 166.0, 127.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 167.0, 166.0, 167.0, 165.0, 165.0, 162.0, 165.0, 163.0, 166.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 65.0, 66.0, 64.0, 66.0, 65.0, 64.0, 65.0, 65.0], "value": 65.8, "unit": "score"}]}]} 00:18:52 INFO - Return code: 0 00:18:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:18:52 ERROR - # TBPL SUCCESS # 00:18:52 INFO - Running post-action listener: _resource_record_post_action 00:18:52 INFO - [mozharness: 2016-09-01 07:18:52.523680Z] Finished run-tests step (success) 00:18:52 INFO - Running post-run listener: _resource_record_post_run 00:18:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 407986176; Read time: 0; Write time: 266740 00:18:52 INFO - TinderboxPrint: CPU usage
13.4% 00:18:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:18:52 INFO - TinderboxPrint: I/O write bytes / time
407,986,176 / 266,740 00:18:52 INFO - TinderboxPrint: CPU idle
8,250.5 (86.6%) 00:18:52 INFO - TinderboxPrint: CPU user
1,217.0 (12.8%) 00:18:52 INFO - TinderboxPrint: Swap in / out
0 / 0 00:18:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118169600; Read time: 0; Write time: 92056 00:18:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289816576; Read time: 0; Write time: 174684 00:18:53 INFO - Running post-run listener: _upload_blobber_files 00:18:53 INFO - Blob upload gear active. 00:18:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:18:53 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 00:18:53 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:18:53 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:18:53 INFO - (blobuploader) - INFO - Open directory for files ... 00:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:58 INFO - (blobuploader) - INFO - Done attempting. 00:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:58 INFO - (blobuploader) - INFO - Done attempting. 00:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:18:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:59 INFO - (blobuploader) - INFO - Done attempting. 00:18:59 INFO - (blobuploader) - INFO - Iteration through files over. 00:18:59 INFO - Return code: 0 00:18:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:18:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:18:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01c31282c64041e60e01c8b0559e1d5965a1ba1cbb1cf3e934a6a18426f0fc3e8b88876bb925279c344dae90bd9577e03dbd504fdbbbe87860729be62625a6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c20a41e3df89d0d9387ef61bb2fcd0c5abafca625d86c540b0a51f8dda9b504c702d7479e8be4779c015cf08efe0b80ef2e2a0b8f42e954cbe19d1dfc08de6d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1384b526ea0236f1dd45e34576a40671ebc7bd78641b643d1392f9a0056c4d33c9eddfd0a6f151dec9390605e0bffbe36370a807554050ab84f2db96730f59a5"} 00:18:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:18:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:18:59 INFO - Contents: 00:18:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01c31282c64041e60e01c8b0559e1d5965a1ba1cbb1cf3e934a6a18426f0fc3e8b88876bb925279c344dae90bd9577e03dbd504fdbbbe87860729be62625a6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c20a41e3df89d0d9387ef61bb2fcd0c5abafca625d86c540b0a51f8dda9b504c702d7479e8be4779c015cf08efe0b80ef2e2a0b8f42e954cbe19d1dfc08de6d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1384b526ea0236f1dd45e34576a40671ebc7bd78641b643d1392f9a0056c4d33c9eddfd0a6f151dec9390605e0bffbe36370a807554050ab84f2db96730f59a5"} 00:18:59 INFO - Running post-run listener: copy_logs_to_upload_dir 00:18:59 INFO - Copying logs to upload dir... 00:18:59 INFO - mkdir: /builds/slave/test/build/upload/logs 00:18:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.531305 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-01 00:18:59.422303) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 00:18:59.425510) ========= 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=8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064 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/sha512/01c31282c64041e60e01c8b0559e1d5965a1ba1cbb1cf3e934a6a18426f0fc3e8b88876bb925279c344dae90bd9577e03dbd504fdbbbe87860729be62625a6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c20a41e3df89d0d9387ef61bb2fcd0c5abafca625d86c540b0a51f8dda9b504c702d7479e8be4779c015cf08efe0b80ef2e2a0b8f42e954cbe19d1dfc08de6d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1384b526ea0236f1dd45e34576a40671ebc7bd78641b643d1392f9a0056c4d33c9eddfd0a6f151dec9390605e0bffbe36370a807554050ab84f2db96730f59a5"} build_url:https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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/sha512/01c31282c64041e60e01c8b0559e1d5965a1ba1cbb1cf3e934a6a18426f0fc3e8b88876bb925279c344dae90bd9577e03dbd504fdbbbe87860729be62625a6db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c20a41e3df89d0d9387ef61bb2fcd0c5abafca625d86c540b0a51f8dda9b504c702d7479e8be4779c015cf08efe0b80ef2e2a0b8f42e954cbe19d1dfc08de6d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1384b526ea0236f1dd45e34576a40671ebc7bd78641b643d1392f9a0056c4d33c9eddfd0a6f151dec9390605e0bffbe36370a807554050ab84f2db96730f59a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 00:18:59.450795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 00:18:59.451152) ========= 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=8887e36bb8e381bfd44124ac000001a8-1472713097.718481-1849199064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 00:18:59.533997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 00:18:59.534315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 00:18:59.534607) ========= ========= Total master_lag: 0.17 =========