builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1476409813.27 results: success (0) buildid: 20161013185002 builduid: f6361f7b0c154d1d83d359d5c9dcea97 revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.272921) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.273901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.274664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.290706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.291031) ========= 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=923d835db2ba3686ebe126b700000192-1476409812.620206-478817395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 18:50:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.85M=0.001s 2016-10-13 18:50:13 (9.85 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.404830 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.715217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.716376) ========= 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=923d835db2ba3686ebe126b700000192-1476409812.620206-478817395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018083 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.797748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:13.798157) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --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 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --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=923d835db2ba3686ebe126b700000192-1476409812.620206-478817395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 18:50:13,929 truncating revision to first 12 chars 2016-10-13 18:50:13,929 Setting DEBUG logging. 2016-10-13 18:50:13,930 attempt 1/10 2016-10-13 18:50:13,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/183b9d08d264?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 18:50:14,386 unpacking tar archive at: fx-team-183b9d08d264/testing/mozharness/ program finished with exit code 0 elapsedTime=0.769578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:14.585828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:14.586992) ========= script_repo_revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:14.588040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:14.588774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 18:50:14.600376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-10-13 18:50:14.600807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1476409812.620206-478817395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:50:14 INFO - MultiFileLogger online at 20161013 18:50:14 in /builds/slave/test 18:50:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:50:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:50:14 INFO - {'append_to_log': False, 18:50:14 INFO - 'base_work_dir': '/builds/slave/test', 18:50:14 INFO - 'blob_upload_branch': 'Fx-Team', 18:50:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:50:14 INFO - 'branch': 'Fx-Team', 18:50:14 INFO - 'buildbot_json_path': 'buildprops.json', 18:50:14 INFO - 'config_files': ('talos/linux_config.py',), 18:50:14 INFO - 'default_actions': ('clobber', 18:50:14 INFO - 'read-buildbot-config', 18:50:14 INFO - 'download-and-extract', 18:50:14 INFO - 'populate-webroot', 18:50:14 INFO - 'create-virtualenv', 18:50:14 INFO - 'install', 18:50:14 INFO - 'run-tests'), 18:50:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:50:14 INFO - 'download_minidump_stackwalk': True, 18:50:14 INFO - 'download_symbols': 'ondemand', 18:50:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:50:14 INFO - 'tooltool.py': '/tools/tooltool.py', 18:50:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:50:14 INFO - '/tools/misc-python/virtualenv.py')}, 18:50:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:50:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:50:14 INFO - 'installer_path': 'installer.exe', 18:50:14 INFO - 'log_level': 'info', 18:50:14 INFO - 'log_name': 'talos', 18:50:14 INFO - 'log_to_console': True, 18:50:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:50:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:50:14 INFO - 'opt_config_files': (), 18:50:14 INFO - 'pip_index': False, 18:50:14 INFO - 'sps_profile': False, 18:50:14 INFO - 'sps_profile_interval': 0, 18:50:14 INFO - 'suite': 'dromaeojs', 18:50:14 INFO - 'system_bits': '32', 18:50:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:50:14 INFO - 'title': 'talos-linux64-ix-007', 18:50:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:50:14 INFO - 'use_talos_json': True, 18:50:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:50:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:50:14 INFO - 'work_dir': 'build'} 18:50:14 INFO - [mozharness: 2016-10-14 01:50:14.834642Z] Running clobber step. 18:50:14 INFO - Running pre-action listener: _resource_record_pre_action 18:50:14 INFO - Running main action method: clobber 18:50:14 INFO - rmtree: /builds/slave/test/build 18:50:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:50:15 INFO - Running post-action listener: _resource_record_post_action 18:50:15 INFO - [mozharness: 2016-10-14 01:50:15.301980Z] Finished clobber step (success) 18:50:15 INFO - [mozharness: 2016-10-14 01:50:15.302081Z] Running read-buildbot-config step. 18:50:15 INFO - Running pre-action listener: _resource_record_pre_action 18:50:15 INFO - Running main action method: read_buildbot_config 18:50:15 INFO - Using buildbot properties: 18:50:15 INFO - { 18:50:15 INFO - "project": "", 18:50:15 INFO - "product": "firefox", 18:50:15 INFO - "script_repo_revision": "production", 18:50:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:50:15 INFO - "repository": "", 18:50:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:50:15 INFO - "buildid": "20161013185002", 18:50:15 INFO - "stage_platform": "linux64-pgo", 18:50:15 INFO - "basedir": "/builds/slave/test", 18:50:15 INFO - "buildnumber": 1630, 18:50:15 INFO - "platform": "ubuntu64_hw", 18:50:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:50:15 INFO - "slavebuilddir": "test", 18:50:15 INFO - "branch": "fx-team", 18:50:15 INFO - "revision": "183b9d08d2648d4ed50fa1d354b50bd43c11a891", 18:50:15 INFO - "slavename": "talos-linux64-ix-007", 18:50:15 INFO - "builduid": "f6361f7b0c154d1d83d359d5c9dcea97", 18:50:15 INFO - "repo_path": "integration/fx-team" 18:50:15 INFO - } 18:50:15 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:50:15 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:50:15 INFO - Running post-action listener: _resource_record_post_action 18:50:15 INFO - [mozharness: 2016-10-14 01:50:15.304563Z] Finished read-buildbot-config step (success) 18:50:15 INFO - [mozharness: 2016-10-14 01:50:15.304653Z] Running download-and-extract step. 18:50:15 INFO - Running pre-action listener: _resource_record_pre_action 18:50:15 INFO - Running main action method: download_and_extract 18:50:15 INFO - mkdir: /builds/slave/test/build/tests 18:50:15 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')]} 18:50:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:50:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:50:15 INFO - Downloaded 1361 bytes. 18:50:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:50:15 INFO - Using the following test package requirements: 18:50:15 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:50:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:50:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'jsshell-linux-x86_64.zip'], 18:50:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:50:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:50:15 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:50:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:50:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:50:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:50:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:50:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:50:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:50:16 INFO - Http code: 200 18:50:16 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 18:50:16 INFO - x-amz-cf-id: YJpDTOh4HwekOGThGLlv6KHmyML5ZKMUrf7i7S-Iejc-FPuMu5qbqQ== 18:50:16 INFO - x-amz-replication-status: COMPLETED 18:50:16 INFO - x-amz-version-id: i8g7MMV.pBWh8IpMTQo__e2fFas8JOL3 18:50:19 INFO - Expected file size: 22120825 18:50:19 INFO - Obtained file size: 22120825 18:50:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:50:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:50:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:50:23 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:50:23 INFO - Http code: 200 18:50:23 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 18:50:23 INFO - x-amz-cf-id: zKM8xagZ77bdioH25kjVYXhG2k6ovE_oXiOMa-Xcz3EAqTcHTCGZyw== 18:50:23 INFO - x-amz-replication-status: COMPLETED 18:50:23 INFO - x-amz-version-id: i8g7MMV.pBWh8IpMTQo__e2fFas8JOL3 18:50:23 INFO - Expected file size: 22120825 18:50:23 INFO - Obtained file size: 22120825 18:50:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:50:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:50:28 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:50:28 INFO - Http code: 200 18:50:28 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 18:50:28 INFO - x-amz-cf-id: vxj4-HRX1sSe7qFm7xvk402Rz8vkSWbfHBu6Y9pvhwYkjQgZ2eBJYg== 18:50:28 INFO - x-amz-replication-status: COMPLETED 18:50:28 INFO - x-amz-version-id: J15sNIN8Z2z8W0Z_oIzDE7NHzsnoCGlP 18:50:37 INFO - Expected file size: 14409006 18:50:37 INFO - Obtained file size: 14409006 18:50:37 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')]} 18:50:37 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:50:37 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:50:43 INFO - Downloaded 59812107 bytes. 18:50:43 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:50:43 INFO - mkdir: /builds/slave/test/properties 18:50:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:50:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:50:43 INFO - Contents: 18:50:43 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:50:43 INFO - Running post-action listener: _resource_record_post_action 18:50:43 INFO - Running post-action listener: set_extra_try_arguments 18:50:43 INFO - [mozharness: 2016-10-14 01:50:43.706342Z] Finished download-and-extract step (success) 18:50:43 INFO - [mozharness: 2016-10-14 01:50:43.706570Z] Running populate-webroot step. 18:50:43 INFO - Running pre-action listener: _resource_record_pre_action 18:50:43 INFO - Running main action method: populate_webroot 18:50:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:50:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:50:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:50:43 INFO - '--tppagecycles', 18:50:43 INFO - '7'], 18:50:43 INFO - 'tests': ['tsvgm']}}, 18:50:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:50:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:50:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:50:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:50:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['damp', 'tps']}, 18:50:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'tests': ['damp', 'tps']}, 18:50:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['dromaeo_dom']}, 18:50:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:50:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['basic_compositor_video']}, 18:50:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:50:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['a11yr', 18:50:43 INFO - 'ts_paint', 18:50:43 INFO - 'tpaint', 18:50:43 INFO - 'sessionrestore', 18:50:43 INFO - 'sessionrestore_no_auto_restore', 18:50:43 INFO - 'tabpaint']}, 18:50:43 INFO - 'other-e10s': {'tests': ['a11yr', 18:50:43 INFO - 'ts_paint', 18:50:43 INFO - 'tpaint', 18:50:43 INFO - 'sessionrestore', 18:50:43 INFO - 'sessionrestore_no_auto_restore', 18:50:43 INFO - 'tabpaint']}, 18:50:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:50:43 INFO - 'ts_paint', 18:50:43 INFO - 'tpaint', 18:50:43 INFO - 'sessionrestore', 18:50:43 INFO - 'sessionrestore_no_auto_restore', 18:50:43 INFO - 'tabpaint']}, 18:50:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:50:43 INFO - 'ts_paint', 18:50:43 INFO - 'tpaint', 18:50:43 INFO - 'sessionrestore', 18:50:43 INFO - 'sessionrestore_no_auto_restore', 18:50:43 INFO - 'tabpaint']}, 18:50:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['a11yr', 18:50:43 INFO - 'ts_paint', 18:50:43 INFO - 'tpaint', 18:50:43 INFO - 'sessionrestore', 18:50:43 INFO - 'sessionrestore_no_auto_restore', 18:50:43 INFO - 'tabpaint']}, 18:50:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['a11yr', 18:50:43 INFO - 'ts_paint', 18:50:43 INFO - 'tpaint', 18:50:43 INFO - 'sessionrestore', 18:50:43 INFO - 'sessionrestore_no_auto_restore', 18:50:43 INFO - 'tabpaint']}, 18:50:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['tsvgx', 18:50:43 INFO - 'tsvgr_opacity', 18:50:43 INFO - 'tart', 18:50:43 INFO - 'tscrollx', 18:50:43 INFO - 'cart']}, 18:50:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:50:43 INFO - 'tsvgr_opacity', 18:50:43 INFO - 'tart', 18:50:43 INFO - 'tscrollx', 18:50:43 INFO - 'cart']}, 18:50:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'talos_options': ['--disable-e10s'], 18:50:43 INFO - 'tests': ['tp5o']}, 18:50:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'tests': ['tp5o']}, 18:50:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'talos_options': ['--disable-e10s', 18:50:43 INFO - '--xperf_path', 18:50:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:43 INFO - 'tests': ['tp5n']}, 18:50:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:43 INFO - 'talos_options': ['--xperf_path', 18:50:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:43 INFO - 'tests': ['tp5n']}}, 18:50:43 INFO - 'talos.zip': {'path': '', 18:50:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:50:43 INFO - Running post-action listener: _resource_record_post_action 18:50:43 INFO - [mozharness: 2016-10-14 01:50:43.725728Z] Finished populate-webroot step (success) 18:50:43 INFO - [mozharness: 2016-10-14 01:50:43.725817Z] Running create-virtualenv step. 18:50:43 INFO - Running pre-action listener: _resource_record_pre_action 18:50:43 INFO - Running main action method: create_virtualenv 18:50:43 INFO - Creating virtualenv /builds/slave/test/build/venv 18:50:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:50:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:50:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:50:43 INFO - Using real prefix '/usr' 18:50:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:50:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:46 INFO - Installing pip.................done. 18:50:46 INFO - Return code: 0 18:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:50:46 INFO - Reading from file tmpfile_stdout 18:50:46 INFO - Output received: 18:50:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:50:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:50:46 INFO - Using env: {'DISPLAY': ':0', 18:50:46 INFO - 'HOME': '/home/cltbld', 18:50:46 INFO - 'LANG': 'en_US.UTF-8', 18:50:46 INFO - 'LANGUAGE': 'en_US:en', 18:50:46 INFO - 'LOGNAME': 'cltbld', 18:50:46 INFO - 'MAIL': '/var/mail/cltbld', 18:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:46 INFO - 'MOZ_NO_REMOTE': '1', 18:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:46 INFO - 'NO_EM_RESTART': '1', 18:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:46 INFO - 'PWD': '/builds/slave/test', 18:50:46 INFO - 'SHELL': '/bin/bash', 18:50:46 INFO - 'SHLVL': '1', 18:50:46 INFO - 'TERM': 'linux', 18:50:46 INFO - 'TMOUT': '86400', 18:50:46 INFO - 'USER': 'cltbld', 18:50:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:46 INFO - '_': '/tools/buildbot/bin/python'} 18:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:50:46 INFO - Cleaning up... 18:50:46 INFO - Return code: 0 18:50:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:50:46 INFO - Using env: {'DISPLAY': ':0', 18:50:46 INFO - 'HOME': '/home/cltbld', 18:50:46 INFO - 'LANG': 'en_US.UTF-8', 18:50:46 INFO - 'LANGUAGE': 'en_US:en', 18:50:46 INFO - 'LOGNAME': 'cltbld', 18:50:46 INFO - 'MAIL': '/var/mail/cltbld', 18:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:46 INFO - 'MOZ_NO_REMOTE': '1', 18:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:46 INFO - 'NO_EM_RESTART': '1', 18:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:46 INFO - 'PWD': '/builds/slave/test', 18:50:46 INFO - 'SHELL': '/bin/bash', 18:50:46 INFO - 'SHLVL': '1', 18:50:46 INFO - 'TERM': 'linux', 18:50:46 INFO - 'TMOUT': '86400', 18:50:46 INFO - 'USER': 'cltbld', 18:50:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:46 INFO - '_': '/tools/buildbot/bin/python'} 18:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:46 INFO - Downloading/unpacking psutil>=3.1.1 18:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:48 INFO - Installing collected packages: psutil 18:50:48 INFO - Running setup.py install for psutil 18:50:49 INFO - building 'psutil._psutil_linux' extension 18:50:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:50:49 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 18:50:49 INFO - building 'psutil._psutil_posix' extension 18:50:49 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 18:50:49 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 18:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:49 INFO - Successfully installed psutil 18:50:49 INFO - Cleaning up... 18:50:49 INFO - Return code: 0 18:50:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:49 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:49 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 18:50:49 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 18:50:49 INFO - Using env: {'DISPLAY': ':0', 18:50:49 INFO - 'HOME': '/home/cltbld', 18:50:49 INFO - 'LANG': 'en_US.UTF-8', 18:50:49 INFO - 'LANGUAGE': 'en_US:en', 18:50:49 INFO - 'LOGNAME': 'cltbld', 18:50:49 INFO - 'MAIL': '/var/mail/cltbld', 18:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:49 INFO - 'MOZ_NO_REMOTE': '1', 18:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:49 INFO - 'NO_EM_RESTART': '1', 18:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:49 INFO - 'PWD': '/builds/slave/test', 18:50:49 INFO - 'SHELL': '/bin/bash', 18:50:49 INFO - 'SHLVL': '1', 18:50:49 INFO - 'TERM': 'linux', 18:50:49 INFO - 'TMOUT': '86400', 18:50:49 INFO - 'USER': 'cltbld', 18:50:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:49 INFO - '_': '/tools/buildbot/bin/python'} 18:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:50:51 INFO - Installing collected packages: mozsystemmonitor 18:50:51 INFO - Running setup.py install for mozsystemmonitor 18:50:51 INFO - Successfully installed mozsystemmonitor 18:50:51 INFO - Cleaning up... 18:50:51 INFO - Return code: 0 18:50:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:51 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:51 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 18:50:51 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 18:50:51 INFO - Using env: {'DISPLAY': ':0', 18:50:51 INFO - 'HOME': '/home/cltbld', 18:50:51 INFO - 'LANG': 'en_US.UTF-8', 18:50:51 INFO - 'LANGUAGE': 'en_US:en', 18:50:51 INFO - 'LOGNAME': 'cltbld', 18:50:51 INFO - 'MAIL': '/var/mail/cltbld', 18:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:51 INFO - 'MOZ_NO_REMOTE': '1', 18:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:51 INFO - 'NO_EM_RESTART': '1', 18:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:51 INFO - 'PWD': '/builds/slave/test', 18:50:51 INFO - 'SHELL': '/bin/bash', 18:50:51 INFO - 'SHLVL': '1', 18:50:51 INFO - 'TERM': 'linux', 18:50:51 INFO - 'TMOUT': '86400', 18:50:51 INFO - 'USER': 'cltbld', 18:50:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:51 INFO - '_': '/tools/buildbot/bin/python'} 18:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:52 INFO - Downloading/unpacking jsonschema==2.5.1 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:50:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:50:54 INFO - warning: no files found matching '*.txt' 18:50:54 INFO - no previously-included directories found matching 'build' 18:50:54 INFO - no previously-included directories found matching 'dist' 18:50:54 INFO - no previously-included directories found matching '.git*' 18:50:54 INFO - Installing collected packages: jsonschema, functools32 18:50:54 INFO - Running setup.py install for functools32 18:50:54 INFO - warning: no files found matching '*.txt' 18:50:54 INFO - no previously-included directories found matching 'build' 18:50:54 INFO - no previously-included directories found matching 'dist' 18:50:54 INFO - no previously-included directories found matching '.git*' 18:50:54 INFO - Successfully installed jsonschema functools32 18:50:54 INFO - Cleaning up... 18:50:54 INFO - Return code: 0 18:50:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:54 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:54 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 18:50:54 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 18:50:54 INFO - Using env: {'DISPLAY': ':0', 18:50:54 INFO - 'HOME': '/home/cltbld', 18:50:54 INFO - 'LANG': 'en_US.UTF-8', 18:50:54 INFO - 'LANGUAGE': 'en_US:en', 18:50:54 INFO - 'LOGNAME': 'cltbld', 18:50:54 INFO - 'MAIL': '/var/mail/cltbld', 18:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:54 INFO - 'MOZ_NO_REMOTE': '1', 18:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:54 INFO - 'NO_EM_RESTART': '1', 18:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:54 INFO - 'PWD': '/builds/slave/test', 18:50:54 INFO - 'SHELL': '/bin/bash', 18:50:54 INFO - 'SHLVL': '1', 18:50:54 INFO - 'TERM': 'linux', 18:50:54 INFO - 'TMOUT': '86400', 18:50:54 INFO - 'USER': 'cltbld', 18:50:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:54 INFO - '_': '/tools/buildbot/bin/python'} 18:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:50:54 INFO - Cleaning up... 18:50:54 INFO - Return code: 0 18:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:54 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:54 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 18:50:54 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 18:50:54 INFO - Using env: {'DISPLAY': ':0', 18:50:54 INFO - 'HOME': '/home/cltbld', 18:50:54 INFO - 'LANG': 'en_US.UTF-8', 18:50:54 INFO - 'LANGUAGE': 'en_US:en', 18:50:54 INFO - 'LOGNAME': 'cltbld', 18:50:54 INFO - 'MAIL': '/var/mail/cltbld', 18:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:54 INFO - 'MOZ_NO_REMOTE': '1', 18:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:54 INFO - 'NO_EM_RESTART': '1', 18:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:54 INFO - 'PWD': '/builds/slave/test', 18:50:54 INFO - 'SHELL': '/bin/bash', 18:50:54 INFO - 'SHLVL': '1', 18:50:54 INFO - 'TERM': 'linux', 18:50:54 INFO - 'TMOUT': '86400', 18:50:54 INFO - 'USER': 'cltbld', 18:50:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:54 INFO - '_': '/tools/buildbot/bin/python'} 18:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:56 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 18:50:56 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 18:50:56 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 18:50:56 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 18:50:56 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 18:50:56 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 18:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:50:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 INFO - Downloading docopt-0.6.1.tar.gz 18:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:57 INFO - Running setup.py install for blobuploader 18:50:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:50:57 INFO - Running setup.py install for requests 18:50:58 INFO - Running setup.py install for docopt 18:50:58 INFO - Successfully installed blobuploader requests docopt 18:50:58 INFO - Cleaning up... 18:50:58 INFO - Return code: 0 18:50:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:58 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')]} 18:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:58 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')]} 18:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:58 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:50:58 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 18:50:58 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 18:50:58 INFO - Using env: {'DISPLAY': ':0', 18:50:58 INFO - 'HOME': '/home/cltbld', 18:50:58 INFO - 'LANG': 'en_US.UTF-8', 18:50:58 INFO - 'LANGUAGE': 'en_US:en', 18:50:58 INFO - 'LOGNAME': 'cltbld', 18:50:58 INFO - 'MAIL': '/var/mail/cltbld', 18:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:58 INFO - 'MOZ_NO_REMOTE': '1', 18:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:58 INFO - 'NO_EM_RESTART': '1', 18:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:58 INFO - 'PWD': '/builds/slave/test', 18:50:58 INFO - 'SHELL': '/bin/bash', 18:50:58 INFO - 'SHLVL': '1', 18:50:58 INFO - 'TERM': 'linux', 18:50:58 INFO - 'TMOUT': '86400', 18:50:58 INFO - 'USER': 'cltbld', 18:50:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:58 INFO - '_': '/tools/buildbot/bin/python'} 18:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:58 INFO - Running setup.py (path:/tmp/pip-uHFTiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:58 INFO - Running setup.py (path:/tmp/pip-Hh3PYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:58 INFO - Running setup.py (path:/tmp/pip-WbpBWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:58 INFO - Running setup.py (path:/tmp/pip-qnvxGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:58 INFO - Running setup.py (path:/tmp/pip-a8nGgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:58 INFO - Running setup.py (path:/tmp/pip-5KiiyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:58 INFO - Running setup.py (path:/tmp/pip-eeqQUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:58 INFO - Running setup.py (path:/tmp/pip-nTWRct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:58 INFO - Running setup.py (path:/tmp/pip-RQf6Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:59 INFO - Running setup.py (path:/tmp/pip-4jxE_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:59 INFO - Running setup.py (path:/tmp/pip-wecUzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:59 INFO - Running setup.py (path:/tmp/pip-ZDKp68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:59 INFO - Running setup.py (path:/tmp/pip-nnWIXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:59 INFO - Running setup.py (path:/tmp/pip-hOK2Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:59 INFO - Running setup.py (path:/tmp/pip-qUrqWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:59 INFO - Running setup.py (path:/tmp/pip-dS_pwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:59 INFO - Running setup.py (path:/tmp/pip-Zm_sbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:59 INFO - Running setup.py install for manifestparser 18:50:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:50:59 INFO - Running setup.py install for mozcrash 18:50:59 INFO - Running setup.py install for mozdebug 18:50:59 INFO - Running setup.py install for mozdevice 18:51:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for mozfile 18:51:00 INFO - Running setup.py install for mozhttpd 18:51:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for mozinfo 18:51:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for mozInstall 18:51:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for mozleak 18:51:00 INFO - Running setup.py install for mozlog 18:51:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for moznetwork 18:51:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for mozprocess 18:51:00 INFO - Running setup.py install for mozprofile 18:51:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:51:00 INFO - Running setup.py install for mozrunner 18:51:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:51:01 INFO - Running setup.py install for mozscreenshot 18:51:01 INFO - Running setup.py install for moztest 18:51:01 INFO - Running setup.py install for mozversion 18:51:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:51:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:51:01 INFO - Cleaning up... 18:51:01 INFO - Return code: 0 18:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:01 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:51:01 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 18:51:01 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 18:51:01 INFO - Using env: {'DISPLAY': ':0', 18:51:01 INFO - 'HOME': '/home/cltbld', 18:51:01 INFO - 'LANG': 'en_US.UTF-8', 18:51:01 INFO - 'LANGUAGE': 'en_US:en', 18:51:01 INFO - 'LOGNAME': 'cltbld', 18:51:01 INFO - 'MAIL': '/var/mail/cltbld', 18:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:01 INFO - 'MOZ_NO_REMOTE': '1', 18:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:01 INFO - 'NO_EM_RESTART': '1', 18:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:01 INFO - 'PWD': '/builds/slave/test', 18:51:01 INFO - 'SHELL': '/bin/bash', 18:51:01 INFO - 'SHLVL': '1', 18:51:01 INFO - 'TERM': 'linux', 18:51:01 INFO - 'TMOUT': '86400', 18:51:01 INFO - 'USER': 'cltbld', 18:51:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:01 INFO - '_': '/tools/buildbot/bin/python'} 18:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:01 INFO - Running setup.py (path:/tmp/pip-x1eYKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:01 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)) 18:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:01 INFO - Running setup.py (path:/tmp/pip-5HHacp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:01 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)) 18:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:01 INFO - Running setup.py (path:/tmp/pip-be6rLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:01 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)) 18:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:01 INFO - Running setup.py (path:/tmp/pip-mvu0CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:01 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)) 18:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:01 INFO - Running setup.py (path:/tmp/pip-PBlb5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:02 INFO - Running setup.py (path:/tmp/pip-Q9YjwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:02 INFO - Running setup.py (path:/tmp/pip-nJhxKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:02 INFO - Running setup.py (path:/tmp/pip-lyaMfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:02 INFO - Running setup.py (path:/tmp/pip-OtZQrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:02 INFO - Running setup.py (path:/tmp/pip-fDteeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:02 INFO - Running setup.py (path:/tmp/pip-lVggDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:02 INFO - Running setup.py (path:/tmp/pip-sNjEcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:02 INFO - Running setup.py (path:/tmp/pip-oXMhV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:02 INFO - Running setup.py (path:/tmp/pip-a_JZwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:02 INFO - Running setup.py (path:/tmp/pip-KK3Ol4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:02 INFO - Running setup.py (path:/tmp/pip-PfwAG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:02 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)) 18:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:02 INFO - Running setup.py (path:/tmp/pip-TCRLA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:02 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)) 18:51:02 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)) 18:51:02 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)) 18:51:02 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)) 18:51:02 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)) 18:51:02 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)) 18:51:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:02 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 18:51:02 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 18:51:02 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 18:51:02 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 18:51:02 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 18:51:02 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 18:51:04 INFO - Downloading blessings-1.6.tar.gz 18:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:51:04 INFO - Installing collected packages: blessings 18:51:04 INFO - Running setup.py install for blessings 18:51:04 INFO - Successfully installed blessings 18:51:04 INFO - Cleaning up... 18:51:05 INFO - Return code: 0 18:51:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:05 INFO - Reading from file tmpfile_stdout 18:51:05 INFO - Current package versions: 18:51:05 INFO - argparse == 1.2.1 18:51:05 INFO - blessings == 1.6 18:51:05 INFO - blobuploader == 1.2.4 18:51:05 INFO - docopt == 0.6.1 18:51:05 INFO - functools32 == 3.2.3-2 18:51:05 INFO - jsonschema == 2.5.1 18:51:05 INFO - manifestparser == 1.1 18:51:05 INFO - mozInstall == 1.12 18:51:05 INFO - mozcrash == 0.17 18:51:05 INFO - mozdebug == 0.1 18:51:05 INFO - mozdevice == 0.48 18:51:05 INFO - mozfile == 1.2 18:51:05 INFO - mozhttpd == 0.7 18:51:05 INFO - mozinfo == 0.9 18:51:05 INFO - mozleak == 0.1 18:51:05 INFO - mozlog == 3.4 18:51:05 INFO - moznetwork == 0.27 18:51:05 INFO - mozprocess == 0.23 18:51:05 INFO - mozprofile == 0.28 18:51:05 INFO - mozrunner == 6.12 18:51:05 INFO - mozscreenshot == 0.1 18:51:05 INFO - mozsystemmonitor == 0.3 18:51:05 INFO - moztest == 0.7 18:51:05 INFO - mozversion == 1.4 18:51:05 INFO - psutil == 3.1.1 18:51:05 INFO - requests == 1.2.3 18:51:05 INFO - wsgiref == 0.1.2 18:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:05 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:51:05 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 18:51:05 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 18:51:05 INFO - Using env: {'DISPLAY': ':0', 18:51:05 INFO - 'HOME': '/home/cltbld', 18:51:05 INFO - 'LANG': 'en_US.UTF-8', 18:51:05 INFO - 'LANGUAGE': 'en_US:en', 18:51:05 INFO - 'LOGNAME': 'cltbld', 18:51:05 INFO - 'MAIL': '/var/mail/cltbld', 18:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:05 INFO - 'MOZ_NO_REMOTE': '1', 18:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:05 INFO - 'NO_EM_RESTART': '1', 18:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:05 INFO - 'PWD': '/builds/slave/test', 18:51:05 INFO - 'SHELL': '/bin/bash', 18:51:05 INFO - 'SHLVL': '1', 18:51:05 INFO - 'TERM': 'linux', 18:51:05 INFO - 'TMOUT': '86400', 18:51:05 INFO - 'USER': 'cltbld', 18:51:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:05 INFO - '_': '/tools/buildbot/bin/python'} 18:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 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)) 18:51:05 INFO - Cleaning up... 18:51:05 INFO - Return code: 0 18:51:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:05 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 0x7fcac9418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1762790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, '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': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', '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 18:51:05 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 18:51:05 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 18:51:05 INFO - Using env: {'DISPLAY': ':0', 18:51:05 INFO - 'HOME': '/home/cltbld', 18:51:05 INFO - 'LANG': 'en_US.UTF-8', 18:51:05 INFO - 'LANGUAGE': 'en_US:en', 18:51:05 INFO - 'LOGNAME': 'cltbld', 18:51:05 INFO - 'MAIL': '/var/mail/cltbld', 18:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:05 INFO - 'MOZ_NO_REMOTE': '1', 18:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:05 INFO - 'NO_EM_RESTART': '1', 18:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:05 INFO - 'PWD': '/builds/slave/test', 18:51:05 INFO - 'SHELL': '/bin/bash', 18:51:05 INFO - 'SHLVL': '1', 18:51:05 INFO - 'TERM': 'linux', 18:51:05 INFO - 'TMOUT': '86400', 18:51:05 INFO - 'USER': 'cltbld', 18:51:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:05 INFO - '_': '/tools/buildbot/bin/python'} 18:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:51:05 INFO - Cleaning up... 18:51:05 INFO - Return code: 0 18:51:05 INFO - Running post-action listener: _resource_record_post_action 18:51:05 INFO - Running post-action listener: _start_resource_monitoring 18:51:05 INFO - Starting resource monitoring. 18:51:05 INFO - [mozharness: 2016-10-14 01:51:05.787937Z] Finished create-virtualenv step (success) 18:51:05 INFO - [mozharness: 2016-10-14 01:51:05.788464Z] Running install step. 18:51:05 INFO - Running pre-action listener: _resource_record_pre_action 18:51:05 INFO - Running main action method: install 18:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:05 INFO - Reading from file tmpfile_stdout 18:51:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:51:06 INFO - Reading from file tmpfile_stdout 18:51:06 INFO - Output received: 18:51:06 INFO - Usage: mozinstall [options] installer 18:51:06 INFO - Options: 18:51:06 INFO - -h, --help show this help message and exit 18:51:06 INFO - -d DEST, --destination=DEST 18:51:06 INFO - Directory to install application into. [default: 18:51:06 INFO - "/builds/slave/test"] 18:51:06 INFO - --app=APP Application being installed. [default: firefox] 18:51:06 INFO - mkdir: /builds/slave/test/build/application 18:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:51:23 INFO - Reading from file tmpfile_stdout 18:51:23 INFO - Output received: 18:51:23 INFO - /builds/slave/test/build/application/firefox/firefox 18:51:23 INFO - Running post-action listener: _resource_record_post_action 18:51:23 INFO - [mozharness: 2016-10-14 01:51:23.127181Z] Finished install step (success) 18:51:23 INFO - [mozharness: 2016-10-14 01:51:23.127454Z] Running run-tests step. 18:51:23 INFO - Running pre-action listener: _resource_record_pre_action 18:51:23 INFO - Running main action method: run_tests 18:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:51:23 INFO - Python 2.7.3 18:51:23 INFO - Return code: 0 18:51:23 INFO - grabbing minidump binary from tooltool 18:51:23 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')]} 18:51:23 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 0x175f930>, '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 0x1760830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1760cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:51:23 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 18:51:23 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 18:51:23 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 18:51:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:51:23 INFO - Return code: 0 18:51:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:51:23 INFO - Using env: {'DISPLAY': ':0', 18:51:23 INFO - 'HOME': '/home/cltbld', 18:51:23 INFO - 'LANG': 'en_US.UTF-8', 18:51:23 INFO - 'LANGUAGE': 'en_US:en', 18:51:23 INFO - 'LOGNAME': 'cltbld', 18:51:23 INFO - 'MAIL': '/var/mail/cltbld', 18:51:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:51:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:23 INFO - 'MOZ_NO_REMOTE': '1', 18:51:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:23 INFO - 'NO_EM_RESTART': '1', 18:51:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:23 INFO - 'PWD': '/builds/slave/test', 18:51:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:51:23 INFO - 'SHELL': '/bin/bash', 18:51:23 INFO - 'SHLVL': '1', 18:51:23 INFO - 'TERM': 'linux', 18:51:23 INFO - 'TMOUT': '86400', 18:51:23 INFO - 'USER': 'cltbld', 18:51:23 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476409812.620206-478817395', 18:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:23 INFO - '_': '/tools/buildbot/bin/python'} 18:51:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:51:23 INFO - mozversion application_buildid: 20161013153005 18:51:23 INFO - mozversion application_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 18:51:23 INFO - mozversion application_display_name: Nightly 18:51:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:51:23 INFO - mozversion application_name: Firefox 18:51:23 INFO - mozversion application_remotingname: firefox 18:51:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:51:23 INFO - mozversion application_vendor: Mozilla 18:51:23 INFO - mozversion application_version: 52.0a1 18:51:23 INFO - mozversion platform_buildid: 20161013153005 18:51:23 INFO - mozversion platform_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 18:51:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:51:23 INFO - mozversion platform_version: 52.0a1 18:51:23 INFO - using testdate: 1476409883 18:51:23 INFO - actual date: 1476409883 18:51:23 INFO - starting webserver on 'localhost:35258' 18:51:23 INFO - SUITE-START | Running 2 tests 18:51:23 INFO - TEST-START | dromaeo_css 18:51:23 INFO - operating with platform_type : linux_ 18:51:23 INFO - Initialising browser for dromaeo_css test... 18:51:23 INFO - TEST-INFO | started process 28947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJnEeFH/profile http://localhost:35258/getInfo.html) 18:51:27 INFO - PROCESS | 28947 | __metrics Screen width/height:1600/1200 18:51:27 INFO - PROCESS | 28947 | colorDepth:24 18:51:27 INFO - PROCESS | 28947 | Browser inner width/height: 1024/697 18:51:27 INFO - PROCESS | 28947 | __metrics 18:51:27 INFO - PROCESS | 28947 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:51:27 INFO - PROCESS | 28947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:51:28 INFO - PROCESS | 28947 | console.error: PushService: 18:51:28 INFO - PROCESS | 28947 | stateChangeProcessEnqueue: Error transitioning state 18:51:28 INFO - PROCESS | 28947 | UnknownError 18:51:29 INFO - TEST-INFO | 28947: exit 0 18:51:29 INFO - Browser initialized. 18:51:29 INFO - Running cycle 1/1 for dromaeo_css test... 18:51:29 INFO - TEST-INFO | started process 29030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJnEeFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:41 INFO - PROCESS | 29030 | RSS: Main: 172302336 18:51:41 INFO - PROCESS | 29030 | 18:52:32 INFO - PROCESS | 29030 | 1476409952937 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] 18:54:43 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:35258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35258/tests/dromaeo/cssquery-ext.html) 18:54:45 INFO - PROCESS | 29030 | RSS: Main: 289112064 18:54:45 INFO - PROCESS | 29030 | 18:57:47 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:35258/tests/dromaeo/cssquery-ext.html (next: http://localhost:35258/tests/dromaeo/cssquery-jquery.html) 18:57:48 INFO - PROCESS | 29030 | RSS: Main: 275718144 18:57:48 INFO - PROCESS | 29030 | 19:00:50 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:35258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35258/tests/dromaeo/cssquery-mootools.html) 19:00:50 INFO - PROCESS | 29030 | RSS: Main: 215715840 19:00:50 INFO - PROCESS | 29030 | 19:03:52 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:35258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35258/tests/dromaeo/cssquery-prototype.html) 19:03:53 INFO - PROCESS | 29030 | RSS: Main: 214466560 19:03:53 INFO - PROCESS | 29030 | 19:06:56 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:35258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35258/tests/dromaeo/cssquery-yui.html) 19:06:56 INFO - PROCESS | 29030 | RSS: Main: 219271168 19:06:56 INFO - PROCESS | 29030 | 19:09:59 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:35258/tests/dromaeo/cssquery-yui.html (next: http://localhost:35258/tests/dromaeo/cssquery-dojo.html) 19:10:00 INFO - PROCESS | 29030 | RSS: Main: 305225728 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | __start_tp_report 19:10:00 INFO - PROCESS | 29030 | _x_x_mozilla_page_load 19:10:00 INFO - PROCESS | 29030 | _x_x_mozilla_page_load_details 19:10:00 INFO - PROCESS | 29030 | |i|pagename|runs| 19:10:00 INFO - PROCESS | 29030 | |0;dojo.html;2959.482090634139;2988.968805762012;2992.9551056734153;3022.8186308821487;3039.149038269284;5094;5109.693418394899;5166.354205724285;5197.896042079161;5264.92102618461;5185.507376799207;5194.792208311673;5262.578993680506;5283.313169287997;5338.946610533893;4686.835960741375;4692.389989301386;4723.126221648989;4738.099761045391;4766.594839438651;4853.684510506823;4868.367112275399;4930.03864246472;4937.728424936627;5001.6998980061135;4741.525847415265;4796.04079184161;4796.592289655384;4845.854624361275;4919.803207871681;4767.070421267854;4821.035792841446;4849.757512124415;4864.367632207825;4868.586170175539;4814.831480898187;4817.7350245736825;4821.63837712173;4868.659193856432;4880.145974454456;5298.470152984709;5327.680339179662;5329.760160792774;5330.973345133289;5341.145416733343;5465.180222966586;5507.586930980193;5520.337559492847;5524.447555244444;5698.886022279573;5579.9163012554845;5695.088785794253;5711.05767548354;5712.057510510802;5713.685747283897;5265.315508983807;5267.683938963636;5269.446708095633;5269.525742683139;5271.78912843482;5690;5755.309362876482;5755.8561035974435;5764.769409223668;5821.27234095738;5268.92096618551;5293.153095504701;5293.179557168645;5546.722663866791;5580.414056524007;5704.344000440003;5704.942950570524;5708.115242137475;5711.343195532567;5763.4812866842185;5688.8862222755315;5692.658440493584;5693.373728889819;5698.515626171822;5706.258186435737;5476.616636835383;5526.253955715927;5533.391326954032;5626.465485778845;5751.338596061507;4304.053108316165;4315.029118448324;4332.328489084197;4335.804888780012;4347.847825326098;3872.9031774205305;3887.3391523441082;3912.4131380292615;3922.5685174630767;3942.0342016206214;5276.445973172762;5281.12861377876;5286.524212820865;5290.523852853262;5355.250264962909;5514.751836167382;5628.549716022709;5639;5672.064109421982;5683.9715801420725;5267.657602255841;5280.445553216934;5317.202419637086;5371.140617501181;5374.48942350476;4914.508549145128;4929.556339929423;4942.9752851236235;4946.629002824802;4997.800087996512;5688.77244910199;5743.10981797822;5883.02930016551;5897.174395584708;5897.941020589825;5659.349174844946;5707.1724599933605;5709.942900571107;5741.368449470471;5782.884342313214;5906.793262235801;5910.320313164041;5916.378780228014;5920.348761636303;5921.526277897672;5416.8645783854145;5607.327120745536;5631.63394379364;5643.576731745217;5666.801661941812;5580.107182850725;5588.3573389060775;5615.213870058276;5636.520895723909;5710.457506536873;5447.509724124848;5493.917591236055;5507.531859791962;5507.807226747044;5509.47659972302;5494.587905907153;5500.889982200253;5503.807366742145;5517.751701173376;5573.498385145356;5365.087935051129;5422.566194704335;5495.53287970527;5539.058360078877;5540.22436858832;5610.607257491936;5616.269884915098;5616.69108199053;5617;5661.858453538694;5234.869128271824;5338.252644629677;5461.2627295316215;5475.890482190413;5481.451854814487 19:10:00 INFO - PROCESS | 29030 | |1;ext.html;554.4150920778579;597.9431953964373;609.5154352289932;612.0482649480058;638.3393188050369;32017.519737203962;42799.14401711968;43744.562554374446;43796.3430548542;43891.34162987554;45609.543904561026;46041.30938035932;46080.53919460804;46429.53570464294;46440.30339544901;7950.602469876512;8246.835063298731;8865.157810008055;9001.549922503882;9014;10509.737256568571;10766.676999690022;10769.78460430791;11107.111431085494;11129.7217569561;10914.399708016055;10977.560897564088;10999.175061870392;11009.724756881062;11018.779624407507;8041.236082572146;8316.043654979694;10465.267431279814;10778.514966826511;10839.674809755681;10296.124829389511;10713.83929241062;10724.678259652144;10745;10746.355218686904;42856.357154642705;43137.66659667864;43160.89971452707;43183.35224971628;43215.78392108051;3335.483000134983;3380.171857894807;3534.469829525566;3852.6339997700175;3902.7072969527117;29134.417311653648;31402.528962065586;31436.685633143603;32558.6744132558;32765;4275.743455392686;4287.206866729665;4312.805923733408;4315.503717072545;4391.231534481453;350311;356943;357241;473797.1443426776;475085;61054.69472652608;61637.69181154066;61767.6911615439;61816.381836181965;61846;65693.67153164203;66138.66930665316;66166.33833661601;66192;66223.66888165625;16568.420105296256;17095.829041709672;17191.1404429778;17677.558061048578;17724;11743.88256117428;12066.818997714865;12723.109382343333;13122.34388280582;13225.140365876186;19359.8064019358;19362.612747745246;19485.92827394507;19518.902405487883;19520.414387568395;6991.440684745208;7021.963630547084;7133.542839727509;7167.534110282815;7240.710371585183;940.7507010642186;1064.7338165458636;1069.0165048155716;1091.1925175370168;1153.1639561318145;32381;32721.672783272337;32767;32925.67074329226;32947;1063.7500187455942;1066.893310668927;1080.8432777247256;1095.4030053620795;1133.8582677165355;16288.837111628733;17233.913830430767;17268.827311726975;17295.481135565955;17339.393121240697;513940;514433;515042;516046;519951;39399.21201575953;39705.80147099246;39707.2058558833;39819;39824.60175398267;1203.4404002139047;1245.570278254019;1248.637895010455;1310.8164856920039;1326.2506683723666;30034.96486106117;33455;33526.329473410886;33717.325653487285;33987.4901876477;51507;52016.479835201164;52056.219156713436;52118;52279.21581176209;372452;372666;372924;373133;373657;28437.43125137527;28443.573346399407;28936.710632893402;29054.709452906045;30876.22809429782;46977.530224697315;47091.29363059625;47434.76282618565;47568.52431475641;47832.76083619559;39764.403533947596;40758;40879.795601021804;41510.37734433926;42423.57576424196;40299.95500674805;40834;40911.59088409078;41371.58628413677;41813.37279940742;40479.1904161921;40571;40617.59382406256;40880.1823963525;40957.38563921484;33734.49398258979;35372;36279;36293.45559816552;36691.81654091713;27609;27699.72300277052;27855;27977.44045119127;28150.85924570364 19:10:00 INFO - PROCESS | 29030 | |2;jquery.html;374.6029209038418;392.5897437178148;402.8630265709659;404.81176253042327;421.7490593097108;13090.738185236289;15206.566949288115;16566.66866662666;18944.431667049976;19578.70631940522;18739.43781686548;18842.05789710516;19011.144498497568;19456.22175112994;19493.610127797434;5560.776629141583;5662.150677398382;5898.321693005317;5906.822795316126;5907.113932910055;5499.477549632798;5773.56698247631;5814.796482123126;5823.330317013555;5862.032764593837;5602.271704678386;5705.058665320217;5780.624259423145;5781.364049954502;5782.624129431594;5755.827325180251;5764.106563482667;5798.7100644967795;5805.4194580542035;5810.5932584719085;5014.598832093424;5166.61250406221;5208.5572726318305;5213.7393130343335;5214.165733482662;22910;23076.307710768702;23183.652245216334;23232.883835580884;23427.531449371087;2174.07601769249;2450.718167410735;2847.8433686147255;3059.281068948795;3134.639516455591;10187.083162515335;10533;10608.567843341127;14158.716825663429;14434.927825360912;1877.3616970230187;1948.0844003318418;1962.6271008508338;1987.4037788663343;2002.5193953451212;79866.6006669963;83250.58374708149;85690;86283;86968;10678.252522323362;11006.779864402668;11081.335119892832;11184.44077796107;11462.828057579143;15894;15923.203839807964;15928.92035539815;15933.123678197579;15933.840661593467;7866.881996770053;8098.072434869084;8103.270705636521;8238.340932725368;8292.12932642076;7615.619219039026;7688.115866675292;7892.802679933047;7933.523988560705;7939.404544659058;4715.78778954941;4740.5733483986605;4755.120302743934;4915.238138088602;4944.826931057396;1954.0791402051805;2016.9294074707316;2033.2578608807678;2060.2994981706292;2063.2675400233;864.567716141929;931.3992474853682;954.5990683912635;967.1102585621245;1046.1839764983324;18182.45452636423;19439.611207776048;19587.412377628694;19614.01929903499;19868.60262794765;958.5878072428783;990.2474119669104;999.3604093380243;1029.0429900192892;1030.258214085857;10085.848712269322;10521.368717876952;10916.126709863192;10933.343999360064;11005.779884402267;458787;461849;463247;464570;474257;65962.67018664972;89710;89740;91161.54419227861;92090;975.658519518163;998.7802683409639;1032.0866033560353;1035.4563853976722;1035.7048241251207;16517.421890233785;16714.498565043068;17239.65520689604;17519.737203941695;17951;40706.185876281714;41016.384754228115;41084.1783164341;42305.15389692251;42978.570214297455;52946;57878.421215787304;62314.68842655939;63170.68414658081;63404;8157.102718701057;8181;8476.406651534333;8516.74449766508;8695.130486951255;11589.82615260755;12595.24428534291;13039.152455090389;13156.210627362007;13322.400491978078;10665.36007839532;11514.30914145154;11651.88348116542;11733.296002239893;12098.274103553815;10615.203859710708;11396.088312935111;11460.312381257152;11744.58893938708;12142.878571214174;5770.711464426846;9122.859642544681;9249.76875578089;11520.596779112691;11669.88330116722;8450.95774521148;8559.14408559164;8645.26515246186;8775.736727898173;8962.641494340154;11486.310821350746;11555.191136620691;11708.12189085839;11768.646270746056;11822.586209482626 19:10:00 INFO - PROCESS | 29030 | |3;mootools.html;1316.657669006058;1463.144060724476;1467.948621798237;1601.9919900400496;1755.4470341842327;7743.419243556735;8663.783405414868;8897.510636914967;8962.37263391562;9259.768505787342;9025.864612030808;9088.636454541827;9101.044390339019;9110.908890911089;9119;2345.472268739533;2376.4534157143867;2381.630847218675;2383.261189031397;2383.8450500717486;2308.8268379871492;2326.7673232676766;2370.2059809963685;2373.9881300593474;2376.0733314007553;2341.2156927429332;2357.2692465335717;2359.575276450238;2374.442006128558;2374.9406264843346;2291.919782807594;2322.674825524428;2329.499157681098;2329.9999999999914;2352;2295.540891821642;2299.1952816514254;2300.5168914527967;2301.0565668076174;2301.5857145713767;8837.116288371111;8996.325275604291;9004.954975225082;9010.504422256774;9024.323175761778;4532.274836026253;4679.672422930396;5085.79656813727;5095.312132862054;5223.764930578133;3349.346877358916;3450.516927630134;3456.8098754568487;3469.3061387722555;3488.4418493041244;1154.8902854228918;1166.3118759931597;1174.5008371442102;1195.862475815275;1197.5030362399593;12704.301263430507;12706;12819.679508012281;12829;12829.93585032069;4483.932741008887;4579.610733087658;4713.9764301178275;4763;4769.165396055746;10545.57817687284;10567.89432105669;10568.577256909637;10575.048245657928;10576.471176441148;5266.078436273637;5286.973565132226;5289.471052894757;5290.418054014055;5291.391489978625;4809.759512024385;4818.638602104857;4847.515248475124;4871.610271178297;4874.683145595525;3680.9263814723554;3713.313037088147;3741.7754934704003;3753.6246375362243;3818.5035945327486;1184.674214590977;1204.0608325506118;1220.261741646309;1224.406163010939;1226.889579937792;812.979675508117;898.1333013641867;908.2688435809105;932.4125800745487;963.7086304352201;5729;5772.105323674838;5905.852353691193;5961.821145365646;6229.2524897012645;451.9344695019204;461.3541042540403;463.9048994956026;471.42957022003077;471.8655183272751;3988.12261302513;4077.204945035749;4129.958700413017;4171.91656166875;4235.851745188904;9644.228461723045;10041.899581004243;10796.460176991277;11304;11320.830187547193;10507.789844203073;10738.087262582769;10914.072303854102;11285.266457680225;11288.379139147262;8266.586670666442;8305.792355191048;8389.244967952913;8435.873461898076;8453.070162282143;5674.2623458950075;5770.2498675171955;5775.711214439178;5814.447627475383;5920.141579471038;10117.949410252902;10203.183745300506;10219.1824654026;10241.641542545975;10344.120749736056;10107.140893024176;10388.792224155626;10603.840942386025;10628.627998020032;10633.308834925705;7739.806504837424;7814.804629884071;7829.569373684502;7832.451728378959;7834.373250139861;8537.146285371662;8544.700935467228;8621.396502244783;8628.094050124646;8630.956845215735;7674.731384401519;7814.101378341564;7853.646585903533;7870.881936771068;8142.307903828004;7625.199354067743;7656.961715191388;7722.227777222458;7757.612119393895;7764.456488045783;6980.371766541036;7138.357547820721;7213.278672132745;7237;7237.240089790706;4876;4952.702837829742;4995.300657907823;5065.164247899055;5215.634905556726;5123.385193776621;5143.279940808365;5163.27714120016;5327.22755200486;5335.226392173191 19:10:00 INFO - PROCESS | 29030 | |4;prototype.html;328.34331337325347;337.6286085306163;343.0890984436321;343.160971424866;346.35404969731445;5317.361916570012;5338.91991620125;5345.823918737871;5367.677939323638;5376.462353764627;5242.798024829571;5302.814401495948;5308.283381743464;5318.707471089088;5322.600804939626;4130;4166.9791651041705;4216.156768646268;4230.619244268008;4236.682248831335;4162.209180255757;4164.604362585549;4169.791510424467;4170.77060761658;4200.642945349649;4124.484439445069;4138.427397588927;4146.688998325122;4172.290710579194;4189.413482112506;3929.2141571685634;4047.1703300823556;4062.5328087270045;4118.043929133668;4142.212979533879;3655.817209139532;3656.579493358271;3662.7252956028137;3668.156324045458;3685.9863537527126;5071.782772134698;5100.546344291859;5122.641415100908;5126.846194614168;5163.199704045879;4398.274284743014;4478.507364189936;4709.175894218532;4736.313234580966;4747.359106520645;5482.80810171646;5489.807856724996;5507.201455788888;5524.889502209933;5565.471280228372;4043.65628921542;4049.481444458328;4057.0871553900433;4067.3288907330257;4069.491313585802;5437.374701909292;5644.8024319148635;5670.716464176775;5675.772969081232;5684.857878552986;4023.4166045923175;4039.111395492987;4057.107436363995;4060.5127384713433;4073.918521629551;4111.6299533042165;4128.979355103205;4130.752154870717;4131.772752498641;4133.6073073058615;4446.199684056836;4622.815087396534;4684.344191813149;4684.859454216379;4710.317004034464;5456.508914197741;5464.207689884945;5466.687994881279;5468.6171967962655;5476.151196564539;1403.256274174689;1411.6541447345467;1417.588899219215;1424.9715005699827;1426.8430472648001;930.2929773372285;930.3766476460787;943.9008904065112;987.8073775613686;1009.4902074452355;5204.271402003723;5221.738913054332;5223.518828556481;5233.685978841282;5237.214417837355;5615.326160860723;5626.35296940857;5642.605017648725;5670.177824215548;5683;5009.423916249605;5015.3480047593575;5203.401608814959;5212.862726282282;5234.581233501311;2877.6475056723307;2942.7498662613916;3020.704264758799;3022.8035177713377;3030.1818509002446;5852.853678658068;5866.413358664099;5879.735411906475;5888.5289176865745;5908.438698323653;5573.665580065128;5734.799282025193;5737.627054241461;5743.282089738783;5820.476157145792;5799.420057994251;5819.418058194146;5821.621594596338;5824.864151490418;5847.298324201123;5445.972770136124;5657.971710141423;5662.915056274077;5693.259876216231;5709.314882213995;5576.804811831566;5586.357568879631;5593.776248949996;5604.271444712162;5614.691191984317;5801.419858014165;5833.241678581757;5844.444777746107;5865.120231965068;5882.264716910387;3940.783256920782;4036.6367026967714;4067.4102255173425;4084;4091.795410229536;5526.50261476469;5573.916391254215;5574.275344205227;5576.693281869536;5622.8313150605545;5446.346438427414;5497.422770609189;5513.173024046425;5535.6955367455175;5551.805686800943;5262;5479.479449452296;5503.752331145188;5520.641158324696;5521.668699878021;5414.512693857571;5432.158015507603;5435.211894275229;5456.781728730806;5462.3445186577865;5378.73106344689;5485.314335708036;5514.200440936122;5519.972400137974;5565.693886836101;5342.171963345688;5348.625596208228;5352.812651557332;5363.0882749931825;5367.624266301322 19:10:00 INFO - PROCESS | 29030 | |5;yui.html;758.3591864874179;792.8176519400538;799.9120096789352;829.48571885431;853.0318088969022;14978.176200308979;15543.067415955036;15851.128187949687;15949.043057416564;16399.918000410013;14966;15362.308696108674;15602.609934751637;15613.141277229748;15623.531294061197;806.7297455352449;818.2758258940851;825.0923983618032;825.7316372179035;825.9132791056943;668.3149771484219;820.7948012996751;822.2681813186239;822.5969275055239;822.7367242482408;718.1633397092381;845.1675100026499;863.1584205399716;869.3827382558391;869.5391442535434;853.9359548033891;854.0647990450447;854.2269246332079;854.239726643288;854.6111519258753;624.5784095735406;625.8153844615849;626.1734510446213;626.4424662050778;626.564537646336;10844.13246940243;11317;14437.205953672545;15017.324220410108;15018.549443516602;14504.202268875208;15068.698626027419;15092.698146037128;15654.373825046985;15912.363505459767;11849.763004739943;11961.880381196164;12085.395730213455;12285.14004019719;12350.320732359716;3864.3816989281863;3925.2738243425056;3979.820908059144;3990.521137463494;4108.424820525129;81753.18246817515;81779.59110204471;82899;85283.88533259107;86533;11552.306861588331;11647.6505704829;11903.166778325434;11939.223950443193;12112;23146.305610831703;23166;23169.304920852403;23174.768252317597;23302;7961.8407631848195;7964.960175199087;8117.797055073553;8375.8324833503;8558.914410855936;4547.954520454753;4576.565226303496;4618.607418369409;4741.83403580873;4849.442314133919;3669.87155449558;3795.3358162321483;3797.582265950743;3797.6771974381936;3800.486934263839;615.9137720719103;623.2863371439677;623.6040114527308;645.8998855177455;653.6470306034784;621.0683974038942;654.5483616304734;704.9718011279595;709.673550166929;744.6388501576731;9197.908020919838;9429.717108486757;9765.609375625038;10061.849072263922;10119.59521619127;556.3462931055993;622.0637939900421;651.5927545284197;713.1442269276888;719.9532030418006;4341.218580655513;4660.067986402733;4718.575328220477;4723.291506274018;4754.429468463806;116340;117764;127871;128428;132287.33856330658;82144.58927705443;84264;85025;100340.49829750805;109836.450817747;52017.47982520202;57179.71410143006;79193.20806791974;80482;84391;9092.818143637223;9432.85850712226;9511;9580.37727547735;9635.181009614262;49324.75337623289;50443;50500.74749626228;51119.48880511296;52141.7392913033;71073.28926710667;72752;77704;79474.20525794668;79851.60074199592;12587.559435419716;12678.619641410773;12955.740885182433;13184.27486488214;13242.513071226385;14536.41854325815;14560.708785824012;14910.105393676415;15467.84532154709;15484.84515154879;13768.86231137716;13814.171149731048;14087.436502539784;14270.286485675882;14335.784963225351;13832;13852.584422467342;14057.542992892939;14177.432902683777;14451.78322325145;13104.279264640536;13371.39828707691;13616.795748063985;13837.515686950908;14306.57080287593;9818.45998470091;9879.456629885426;10022.498875056071;10240.18078553699;10401.479926003518;10190.949045254727;10712.785744284914;10816.837747433952;10837.566497340018;10893.128549715846 19:10:00 INFO - PROCESS | 29030 | __end_tp_report 19:10:00 INFO - PROCESS | 29030 | __start_cc_report 19:10:00 INFO - PROCESS | 29030 | _x_x_mozilla_cycle_collect,1129 19:10:00 INFO - PROCESS | 29030 | __end_cc_report 19:10:00 INFO - PROCESS | 29030 | __startTimestamp1476411000090__endTimestamp 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | ------- Summary: start ------- 19:10:00 INFO - PROCESS | 29030 | Number of tests: 6 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | [#0] dojo.html Cycles:165 Average:5246.60 Median:5422.57 stddev:596.19 (11.0%) stddev-sans-first:570.38 19:10:00 INFO - PROCESS | 29030 | Values: 2959.5 2989.0 2993.0 3022.8 3039.1 5094.0 5109.7 5166.4 5197.9 5264.9 5185.5 5194.8 5262.6 5283.3 5338.9 4686.8 4692.4 4723.1 4738.1 4766.6 4853.7 4868.4 4930.0 4937.7 5001.7 4741.5 4796.0 4796.6 4845.9 4919.8 4767.1 4821.0 4849.8 4864.4 4868.6 4814.8 4817.7 4821.6 4868.7 4880.1 5298.5 5327.7 5329.8 5331.0 5341.1 5465.2 5507.6 5520.3 5524.4 5698.9 5579.9 5695.1 5711.1 5712.1 5713.7 5265.3 5267.7 5269.4 5269.5 5271.8 5690.0 5755.3 5755.9 5764.8 5821.3 5268.9 5293.2 5293.2 5546.7 5580.4 5704.3 5704.9 5708.1 5711.3 5763.5 5688.9 5692.7 5693.4 5698.5 5706.3 5476.6 5526.3 5533.4 5626.5 5751.3 4304.1 4315.0 4332.3 4335.8 4347.8 3872.9 3887.3 3912.4 3922.6 3942.0 5276.4 5281.1 5286.5 5290.5 5355.3 5514.8 5628.5 5639.0 5672.1 5684.0 5267.7 5280.4 5317.2 5371.1 5374.5 4914.5 4929.6 4943.0 4946.6 4997.8 5688.8 5743.1 5883.0 5897.2 5897.9 5659.3 5707.2 5709.9 5741.4 5782.9 5906.8 5910.3 5916.4 5920.3 5921.5 5416.9 5607.3 5631.6 5643.6 5666.8 5580.1 5588.4 5615.2 5636.5 5710.5 5447.5 5493.9 5507.5 5507.8 5509.5 5494.6 5500.9 5503.8 5517.8 5573.5 5365.1 5422.6 5495.5 5539.1 5540.2 5610.6 5616.3 5616.7 5617.0 5661.9 5234.9 5338.3 5461.3 5475.9 5481.5 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | [#1] ext.html Cycles:180 Average:59378.63 Median:372795.00 stddev:115443.55 (31.0%) stddev-sans-first:115682.91 19:10:00 INFO - PROCESS | 29030 | Values: 554.4 597.9 609.5 612.0 638.3 32017.5 42799.1 43744.6 43796.3 43891.3 45609.5 46041.3 46080.5 46429.5 46440.3 7950.6 8246.8 8865.2 9001.5 9014.0 10509.7 10766.7 10769.8 11107.1 11129.7 10914.4 10977.6 10999.2 11009.7 11018.8 8041.2 8316.0 10465.3 10778.5 10839.7 10296.1 10713.8 10724.7 10745.0 10746.4 42856.4 43137.7 43160.9 43183.4 43215.8 3335.5 3380.2 3534.5 3852.6 3902.7 29134.4 31402.5 31436.7 32558.7 32765.0 4275.7 4287.2 4312.8 4315.5 4391.2 350311.0 356943.0 357241.0 473797.1 475085.0 61054.7 61637.7 61767.7 61816.4 61846.0 65693.7 66138.7 66166.3 66192.0 66223.7 16568.4 17095.8 17191.1 17677.6 17724.0 11743.9 12066.8 12723.1 13122.3 13225.1 19359.8 19362.6 19485.9 19518.9 19520.4 6991.4 7022.0 7133.5 7167.5 7240.7 940.8 1064.7 1069.0 1091.2 1153.2 32381.0 32721.7 32767.0 32925.7 32947.0 1063.8 1066.9 1080.8 1095.4 1133.9 16288.8 17233.9 17268.8 17295.5 17339.4 513940.0 514433.0 515042.0 516046.0 519951.0 39399.2 39705.8 39707.2 39819.0 39824.6 1203.4 1245.6 1248.6 1310.8 1326.3 30035.0 33455.0 33526.3 33717.3 33987.5 51507.0 52016.5 52056.2 52118.0 52279.2 372452.0 372666.0 372924.0 373133.0 373657.0 28437.4 28443.6 28936.7 29054.7 30876.2 46977.5 47091.3 47434.8 47568.5 47832.8 39764.4 40758.0 40879.8 41510.4 42423.6 40300.0 40834.0 40911.6 41371.6 41813.4 40479.2 40571.0 40617.6 40880.2 40957.4 33734.5 35372.0 36279.0 36293.5 36691.8 27609.0 27699.7 27855.0 27977.4 28150.9 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | [#2] jquery.html Cycles:180 Average:28178.52 Median:403.84 stddev:76733.42 (19001.1%) stddev-sans-first:76920.28 19:10:00 INFO - PROCESS | 29030 | Values: 374.6 392.6 402.9 404.8 421.7 13090.7 15206.6 16566.7 18944.4 19578.7 18739.4 18842.1 19011.1 19456.2 19493.6 5560.8 5662.2 5898.3 5906.8 5907.1 5499.5 5773.6 5814.8 5823.3 5862.0 5602.3 5705.1 5780.6 5781.4 5782.6 5755.8 5764.1 5798.7 5805.4 5810.6 5014.6 5166.6 5208.6 5213.7 5214.2 22910.0 23076.3 23183.7 23232.9 23427.5 2174.1 2450.7 2847.8 3059.3 3134.6 10187.1 10533.0 10608.6 14158.7 14434.9 1877.4 1948.1 1962.6 1987.4 2002.5 79866.6 83250.6 85690.0 86283.0 86968.0 10678.3 11006.8 11081.3 11184.4 11462.8 15894.0 15923.2 15928.9 15933.1 15933.8 7866.9 8098.1 8103.3 8238.3 8292.1 7615.6 7688.1 7892.8 7933.5 7939.4 4715.8 4740.6 4755.1 4915.2 4944.8 1954.1 2016.9 2033.3 2060.3 2063.3 864.6 931.4 954.6 967.1 1046.2 18182.5 19439.6 19587.4 19614.0 19868.6 958.6 990.2 999.4 1029.0 1030.3 10085.8 10521.4 10916.1 10933.3 11005.8 458787.0 461849.0 463247.0 464570.0 474257.0 65962.7 89710.0 89740.0 91161.5 92090.0 975.7 998.8 1032.1 1035.5 1035.7 16517.4 16714.5 17239.7 17519.7 17951.0 40706.2 41016.4 41084.2 42305.2 42978.6 52946.0 57878.4 62314.7 63170.7 63404.0 8157.1 8181.0 8476.4 8516.7 8695.1 11589.8 12595.2 13039.2 13156.2 13322.4 10665.4 11514.3 11651.9 11733.3 12098.3 10615.2 11396.1 11460.3 11744.6 12142.9 5770.7 9122.9 9249.8 11520.6 11669.9 8451.0 8559.1 8645.3 8775.7 8962.6 11486.3 11555.2 11708.1 11768.6 11822.6 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | [#3] mootools.html Cycles:180 Average:5829.15 Median:2575.55 stddev:3388.09 (131.5%) stddev-sans-first:3380.63 19:10:00 INFO - PROCESS | 29030 | Values: 1316.7 1463.1 1467.9 1602.0 1755.4 7743.4 8663.8 8897.5 8962.4 9259.8 9025.9 9088.6 9101.0 9110.9 9119.0 2345.5 2376.5 2381.6 2383.3 2383.8 2308.8 2326.8 2370.2 2374.0 2376.1 2341.2 2357.3 2359.6 2374.4 2374.9 2291.9 2322.7 2329.5 2330.0 2352.0 2295.5 2299.2 2300.5 2301.1 2301.6 8837.1 8996.3 9005.0 9010.5 9024.3 4532.3 4679.7 5085.8 5095.3 5223.8 3349.3 3450.5 3456.8 3469.3 3488.4 1154.9 1166.3 1174.5 1195.9 1197.5 12704.3 12706.0 12819.7 12829.0 12829.9 4483.9 4579.6 4714.0 4763.0 4769.2 10545.6 10567.9 10568.6 10575.0 10576.5 5266.1 5287.0 5289.5 5290.4 5291.4 4809.8 4818.6 4847.5 4871.6 4874.7 3680.9 3713.3 3741.8 3753.6 3818.5 1184.7 1204.1 1220.3 1224.4 1226.9 813.0 898.1 908.3 932.4 963.7 5729.0 5772.1 5905.9 5961.8 6229.3 451.9 461.4 463.9 471.4 471.9 3988.1 4077.2 4130.0 4171.9 4235.9 9644.2 10041.9 10796.5 11304.0 11320.8 10507.8 10738.1 10914.1 11285.3 11288.4 8266.6 8305.8 8389.2 8435.9 8453.1 5674.3 5770.2 5775.7 5814.4 5920.1 10117.9 10203.2 10219.2 10241.6 10344.1 10107.1 10388.8 10603.8 10628.6 10633.3 7739.8 7814.8 7829.6 7832.5 7834.4 8537.1 8544.7 8621.4 8628.1 8631.0 7674.7 7814.1 7853.6 7870.9 8142.3 7625.2 7657.0 7722.2 7757.6 7764.5 6980.4 7138.4 7213.3 7237.0 7237.2 4876.0 4952.7 4995.3 5065.2 5215.6 5123.4 5143.3 5163.3 5327.2 5335.2 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | [#4] prototype.html Cycles:180 Average:4643.64 Median:5318.03 stddev:1350.94 (25.4%) stddev-sans-first:1315.33 19:10:00 INFO - PROCESS | 29030 | Values: 328.3 337.6 343.1 343.2 346.4 5317.4 5338.9 5345.8 5367.7 5376.5 5242.8 5302.8 5308.3 5318.7 5322.6 4130.0 4167.0 4216.2 4230.6 4236.7 4162.2 4164.6 4169.8 4170.8 4200.6 4124.5 4138.4 4146.7 4172.3 4189.4 3929.2 4047.2 4062.5 4118.0 4142.2 3655.8 3656.6 3662.7 3668.2 3686.0 5071.8 5100.5 5122.6 5126.8 5163.2 4398.3 4478.5 4709.2 4736.3 4747.4 5482.8 5489.8 5507.2 5524.9 5565.5 4043.7 4049.5 4057.1 4067.3 4069.5 5437.4 5644.8 5670.7 5675.8 5684.9 4023.4 4039.1 4057.1 4060.5 4073.9 4111.6 4129.0 4130.8 4131.8 4133.6 4446.2 4622.8 4684.3 4684.9 4710.3 5456.5 5464.2 5466.7 5468.6 5476.2 1403.3 1411.7 1417.6 1425.0 1426.8 930.3 930.4 943.9 987.8 1009.5 5204.3 5221.7 5223.5 5233.7 5237.2 5615.3 5626.4 5642.6 5670.2 5683.0 5009.4 5015.3 5203.4 5212.9 5234.6 2877.6 2942.7 3020.7 3022.8 3030.2 5852.9 5866.4 5879.7 5888.5 5908.4 5573.7 5734.8 5737.6 5743.3 5820.5 5799.4 5819.4 5821.6 5824.9 5847.3 5446.0 5658.0 5662.9 5693.3 5709.3 5576.8 5586.4 5593.8 5604.3 5614.7 5801.4 5833.2 5844.4 5865.1 5882.3 3940.8 4036.6 4067.4 4084.0 4091.8 5526.5 5573.9 5574.3 5576.7 5622.8 5446.3 5497.4 5513.2 5535.7 5551.8 5262.0 5479.5 5503.8 5520.6 5521.7 5414.5 5432.2 5435.2 5456.8 5462.3 5378.7 5485.3 5514.2 5520.0 5565.7 5342.2 5348.6 5352.8 5363.1 5367.6 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - PROCESS | 29030 | [#5] yui.html Cycles:180 Average:20736.06 Median:4639.34 stddev:30136.32 (649.6%) stddev-sans-first:30183.53 19:10:00 INFO - PROCESS | 29030 | Values: 758.4 792.8 799.9 829.5 853.0 14978.2 15543.1 15851.1 15949.0 16399.9 14966.0 15362.3 15602.6 15613.1 15623.5 806.7 818.3 825.1 825.7 825.9 668.3 820.8 822.3 822.6 822.7 718.2 845.2 863.2 869.4 869.5 853.9 854.1 854.2 854.2 854.6 624.6 625.8 626.2 626.4 626.6 10844.1 11317.0 14437.2 15017.3 15018.5 14504.2 15068.7 15092.7 15654.4 15912.4 11849.8 11961.9 12085.4 12285.1 12350.3 3864.4 3925.3 3979.8 3990.5 4108.4 81753.2 81779.6 82899.0 85283.9 86533.0 11552.3 11647.7 11903.2 11939.2 12112.0 23146.3 23166.0 23169.3 23174.8 23302.0 7961.8 7965.0 8117.8 8375.8 8558.9 4548.0 4576.6 4618.6 4741.8 4849.4 3669.9 3795.3 3797.6 3797.7 3800.5 615.9 623.3 623.6 645.9 653.6 621.1 654.5 705.0 709.7 744.6 9197.9 9429.7 9765.6 10061.8 10119.6 556.3 622.1 651.6 713.1 720.0 4341.2 4660.1 4718.6 4723.3 4754.4 116340.0 117764.0 127871.0 128428.0 132287.3 82144.6 84264.0 85025.0 100340.5 109836.5 52017.5 57179.7 79193.2 80482.0 84391.0 9092.8 9432.9 9511.0 9580.4 9635.2 49324.8 50443.0 50500.7 51119.5 52141.7 71073.3 72752.0 77704.0 79474.2 79851.6 12587.6 12678.6 12955.7 13184.3 13242.5 14536.4 14560.7 14910.1 15467.8 15484.8 13768.9 13814.2 14087.4 14270.3 14335.8 13832.0 13852.6 14057.5 14177.4 14451.8 13104.3 13371.4 13616.8 13837.5 14306.6 9818.5 9879.5 10022.5 10240.2 10401.5 10190.9 10712.8 10816.8 10837.6 10893.1 19:10:00 INFO - PROCESS | 29030 | -------- Summary: end -------- 19:10:00 INFO - PROCESS | 29030 | 19:10:00 INFO - TEST-INFO | 29030: exit 0 19:10:00 INFO - TEST-OK | dromaeo_css | took 1117516ms 19:10:00 INFO - TEST-START | kraken 19:10:00 INFO - operating with platform_type : linux_ 19:10:00 INFO - Initialising browser for kraken test... 19:10:00 INFO - TEST-INFO | started process 29335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcqEh5/profile http://localhost:35258/getInfo.html) 19:10:04 INFO - PROCESS | 29335 | __metrics Screen width/height:1600/1200 19:10:04 INFO - PROCESS | 29335 | colorDepth:24 19:10:04 INFO - PROCESS | 29335 | Browser inner width/height: 1024/697 19:10:04 INFO - PROCESS | 29335 | __metrics 19:10:05 INFO - PROCESS | 29335 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:10:05 INFO - PROCESS | 29335 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:10:05 INFO - PROCESS | 29335 | console.error: PushService: 19:10:05 INFO - PROCESS | 29335 | stateChangeProcessEnqueue: Error transitioning state 19:10:05 INFO - PROCESS | 29335 | UnknownError 19:10:06 INFO - TEST-INFO | 29335: exit 0 19:10:06 INFO - Browser initialized. 19:10:06 INFO - Running cycle 1/1 for kraken test... 19:10:06 INFO - TEST-INFO | started process 29416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHcqEh5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:18 INFO - PROCESS | 29416 | RSS: Main: 172806144 19:10:18 INFO - PROCESS | 29416 | 19:10:21 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35258/tests/kraken/driver.html?testName=audio-beat-detection) 19:10:21 INFO - PROCESS | 29416 | RSS: Main: 232464384 19:10:21 INFO - PROCESS | 29416 | 19:10:24 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35258/tests/kraken/driver.html?testName=audio-dft) 19:10:25 INFO - PROCESS | 29416 | RSS: Main: 217362432 19:10:25 INFO - PROCESS | 29416 | 19:10:28 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35258/tests/kraken/driver.html?testName=audio-fft) 19:10:28 INFO - PROCESS | 29416 | RSS: Main: 299134976 19:10:28 INFO - PROCESS | 29416 | 19:10:31 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35258/tests/kraken/driver.html?testName=audio-oscillator) 19:10:31 INFO - PROCESS | 29416 | RSS: Main: 207659008 19:10:31 INFO - PROCESS | 29416 | 19:10:33 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:10:34 INFO - PROCESS | 29416 | RSS: Main: 212336640 19:10:34 INFO - PROCESS | 29416 | 19:10:37 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35258/tests/kraken/driver.html?testName=imaging-darkroom) 19:10:38 INFO - PROCESS | 29416 | RSS: Main: 249409536 19:10:38 INFO - PROCESS | 29416 | 19:10:41 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35258/tests/kraken/driver.html?testName=imaging-desaturate) 19:10:42 INFO - PROCESS | 29416 | RSS: Main: 248213504 19:10:42 INFO - PROCESS | 29416 | 19:10:44 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35258/tests/kraken/driver.html?testName=json-parse-financial) 19:10:45 INFO - PROCESS | 29416 | RSS: Main: 247693312 19:10:45 INFO - PROCESS | 29416 | 19:10:46 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:10:47 INFO - PROCESS | 29416 | RSS: Main: 209313792 19:10:47 INFO - PROCESS | 29416 | 19:10:49 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:49 INFO - PROCESS | 29416 | RSS: Main: 216596480 19:10:49 INFO - PROCESS | 29416 | 19:10:51 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:52 INFO - PROCESS | 29416 | RSS: Main: 226545664 19:10:52 INFO - PROCESS | 29416 | 19:10:55 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:55 INFO - PROCESS | 29416 | RSS: Main: 234491904 19:10:55 INFO - PROCESS | 29416 | 19:10:58 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:59 INFO - PROCESS | 29416 | RSS: Main: 232075264 19:10:59 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | Cycle 1(1): loaded http://localhost:35258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35258/tests/kraken/driver.html?testName=ai-astar) 19:11:01 INFO - PROCESS | 29416 | RSS: Main: 280977408 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | __start_tp_report 19:11:01 INFO - PROCESS | 29416 | _x_x_mozilla_page_load 19:11:01 INFO - PROCESS | 29416 | _x_x_mozilla_page_load_details 19:11:01 INFO - PROCESS | 29416 | |i|pagename|runs| 19:11:01 INFO - PROCESS | 29416 | |0;ai-astar;107;111;112;111;112;111;110;112;112;110 19:11:01 INFO - PROCESS | 29416 | |1;audio-beat-detection;148;122;123;164;123;127;129;125;165;125 19:11:01 INFO - PROCESS | 29416 | |2;audio-dft;161;162;160;161;160;162;163;162;162;163 19:11:01 INFO - PROCESS | 29416 | |3;audio-fft;76;77;77;115;76;76;77;76;98;76 19:11:01 INFO - PROCESS | 29416 | |4;audio-oscillator;82;81;133;82;82;83;115;83;82;112 19:11:01 INFO - PROCESS | 29416 | |5;imaging-gaussian-blur;116;118;118;118;118;119;117;118;118;117 19:11:01 INFO - PROCESS | 29416 | |6;imaging-darkroom;146;146;145;146;146;145;146;145;146;145 19:11:01 INFO - PROCESS | 29416 | |7;imaging-desaturate;94;96;96;96;97;96;96;97;96;96 19:11:01 INFO - PROCESS | 29416 | |8;json-parse-financial;53;52;52;51;51;53;52;53;52;53 19:11:01 INFO - PROCESS | 29416 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;61;62;62 19:11:01 INFO - PROCESS | 29416 | |10;stanford-crypto-aes;88;82;79;83;79;85;80;80;88;79 19:11:01 INFO - PROCESS | 29416 | |11;stanford-crypto-ccm;132;133;130;131;143;141;127;130;178;137 19:11:01 INFO - PROCESS | 29416 | |12;stanford-crypto-pbkdf2;166;169;166;164;167;168;165;170;167;165 19:11:01 INFO - PROCESS | 29416 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;66;68;65;68;65 19:11:01 INFO - PROCESS | 29416 | __end_tp_report 19:11:01 INFO - PROCESS | 29416 | __start_cc_report 19:11:01 INFO - PROCESS | 29416 | _x_x_mozilla_cycle_collect,1728 19:11:01 INFO - PROCESS | 29416 | __end_cc_report 19:11:01 INFO - PROCESS | 29416 | __startTimestamp1476411061261__endTimestamp 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | ------- Summary: start ------- 19:11:01 INFO - PROCESS | 29416 | Number of tests: 14 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.55 (1.4%) stddev-sans-first:0.83 19:11:01 INFO - PROCESS | 29416 | Values: 107.0 111.0 112.0 111.0 112.0 111.0 110.0 112.0 112.0 110.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:128.00 stddev:17.21 (13.4%) stddev-sans-first:17.61 19:11:01 INFO - PROCESS | 29416 | Values: 148.0 122.0 123.0 164.0 123.0 127.0 129.0 125.0 165.0 125.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 19:11:01 INFO - PROCESS | 29416 | Values: 161.0 162.0 160.0 161.0 160.0 162.0 163.0 162.0 162.0 163.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:13.33 (17.4%) stddev-sans-first:13.93 19:11:01 INFO - PROCESS | 29416 | Values: 76.0 77.0 77.0 115.0 76.0 76.0 77.0 76.0 98.0 76.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:82.00 stddev:19.06 (23.2%) stddev-sans-first:19.76 19:11:01 INFO - PROCESS | 29416 | Values: 82.0 81.0 133.0 82.0 82.0 83.0 115.0 83.0 82.0 112.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 19:11:01 INFO - PROCESS | 29416 | Values: 116.0 118.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 117.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:11:01 INFO - PROCESS | 29416 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.44 19:11:01 INFO - PROCESS | 29416 | Values: 94.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:0.79 (1.5%) stddev-sans-first:0.78 19:11:01 INFO - PROCESS | 29416 | Values: 53.0 52.0 52.0 51.0 51.0 53.0 52.0 53.0 52.0 53.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 19:11:01 INFO - PROCESS | 29416 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:3.59 (4.4%) stddev-sans-first:3.16 19:11:01 INFO - PROCESS | 29416 | Values: 88.0 82.0 79.0 83.0 79.0 85.0 80.0 80.0 88.0 79.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:135.00 stddev:14.88 (11.0%) stddev-sans-first:15.62 19:11:01 INFO - PROCESS | 29416 | Values: 132.0 133.0 130.0 131.0 143.0 141.0 127.0 130.0 178.0 137.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:1.89 (1.1%) stddev-sans-first:1.99 19:11:01 INFO - PROCESS | 29416 | Values: 166.0 169.0 166.0 164.0 167.0 168.0 165.0 170.0 167.0 165.0 19:11:01 INFO - PROCESS | 29416 | 19:11:01 INFO - PROCESS | 29416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.12 19:11:01 INFO - PROCESS | 29416 | Values: 67.0 66.0 67.0 66.0 66.0 66.0 68.0 65.0 68.0 65.0 19:11:01 INFO - PROCESS | 29416 | -------- Summary: end -------- 19:11:01 INFO - PROCESS | 29416 | 19:11:02 INFO - TEST-INFO | 29416: exit 0 19:11:02 INFO - TEST-OK | kraken | took 61586ms 19:11:02 INFO - SUITE-END | took 1179s 19:11:02 INFO - Completed test suite (00:19:39) 19:11:02 INFO - javascript benchmark 19:11:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2959.482090634139, 2988.968805762012, 2992.9551056734153, 3022.8186308821487, 3039.149038269284, 5094.0, 5109.693418394899, 5166.354205724285, 5197.896042079161, 5264.92102618461, 5185.507376799207, 5194.792208311673, 5262.578993680506, 5283.313169287997, 5338.946610533893, 4686.835960741375, 4692.389989301386, 4723.126221648989, 4738.099761045391, 4766.594839438651, 4853.684510506823, 4868.367112275399, 4930.03864246472, 4937.728424936627, 5001.6998980061135, 4741.525847415265, 4796.04079184161, 4796.592289655384, 4845.854624361275, 4919.803207871681, 4767.070421267854, 4821.035792841446, 4849.757512124415, 4864.367632207825, 4868.586170175539, 4814.831480898187, 4817.7350245736825, 4821.63837712173, 4868.659193856432, 4880.145974454456, 5298.470152984709, 5327.680339179662, 5329.760160792774, 5330.973345133289, 5341.145416733343, 5465.180222966586, 5507.586930980193, 5520.337559492847, 5524.447555244444, 5698.886022279573, 5579.9163012554845, 5695.088785794253, 5711.05767548354, 5712.057510510802, 5713.685747283897, 5265.315508983807, 5267.683938963636, 5269.446708095633, 5269.525742683139, 5271.78912843482, 5690.0, 5755.309362876482, 5755.8561035974435, 5764.769409223668, 5821.27234095738, 5268.92096618551, 5293.153095504701, 5293.179557168645, 5546.722663866791, 5580.414056524007, 5704.344000440003, 5704.942950570524, 5708.115242137475, 5711.343195532567, 5763.4812866842185, 5688.8862222755315, 5692.658440493584, 5693.373728889819, 5698.515626171822, 5706.258186435737, 5476.616636835383, 5526.253955715927, 5533.391326954032, 5626.465485778845, 5751.338596061507, 4304.053108316165, 4315.029118448324, 4332.328489084197, 4335.804888780012, 4347.847825326098, 3872.9031774205305, 3887.3391523441082, 3912.4131380292615, 3922.5685174630767, 3942.0342016206214, 5276.445973172762, 5281.12861377876, 5286.524212820865, 5290.523852853262, 5355.250264962909, 5514.751836167382, 5628.549716022709, 5639.0, 5672.064109421982, 5683.9715801420725, 5267.657602255841, 5280.445553216934, 5317.202419637086, 5371.140617501181, 5374.48942350476, 4914.508549145128, 4929.556339929423, 4942.9752851236235, 4946.629002824802, 4997.800087996512, 5688.77244910199, 5743.10981797822, 5883.02930016551, 5897.174395584708, 5897.941020589825, 5659.349174844946, 5707.1724599933605, 5709.942900571107, 5741.368449470471, 5782.884342313214, 5906.793262235801, 5910.320313164041, 5916.378780228014, 5920.348761636303, 5921.526277897672, 5416.8645783854145, 5607.327120745536, 5631.63394379364, 5643.576731745217, 5666.801661941812, 5580.107182850725, 5588.3573389060775, 5615.213870058276, 5636.520895723909, 5710.457506536873, 5447.509724124848, 5493.917591236055, 5507.531859791962, 5507.807226747044, 5509.47659972302, 5494.587905907153, 5500.889982200253, 5503.807366742145, 5517.751701173376, 5573.498385145356, 5365.087935051129, 5422.566194704335, 5495.53287970527, 5539.058360078877, 5540.22436858832, 5610.607257491936, 5616.269884915098, 5616.69108199053, 5617.0, 5661.858453538694, 5234.869128271824, 5338.252644629677, 5461.2627295316215, 5475.890482190413, 5481.451854814487], "value": 5206.0481866302125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.4150920778579, 597.9431953964373, 609.5154352289932, 612.0482649480058, 638.3393188050369, 32017.519737203962, 42799.14401711968, 43744.562554374446, 43796.3430548542, 43891.34162987554, 45609.543904561026, 46041.30938035932, 46080.53919460804, 46429.53570464294, 46440.30339544901, 7950.602469876512, 8246.835063298731, 8865.157810008055, 9001.549922503882, 9014.0, 10509.737256568571, 10766.676999690022, 10769.78460430791, 11107.111431085494, 11129.7217569561, 10914.399708016055, 10977.560897564088, 10999.175061870392, 11009.724756881062, 11018.779624407507, 8041.236082572146, 8316.043654979694, 10465.267431279814, 10778.514966826511, 10839.674809755681, 10296.124829389511, 10713.83929241062, 10724.678259652144, 10745.0, 10746.355218686904, 42856.357154642705, 43137.66659667864, 43160.89971452707, 43183.35224971628, 43215.78392108051, 3335.483000134983, 3380.171857894807, 3534.469829525566, 3852.6339997700175, 3902.7072969527117, 29134.417311653648, 31402.528962065586, 31436.685633143603, 32558.6744132558, 32765.0, 4275.743455392686, 4287.206866729665, 4312.805923733408, 4315.503717072545, 4391.231534481453, 350311.0, 356943.0, 357241.0, 473797.1443426776, 475085.0, 61054.69472652608, 61637.69181154066, 61767.6911615439, 61816.381836181965, 61846.0, 65693.67153164203, 66138.66930665316, 66166.33833661601, 66192.0, 66223.66888165625, 16568.420105296256, 17095.829041709672, 17191.1404429778, 17677.558061048578, 17724.0, 11743.88256117428, 12066.818997714865, 12723.109382343333, 13122.34388280582, 13225.140365876186, 19359.8064019358, 19362.612747745246, 19485.92827394507, 19518.902405487883, 19520.414387568395, 6991.440684745208, 7021.963630547084, 7133.542839727509, 7167.534110282815, 7240.710371585183, 940.7507010642186, 1064.7338165458636, 1069.0165048155716, 1091.1925175370168, 1153.1639561318145, 32381.0, 32721.672783272337, 32767.0, 32925.67074329226, 32947.0, 1063.7500187455942, 1066.893310668927, 1080.8432777247256, 1095.4030053620795, 1133.8582677165355, 16288.837111628733, 17233.913830430767, 17268.827311726975, 17295.481135565955, 17339.393121240697, 513940.0, 514433.0, 515042.0, 516046.0, 519951.0, 39399.21201575953, 39705.80147099246, 39707.2058558833, 39819.0, 39824.60175398267, 1203.4404002139047, 1245.570278254019, 1248.637895010455, 1310.8164856920039, 1326.2506683723666, 30034.96486106117, 33455.0, 33526.329473410886, 33717.325653487285, 33987.4901876477, 51507.0, 52016.479835201164, 52056.219156713436, 52118.0, 52279.21581176209, 372452.0, 372666.0, 372924.0, 373133.0, 373657.0, 28437.43125137527, 28443.573346399407, 28936.710632893402, 29054.709452906045, 30876.22809429782, 46977.530224697315, 47091.29363059625, 47434.76282618565, 47568.52431475641, 47832.76083619559, 39764.403533947596, 40758.0, 40879.795601021804, 41510.37734433926, 42423.57576424196, 40299.95500674805, 40834.0, 40911.59088409078, 41371.58628413677, 41813.37279940742, 40479.1904161921, 40571.0, 40617.59382406256, 40880.1823963525, 40957.38563921484, 33734.49398258979, 35372.0, 36279.0, 36293.45559816552, 36691.81654091713, 27609.0, 27699.72300277052, 27855.0, 27977.44045119127, 28150.85924570364], "value": 20348.116667961807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.6029209038418, 392.5897437178148, 402.8630265709659, 404.81176253042327, 421.7490593097108, 13090.738185236289, 15206.566949288115, 16566.66866662666, 18944.431667049976, 19578.70631940522, 18739.43781686548, 18842.05789710516, 19011.144498497568, 19456.22175112994, 19493.610127797434, 5560.776629141583, 5662.150677398382, 5898.321693005317, 5906.822795316126, 5907.113932910055, 5499.477549632798, 5773.56698247631, 5814.796482123126, 5823.330317013555, 5862.032764593837, 5602.271704678386, 5705.058665320217, 5780.624259423145, 5781.364049954502, 5782.624129431594, 5755.827325180251, 5764.106563482667, 5798.7100644967795, 5805.4194580542035, 5810.5932584719085, 5014.598832093424, 5166.61250406221, 5208.5572726318305, 5213.7393130343335, 5214.165733482662, 22910.0, 23076.307710768702, 23183.652245216334, 23232.883835580884, 23427.531449371087, 2174.07601769249, 2450.718167410735, 2847.8433686147255, 3059.281068948795, 3134.639516455591, 10187.083162515335, 10533.0, 10608.567843341127, 14158.716825663429, 14434.927825360912, 1877.3616970230187, 1948.0844003318418, 1962.6271008508338, 1987.4037788663343, 2002.5193953451212, 79866.6006669963, 83250.58374708149, 85690.0, 86283.0, 86968.0, 10678.252522323362, 11006.779864402668, 11081.335119892832, 11184.44077796107, 11462.828057579143, 15894.0, 15923.203839807964, 15928.92035539815, 15933.123678197579, 15933.840661593467, 7866.881996770053, 8098.072434869084, 8103.270705636521, 8238.340932725368, 8292.12932642076, 7615.619219039026, 7688.115866675292, 7892.802679933047, 7933.523988560705, 7939.404544659058, 4715.78778954941, 4740.5733483986605, 4755.120302743934, 4915.238138088602, 4944.826931057396, 1954.0791402051805, 2016.9294074707316, 2033.2578608807678, 2060.2994981706292, 2063.2675400233, 864.567716141929, 931.3992474853682, 954.5990683912635, 967.1102585621245, 1046.1839764983324, 18182.45452636423, 19439.611207776048, 19587.412377628694, 19614.01929903499, 19868.60262794765, 958.5878072428783, 990.2474119669104, 999.3604093380243, 1029.0429900192892, 1030.258214085857, 10085.848712269322, 10521.368717876952, 10916.126709863192, 10933.343999360064, 11005.779884402267, 458787.0, 461849.0, 463247.0, 464570.0, 474257.0, 65962.67018664972, 89710.0, 89740.0, 91161.54419227861, 92090.0, 975.658519518163, 998.7802683409639, 1032.0866033560353, 1035.4563853976722, 1035.7048241251207, 16517.421890233785, 16714.498565043068, 17239.65520689604, 17519.737203941695, 17951.0, 40706.185876281714, 41016.384754228115, 41084.1783164341, 42305.15389692251, 42978.570214297455, 52946.0, 57878.421215787304, 62314.68842655939, 63170.68414658081, 63404.0, 8157.102718701057, 8181.0, 8476.406651534333, 8516.74449766508, 8695.130486951255, 11589.82615260755, 12595.24428534291, 13039.152455090389, 13156.210627362007, 13322.400491978078, 10665.36007839532, 11514.30914145154, 11651.88348116542, 11733.296002239893, 12098.274103553815, 10615.203859710708, 11396.088312935111, 11460.312381257152, 11744.58893938708, 12142.878571214174, 5770.711464426846, 9122.859642544681, 9249.76875578089, 11520.596779112691, 11669.88330116722, 8450.95774521148, 8559.14408559164, 8645.26515246186, 8775.736727898173, 8962.641494340154, 11486.310821350746, 11555.191136620691, 11708.12189085839, 11768.646270746056, 11822.586209482626], "value": 9182.395318980256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.657669006058, 1463.144060724476, 1467.948621798237, 1601.9919900400496, 1755.4470341842327, 7743.419243556735, 8663.783405414868, 8897.510636914967, 8962.37263391562, 9259.768505787342, 9025.864612030808, 9088.636454541827, 9101.044390339019, 9110.908890911089, 9119.0, 2345.472268739533, 2376.4534157143867, 2381.630847218675, 2383.261189031397, 2383.8450500717486, 2308.8268379871492, 2326.7673232676766, 2370.2059809963685, 2373.9881300593474, 2376.0733314007553, 2341.2156927429332, 2357.2692465335717, 2359.575276450238, 2374.442006128558, 2374.9406264843346, 2291.919782807594, 2322.674825524428, 2329.499157681098, 2329.9999999999914, 2352.0, 2295.540891821642, 2299.1952816514254, 2300.5168914527967, 2301.0565668076174, 2301.5857145713767, 8837.116288371111, 8996.325275604291, 9004.954975225082, 9010.504422256774, 9024.323175761778, 4532.274836026253, 4679.672422930396, 5085.79656813727, 5095.312132862054, 5223.764930578133, 3349.346877358916, 3450.516927630134, 3456.8098754568487, 3469.3061387722555, 3488.4418493041244, 1154.8902854228918, 1166.3118759931597, 1174.5008371442102, 1195.862475815275, 1197.5030362399593, 12704.301263430507, 12706.0, 12819.679508012281, 12829.0, 12829.93585032069, 4483.932741008887, 4579.610733087658, 4713.9764301178275, 4763.0, 4769.165396055746, 10545.57817687284, 10567.89432105669, 10568.577256909637, 10575.048245657928, 10576.471176441148, 5266.078436273637, 5286.973565132226, 5289.471052894757, 5290.418054014055, 5291.391489978625, 4809.759512024385, 4818.638602104857, 4847.515248475124, 4871.610271178297, 4874.683145595525, 3680.9263814723554, 3713.313037088147, 3741.7754934704003, 3753.6246375362243, 3818.5035945327486, 1184.674214590977, 1204.0608325506118, 1220.261741646309, 1224.406163010939, 1226.889579937792, 812.979675508117, 898.1333013641867, 908.2688435809105, 932.4125800745487, 963.7086304352201, 5729.0, 5772.105323674838, 5905.852353691193, 5961.821145365646, 6229.2524897012645, 451.9344695019204, 461.3541042540403, 463.9048994956026, 471.42957022003077, 471.8655183272751, 3988.12261302513, 4077.204945035749, 4129.958700413017, 4171.91656166875, 4235.851745188904, 9644.228461723045, 10041.899581004243, 10796.460176991277, 11304.0, 11320.830187547193, 10507.789844203073, 10738.087262582769, 10914.072303854102, 11285.266457680225, 11288.379139147262, 8266.586670666442, 8305.792355191048, 8389.244967952913, 8435.873461898076, 8453.070162282143, 5674.2623458950075, 5770.2498675171955, 5775.711214439178, 5814.447627475383, 5920.141579471038, 10117.949410252902, 10203.183745300506, 10219.1824654026, 10241.641542545975, 10344.120749736056, 10107.140893024176, 10388.792224155626, 10603.840942386025, 10628.627998020032, 10633.308834925705, 7739.806504837424, 7814.804629884071, 7829.569373684502, 7832.451728378959, 7834.373250139861, 8537.146285371662, 8544.700935467228, 8621.396502244783, 8628.094050124646, 8630.956845215735, 7674.731384401519, 7814.101378341564, 7853.646585903533, 7870.881936771068, 8142.307903828004, 7625.199354067743, 7656.961715191388, 7722.227777222458, 7757.612119393895, 7764.456488045783, 6980.371766541036, 7138.357547820721, 7213.278672132745, 7237.0, 7237.240089790706, 4876.0, 4952.702837829742, 4995.300657907823, 5065.164247899055, 5215.634905556726, 5123.385193776621, 5143.279940808365, 5163.27714120016, 5327.22755200486, 5335.226392173191], "value": 4559.345723658974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.34331337325347, 337.6286085306163, 343.0890984436321, 343.160971424866, 346.35404969731445, 5317.361916570012, 5338.91991620125, 5345.823918737871, 5367.677939323638, 5376.462353764627, 5242.798024829571, 5302.814401495948, 5308.283381743464, 5318.707471089088, 5322.600804939626, 4130.0, 4166.9791651041705, 4216.156768646268, 4230.619244268008, 4236.682248831335, 4162.209180255757, 4164.604362585549, 4169.791510424467, 4170.77060761658, 4200.642945349649, 4124.484439445069, 4138.427397588927, 4146.688998325122, 4172.290710579194, 4189.413482112506, 3929.2141571685634, 4047.1703300823556, 4062.5328087270045, 4118.043929133668, 4142.212979533879, 3655.817209139532, 3656.579493358271, 3662.7252956028137, 3668.156324045458, 3685.9863537527126, 5071.782772134698, 5100.546344291859, 5122.641415100908, 5126.846194614168, 5163.199704045879, 4398.274284743014, 4478.507364189936, 4709.175894218532, 4736.313234580966, 4747.359106520645, 5482.80810171646, 5489.807856724996, 5507.201455788888, 5524.889502209933, 5565.471280228372, 4043.65628921542, 4049.481444458328, 4057.0871553900433, 4067.3288907330257, 4069.491313585802, 5437.374701909292, 5644.8024319148635, 5670.716464176775, 5675.772969081232, 5684.857878552986, 4023.4166045923175, 4039.111395492987, 4057.107436363995, 4060.5127384713433, 4073.918521629551, 4111.6299533042165, 4128.979355103205, 4130.752154870717, 4131.772752498641, 4133.6073073058615, 4446.199684056836, 4622.815087396534, 4684.344191813149, 4684.859454216379, 4710.317004034464, 5456.508914197741, 5464.207689884945, 5466.687994881279, 5468.6171967962655, 5476.151196564539, 1403.256274174689, 1411.6541447345467, 1417.588899219215, 1424.9715005699827, 1426.8430472648001, 930.2929773372285, 930.3766476460787, 943.9008904065112, 987.8073775613686, 1009.4902074452355, 5204.271402003723, 5221.738913054332, 5223.518828556481, 5233.685978841282, 5237.214417837355, 5615.326160860723, 5626.35296940857, 5642.605017648725, 5670.177824215548, 5683.0, 5009.423916249605, 5015.3480047593575, 5203.401608814959, 5212.862726282282, 5234.581233501311, 2877.6475056723307, 2942.7498662613916, 3020.704264758799, 3022.8035177713377, 3030.1818509002446, 5852.853678658068, 5866.413358664099, 5879.735411906475, 5888.5289176865745, 5908.438698323653, 5573.665580065128, 5734.799282025193, 5737.627054241461, 5743.282089738783, 5820.476157145792, 5799.420057994251, 5819.418058194146, 5821.621594596338, 5824.864151490418, 5847.298324201123, 5445.972770136124, 5657.971710141423, 5662.915056274077, 5693.259876216231, 5709.314882213995, 5576.804811831566, 5586.357568879631, 5593.776248949996, 5604.271444712162, 5614.691191984317, 5801.419858014165, 5833.241678581757, 5844.444777746107, 5865.120231965068, 5882.264716910387, 3940.783256920782, 4036.6367026967714, 4067.4102255173425, 4084.0, 4091.795410229536, 5526.50261476469, 5573.916391254215, 5574.275344205227, 5576.693281869536, 5622.8313150605545, 5446.346438427414, 5497.422770609189, 5513.173024046425, 5535.6955367455175, 5551.805686800943, 5262.0, 5479.479449452296, 5503.752331145188, 5520.641158324696, 5521.668699878021, 5414.512693857571, 5432.158015507603, 5435.211894275229, 5456.781728730806, 5462.3445186577865, 5378.73106344689, 5485.314335708036, 5514.200440936122, 5519.972400137974, 5565.693886836101, 5342.171963345688, 5348.625596208228, 5352.812651557332, 5363.0882749931825, 5367.624266301322], "value": 4216.842631772016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.3591864874179, 792.8176519400538, 799.9120096789352, 829.48571885431, 853.0318088969022, 14978.176200308979, 15543.067415955036, 15851.128187949687, 15949.043057416564, 16399.918000410013, 14966.0, 15362.308696108674, 15602.609934751637, 15613.141277229748, 15623.531294061197, 806.7297455352449, 818.2758258940851, 825.0923983618032, 825.7316372179035, 825.9132791056943, 668.3149771484219, 820.7948012996751, 822.2681813186239, 822.5969275055239, 822.7367242482408, 718.1633397092381, 845.1675100026499, 863.1584205399716, 869.3827382558391, 869.5391442535434, 853.9359548033891, 854.0647990450447, 854.2269246332079, 854.239726643288, 854.6111519258753, 624.5784095735406, 625.8153844615849, 626.1734510446213, 626.4424662050778, 626.564537646336, 10844.13246940243, 11317.0, 14437.205953672545, 15017.324220410108, 15018.549443516602, 14504.202268875208, 15068.698626027419, 15092.698146037128, 15654.373825046985, 15912.363505459767, 11849.763004739943, 11961.880381196164, 12085.395730213455, 12285.14004019719, 12350.320732359716, 3864.3816989281863, 3925.2738243425056, 3979.820908059144, 3990.521137463494, 4108.424820525129, 81753.18246817515, 81779.59110204471, 82899.0, 85283.88533259107, 86533.0, 11552.306861588331, 11647.6505704829, 11903.166778325434, 11939.223950443193, 12112.0, 23146.305610831703, 23166.0, 23169.304920852403, 23174.768252317597, 23302.0, 7961.8407631848195, 7964.960175199087, 8117.797055073553, 8375.8324833503, 8558.914410855936, 4547.954520454753, 4576.565226303496, 4618.607418369409, 4741.83403580873, 4849.442314133919, 3669.87155449558, 3795.3358162321483, 3797.582265950743, 3797.6771974381936, 3800.486934263839, 615.9137720719103, 623.2863371439677, 623.6040114527308, 645.8998855177455, 653.6470306034784, 621.0683974038942, 654.5483616304734, 704.9718011279595, 709.673550166929, 744.6388501576731, 9197.908020919838, 9429.717108486757, 9765.609375625038, 10061.849072263922, 10119.59521619127, 556.3462931055993, 622.0637939900421, 651.5927545284197, 713.1442269276888, 719.9532030418006, 4341.218580655513, 4660.067986402733, 4718.575328220477, 4723.291506274018, 4754.429468463806, 116340.0, 117764.0, 127871.0, 128428.0, 132287.33856330658, 82144.58927705443, 84264.0, 85025.0, 100340.49829750805, 109836.450817747, 52017.47982520202, 57179.71410143006, 79193.20806791974, 80482.0, 84391.0, 9092.818143637223, 9432.85850712226, 9511.0, 9580.37727547735, 9635.181009614262, 49324.75337623289, 50443.0, 50500.74749626228, 51119.48880511296, 52141.7392913033, 71073.28926710667, 72752.0, 77704.0, 79474.20525794668, 79851.60074199592, 12587.559435419716, 12678.619641410773, 12955.740885182433, 13184.27486488214, 13242.513071226385, 14536.41854325815, 14560.708785824012, 14910.105393676415, 15467.84532154709, 15484.84515154879, 13768.86231137716, 13814.171149731048, 14087.436502539784, 14270.286485675882, 14335.784963225351, 13832.0, 13852.584422467342, 14057.542992892939, 14177.432902683777, 14451.78322325145, 13104.279264640536, 13371.39828707691, 13616.795748063985, 13837.515686950908, 14306.57080287593, 9818.45998470091, 9879.456629885426, 10022.498875056071, 10240.18078553699, 10401.479926003518, 10190.949045254727, 10712.785744284914, 10816.837747433952, 10837.566497340018, 10893.128549715846], "value": 7545.778415916007, "unit": "score"}], "name": "dromaeo_css", "value": 7215.584417010466, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 112.0, 111.0, 112.0, 111.0, 110.0, 112.0, 112.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 123.0, 164.0, 123.0, 127.0, 129.0, 125.0, 165.0, 125.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 162.0, 163.0, 162.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 115.0, 76.0, 76.0, 77.0, 76.0, 98.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 133.0, 82.0, 82.0, 83.0, 115.0, 83.0, 82.0, 112.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 51.0, 53.0, 52.0, 53.0, 52.0, 53.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 79.0, 83.0, 79.0, 85.0, 80.0, 80.0, 88.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 130.0, 131.0, 143.0, 141.0, 127.0, 130.0, 178.0, 137.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 166.0, 164.0, 167.0, 168.0, 165.0, 170.0, 167.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 68.0, 65.0, 68.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1509.6000000000001, "alertThreshold": 2.0}]} 19:11:03 INFO - Return code: 0 19:11:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:11:03 INFO - # TBPL SUCCESS # 19:11:03 INFO - Running post-action listener: _resource_record_post_action 19:11:03 INFO - [mozharness: 2016-10-14 02:11:03.074473Z] Finished run-tests step (success) 19:11:03 INFO - Running post-run listener: _resource_record_post_run 19:11:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395902976; Read time: 4; Write time: 270128 19:11:03 INFO - TinderboxPrint: CPU usage
13.1% 19:11:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 19:11:03 INFO - TinderboxPrint: I/O write bytes / time
395,902,976 / 270,128 19:11:03 INFO - TinderboxPrint: CPU idle
8,303.0 (86.9%) 19:11:03 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 19:11:03 INFO - TinderboxPrint: Swap in / out
0 / 0 19:11:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103137280; Read time: 0; Write time: 50012 19:11:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 291606528; Read time: 0; Write time: 219896 19:11:03 INFO - Running post-run listener: _upload_blobber_files 19:11:03 INFO - Blob upload gear active. 19:11:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:11:03 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 19:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:11:04 INFO - (blobuploader) - INFO - Open directory for files ... 19:11:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:11:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:06 INFO - (blobuploader) - INFO - Done attempting. 19:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:09 INFO - (blobuploader) - INFO - Done attempting. 19:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:10 INFO - (blobuploader) - INFO - Done attempting. 19:11:10 INFO - (blobuploader) - INFO - Iteration through files over. 19:11:10 INFO - Return code: 0 19:11:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:11:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:11:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5911ad5bba87758e6084802b7c7f4abfc4240a7bbade4267cc831f272681694825cc8acaeb375745674c50859c3b2046d31dc2420f56329c89435b593624c761", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e230719dbc70adfbfc22dfa22da600b518dde5702e96ed8e498fea839ba6a0394f4d624277831c4826823c714cdaada3e88442207018214adce6182246cb69e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fb5fdeed1188eab73ece0fd06be012251c985d81942388c4f55aede98c920291c0ef9a470d4af7f20f126fc0da18d36e36d513306b806f7012beac2cdb4eff9"} 19:11:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:11:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:11:10 INFO - Contents: 19:11:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5911ad5bba87758e6084802b7c7f4abfc4240a7bbade4267cc831f272681694825cc8acaeb375745674c50859c3b2046d31dc2420f56329c89435b593624c761", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e230719dbc70adfbfc22dfa22da600b518dde5702e96ed8e498fea839ba6a0394f4d624277831c4826823c714cdaada3e88442207018214adce6182246cb69e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fb5fdeed1188eab73ece0fd06be012251c985d81942388c4f55aede98c920291c0ef9a470d4af7f20f126fc0da18d36e36d513306b806f7012beac2cdb4eff9"} 19:11:10 INFO - Running post-run listener: copy_logs_to_upload_dir 19:11:10 INFO - Copying logs to upload dir... 19:11:10 INFO - mkdir: /builds/slave/test/build/upload/logs 19:11:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.099334 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-10-13 19:11:10.712034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 19:11:10.715080) ========= 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=923d835db2ba3686ebe126b700000192-1476409812.620206-478817395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5911ad5bba87758e6084802b7c7f4abfc4240a7bbade4267cc831f272681694825cc8acaeb375745674c50859c3b2046d31dc2420f56329c89435b593624c761", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e230719dbc70adfbfc22dfa22da600b518dde5702e96ed8e498fea839ba6a0394f4d624277831c4826823c714cdaada3e88442207018214adce6182246cb69e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fb5fdeed1188eab73ece0fd06be012251c985d81942388c4f55aede98c920291c0ef9a470d4af7f20f126fc0da18d36e36d513306b806f7012beac2cdb4eff9"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476397805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5911ad5bba87758e6084802b7c7f4abfc4240a7bbade4267cc831f272681694825cc8acaeb375745674c50859c3b2046d31dc2420f56329c89435b593624c761", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e230719dbc70adfbfc22dfa22da600b518dde5702e96ed8e498fea839ba6a0394f4d624277831c4826823c714cdaada3e88442207018214adce6182246cb69e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fb5fdeed1188eab73ece0fd06be012251c985d81942388c4f55aede98c920291c0ef9a470d4af7f20f126fc0da18d36e36d513306b806f7012beac2cdb4eff9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 19:11:10.742200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 19:11:10.742547) ========= 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=923d835db2ba3686ebe126b700000192-1476409812.620206-478817395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 19:11:10.827542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 19:11:10.827863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 19:11:10.831875) ========= ========= Total master_lag: 0.21 =========