builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1479131636.28 results: success (0) buildid: 20161114030203 builduid: 2925079056124088a53f561f478b114c revision: 1196bf3032e1bce1fb07a01fd9082a767426c5fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.282489) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.282942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.283231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.301468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.301814) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 05:53:56-- 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% 128M=0s 2016-11-14 05:53:56 (128 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089380 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.646692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.647010) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017345 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:56.685975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 05:53:56.689333) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1196bf3032e1bce1fb07a01fd9082a767426c5fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1196bf3032e1bce1fb07a01fd9082a767426c5fb --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=20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 05:53:57,209 truncating revision to first 12 chars 2016-11-14 05:53:57,209 Setting DEBUG logging. 2016-11-14 05:53:57,209 attempt 1/10 2016-11-14 05:53:57,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1196bf3032e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 05:53:58,645 unpacking tar archive at: mozilla-central-1196bf3032e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.783138 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 05:53:58.485674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:58.485996) ========= script_repo_revision: 1196bf3032e1bce1fb07a01fd9082a767426c5fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:58.486455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:58.486721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 05:53:58.495502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-14 05:53:58.495770) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:59 INFO - MultiFileLogger online at 20161114 05:53:59 in /builds/slave/test 05:53:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:59 INFO - {'append_to_log': False, 05:53:59 INFO - 'base_work_dir': '/builds/slave/test', 05:53:59 INFO - 'blob_upload_branch': 'Firefox', 05:53:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:59 INFO - 'branch': 'Firefox', 05:53:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:59 INFO - 'config_files': ('talos/linux_config.py',), 05:53:59 INFO - 'default_actions': ('clobber', 05:53:59 INFO - 'read-buildbot-config', 05:53:59 INFO - 'download-and-extract', 05:53:59 INFO - 'populate-webroot', 05:53:59 INFO - 'create-virtualenv', 05:53:59 INFO - 'install', 05:53:59 INFO - 'run-tests'), 05:53:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:59 INFO - 'download_minidump_stackwalk': True, 05:53:59 INFO - 'download_symbols': 'ondemand', 05:53:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:59 INFO - 'installer_path': 'installer.exe', 05:53:59 INFO - 'log_level': 'info', 05:53:59 INFO - 'log_name': 'talos', 05:53:59 INFO - 'log_to_console': True, 05:53:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:59 INFO - 'opt_config_files': (), 05:53:59 INFO - 'pip_index': False, 05:53:59 INFO - 'sps_profile': False, 05:53:59 INFO - 'sps_profile_interval': 0, 05:53:59 INFO - 'suite': 'dromaeojs', 05:53:59 INFO - 'system_bits': '32', 05:53:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:59 INFO - 'title': 'talos-linux64-ix-015', 05:53:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:59 INFO - 'use_talos_json': True, 05:53:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:59 INFO - 'work_dir': 'build'} 05:53:59 INFO - [mozharness: 2016-11-14 13:53:59.120660Z] Running clobber step. 05:53:59 INFO - Running pre-action listener: _resource_record_pre_action 05:53:59 INFO - Running main action method: clobber 05:53:59 INFO - rmtree: /builds/slave/test/build 05:53:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:00 INFO - Running post-action listener: _resource_record_post_action 05:54:00 INFO - [mozharness: 2016-11-14 13:54:00.089737Z] Finished clobber step (success) 05:54:00 INFO - [mozharness: 2016-11-14 13:54:00.089840Z] Running read-buildbot-config step. 05:54:00 INFO - Running pre-action listener: _resource_record_pre_action 05:54:00 INFO - Running main action method: read_buildbot_config 05:54:00 INFO - Using buildbot properties: 05:54:00 INFO - { 05:54:00 INFO - "project": "", 05:54:00 INFO - "product": "firefox", 05:54:00 INFO - "script_repo_revision": "production", 05:54:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:54:00 INFO - "repository": "", 05:54:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:54:00 INFO - "buildid": "20161114030203", 05:54:00 INFO - "stage_platform": "linux64-pgo", 05:54:00 INFO - "basedir": "/builds/slave/test", 05:54:00 INFO - "nightly_build": "True", 05:54:00 INFO - "buildnumber": 64, 05:54:00 INFO - "slavename": "talos-linux64-ix-015", 05:54:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:54:00 INFO - "platform": "ubuntu64_hw", 05:54:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:00 INFO - "branch": "mozilla-central", 05:54:00 INFO - "repo_path": "mozilla-central", 05:54:00 INFO - "revision": "1196bf3032e1bce1fb07a01fd9082a767426c5fb", 05:54:00 INFO - "pgo_build": "True", 05:54:00 INFO - "builduid": "2925079056124088a53f561f478b114c", 05:54:00 INFO - "slavebuilddir": "test" 05:54:00 INFO - } 05:54:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:54:00 INFO - Running post-action listener: _resource_record_post_action 05:54:00 INFO - [mozharness: 2016-11-14 13:54:00.092314Z] Finished read-buildbot-config step (success) 05:54:00 INFO - [mozharness: 2016-11-14 13:54:00.092402Z] Running download-and-extract step. 05:54:00 INFO - Running pre-action listener: _resource_record_pre_action 05:54:00 INFO - Running main action method: download_and_extract 05:54:00 INFO - mkdir: /builds/slave/test/build/tests 05:54:00 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')]} 05:54:00 INFO - trying https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:00 INFO - Downloading https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/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 05:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/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 05:54:00 INFO - Downloaded 1361 bytes. 05:54:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:00 INFO - Using the following test package requirements: 05:54:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'jsshell-linux-x86_64.zip'], 05:54:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:00 INFO - Fetch https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:01 INFO - Http code: 200 05:54:01 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 05:54:01 INFO - x-amz-cf-id: 122okl2sXVlCfKNOX4lulDvtYC7SQr2dQdzlVvapR6txgFfI4HLc3w== 05:54:01 INFO - x-amz-version-id: JVT08Iigqh6wsuALxrLTimQONfokEBwY 05:54:02 INFO - Expected file size: 21969549 05:54:02 INFO - Obtained file size: 21969549 05:54:06 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 05:54:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:07 INFO - Http code: 200 05:54:07 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 05:54:07 INFO - x-amz-cf-id: ioEUidEqWP_kQwylq4mXzdjp8A41a1p3ZjdcKti8Cn_M_yHT2FkOSw== 05:54:07 INFO - x-amz-version-id: JVT08Iigqh6wsuALxrLTimQONfokEBwY 05:54:07 INFO - Expected file size: 21969549 05:54:07 INFO - Obtained file size: 21969549 05:54:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:54:12 INFO - Http code: 200 05:54:12 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 05:54:12 INFO - x-amz-cf-id: -wOqu4Rkap20WHpHUsImMWo7J5UV6gxdyD51OJWBhf4TWAXsZOGFwg== 05:54:12 INFO - x-amz-version-id: wzmBdqxcXJ1ZMHaW3nbsT0lAS6hZm6me 05:54:13 INFO - Expected file size: 14409038 05:54:13 INFO - Obtained file size: 14409038 05:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:13 INFO - trying https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:13 INFO - Downloading https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/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 05:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/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 05:54:15 INFO - Downloaded 59515215 bytes. 05:54:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:15 INFO - mkdir: /builds/slave/test/properties 05:54:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:15 INFO - Contents: 05:54:15 INFO - build_url:https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - Running post-action listener: set_extra_try_arguments 05:54:16 INFO - [mozharness: 2016-11-14 13:54:16.412282Z] Finished download-and-extract step (success) 05:54:16 INFO - [mozharness: 2016-11-14 13:54:16.412508Z] Running populate-webroot step. 05:54:16 INFO - Running pre-action listener: _resource_record_pre_action 05:54:16 INFO - Running main action method: populate_webroot 05:54:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:16 INFO - '--tppagecycles', 05:54:16 INFO - '7'], 05:54:16 INFO - 'tests': ['tsvgm']}}, 05:54:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['damp', 'tps']}, 05:54:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'tests': ['damp', 'tps']}, 05:54:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['dromaeo_dom']}, 05:54:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['basic_compositor_video']}, 05:54:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['a11yr', 05:54:16 INFO - 'ts_paint', 05:54:16 INFO - 'tpaint', 05:54:16 INFO - 'sessionrestore', 05:54:16 INFO - 'sessionrestore_no_auto_restore', 05:54:16 INFO - 'tabpaint']}, 05:54:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:16 INFO - 'ts_paint', 05:54:16 INFO - 'tpaint', 05:54:16 INFO - 'sessionrestore', 05:54:16 INFO - 'sessionrestore_no_auto_restore', 05:54:16 INFO - 'tabpaint']}, 05:54:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:16 INFO - 'ts_paint', 05:54:16 INFO - 'tpaint', 05:54:16 INFO - 'sessionrestore', 05:54:16 INFO - 'sessionrestore_no_auto_restore', 05:54:16 INFO - 'tabpaint']}, 05:54:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:16 INFO - 'ts_paint', 05:54:16 INFO - 'tpaint', 05:54:16 INFO - 'sessionrestore', 05:54:16 INFO - 'sessionrestore_no_auto_restore', 05:54:16 INFO - 'tabpaint']}, 05:54:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['a11yr', 05:54:16 INFO - 'ts_paint', 05:54:16 INFO - 'tpaint', 05:54:16 INFO - 'sessionrestore', 05:54:16 INFO - 'sessionrestore_no_auto_restore', 05:54:16 INFO - 'tabpaint']}, 05:54:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['a11yr', 05:54:16 INFO - 'ts_paint', 05:54:16 INFO - 'tpaint', 05:54:16 INFO - 'sessionrestore', 05:54:16 INFO - 'sessionrestore_no_auto_restore', 05:54:16 INFO - 'tabpaint']}, 05:54:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['tsvgx', 05:54:16 INFO - 'tsvgr_opacity', 05:54:16 INFO - 'tart', 05:54:16 INFO - 'tscrollx', 05:54:16 INFO - 'cart']}, 05:54:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:16 INFO - 'tsvgr_opacity', 05:54:16 INFO - 'tart', 05:54:16 INFO - 'tscrollx', 05:54:16 INFO - 'cart']}, 05:54:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'talos_options': ['--disable-e10s'], 05:54:16 INFO - 'tests': ['tp5o']}, 05:54:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'tests': ['tp5o']}, 05:54:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'talos_options': ['--disable-e10s', 05:54:16 INFO - '--xperf_path', 05:54:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:16 INFO - 'tests': ['tp5n']}, 05:54:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:16 INFO - 'talos_options': ['--xperf_path', 05:54:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:16 INFO - 'tests': ['tp5n']}}, 05:54:16 INFO - 'talos.zip': {'path': '', 05:54:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - [mozharness: 2016-11-14 13:54:16.431544Z] Finished populate-webroot step (success) 05:54:16 INFO - [mozharness: 2016-11-14 13:54:16.431631Z] Running create-virtualenv step. 05:54:16 INFO - Running pre-action listener: _resource_record_pre_action 05:54:16 INFO - Running main action method: create_virtualenv 05:54:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:16 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 05:54:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:16 INFO - Using real prefix '/usr' 05:54:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:18 INFO - Installing pip.................done. 05:54:19 INFO - Return code: 0 05:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:54:19 INFO - Reading from file tmpfile_stdout 05:54:19 INFO - Output received: 05:54:19 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) 05:54:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:54:19 INFO - Using env: {'DISPLAY': ':0', 05:54:19 INFO - 'HOME': '/home/cltbld', 05:54:19 INFO - 'LANG': 'en_US.UTF-8', 05:54:19 INFO - 'LANGUAGE': 'en_US:en', 05:54:19 INFO - 'LOGNAME': 'cltbld', 05:54:19 INFO - 'MAIL': '/var/mail/cltbld', 05:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:19 INFO - 'MOZ_NO_REMOTE': '1', 05:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:19 INFO - 'NO_EM_RESTART': '1', 05:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:19 INFO - 'PWD': '/builds/slave/test', 05:54:19 INFO - 'SHELL': '/bin/bash', 05:54:19 INFO - 'SHLVL': '1', 05:54:19 INFO - 'TERM': 'linux', 05:54:19 INFO - 'TMOUT': '86400', 05:54:19 INFO - 'USER': 'cltbld', 05:54:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:19 INFO - '_': '/tools/buildbot/bin/python'} 05:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:19 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 05:54:19 INFO - Cleaning up... 05:54:19 INFO - Return code: 0 05:54:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:54:19 INFO - Using env: {'DISPLAY': ':0', 05:54:19 INFO - 'HOME': '/home/cltbld', 05:54:19 INFO - 'LANG': 'en_US.UTF-8', 05:54:19 INFO - 'LANGUAGE': 'en_US:en', 05:54:19 INFO - 'LOGNAME': 'cltbld', 05:54:19 INFO - 'MAIL': '/var/mail/cltbld', 05:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:19 INFO - 'MOZ_NO_REMOTE': '1', 05:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:19 INFO - 'NO_EM_RESTART': '1', 05:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:19 INFO - 'PWD': '/builds/slave/test', 05:54:19 INFO - 'SHELL': '/bin/bash', 05:54:19 INFO - 'SHLVL': '1', 05:54:19 INFO - 'TERM': 'linux', 05:54:19 INFO - 'TMOUT': '86400', 05:54:19 INFO - 'USER': 'cltbld', 05:54:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:19 INFO - '_': '/tools/buildbot/bin/python'} 05:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:19 INFO - Downloading/unpacking psutil>=3.1.1 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:21 INFO - Installing collected packages: psutil 05:54:21 INFO - Running setup.py install for psutil 05:54:21 INFO - building 'psutil._psutil_linux' extension 05:54:21 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 05:54:21 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 05:54:21 INFO - building 'psutil._psutil_posix' extension 05:54:21 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 05:54:22 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 05:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:22 INFO - Successfully installed psutil 05:54:22 INFO - Cleaning up... 05:54:22 INFO - Return code: 0 05:54:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:22 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:22 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 05:54:22 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 05:54:22 INFO - Using env: {'DISPLAY': ':0', 05:54:22 INFO - 'HOME': '/home/cltbld', 05:54:22 INFO - 'LANG': 'en_US.UTF-8', 05:54:22 INFO - 'LANGUAGE': 'en_US:en', 05:54:22 INFO - 'LOGNAME': 'cltbld', 05:54:22 INFO - 'MAIL': '/var/mail/cltbld', 05:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:22 INFO - 'MOZ_NO_REMOTE': '1', 05:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:22 INFO - 'NO_EM_RESTART': '1', 05:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:22 INFO - 'PWD': '/builds/slave/test', 05:54:22 INFO - 'SHELL': '/bin/bash', 05:54:22 INFO - 'SHLVL': '1', 05:54:22 INFO - 'TERM': 'linux', 05:54:22 INFO - 'TMOUT': '86400', 05:54:22 INFO - 'USER': 'cltbld', 05:54:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:22 INFO - '_': '/tools/buildbot/bin/python'} 05:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:24 INFO - Installing collected packages: mozsystemmonitor 05:54:24 INFO - Running setup.py install for mozsystemmonitor 05:54:24 INFO - Successfully installed mozsystemmonitor 05:54:24 INFO - Cleaning up... 05:54:24 INFO - Return code: 0 05:54:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:24 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')]} 05:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:24 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')]} 05:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:24 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:24 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 05:54:24 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 05:54:24 INFO - Using env: {'DISPLAY': ':0', 05:54:24 INFO - 'HOME': '/home/cltbld', 05:54:24 INFO - 'LANG': 'en_US.UTF-8', 05:54:24 INFO - 'LANGUAGE': 'en_US:en', 05:54:24 INFO - 'LOGNAME': 'cltbld', 05:54:24 INFO - 'MAIL': '/var/mail/cltbld', 05:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:24 INFO - 'MOZ_NO_REMOTE': '1', 05:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:24 INFO - 'NO_EM_RESTART': '1', 05:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:24 INFO - 'PWD': '/builds/slave/test', 05:54:24 INFO - 'SHELL': '/bin/bash', 05:54:24 INFO - 'SHLVL': '1', 05:54:24 INFO - 'TERM': 'linux', 05:54:24 INFO - 'TMOUT': '86400', 05:54:24 INFO - 'USER': 'cltbld', 05:54:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:24 INFO - '_': '/tools/buildbot/bin/python'} 05:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:24 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:26 INFO - warning: no files found matching '*.txt' 05:54:26 INFO - no previously-included directories found matching 'build' 05:54:26 INFO - no previously-included directories found matching 'dist' 05:54:26 INFO - no previously-included directories found matching '.git*' 05:54:26 INFO - Installing collected packages: jsonschema, functools32 05:54:27 INFO - Running setup.py install for functools32 05:54:27 INFO - warning: no files found matching '*.txt' 05:54:27 INFO - no previously-included directories found matching 'build' 05:54:27 INFO - no previously-included directories found matching 'dist' 05:54:27 INFO - no previously-included directories found matching '.git*' 05:54:27 INFO - Successfully installed jsonschema functools32 05:54:27 INFO - Cleaning up... 05:54:27 INFO - Return code: 0 05:54:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:27 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:27 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 05:54:27 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 05:54:27 INFO - Using env: {'DISPLAY': ':0', 05:54:27 INFO - 'HOME': '/home/cltbld', 05:54:27 INFO - 'LANG': 'en_US.UTF-8', 05:54:27 INFO - 'LANGUAGE': 'en_US:en', 05:54:27 INFO - 'LOGNAME': 'cltbld', 05:54:27 INFO - 'MAIL': '/var/mail/cltbld', 05:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:27 INFO - 'MOZ_NO_REMOTE': '1', 05:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:27 INFO - 'NO_EM_RESTART': '1', 05:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:27 INFO - 'PWD': '/builds/slave/test', 05:54:27 INFO - 'SHELL': '/bin/bash', 05:54:27 INFO - 'SHLVL': '1', 05:54:27 INFO - 'TERM': 'linux', 05:54:27 INFO - 'TMOUT': '86400', 05:54:27 INFO - 'USER': 'cltbld', 05:54:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:27 INFO - '_': '/tools/buildbot/bin/python'} 05:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:27 INFO - Cleaning up... 05:54:27 INFO - Return code: 0 05:54:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:27 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:27 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 05:54:27 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 05:54:27 INFO - Using env: {'DISPLAY': ':0', 05:54:27 INFO - 'HOME': '/home/cltbld', 05:54:27 INFO - 'LANG': 'en_US.UTF-8', 05:54:27 INFO - 'LANGUAGE': 'en_US:en', 05:54:27 INFO - 'LOGNAME': 'cltbld', 05:54:27 INFO - 'MAIL': '/var/mail/cltbld', 05:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:27 INFO - 'MOZ_NO_REMOTE': '1', 05:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:27 INFO - 'NO_EM_RESTART': '1', 05:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:27 INFO - 'PWD': '/builds/slave/test', 05:54:27 INFO - 'SHELL': '/bin/bash', 05:54:27 INFO - 'SHLVL': '1', 05:54:27 INFO - 'TERM': 'linux', 05:54:27 INFO - 'TMOUT': '86400', 05:54:27 INFO - 'USER': 'cltbld', 05:54:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:27 INFO - '_': '/tools/buildbot/bin/python'} 05:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:27 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 05:54:27 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 05:54:27 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 05:54:27 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 05:54:27 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 05:54:27 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 05:54:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:30 INFO - Downloading docopt-0.6.1.tar.gz 05:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:30 INFO - Running setup.py install for blobuploader 05:54:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:30 INFO - Running setup.py install for requests 05:54:30 INFO - Running setup.py install for docopt 05:54:30 INFO - Successfully installed blobuploader requests docopt 05:54:30 INFO - Cleaning up... 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:30 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')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 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')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:30 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 05:54:30 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 05:54:30 INFO - Using env: {'DISPLAY': ':0', 05:54:30 INFO - 'HOME': '/home/cltbld', 05:54:30 INFO - 'LANG': 'en_US.UTF-8', 05:54:30 INFO - 'LANGUAGE': 'en_US:en', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MAIL': '/var/mail/cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SHLVL': '1', 05:54:30 INFO - 'TERM': 'linux', 05:54:30 INFO - 'TMOUT': '86400', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - '_': '/tools/buildbot/bin/python'} 05:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:31 INFO - Running setup.py (path:/tmp/pip-U3Y7rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:31 INFO - Running setup.py (path:/tmp/pip-h75lQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:31 INFO - Running setup.py (path:/tmp/pip-LR51ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:31 INFO - Running setup.py (path:/tmp/pip-HSrV8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:31 INFO - Running setup.py (path:/tmp/pip-b9Ozzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:31 INFO - Running setup.py (path:/tmp/pip-mZMXe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:31 INFO - Running setup.py (path:/tmp/pip-_2sa57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:31 INFO - Running setup.py (path:/tmp/pip-bmGhu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:31 INFO - Running setup.py (path:/tmp/pip-YIZtmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:31 INFO - Running setup.py (path:/tmp/pip-DpHpog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:31 INFO - Running setup.py (path:/tmp/pip-wibzTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:31 INFO - Running setup.py (path:/tmp/pip-ax5PHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:32 INFO - Running setup.py (path:/tmp/pip-p3EthO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:32 INFO - Running setup.py (path:/tmp/pip-WgrYei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:32 INFO - Running setup.py (path:/tmp/pip-7gB_vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:32 INFO - Running setup.py (path:/tmp/pip-hBH42v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:32 INFO - Running setup.py (path:/tmp/pip-zIS1QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:32 INFO - Running setup.py install for manifestparser 05:54:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:32 INFO - Running setup.py install for mozcrash 05:54:32 INFO - Running setup.py install for mozdebug 05:54:32 INFO - Running setup.py install for mozdevice 05:54:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:32 INFO - Running setup.py install for mozfile 05:54:32 INFO - Running setup.py install for mozhttpd 05:54:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for mozinfo 05:54:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for mozInstall 05:54:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for mozleak 05:54:33 INFO - Running setup.py install for mozlog 05:54:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for moznetwork 05:54:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for mozprocess 05:54:33 INFO - Running setup.py install for mozprofile 05:54:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for mozrunner 05:54:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:33 INFO - Running setup.py install for mozscreenshot 05:54:34 INFO - Running setup.py install for moztest 05:54:34 INFO - Running setup.py install for mozversion 05:54:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:34 INFO - Cleaning up... 05:54:34 INFO - Return code: 0 05:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:34 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')]} 05:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:34 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')]} 05:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:34 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:34 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 05:54:34 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 05:54:34 INFO - Using env: {'DISPLAY': ':0', 05:54:34 INFO - 'HOME': '/home/cltbld', 05:54:34 INFO - 'LANG': 'en_US.UTF-8', 05:54:34 INFO - 'LANGUAGE': 'en_US:en', 05:54:34 INFO - 'LOGNAME': 'cltbld', 05:54:34 INFO - 'MAIL': '/var/mail/cltbld', 05:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:34 INFO - 'MOZ_NO_REMOTE': '1', 05:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:34 INFO - 'NO_EM_RESTART': '1', 05:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:34 INFO - 'PWD': '/builds/slave/test', 05:54:34 INFO - 'SHELL': '/bin/bash', 05:54:34 INFO - 'SHLVL': '1', 05:54:34 INFO - 'TERM': 'linux', 05:54:34 INFO - 'TMOUT': '86400', 05:54:34 INFO - 'USER': 'cltbld', 05:54:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:34 INFO - '_': '/tools/buildbot/bin/python'} 05:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:34 INFO - Running setup.py (path:/tmp/pip-FhOf27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:34 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:34 INFO - Running setup.py (path:/tmp/pip-T0bX0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:34 INFO - Running setup.py (path:/tmp/pip-nST7XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:34 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:34 INFO - Running setup.py (path:/tmp/pip-fR14DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:34 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:34 INFO - Running setup.py (path:/tmp/pip-4dxNqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:34 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:34 INFO - Running setup.py (path:/tmp/pip-Q48Ydv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:34 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:34 INFO - Running setup.py (path:/tmp/pip-AhuFaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:34 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)) 05:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:34 INFO - Running setup.py (path:/tmp/pip-tqjpyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:35 INFO - Running setup.py (path:/tmp/pip-8_gpOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:35 INFO - Running setup.py (path:/tmp/pip-Ei4Luj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:35 INFO - Running setup.py (path:/tmp/pip-R4Z0Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:35 INFO - Running setup.py (path:/tmp/pip-T2uLnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:35 INFO - Running setup.py (path:/tmp/pip-JmzY7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:35 INFO - Running setup.py (path:/tmp/pip-9CkbpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:35 INFO - Running setup.py (path:/tmp/pip-5had7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:35 INFO - Running setup.py (path:/tmp/pip-Hi4rJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:35 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)) 05:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:35 INFO - Running setup.py (path:/tmp/pip-MK13JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:35 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)) 05:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:35 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)) 05:54:35 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)) 05:54:35 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)) 05:54:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:35 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 05:54:35 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 05:54:35 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 05:54:35 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 05:54:35 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 05:54:35 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 05:54:37 INFO - Downloading blessings-1.6.tar.gz 05:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:37 INFO - Installing collected packages: blessings 05:54:37 INFO - Running setup.py install for blessings 05:54:37 INFO - Successfully installed blessings 05:54:37 INFO - Cleaning up... 05:54:37 INFO - Return code: 0 05:54:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:38 INFO - Reading from file tmpfile_stdout 05:54:38 INFO - Current package versions: 05:54:38 INFO - argparse == 1.2.1 05:54:38 INFO - blessings == 1.6 05:54:38 INFO - blobuploader == 1.2.4 05:54:38 INFO - docopt == 0.6.1 05:54:38 INFO - functools32 == 3.2.3-2 05:54:38 INFO - jsonschema == 2.5.1 05:54:38 INFO - manifestparser == 1.1 05:54:38 INFO - mozInstall == 1.12 05:54:38 INFO - mozcrash == 1.0 05:54:38 INFO - mozdebug == 0.1 05:54:38 INFO - mozdevice == 0.48 05:54:38 INFO - mozfile == 1.2 05:54:38 INFO - mozhttpd == 0.7 05:54:38 INFO - mozinfo == 0.9 05:54:38 INFO - mozleak == 0.1 05:54:38 INFO - mozlog == 3.4 05:54:38 INFO - moznetwork == 0.27 05:54:38 INFO - mozprocess == 0.23 05:54:38 INFO - mozprofile == 0.28 05:54:38 INFO - mozrunner == 6.13 05:54:38 INFO - mozscreenshot == 0.1 05:54:38 INFO - mozsystemmonitor == 0.3 05:54:38 INFO - moztest == 0.7 05:54:38 INFO - mozversion == 1.4 05:54:38 INFO - psutil == 3.1.1 05:54:38 INFO - requests == 1.2.3 05:54:38 INFO - wsgiref == 0.1.2 05:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 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 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:38 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 05:54:38 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 05:54:38 INFO - Using env: {'DISPLAY': ':0', 05:54:38 INFO - 'HOME': '/home/cltbld', 05:54:38 INFO - 'LANG': 'en_US.UTF-8', 05:54:38 INFO - 'LANGUAGE': 'en_US:en', 05:54:38 INFO - 'LOGNAME': 'cltbld', 05:54:38 INFO - 'MAIL': '/var/mail/cltbld', 05:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:38 INFO - 'MOZ_NO_REMOTE': '1', 05:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:38 INFO - 'NO_EM_RESTART': '1', 05:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:38 INFO - 'PWD': '/builds/slave/test', 05:54:38 INFO - 'SHELL': '/bin/bash', 05:54:38 INFO - 'SHLVL': '1', 05:54:38 INFO - 'TERM': 'linux', 05:54:38 INFO - 'TMOUT': '86400', 05:54:38 INFO - 'USER': 'cltbld', 05:54:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:38 INFO - '_': '/tools/buildbot/bin/python'} 05:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 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)) 05:54:38 INFO - Cleaning up... 05:54:38 INFO - Return code: 0 05:54:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd52a257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', '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 05:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:54:38 INFO - Using env: {'DISPLAY': ':0', 05:54:38 INFO - 'HOME': '/home/cltbld', 05:54:38 INFO - 'LANG': 'en_US.UTF-8', 05:54:38 INFO - 'LANGUAGE': 'en_US:en', 05:54:38 INFO - 'LOGNAME': 'cltbld', 05:54:38 INFO - 'MAIL': '/var/mail/cltbld', 05:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:38 INFO - 'MOZ_NO_REMOTE': '1', 05:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:38 INFO - 'NO_EM_RESTART': '1', 05:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:38 INFO - 'PWD': '/builds/slave/test', 05:54:38 INFO - 'SHELL': '/bin/bash', 05:54:38 INFO - 'SHLVL': '1', 05:54:38 INFO - 'TERM': 'linux', 05:54:38 INFO - 'TMOUT': '86400', 05:54:38 INFO - 'USER': 'cltbld', 05:54:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:38 INFO - '_': '/tools/buildbot/bin/python'} 05:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:38 INFO - Cleaning up... 05:54:38 INFO - Return code: 0 05:54:38 INFO - Running post-action listener: _resource_record_post_action 05:54:38 INFO - Running post-action listener: _start_resource_monitoring 05:54:38 INFO - Starting resource monitoring. 05:54:38 INFO - [mozharness: 2016-11-14 13:54:38.576875Z] Finished create-virtualenv step (success) 05:54:38 INFO - [mozharness: 2016-11-14 13:54:38.577389Z] Running install step. 05:54:38 INFO - Running pre-action listener: _resource_record_pre_action 05:54:38 INFO - Running main action method: install 05:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:38 INFO - Reading from file tmpfile_stdout 05:54:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:38 INFO - Reading from file tmpfile_stdout 05:54:38 INFO - Output received: 05:54:38 INFO - Usage: mozinstall [options] installer 05:54:38 INFO - Options: 05:54:38 INFO - -h, --help show this help message and exit 05:54:38 INFO - -d DEST, --destination=DEST 05:54:38 INFO - Directory to install application into. [default: 05:54:38 INFO - "/builds/slave/test"] 05:54:38 INFO - --app=APP Application being installed. [default: firefox] 05:54:38 INFO - mkdir: /builds/slave/test/build/application 05:54:38 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'] 05:54:38 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 05:54:56 INFO - Reading from file tmpfile_stdout 05:54:56 INFO - Output received: 05:54:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:54:56 INFO - Running post-action listener: _resource_record_post_action 05:54:56 INFO - [mozharness: 2016-11-14 13:54:56.259130Z] Finished install step (success) 05:54:56 INFO - [mozharness: 2016-11-14 13:54:56.259373Z] Running run-tests step. 05:54:56 INFO - Running pre-action listener: _resource_record_pre_action 05:54:56 INFO - Running main action method: run_tests 05:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:56 INFO - Python 2.7.3 05:54:56 INFO - Return code: 0 05:54:56 INFO - grabbing minidump binary from tooltool 05:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:56 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 0x28c4930>, '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 0x28c5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c5cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:56 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 05:54:56 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 05:54:56 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 05:54:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:56 INFO - Return code: 0 05:54:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:54:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:54:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 05:54:56 INFO - Using env: {'DISPLAY': ':0', 05:54:56 INFO - 'HOME': '/home/cltbld', 05:54:56 INFO - 'LANG': 'en_US.UTF-8', 05:54:56 INFO - 'LANGUAGE': 'en_US:en', 05:54:56 INFO - 'LOGNAME': 'cltbld', 05:54:56 INFO - 'MAIL': '/var/mail/cltbld', 05:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:56 INFO - 'MOZ_NO_REMOTE': '1', 05:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:56 INFO - 'NO_EM_RESTART': '1', 05:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:56 INFO - 'PWD': '/builds/slave/test', 05:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:56 INFO - 'SHELL': '/bin/bash', 05:54:56 INFO - 'SHLVL': '1', 05:54:56 INFO - 'TERM': 'linux', 05:54:56 INFO - 'TMOUT': '86400', 05:54:56 INFO - 'USER': 'cltbld', 05:54:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150', 05:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:56 INFO - '_': '/tools/buildbot/bin/python'} 05:54:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:54:56 INFO - mozversion application_buildid: 20161114030203 05:54:56 INFO - mozversion application_changeset: 1196bf3032e1bce1fb07a01fd9082a767426c5fb 05:54:56 INFO - mozversion application_display_name: Nightly 05:54:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:56 INFO - mozversion application_name: Firefox 05:54:56 INFO - mozversion application_remotingname: firefox 05:54:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:56 INFO - mozversion application_vendor: Mozilla 05:54:56 INFO - mozversion application_version: 52.0a1 05:54:56 INFO - mozversion platform_buildid: 20161114030203 05:54:56 INFO - mozversion platform_changeset: 1196bf3032e1bce1fb07a01fd9082a767426c5fb 05:54:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:56 INFO - mozversion platform_version: 52.0a1 05:54:56 INFO - using testdate: 1479131696 05:54:56 INFO - actual date: 1479131696 05:54:56 INFO - starting webserver on 'localhost:41283' 05:54:56 INFO - SUITE-START | Running 2 tests 05:54:56 INFO - TEST-START | dromaeo_css 05:54:56 INFO - operating with platform_type : linux_ 05:54:56 INFO - Initialising browser for dromaeo_css test... 05:54:56 INFO - TEST-INFO | started process 11254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7uUzOG/profile http://localhost:41283/getInfo.html) 05:55:00 INFO - PROCESS | 11254 | __metrics Screen width/height:1600/1200 05:55:00 INFO - PROCESS | 11254 | colorDepth:24 05:55:00 INFO - PROCESS | 11254 | Browser inner width/height: 1024/697 05:55:00 INFO - PROCESS | 11254 | __metrics 05:55:01 INFO - PROCESS | 11254 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:55:01 INFO - PROCESS | 11254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:01 INFO - PROCESS | 11254 | console.error: PushService: 05:55:01 INFO - PROCESS | 11254 | stateChangeProcessEnqueue: Error transitioning state 05:55:01 INFO - PROCESS | 11254 | UnknownError 05:55:02 INFO - TEST-INFO | 11254: exit 0 05:55:02 INFO - Browser initialized. 05:55:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:02 INFO - TEST-INFO | started process 11339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7uUzOG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:14 INFO - PROCESS | 11339 | RSS: Main: 173236224 05:55:14 INFO - PROCESS | 11339 | 05:56:05 INFO - PROCESS | 11339 | 1479131765599 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] 05:58:17 INFO - PROCESS | 11339 | Cycle 1(1): loaded http://localhost:41283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41283/tests/dromaeo/cssquery-ext.html) 05:58:19 INFO - PROCESS | 11339 | RSS: Main: 291467264 05:58:19 INFO - PROCESS | 11339 | 06:01:21 INFO - PROCESS | 11339 | Cycle 1(1): loaded http://localhost:41283/tests/dromaeo/cssquery-ext.html (next: http://localhost:41283/tests/dromaeo/cssquery-jquery.html) 06:01:22 INFO - PROCESS | 11339 | RSS: Main: 277086208 06:01:22 INFO - PROCESS | 11339 | 06:04:24 INFO - PROCESS | 11339 | Cycle 1(1): loaded http://localhost:41283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41283/tests/dromaeo/cssquery-mootools.html) 06:04:24 INFO - PROCESS | 11339 | RSS: Main: 258998272 06:04:24 INFO - PROCESS | 11339 | 06:07:26 INFO - PROCESS | 11339 | Cycle 1(1): loaded http://localhost:41283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41283/tests/dromaeo/cssquery-prototype.html) 06:07:27 INFO - PROCESS | 11339 | RSS: Main: 220827648 06:07:27 INFO - PROCESS | 11339 | 06:10:30 INFO - PROCESS | 11339 | Cycle 1(1): loaded http://localhost:41283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41283/tests/dromaeo/cssquery-yui.html) 06:10:31 INFO - PROCESS | 11339 | RSS: Main: 219389952 06:10:31 INFO - PROCESS | 11339 | 06:13:33 INFO - PROCESS | 11339 | Cycle 1(1): loaded http://localhost:41283/tests/dromaeo/cssquery-yui.html (next: http://localhost:41283/tests/dromaeo/cssquery-dojo.html) 06:13:34 INFO - PROCESS | 11339 | RSS: Main: 310079488 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | __start_tp_report 06:13:34 INFO - PROCESS | 11339 | _x_x_mozilla_page_load 06:13:34 INFO - PROCESS | 11339 | _x_x_mozilla_page_load_details 06:13:34 INFO - PROCESS | 11339 | |i|pagename|runs| 06:13:34 INFO - PROCESS | 11339 | |0;dojo.html;3066.1414803854923;3081.245094951737;3115.096621979627;3126.890558830443;3133.404653115908;5249.790008399665;5266.710330931797;5280.1815718563685;5293.89412211755;5311.681299122055;5419.918701219475;5439.347278326596;5444.292242008533;5450.400455949853;5458.1266997280445;4914.729689867065;4925.211966085427;4941;4975.701457912519;5011.599072074244;4992.750362481879;5032.370953630796;5042.798288068473;5051.116054690433;5054.064997975368;4836.177849765549;4865.2945322928335;4878.512148785111;4894.388201474816;4898.412190537123;4914.140025495524;4942.579880710144;4949.90100197994;4950.4307004694565;4972.154733695263;4766.952330476685;4794.424669039703;4807.807687692488;4842.249451335014;4873.19592267279;5287.07476191665;5289.418164001957;5306.787728490855;5308.044551980642;5373.785048598091;5707.315122185364;5712.1431785232135;5715.371309155989;5720;5721.4850663440075;5530.5022547970475;5701.885962280772;5707.400722924075;5768.048272035109;5818.505427038707;5280.3663560373;5326.813561525367;5329.25390445338;5329.520343169133;5335.09303418412;5791.044477661138;5793.768249270066;5795.82612521625;5891.1457838614015;5921.496672782776;5752.223449834302;5755.798547050833;5769.798057067983;5797.188393624896;5817.476427121579;5790;5843.3864444233595;5853.9414605854245;5854.560907931922;5854.941450585439;5709.7716091356715;5740.138979153077;5790.420957904176;5828.417158284223;5834.533237341003;5772.913406298909;5830.154627578977;5831.154482599999;5838.211841401441;5873.706314684248;4440.245158323093;4474.642028637766;4482.058767658763;4483.170613436525;4521.909561808746;3891.0855948851995;3960.405939109157;3968.0873399117786;4011.3581826907553;4054.3310353791885;5402.054640437907;5443.564514838803;5454.972725136428;5484.478974497416;5543.501084902297;5776.844631073802;5799.159121927381;5820.097884827858;5851.882962340729;5860.3260625027815;5262.815801447007;5483.917741233885;5490.6431081979545;5493.725313734298;5519.558435325164;4852.8301509447;4856.053069651384;4904.288878112654;4907.484714105039;4908.8772780680765;5766.740496677576;5808.3901190375245;5809.651420914674;5810.302763668386;5818.796342128006;5655.575831812713;5660.037793575185;5663.603547751618;5663.660180389025;5670.461306175906;5780.508656764222;5815;5815.621984570989;5821.359650438533;5823.7379317931645;5704.11586204139;5708.115242137475;5730.541556675373;5734.7132643368495;5735.483806457439;5841.18223448726;5854.882902341844;5855.853603659943;5864.179014937998;5865.090910908816;5631.436856314336;5633.521150702236;5650.0959846424375;5674.319081710221;5711.143328500758;5691;5693.971530142323;5695.316562012585;5701.429857014431;5701.517605422703;5506.1190209566275;5520.641158324696;5520.944790552043;5576.888462230814;5649.12438572022;5650.26546548946;5656.066748986371;5656.2929633795775;5689.943100569107;5709.771609135588;5531.557475401878;5533.3083364579425;5536.833894983157;5546.916796248141;5579.860503487445 06:13:34 INFO - PROCESS | 11339 | |1;ext.html;562.9607565715987;590.2503820148412;607.4623957797348;615.4399496458224;631.649434563817;31608.525872111906;32392.19019524513;42480.57519424805;43594.20463748985;43597.47408840683;40406.59593404065;44733;44830.32754508685;44879.102417951704;44894.1021179577;8652.22130008299;8806.735797926072;8810.603522841455;8811.295096392305;8813.250873675714;8671.479711217316;8752.518611476366;8755.824883502326;8761.649534018632;8767.035626081126;8672.262857657106;8753.562321883912;8758.255548278372;8770.429922055046;8781.824363512726;8685.913140868604;8707.9985801633;8719.302455803521;8740;8741.825163496726;8498.192671696179;8626.353023523261;8631.050584435707;8638.136186381375;8643.740687779376;41499.58500414987;41781.58218417807;41800.58199417997;41890.37164442536;42194.57805421968;3258.690424409701;3411.9147021324416;3425.383430982422;3685.8157092145284;3848.6536211741077;30856.228594285098;31006.844965775028;31042.068737937898;31106.53340199899;32449.35101297961;3911.2568611963634;4037.4347591337237;4072.2059198456313;4091.3249313863175;4114.814833332507;237944;239510.8024459884;240146;240960;241241;34281;52798.73600632049;52944.73527632337;52999;53022.083785391405;35993.64006359955;36002.81998590042;36227;36251;36289.45565816515;13558.11872228302;13651.249181295125;13666.385012674453;13669.521566745316;13675.863241367459;10993.835092473619;11027.283226590245;11043.558257669603;11047.502862371213;11062.889371106186;8566.742997710078;8571.4000019998;8602.31181505478;8660.22058014769;8683.348748843862;3334.7165490933544;3346.6867800877444;3352.4468462703867;3370.5449764281507;3375.8312084395684;982.7051884434641;983.7884854756262;1019.3221507697447;1082.976587125159;1125.285443743229;30658.70778091069;31114;31172;31757.20606984844;31794.205144871565;876.8728534362609;1100.339796122336;1106.2753896198003;1111.0944580167138;1134.6199023327279;15771.921140394454;16358.427455039016;16565.91717041407;16579.918991272127;16580.917095414447;493797;496709;498359;498629.1370862957;498801;55645.443545564834;56168.71915640395;56284;56318.15522767162;56464.43535564592;1200.1838749650321;1243.25404757145;1274.089026346167;1323.1201251168059;1330.3946704249736;30477.23806904845;31694.683053170094;32466.83766581152;32483;32981.50527742038;50557;51009.489905100476;51081;51164;51291;374143;374357;374864;374875;376314.539554939;27647.585286221125;28734.568981465713;28853.42293154083;29667.258318541346;29889.402211955203;45328.32007519824;45507.31739023851;46107.3083903735;46312.073758525315;47264.527354726015;39347.9173748728;39432.80283598564;40438.79780601078;40459.39310910398;42030.579694202665;38594.6140538591;38970.4154437678;39154.216915662095;39679.801600991814;40901.590984090966;39336.40995385014;39909;40008.79995600003;40618.79690601528;40661;33154.50268246027;35354.00369932814;35414.468782967764;35854.82072589621;36015.459768104025;26661.866690666422;27259.182224533295;27393.589096163174;27459.86270068717;27530.002680140067 06:13:34 INFO - PROCESS | 11339 | |2;jquery.html;379.75695554844924;396.1067792128751;401.4059192395254;403.9697022723296;417.8140727376317;13401.530946416866;15362.692746145085;18801.341953031646;19123;19450.90274548625;18809;19022.714659280122;19458.1243844027;19679.949607810777;19685.606287874234;4620.53794620537;5419.674819510832;5680.034394152984;5682.232898558704;5683.573731970098;4118.6499147572495;4328.913421731563;5541.085720856074;5607.158926161068;5983.551233657493;6233.875322493547;6338.84152896179;6347.492200623962;6348.492120630362;6352.491800655959;6130.1111338855835;6179.412955769218;6205.007198848185;6205.968970155121;6211.09939058834;5335.733213339357;5505.834824955257;5521.116621340607;5535.58483113768;5540.196671482612;22934.19730309431;22935.885320573456;23040.926316631416;23363.415914602272;23366;2413.2036427978724;2599.051346258621;2641.564141916601;2666.213467027212;3083.367909578531;14132.22272774997;14377.78433323501;14435.133891966516;14440.26716793981;15095.24523773818;1804.4225847728733;1918.4340619517277;1945.8540609454349;1954.5993071420326;1992.6512860249543;82187.5890620543;82318;82361.58819205925;82810.17189828085;84064.57967710122;10333.948330258301;10573.577056917791;10577.524011419504;10962.780744385227;11032.117430605533;15084.773728394082;15085.849141508665;15100.622484437978;15105.54683359501;15113.697726045637;7144.3570078693165;7203.315685009916;7210.495265331481;7333;7494.175640679521;6490.513211509156;6639;6739.359760822714;6765.05289259504;6929.618870962146;6336.085400715722;6410.775622853178;6527.765533319556;6608.537402381787;6669.599824010575;1677.753546886778;1809.185866360117;1812.7927724227486;1874.0884298015947;1980.2475059477306;880.2825697056878;946.6071580294101;955.0831202045974;1001.529281237817;1009.4801177393648;18132.925469967446;19750.40748777539;19767;19984;20062.09720562578;933.5192375926404;967.6322997260996;967.883853937532;1020.1940467031111;1021.9080282774437;8860.601272942733;10829.512671929782;11168;11183;11201.551937922555;412126;414118;414234;426011;437902;79486.60256698795;79573.60213199013;80132.59933700411;80795.59602201951;82139;961.778790878102;971.815355082532;974.4396971741277;983.695054533097;992.1517102876936;15971.920140399223;16590.917045414695;17141.22864471077;18620.348287810404;18650;42237.36643950282;42920.35619465648;42960.570394296905;43583.56416435795;43666.34500482432;57110;58173;58223;58790.711625466225;59797.70101149466;8003.759887203393;8316.916830831615;8336.916630833857;8358;8606.44058136219;8685.044645088909;11760.176787624785;13058.869411306145;13129.868701312864;13154.80267796003;5208.73956302191;5410.648307859977;11159.609413670483;11176.552937882394;11411.885881141414;11137.498812553617;11159.051480624237;11273.267237629529;11443.485043173243;11574.421278935852;11109.333439993627;11355.716107097389;11523.308601483937;11701.531938722695;12080;7815.25755053269;7951.681932722627;7980.521168729895;8244.670213191404;8576.356773241907;8039.799005024687;8194.67221311141;8278.675411934062;10367.481625918523;11610.303381797119 06:13:34 INFO - PROCESS | 11339 | |3;mootools.html;1457.2859298943517;1475.1886462445652;1585.1677869118712;1670.7827982362292;1756.7891852977646;7750.069991601009;8225.917740822604;8237.83524329513;8268.462549934258;8277.006759188891;6981.581105133696;7243.203247642755;7267.164276108249;7318.048653675028;8139.755807325775;2038.714579958807;2203.0526873444414;2272.943176420586;2282.0985710644286;2302.527981763743;2320.8143348532076;2330.021391015777;2334.311378143443;2338.4037070546988;2348.6124789409814;2268.6823844661676;2331.1491305673394;2348.189874493297;2351.271105957159;2354.1878052072007;2235.396442960408;2235.7987781099696;2272.2842304673973;2273.7726227377298;2273.9658905116435;2221.8777967211795;2234.229190929127;2236.519148383089;2238.8992495337748;2265.1732117777055;8145.674173033071;8202.876956845652;8234.094249632535;8249.670013199464;8259.339252859756;4798.328234047236;4922.335484709554;4936;4939.3084968104495;4965.379327584052;3076.292452735861;3114.5016797312323;3159.8262095584732;3202.1834432219866;3282.7373810095373;1095.5179720922768;1126.774645070989;1173.5481839491856;1201.525397468004;1225.2587184753186;10763;10793.08258798003;10825.83761243582;10829.783404331947;11161.944190279079;4299;4585.70192937458;4611.7232966021475;4654.511276316006;4674.0651869625535;9641.710748677551;9649.710508684751;9660.275479339078;9664.130228279488;9666.468344241135;5027.572656324181;5027.597792176617;5030.773615187325;5033.968036552498;5038.571721403649;4469.597736203757;4515.525869783691;4527.9547204527535;4587.678862479661;4592.425946756655;3521.2429327694667;3635.4001589737927;3637.308911306843;3678.8712395066045;3684.778913265213;1229.3484453239798;1249.5501619417003;1272.6118533847266;1285.1132718424258;1296.7600993816175;747.8242612985944;853.1340689200466;859.1966511311944;859.3941271403645;860.5611138319503;4972.925406118911;5116.309298244763;5231.215317702375;5251.36983561975;5484.725763711878;956.6173530587681;963.4363897120263;981.3670182732097;1002.2182697495965;1058.4707646176912;3263.8041717496553;3285.375778602058;3348.6986171244703;3360.7479439042168;3418.5214070030215;9870.506474676238;10155.898441015643;10234;10247.436390998566;10255.743606409751;10169.440680762482;10185.08334249921;10195.592176312864;10198.847017294747;10240.129588984872;7654.923450765533;7835.098963619257;7844.294013538809;7848.529088254723;7853.175416581176;4769.403824521934;4770.332153498583;4885.413750349839;4888.633352498506;5070.163423035158;9034.954825225832;9241;9328.067193280618;9431.339806213498;9458.763530911783;9380.530973451436;9431;9514.096160864707;9542.332036757638;9575.760605984906;7374;7448.106227252548;7496.812579685551;7500.587467689329;7570.697172113274;6770.526063175727;7589.316961473494;7616.7334143304715;7656.310932015923;7659.655315510704;6705.329467053256;7014.0531028310525;7067.787966361017;7071.43428525727;7307.7807665770115;7163.3552980232025;7192.352688258082;7227.168875579376;7268.636568171464;7364.153122390993;6466.612003279818;6531.412172904462;6543.967280163569;6566.11357466755;6597.736090556324;4486.439195100613;4559.202139625619;4667.8599642010795;4681.789319480564;4699.600533954515;4478.888027799331;4583.564561366665;4632.189366860854;4687.48437671849;4792.760361981817 06:13:34 INFO - PROCESS | 11339 | |4;prototype.html;327.41246127906527;340.06821309611666;346.2590057277426;348.61303952612593;352.65439868928433;5198.220266959948;5257.211418287249;5283.8150664726745;5344.385395679493;5352.892942141155;5052.469490703478;5179.378474583055;5192.273081768555;5203.791848326063;5252.238425428311;4155.542890282067;4164.9583504164875;4166.791660416982;4177.248095342845;4193.182329445759;3929.332013557688;4096.87709368718;4203.180379825935;4212.53662097169;4231.344141658033;4090.979545102285;4095.610916962884;4100.692448066392;4105.404716316132;4134.855280065199;4060.8984775380554;4080.6123418275215;4081.8775436736946;4083.8979025524304;4098.221337945781;3487.9128021799406;3621.700220360064;3624.474451204587;3626.691731202851;3631.673149416565;5129.948700513021;5132.230165475171;5138.794448222066;5144.254083157958;5157.638965272433;4697.765111744433;4705.764711764432;4717.433907931036;4729.62163026957;4750.881227969294;5353.250544923714;5435.619506634537;5484.314460692413;5512.972435137839;5529.557635389199;3971.6425521703186;3988.3419235826054;3990.186918222646;3993.1813978134705;3997.520297564282;5674.971625141848;5739.426057394269;5744.310682718059;5748.195252664588;5774.249347584787;3981.7610943343493;4027.5166979962005;4070.9389359159636;4109.321961876257;4134.111166099303;4095.85664501747;4097.672186225095;4102.830693252408;4133.276676581646;4142.357934520154;4666.929996050062;4676.205045142334;4679.836205732783;4684.812607495662;4708.9058218835435;5334.3058108864725;5456.372517160498;5497.615166938356;5509.228707980886;5515.889682206333;1313.5550894016505;1335.2789493673308;1340.9597712068653;1375.91302870731;1378.1937566523695;937.2033771294346;953.7853982853941;961.2310151878469;968.1335204991493;972.9006222968001;5016.974915125401;5043.344365232496;5061.822836200715;5067.5185857343495;5082.74586270685;5316.76074576645;5340.626156169109;5370.409254981949;5411.56707463402;5422.213779002102;4849.975750121227;5041.663959050855;5102.260172275;5105.387353517602;5149.897002059938;2882.337062475642;2889.3065664240853;2890.5519644455144;2894.3632400871775;2905.4915389806697;5574.442555744393;5574.58190635704;5581.413951535112;5609.411011843779;5610.887782244414;5135.177012160704;5388.622796404293;5412.431694672082;5448.42791506894;5448.564114870801;5487.670739755627;5502.807401741;5519.613627046148;5537.031019571559;5567.805126820542;5330.78676852937;5359.7136687194015;5376.623636345575;5392.7573259202645;5422.267993820941;5285.656432331886;5580.888382232414;5594.776208951596;5605.5515558756015;5610.663360198401;5777.162311464898;5803.593748437569;5815.836832633575;5821.94178058214;5830.82507524775;3977.080556273962;3978.1844721832535;3984.641382275609;4003.5796241394232;4017.879463616096;5339.504938617193;5619.409961953936;5625.88748225025;5641.887162256814;5663.943360566342;5343.4122246553625;5356.518263128842;5508.338999320107;5513.649155956817;5538.086215774352;5496.862578435571;5517.806876759294;5522.609525427375;5541.806036788693;5559.52744016747;5259.789608415774;5445.7821687133655;5448;5454;5488.231647569423;5533.727242734113;5551.750171242223;5553.972230138824;5559.9444005561045;5566.165075238585;5450.509454148987;5460.481254280837;5482.342118945592;5490.725463726718;5496.8076117337305 06:13:34 INFO - PROCESS | 11339 | |5;yui.html;628.7830698409048;717.3938022371096;720.7369310201778;735.2904447208443;771.5872008475465;14159.646008849784;14920.925395373008;14966.251687415614;15057.774133387995;15060.171690557016;14457.710845783078;14584.927075364634;14605.926970365133;14606.780898286534;14623;658.4633523678211;680.0852852912824;773.7562667759638;787.8069872881152;789.4434423731255;763.5304287862953;782.5774081995716;786.5123623353529;788.8540619985321;789.0964845252183;831.5177197225624;834.0700119366923;834.1033389106734;834.407570624857;834.7412302186311;702.4977141343963;824.5258976088772;826.7767702720262;827.8634025385834;828.6643909216747;529.3489008519504;583.8160979291509;597.6951754605183;598.7395482964924;599.442518457834;13024.674383140402;13031.674208144872;13057.347132643425;13069;13072.803907941388;12871.292078935654;13011.804822927663;13198.406071726698;13289.734205315839;13376.799348009788;11668.299902005907;11770.529178832836;11822.349770762605;11833.763324733458;11910.58312959051;4112.37785016287;4161.313383291753;4229.70392072555;4282.122164956177;4411.1618792429335;58462.70768646172;58660.12009819856;59119.70440147815;59226;60735.69632151811;10654.307470014579;10713.78572428547;10735.409552474688;10869;10930.508127134299;19387.515312117026;19558.80441195598;19580.70628940567;19582.5104372389;19934;7433.479656423999;7453.105627324756;7588.165301816795;7593.5823529706395;7790.532568045822;3887.494625698641;4009.4587230723478;4113.056633165048;4120.361343991686;4129.566395528486;3111.642161151451;3178.618565772122;3178.98410507946;3185.9681403185673;3194.8402579870913;535.568867062011;537.9246905433242;539.7652021370716;546.3471151973354;546.3553007451167;591.5060924128401;596.931352894414;646.5668002438377;667.9866402671919;676.631235976394;7839.960800195962;8480.279176269964;8516.616752246164;8571;8594.957025214959;592.2774215457135;613.9324674285825;637.8022812928007;661.2626920983165;679.2392520377209;4020.3567429211184;4101.507819061731;4115.71190016702;4134.896627584334;4195.517515485697;86078.34825324814;88888.5555572218;89027.10972890317;92440.53779731058;93084.53457732667;76281;76470;78401;78772.24297149573;79508.60245698734;45005.774971124934;45698.77150614226;66261.33738662647;66503.66748166324;66812;7916.920830791619;8054.31538319226;8150.75547733569;8245.711400100967;8246.711365102192;37199.628003720696;39562;48232.276515852995;48570.75714621404;51262.231066534776;39155.41266881056;54099.459005411016;56136;56532.325398848945;59039.70480147572;11787.292762433939;11955.581554645545;12224.327661978676;12275;12642.431090600761;12934.353282336035;13280.53518126861;13807.585772426843;14063.156210627396;14194.322271091232;11981.580644677395;12133.514659413524;12658.177218480769;12806.67983300425;12929.418176182282;11612.535498579962;11814.232074915102;11847.822282665595;11930;11952.58165964187;12083.381227729149;12316.199447035913;12587.118901676795;12611.747765044463;12657.87342126567;9857.489886620318;10240.897591023995;10241.436720980417;10952.397618131079;11024;9811.607535698493;10350.275480716278;10393.53229104677;10477.266591338534;10688.679339619825 06:13:34 INFO - PROCESS | 11339 | __end_tp_report 06:13:34 INFO - PROCESS | 11339 | __start_cc_report 06:13:34 INFO - PROCESS | 11339 | _x_x_mozilla_cycle_collect,1174 06:13:34 INFO - PROCESS | 11339 | __end_cc_report 06:13:34 INFO - PROCESS | 11339 | __startTimestamp1479132814151__endTimestamp 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | ------- Summary: start ------- 06:13:34 INFO - PROCESS | 11339 | Number of tests: 6 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | [#0] dojo.html Cycles:165 Average:5352.70 Median:5546.92 stddev:599.38 (10.8%) stddev-sans-first:573.75 06:13:34 INFO - PROCESS | 11339 | Values: 3066.1 3081.2 3115.1 3126.9 3133.4 5249.8 5266.7 5280.2 5293.9 5311.7 5419.9 5439.3 5444.3 5450.4 5458.1 4914.7 4925.2 4941.0 4975.7 5011.6 4992.8 5032.4 5042.8 5051.1 5054.1 4836.2 4865.3 4878.5 4894.4 4898.4 4914.1 4942.6 4949.9 4950.4 4972.2 4767.0 4794.4 4807.8 4842.2 4873.2 5287.1 5289.4 5306.8 5308.0 5373.8 5707.3 5712.1 5715.4 5720.0 5721.5 5530.5 5701.9 5707.4 5768.0 5818.5 5280.4 5326.8 5329.3 5329.5 5335.1 5791.0 5793.8 5795.8 5891.1 5921.5 5752.2 5755.8 5769.8 5797.2 5817.5 5790.0 5843.4 5853.9 5854.6 5854.9 5709.8 5740.1 5790.4 5828.4 5834.5 5772.9 5830.2 5831.2 5838.2 5873.7 4440.2 4474.6 4482.1 4483.2 4521.9 3891.1 3960.4 3968.1 4011.4 4054.3 5402.1 5443.6 5455.0 5484.5 5543.5 5776.8 5799.2 5820.1 5851.9 5860.3 5262.8 5483.9 5490.6 5493.7 5519.6 4852.8 4856.1 4904.3 4907.5 4908.9 5766.7 5808.4 5809.7 5810.3 5818.8 5655.6 5660.0 5663.6 5663.7 5670.5 5780.5 5815.0 5815.6 5821.4 5823.7 5704.1 5708.1 5730.5 5734.7 5735.5 5841.2 5854.9 5855.9 5864.2 5865.1 5631.4 5633.5 5650.1 5674.3 5711.1 5691.0 5694.0 5695.3 5701.4 5701.5 5506.1 5520.6 5520.9 5576.9 5649.1 5650.3 5656.1 5656.3 5689.9 5709.8 5531.6 5533.3 5536.8 5546.9 5579.9 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | [#1] ext.html Cycles:180 Average:52482.71 Median:39390.36 stddev:102320.98 (259.8%) stddev-sans-first:102533.76 06:13:34 INFO - PROCESS | 11339 | Values: 563.0 590.3 607.5 615.4 631.6 31608.5 32392.2 42480.6 43594.2 43597.5 40406.6 44733.0 44830.3 44879.1 44894.1 8652.2 8806.7 8810.6 8811.3 8813.3 8671.5 8752.5 8755.8 8761.6 8767.0 8672.3 8753.6 8758.3 8770.4 8781.8 8685.9 8708.0 8719.3 8740.0 8741.8 8498.2 8626.4 8631.1 8638.1 8643.7 41499.6 41781.6 41800.6 41890.4 42194.6 3258.7 3411.9 3425.4 3685.8 3848.7 30856.2 31006.8 31042.1 31106.5 32449.4 3911.3 4037.4 4072.2 4091.3 4114.8 237944.0 239510.8 240146.0 240960.0 241241.0 34281.0 52798.7 52944.7 52999.0 53022.1 35993.6 36002.8 36227.0 36251.0 36289.5 13558.1 13651.2 13666.4 13669.5 13675.9 10993.8 11027.3 11043.6 11047.5 11062.9 8566.7 8571.4 8602.3 8660.2 8683.3 3334.7 3346.7 3352.4 3370.5 3375.8 982.7 983.8 1019.3 1083.0 1125.3 30658.7 31114.0 31172.0 31757.2 31794.2 876.9 1100.3 1106.3 1111.1 1134.6 15771.9 16358.4 16565.9 16579.9 16580.9 493797.0 496709.0 498359.0 498629.1 498801.0 55645.4 56168.7 56284.0 56318.2 56464.4 1200.2 1243.3 1274.1 1323.1 1330.4 30477.2 31694.7 32466.8 32483.0 32981.5 50557.0 51009.5 51081.0 51164.0 51291.0 374143.0 374357.0 374864.0 374875.0 376314.5 27647.6 28734.6 28853.4 29667.3 29889.4 45328.3 45507.3 46107.3 46312.1 47264.5 39347.9 39432.8 40438.8 40459.4 42030.6 38594.6 38970.4 39154.2 39679.8 40901.6 39336.4 39909.0 40008.8 40618.8 40661.0 33154.5 35354.0 35414.5 35854.8 36015.5 26661.9 27259.2 27393.6 27459.9 27530.0 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | [#2] jquery.html Cycles:180 Average:26703.54 Median:21327.59 stddev:69667.12 (326.7%) stddev-sans-first:69834.52 06:13:34 INFO - PROCESS | 11339 | Values: 379.8 396.1 401.4 404.0 417.8 13401.5 15362.7 18801.3 19123.0 19450.9 18809.0 19022.7 19458.1 19679.9 19685.6 4620.5 5419.7 5680.0 5682.2 5683.6 4118.6 4328.9 5541.1 5607.2 5983.6 6233.9 6338.8 6347.5 6348.5 6352.5 6130.1 6179.4 6205.0 6206.0 6211.1 5335.7 5505.8 5521.1 5535.6 5540.2 22934.2 22935.9 23040.9 23363.4 23366.0 2413.2 2599.1 2641.6 2666.2 3083.4 14132.2 14377.8 14435.1 14440.3 15095.2 1804.4 1918.4 1945.9 1954.6 1992.7 82187.6 82318.0 82361.6 82810.2 84064.6 10333.9 10573.6 10577.5 10962.8 11032.1 15084.8 15085.8 15100.6 15105.5 15113.7 7144.4 7203.3 7210.5 7333.0 7494.2 6490.5 6639.0 6739.4 6765.1 6929.6 6336.1 6410.8 6527.8 6608.5 6669.6 1677.8 1809.2 1812.8 1874.1 1980.2 880.3 946.6 955.1 1001.5 1009.5 18132.9 19750.4 19767.0 19984.0 20062.1 933.5 967.6 967.9 1020.2 1021.9 8860.6 10829.5 11168.0 11183.0 11201.6 412126.0 414118.0 414234.0 426011.0 437902.0 79486.6 79573.6 80132.6 80795.6 82139.0 961.8 971.8 974.4 983.7 992.2 15971.9 16590.9 17141.2 18620.3 18650.0 42237.4 42920.4 42960.6 43583.6 43666.3 57110.0 58173.0 58223.0 58790.7 59797.7 8003.8 8316.9 8336.9 8358.0 8606.4 8685.0 11760.2 13058.9 13129.9 13154.8 5208.7 5410.6 11159.6 11176.6 11411.9 11137.5 11159.1 11273.3 11443.5 11574.4 11109.3 11355.7 11523.3 11701.5 12080.0 7815.3 7951.7 7980.5 8244.7 8576.4 8039.8 8194.7 8278.7 10367.5 11610.3 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | [#3] mootools.html Cycles:180 Average:5354.05 Median:4769.87 stddev:2997.15 (62.8%) stddev-sans-first:2991.25 06:13:34 INFO - PROCESS | 11339 | Values: 1457.3 1475.2 1585.2 1670.8 1756.8 7750.1 8225.9 8237.8 8268.5 8277.0 6981.6 7243.2 7267.2 7318.0 8139.8 2038.7 2203.1 2272.9 2282.1 2302.5 2320.8 2330.0 2334.3 2338.4 2348.6 2268.7 2331.1 2348.2 2351.3 2354.2 2235.4 2235.8 2272.3 2273.8 2274.0 2221.9 2234.2 2236.5 2238.9 2265.2 8145.7 8202.9 8234.1 8249.7 8259.3 4798.3 4922.3 4936.0 4939.3 4965.4 3076.3 3114.5 3159.8 3202.2 3282.7 1095.5 1126.8 1173.5 1201.5 1225.3 10763.0 10793.1 10825.8 10829.8 11161.9 4299.0 4585.7 4611.7 4654.5 4674.1 9641.7 9649.7 9660.3 9664.1 9666.5 5027.6 5027.6 5030.8 5034.0 5038.6 4469.6 4515.5 4528.0 4587.7 4592.4 3521.2 3635.4 3637.3 3678.9 3684.8 1229.3 1249.6 1272.6 1285.1 1296.8 747.8 853.1 859.2 859.4 860.6 4972.9 5116.3 5231.2 5251.4 5484.7 956.6 963.4 981.4 1002.2 1058.5 3263.8 3285.4 3348.7 3360.7 3418.5 9870.5 10155.9 10234.0 10247.4 10255.7 10169.4 10185.1 10195.6 10198.8 10240.1 7654.9 7835.1 7844.3 7848.5 7853.2 4769.4 4770.3 4885.4 4888.6 5070.2 9035.0 9241.0 9328.1 9431.3 9458.8 9380.5 9431.0 9514.1 9542.3 9575.8 7374.0 7448.1 7496.8 7500.6 7570.7 6770.5 7589.3 7616.7 7656.3 7659.7 6705.3 7014.1 7067.8 7071.4 7307.8 7163.4 7192.4 7227.2 7268.6 7364.2 6466.6 6531.4 6544.0 6566.1 6597.7 4486.4 4559.2 4667.9 4681.8 4699.6 4478.9 4583.6 4632.2 4687.5 4792.8 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | [#4] prototype.html Cycles:180 Average:4587.44 Median:5228.02 stddev:1329.87 (25.4%) stddev-sans-first:1294.59 06:13:34 INFO - PROCESS | 11339 | Values: 327.4 340.1 346.3 348.6 352.7 5198.2 5257.2 5283.8 5344.4 5352.9 5052.5 5179.4 5192.3 5203.8 5252.2 4155.5 4165.0 4166.8 4177.2 4193.2 3929.3 4096.9 4203.2 4212.5 4231.3 4091.0 4095.6 4100.7 4105.4 4134.9 4060.9 4080.6 4081.9 4083.9 4098.2 3487.9 3621.7 3624.5 3626.7 3631.7 5129.9 5132.2 5138.8 5144.3 5157.6 4697.8 4705.8 4717.4 4729.6 4750.9 5353.3 5435.6 5484.3 5513.0 5529.6 3971.6 3988.3 3990.2 3993.2 3997.5 5675.0 5739.4 5744.3 5748.2 5774.2 3981.8 4027.5 4070.9 4109.3 4134.1 4095.9 4097.7 4102.8 4133.3 4142.4 4666.9 4676.2 4679.8 4684.8 4708.9 5334.3 5456.4 5497.6 5509.2 5515.9 1313.6 1335.3 1341.0 1375.9 1378.2 937.2 953.8 961.2 968.1 972.9 5017.0 5043.3 5061.8 5067.5 5082.7 5316.8 5340.6 5370.4 5411.6 5422.2 4850.0 5041.7 5102.3 5105.4 5149.9 2882.3 2889.3 2890.6 2894.4 2905.5 5574.4 5574.6 5581.4 5609.4 5610.9 5135.2 5388.6 5412.4 5448.4 5448.6 5487.7 5502.8 5519.6 5537.0 5567.8 5330.8 5359.7 5376.6 5392.8 5422.3 5285.7 5580.9 5594.8 5605.6 5610.7 5777.2 5803.6 5815.8 5821.9 5830.8 3977.1 3978.2 3984.6 4003.6 4017.9 5339.5 5619.4 5625.9 5641.9 5663.9 5343.4 5356.5 5508.3 5513.6 5538.1 5496.9 5517.8 5522.6 5541.8 5559.5 5259.8 5445.8 5448.0 5454.0 5488.2 5533.7 5551.8 5554.0 5559.9 5566.2 5450.5 5460.5 5482.3 5490.7 5496.8 06:13:34 INFO - PROCESS | 11339 | 06:13:34 INFO - PROCESS | 11339 | [#5] yui.html Cycles:180 Average:16950.19 Median:24708.47 stddev:22666.25 (91.7%) stddev-sans-first:22696.70 06:13:34 INFO - PROCESS | 11339 | Values: 628.8 717.4 720.7 735.3 771.6 14159.6 14920.9 14966.3 15057.8 15060.2 14457.7 14584.9 14605.9 14606.8 14623.0 658.5 680.1 773.8 787.8 789.4 763.5 782.6 786.5 788.9 789.1 831.5 834.1 834.1 834.4 834.7 702.5 824.5 826.8 827.9 828.7 529.3 583.8 597.7 598.7 599.4 13024.7 13031.7 13057.3 13069.0 13072.8 12871.3 13011.8 13198.4 13289.7 13376.8 11668.3 11770.5 11822.3 11833.8 11910.6 4112.4 4161.3 4229.7 4282.1 4411.2 58462.7 58660.1 59119.7 59226.0 60735.7 10654.3 10713.8 10735.4 10869.0 10930.5 19387.5 19558.8 19580.7 19582.5 19934.0 7433.5 7453.1 7588.2 7593.6 7790.5 3887.5 4009.5 4113.1 4120.4 4129.6 3111.6 3178.6 3179.0 3186.0 3194.8 535.6 537.9 539.8 546.3 546.4 591.5 596.9 646.6 668.0 676.6 7840.0 8480.3 8516.6 8571.0 8595.0 592.3 613.9 637.8 661.3 679.2 4020.4 4101.5 4115.7 4134.9 4195.5 86078.3 88888.6 89027.1 92440.5 93084.5 76281.0 76470.0 78401.0 78772.2 79508.6 45005.8 45698.8 66261.3 66503.7 66812.0 7916.9 8054.3 8150.8 8245.7 8246.7 37199.6 39562.0 48232.3 48570.8 51262.2 39155.4 54099.5 56136.0 56532.3 59039.7 11787.3 11955.6 12224.3 12275.0 12642.4 12934.4 13280.5 13807.6 14063.2 14194.3 11981.6 12133.5 12658.2 12806.7 12929.4 11612.5 11814.2 11847.8 11930.0 11952.6 12083.4 12316.2 12587.1 12611.7 12657.9 9857.5 10240.9 10241.4 10952.4 11024.0 9811.6 10350.3 10393.5 10477.3 10688.7 06:13:34 INFO - PROCESS | 11339 | -------- Summary: end -------- 06:13:34 INFO - PROCESS | 11339 | 06:13:35 INFO - TEST-INFO | 11339: exit 0 06:13:35 INFO - TEST-OK | dromaeo_css | took 1118609ms 06:13:35 INFO - TEST-START | kraken 06:13:35 INFO - operating with platform_type : linux_ 06:13:35 INFO - Initialising browser for kraken test... 06:13:35 INFO - TEST-INFO | started process 11640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIhmcx/profile http://localhost:41283/getInfo.html) 06:13:39 INFO - PROCESS | 11640 | __metrics Screen width/height:1600/1200 06:13:39 INFO - PROCESS | 11640 | colorDepth:24 06:13:39 INFO - PROCESS | 11640 | Browser inner width/height: 1024/697 06:13:39 INFO - PROCESS | 11640 | __metrics 06:13:39 INFO - PROCESS | 11640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:13:39 INFO - PROCESS | 11640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:40 INFO - PROCESS | 11640 | console.error: PushService: 06:13:40 INFO - PROCESS | 11640 | stateChangeProcessEnqueue: Error transitioning state 06:13:40 INFO - PROCESS | 11640 | UnknownError 06:13:40 INFO - TEST-INFO | 11640: exit 0 06:13:40 INFO - Browser initialized. 06:13:40 INFO - Running cycle 1/1 for kraken test... 06:13:40 INFO - TEST-INFO | started process 11725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIhmcx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:53 INFO - PROCESS | 11725 | RSS: Main: 174075904 06:13:53 INFO - PROCESS | 11725 | 06:13:55 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41283/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:56 INFO - PROCESS | 11725 | RSS: Main: 234586112 06:13:56 INFO - PROCESS | 11725 | 06:13:59 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41283/tests/kraken/driver.html?testName=audio-dft) 06:13:59 INFO - PROCESS | 11725 | RSS: Main: 216379392 06:13:59 INFO - PROCESS | 11725 | 06:14:02 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41283/tests/kraken/driver.html?testName=audio-fft) 06:14:03 INFO - PROCESS | 11725 | RSS: Main: 297705472 06:14:03 INFO - PROCESS | 11725 | 06:14:05 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41283/tests/kraken/driver.html?testName=audio-oscillator) 06:14:06 INFO - PROCESS | 11725 | RSS: Main: 210309120 06:14:06 INFO - PROCESS | 11725 | 06:14:08 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:08 INFO - PROCESS | 11725 | RSS: Main: 213217280 06:14:08 INFO - PROCESS | 11725 | 06:14:11 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41283/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:12 INFO - PROCESS | 11725 | RSS: Main: 252178432 06:14:12 INFO - PROCESS | 11725 | 06:14:15 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41283/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:16 INFO - PROCESS | 11725 | RSS: Main: 252207104 06:14:16 INFO - PROCESS | 11725 | 06:14:19 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41283/tests/kraken/driver.html?testName=json-parse-financial) 06:14:19 INFO - PROCESS | 11725 | RSS: Main: 251465728 06:14:19 INFO - PROCESS | 11725 | 06:14:21 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:21 INFO - PROCESS | 11725 | RSS: Main: 213614592 06:14:21 INFO - PROCESS | 11725 | 06:14:23 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:24 INFO - PROCESS | 11725 | RSS: Main: 220450816 06:14:24 INFO - PROCESS | 11725 | 06:14:26 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:26 INFO - PROCESS | 11725 | RSS: Main: 229285888 06:14:26 INFO - PROCESS | 11725 | 06:14:29 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:30 INFO - PROCESS | 11725 | RSS: Main: 237969408 06:14:30 INFO - PROCESS | 11725 | 06:14:33 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:33 INFO - PROCESS | 11725 | RSS: Main: 234921984 06:14:33 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | Cycle 1(1): loaded http://localhost:41283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41283/tests/kraken/driver.html?testName=ai-astar) 06:14:35 INFO - PROCESS | 11725 | RSS: Main: 286740480 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | __start_tp_report 06:14:35 INFO - PROCESS | 11725 | _x_x_mozilla_page_load 06:14:35 INFO - PROCESS | 11725 | _x_x_mozilla_page_load_details 06:14:35 INFO - PROCESS | 11725 | |i|pagename|runs| 06:14:35 INFO - PROCESS | 11725 | |0;ai-astar;112;114;115;113;113;115;114;112;113;112 06:14:35 INFO - PROCESS | 11725 | |1;audio-beat-detection;148;122;125;168;123;127;126;122;163;122 06:14:35 INFO - PROCESS | 11725 | |2;audio-dft;161;161;160;162;160;162;161;162;161;162 06:14:35 INFO - PROCESS | 11725 | |3;audio-fft;75;77;75;106;76;75;77;75;102;75 06:14:35 INFO - PROCESS | 11725 | |4;audio-oscillator;83;82;122;81;81;83;100;82;82;118 06:14:35 INFO - PROCESS | 11725 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 06:14:35 INFO - PROCESS | 11725 | |6;imaging-darkroom;146;147;145;145;147;146;145;145;147;146 06:14:35 INFO - PROCESS | 11725 | |7;imaging-desaturate;85;85;85;84;84;85;84;85;85;84 06:14:35 INFO - PROCESS | 11725 | |8;json-parse-financial;54;51;51;51;51;57;53;52;52;53 06:14:35 INFO - PROCESS | 11725 | |9;json-stringify-tinderbox;61;62;62;61;61;62;62;62;62;62 06:14:35 INFO - PROCESS | 11725 | |10;stanford-crypto-aes;80;80;79;80;88;79;80;81;86;79 06:14:35 INFO - PROCESS | 11725 | |11;stanford-crypto-ccm;134;143;128;142;138;133;139;134;194;127 06:14:35 INFO - PROCESS | 11725 | |12;stanford-crypto-pbkdf2;165;165;163;166;169;167;169;168;163;164 06:14:35 INFO - PROCESS | 11725 | |13;stanford-crypto-sha256-iterative;64;66;64;64;64;64;71;65;63;64 06:14:35 INFO - PROCESS | 11725 | __end_tp_report 06:14:35 INFO - PROCESS | 11725 | __start_cc_report 06:14:35 INFO - PROCESS | 11725 | _x_x_mozilla_cycle_collect,1681 06:14:35 INFO - PROCESS | 11725 | __end_cc_report 06:14:35 INFO - PROCESS | 11725 | __startTimestamp1479132875655__endTimestamp 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | ------- Summary: start ------- 06:14:35 INFO - PROCESS | 11725 | Number of tests: 14 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.16 (1.0%) stddev-sans-first:1.13 06:14:35 INFO - PROCESS | 11725 | Values: 112.0 114.0 115.0 113.0 113.0 115.0 114.0 112.0 113.0 112.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:126.50 stddev:18.06 (14.3%) stddev-sans-first:18.50 06:14:35 INFO - PROCESS | 11725 | Values: 148.0 122.0 125.0 168.0 123.0 127.0 126.0 122.0 163.0 122.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:14:35 INFO - PROCESS | 11725 | Values: 161.0 161.0 160.0 162.0 160.0 162.0 161.0 162.0 161.0 162.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:12.03 (16.0%) stddev-sans-first:12.54 06:14:35 INFO - PROCESS | 11725 | Values: 75.0 77.0 75.0 106.0 76.0 75.0 77.0 75.0 102.0 75.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.00 stddev:16.13 (19.7%) stddev-sans-first:16.82 06:14:35 INFO - PROCESS | 11725 | Values: 83.0 82.0 122.0 81.0 81.0 83.0 100.0 82.0 82.0 118.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:14:35 INFO - PROCESS | 11725 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 06:14:35 INFO - PROCESS | 11725 | Values: 146.0 147.0 145.0 145.0 147.0 146.0 145.0 145.0 147.0 146.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:14:35 INFO - PROCESS | 11725 | Values: 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 85.0 84.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:1.90 (3.6%) stddev-sans-first:1.94 06:14:35 INFO - PROCESS | 11725 | Values: 54.0 51.0 51.0 51.0 51.0 57.0 53.0 52.0 52.0 53.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 06:14:35 INFO - PROCESS | 11725 | Values: 61.0 62.0 62.0 61.0 61.0 62.0 62.0 62.0 62.0 62.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:3.16 (3.9%) stddev-sans-first:3.32 06:14:35 INFO - PROCESS | 11725 | Values: 80.0 80.0 79.0 80.0 88.0 79.0 80.0 81.0 86.0 79.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:138.50 stddev:19.30 (13.9%) stddev-sans-first:20.30 06:14:35 INFO - PROCESS | 11725 | Values: 134.0 143.0 128.0 142.0 138.0 133.0 139.0 134.0 194.0 127.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.50 stddev:2.28 (1.4%) stddev-sans-first:2.40 06:14:35 INFO - PROCESS | 11725 | Values: 165.0 165.0 163.0 166.0 169.0 167.0 169.0 168.0 163.0 164.0 06:14:35 INFO - PROCESS | 11725 | 06:14:35 INFO - PROCESS | 11725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.00 stddev:2.28 (3.6%) stddev-sans-first:2.40 06:14:35 INFO - PROCESS | 11725 | Values: 64.0 66.0 64.0 64.0 64.0 64.0 71.0 65.0 63.0 64.0 06:14:35 INFO - PROCESS | 11725 | -------- Summary: end -------- 06:14:35 INFO - PROCESS | 11725 | 06:14:36 INFO - TEST-INFO | 11725: exit 0 06:14:36 INFO - TEST-OK | kraken | took 61708ms 06:14:36 INFO - SUITE-END | took 1180s 06:14:37 INFO - Completed test suite (00:19:40) 06:14:37 INFO - javascript benchmark 06:14:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.1414803854923, 3081.245094951737, 3115.096621979627, 3126.890558830443, 3133.404653115908, 5249.790008399665, 5266.710330931797, 5280.1815718563685, 5293.89412211755, 5311.681299122055, 5419.918701219475, 5439.347278326596, 5444.292242008533, 5450.400455949853, 5458.1266997280445, 4914.729689867065, 4925.211966085427, 4941.0, 4975.701457912519, 5011.599072074244, 4992.750362481879, 5032.370953630796, 5042.798288068473, 5051.116054690433, 5054.064997975368, 4836.177849765549, 4865.2945322928335, 4878.512148785111, 4894.388201474816, 4898.412190537123, 4914.140025495524, 4942.579880710144, 4949.90100197994, 4950.4307004694565, 4972.154733695263, 4766.952330476685, 4794.424669039703, 4807.807687692488, 4842.249451335014, 4873.19592267279, 5287.07476191665, 5289.418164001957, 5306.787728490855, 5308.044551980642, 5373.785048598091, 5707.315122185364, 5712.1431785232135, 5715.371309155989, 5720.0, 5721.4850663440075, 5530.5022547970475, 5701.885962280772, 5707.400722924075, 5768.048272035109, 5818.505427038707, 5280.3663560373, 5326.813561525367, 5329.25390445338, 5329.520343169133, 5335.09303418412, 5791.044477661138, 5793.768249270066, 5795.82612521625, 5891.1457838614015, 5921.496672782776, 5752.223449834302, 5755.798547050833, 5769.798057067983, 5797.188393624896, 5817.476427121579, 5790.0, 5843.3864444233595, 5853.9414605854245, 5854.560907931922, 5854.941450585439, 5709.7716091356715, 5740.138979153077, 5790.420957904176, 5828.417158284223, 5834.533237341003, 5772.913406298909, 5830.154627578977, 5831.154482599999, 5838.211841401441, 5873.706314684248, 4440.245158323093, 4474.642028637766, 4482.058767658763, 4483.170613436525, 4521.909561808746, 3891.0855948851995, 3960.405939109157, 3968.0873399117786, 4011.3581826907553, 4054.3310353791885, 5402.054640437907, 5443.564514838803, 5454.972725136428, 5484.478974497416, 5543.501084902297, 5776.844631073802, 5799.159121927381, 5820.097884827858, 5851.882962340729, 5860.3260625027815, 5262.815801447007, 5483.917741233885, 5490.6431081979545, 5493.725313734298, 5519.558435325164, 4852.8301509447, 4856.053069651384, 4904.288878112654, 4907.484714105039, 4908.8772780680765, 5766.740496677576, 5808.3901190375245, 5809.651420914674, 5810.302763668386, 5818.796342128006, 5655.575831812713, 5660.037793575185, 5663.603547751618, 5663.660180389025, 5670.461306175906, 5780.508656764222, 5815.0, 5815.621984570989, 5821.359650438533, 5823.7379317931645, 5704.11586204139, 5708.115242137475, 5730.541556675373, 5734.7132643368495, 5735.483806457439, 5841.18223448726, 5854.882902341844, 5855.853603659943, 5864.179014937998, 5865.090910908816, 5631.436856314336, 5633.521150702236, 5650.0959846424375, 5674.319081710221, 5711.143328500758, 5691.0, 5693.971530142323, 5695.316562012585, 5701.429857014431, 5701.517605422703, 5506.1190209566275, 5520.641158324696, 5520.944790552043, 5576.888462230814, 5649.12438572022, 5650.26546548946, 5656.066748986371, 5656.2929633795775, 5689.943100569107, 5709.771609135588, 5531.557475401878, 5533.3083364579425, 5536.833894983157, 5546.916796248141, 5579.860503487445], "value": 5312.508332888388, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9607565715987, 590.2503820148412, 607.4623957797348, 615.4399496458224, 631.649434563817, 31608.525872111906, 32392.19019524513, 42480.57519424805, 43594.20463748985, 43597.47408840683, 40406.59593404065, 44733.0, 44830.32754508685, 44879.102417951704, 44894.1021179577, 8652.22130008299, 8806.735797926072, 8810.603522841455, 8811.295096392305, 8813.250873675714, 8671.479711217316, 8752.518611476366, 8755.824883502326, 8761.649534018632, 8767.035626081126, 8672.262857657106, 8753.562321883912, 8758.255548278372, 8770.429922055046, 8781.824363512726, 8685.913140868604, 8707.9985801633, 8719.302455803521, 8740.0, 8741.825163496726, 8498.192671696179, 8626.353023523261, 8631.050584435707, 8638.136186381375, 8643.740687779376, 41499.58500414987, 41781.58218417807, 41800.58199417997, 41890.37164442536, 42194.57805421968, 3258.690424409701, 3411.9147021324416, 3425.383430982422, 3685.8157092145284, 3848.6536211741077, 30856.228594285098, 31006.844965775028, 31042.068737937898, 31106.53340199899, 32449.35101297961, 3911.2568611963634, 4037.4347591337237, 4072.2059198456313, 4091.3249313863175, 4114.814833332507, 237944.0, 239510.8024459884, 240146.0, 240960.0, 241241.0, 34281.0, 52798.73600632049, 52944.73527632337, 52999.0, 53022.083785391405, 35993.64006359955, 36002.81998590042, 36227.0, 36251.0, 36289.45565816515, 13558.11872228302, 13651.249181295125, 13666.385012674453, 13669.521566745316, 13675.863241367459, 10993.835092473619, 11027.283226590245, 11043.558257669603, 11047.502862371213, 11062.889371106186, 8566.742997710078, 8571.4000019998, 8602.31181505478, 8660.22058014769, 8683.348748843862, 3334.7165490933544, 3346.6867800877444, 3352.4468462703867, 3370.5449764281507, 3375.8312084395684, 982.7051884434641, 983.7884854756262, 1019.3221507697447, 1082.976587125159, 1125.285443743229, 30658.70778091069, 31114.0, 31172.0, 31757.20606984844, 31794.205144871565, 876.8728534362609, 1100.339796122336, 1106.2753896198003, 1111.0944580167138, 1134.6199023327279, 15771.921140394454, 16358.427455039016, 16565.91717041407, 16579.918991272127, 16580.917095414447, 493797.0, 496709.0, 498359.0, 498629.1370862957, 498801.0, 55645.443545564834, 56168.71915640395, 56284.0, 56318.15522767162, 56464.43535564592, 1200.1838749650321, 1243.25404757145, 1274.089026346167, 1323.1201251168059, 1330.3946704249736, 30477.23806904845, 31694.683053170094, 32466.83766581152, 32483.0, 32981.50527742038, 50557.0, 51009.489905100476, 51081.0, 51164.0, 51291.0, 374143.0, 374357.0, 374864.0, 374875.0, 376314.539554939, 27647.585286221125, 28734.568981465713, 28853.42293154083, 29667.258318541346, 29889.402211955203, 45328.32007519824, 45507.31739023851, 46107.3083903735, 46312.073758525315, 47264.527354726015, 39347.9173748728, 39432.80283598564, 40438.79780601078, 40459.39310910398, 42030.579694202665, 38594.6140538591, 38970.4154437678, 39154.216915662095, 39679.801600991814, 40901.590984090966, 39336.40995385014, 39909.0, 40008.79995600003, 40618.79690601528, 40661.0, 33154.50268246027, 35354.00369932814, 35414.468782967764, 35854.82072589621, 36015.459768104025, 26661.866690666422, 27259.182224533295, 27393.589096163174, 27459.86270068717, 27530.002680140067], "value": 18080.445718814553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.75695554844924, 396.1067792128751, 401.4059192395254, 403.9697022723296, 417.8140727376317, 13401.530946416866, 15362.692746145085, 18801.341953031646, 19123.0, 19450.90274548625, 18809.0, 19022.714659280122, 19458.1243844027, 19679.949607810777, 19685.606287874234, 4620.53794620537, 5419.674819510832, 5680.034394152984, 5682.232898558704, 5683.573731970098, 4118.6499147572495, 4328.913421731563, 5541.085720856074, 5607.158926161068, 5983.551233657493, 6233.875322493547, 6338.84152896179, 6347.492200623962, 6348.492120630362, 6352.491800655959, 6130.1111338855835, 6179.412955769218, 6205.007198848185, 6205.968970155121, 6211.09939058834, 5335.733213339357, 5505.834824955257, 5521.116621340607, 5535.58483113768, 5540.196671482612, 22934.19730309431, 22935.885320573456, 23040.926316631416, 23363.415914602272, 23366.0, 2413.2036427978724, 2599.051346258621, 2641.564141916601, 2666.213467027212, 3083.367909578531, 14132.22272774997, 14377.78433323501, 14435.133891966516, 14440.26716793981, 15095.24523773818, 1804.4225847728733, 1918.4340619517277, 1945.8540609454349, 1954.5993071420326, 1992.6512860249543, 82187.5890620543, 82318.0, 82361.58819205925, 82810.17189828085, 84064.57967710122, 10333.948330258301, 10573.577056917791, 10577.524011419504, 10962.780744385227, 11032.117430605533, 15084.773728394082, 15085.849141508665, 15100.622484437978, 15105.54683359501, 15113.697726045637, 7144.3570078693165, 7203.315685009916, 7210.495265331481, 7333.0, 7494.175640679521, 6490.513211509156, 6639.0, 6739.359760822714, 6765.05289259504, 6929.618870962146, 6336.085400715722, 6410.775622853178, 6527.765533319556, 6608.537402381787, 6669.599824010575, 1677.753546886778, 1809.185866360117, 1812.7927724227486, 1874.0884298015947, 1980.2475059477306, 880.2825697056878, 946.6071580294101, 955.0831202045974, 1001.529281237817, 1009.4801177393648, 18132.925469967446, 19750.40748777539, 19767.0, 19984.0, 20062.09720562578, 933.5192375926404, 967.6322997260996, 967.883853937532, 1020.1940467031111, 1021.9080282774437, 8860.601272942733, 10829.512671929782, 11168.0, 11183.0, 11201.551937922555, 412126.0, 414118.0, 414234.0, 426011.0, 437902.0, 79486.60256698795, 79573.60213199013, 80132.59933700411, 80795.59602201951, 82139.0, 961.778790878102, 971.815355082532, 974.4396971741277, 983.695054533097, 992.1517102876936, 15971.920140399223, 16590.917045414695, 17141.22864471077, 18620.348287810404, 18650.0, 42237.36643950282, 42920.35619465648, 42960.570394296905, 43583.56416435795, 43666.34500482432, 57110.0, 58173.0, 58223.0, 58790.711625466225, 59797.70101149466, 8003.759887203393, 8316.916830831615, 8336.916630833857, 8358.0, 8606.44058136219, 8685.044645088909, 11760.176787624785, 13058.869411306145, 13129.868701312864, 13154.80267796003, 5208.73956302191, 5410.648307859977, 11159.609413670483, 11176.552937882394, 11411.885881141414, 11137.498812553617, 11159.051480624237, 11273.267237629529, 11443.485043173243, 11574.421278935852, 11109.333439993627, 11355.716107097389, 11523.308601483937, 11701.531938722695, 12080.0, 7815.25755053269, 7951.681932722627, 7980.521168729895, 8244.670213191404, 8576.356773241907, 8039.799005024687, 8194.67221311141, 8278.675411934062, 10367.481625918523, 11610.303381797119], "value": 9040.433444432909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.2859298943517, 1475.1886462445652, 1585.1677869118712, 1670.7827982362292, 1756.7891852977646, 7750.069991601009, 8225.917740822604, 8237.83524329513, 8268.462549934258, 8277.006759188891, 6981.581105133696, 7243.203247642755, 7267.164276108249, 7318.048653675028, 8139.755807325775, 2038.714579958807, 2203.0526873444414, 2272.943176420586, 2282.0985710644286, 2302.527981763743, 2320.8143348532076, 2330.021391015777, 2334.311378143443, 2338.4037070546988, 2348.6124789409814, 2268.6823844661676, 2331.1491305673394, 2348.189874493297, 2351.271105957159, 2354.1878052072007, 2235.396442960408, 2235.7987781099696, 2272.2842304673973, 2273.7726227377298, 2273.9658905116435, 2221.8777967211795, 2234.229190929127, 2236.519148383089, 2238.8992495337748, 2265.1732117777055, 8145.674173033071, 8202.876956845652, 8234.094249632535, 8249.670013199464, 8259.339252859756, 4798.328234047236, 4922.335484709554, 4936.0, 4939.3084968104495, 4965.379327584052, 3076.292452735861, 3114.5016797312323, 3159.8262095584732, 3202.1834432219866, 3282.7373810095373, 1095.5179720922768, 1126.774645070989, 1173.5481839491856, 1201.525397468004, 1225.2587184753186, 10763.0, 10793.08258798003, 10825.83761243582, 10829.783404331947, 11161.944190279079, 4299.0, 4585.70192937458, 4611.7232966021475, 4654.511276316006, 4674.0651869625535, 9641.710748677551, 9649.710508684751, 9660.275479339078, 9664.130228279488, 9666.468344241135, 5027.572656324181, 5027.597792176617, 5030.773615187325, 5033.968036552498, 5038.571721403649, 4469.597736203757, 4515.525869783691, 4527.9547204527535, 4587.678862479661, 4592.425946756655, 3521.2429327694667, 3635.4001589737927, 3637.308911306843, 3678.8712395066045, 3684.778913265213, 1229.3484453239798, 1249.5501619417003, 1272.6118533847266, 1285.1132718424258, 1296.7600993816175, 747.8242612985944, 853.1340689200466, 859.1966511311944, 859.3941271403645, 860.5611138319503, 4972.925406118911, 5116.309298244763, 5231.215317702375, 5251.36983561975, 5484.725763711878, 956.6173530587681, 963.4363897120263, 981.3670182732097, 1002.2182697495965, 1058.4707646176912, 3263.8041717496553, 3285.375778602058, 3348.6986171244703, 3360.7479439042168, 3418.5214070030215, 9870.506474676238, 10155.898441015643, 10234.0, 10247.436390998566, 10255.743606409751, 10169.440680762482, 10185.08334249921, 10195.592176312864, 10198.847017294747, 10240.129588984872, 7654.923450765533, 7835.098963619257, 7844.294013538809, 7848.529088254723, 7853.175416581176, 4769.403824521934, 4770.332153498583, 4885.413750349839, 4888.633352498506, 5070.163423035158, 9034.954825225832, 9241.0, 9328.067193280618, 9431.339806213498, 9458.763530911783, 9380.530973451436, 9431.0, 9514.096160864707, 9542.332036757638, 9575.760605984906, 7374.0, 7448.106227252548, 7496.812579685551, 7500.587467689329, 7570.697172113274, 6770.526063175727, 7589.316961473494, 7616.7334143304715, 7656.310932015923, 7659.655315510704, 6705.329467053256, 7014.0531028310525, 7067.787966361017, 7071.43428525727, 7307.7807665770115, 7163.3552980232025, 7192.352688258082, 7227.168875579376, 7268.636568171464, 7364.153122390993, 6466.612003279818, 6531.412172904462, 6543.967280163569, 6566.11357466755, 6597.736090556324, 4486.439195100613, 4559.202139625619, 4667.8599642010795, 4681.789319480564, 4699.600533954515, 4478.888027799331, 4583.564561366665, 4632.189366860854, 4687.48437671849, 4792.760361981817], "value": 4338.216754559652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.41246127906527, 340.06821309611666, 346.2590057277426, 348.61303952612593, 352.65439868928433, 5198.220266959948, 5257.211418287249, 5283.8150664726745, 5344.385395679493, 5352.892942141155, 5052.469490703478, 5179.378474583055, 5192.273081768555, 5203.791848326063, 5252.238425428311, 4155.542890282067, 4164.9583504164875, 4166.791660416982, 4177.248095342845, 4193.182329445759, 3929.332013557688, 4096.87709368718, 4203.180379825935, 4212.53662097169, 4231.344141658033, 4090.979545102285, 4095.610916962884, 4100.692448066392, 4105.404716316132, 4134.855280065199, 4060.8984775380554, 4080.6123418275215, 4081.8775436736946, 4083.8979025524304, 4098.221337945781, 3487.9128021799406, 3621.700220360064, 3624.474451204587, 3626.691731202851, 3631.673149416565, 5129.948700513021, 5132.230165475171, 5138.794448222066, 5144.254083157958, 5157.638965272433, 4697.765111744433, 4705.764711764432, 4717.433907931036, 4729.62163026957, 4750.881227969294, 5353.250544923714, 5435.619506634537, 5484.314460692413, 5512.972435137839, 5529.557635389199, 3971.6425521703186, 3988.3419235826054, 3990.186918222646, 3993.1813978134705, 3997.520297564282, 5674.971625141848, 5739.426057394269, 5744.310682718059, 5748.195252664588, 5774.249347584787, 3981.7610943343493, 4027.5166979962005, 4070.9389359159636, 4109.321961876257, 4134.111166099303, 4095.85664501747, 4097.672186225095, 4102.830693252408, 4133.276676581646, 4142.357934520154, 4666.929996050062, 4676.205045142334, 4679.836205732783, 4684.812607495662, 4708.9058218835435, 5334.3058108864725, 5456.372517160498, 5497.615166938356, 5509.228707980886, 5515.889682206333, 1313.5550894016505, 1335.2789493673308, 1340.9597712068653, 1375.91302870731, 1378.1937566523695, 937.2033771294346, 953.7853982853941, 961.2310151878469, 968.1335204991493, 972.9006222968001, 5016.974915125401, 5043.344365232496, 5061.822836200715, 5067.5185857343495, 5082.74586270685, 5316.76074576645, 5340.626156169109, 5370.409254981949, 5411.56707463402, 5422.213779002102, 4849.975750121227, 5041.663959050855, 5102.260172275, 5105.387353517602, 5149.897002059938, 2882.337062475642, 2889.3065664240853, 2890.5519644455144, 2894.3632400871775, 2905.4915389806697, 5574.442555744393, 5574.58190635704, 5581.413951535112, 5609.411011843779, 5610.887782244414, 5135.177012160704, 5388.622796404293, 5412.431694672082, 5448.42791506894, 5448.564114870801, 5487.670739755627, 5502.807401741, 5519.613627046148, 5537.031019571559, 5567.805126820542, 5330.78676852937, 5359.7136687194015, 5376.623636345575, 5392.7573259202645, 5422.267993820941, 5285.656432331886, 5580.888382232414, 5594.776208951596, 5605.5515558756015, 5610.663360198401, 5777.162311464898, 5803.593748437569, 5815.836832633575, 5821.94178058214, 5830.82507524775, 3977.080556273962, 3978.1844721832535, 3984.641382275609, 4003.5796241394232, 4017.879463616096, 5339.504938617193, 5619.409961953936, 5625.88748225025, 5641.887162256814, 5663.943360566342, 5343.4122246553625, 5356.518263128842, 5508.338999320107, 5513.649155956817, 5538.086215774352, 5496.862578435571, 5517.806876759294, 5522.609525427375, 5541.806036788693, 5559.52744016747, 5259.789608415774, 5445.7821687133655, 5448.0, 5454.0, 5488.231647569423, 5533.727242734113, 5551.750171242223, 5553.972230138824, 5559.9444005561045, 5566.165075238585, 5450.509454148987, 5460.481254280837, 5482.342118945592, 5490.725463726718, 5496.8076117337305], "value": 4167.302218454318, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.7830698409048, 717.3938022371096, 720.7369310201778, 735.2904447208443, 771.5872008475465, 14159.646008849784, 14920.925395373008, 14966.251687415614, 15057.774133387995, 15060.171690557016, 14457.710845783078, 14584.927075364634, 14605.926970365133, 14606.780898286534, 14623.0, 658.4633523678211, 680.0852852912824, 773.7562667759638, 787.8069872881152, 789.4434423731255, 763.5304287862953, 782.5774081995716, 786.5123623353529, 788.8540619985321, 789.0964845252183, 831.5177197225624, 834.0700119366923, 834.1033389106734, 834.407570624857, 834.7412302186311, 702.4977141343963, 824.5258976088772, 826.7767702720262, 827.8634025385834, 828.6643909216747, 529.3489008519504, 583.8160979291509, 597.6951754605183, 598.7395482964924, 599.442518457834, 13024.674383140402, 13031.674208144872, 13057.347132643425, 13069.0, 13072.803907941388, 12871.292078935654, 13011.804822927663, 13198.406071726698, 13289.734205315839, 13376.799348009788, 11668.299902005907, 11770.529178832836, 11822.349770762605, 11833.763324733458, 11910.58312959051, 4112.37785016287, 4161.313383291753, 4229.70392072555, 4282.122164956177, 4411.1618792429335, 58462.70768646172, 58660.12009819856, 59119.70440147815, 59226.0, 60735.69632151811, 10654.307470014579, 10713.78572428547, 10735.409552474688, 10869.0, 10930.508127134299, 19387.515312117026, 19558.80441195598, 19580.70628940567, 19582.5104372389, 19934.0, 7433.479656423999, 7453.105627324756, 7588.165301816795, 7593.5823529706395, 7790.532568045822, 3887.494625698641, 4009.4587230723478, 4113.056633165048, 4120.361343991686, 4129.566395528486, 3111.642161151451, 3178.618565772122, 3178.98410507946, 3185.9681403185673, 3194.8402579870913, 535.568867062011, 537.9246905433242, 539.7652021370716, 546.3471151973354, 546.3553007451167, 591.5060924128401, 596.931352894414, 646.5668002438377, 667.9866402671919, 676.631235976394, 7839.960800195962, 8480.279176269964, 8516.616752246164, 8571.0, 8594.957025214959, 592.2774215457135, 613.9324674285825, 637.8022812928007, 661.2626920983165, 679.2392520377209, 4020.3567429211184, 4101.507819061731, 4115.71190016702, 4134.896627584334, 4195.517515485697, 86078.34825324814, 88888.5555572218, 89027.10972890317, 92440.53779731058, 93084.53457732667, 76281.0, 76470.0, 78401.0, 78772.24297149573, 79508.60245698734, 45005.774971124934, 45698.77150614226, 66261.33738662647, 66503.66748166324, 66812.0, 7916.920830791619, 8054.31538319226, 8150.75547733569, 8245.711400100967, 8246.711365102192, 37199.628003720696, 39562.0, 48232.276515852995, 48570.75714621404, 51262.231066534776, 39155.41266881056, 54099.459005411016, 56136.0, 56532.325398848945, 59039.70480147572, 11787.292762433939, 11955.581554645545, 12224.327661978676, 12275.0, 12642.431090600761, 12934.353282336035, 13280.53518126861, 13807.585772426843, 14063.156210627396, 14194.322271091232, 11981.580644677395, 12133.514659413524, 12658.177218480769, 12806.67983300425, 12929.418176182282, 11612.535498579962, 11814.232074915102, 11847.822282665595, 11930.0, 11952.58165964187, 12083.381227729149, 12316.199447035913, 12587.118901676795, 12611.747765044463, 12657.87342126567, 9857.489886620318, 10240.897591023995, 10241.436720980417, 10952.397618131079, 11024.0, 9811.607535698493, 10350.275480716278, 10393.53229104677, 10477.266591338534, 10688.679339619825], "value": 6752.186538976681, "unit": "score"}], "name": "dromaeo_css", "value": 6879.529317228404, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 113.0, 113.0, 115.0, 114.0, 112.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 125.0, 168.0, 123.0, 127.0, 126.0, 122.0, 163.0, 122.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 160.0, 162.0, 161.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 106.0, 76.0, 75.0, 77.0, 75.0, 102.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 122.0, 81.0, 81.0, 83.0, 100.0, 82.0, 82.0, 118.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 51.0, 51.0, 57.0, 53.0, 52.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 88.0, 79.0, 80.0, 81.0, 86.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 128.0, 142.0, 138.0, 133.0, 139.0, 134.0, 194.0, 127.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 166.0, 169.0, 167.0, 169.0, 168.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 64.0, 64.0, 64.0, 71.0, 65.0, 63.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1496.6000000000001, "alertThreshold": 2.0}]} 06:14:37 INFO - Return code: 0 06:14:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:37 INFO - # TBPL SUCCESS # 06:14:37 INFO - Running post-action listener: _resource_record_post_action 06:14:37 INFO - [mozharness: 2016-11-14 14:14:37.460208Z] Finished run-tests step (success) 06:14:37 INFO - Running post-run listener: _resource_record_post_run 06:14:37 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391671808; Read time: 16; Write time: 224200 06:14:37 INFO - TinderboxPrint: CPU usage
13.1% 06:14:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:14:37 INFO - TinderboxPrint: I/O write bytes / time
391,671,808 / 224,200 06:14:37 INFO - TinderboxPrint: CPU idle
8,305.8 (86.9%) 06:14:37 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 06:14:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:14:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103784448; Read time: 0; Write time: 40648 06:14:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287887360; Read time: 0; Write time: 183552 06:14:38 INFO - Running post-run listener: _upload_blobber_files 06:14:38 INFO - Blob upload gear active. 06:14:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:38 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 06:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:42 INFO - (blobuploader) - INFO - Done attempting. 06:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:42 INFO - (blobuploader) - INFO - Done attempting. 06:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:43 INFO - (blobuploader) - INFO - Done attempting. 06:14:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:43 INFO - Return code: 0 06:14:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d2d5ec19b2e5c0418925eb370bcd593fe174a325141963cb6b5963f077c6fa64a9b9abc687a00e720abb1ba4b7a1076c351b88c344015fca6a15e2c50ea425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2eb042c73903f611b0621066649f54f8a935bb7f0d051e4cc301c56d1d33bffba0aa068a9cb47c12d7045c070b00cbd53af7f7408bf5a65880f987bfa58c12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b68e158c3ced489a3a228992359855e042aa4bb9c2ff22e854b222bceda4e3a31104b35eef3ba5f9b7f380bdd53c8c0c0064b548f9b0c4506a7327e154cd1dbc"} 06:14:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:43 INFO - Contents: 06:14:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d2d5ec19b2e5c0418925eb370bcd593fe174a325141963cb6b5963f077c6fa64a9b9abc687a00e720abb1ba4b7a1076c351b88c344015fca6a15e2c50ea425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2eb042c73903f611b0621066649f54f8a935bb7f0d051e4cc301c56d1d33bffba0aa068a9cb47c12d7045c070b00cbd53af7f7408bf5a65880f987bfa58c12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b68e158c3ced489a3a228992359855e042aa4bb9c2ff22e854b222bceda4e3a31104b35eef3ba5f9b7f380bdd53c8c0c0064b548f9b0c4506a7327e154cd1dbc"} 06:14:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:43 INFO - Copying logs to upload dir... 06:14:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.675893 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-14 06:14:43.728579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 06:14:43.736525) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d2d5ec19b2e5c0418925eb370bcd593fe174a325141963cb6b5963f077c6fa64a9b9abc687a00e720abb1ba4b7a1076c351b88c344015fca6a15e2c50ea425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2eb042c73903f611b0621066649f54f8a935bb7f0d051e4cc301c56d1d33bffba0aa068a9cb47c12d7045c070b00cbd53af7f7408bf5a65880f987bfa58c12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b68e158c3ced489a3a228992359855e042aa4bb9c2ff22e854b222bceda4e3a31104b35eef3ba5f9b7f380bdd53c8c0c0064b548f9b0c4506a7327e154cd1dbc"} build_url:https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010070 build_url: 'https://queue.taskcluster.net/v1/task/VwjmAnh0Rw2TUdXbD4gOyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d2d5ec19b2e5c0418925eb370bcd593fe174a325141963cb6b5963f077c6fa64a9b9abc687a00e720abb1ba4b7a1076c351b88c344015fca6a15e2c50ea425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2eb042c73903f611b0621066649f54f8a935bb7f0d051e4cc301c56d1d33bffba0aa068a9cb47c12d7045c070b00cbd53af7f7408bf5a65880f987bfa58c12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b68e158c3ced489a3a228992359855e042aa4bb9c2ff22e854b222bceda4e3a31104b35eef3ba5f9b7f380bdd53c8c0c0064b548f9b0c4506a7327e154cd1dbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 06:14:43.765021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:14:43.765397) ========= 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=20e666a3d4cfbb71505a330e000001b4-1479131590.807130-916115150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:14:43.815554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 06:14:43.815982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 06:14:43.816400) ========= ========= Total master_lag: 0.91 =========