builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1472499085.21 results: success (0) buildid: 20160829095731 builduid: 58530b7bb9fb404a85ea453aaed558f4 revision: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.213986) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.214456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.214775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.257406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.257694) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 12:31:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-08-29 12:31:27 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099281 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.370586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.370908) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.420678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:25.421060) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 --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 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 --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=82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 12:31:27,207 truncating revision to first 12 chars 2016-08-29 12:31:27,208 Setting DEBUG logging. 2016-08-29 12:31:27,208 attempt 1/10 2016-08-29 12:31:27,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2ec253835380?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 12:31:27,480 unpacking tar archive at: fx-team-2ec253835380/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:26.008416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:26.008734) ========= script_repo_revision: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:26.009118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:26.009381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 12:31:26.022521) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-29 12:31:26.022783) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:31:27 INFO - MultiFileLogger online at 20160829 12:31:27 in /builds/slave/test 12:31:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:31:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:31:27 INFO - {'append_to_log': False, 12:31:27 INFO - 'base_work_dir': '/builds/slave/test', 12:31:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:31:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:31:27 INFO - 'branch': 'Fx-Team-Non-PGO', 12:31:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:31:27 INFO - 'config_files': ('talos/linux_config.py',), 12:31:27 INFO - 'default_actions': ('clobber', 12:31:27 INFO - 'read-buildbot-config', 12:31:27 INFO - 'download-and-extract', 12:31:27 INFO - 'populate-webroot', 12:31:27 INFO - 'create-virtualenv', 12:31:27 INFO - 'install', 12:31:27 INFO - 'run-tests'), 12:31:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:31:27 INFO - 'download_minidump_stackwalk': True, 12:31:27 INFO - 'download_symbols': 'ondemand', 12:31:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:31:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:31:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:31:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:31:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:31:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:31:27 INFO - 'installer_path': 'installer.exe', 12:31:27 INFO - 'log_level': 'info', 12:31:27 INFO - 'log_name': 'talos', 12:31:27 INFO - 'log_to_console': True, 12:31:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:31:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:31:27 INFO - 'opt_config_files': (), 12:31:27 INFO - 'pip_index': False, 12:31:27 INFO - 'sps_profile': False, 12:31:27 INFO - 'sps_profile_interval': 0, 12:31:27 INFO - 'suite': 'dromaeojs-e10s', 12:31:27 INFO - 'system_bits': '32', 12:31:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:31:27 INFO - 'title': 'talos-linux64-ix-066', 12:31:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:31:27 INFO - 'use_talos_json': True, 12:31:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:31:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:31:27 INFO - 'work_dir': 'build'} 12:31:27 INFO - [mozharness: 2016-08-29 19:31:27.899398Z] Running clobber step. 12:31:27 INFO - Running pre-action listener: _resource_record_pre_action 12:31:27 INFO - Running main action method: clobber 12:31:27 INFO - rmtree: /builds/slave/test/build 12:31:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:31:28 INFO - Running post-action listener: _resource_record_post_action 12:31:28 INFO - [mozharness: 2016-08-29 19:31:28.360750Z] Finished clobber step (success) 12:31:28 INFO - [mozharness: 2016-08-29 19:31:28.360853Z] Running read-buildbot-config step. 12:31:28 INFO - Running pre-action listener: _resource_record_pre_action 12:31:28 INFO - Running main action method: read_buildbot_config 12:31:28 INFO - Using buildbot properties: 12:31:28 INFO - { 12:31:28 INFO - "project": "", 12:31:28 INFO - "product": "firefox", 12:31:28 INFO - "script_repo_revision": "production", 12:31:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:31:28 INFO - "repository": "", 12:31:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:31:28 INFO - "buildid": "20160829095731", 12:31:28 INFO - "pgo_build": "False", 12:31:28 INFO - "basedir": "/builds/slave/test", 12:31:28 INFO - "buildnumber": 1549, 12:31:28 INFO - "slavename": "talos-linux64-ix-066", 12:31:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:31:28 INFO - "platform": "ubuntu64_hw", 12:31:28 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 12:31:28 INFO - "branch": "fx-team", 12:31:28 INFO - "repo_path": "integration/fx-team", 12:31:28 INFO - "revision": "2ec2538353807a17b8b23f2440c9a52ec3f3ccc5", 12:31:28 INFO - "stage_platform": "linux64", 12:31:28 INFO - "builduid": "58530b7bb9fb404a85ea453aaed558f4", 12:31:28 INFO - "slavebuilddir": "test" 12:31:28 INFO - } 12:31:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:31:28 INFO - Running post-action listener: _resource_record_post_action 12:31:28 INFO - [mozharness: 2016-08-29 19:31:28.363304Z] Finished read-buildbot-config step (success) 12:31:28 INFO - [mozharness: 2016-08-29 19:31:28.363394Z] Running download-and-extract step. 12:31:28 INFO - Running pre-action listener: _resource_record_pre_action 12:31:28 INFO - Running main action method: download_and_extract 12:31:28 INFO - mkdir: /builds/slave/test/build/tests 12:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:28 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:31:28 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:28 INFO - Downloaded 1361 bytes. 12:31:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:31:28 INFO - Using the following test package requirements: 12:31:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:31:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:31:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:31:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'jsshell-linux-x86_64.zip'], 12:31:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:31:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:31:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:31:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:31:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:31:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:31:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:31:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:28 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:31:28 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:29 INFO - Downloaded 20305082 bytes. 12:31:29 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 12:31:33 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 12:31: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')]} 12:31:33 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:31:33 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:34 INFO - Downloaded 20305082 bytes. 12:31:34 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 12:31:39 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')]} 12:31:39 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:31:39 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:40 INFO - Downloaded 14413998 bytes. 12:31:40 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 12:31:40 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')]} 12:31:40 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:31:40 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 12:31:41 INFO - Downloaded 55869688 bytes. 12:31:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:31:41 INFO - mkdir: /builds/slave/test/properties 12:31:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:31:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:31:41 INFO - Contents: 12:31:41 INFO - build_url:https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:31:42 INFO - Running post-action listener: _resource_record_post_action 12:31:42 INFO - Running post-action listener: set_extra_try_arguments 12:31:42 INFO - [mozharness: 2016-08-29 19:31:42.169764Z] Finished download-and-extract step (success) 12:31:42 INFO - [mozharness: 2016-08-29 19:31:42.169992Z] Running populate-webroot step. 12:31:42 INFO - Running pre-action listener: _resource_record_pre_action 12:31:42 INFO - Running main action method: populate_webroot 12:31:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:31:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:31:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:31:42 INFO - '--tppagecycles', 12:31:42 INFO - '7'], 12:31:42 INFO - 'tests': ['tsvgm']}}, 12:31:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:31:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:31:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:31:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:31:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['damp', 'tps']}, 12:31:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'tests': ['damp', 'tps']}, 12:31:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['dromaeo_dom']}, 12:31:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:31:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['basic_compositor_video']}, 12:31:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:31:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['a11yr', 12:31:42 INFO - 'ts_paint', 12:31:42 INFO - 'tpaint', 12:31:42 INFO - 'sessionrestore', 12:31:42 INFO - 'sessionrestore_no_auto_restore', 12:31:42 INFO - 'tabpaint']}, 12:31:42 INFO - 'other-e10s': {'tests': ['a11yr', 12:31:42 INFO - 'ts_paint', 12:31:42 INFO - 'tpaint', 12:31:42 INFO - 'sessionrestore', 12:31:42 INFO - 'sessionrestore_no_auto_restore', 12:31:42 INFO - 'tabpaint']}, 12:31:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:31:42 INFO - 'ts_paint', 12:31:42 INFO - 'tpaint', 12:31:42 INFO - 'sessionrestore', 12:31:42 INFO - 'sessionrestore_no_auto_restore', 12:31:42 INFO - 'tabpaint']}, 12:31:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:31:42 INFO - 'ts_paint', 12:31:42 INFO - 'tpaint', 12:31:42 INFO - 'sessionrestore', 12:31:42 INFO - 'sessionrestore_no_auto_restore', 12:31:42 INFO - 'tabpaint']}, 12:31:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['a11yr', 12:31:42 INFO - 'ts_paint', 12:31:42 INFO - 'tpaint', 12:31:42 INFO - 'sessionrestore', 12:31:42 INFO - 'sessionrestore_no_auto_restore', 12:31:42 INFO - 'tabpaint']}, 12:31:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['a11yr', 12:31:42 INFO - 'ts_paint', 12:31:42 INFO - 'tpaint', 12:31:42 INFO - 'sessionrestore', 12:31:42 INFO - 'sessionrestore_no_auto_restore', 12:31:42 INFO - 'tabpaint']}, 12:31:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['tsvgx', 12:31:42 INFO - 'tsvgr_opacity', 12:31:42 INFO - 'tart', 12:31:42 INFO - 'tscrollx', 12:31:42 INFO - 'cart']}, 12:31:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:31:42 INFO - 'tsvgr_opacity', 12:31:42 INFO - 'tart', 12:31:42 INFO - 'tscrollx', 12:31:42 INFO - 'cart']}, 12:31:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'talos_options': ['--disable-e10s'], 12:31:42 INFO - 'tests': ['tp5o']}, 12:31:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'tests': ['tp5o']}, 12:31:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'talos_options': ['--disable-e10s', 12:31:42 INFO - '--xperf_path', 12:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:42 INFO - 'tests': ['tp5n']}, 12:31:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:42 INFO - 'talos_options': ['--xperf_path', 12:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:42 INFO - 'tests': ['tp5n']}}, 12:31:42 INFO - 'talos.zip': {'path': '', 12:31:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:31:42 INFO - Running post-action listener: _resource_record_post_action 12:31:42 INFO - [mozharness: 2016-08-29 19:31:42.188011Z] Finished populate-webroot step (success) 12:31:42 INFO - [mozharness: 2016-08-29 19:31:42.188101Z] Running create-virtualenv step. 12:31:42 INFO - Running pre-action listener: _resource_record_pre_action 12:31:42 INFO - Running main action method: create_virtualenv 12:31:42 INFO - Creating virtualenv /builds/slave/test/build/venv 12:31:42 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 12:31:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:31:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:31:42 INFO - Using real prefix '/usr' 12:31:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:31:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:44 INFO - Installing pip.................done. 12:31:44 INFO - Return code: 0 12:31:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:31:44 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')]} 12:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:44 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')]} 12:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:44 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:44 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 12:31:44 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 12:31:44 INFO - Using env: {'DISPLAY': ':0', 12:31:44 INFO - 'HOME': '/home/cltbld', 12:31:44 INFO - 'LANG': 'en_US.UTF-8', 12:31:44 INFO - 'LANGUAGE': 'en_US:en', 12:31:44 INFO - 'LOGNAME': 'cltbld', 12:31:44 INFO - 'MAIL': '/var/mail/cltbld', 12:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:44 INFO - 'MOZ_NO_REMOTE': '1', 12:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:44 INFO - 'NO_EM_RESTART': '1', 12:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:44 INFO - 'PWD': '/builds/slave/test', 12:31:44 INFO - 'SHELL': '/bin/bash', 12:31:44 INFO - 'SHLVL': '1', 12:31:44 INFO - 'TERM': 'linux', 12:31:44 INFO - 'TMOUT': '86400', 12:31:44 INFO - 'USER': 'cltbld', 12:31:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:44 INFO - '_': '/tools/buildbot/bin/python'} 12:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:44 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 12:31:44 INFO - Cleaning up... 12:31:44 INFO - Return code: 0 12:31:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:31:44 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')]} 12:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:44 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')]} 12:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:44 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:44 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 12:31:44 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 12:31:45 INFO - Using env: {'DISPLAY': ':0', 12:31:45 INFO - 'HOME': '/home/cltbld', 12:31:45 INFO - 'LANG': 'en_US.UTF-8', 12:31:45 INFO - 'LANGUAGE': 'en_US:en', 12:31:45 INFO - 'LOGNAME': 'cltbld', 12:31:45 INFO - 'MAIL': '/var/mail/cltbld', 12:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:45 INFO - 'MOZ_NO_REMOTE': '1', 12:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:45 INFO - 'NO_EM_RESTART': '1', 12:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:45 INFO - 'PWD': '/builds/slave/test', 12:31:45 INFO - 'SHELL': '/bin/bash', 12:31:45 INFO - 'SHLVL': '1', 12:31:45 INFO - 'TERM': 'linux', 12:31:45 INFO - 'TMOUT': '86400', 12:31:45 INFO - 'USER': 'cltbld', 12:31:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:45 INFO - '_': '/tools/buildbot/bin/python'} 12:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:45 INFO - Downloading/unpacking psutil>=3.1.1 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:47 INFO - Installing collected packages: psutil 12:31:47 INFO - Running setup.py install for psutil 12:31:47 INFO - building 'psutil._psutil_linux' extension 12:31:47 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 12:31:47 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 12:31:47 INFO - building 'psutil._psutil_posix' extension 12:31:47 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 12:31:47 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 12:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:47 INFO - Successfully installed psutil 12:31:47 INFO - Cleaning up... 12:31:47 INFO - Return code: 0 12:31:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:31:47 INFO - Using env: {'DISPLAY': ':0', 12:31:47 INFO - 'HOME': '/home/cltbld', 12:31:47 INFO - 'LANG': 'en_US.UTF-8', 12:31:47 INFO - 'LANGUAGE': 'en_US:en', 12:31:47 INFO - 'LOGNAME': 'cltbld', 12:31:47 INFO - 'MAIL': '/var/mail/cltbld', 12:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:47 INFO - 'MOZ_NO_REMOTE': '1', 12:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:47 INFO - 'NO_EM_RESTART': '1', 12:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:47 INFO - 'PWD': '/builds/slave/test', 12:31:47 INFO - 'SHELL': '/bin/bash', 12:31:47 INFO - 'SHLVL': '1', 12:31:47 INFO - 'TERM': 'linux', 12:31:47 INFO - 'TMOUT': '86400', 12:31:47 INFO - 'USER': 'cltbld', 12:31:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:47 INFO - '_': '/tools/buildbot/bin/python'} 12:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:31:49 INFO - Installing collected packages: mozsystemmonitor 12:31:49 INFO - Running setup.py install for mozsystemmonitor 12:31:49 INFO - Successfully installed mozsystemmonitor 12:31:49 INFO - Cleaning up... 12:31:50 INFO - Return code: 0 12:31:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:50 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:50 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 12:31:50 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 12:31:50 INFO - Using env: {'DISPLAY': ':0', 12:31:50 INFO - 'HOME': '/home/cltbld', 12:31:50 INFO - 'LANG': 'en_US.UTF-8', 12:31:50 INFO - 'LANGUAGE': 'en_US:en', 12:31:50 INFO - 'LOGNAME': 'cltbld', 12:31:50 INFO - 'MAIL': '/var/mail/cltbld', 12:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:50 INFO - 'MOZ_NO_REMOTE': '1', 12:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:50 INFO - 'NO_EM_RESTART': '1', 12:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:50 INFO - 'PWD': '/builds/slave/test', 12:31:50 INFO - 'SHELL': '/bin/bash', 12:31:50 INFO - 'SHLVL': '1', 12:31:50 INFO - 'TERM': 'linux', 12:31:50 INFO - 'TMOUT': '86400', 12:31:50 INFO - 'USER': 'cltbld', 12:31:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:50 INFO - '_': '/tools/buildbot/bin/python'} 12:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 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 12:31:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:31:52 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 12:31:52 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 12:31:52 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 12:31:52 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 12:31:52 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 12:31:52 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 12:31:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:52 INFO - warning: no files found matching '*.txt' 12:31:52 INFO - no previously-included directories found matching 'build' 12:31:52 INFO - no previously-included directories found matching 'dist' 12:31:52 INFO - no previously-included directories found matching '.git*' 12:31:52 INFO - Installing collected packages: jsonschema, functools32 12:31:52 INFO - Running setup.py install for functools32 12:31:52 INFO - warning: no files found matching '*.txt' 12:31:52 INFO - no previously-included directories found matching 'build' 12:31:52 INFO - no previously-included directories found matching 'dist' 12:31:52 INFO - no previously-included directories found matching '.git*' 12:31:52 INFO - Successfully installed jsonschema functools32 12:31:52 INFO - Cleaning up... 12:31:52 INFO - Return code: 0 12:31:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:52 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:52 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 12:31:52 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 12:31:52 INFO - Using env: {'DISPLAY': ':0', 12:31:52 INFO - 'HOME': '/home/cltbld', 12:31:52 INFO - 'LANG': 'en_US.UTF-8', 12:31:52 INFO - 'LANGUAGE': 'en_US:en', 12:31:52 INFO - 'LOGNAME': 'cltbld', 12:31:52 INFO - 'MAIL': '/var/mail/cltbld', 12:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:52 INFO - 'MOZ_NO_REMOTE': '1', 12:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:52 INFO - 'NO_EM_RESTART': '1', 12:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:52 INFO - 'PWD': '/builds/slave/test', 12:31:52 INFO - 'SHELL': '/bin/bash', 12:31:52 INFO - 'SHLVL': '1', 12:31:52 INFO - 'TERM': 'linux', 12:31:52 INFO - 'TMOUT': '86400', 12:31:52 INFO - 'USER': 'cltbld', 12:31:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:52 INFO - '_': '/tools/buildbot/bin/python'} 12:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:31:52 INFO - Cleaning up... 12:31:52 INFO - Return code: 0 12:31:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:52 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:52 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 12:31:52 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 12:31:52 INFO - Using env: {'DISPLAY': ':0', 12:31:52 INFO - 'HOME': '/home/cltbld', 12:31:52 INFO - 'LANG': 'en_US.UTF-8', 12:31:52 INFO - 'LANGUAGE': 'en_US:en', 12:31:52 INFO - 'LOGNAME': 'cltbld', 12:31:52 INFO - 'MAIL': '/var/mail/cltbld', 12:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:52 INFO - 'MOZ_NO_REMOTE': '1', 12:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:52 INFO - 'NO_EM_RESTART': '1', 12:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:52 INFO - 'PWD': '/builds/slave/test', 12:31:52 INFO - 'SHELL': '/bin/bash', 12:31:52 INFO - 'SHLVL': '1', 12:31:52 INFO - 'TERM': 'linux', 12:31:52 INFO - 'TMOUT': '86400', 12:31:52 INFO - 'USER': 'cltbld', 12:31:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:52 INFO - '_': '/tools/buildbot/bin/python'} 12:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:54 INFO - Downloading blobuploader-1.2.4.tar.gz 12:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:31:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:31:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:55 INFO - Downloading docopt-0.6.1.tar.gz 12:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:31:55 INFO - Installing collected packages: blobuploader, requests, docopt 12:31:55 INFO - Running setup.py install for blobuploader 12:31:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:31:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:31:55 INFO - Running setup.py install for requests 12:31:56 INFO - Running setup.py install for docopt 12:31:56 INFO - Successfully installed blobuploader requests docopt 12:31:56 INFO - Cleaning up... 12:31:56 INFO - Return code: 0 12:31:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:56 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:56 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 12:31:56 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 12:31:56 INFO - Using env: {'DISPLAY': ':0', 12:31:56 INFO - 'HOME': '/home/cltbld', 12:31:56 INFO - 'LANG': 'en_US.UTF-8', 12:31:56 INFO - 'LANGUAGE': 'en_US:en', 12:31:56 INFO - 'LOGNAME': 'cltbld', 12:31:56 INFO - 'MAIL': '/var/mail/cltbld', 12:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:56 INFO - 'MOZ_NO_REMOTE': '1', 12:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:56 INFO - 'NO_EM_RESTART': '1', 12:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:56 INFO - 'PWD': '/builds/slave/test', 12:31:56 INFO - 'SHELL': '/bin/bash', 12:31:56 INFO - 'SHLVL': '1', 12:31:56 INFO - 'TERM': 'linux', 12:31:56 INFO - 'TMOUT': '86400', 12:31:56 INFO - 'USER': 'cltbld', 12:31:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:56 INFO - '_': '/tools/buildbot/bin/python'} 12:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:56 INFO - Running setup.py (path:/tmp/pip-LYUcgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:56 INFO - Running setup.py (path:/tmp/pip-iBikU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:56 INFO - Running setup.py (path:/tmp/pip-PMq7Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:56 INFO - Running setup.py (path:/tmp/pip-_snotn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:56 INFO - Running setup.py (path:/tmp/pip-jRssxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:56 INFO - Running setup.py (path:/tmp/pip-Hgghw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:56 INFO - Running setup.py (path:/tmp/pip-kXgO8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:56 INFO - Running setup.py (path:/tmp/pip-94I62B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:57 INFO - Running setup.py (path:/tmp/pip-DvACJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:57 INFO - Running setup.py (path:/tmp/pip-E7rTkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:57 INFO - Running setup.py (path:/tmp/pip-c0KEnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:57 INFO - Running setup.py (path:/tmp/pip-_dq6W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:57 INFO - Running setup.py (path:/tmp/pip-JaQofu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:57 INFO - Running setup.py (path:/tmp/pip-tXadFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:57 INFO - Running setup.py (path:/tmp/pip-CiNHn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:57 INFO - Running setup.py (path:/tmp/pip-W96rSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:57 INFO - Running setup.py (path:/tmp/pip-fd20di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:57 INFO - Running setup.py install for manifestparser 12:31:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:57 INFO - Running setup.py install for mozcrash 12:31:57 INFO - Running setup.py install for mozdebug 12:31:57 INFO - Running setup.py install for mozdevice 12:31:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Running setup.py install for mozfile 12:31:58 INFO - Running setup.py install for mozhttpd 12:31:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Running setup.py install for mozinfo 12:31:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Running setup.py install for mozInstall 12:31:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Running setup.py install for mozleak 12:31:58 INFO - Running setup.py install for mozlog 12:31:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Running setup.py install for moznetwork 12:31:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:58 INFO - Running setup.py install for mozprocess 12:31:58 INFO - Running setup.py install for mozprofile 12:31:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:59 INFO - Running setup.py install for mozrunner 12:31:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:59 INFO - Running setup.py install for mozscreenshot 12:31:59 INFO - Running setup.py install for moztest 12:31:59 INFO - Running setup.py install for mozversion 12:31:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:59 INFO - Cleaning up... 12:31:59 INFO - Return code: 0 12:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:59 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:31:59 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 12:31:59 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 12:31:59 INFO - Using env: {'DISPLAY': ':0', 12:31:59 INFO - 'HOME': '/home/cltbld', 12:31:59 INFO - 'LANG': 'en_US.UTF-8', 12:31:59 INFO - 'LANGUAGE': 'en_US:en', 12:31:59 INFO - 'LOGNAME': 'cltbld', 12:31:59 INFO - 'MAIL': '/var/mail/cltbld', 12:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:59 INFO - 'MOZ_NO_REMOTE': '1', 12:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:59 INFO - 'NO_EM_RESTART': '1', 12:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:59 INFO - 'PWD': '/builds/slave/test', 12:31:59 INFO - 'SHELL': '/bin/bash', 12:31:59 INFO - 'SHLVL': '1', 12:31:59 INFO - 'TERM': 'linux', 12:31:59 INFO - 'TMOUT': '86400', 12:31:59 INFO - 'USER': 'cltbld', 12:31:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:59 INFO - '_': '/tools/buildbot/bin/python'} 12:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:59 INFO - Running setup.py (path:/tmp/pip-vzxzbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:59 INFO - Running setup.py (path:/tmp/pip-MCyxqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:59 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)) 12:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:59 INFO - Running setup.py (path:/tmp/pip-3la_Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:59 INFO - Running setup.py (path:/tmp/pip-A_E5k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:59 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)) 12:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:59 INFO - Running setup.py (path:/tmp/pip-QiU_0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:00 INFO - Running setup.py (path:/tmp/pip-UNWKcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:00 INFO - Running setup.py (path:/tmp/pip-4TyuSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:00 INFO - Running setup.py (path:/tmp/pip-qyh5Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:00 INFO - Running setup.py (path:/tmp/pip-iBd8Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:00 INFO - Running setup.py (path:/tmp/pip-gSHiFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:00 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)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:00 INFO - Running setup.py (path:/tmp/pip-CSoqgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:00 INFO - Running setup.py (path:/tmp/pip-BX7E2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:00 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)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:00 INFO - Running setup.py (path:/tmp/pip-x7WOWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:00 INFO - Running setup.py (path:/tmp/pip-H_Wcqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:00 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)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:00 INFO - Running setup.py (path:/tmp/pip-48kJOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:00 INFO - Running setup.py (path:/tmp/pip-yRBsJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:00 INFO - Running setup.py (path:/tmp/pip-VaXHSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:00 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)) 12:32:00 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)) 12:32:00 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)) 12:32:00 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)) 12:32:00 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)) 12:32:00 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)) 12:32:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:02 INFO - Downloading blessings-1.6.tar.gz 12:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:32:02 INFO - Installing collected packages: blessings 12:32:02 INFO - Running setup.py install for blessings 12:32:03 INFO - Successfully installed blessings 12:32:03 INFO - Cleaning up... 12:32:03 INFO - Return code: 0 12:32:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:03 INFO - Reading from file tmpfile_stdout 12:32:03 INFO - Current package versions: 12:32:03 INFO - argparse == 1.2.1 12:32:03 INFO - blessings == 1.6 12:32:03 INFO - blobuploader == 1.2.4 12:32:03 INFO - docopt == 0.6.1 12:32:03 INFO - functools32 == 3.2.3-2 12:32:03 INFO - jsonschema == 2.5.1 12:32:03 INFO - manifestparser == 1.1 12:32:03 INFO - mozInstall == 1.12 12:32:03 INFO - mozcrash == 0.17 12:32:03 INFO - mozdebug == 0.1 12:32:03 INFO - mozdevice == 0.48 12:32:03 INFO - mozfile == 1.2 12:32:03 INFO - mozhttpd == 0.7 12:32:03 INFO - mozinfo == 0.9 12:32:03 INFO - mozleak == 0.1 12:32:03 INFO - mozlog == 3.3 12:32:03 INFO - moznetwork == 0.27 12:32:03 INFO - mozprocess == 0.23 12:32:03 INFO - mozprofile == 0.28 12:32:03 INFO - mozrunner == 6.12 12:32:03 INFO - mozscreenshot == 0.1 12:32:03 INFO - mozsystemmonitor == 0.3 12:32:03 INFO - moztest == 0.7 12:32:03 INFO - mozversion == 1.4 12:32:03 INFO - psutil == 3.1.1 12:32:03 INFO - requests == 1.2.3 12:32:03 INFO - wsgiref == 0.1.2 12:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:32:03 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 12:32:03 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 12:32:03 INFO - Using env: {'DISPLAY': ':0', 12:32:03 INFO - 'HOME': '/home/cltbld', 12:32:03 INFO - 'LANG': 'en_US.UTF-8', 12:32:03 INFO - 'LANGUAGE': 'en_US:en', 12:32:03 INFO - 'LOGNAME': 'cltbld', 12:32:03 INFO - 'MAIL': '/var/mail/cltbld', 12:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:03 INFO - 'MOZ_NO_REMOTE': '1', 12:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:03 INFO - 'NO_EM_RESTART': '1', 12:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:03 INFO - 'PWD': '/builds/slave/test', 12:32:03 INFO - 'SHELL': '/bin/bash', 12:32:03 INFO - 'SHLVL': '1', 12:32:03 INFO - 'TERM': 'linux', 12:32:03 INFO - 'TMOUT': '86400', 12:32:03 INFO - 'USER': 'cltbld', 12:32:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:03 INFO - '_': '/tools/buildbot/bin/python'} 12:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:32:03 INFO - Cleaning up... 12:32:03 INFO - Return code: 0 12:32:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:03 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 0x7f58903aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', '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 12:32:03 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 12:32:03 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 12:32:03 INFO - Using env: {'DISPLAY': ':0', 12:32:03 INFO - 'HOME': '/home/cltbld', 12:32:03 INFO - 'LANG': 'en_US.UTF-8', 12:32:03 INFO - 'LANGUAGE': 'en_US:en', 12:32:03 INFO - 'LOGNAME': 'cltbld', 12:32:03 INFO - 'MAIL': '/var/mail/cltbld', 12:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:03 INFO - 'MOZ_NO_REMOTE': '1', 12:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:03 INFO - 'NO_EM_RESTART': '1', 12:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:03 INFO - 'PWD': '/builds/slave/test', 12:32:03 INFO - 'SHELL': '/bin/bash', 12:32:03 INFO - 'SHLVL': '1', 12:32:03 INFO - 'TERM': 'linux', 12:32:03 INFO - 'TMOUT': '86400', 12:32:03 INFO - 'USER': 'cltbld', 12:32:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:03 INFO - '_': '/tools/buildbot/bin/python'} 12:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:32:03 INFO - Cleaning up... 12:32:03 INFO - Return code: 0 12:32:03 INFO - Running post-action listener: _resource_record_post_action 12:32:03 INFO - Running post-action listener: _start_resource_monitoring 12:32:03 INFO - Starting resource monitoring. 12:32:03 INFO - [mozharness: 2016-08-29 19:32:03.780130Z] Finished create-virtualenv step (success) 12:32:03 INFO - [mozharness: 2016-08-29 19:32:03.780599Z] Running install step. 12:32:03 INFO - Running pre-action listener: _resource_record_pre_action 12:32:03 INFO - Running main action method: install 12:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:03 INFO - Reading from file tmpfile_stdout 12:32:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:32:04 INFO - Reading from file tmpfile_stdout 12:32:04 INFO - Output received: 12:32:04 INFO - Usage: mozinstall [options] installer 12:32:04 INFO - Options: 12:32:04 INFO - -h, --help show this help message and exit 12:32:04 INFO - -d DEST, --destination=DEST 12:32:04 INFO - Directory to install application into. [default: 12:32:04 INFO - "/builds/slave/test"] 12:32:04 INFO - --app=APP Application being installed. [default: firefox] 12:32:04 INFO - mkdir: /builds/slave/test/build/application 12:32:04 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'] 12:32:04 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 12:32:20 INFO - Reading from file tmpfile_stdout 12:32:20 INFO - Output received: 12:32:20 INFO - /builds/slave/test/build/application/firefox/firefox 12:32:20 INFO - Running post-action listener: _resource_record_post_action 12:32:20 INFO - [mozharness: 2016-08-29 19:32:20.202168Z] Finished install step (success) 12:32:20 INFO - [mozharness: 2016-08-29 19:32:20.202448Z] Running run-tests step. 12:32:20 INFO - Running pre-action listener: _resource_record_pre_action 12:32:20 INFO - Running main action method: run_tests 12:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:32:20 INFO - Python 2.7.3 12:32:20 INFO - Return code: 0 12:32:20 INFO - grabbing minidump binary from tooltool 12:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2738090>, '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 0x273b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:32:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:32:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:32:20 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 12:32:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:32:20 INFO - Return code: 0 12:32:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:32:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:32:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:32:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:32:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 12:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 12:32:20 INFO - Using env: {'DISPLAY': ':0', 12:32:20 INFO - 'HOME': '/home/cltbld', 12:32:20 INFO - 'LANG': 'en_US.UTF-8', 12:32:20 INFO - 'LANGUAGE': 'en_US:en', 12:32:20 INFO - 'LOGNAME': 'cltbld', 12:32:20 INFO - 'MAIL': '/var/mail/cltbld', 12:32:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:32:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:20 INFO - 'MOZ_NO_REMOTE': '1', 12:32:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:20 INFO - 'NO_EM_RESTART': '1', 12:32:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:20 INFO - 'PWD': '/builds/slave/test', 12:32:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:32:20 INFO - 'SHELL': '/bin/bash', 12:32:20 INFO - 'SHLVL': '1', 12:32:20 INFO - 'TERM': 'linux', 12:32:20 INFO - 'TMOUT': '86400', 12:32:20 INFO - 'USER': 'cltbld', 12:32:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518', 12:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:20 INFO - '_': '/tools/buildbot/bin/python'} 12:32:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 12:32:20 INFO - mozversion application_buildid: 20160829095731 12:32:20 INFO - mozversion application_changeset: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 12:32:20 INFO - mozversion application_display_name: Nightly 12:32:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:32:20 INFO - mozversion application_name: Firefox 12:32:20 INFO - mozversion application_remotingname: firefox 12:32:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:32:20 INFO - mozversion application_vendor: Mozilla 12:32:20 INFO - mozversion application_version: 51.0a1 12:32:20 INFO - mozversion platform_buildid: 20160829095731 12:32:20 INFO - mozversion platform_changeset: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 12:32:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:32:20 INFO - mozversion platform_version: 51.0a1 12:32:20 INFO - using testdate: 1472499140 12:32:20 INFO - actual date: 1472499140 12:32:20 INFO - starting webserver on 'localhost:32922' 12:32:20 INFO - SUITE-START | Running 2 tests 12:32:20 INFO - TEST-START | dromaeo_css 12:32:20 INFO - operating with platform_type : linux_ 12:32:20 INFO - Initialising browser for dromaeo_css test... 12:32:20 INFO - TEST-INFO | started process 11657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9jAYB/profile http://localhost:32922/getInfo.html) 12:32:25 INFO - PROCESS | 11657 | __metrics Screen width/height:1600/1200 12:32:25 INFO - PROCESS | 11657 | colorDepth:24 12:32:25 INFO - PROCESS | 11657 | Browser inner width/height: 1024/697 12:32:25 INFO - PROCESS | 11657 | __metrics 12:32:26 ERROR - PROCESS | 11657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:32:27 INFO - TEST-INFO | 11657: exit 0 12:32:27 INFO - Browser initialized. 12:32:27 INFO - Running cycle 1/1 for dromaeo_css test... 12:32:27 INFO - TEST-INFO | started process 11776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9jAYB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:39 INFO - PROCESS | 11776 | RSS: Main: 192806912 12:32:39 INFO - PROCESS | 11776 | 12:33:29 INFO - PROCESS | 11776 | 1472499209128 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] 12:35:41 INFO - PROCESS | 11776 | Cycle 1(1): loaded http://localhost:32922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32922/tests/dromaeo/cssquery-ext.html) 12:35:42 INFO - PROCESS | 11776 | RSS: Main: 212721664 12:35:42 INFO - PROCESS | 11776 | 12:38:45 INFO - PROCESS | 11776 | Cycle 1(1): loaded http://localhost:32922/tests/dromaeo/cssquery-ext.html (next: http://localhost:32922/tests/dromaeo/cssquery-jquery.html) 12:38:45 INFO - PROCESS | 11776 | RSS: Main: 207335424 12:38:45 INFO - PROCESS | 11776 | 12:41:47 INFO - PROCESS | 11776 | Cycle 1(1): loaded http://localhost:32922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32922/tests/dromaeo/cssquery-mootools.html) 12:41:48 INFO - PROCESS | 11776 | RSS: Main: 203296768 12:41:48 INFO - PROCESS | 11776 | 12:44:50 INFO - PROCESS | 11776 | Cycle 1(1): loaded http://localhost:32922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32922/tests/dromaeo/cssquery-prototype.html) 12:44:50 INFO - PROCESS | 11776 | RSS: Main: 196632576 12:44:50 INFO - PROCESS | 11776 | 12:47:53 INFO - PROCESS | 11776 | Cycle 1(1): loaded http://localhost:32922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32922/tests/dromaeo/cssquery-yui.html) 12:47:54 INFO - PROCESS | 11776 | RSS: Main: 198545408 12:47:54 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | Cycle 1(1): loaded http://localhost:32922/tests/dromaeo/cssquery-yui.html (next: http://localhost:32922/tests/dromaeo/cssquery-dojo.html) 12:50:57 INFO - PROCESS | 11776 | RSS: Main: 199294976 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | __start_tp_report 12:50:57 INFO - PROCESS | 11776 | _x_x_mozilla_page_load 12:50:57 INFO - PROCESS | 11776 | _x_x_mozilla_page_load_details 12:50:57 INFO - PROCESS | 11776 | |i|pagename|runs| 12:50:57 INFO - PROCESS | 11776 | |0;dojo.html;2604.8046396520267;2623.6720409948757;2635.051381502659;2660.2285337252197;2668.6797584289875;4702.435707715071;4714.882127946798;4733.952660473395;4737.834175803848;4745.691530050544;4613.538646135385;4696.577308042276;4708.599769019637;4727.243641017438;4741.976290118545;4330.523642399334;4366.323219900921;4379.343098535213;4428.756418396987;4479.596836284733;4125.793710314488;4435.933460998088;4444.022315090675;4448.666350023745;4454.443194600675;4228.1966426379195;4277.401163837066;4290.485141782975;4346.304591265382;4364.825406983717;4295.119500502389;4308;4308.9784551077355;4310.116426132635;4374.540673229297;4293.205756934977;4328.61042506176;4343.261645520269;4369.519352871182;4383.561643835623;4660.976695116537;4669.276262179367;4715.764211789431;4720.693154944917;4760.714357138583;5058.215976523645;5068.113080210986;5069.594432445432;5070.594352451795;5099.750561112552;5059.949400505985;5063.367079115111;5071.619628527875;5086.440491545927;5112.795488180468;4645.581897629229;4685.086408150446;4688.976555117237;4743.28850672395;4751.691140075884;5172.586193104543;5210.166373380241;5216.556592689664;5216.66091704038;5265.078611243017;4997.125503036954;5000.199968005102;5031.6729412588065;5034.093863104603;5067.037262920034;4888.071266459361;4946.356973593482;4983.775730092155;4984.626153038536;5078.415982162099;4940.357753492023;4944.752762361867;4945.134601444733;4960.255961605788;4970.080535101018;4916.655834091651;4941.654084214142;4943.258511223274;4974.850754477371;4990.5508504234795;4172.353285240732;4270.167317373144;4293.635041021485;4298.161858437637;4300.698951073395;3730.813459327023;3734.3651579231596;3739;3770.132869440044;3802.2015376770637;4377.715448495837;4387.517373088957;4397.076613911115;4436.689431739812;4444.866654000385;4940.061388336205;4989.25161225819;5024.422191447957;5051.444341122474;5068.4287870759445;4377.584129507692;4379.233634114017;4379.627731642782;4409.581089796464;4416.779161041999;4558.8632341029825;4585.243434833282;4587.678862479661;4587.8623641290815;4630.74530900797;4695.718256904528;4743.549362810528;4766.666333356632;4768.403949506312;4792.376990991149;5040.092783298895;5079.339685840817;5082.898342033212;5084.161113416245;5114.820981265638;4750.8337208197545;4769.046190761931;4778.593819525379;4782.258749893772;4825.686330388514;4866.172750632471;4902.901941961212;4911.7298548580175;4970.428400733962;5070.822521211888;5071.898562028812;5087.23691446286;5109.74451277442;5120.4111527174855;5196.402413722471;4960.30555722192;4962.627802914723;4970.950290497193;4971.65198436106;5032.84901452957;4748.691335063209;4942;4960.305557222064;4961.330220420341;5027.195648696191;4828.8792780180775;4841;4862.781174847069;4866.05112003156;4926.310316555613;4970.552650261494;4981.402231732215;4983;4984.177610694195;5041.823536176216;4762.809487620457;4860.3195552621955;4877.80488780459;4898.583620392306;4952.133376659142 12:50:57 INFO - PROCESS | 11776 | |1;ext.html;548.7338640759231;549.5383877542864;562.3364429972634;566.0179588414102;577.5783677915124;36701.26597468049;38261;38276.23447531055;38303.42544861829;38349.233015339676;37991;38621.42067868984;38650;38663.22673546527;38719;7467.925320746777;7583.355414789722;7632.160462349138;7637.350825179867;7641.3504852087635;7552.39580833532;7616;7635.541867487941;7657.885131723028;7675.923240767576;7606.087269527665;7622.352100071501;7628.656710448043;7639.770806875803;7653.387728981668;7553.924460755377;7636.350910172642;7640;7667.923320766805;7680.692772289101;7519.586422746746;7568.810779730551;7578.507397019232;7581.3934885209055;7605.619719014027;34727;35038.824805876066;35111.29777404463;35197.472037919455;35261.64738352609;2809.3959798643186;2914.2714321419644;2979.7765167612297;3217.1635374802486;3468.757186996911;27602.5859612106;27759.583606245924;28127.437451251066;28291.453769160875;28352;3122.110198593413;3167.192365946669;3208.4064448076947;3313.867445302185;3321.6014078310513;173009;173223;175210;175528;176404.99999999872;30208.20315429011;48634.75682621635;48867;49074.75462622664;49243;30726.38547229043;32390;32412;32506;32559.674403256136;12036.699082523008;12089.697757555956;12103.910648041718;12116.09129315305;12164.939175304244;10063.094321511098;10144.239182061376;10158.984101589782;10161.644342447978;10169.389836609827;7588.354989825816;7628.580428076398;7671.923280767121;7712.305892469592;7719.421043421766;2992.865321060514;2998.775091868075;3039.6656367799524;3046.4059508396094;3081.5839861618397;841.8358420108143;854.5513605357113;907.9682211122711;949.3022628368144;971.3928794503436;26947.191584252505;27457.45085098287;27531.587026194622;27713.86143069272;28157.859210704224;950.6815216902277;959.8128364968765;961.4135377419768;971.5870754929127;988.7083310423442;13985.440582376794;14736.484223052355;14975.32611032506;15046.247687615576;15112.09327440357;357894;363052;363412;363521;364377;47089;47250.29124563134;47501.52498474971;47786.76106619445;47861.76069119632;1167.4571324334224;1171.4494187731752;1181.639599922032;1192.350169157811;1208.655533173059;25297.241082767545;26116.216513504627;26690.798914048526;26980.730192698607;27313.86343068272;40201.39697904475;40478.190436190525;40504;40548.594514055665;40571.59428405796;302356;302757;304609;305281;306040.1677907737;24005.27984160478;24536.141235056686;24555.140570079962;24555.508889821747;24564.508709825346;41039.794801027;44023.77988110039;44648.55351446444;45256;48837.267440989126;34300.656993429744;34879.65120348764;35888.641113589576;37196.25607487781;37266.25467490689;36672.266554668226;36954.44568331423;37783.81108094442;37930.8103459492;38807.805960970014;36650;37137.25725485529;37276.25447490981;37324.25351493009;37826.24347512979;31616.367672646877;34146.41449174071;34630.82684586561;34669.30661386708;34778.30443391067;26501.33746656349;26536.469270614867;26705.599416008386;26809.9168595614;26825.463490729686 12:50:57 INFO - PROCESS | 11776 | |2;jquery.html;342.5119205132687;354.68610279902293;356.099069354533;363.94358874374484;364.61897317303414;15393.307301171446;15746.21268936553;17046.744298835496;17113.68965189699;17202;13183.077184597081;16018.83981160188;16606.086665233437;16635.50093497194;16716.83283167168;4669.2062349400685;5095.261187127864;5122.052420302256;5124.026434977342;5128.640995130342;4947.183714687072;5060.4686507916695;5080.847574572768;5116.923246151311;5118.104331741949;4722.150012997659;4745.050989802036;4772.04559088182;4777.928331075037;4939.086269040239;4598.747068911209;4716.514297996155;4735.810567577293;4761.000189960113;4771.498992605779;4434.401355816955;4550.067236216601;4573.634109271284;4592.609628181609;4601.746903920283;12016.63950081499;12262.141650084497;12305.815412768816;12308.876911230953;18174.36389726353;1771.2472199315368;1803.7835459744783;1809.1496996411797;1815.6187200687739;1833.8257865502756;8758.56207189638;8772.824543509158;8908;8935.821283574358;9036.231920286784;1650.645111301064;1697.6944150052987;1700.013991884704;1825.543614096476;1825.9609206508983;64301.67849160771;66171;66824.6658766703;68100.31899680989;69021.30978690198;9094.681686140953;9527.38072025316;9717.416954982582;9800.598853280992;9912.900870991341;12825.871741282654;13376.39806208723;13382.933085334706;13458.730825383438;13490.595282141552;6697.430718388894;6703.597784132968;6725.226598941086;6872.244053154149;7000.684969176297;6352.618842869442;6416.839579010562;6534.215894092644;6544.901826472512;6586.27550969393;4026.4564283821896;4129.174165166979;4211.43145675336;4225.929294645663;4260.339647354665;1796.3622913865652;1852.4998250472297;1858.5446565591517;1881.5484283771796;1888.1314595286321;774.5662429039643;810.4974915552395;868.3617541107282;898.5597057441937;907.6505545365083;16430.260638271306;16655.83344166567;16901.408450704166;16952.74570881438;17558.209880555405;832.8667413213857;844.932405407566;849.3502470609989;852.3607294529103;883.3639779358851;8626.223639872442;9605.759856003655;9647.565859536338;9800.970898055744;9837.754056148653;350098;359476;378324;379446;379654;49605.751971239915;73917.6304118476;74927.62536187284;77067.22932770601;79021.60489197518;888.693400776731;896.1173244354305;912.0423555267075;926.379325851681;927.4435338796668;12969.675758105745;14776.187309698069;15028.699426011637;15051.849481505045;15720.371185152922;33715;36463.81768091142;36565.45151822671;37542.43686344762;37564;48822;49485.75257123692;49558.50441495539;49781;49972.25041624451;7570.507916985378;7604.467687261838;7674.270944260286;7773.261540153676;7816.452848300564;11200;11816.113791465847;11933.105017123577;12026;12121.636350909486;10079.748006299902;10323.63867264642;10447.477626118512;10561.10230630405;10720.946395268285;10062.295639305179;10112.089911907964;10140.594376224868;10147.898521014695;10280.17758579297;10103.191744660262;10326.432046237529;10451.477426128815;10526.105281051196;10784.137269018616;7023.894641580483;7327.34053935127;7401.8149546261775;7563.432742544442;7830.060392752906;9982.650607228712;10343;10374.221933354878;10586.523606437882;10930.726731831768 12:50:57 INFO - PROCESS | 11776 | |3;mootools.html;1336.1381908668907;1379.1656048090904;1446.247951065446;1661.8338166183376;1696.9490915272547;6673.799786006415;7290.854182916339;7516.962415187916;7889.526628402293;7891.487053341536;7650.732224372148;7779.8833017504785;7877.881831772528;7880.251376119274;7880.566568838712;2155.2564365293947;2182.967255491169;2183.1376606240524;2183.661532462463;2189.748178959424;2155.267209148889;2172.283146561631;2179.4743679424387;2179.6294629912954;2186.9562608747815;2154.2244791874914;2158.179891641182;2158.417227348615;2160.621891169039;2206.1175529788134;2139.711138996239;2145.034734369532;2145.914163433461;2147.2162660628837;2150.2474134052954;2058.043010000357;2088.2169186555043;2121.4378189779723;2130.1905275995177;2131.818795402393;7604.0875094988405;7767.262110099531;7768.41736869737;7781.494202876852;7852.803679907991;4398.846040388571;4515.932261016087;4518.322251662277;4529.773511324421;4545.295479200696;2812.676542197653;2837.985810070957;2849.8147620404816;2862.5133727266416;2888.566714992768;889.9777505562348;945.8770359853244;948.4072454715803;953.1088432315738;962.259060523393;10475.371477711438;10490.108340791043;10518.368897866076;10550.472476376228;10610.946945265301;3776.546814382292;3955.4660120883887;4094.713370064067;4103.742941382227;4120.361343991686;8968.417052891542;8968.417052891542;8990.415622984485;9004.36969412135;9037.864432033524;4488.798004089824;4499.302608095751;4519.81920723174;4523.389342438794;4553.157665831832;3600.6399360063783;3883.514560679915;4006.4991876015497;4155.148194620096;4157.459530261047;3526.9647303526635;3610.368185567515;3633.5821380541047;3653.5433070866143;3696;1180.1208099965581;1180.1738782852037;1186.549111337686;1192.7375977284983;1197.862245841722;761.588742079282;773.7175930785336;787.4487858499074;787.7321710618418;795.6260557537948;4790.976045119752;4813.860080330913;4827.324174615556;4964.453910069889;5034.270030845507;402.92747305485295;403.12924083978464;404.61763633366775;406.45129075748093;410.16122030447804;3260.5761251037216;3283.212029112996;3297.225152089257;3314.486254630536;3348.1462227131924;8605.569721513899;8758.255548278468;8895.510746908982;8978.46129232235;9070.86393704095;8930.240929521064;8987.77530561728;9007.684731034382;9008.684696035607;9008.864867027;6856.9314306856295;6873.1064961554675;7000.544964577286;7009.264027277266;7013.123359580052;4692.131955588091;4844.61243100544;4857.538533839421;4878.390201224847;4900.019996000886;8380.539070350946;8383.28742056932;8431.451955622864;8504.829903402022;8516.233538981522;8443.493390396596;8467.11095334981;8564.52895090776;8620.827583448421;8641.395102342776;6083.69581520931;6483.4164925156965;6545.312742162195;6618.271990080991;6762.256151823394;7550.056242969629;7567.167611562833;7577.5453472791805;7614.657340419583;7634.847303054019;6699.43054840344;6775;6775.93224067753;6804.829879253059;6952.339527744856;6508.967455162694;6548.705308261045;6630.071789949315;6754.831129221809;6793.388595026471;5712.514436272963;5785.537157027344;5798.536117110705;5800.042992906123;5815.447532484407;4313.223619748475;4333.523312435566;4353.717008394444;4401.339799030171;4414.006848459071;4209.389638502461;4229.344451610005;4312.813976156582;4433.512313645432;4439.156560253541 12:50:57 INFO - PROCESS | 11776 | |4;prototype.html;283.49820817153636;289.5627602320495;290.1108103662275;298.36448364982584;304.21360782377553;4892.119418504668;4928.408590969088;4935.901281974358;4939.58013568847;4940.419065898918;4802.847316644006;4853.441854186761;4857.708537487753;4878.756062196885;4891.633127515442;3633.200695846916;3756.361418558838;3845.2309538092354;3850.5571859236125;3851.4030325299623;3822.6750726188307;3832.386818109103;3834.5015148030857;3853.6724378427725;3874.1864208516245;3848.4804551385487;3868.613138686137;3874.341361968458;3876.573576906538;3893.8247778849877;3794.742980174026;3795.430685397185;3816.9618303816883;3846.788426636534;3863.594322596115;3375.780574262665;3376.7298616110897;3385.0860267727576;3401.812900290483;3402.3195360927666;4768.402585133984;4773.188557945123;4773.546513081252;4796.688215265996;4801.207800712878;4339.891502712426;4343.9348409773875;4353.455818022747;4419.491758447755;4430.556944305544;4944.728039957837;5062.82280120194;5074.517920797518;5090.389153301628;5153.2785410042625;3696.039029852258;3699.5375578052744;3708.7033037356946;3717.3866312058476;3723.7843483127494;5360;5365.490278423583;5372.77030032536;5386.165144402624;5401.810936617199;3661.4507823826107;3772.2266935278203;3783.356829339019;3794.3928971365003;3794.9886560123177;3840.6735427488975;3842.9231415371537;3845.692344612424;3848.615138486129;3849.2493963676816;4368.36658684489;4384.377780221338;4396.1647287016;4400.44994375703;4401;4951.907726692256;5121.769520371592;5141.151709967889;5149.562287205629;5155.871103222375;1319.8746119118669;1339.9598012059653;1342.5032737887045;1344.9798253026213;1346.9730605387838;837.8049510283097;864.9264812490883;868.6438560190292;880.2693764175718;882.8455020371409;4393.868183954486;4407.449068866392;4543.863684089482;4545.2954792007295;4557.5442455754155;5257.947420525822;5267.868303292448;5271.710055946883;5272.894542109137;5288.233206185082;4536.253542386139;4544.636429085731;4549.658775591844;4552.658550608718;4558.612517935946;2662.933426664349;2810.353618667718;2831.3912508810704;2834.4472827798795;2835.503786837295;5027.698338099725;5029.823956161516;5034.295198672189;5041.59667226621;5058.848234552969;5195.7142357170715;5401.864953376118;5402.675839449567;5407.432219616962;5417.404085550586;5014.824481143142;5025.346704928336;5045.495450454925;5049.772760225872;5056.721880296545;5372.167314066326;5381.19282107687;5386.649867758583;5392.649477783932;5401.864953376197;5101.362329708786;5134.948650513447;5210.97394513025;5240.737963101906;5245.291885595396;4944.554990050912;5016;5020.47285035066;5020.698758074527;5036.748162591929;3613.277344531157;3640.0899775056237;3660.432632941898;3679.632036796299;3684.299983003221;5136.228001339532;5273.604479664117;5318.388385335581;5331.600129990189;5349.438308977501;5161.329027226587;5165.870853228549;5172.9741351293005;5175.611829112756;5175.844724658115;5160.587153027824;5173.3533308336455;5173.974130129325;5184.922226166535;5214.165733482625;4950.4059512858685;5119.48805119485;5119.718415487035;5126.359205099363;5156.123459011902;4970.950290497049;5019.598432125348;5128.307678463509;5217.791288348423;5222.190560463135;5010.69935803853;5023.095842748195;5027.7234752087525;5095.528668595654;5116.334876466036 12:50:57 INFO - PROCESS | 11776 | |5;yui.html;555.53057666272;562.1062510608132;567.5005994724642;592.0432969037332;600.3996003996002;10210.897891021088;10550.99999999999;10767.892321076786;11363.261388009774;11452.141089418285;11168.050715689176;11248.212625116244;11252.662420127388;11267.4366281686;11272.661820145388;610.1579819848603;726.789231122975;747.331138630925;749.108560812634;750.6847124207818;717.921028686844;732.9450291228153;740.8999785029006;742.4580056558689;742.9962850185741;782.1669921533577;786.5516655506364;788.4480863395618;788.8856115863197;795.8885755994165;785.2461636828594;785.6857257097149;788.5662885413028;794.7417089445953;795.1889073145388;576.4725276372114;577.9566532510037;579.0156733552935;579.111064515966;581.2095550051926;11950;11992.70018249542;12013.63959081229;12015.21901076436;12019.038476921825;12518.74962500754;12617.936910315482;12846;13318.334083295893;13611.387487562984;10212.336198147097;10285.331453455576;10421.478926053667;10504.36973781568;10554.419506927115;2963.7777166712367;2990.9102726918227;2992.356643321696;3020.5620185073262;3026.879162702191;66211.337886621;67688.32311676869;68037.65981170062;68436;69477.30522694759;8826.470411775314;8933.19601235892;9218.907810921804;9542.761430964281;9563.378380405251;18994.62010759777;19039.143238554298;19111.617767644846;19164.90417547931;19191.136398862083;6179.969100154471;6337.04944258365;6666.466682665375;6748.392644661906;6814.48891333152;3136.9961612284305;3168.58808354917;3180.189051791778;3209.5988001499813;3223.774335796472;2876.2090425132837;3050.633923929143;3214.4053350129834;3217.7104060634656;3243.1243564237525;535.3709391465013;545.4654438650145;546.4071482441595;546.9453054694578;549.6262541471838;542.3654324440336;548.6488647265753;572.5505478199593;594.4323171371417;595.9642421454727;7103.822404439827;7366.484346095722;7376.7418140364825;7423.62881855905;7670.42471814605;528.8730704630938;530.5516838271654;531.0785786660142;536.2546060975247;536.4260241541513;3422.589289285252;3493.63316851732;3632.4369722693023;3656.213914008448;3658.487811706363;87306;98681;100000;100884.49557752164;102975;86251;87847;89401.55299223462;89530.55234723784;90003;76953;77198;78059.60970195112;79269.20730792734;83019;7088.397486213729;7714.305712485679;7887.44787864844;7980.12218655959;8056.798580035546;39455.2108957825;40595.79702101589;40757.18485630211;41661.58338416698;41997.580024199364;59086;59450.405495946216;60655;61028.694856525435;61149.38850611615;10083.14293285079;10334.741631459274;10369.9481502592;10398.168146548409;10429.12275790365;11011.2650266698;11016.834747478633;11148.944255278997;11212.49543770516;11280.7743845121;10524.263301568817;10650.176327422701;10726.624568140078;10733.087687546646;11150.944245278723;9691.418514889128;9785.461799601091;9899.356541824758;10286.639967601099;10882;9767.462789546358;10216.846747298945;10356.948215258875;10459.424731639832;10675.519601618102;8024.879626805719;8561.101084386299;8618.612162452579;8655.740327790176;8980.46117232968;8961.551922403984;9011.279097672039;9112.635494580143;9235.953820230856;9246.907530924605 12:50:57 INFO - PROCESS | 11776 | __end_tp_report 12:50:57 INFO - PROCESS | 11776 | __start_cc_report 12:50:57 INFO - PROCESS | 11776 | _x_x_mozilla_cycle_collect,381 12:50:57 INFO - PROCESS | 11776 | __end_cc_report 12:50:57 INFO - PROCESS | 11776 | __startTimestamp1472500257483__endTimestamp 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | ------- Summary: start ------- 12:50:57 INFO - PROCESS | 11776 | Number of tests: 6 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | [#0] dojo.html Cycles:165 Average:4673.66 Median:4769.05 stddev:487.91 (10.2%) stddev-sans-first:461.62 12:50:57 INFO - PROCESS | 11776 | Values: 2604.8 2623.7 2635.1 2660.2 2668.7 4702.4 4714.9 4734.0 4737.8 4745.7 4613.5 4696.6 4708.6 4727.2 4742.0 4330.5 4366.3 4379.3 4428.8 4479.6 4125.8 4435.9 4444.0 4448.7 4454.4 4228.2 4277.4 4290.5 4346.3 4364.8 4295.1 4308.0 4309.0 4310.1 4374.5 4293.2 4328.6 4343.3 4369.5 4383.6 4661.0 4669.3 4715.8 4720.7 4760.7 5058.2 5068.1 5069.6 5070.6 5099.8 5059.9 5063.4 5071.6 5086.4 5112.8 4645.6 4685.1 4689.0 4743.3 4751.7 5172.6 5210.2 5216.6 5216.7 5265.1 4997.1 5000.2 5031.7 5034.1 5067.0 4888.1 4946.4 4983.8 4984.6 5078.4 4940.4 4944.8 4945.1 4960.3 4970.1 4916.7 4941.7 4943.3 4974.9 4990.6 4172.4 4270.2 4293.6 4298.2 4300.7 3730.8 3734.4 3739.0 3770.1 3802.2 4377.7 4387.5 4397.1 4436.7 4444.9 4940.1 4989.3 5024.4 5051.4 5068.4 4377.6 4379.2 4379.6 4409.6 4416.8 4558.9 4585.2 4587.7 4587.9 4630.7 4695.7 4743.5 4766.7 4768.4 4792.4 5040.1 5079.3 5082.9 5084.2 5114.8 4750.8 4769.0 4778.6 4782.3 4825.7 4866.2 4902.9 4911.7 4970.4 5070.8 5071.9 5087.2 5109.7 5120.4 5196.4 4960.3 4962.6 4971.0 4971.7 5032.8 4748.7 4942.0 4960.3 4961.3 5027.2 4828.9 4841.0 4862.8 4866.1 4926.3 4970.6 4981.4 4983.0 4984.2 5041.8 4762.8 4860.3 4877.8 4898.6 4952.1 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | [#1] ext.html Cycles:180 Average:42682.61 Median:363232.00 stddev:76897.94 (21.2%) stddev-sans-first:77048.59 12:50:57 INFO - PROCESS | 11776 | Values: 548.7 549.5 562.3 566.0 577.6 36701.3 38261.0 38276.2 38303.4 38349.2 37991.0 38621.4 38650.0 38663.2 38719.0 7467.9 7583.4 7632.2 7637.4 7641.4 7552.4 7616.0 7635.5 7657.9 7675.9 7606.1 7622.4 7628.7 7639.8 7653.4 7553.9 7636.4 7640.0 7667.9 7680.7 7519.6 7568.8 7578.5 7581.4 7605.6 34727.0 35038.8 35111.3 35197.5 35261.6 2809.4 2914.3 2979.8 3217.2 3468.8 27602.6 27759.6 28127.4 28291.5 28352.0 3122.1 3167.2 3208.4 3313.9 3321.6 173009.0 173223.0 175210.0 175528.0 176405.0 30208.2 48634.8 48867.0 49074.8 49243.0 30726.4 32390.0 32412.0 32506.0 32559.7 12036.7 12089.7 12103.9 12116.1 12164.9 10063.1 10144.2 10159.0 10161.6 10169.4 7588.4 7628.6 7671.9 7712.3 7719.4 2992.9 2998.8 3039.7 3046.4 3081.6 841.8 854.6 908.0 949.3 971.4 26947.2 27457.5 27531.6 27713.9 28157.9 950.7 959.8 961.4 971.6 988.7 13985.4 14736.5 14975.3 15046.2 15112.1 357894.0 363052.0 363412.0 363521.0 364377.0 47089.0 47250.3 47501.5 47786.8 47861.8 1167.5 1171.4 1181.6 1192.4 1208.7 25297.2 26116.2 26690.8 26980.7 27313.9 40201.4 40478.2 40504.0 40548.6 40571.6 302356.0 302757.0 304609.0 305281.0 306040.2 24005.3 24536.1 24555.1 24555.5 24564.5 41039.8 44023.8 44648.6 45256.0 48837.3 34300.7 34879.7 35888.6 37196.3 37266.3 36672.3 36954.4 37783.8 37930.8 38807.8 36650.0 37137.3 37276.3 37324.3 37826.2 31616.4 34146.4 34630.8 34669.3 34778.3 26501.3 26536.5 26705.6 26809.9 26825.5 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | [#2] jquery.html Cycles:180 Average:23058.86 Median:4561.85 stddev:61051.25 (1338.3%) stddev-sans-first:61198.69 12:50:57 INFO - PROCESS | 11776 | Values: 342.5 354.7 356.1 363.9 364.6 15393.3 15746.2 17046.7 17113.7 17202.0 13183.1 16018.8 16606.1 16635.5 16716.8 4669.2 5095.3 5122.1 5124.0 5128.6 4947.2 5060.5 5080.8 5116.9 5118.1 4722.2 4745.1 4772.0 4777.9 4939.1 4598.7 4716.5 4735.8 4761.0 4771.5 4434.4 4550.1 4573.6 4592.6 4601.7 12016.6 12262.1 12305.8 12308.9 18174.4 1771.2 1803.8 1809.1 1815.6 1833.8 8758.6 8772.8 8908.0 8935.8 9036.2 1650.6 1697.7 1700.0 1825.5 1826.0 64301.7 66171.0 66824.7 68100.3 69021.3 9094.7 9527.4 9717.4 9800.6 9912.9 12825.9 13376.4 13382.9 13458.7 13490.6 6697.4 6703.6 6725.2 6872.2 7000.7 6352.6 6416.8 6534.2 6544.9 6586.3 4026.5 4129.2 4211.4 4225.9 4260.3 1796.4 1852.5 1858.5 1881.5 1888.1 774.6 810.5 868.4 898.6 907.7 16430.3 16655.8 16901.4 16952.7 17558.2 832.9 844.9 849.4 852.4 883.4 8626.2 9605.8 9647.6 9801.0 9837.8 350098.0 359476.0 378324.0 379446.0 379654.0 49605.8 73917.6 74927.6 77067.2 79021.6 888.7 896.1 912.0 926.4 927.4 12969.7 14776.2 15028.7 15051.8 15720.4 33715.0 36463.8 36565.5 37542.4 37564.0 48822.0 49485.8 49558.5 49781.0 49972.3 7570.5 7604.5 7674.3 7773.3 7816.5 11200.0 11816.1 11933.1 12026.0 12121.6 10079.7 10323.6 10447.5 10561.1 10720.9 10062.3 10112.1 10140.6 10147.9 10280.2 10103.2 10326.4 10451.5 10526.1 10784.1 7023.9 7327.3 7401.8 7563.4 7830.1 9982.7 10343.0 10374.2 10586.5 10930.7 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | [#3] mootools.html Cycles:180 Average:4956.07 Median:4741.55 stddev:2789.13 (58.8%) stddev-sans-first:2783.69 12:50:57 INFO - PROCESS | 11776 | Values: 1336.1 1379.2 1446.2 1661.8 1696.9 6673.8 7290.9 7517.0 7889.5 7891.5 7650.7 7779.9 7877.9 7880.3 7880.6 2155.3 2183.0 2183.1 2183.7 2189.7 2155.3 2172.3 2179.5 2179.6 2187.0 2154.2 2158.2 2158.4 2160.6 2206.1 2139.7 2145.0 2145.9 2147.2 2150.2 2058.0 2088.2 2121.4 2130.2 2131.8 7604.1 7767.3 7768.4 7781.5 7852.8 4398.8 4515.9 4518.3 4529.8 4545.3 2812.7 2838.0 2849.8 2862.5 2888.6 890.0 945.9 948.4 953.1 962.3 10475.4 10490.1 10518.4 10550.5 10610.9 3776.5 3955.5 4094.7 4103.7 4120.4 8968.4 8968.4 8990.4 9004.4 9037.9 4488.8 4499.3 4519.8 4523.4 4553.2 3600.6 3883.5 4006.5 4155.1 4157.5 3527.0 3610.4 3633.6 3653.5 3696.0 1180.1 1180.2 1186.5 1192.7 1197.9 761.6 773.7 787.4 787.7 795.6 4791.0 4813.9 4827.3 4964.5 5034.3 402.9 403.1 404.6 406.5 410.2 3260.6 3283.2 3297.2 3314.5 3348.1 8605.6 8758.3 8895.5 8978.5 9070.9 8930.2 8987.8 9007.7 9008.7 9008.9 6856.9 6873.1 7000.5 7009.3 7013.1 4692.1 4844.6 4857.5 4878.4 4900.0 8380.5 8383.3 8431.5 8504.8 8516.2 8443.5 8467.1 8564.5 8620.8 8641.4 6083.7 6483.4 6545.3 6618.3 6762.3 7550.1 7567.2 7577.5 7614.7 7634.8 6699.4 6775.0 6775.9 6804.8 6952.3 6509.0 6548.7 6630.1 6754.8 6793.4 5712.5 5785.5 5798.5 5800.0 5815.4 4313.2 4333.5 4353.7 4401.3 4414.0 4209.4 4229.3 4312.8 4433.5 4439.2 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | [#4] prototype.html Cycles:180 Average:4280.23 Median:4910.26 stddev:1243.33 (25.3%) stddev-sans-first:1210.09 12:50:57 INFO - PROCESS | 11776 | Values: 283.5 289.6 290.1 298.4 304.2 4892.1 4928.4 4935.9 4939.6 4940.4 4802.8 4853.4 4857.7 4878.8 4891.6 3633.2 3756.4 3845.2 3850.6 3851.4 3822.7 3832.4 3834.5 3853.7 3874.2 3848.5 3868.6 3874.3 3876.6 3893.8 3794.7 3795.4 3817.0 3846.8 3863.6 3375.8 3376.7 3385.1 3401.8 3402.3 4768.4 4773.2 4773.5 4796.7 4801.2 4339.9 4343.9 4353.5 4419.5 4430.6 4944.7 5062.8 5074.5 5090.4 5153.3 3696.0 3699.5 3708.7 3717.4 3723.8 5360.0 5365.5 5372.8 5386.2 5401.8 3661.5 3772.2 3783.4 3794.4 3795.0 3840.7 3842.9 3845.7 3848.6 3849.2 4368.4 4384.4 4396.2 4400.4 4401.0 4951.9 5121.8 5141.2 5149.6 5155.9 1319.9 1340.0 1342.5 1345.0 1347.0 837.8 864.9 868.6 880.3 882.8 4393.9 4407.4 4543.9 4545.3 4557.5 5257.9 5267.9 5271.7 5272.9 5288.2 4536.3 4544.6 4549.7 4552.7 4558.6 2662.9 2810.4 2831.4 2834.4 2835.5 5027.7 5029.8 5034.3 5041.6 5058.8 5195.7 5401.9 5402.7 5407.4 5417.4 5014.8 5025.3 5045.5 5049.8 5056.7 5372.2 5381.2 5386.6 5392.6 5401.9 5101.4 5134.9 5211.0 5240.7 5245.3 4944.6 5016.0 5020.5 5020.7 5036.7 3613.3 3640.1 3660.4 3679.6 3684.3 5136.2 5273.6 5318.4 5331.6 5349.4 5161.3 5165.9 5173.0 5175.6 5175.8 5160.6 5173.4 5174.0 5184.9 5214.2 4950.4 5119.5 5119.7 5126.4 5156.1 4971.0 5019.6 5128.3 5217.8 5222.2 5010.7 5023.1 5027.7 5095.5 5116.3 12:50:57 INFO - PROCESS | 11776 | 12:50:57 INFO - PROCESS | 11776 | [#5] yui.html Cycles:180 Average:17530.81 Median:552.58 stddev:26216.43 (4744.4%) stddev-sans-first:26258.99 12:50:57 INFO - PROCESS | 11776 | Values: 555.5 562.1 567.5 592.0 600.4 10210.9 10551.0 10767.9 11363.3 11452.1 11168.1 11248.2 11252.7 11267.4 11272.7 610.2 726.8 747.3 749.1 750.7 717.9 732.9 740.9 742.5 743.0 782.2 786.6 788.4 788.9 795.9 785.2 785.7 788.6 794.7 795.2 576.5 578.0 579.0 579.1 581.2 11950.0 11992.7 12013.6 12015.2 12019.0 12518.7 12617.9 12846.0 13318.3 13611.4 10212.3 10285.3 10421.5 10504.4 10554.4 2963.8 2990.9 2992.4 3020.6 3026.9 66211.3 67688.3 68037.7 68436.0 69477.3 8826.5 8933.2 9218.9 9542.8 9563.4 18994.6 19039.1 19111.6 19164.9 19191.1 6180.0 6337.0 6666.5 6748.4 6814.5 3137.0 3168.6 3180.2 3209.6 3223.8 2876.2 3050.6 3214.4 3217.7 3243.1 535.4 545.5 546.4 546.9 549.6 542.4 548.6 572.6 594.4 596.0 7103.8 7366.5 7376.7 7423.6 7670.4 528.9 530.6 531.1 536.3 536.4 3422.6 3493.6 3632.4 3656.2 3658.5 87306.0 98681.0 100000.0 100884.5 102975.0 86251.0 87847.0 89401.6 89530.6 90003.0 76953.0 77198.0 78059.6 79269.2 83019.0 7088.4 7714.3 7887.4 7980.1 8056.8 39455.2 40595.8 40757.2 41661.6 41997.6 59086.0 59450.4 60655.0 61028.7 61149.4 10083.1 10334.7 10369.9 10398.2 10429.1 11011.3 11016.8 11148.9 11212.5 11280.8 10524.3 10650.2 10726.6 10733.1 11150.9 9691.4 9785.5 9899.4 10286.6 10882.0 9767.5 10216.8 10356.9 10459.4 10675.5 8024.9 8561.1 8618.6 8655.7 8980.5 8961.6 9011.3 9112.6 9236.0 9246.9 12:50:57 INFO - PROCESS | 11776 | -------- Summary: end -------- 12:50:57 INFO - PROCESS | 11776 | 12:50:58 INFO - TEST-INFO | 11776: exit 0 12:50:58 INFO - TEST-OK | dromaeo_css | took 1118108ms 12:50:58 INFO - TEST-START | kraken 12:50:58 INFO - operating with platform_type : linux_ 12:50:58 INFO - Initialising browser for kraken test... 12:50:58 INFO - TEST-INFO | started process 12132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrVJdB/profile http://localhost:32922/getInfo.html) 12:51:03 INFO - PROCESS | 12132 | __metrics Screen width/height:1600/1200 12:51:03 INFO - PROCESS | 12132 | colorDepth:24 12:51:03 INFO - PROCESS | 12132 | Browser inner width/height: 1024/697 12:51:03 INFO - PROCESS | 12132 | __metrics 12:51:04 ERROR - PROCESS | 12132 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:51:05 INFO - TEST-INFO | 12132: exit 0 12:51:05 INFO - Browser initialized. 12:51:05 INFO - Running cycle 1/1 for kraken test... 12:51:05 INFO - TEST-INFO | started process 12250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrVJdB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:17 INFO - PROCESS | 12250 | RSS: Main: 193376256 12:51:17 INFO - PROCESS | 12250 | 12:51:20 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32922/tests/kraken/driver.html?testName=audio-beat-detection) 12:51:21 INFO - PROCESS | 12250 | RSS: Main: 206401536 12:51:21 INFO - PROCESS | 12250 | 12:51:24 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32922/tests/kraken/driver.html?testName=audio-dft) 12:51:24 INFO - PROCESS | 12250 | RSS: Main: 205684736 12:51:24 INFO - PROCESS | 12250 | 12:51:27 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32922/tests/kraken/driver.html?testName=audio-fft) 12:51:28 INFO - PROCESS | 12250 | RSS: Main: 198995968 12:51:28 INFO - PROCESS | 12250 | 12:51:30 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32922/tests/kraken/driver.html?testName=audio-oscillator) 12:51:31 INFO - PROCESS | 12250 | RSS: Main: 199028736 12:51:31 INFO - PROCESS | 12250 | 12:51:33 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:51:34 INFO - PROCESS | 12250 | RSS: Main: 199352320 12:51:34 INFO - PROCESS | 12250 | 12:51:37 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32922/tests/kraken/driver.html?testName=imaging-darkroom) 12:51:37 INFO - PROCESS | 12250 | RSS: Main: 199626752 12:51:37 INFO - PROCESS | 12250 | 12:51:41 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32922/tests/kraken/driver.html?testName=imaging-desaturate) 12:51:42 INFO - PROCESS | 12250 | RSS: Main: 196960256 12:51:42 INFO - PROCESS | 12250 | 12:51:45 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32922/tests/kraken/driver.html?testName=json-parse-financial) 12:51:45 INFO - PROCESS | 12250 | RSS: Main: 198819840 12:51:45 INFO - PROCESS | 12250 | 12:51:47 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:51:48 INFO - PROCESS | 12250 | RSS: Main: 199094272 12:51:48 INFO - PROCESS | 12250 | 12:51:49 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:51:50 INFO - PROCESS | 12250 | RSS: Main: 199487488 12:51:50 INFO - PROCESS | 12250 | 12:51:52 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:51:53 INFO - PROCESS | 12250 | RSS: Main: 200101888 12:51:53 INFO - PROCESS | 12250 | 12:51:56 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:57 INFO - PROCESS | 12250 | RSS: Main: 199950336 12:51:57 INFO - PROCESS | 12250 | 12:51:59 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:52:00 INFO - PROCESS | 12250 | RSS: Main: 199819264 12:52:00 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | Cycle 1(1): loaded http://localhost:32922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32922/tests/kraken/driver.html?testName=ai-astar) 12:52:02 INFO - PROCESS | 12250 | RSS: Main: 202702848 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | __start_tp_report 12:52:02 INFO - PROCESS | 12250 | _x_x_mozilla_page_load 12:52:02 INFO - PROCESS | 12250 | _x_x_mozilla_page_load_details 12:52:02 INFO - PROCESS | 12250 | |i|pagename|runs| 12:52:02 INFO - PROCESS | 12250 | |0;ai-astar;109;115;115;116;114;116;115;116;115;132 12:52:02 INFO - PROCESS | 12250 | |1;audio-beat-detection;159;124;161;196;125;149;158;126;207;130 12:52:02 INFO - PROCESS | 12250 | |2;audio-dft;174;162;164;162;162;165;163;166;162;163 12:52:02 INFO - PROCESS | 12250 | |3;audio-fft;78;77;77;184;79;76;76;79;159;78 12:52:02 INFO - PROCESS | 12250 | |4;audio-oscillator;84;85;138;85;86;84;138;84;83;147 12:52:02 INFO - PROCESS | 12250 | |5;imaging-gaussian-blur;119;117;118;118;119;118;118;119;118;118 12:52:02 INFO - PROCESS | 12250 | |6;imaging-darkroom;148;148;150;147;147;149;147;147;147;148 12:52:02 INFO - PROCESS | 12250 | |7;imaging-desaturate;95;95;95;95;96;96;95;97;96;95 12:52:02 INFO - PROCESS | 12250 | |8;json-parse-financial;64;67;66;65;66;67;66;65;66;66 12:52:02 INFO - PROCESS | 12250 | |9;json-stringify-tinderbox;65;65;65;67;65;65;65;67;66;66 12:52:02 INFO - PROCESS | 12250 | |10;stanford-crypto-aes;90;89;83;82;83;84;84;89;87;82 12:52:02 INFO - PROCESS | 12250 | |11;stanford-crypto-ccm;135;152;132;137;138;142;137;151;174;135 12:52:02 INFO - PROCESS | 12250 | |12;stanford-crypto-pbkdf2;174;174;178;183;177;178;178;176;178;176 12:52:02 INFO - PROCESS | 12250 | |13;stanford-crypto-sha256-iterative;70;71;70;71;71;69;75;69;69;74 12:52:02 INFO - PROCESS | 12250 | __end_tp_report 12:52:02 INFO - PROCESS | 12250 | __start_cc_report 12:52:02 INFO - PROCESS | 12250 | _x_x_mozilla_cycle_collect,895 12:52:02 INFO - PROCESS | 12250 | __end_cc_report 12:52:02 INFO - PROCESS | 12250 | __startTimestamp1472500322681__endTimestamp 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | ------- Summary: start ------- 12:52:02 INFO - PROCESS | 12250 | Number of tests: 14 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.50 stddev:5.89 (5.1%) stddev-sans-first:5.62 12:52:02 INFO - PROCESS | 12250 | Values: 109.0 115.0 115.0 116.0 114.0 116.0 115.0 116.0 115.0 132.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:158.50 stddev:29.41 (18.6%) stddev-sans-first:31.13 12:52:02 INFO - PROCESS | 12250 | Values: 159.0 124.0 161.0 196.0 125.0 149.0 158.0 126.0 207.0 130.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.68 (2.3%) stddev-sans-first:1.48 12:52:02 INFO - PROCESS | 12250 | Values: 174.0 162.0 164.0 162.0 162.0 165.0 163.0 166.0 162.0 163.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#3] audio-fft Cycles:10 Average:96.30 Median:77.50 stddev:40.08 (51.7%) stddev-sans-first:41.96 12:52:02 INFO - PROCESS | 12250 | Values: 78.0 77.0 77.0 184.0 79.0 76.0 76.0 79.0 159.0 78.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:84.00 stddev:27.45 (32.7%) stddev-sans-first:28.38 12:52:02 INFO - PROCESS | 12250 | Values: 84.0 85.0 138.0 85.0 86.0 84.0 138.0 84.0 83.0 147.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 12:52:02 INFO - PROCESS | 12250 | Values: 119.0 117.0 118.0 118.0 119.0 118.0 118.0 119.0 118.0 118.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 12:52:02 INFO - PROCESS | 12250 | Values: 148.0 148.0 150.0 147.0 147.0 149.0 147.0 147.0 147.0 148.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 12:52:02 INFO - PROCESS | 12250 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 97.0 96.0 95.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 12:52:02 INFO - PROCESS | 12250 | Values: 64.0 67.0 66.0 65.0 66.0 67.0 66.0 65.0 66.0 66.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 12:52:02 INFO - PROCESS | 12250 | Values: 65.0 65.0 65.0 67.0 65.0 65.0 65.0 67.0 66.0 66.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:3.13 (3.7%) stddev-sans-first:2.82 12:52:02 INFO - PROCESS | 12250 | Values: 90.0 89.0 83.0 82.0 83.0 84.0 84.0 89.0 87.0 82.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:140.00 stddev:12.70 (9.1%) stddev-sans-first:13.11 12:52:02 INFO - PROCESS | 12250 | Values: 135.0 152.0 132.0 137.0 138.0 142.0 137.0 151.0 174.0 135.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:178.00 stddev:2.57 (1.4%) stddev-sans-first:2.46 12:52:02 INFO - PROCESS | 12250 | Values: 174.0 174.0 178.0 183.0 177.0 178.0 178.0 176.0 178.0 176.0 12:52:02 INFO - PROCESS | 12250 | 12:52:02 INFO - PROCESS | 12250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:2.08 (2.9%) stddev-sans-first:2.18 12:52:02 INFO - PROCESS | 12250 | Values: 70.0 71.0 70.0 71.0 71.0 69.0 75.0 69.0 69.0 74.0 12:52:02 INFO - PROCESS | 12250 | -------- Summary: end -------- 12:52:02 INFO - PROCESS | 12250 | 12:52:03 INFO - TEST-INFO | 12250: exit 0 12:52:03 INFO - TEST-OK | kraken | took 65400ms 12:52:03 INFO - SUITE-END | took 1183s 12:52:04 INFO - Completed test suite (00:19:43) 12:52:04 INFO - javascript benchmark 12:52:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6159.083053931656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.8046396520267, 2623.6720409948757, 2635.051381502659, 2660.2285337252197, 2668.6797584289875, 4702.435707715071, 4714.882127946798, 4733.952660473395, 4737.834175803848, 4745.691530050544, 4613.538646135385, 4696.577308042276, 4708.599769019637, 4727.243641017438, 4741.976290118545, 4330.523642399334, 4366.323219900921, 4379.343098535213, 4428.756418396987, 4479.596836284733, 4125.793710314488, 4435.933460998088, 4444.022315090675, 4448.666350023745, 4454.443194600675, 4228.1966426379195, 4277.401163837066, 4290.485141782975, 4346.304591265382, 4364.825406983717, 4295.119500502389, 4308.0, 4308.9784551077355, 4310.116426132635, 4374.540673229297, 4293.205756934977, 4328.61042506176, 4343.261645520269, 4369.519352871182, 4383.561643835623, 4660.976695116537, 4669.276262179367, 4715.764211789431, 4720.693154944917, 4760.714357138583, 5058.215976523645, 5068.113080210986, 5069.594432445432, 5070.594352451795, 5099.750561112552, 5059.949400505985, 5063.367079115111, 5071.619628527875, 5086.440491545927, 5112.795488180468, 4645.581897629229, 4685.086408150446, 4688.976555117237, 4743.28850672395, 4751.691140075884, 5172.586193104543, 5210.166373380241, 5216.556592689664, 5216.66091704038, 5265.078611243017, 4997.125503036954, 5000.199968005102, 5031.6729412588065, 5034.093863104603, 5067.037262920034, 4888.071266459361, 4946.356973593482, 4983.775730092155, 4984.626153038536, 5078.415982162099, 4940.357753492023, 4944.752762361867, 4945.134601444733, 4960.255961605788, 4970.080535101018, 4916.655834091651, 4941.654084214142, 4943.258511223274, 4974.850754477371, 4990.5508504234795, 4172.353285240732, 4270.167317373144, 4293.635041021485, 4298.161858437637, 4300.698951073395, 3730.813459327023, 3734.3651579231596, 3739.0, 3770.132869440044, 3802.2015376770637, 4377.715448495837, 4387.517373088957, 4397.076613911115, 4436.689431739812, 4444.866654000385, 4940.061388336205, 4989.25161225819, 5024.422191447957, 5051.444341122474, 5068.4287870759445, 4377.584129507692, 4379.233634114017, 4379.627731642782, 4409.581089796464, 4416.779161041999, 4558.8632341029825, 4585.243434833282, 4587.678862479661, 4587.8623641290815, 4630.74530900797, 4695.718256904528, 4743.549362810528, 4766.666333356632, 4768.403949506312, 4792.376990991149, 5040.092783298895, 5079.339685840817, 5082.898342033212, 5084.161113416245, 5114.820981265638, 4750.8337208197545, 4769.046190761931, 4778.593819525379, 4782.258749893772, 4825.686330388514, 4866.172750632471, 4902.901941961212, 4911.7298548580175, 4970.428400733962, 5070.822521211888, 5071.898562028812, 5087.23691446286, 5109.74451277442, 5120.4111527174855, 5196.402413722471, 4960.30555722192, 4962.627802914723, 4970.950290497193, 4971.65198436106, 5032.84901452957, 4748.691335063209, 4942.0, 4960.305557222064, 4961.330220420341, 5027.195648696191, 4828.8792780180775, 4841.0, 4862.781174847069, 4866.05112003156, 4926.310316555613, 4970.552650261494, 4981.402231732215, 4983.0, 4984.177610694195, 5041.823536176216, 4762.809487620457, 4860.3195552621955, 4877.80488780459, 4898.583620392306, 4952.133376659142], "value": 4642.546955848917, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7338640759231, 549.5383877542864, 562.3364429972634, 566.0179588414102, 577.5783677915124, 36701.26597468049, 38261.0, 38276.23447531055, 38303.42544861829, 38349.233015339676, 37991.0, 38621.42067868984, 38650.0, 38663.22673546527, 38719.0, 7467.925320746777, 7583.355414789722, 7632.160462349138, 7637.350825179867, 7641.3504852087635, 7552.39580833532, 7616.0, 7635.541867487941, 7657.885131723028, 7675.923240767576, 7606.087269527665, 7622.352100071501, 7628.656710448043, 7639.770806875803, 7653.387728981668, 7553.924460755377, 7636.350910172642, 7640.0, 7667.923320766805, 7680.692772289101, 7519.586422746746, 7568.810779730551, 7578.507397019232, 7581.3934885209055, 7605.619719014027, 34727.0, 35038.824805876066, 35111.29777404463, 35197.472037919455, 35261.64738352609, 2809.3959798643186, 2914.2714321419644, 2979.7765167612297, 3217.1635374802486, 3468.757186996911, 27602.5859612106, 27759.583606245924, 28127.437451251066, 28291.453769160875, 28352.0, 3122.110198593413, 3167.192365946669, 3208.4064448076947, 3313.867445302185, 3321.6014078310513, 173009.0, 173223.0, 175210.0, 175528.0, 176404.99999999872, 30208.20315429011, 48634.75682621635, 48867.0, 49074.75462622664, 49243.0, 30726.38547229043, 32390.0, 32412.0, 32506.0, 32559.674403256136, 12036.699082523008, 12089.697757555956, 12103.910648041718, 12116.09129315305, 12164.939175304244, 10063.094321511098, 10144.239182061376, 10158.984101589782, 10161.644342447978, 10169.389836609827, 7588.354989825816, 7628.580428076398, 7671.923280767121, 7712.305892469592, 7719.421043421766, 2992.865321060514, 2998.775091868075, 3039.6656367799524, 3046.4059508396094, 3081.5839861618397, 841.8358420108143, 854.5513605357113, 907.9682211122711, 949.3022628368144, 971.3928794503436, 26947.191584252505, 27457.45085098287, 27531.587026194622, 27713.86143069272, 28157.859210704224, 950.6815216902277, 959.8128364968765, 961.4135377419768, 971.5870754929127, 988.7083310423442, 13985.440582376794, 14736.484223052355, 14975.32611032506, 15046.247687615576, 15112.09327440357, 357894.0, 363052.0, 363412.0, 363521.0, 364377.0, 47089.0, 47250.29124563134, 47501.52498474971, 47786.76106619445, 47861.76069119632, 1167.4571324334224, 1171.4494187731752, 1181.639599922032, 1192.350169157811, 1208.655533173059, 25297.241082767545, 26116.216513504627, 26690.798914048526, 26980.730192698607, 27313.86343068272, 40201.39697904475, 40478.190436190525, 40504.0, 40548.594514055665, 40571.59428405796, 302356.0, 302757.0, 304609.0, 305281.0, 306040.1677907737, 24005.27984160478, 24536.141235056686, 24555.140570079962, 24555.508889821747, 24564.508709825346, 41039.794801027, 44023.77988110039, 44648.55351446444, 45256.0, 48837.267440989126, 34300.656993429744, 34879.65120348764, 35888.641113589576, 37196.25607487781, 37266.25467490689, 36672.266554668226, 36954.44568331423, 37783.81108094442, 37930.8103459492, 38807.805960970014, 36650.0, 37137.25725485529, 37276.25447490981, 37324.25351493009, 37826.24347512979, 31616.367672646877, 34146.41449174071, 34630.82684586561, 34669.30661386708, 34778.30443391067, 26501.33746656349, 26536.469270614867, 26705.599416008386, 26809.9168595614, 26825.463490729686], "value": 15893.988851210705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5119205132687, 354.68610279902293, 356.099069354533, 363.94358874374484, 364.61897317303414, 15393.307301171446, 15746.21268936553, 17046.744298835496, 17113.68965189699, 17202.0, 13183.077184597081, 16018.83981160188, 16606.086665233437, 16635.50093497194, 16716.83283167168, 4669.2062349400685, 5095.261187127864, 5122.052420302256, 5124.026434977342, 5128.640995130342, 4947.183714687072, 5060.4686507916695, 5080.847574572768, 5116.923246151311, 5118.104331741949, 4722.150012997659, 4745.050989802036, 4772.04559088182, 4777.928331075037, 4939.086269040239, 4598.747068911209, 4716.514297996155, 4735.810567577293, 4761.000189960113, 4771.498992605779, 4434.401355816955, 4550.067236216601, 4573.634109271284, 4592.609628181609, 4601.746903920283, 12016.63950081499, 12262.141650084497, 12305.815412768816, 12308.876911230953, 18174.36389726353, 1771.2472199315368, 1803.7835459744783, 1809.1496996411797, 1815.6187200687739, 1833.8257865502756, 8758.56207189638, 8772.824543509158, 8908.0, 8935.821283574358, 9036.231920286784, 1650.645111301064, 1697.6944150052987, 1700.013991884704, 1825.543614096476, 1825.9609206508983, 64301.67849160771, 66171.0, 66824.6658766703, 68100.31899680989, 69021.30978690198, 9094.681686140953, 9527.38072025316, 9717.416954982582, 9800.598853280992, 9912.900870991341, 12825.871741282654, 13376.39806208723, 13382.933085334706, 13458.730825383438, 13490.595282141552, 6697.430718388894, 6703.597784132968, 6725.226598941086, 6872.244053154149, 7000.684969176297, 6352.618842869442, 6416.839579010562, 6534.215894092644, 6544.901826472512, 6586.27550969393, 4026.4564283821896, 4129.174165166979, 4211.43145675336, 4225.929294645663, 4260.339647354665, 1796.3622913865652, 1852.4998250472297, 1858.5446565591517, 1881.5484283771796, 1888.1314595286321, 774.5662429039643, 810.4974915552395, 868.3617541107282, 898.5597057441937, 907.6505545365083, 16430.260638271306, 16655.83344166567, 16901.408450704166, 16952.74570881438, 17558.209880555405, 832.8667413213857, 844.932405407566, 849.3502470609989, 852.3607294529103, 883.3639779358851, 8626.223639872442, 9605.759856003655, 9647.565859536338, 9800.970898055744, 9837.754056148653, 350098.0, 359476.0, 378324.0, 379446.0, 379654.0, 49605.751971239915, 73917.6304118476, 74927.62536187284, 77067.22932770601, 79021.60489197518, 888.693400776731, 896.1173244354305, 912.0423555267075, 926.379325851681, 927.4435338796668, 12969.675758105745, 14776.187309698069, 15028.699426011637, 15051.849481505045, 15720.371185152922, 33715.0, 36463.81768091142, 36565.45151822671, 37542.43686344762, 37564.0, 48822.0, 49485.75257123692, 49558.50441495539, 49781.0, 49972.25041624451, 7570.507916985378, 7604.467687261838, 7674.270944260286, 7773.261540153676, 7816.452848300564, 11200.0, 11816.113791465847, 11933.105017123577, 12026.0, 12121.636350909486, 10079.748006299902, 10323.63867264642, 10447.477626118512, 10561.10230630405, 10720.946395268285, 10062.295639305179, 10112.089911907964, 10140.594376224868, 10147.898521014695, 10280.17758579297, 10103.191744660262, 10326.432046237529, 10451.477426128815, 10526.105281051196, 10784.137269018616, 7023.894641580483, 7327.34053935127, 7401.8149546261775, 7563.432742544442, 7830.060392752906, 9982.650607228712, 10343.0, 10374.221933354878, 10586.523606437882, 10930.726731831768], "value": 7835.985490279625, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.1381908668907, 1379.1656048090904, 1446.247951065446, 1661.8338166183376, 1696.9490915272547, 6673.799786006415, 7290.854182916339, 7516.962415187916, 7889.526628402293, 7891.487053341536, 7650.732224372148, 7779.8833017504785, 7877.881831772528, 7880.251376119274, 7880.566568838712, 2155.2564365293947, 2182.967255491169, 2183.1376606240524, 2183.661532462463, 2189.748178959424, 2155.267209148889, 2172.283146561631, 2179.4743679424387, 2179.6294629912954, 2186.9562608747815, 2154.2244791874914, 2158.179891641182, 2158.417227348615, 2160.621891169039, 2206.1175529788134, 2139.711138996239, 2145.034734369532, 2145.914163433461, 2147.2162660628837, 2150.2474134052954, 2058.043010000357, 2088.2169186555043, 2121.4378189779723, 2130.1905275995177, 2131.818795402393, 7604.0875094988405, 7767.262110099531, 7768.41736869737, 7781.494202876852, 7852.803679907991, 4398.846040388571, 4515.932261016087, 4518.322251662277, 4529.773511324421, 4545.295479200696, 2812.676542197653, 2837.985810070957, 2849.8147620404816, 2862.5133727266416, 2888.566714992768, 889.9777505562348, 945.8770359853244, 948.4072454715803, 953.1088432315738, 962.259060523393, 10475.371477711438, 10490.108340791043, 10518.368897866076, 10550.472476376228, 10610.946945265301, 3776.546814382292, 3955.4660120883887, 4094.713370064067, 4103.742941382227, 4120.361343991686, 8968.417052891542, 8968.417052891542, 8990.415622984485, 9004.36969412135, 9037.864432033524, 4488.798004089824, 4499.302608095751, 4519.81920723174, 4523.389342438794, 4553.157665831832, 3600.6399360063783, 3883.514560679915, 4006.4991876015497, 4155.148194620096, 4157.459530261047, 3526.9647303526635, 3610.368185567515, 3633.5821380541047, 3653.5433070866143, 3696.0, 1180.1208099965581, 1180.1738782852037, 1186.549111337686, 1192.7375977284983, 1197.862245841722, 761.588742079282, 773.7175930785336, 787.4487858499074, 787.7321710618418, 795.6260557537948, 4790.976045119752, 4813.860080330913, 4827.324174615556, 4964.453910069889, 5034.270030845507, 402.92747305485295, 403.12924083978464, 404.61763633366775, 406.45129075748093, 410.16122030447804, 3260.5761251037216, 3283.212029112996, 3297.225152089257, 3314.486254630536, 3348.1462227131924, 8605.569721513899, 8758.255548278468, 8895.510746908982, 8978.46129232235, 9070.86393704095, 8930.240929521064, 8987.77530561728, 9007.684731034382, 9008.684696035607, 9008.864867027, 6856.9314306856295, 6873.1064961554675, 7000.544964577286, 7009.264027277266, 7013.123359580052, 4692.131955588091, 4844.61243100544, 4857.538533839421, 4878.390201224847, 4900.019996000886, 8380.539070350946, 8383.28742056932, 8431.451955622864, 8504.829903402022, 8516.233538981522, 8443.493390396596, 8467.11095334981, 8564.52895090776, 8620.827583448421, 8641.395102342776, 6083.69581520931, 6483.4164925156965, 6545.312742162195, 6618.271990080991, 6762.256151823394, 7550.056242969629, 7567.167611562833, 7577.5453472791805, 7614.657340419583, 7634.847303054019, 6699.43054840344, 6775.0, 6775.93224067753, 6804.829879253059, 6952.339527744856, 6508.967455162694, 6548.705308261045, 6630.071789949315, 6754.831129221809, 6793.388595026471, 5712.514436272963, 5785.537157027344, 5798.536117110705, 5800.042992906123, 5815.447532484407, 4313.223619748475, 4333.523312435566, 4353.717008394444, 4401.339799030171, 4414.006848459071, 4209.389638502461, 4229.344451610005, 4312.813976156582, 4433.512313645432, 4439.156560253541], "value": 3937.537958795914, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.49820817153636, 289.5627602320495, 290.1108103662275, 298.36448364982584, 304.21360782377553, 4892.119418504668, 4928.408590969088, 4935.901281974358, 4939.58013568847, 4940.419065898918, 4802.847316644006, 4853.441854186761, 4857.708537487753, 4878.756062196885, 4891.633127515442, 3633.200695846916, 3756.361418558838, 3845.2309538092354, 3850.5571859236125, 3851.4030325299623, 3822.6750726188307, 3832.386818109103, 3834.5015148030857, 3853.6724378427725, 3874.1864208516245, 3848.4804551385487, 3868.613138686137, 3874.341361968458, 3876.573576906538, 3893.8247778849877, 3794.742980174026, 3795.430685397185, 3816.9618303816883, 3846.788426636534, 3863.594322596115, 3375.780574262665, 3376.7298616110897, 3385.0860267727576, 3401.812900290483, 3402.3195360927666, 4768.402585133984, 4773.188557945123, 4773.546513081252, 4796.688215265996, 4801.207800712878, 4339.891502712426, 4343.9348409773875, 4353.455818022747, 4419.491758447755, 4430.556944305544, 4944.728039957837, 5062.82280120194, 5074.517920797518, 5090.389153301628, 5153.2785410042625, 3696.039029852258, 3699.5375578052744, 3708.7033037356946, 3717.3866312058476, 3723.7843483127494, 5360.0, 5365.490278423583, 5372.77030032536, 5386.165144402624, 5401.810936617199, 3661.4507823826107, 3772.2266935278203, 3783.356829339019, 3794.3928971365003, 3794.9886560123177, 3840.6735427488975, 3842.9231415371537, 3845.692344612424, 3848.615138486129, 3849.2493963676816, 4368.36658684489, 4384.377780221338, 4396.1647287016, 4400.44994375703, 4401.0, 4951.907726692256, 5121.769520371592, 5141.151709967889, 5149.562287205629, 5155.871103222375, 1319.8746119118669, 1339.9598012059653, 1342.5032737887045, 1344.9798253026213, 1346.9730605387838, 837.8049510283097, 864.9264812490883, 868.6438560190292, 880.2693764175718, 882.8455020371409, 4393.868183954486, 4407.449068866392, 4543.863684089482, 4545.2954792007295, 4557.5442455754155, 5257.947420525822, 5267.868303292448, 5271.710055946883, 5272.894542109137, 5288.233206185082, 4536.253542386139, 4544.636429085731, 4549.658775591844, 4552.658550608718, 4558.612517935946, 2662.933426664349, 2810.353618667718, 2831.3912508810704, 2834.4472827798795, 2835.503786837295, 5027.698338099725, 5029.823956161516, 5034.295198672189, 5041.59667226621, 5058.848234552969, 5195.7142357170715, 5401.864953376118, 5402.675839449567, 5407.432219616962, 5417.404085550586, 5014.824481143142, 5025.346704928336, 5045.495450454925, 5049.772760225872, 5056.721880296545, 5372.167314066326, 5381.19282107687, 5386.649867758583, 5392.649477783932, 5401.864953376197, 5101.362329708786, 5134.948650513447, 5210.97394513025, 5240.737963101906, 5245.291885595396, 4944.554990050912, 5016.0, 5020.47285035066, 5020.698758074527, 5036.748162591929, 3613.277344531157, 3640.0899775056237, 3660.432632941898, 3679.632036796299, 3684.299983003221, 5136.228001339532, 5273.604479664117, 5318.388385335581, 5331.600129990189, 5349.438308977501, 5161.329027226587, 5165.870853228549, 5172.9741351293005, 5175.611829112756, 5175.844724658115, 5160.587153027824, 5173.3533308336455, 5173.974130129325, 5184.922226166535, 5214.165733482625, 4950.4059512858685, 5119.48805119485, 5119.718415487035, 5126.359205099363, 5156.123459011902, 4970.950290497049, 5019.598432125348, 5128.307678463509, 5217.791288348423, 5222.190560463135, 5010.69935803853, 5023.095842748195, 5027.7234752087525, 5095.528668595654, 5116.334876466036], "value": 3881.2994215231365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.53057666272, 562.1062510608132, 567.5005994724642, 592.0432969037332, 600.3996003996002, 10210.897891021088, 10550.99999999999, 10767.892321076786, 11363.261388009774, 11452.141089418285, 11168.050715689176, 11248.212625116244, 11252.662420127388, 11267.4366281686, 11272.661820145388, 610.1579819848603, 726.789231122975, 747.331138630925, 749.108560812634, 750.6847124207818, 717.921028686844, 732.9450291228153, 740.8999785029006, 742.4580056558689, 742.9962850185741, 782.1669921533577, 786.5516655506364, 788.4480863395618, 788.8856115863197, 795.8885755994165, 785.2461636828594, 785.6857257097149, 788.5662885413028, 794.7417089445953, 795.1889073145388, 576.4725276372114, 577.9566532510037, 579.0156733552935, 579.111064515966, 581.2095550051926, 11950.0, 11992.70018249542, 12013.63959081229, 12015.21901076436, 12019.038476921825, 12518.74962500754, 12617.936910315482, 12846.0, 13318.334083295893, 13611.387487562984, 10212.336198147097, 10285.331453455576, 10421.478926053667, 10504.36973781568, 10554.419506927115, 2963.7777166712367, 2990.9102726918227, 2992.356643321696, 3020.5620185073262, 3026.879162702191, 66211.337886621, 67688.32311676869, 68037.65981170062, 68436.0, 69477.30522694759, 8826.470411775314, 8933.19601235892, 9218.907810921804, 9542.761430964281, 9563.378380405251, 18994.62010759777, 19039.143238554298, 19111.617767644846, 19164.90417547931, 19191.136398862083, 6179.969100154471, 6337.04944258365, 6666.466682665375, 6748.392644661906, 6814.48891333152, 3136.9961612284305, 3168.58808354917, 3180.189051791778, 3209.5988001499813, 3223.774335796472, 2876.2090425132837, 3050.633923929143, 3214.4053350129834, 3217.7104060634656, 3243.1243564237525, 535.3709391465013, 545.4654438650145, 546.4071482441595, 546.9453054694578, 549.6262541471838, 542.3654324440336, 548.6488647265753, 572.5505478199593, 594.4323171371417, 595.9642421454727, 7103.822404439827, 7366.484346095722, 7376.7418140364825, 7423.62881855905, 7670.42471814605, 528.8730704630938, 530.5516838271654, 531.0785786660142, 536.2546060975247, 536.4260241541513, 3422.589289285252, 3493.63316851732, 3632.4369722693023, 3656.213914008448, 3658.487811706363, 87306.0, 98681.0, 100000.0, 100884.49557752164, 102975.0, 86251.0, 87847.0, 89401.55299223462, 89530.55234723784, 90003.0, 76953.0, 77198.0, 78059.60970195112, 79269.20730792734, 83019.0, 7088.397486213729, 7714.305712485679, 7887.44787864844, 7980.12218655959, 8056.798580035546, 39455.2108957825, 40595.79702101589, 40757.18485630211, 41661.58338416698, 41997.580024199364, 59086.0, 59450.405495946216, 60655.0, 61028.694856525435, 61149.38850611615, 10083.14293285079, 10334.741631459274, 10369.9481502592, 10398.168146548409, 10429.12275790365, 11011.2650266698, 11016.834747478633, 11148.944255278997, 11212.49543770516, 11280.7743845121, 10524.263301568817, 10650.176327422701, 10726.624568140078, 10733.087687546646, 11150.944245278723, 9691.418514889128, 9785.461799601091, 9899.356541824758, 10286.639967601099, 10882.0, 9767.462789546358, 10216.846747298945, 10356.948215258875, 10459.424731639832, 10675.519601618102, 8024.879626805719, 8561.101084386299, 8618.612162452579, 8655.740327790176, 8980.46117232968, 8961.551922403984, 9011.279097672039, 9112.635494580143, 9235.953820230856, 9246.907530924605], "value": 6176.833952851773, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 115.0, 116.0, 114.0, 116.0, 115.0, 116.0, 115.0, 132.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 161.0, 196.0, 125.0, 149.0, 158.0, 126.0, 207.0, 130.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 162.0, 164.0, 162.0, 162.0, 165.0, 163.0, 166.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 184.0, 79.0, 76.0, 76.0, 79.0, 159.0, 78.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 138.0, 85.0, 86.0, 84.0, 138.0, 84.0, 83.0, 147.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 83.0, 82.0, 83.0, 84.0, 84.0, 89.0, 87.0, 82.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 152.0, 132.0, 137.0, 138.0, 142.0, 137.0, 151.0, 174.0, 135.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 178.0, 183.0, 177.0, 178.0, 178.0, 176.0, 178.0, 176.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 71.0, 71.0, 69.0, 75.0, 69.0, 69.0, 74.0], "value": 70.9, "unit": "score"}]}]} 12:52:04 INFO - Return code: 0 12:52:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:52:04 ERROR - # TBPL SUCCESS # 12:52:04 INFO - Running post-action listener: _resource_record_post_action 12:52:04 INFO - [mozharness: 2016-08-29 19:52:04.500660Z] Finished run-tests step (success) 12:52:04 INFO - Running post-run listener: _resource_record_post_run 12:52:04 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416202752; Read time: 12; Write time: 287476 12:52:04 INFO - TinderboxPrint: CPU usage
13.4% 12:52:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:52:04 INFO - TinderboxPrint: I/O write bytes / time
416,202,752 / 287,476 12:52:04 INFO - TinderboxPrint: CPU idle
8,288.7 (86.6%) 12:52:04 INFO - TinderboxPrint: CPU user
1,219.5 (12.7%) 12:52:04 INFO - TinderboxPrint: Swap in / out
0 / 0 12:52:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124948480; Read time: 0; Write time: 89692 12:52:04 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291254272; Read time: 12; Write time: 197784 12:52:05 INFO - Running post-run listener: _upload_blobber_files 12:52:05 INFO - Blob upload gear active. 12:52:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:52:05 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 12:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:52:05 INFO - (blobuploader) - INFO - Open directory for files ... 12:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:06 INFO - (blobuploader) - INFO - Done attempting. 12:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:10 INFO - (blobuploader) - INFO - Done attempting. 12:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:11 INFO - (blobuploader) - INFO - Done attempting. 12:52:11 INFO - (blobuploader) - INFO - Iteration through files over. 12:52:11 INFO - Return code: 0 12:52:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:52:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:52:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9791fa65bbba4ef8ecdfc3ed5389e9bc52619dd9c0b9e29b791f45e876028456e20110bd6de25cd3eb880ff6a3ae9f9136904ec3879f1689f17c3942231f0958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d5b68af1b754110ef0f640a335b4b4d0531ab3e1165701a8fdf2d9f3ae9c253cbb1c907623534f9834dcfd092e2b6ad965bd6c263abf9d37c4212af306b2e76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/687f48e670ff51f03469065942a6e9ca10ba04a1c6b90c1cd4f4a77e9e3136b84a304db58d7f51ac08983f99c00e6d1c1d84753eea42d088f2c970138da1fe7c"} 12:52:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:52:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:52:11 INFO - Contents: 12:52:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9791fa65bbba4ef8ecdfc3ed5389e9bc52619dd9c0b9e29b791f45e876028456e20110bd6de25cd3eb880ff6a3ae9f9136904ec3879f1689f17c3942231f0958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d5b68af1b754110ef0f640a335b4b4d0531ab3e1165701a8fdf2d9f3ae9c253cbb1c907623534f9834dcfd092e2b6ad965bd6c263abf9d37c4212af306b2e76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/687f48e670ff51f03469065942a6e9ca10ba04a1c6b90c1cd4f4a77e9e3136b84a304db58d7f51ac08983f99c00e6d1c1d84753eea42d088f2c970138da1fe7c"} 12:52:11 INFO - Running post-run listener: copy_logs_to_upload_dir 12:52:11 INFO - Copying logs to upload dir... 12:52:11 INFO - mkdir: /builds/slave/test/build/upload/logs 12:52:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.898572 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-29 12:52:09.913925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 12:52:09.917451) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9791fa65bbba4ef8ecdfc3ed5389e9bc52619dd9c0b9e29b791f45e876028456e20110bd6de25cd3eb880ff6a3ae9f9136904ec3879f1689f17c3942231f0958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d5b68af1b754110ef0f640a335b4b4d0531ab3e1165701a8fdf2d9f3ae9c253cbb1c907623534f9834dcfd092e2b6ad965bd6c263abf9d37c4212af306b2e76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/687f48e670ff51f03469065942a6e9ca10ba04a1c6b90c1cd4f4a77e9e3136b84a304db58d7f51ac08983f99c00e6d1c1d84753eea42d088f2c970138da1fe7c"} build_url:https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9791fa65bbba4ef8ecdfc3ed5389e9bc52619dd9c0b9e29b791f45e876028456e20110bd6de25cd3eb880ff6a3ae9f9136904ec3879f1689f17c3942231f0958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d5b68af1b754110ef0f640a335b4b4d0531ab3e1165701a8fdf2d9f3ae9c253cbb1c907623534f9834dcfd092e2b6ad965bd6c263abf9d37c4212af306b2e76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/687f48e670ff51f03469065942a6e9ca10ba04a1c6b90c1cd4f4a77e9e3136b84a304db58d7f51ac08983f99c00e6d1c1d84753eea42d088f2c970138da1fe7c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 12:52:09.942713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:52:09.943074) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472498101.470439-227409518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:52:10.025909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 12:52:10.026230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 12:52:10.026626) ========= ========= Total master_lag: 0.15 =========