builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1486765725.73 results: success (0) buildid: 20170210123454 builduid: 0a897735900642c38424569f77ecdfd7 revision: 4603dc332d7f1a384c5f4b39192e992f596a4c5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.725308) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.725724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.725998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.745647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.745954) ========= 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=52faae308a556c440401f8e5000001e8-1486764764.395598-424435108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-10 14:28:46-- 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% 40.7M=0s 2017-02-10 14:28:46 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120989 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.879999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.880308) ========= 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=52faae308a556c440401f8e5000001e8-1486764764.395598-424435108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020688 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.932338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:45.935729) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4603dc332d7f1a384c5f4b39192e992f596a4c5b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4603dc332d7f1a384c5f4b39192e992f596a4c5b --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=52faae308a556c440401f8e5000001e8-1486764764.395598-424435108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-10 14:28:46,330 truncating revision to first 12 chars 2017-02-10 14:28:46,331 Setting DEBUG logging. 2017-02-10 14:28:46,331 attempt 1/10 2017-02-10 14:28:46,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4603dc332d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 14:28:46,660 unpacking tar archive at: mozilla-beta-4603dc332d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:46.566819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:46.567125) ========= script_repo_revision: 4603dc332d7f1a384c5f4b39192e992f596a4c5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:46.567519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:46.567800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:28:46.575412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-10 14:28:46.575710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=52faae308a556c440401f8e5000001e8-1486764764.395598-424435108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:28:47 INFO - MultiFileLogger online at 20170210 14:28:47 in /builds/slave/test 14:28:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:28:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:28:47 INFO - {'append_to_log': False, 14:28:47 INFO - 'base_work_dir': '/builds/slave/test', 14:28:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:28:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:28:47 INFO - 'branch': 'Mozilla-Beta', 14:28:47 INFO - 'buildbot_json_path': 'buildprops.json', 14:28:47 INFO - 'config_files': ('talos/linux_config.py',), 14:28:47 INFO - 'default_actions': ('clobber', 14:28:47 INFO - 'read-buildbot-config', 14:28:47 INFO - 'download-and-extract', 14:28:47 INFO - 'populate-webroot', 14:28:47 INFO - 'create-virtualenv', 14:28:47 INFO - 'install', 14:28:47 INFO - 'run-tests'), 14:28:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:28:47 INFO - 'download_minidump_stackwalk': True, 14:28:47 INFO - 'download_symbols': 'ondemand', 14:28:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:28:47 INFO - 'tooltool.py': '/tools/tooltool.py', 14:28:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:28:47 INFO - '/tools/misc-python/virtualenv.py')}, 14:28:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:28:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:28:47 INFO - 'installer_path': 'installer.exe', 14:28:47 INFO - 'log_level': 'info', 14:28:47 INFO - 'log_name': 'talos', 14:28:47 INFO - 'log_to_console': True, 14:28:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:28:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:28:47 INFO - 'opt_config_files': (), 14:28:47 INFO - 'pip_index': False, 14:28:47 INFO - 'sps_profile': False, 14:28:47 INFO - 'sps_profile_interval': 0, 14:28:47 INFO - 'suite': 'dromaeojs', 14:28:47 INFO - 'system_bits': '32', 14:28:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:28:47 INFO - 'title': 'talos-linux64-ix-056', 14:28:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:28:47 INFO - 'use_talos_json': True, 14:28:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:28:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:28:47 INFO - 'work_dir': 'build'} 14:28:47 INFO - [mozharness: 2017-02-10 22:28:47.067510Z] Running clobber step. 14:28:47 INFO - Running pre-action listener: _resource_record_pre_action 14:28:47 INFO - Running main action method: clobber 14:28:47 INFO - rmtree: /builds/slave/test/build 14:28:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:28:48 INFO - Running post-action listener: _resource_record_post_action 14:28:48 INFO - [mozharness: 2017-02-10 22:28:48.062933Z] Finished clobber step (success) 14:28:48 INFO - [mozharness: 2017-02-10 22:28:48.063032Z] Running read-buildbot-config step. 14:28:48 INFO - Running pre-action listener: _resource_record_pre_action 14:28:48 INFO - Running main action method: read_buildbot_config 14:28:48 INFO - Using buildbot properties: 14:28:48 INFO - { 14:28:48 INFO - "project": "", 14:28:48 INFO - "product": "firefox", 14:28:48 INFO - "script_repo_revision": "production", 14:28:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:28:48 INFO - "repository": "", 14:28:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:28:48 INFO - "buildid": "20170210123454", 14:28:48 INFO - "pgo_build": "True", 14:28:48 INFO - "basedir": "/builds/slave/test", 14:28:48 INFO - "buildnumber": 553, 14:28:48 INFO - "slavename": "talos-linux64-ix-056", 14:28:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:28:48 INFO - "platform": "ubuntu64_hw", 14:28:48 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:28:48 INFO - "branch": "mozilla-beta", 14:28:48 INFO - "repo_path": "releases/mozilla-beta", 14:28:48 INFO - "revision": "4603dc332d7f1a384c5f4b39192e992f596a4c5b", 14:28:48 INFO - "stage_platform": "linux64-pgo", 14:28:48 INFO - "builduid": "0a897735900642c38424569f77ecdfd7", 14:28:48 INFO - "slavebuilddir": "test" 14:28:48 INFO - } 14:28:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 14:28:48 INFO - Running post-action listener: _resource_record_post_action 14:28:48 INFO - [mozharness: 2017-02-10 22:28:48.065463Z] Finished read-buildbot-config step (success) 14:28:48 INFO - [mozharness: 2017-02-10 22:28:48.065551Z] Running download-and-extract step. 14:28:48 INFO - Running pre-action listener: _resource_record_pre_action 14:28:48 INFO - Running main action method: download_and_extract 14:28:48 INFO - mkdir: /builds/slave/test/build/tests 14:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:48 INFO - trying https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:28:48 INFO - Downloading https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:28:48 INFO - Downloaded 1327 bytes. 14:28:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:28:48 INFO - Using the following test package requirements: 14:28:48 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:28:48 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:28:48 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 14:28:48 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'jsshell-linux-x86_64.zip'], 14:28:48 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:28:48 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:28:48 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 14:28:48 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 14:28:48 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:28:48 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:28:48 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:28:48 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:28:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:28:49 INFO - Http code: 200 14:28:49 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 14:28:49 INFO - x-amz-cf-id: inEo8j1z5XUgsKcFPZ0Xq09inq9Ac8R0qvC0gof1slYMDil3Ypo4ww== 14:28:49 INFO - x-amz-version-id: tSJTV2PXXmksvonNbPG78vGAu2gK381g 14:28:49 INFO - Expected file size: 21958928 14:28:49 INFO - Obtained file size: 21958928 14:28:53 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:28:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:28:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:53 INFO - Fetch https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:28:54 INFO - Http code: 200 14:28:54 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 14:28:54 INFO - x-amz-cf-id: U7s8n22Z6PueBB6Wcs0QJUfJVJaT4oAIFPnb0ogDQKUtHXYyyaX3Lg== 14:28:54 INFO - x-amz-version-id: tSJTV2PXXmksvonNbPG78vGAu2gK381g 14:28:54 INFO - Expected file size: 21958928 14:28:54 INFO - Obtained file size: 21958928 14:28:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 14:28:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:28:58 INFO - Fetch https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 14:28:59 INFO - Http code: 200 14:28:59 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 14:28:59 INFO - x-amz-cf-id: zmsMXQhgKjwzdJ5YfEGsIGjEQJ5TtxjKm1mcvVLOd1ebDzVwPPKLHA== 14:28:59 INFO - x-amz-version-id: FsGp4lbC1VLw2740kIuiSJQMcc6Roevg 14:28:59 INFO - Expected file size: 14403005 14:28:59 INFO - Obtained file size: 14403005 14:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:59 INFO - trying https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:28:59 INFO - Downloading https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:29:00 INFO - Downloaded 57708344 bytes. 14:29:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:29:00 INFO - mkdir: /builds/slave/test/properties 14:29:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:29:00 INFO - Writing to file /builds/slave/test/properties/build_url 14:29:00 INFO - Contents: 14:29:00 INFO - build_url:https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:29:01 INFO - Running post-action listener: _resource_record_post_action 14:29:01 INFO - Running post-action listener: set_extra_try_arguments 14:29:01 INFO - [mozharness: 2017-02-10 22:29:01.656591Z] Finished download-and-extract step (success) 14:29:01 INFO - [mozharness: 2017-02-10 22:29:01.656820Z] Running populate-webroot step. 14:29:01 INFO - Running pre-action listener: _resource_record_pre_action 14:29:01 INFO - Running main action method: populate_webroot 14:29:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:29:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:29:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:29:01 INFO - '--tppagecycles', 14:29:01 INFO - '7'], 14:29:01 INFO - 'tests': ['tsvgm']}}, 14:29:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:29:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:29:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:29:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:29:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['damp', 'tps']}, 14:29:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'tests': ['damp', 'tps']}, 14:29:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['dromaeo_dom']}, 14:29:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:29:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['basic_compositor_video']}, 14:29:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:29:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['a11yr', 14:29:01 INFO - 'ts_paint', 14:29:01 INFO - 'tpaint', 14:29:01 INFO - 'sessionrestore', 14:29:01 INFO - 'sessionrestore_no_auto_restore', 14:29:01 INFO - 'tabpaint']}, 14:29:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:29:01 INFO - 'ts_paint', 14:29:01 INFO - 'tpaint', 14:29:01 INFO - 'sessionrestore', 14:29:01 INFO - 'sessionrestore_no_auto_restore', 14:29:01 INFO - 'tabpaint']}, 14:29:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:29:01 INFO - 'ts_paint', 14:29:01 INFO - 'tpaint', 14:29:01 INFO - 'sessionrestore', 14:29:01 INFO - 'sessionrestore_no_auto_restore', 14:29:01 INFO - 'tabpaint']}, 14:29:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:29:01 INFO - 'ts_paint', 14:29:01 INFO - 'tpaint', 14:29:01 INFO - 'sessionrestore', 14:29:01 INFO - 'sessionrestore_no_auto_restore', 14:29:01 INFO - 'tabpaint']}, 14:29:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['a11yr', 14:29:01 INFO - 'ts_paint', 14:29:01 INFO - 'tpaint', 14:29:01 INFO - 'sessionrestore', 14:29:01 INFO - 'sessionrestore_no_auto_restore', 14:29:01 INFO - 'tabpaint']}, 14:29:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['a11yr', 14:29:01 INFO - 'ts_paint', 14:29:01 INFO - 'tpaint', 14:29:01 INFO - 'sessionrestore', 14:29:01 INFO - 'sessionrestore_no_auto_restore', 14:29:01 INFO - 'tabpaint']}, 14:29:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['tsvgx', 14:29:01 INFO - 'tsvgr_opacity', 14:29:01 INFO - 'tart', 14:29:01 INFO - 'tscrollx', 14:29:01 INFO - 'cart']}, 14:29:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:29:01 INFO - 'tsvgr_opacity', 14:29:01 INFO - 'tart', 14:29:01 INFO - 'tscrollx', 14:29:01 INFO - 'cart']}, 14:29:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'talos_options': ['--disable-e10s'], 14:29:01 INFO - 'tests': ['tp5o']}, 14:29:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'tests': ['tp5o']}, 14:29:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'talos_options': ['--disable-e10s', 14:29:01 INFO - '--xperf_path', 14:29:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:01 INFO - 'tests': ['tp5n']}, 14:29:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:01 INFO - 'talos_options': ['--xperf_path', 14:29:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:01 INFO - 'tests': ['tp5n']}}, 14:29:01 INFO - 'talos.zip': {'path': '', 14:29:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:29:01 INFO - Running post-action listener: _resource_record_post_action 14:29:01 INFO - [mozharness: 2017-02-10 22:29:01.676199Z] Finished populate-webroot step (success) 14:29:01 INFO - [mozharness: 2017-02-10 22:29:01.676287Z] Running create-virtualenv step. 14:29:01 INFO - Running pre-action listener: _resource_record_pre_action 14:29:01 INFO - Running main action method: create_virtualenv 14:29:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:29:01 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 14:29:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:29:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:29:01 INFO - Using real prefix '/usr' 14:29:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:29:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:29:04 INFO - Installing pip.................done. 14:29:04 INFO - Return code: 0 14:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:29:04 INFO - Reading from file tmpfile_stdout 14:29:04 INFO - Output received: 14:29:04 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) 14:29:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:29:04 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')]} 14:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:04 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')]} 14:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:04 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:04 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 14:29:04 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 14:29:04 INFO - Using env: {'DISPLAY': ':0', 14:29:04 INFO - 'HOME': '/home/cltbld', 14:29:04 INFO - 'LANG': 'en_US.UTF-8', 14:29:04 INFO - 'LANGUAGE': 'en_US:en', 14:29:04 INFO - 'LOGNAME': 'cltbld', 14:29:04 INFO - 'MAIL': '/var/mail/cltbld', 14:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:04 INFO - 'MOZ_NO_REMOTE': '1', 14:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:04 INFO - 'NO_EM_RESTART': '1', 14:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:04 INFO - 'PWD': '/builds/slave/test', 14:29:04 INFO - 'SHELL': '/bin/bash', 14:29:04 INFO - 'SHLVL': '1', 14:29:04 INFO - 'TERM': 'linux', 14:29:04 INFO - 'TMOUT': '86400', 14:29:04 INFO - 'USER': 'cltbld', 14:29:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:04 INFO - '_': '/tools/buildbot/bin/python'} 14:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:04 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 14:29:04 INFO - Cleaning up... 14:29:04 INFO - Return code: 0 14:29:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:29:04 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')]} 14:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:04 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')]} 14:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:04 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:04 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 14:29:04 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 14:29:04 INFO - Using env: {'DISPLAY': ':0', 14:29:04 INFO - 'HOME': '/home/cltbld', 14:29:04 INFO - 'LANG': 'en_US.UTF-8', 14:29:04 INFO - 'LANGUAGE': 'en_US:en', 14:29:04 INFO - 'LOGNAME': 'cltbld', 14:29:04 INFO - 'MAIL': '/var/mail/cltbld', 14:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:04 INFO - 'MOZ_NO_REMOTE': '1', 14:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:04 INFO - 'NO_EM_RESTART': '1', 14:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:04 INFO - 'PWD': '/builds/slave/test', 14:29:04 INFO - 'SHELL': '/bin/bash', 14:29:04 INFO - 'SHLVL': '1', 14:29:04 INFO - 'TERM': 'linux', 14:29:04 INFO - 'TMOUT': '86400', 14:29:04 INFO - 'USER': 'cltbld', 14:29:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:04 INFO - '_': '/tools/buildbot/bin/python'} 14:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:04 INFO - Downloading/unpacking psutil>=3.1.1 14:29:04 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 14:29:04 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 14:29:04 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 14:29:04 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 14:29:04 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 14:29:04 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 14:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:29:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:29:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:29:07 INFO - Installing collected packages: psutil 14:29:07 INFO - Running setup.py install for psutil 14:29:07 INFO - building 'psutil._psutil_linux' extension 14:29:07 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 14:29:07 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 14:29:07 INFO - building 'psutil._psutil_posix' extension 14:29:07 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 14:29:07 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 14:29:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:29:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:29:07 INFO - Successfully installed psutil 14:29:07 INFO - Cleaning up... 14:29:07 INFO - Return code: 0 14:29:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:29:07 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')]} 14:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:07 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')]} 14:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:07 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:07 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 14:29:07 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 14:29:07 INFO - Using env: {'DISPLAY': ':0', 14:29:07 INFO - 'HOME': '/home/cltbld', 14:29:07 INFO - 'LANG': 'en_US.UTF-8', 14:29:07 INFO - 'LANGUAGE': 'en_US:en', 14:29:07 INFO - 'LOGNAME': 'cltbld', 14:29:07 INFO - 'MAIL': '/var/mail/cltbld', 14:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:07 INFO - 'MOZ_NO_REMOTE': '1', 14:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:07 INFO - 'NO_EM_RESTART': '1', 14:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:07 INFO - 'PWD': '/builds/slave/test', 14:29:07 INFO - 'SHELL': '/bin/bash', 14:29:07 INFO - 'SHLVL': '1', 14:29:07 INFO - 'TERM': 'linux', 14:29:07 INFO - 'TMOUT': '86400', 14:29:07 INFO - 'USER': 'cltbld', 14:29:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:07 INFO - '_': '/tools/buildbot/bin/python'} 14:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:29:07 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 14:29:07 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 14:29:07 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 14:29:07 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 14:29:07 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 14:29:07 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 14:29:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:29:09 INFO - Installing collected packages: mozsystemmonitor 14:29:09 INFO - Running setup.py install for mozsystemmonitor 14:29:10 INFO - Successfully installed mozsystemmonitor 14:29:10 INFO - Cleaning up... 14:29:10 INFO - Return code: 0 14:29:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:29:10 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')]} 14:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:10 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')]} 14:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:10 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:10 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 14:29:10 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 14:29:10 INFO - Using env: {'DISPLAY': ':0', 14:29:10 INFO - 'HOME': '/home/cltbld', 14:29:10 INFO - 'LANG': 'en_US.UTF-8', 14:29:10 INFO - 'LANGUAGE': 'en_US:en', 14:29:10 INFO - 'LOGNAME': 'cltbld', 14:29:10 INFO - 'MAIL': '/var/mail/cltbld', 14:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:10 INFO - 'MOZ_NO_REMOTE': '1', 14:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:10 INFO - 'NO_EM_RESTART': '1', 14:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:10 INFO - 'PWD': '/builds/slave/test', 14:29:10 INFO - 'SHELL': '/bin/bash', 14:29:10 INFO - 'SHLVL': '1', 14:29:10 INFO - 'TERM': 'linux', 14:29:10 INFO - 'TMOUT': '86400', 14:29:10 INFO - 'USER': 'cltbld', 14:29:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:10 INFO - '_': '/tools/buildbot/bin/python'} 14:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:29:10 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 14:29:10 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 14:29:10 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 14:29:10 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 14:29:10 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 14:29:10 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 14:29:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:29:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:29:12 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 14:29:12 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 14:29:12 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 14:29:12 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 14:29:12 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 14:29:12 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 14:29:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:29:12 INFO - warning: no files found matching '*.txt' 14:29:12 INFO - no previously-included directories found matching 'build' 14:29:12 INFO - no previously-included directories found matching 'dist' 14:29:12 INFO - no previously-included directories found matching '.git*' 14:29:12 INFO - Installing collected packages: jsonschema, functools32 14:29:12 INFO - Running setup.py install for functools32 14:29:12 INFO - warning: no files found matching '*.txt' 14:29:12 INFO - no previously-included directories found matching 'build' 14:29:12 INFO - no previously-included directories found matching 'dist' 14:29:12 INFO - no previously-included directories found matching '.git*' 14:29:12 INFO - Successfully installed jsonschema functools32 14:29:12 INFO - Cleaning up... 14:29:12 INFO - Return code: 0 14:29:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:29:12 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')]} 14:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:12 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')]} 14:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:12 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:12 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 14:29:12 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 14:29:12 INFO - Using env: {'DISPLAY': ':0', 14:29:12 INFO - 'HOME': '/home/cltbld', 14:29:12 INFO - 'LANG': 'en_US.UTF-8', 14:29:12 INFO - 'LANGUAGE': 'en_US:en', 14:29:12 INFO - 'LOGNAME': 'cltbld', 14:29:12 INFO - 'MAIL': '/var/mail/cltbld', 14:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:12 INFO - 'MOZ_NO_REMOTE': '1', 14:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:12 INFO - 'NO_EM_RESTART': '1', 14:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:12 INFO - 'PWD': '/builds/slave/test', 14:29:12 INFO - 'SHELL': '/bin/bash', 14:29:12 INFO - 'SHLVL': '1', 14:29:12 INFO - 'TERM': 'linux', 14:29:12 INFO - 'TMOUT': '86400', 14:29:12 INFO - 'USER': 'cltbld', 14:29:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:12 INFO - '_': '/tools/buildbot/bin/python'} 14:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:29:13 INFO - Cleaning up... 14:29:13 INFO - Return code: 0 14:29:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:29:13 INFO - Using env: {'DISPLAY': ':0', 14:29:13 INFO - 'HOME': '/home/cltbld', 14:29:13 INFO - 'LANG': 'en_US.UTF-8', 14:29:13 INFO - 'LANGUAGE': 'en_US:en', 14:29:13 INFO - 'LOGNAME': 'cltbld', 14:29:13 INFO - 'MAIL': '/var/mail/cltbld', 14:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:13 INFO - 'MOZ_NO_REMOTE': '1', 14:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:13 INFO - 'NO_EM_RESTART': '1', 14:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:13 INFO - 'PWD': '/builds/slave/test', 14:29:13 INFO - 'SHELL': '/bin/bash', 14:29:13 INFO - 'SHLVL': '1', 14:29:13 INFO - 'TERM': 'linux', 14:29:13 INFO - 'TMOUT': '86400', 14:29:13 INFO - 'USER': 'cltbld', 14:29:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:13 INFO - '_': '/tools/buildbot/bin/python'} 14:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:29:13 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 14:29:13 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 14:29:13 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 14:29:13 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 14:29:13 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 14:29:13 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 14:29:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:29:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:29:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 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 14:29:15 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 14:29:16 INFO - Downloading docopt-0.6.1.tar.gz 14:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:29:16 INFO - Running setup.py install for blobuploader 14:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:29:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:29:16 INFO - Running setup.py install for requests 14:29:16 INFO - Running setup.py install for docopt 14:29:16 INFO - Successfully installed blobuploader requests docopt 14:29:16 INFO - Cleaning up... 14:29:16 INFO - Return code: 0 14:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:16 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:16 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 14:29:16 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 14:29:16 INFO - Using env: {'DISPLAY': ':0', 14:29:16 INFO - 'HOME': '/home/cltbld', 14:29:16 INFO - 'LANG': 'en_US.UTF-8', 14:29:16 INFO - 'LANGUAGE': 'en_US:en', 14:29:16 INFO - 'LOGNAME': 'cltbld', 14:29:16 INFO - 'MAIL': '/var/mail/cltbld', 14:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:16 INFO - 'MOZ_NO_REMOTE': '1', 14:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:16 INFO - 'NO_EM_RESTART': '1', 14:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:16 INFO - 'PWD': '/builds/slave/test', 14:29:16 INFO - 'SHELL': '/bin/bash', 14:29:16 INFO - 'SHLVL': '1', 14:29:16 INFO - 'TERM': 'linux', 14:29:16 INFO - 'TMOUT': '86400', 14:29:16 INFO - 'USER': 'cltbld', 14:29:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:16 INFO - '_': '/tools/buildbot/bin/python'} 14:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:29:16 INFO - Running setup.py (path:/tmp/pip-3wufFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:29:17 INFO - Running setup.py (path:/tmp/pip-wwb_v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:29:17 INFO - Running setup.py (path:/tmp/pip-nr76By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:29:17 INFO - Running setup.py (path:/tmp/pip-76vyWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:29:17 INFO - Running setup.py (path:/tmp/pip-MsZ8AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:29:17 INFO - Running setup.py (path:/tmp/pip-MBqgbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:29:17 INFO - Running setup.py (path:/tmp/pip-RAlsui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:29:17 INFO - Running setup.py (path:/tmp/pip-3EBMuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:29:17 INFO - Running setup.py (path:/tmp/pip-B7qosh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:29:17 INFO - Running setup.py (path:/tmp/pip-mxWTDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:29:17 INFO - Running setup.py (path:/tmp/pip-djOJhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:17 INFO - Running setup.py (path:/tmp/pip-9kevkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:17 INFO - Running setup.py (path:/tmp/pip-cqQca3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:17 INFO - Running setup.py (path:/tmp/pip-4p2zGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:17 INFO - Running setup.py (path:/tmp/pip-vE9nE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:18 INFO - Running setup.py (path:/tmp/pip-0LLD0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:18 INFO - Running setup.py (path:/tmp/pip-nR9Vv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:29:18 INFO - Running setup.py install for manifestparser 14:29:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Running setup.py install for mozcrash 14:29:18 INFO - Running setup.py install for mozdebug 14:29:18 INFO - Running setup.py install for mozdevice 14:29:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Running setup.py install for mozfile 14:29:18 INFO - Running setup.py install for mozhttpd 14:29:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Running setup.py install for mozinfo 14:29:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Running setup.py install for mozInstall 14:29:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:29:18 INFO - Running setup.py install for mozleak 14:29:19 INFO - Running setup.py install for mozlog 14:29:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Running setup.py install for moznetwork 14:29:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Running setup.py install for mozprocess 14:29:19 INFO - Running setup.py install for mozprofile 14:29:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Running setup.py install for mozrunner 14:29:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Running setup.py install for mozscreenshot 14:29:19 INFO - Running setup.py install for moztest 14:29:19 INFO - Running setup.py install for mozversion 14:29:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:29:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:29:19 INFO - Cleaning up... 14:29:19 INFO - Return code: 0 14:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:20 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:20 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 14:29:20 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 14:29:20 INFO - Using env: {'DISPLAY': ':0', 14:29:20 INFO - 'HOME': '/home/cltbld', 14:29:20 INFO - 'LANG': 'en_US.UTF-8', 14:29:20 INFO - 'LANGUAGE': 'en_US:en', 14:29:20 INFO - 'LOGNAME': 'cltbld', 14:29:20 INFO - 'MAIL': '/var/mail/cltbld', 14:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:20 INFO - 'MOZ_NO_REMOTE': '1', 14:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:20 INFO - 'NO_EM_RESTART': '1', 14:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:20 INFO - 'PWD': '/builds/slave/test', 14:29:20 INFO - 'SHELL': '/bin/bash', 14:29:20 INFO - 'SHLVL': '1', 14:29:20 INFO - 'TERM': 'linux', 14:29:20 INFO - 'TMOUT': '86400', 14:29:20 INFO - 'USER': 'cltbld', 14:29:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:20 INFO - '_': '/tools/buildbot/bin/python'} 14:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:29:20 INFO - Running setup.py (path:/tmp/pip-ORpiD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:29:20 INFO - Running setup.py (path:/tmp/pip-f2hPnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:29:20 INFO - Running setup.py (path:/tmp/pip-w0vZvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:29:20 INFO - Running setup.py (path:/tmp/pip-sT02WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:29:20 INFO - Running setup.py (path:/tmp/pip-ngzeEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:29:20 INFO - Running setup.py (path:/tmp/pip-eixen0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:29:20 INFO - Running setup.py (path:/tmp/pip-_ElTs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:29:20 INFO - Running setup.py (path:/tmp/pip-hiK83G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:29:20 INFO - Running setup.py (path:/tmp/pip-3Sj9xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:29:20 INFO - Running setup.py (path:/tmp/pip-kwiStf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:29:20 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)) 14:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:29:20 INFO - Running setup.py (path:/tmp/pip-mogzVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:21 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)) 14:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:21 INFO - Running setup.py (path:/tmp/pip-hrUHwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:21 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)) 14:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:21 INFO - Running setup.py (path:/tmp/pip-cj74yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:21 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)) 14:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:21 INFO - Running setup.py (path:/tmp/pip-loSqN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:21 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)) 14:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:21 INFO - Running setup.py (path:/tmp/pip-MnOZ79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:21 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)) 14:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:21 INFO - Running setup.py (path:/tmp/pip-0o5tyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:21 INFO - Running setup.py (path:/tmp/pip-0QGOP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:21 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)) 14:29:21 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)) 14:29:21 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)) 14:29:21 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)) 14:29:21 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)) 14:29:21 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)) 14:29:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:23 INFO - Downloading blessings-1.6.tar.gz 14:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:29:23 INFO - Installing collected packages: blessings 14:29:23 INFO - Running setup.py install for blessings 14:29:23 INFO - Successfully installed blessings 14:29:23 INFO - Cleaning up... 14:29:23 INFO - Return code: 0 14:29:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:23 INFO - Reading from file tmpfile_stdout 14:29:23 INFO - Current package versions: 14:29:23 INFO - argparse == 1.2.1 14:29:23 INFO - blessings == 1.6 14:29:23 INFO - blobuploader == 1.2.4 14:29:23 INFO - docopt == 0.6.1 14:29:23 INFO - functools32 == 3.2.3-2 14:29:23 INFO - jsonschema == 2.5.1 14:29:23 INFO - manifestparser == 1.1 14:29:23 INFO - mozInstall == 1.12 14:29:23 INFO - mozcrash == 1.0 14:29:23 INFO - mozdebug == 0.1 14:29:23 INFO - mozdevice == 0.48 14:29:23 INFO - mozfile == 1.2 14:29:23 INFO - mozhttpd == 0.7 14:29:23 INFO - mozinfo == 0.9 14:29:23 INFO - mozleak == 0.1 14:29:23 INFO - mozlog == 3.4 14:29:23 INFO - moznetwork == 0.27 14:29:23 INFO - mozprocess == 0.23 14:29:23 INFO - mozprofile == 0.28 14:29:23 INFO - mozrunner == 6.13 14:29:23 INFO - mozscreenshot == 0.1 14:29:23 INFO - mozsystemmonitor == 0.3 14:29:23 INFO - moztest == 0.8 14:29:23 INFO - mozversion == 1.4 14:29:23 INFO - psutil == 3.1.1 14:29:23 INFO - requests == 1.2.3 14:29:23 INFO - wsgiref == 0.1.2 14:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:23 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 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29:23 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 14:29:23 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 14:29:23 INFO - Using env: {'DISPLAY': ':0', 14:29:23 INFO - 'HOME': '/home/cltbld', 14:29:23 INFO - 'LANG': 'en_US.UTF-8', 14:29:23 INFO - 'LANGUAGE': 'en_US:en', 14:29:23 INFO - 'LOGNAME': 'cltbld', 14:29:23 INFO - 'MAIL': '/var/mail/cltbld', 14:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:23 INFO - 'MOZ_NO_REMOTE': '1', 14:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:23 INFO - 'NO_EM_RESTART': '1', 14:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:23 INFO - 'PWD': '/builds/slave/test', 14:29:23 INFO - 'SHELL': '/bin/bash', 14:29:23 INFO - 'SHLVL': '1', 14:29:23 INFO - 'TERM': 'linux', 14:29:23 INFO - 'TMOUT': '86400', 14:29:23 INFO - 'USER': 'cltbld', 14:29:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:23 INFO - '_': '/tools/buildbot/bin/python'} 14:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 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)) 14:29:24 INFO - Cleaning up... 14:29:24 INFO - Return code: 0 14:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faebed1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, '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': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', '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 14:29: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'] in /builds/slave/test/build 14:29: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 14:29:24 INFO - Using env: {'DISPLAY': ':0', 14:29:24 INFO - 'HOME': '/home/cltbld', 14:29:24 INFO - 'LANG': 'en_US.UTF-8', 14:29:24 INFO - 'LANGUAGE': 'en_US:en', 14:29:24 INFO - 'LOGNAME': 'cltbld', 14:29:24 INFO - 'MAIL': '/var/mail/cltbld', 14:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:24 INFO - 'MOZ_NO_REMOTE': '1', 14:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:24 INFO - 'NO_EM_RESTART': '1', 14:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:24 INFO - 'PWD': '/builds/slave/test', 14:29:24 INFO - 'SHELL': '/bin/bash', 14:29:24 INFO - 'SHLVL': '1', 14:29:24 INFO - 'TERM': 'linux', 14:29:24 INFO - 'TMOUT': '86400', 14:29:24 INFO - 'USER': 'cltbld', 14:29:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:24 INFO - '_': '/tools/buildbot/bin/python'} 14:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:29:24 INFO - Cleaning up... 14:29:24 INFO - Return code: 0 14:29:24 INFO - Running post-action listener: _resource_record_post_action 14:29:24 INFO - Running post-action listener: _start_resource_monitoring 14:29:24 INFO - Starting resource monitoring. 14:29:24 INFO - [mozharness: 2017-02-10 22:29:24.459191Z] Finished create-virtualenv step (success) 14:29:24 INFO - [mozharness: 2017-02-10 22:29:24.459777Z] Running install step. 14:29:24 INFO - Running pre-action listener: _resource_record_pre_action 14:29:24 INFO - Running main action method: install 14:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:24 INFO - Reading from file tmpfile_stdout 14:29:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:29:24 INFO - Reading from file tmpfile_stdout 14:29:24 INFO - Output received: 14:29:24 INFO - Usage: mozinstall [options] installer 14:29:24 INFO - Options: 14:29:24 INFO - -h, --help show this help message and exit 14:29:24 INFO - -d DEST, --destination=DEST 14:29:24 INFO - Directory to install application into. [default: 14:29:24 INFO - "/builds/slave/test"] 14:29:24 INFO - --app=APP Application being installed. [default: firefox] 14:29:24 INFO - mkdir: /builds/slave/test/build/application 14:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:29:38 INFO - Reading from file tmpfile_stdout 14:29:38 INFO - Output received: 14:29:38 INFO - /builds/slave/test/build/application/firefox/firefox 14:29:38 INFO - Running post-action listener: _resource_record_post_action 14:29:38 INFO - [mozharness: 2017-02-10 22:29:38.407931Z] Finished install step (success) 14:29:38 INFO - [mozharness: 2017-02-10 22:29:38.408171Z] Running run-tests step. 14:29:38 INFO - Running pre-action listener: _resource_record_pre_action 14:29:38 INFO - Running main action method: run_tests 14:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:38 INFO - Python 2.7.3 14:29:38 INFO - Return code: 0 14:29:38 INFO - grabbing minidump binary from tooltool 14:29: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')]} 14:29:38 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 0x1df7f60>, '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 0x1df8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:38 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 14:29:38 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 14:29:38 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 14:29:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:38 INFO - Return code: 0 14:29:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:29:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:29:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 14:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 14:29:38 INFO - Using env: {'DISPLAY': ':0', 14:29:38 INFO - 'HOME': '/home/cltbld', 14:29:38 INFO - 'LANG': 'en_US.UTF-8', 14:29:38 INFO - 'LANGUAGE': 'en_US:en', 14:29:38 INFO - 'LOGNAME': 'cltbld', 14:29:38 INFO - 'MAIL': '/var/mail/cltbld', 14:29:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:38 INFO - 'MOZ_NO_REMOTE': '1', 14:29:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:38 INFO - 'NO_EM_RESTART': '1', 14:29:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:38 INFO - 'PWD': '/builds/slave/test', 14:29:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:38 INFO - 'SHELL': '/bin/bash', 14:29:38 INFO - 'SHLVL': '1', 14:29:38 INFO - 'TERM': 'linux', 14:29:38 INFO - 'TMOUT': '86400', 14:29:38 INFO - 'USER': 'cltbld', 14:29:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1486764764.395598-424435108', 14:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:38 INFO - '_': '/tools/buildbot/bin/python'} 14:29:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 14:29:38 INFO - mozversion application_buildid: 20170210123454 14:29:38 INFO - mozversion application_changeset: 4603dc332d7f1a384c5f4b39192e992f596a4c5b 14:29:38 INFO - mozversion application_display_name: Firefox 14:29:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:38 INFO - mozversion application_name: Firefox 14:29:38 INFO - mozversion application_remotingname: firefox 14:29:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:29:38 INFO - mozversion application_vendor: Mozilla 14:29:38 INFO - mozversion application_version: 52.0 14:29:38 INFO - mozversion platform_buildid: 20170210123454 14:29:38 INFO - mozversion platform_changeset: 4603dc332d7f1a384c5f4b39192e992f596a4c5b 14:29:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:29:38 INFO - mozversion platform_version: 52.0 14:29:38 INFO - using testdate: 1486765778 14:29:38 INFO - actual date: 1486765778 14:29:38 INFO - starting webserver on 'localhost:48894' 14:29:38 INFO - SUITE-START | Running 2 tests 14:29:38 INFO - TEST-START | dromaeo_css 14:29:38 INFO - operating with platform_type : linux_ 14:29:38 INFO - Initialising browser for dromaeo_css test... 14:29:38 INFO - TEST-INFO | started process 3860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPhV6Gh/profile http://localhost:48894/getInfo.html) 14:29:42 INFO - PROCESS | 3860 | __metrics Screen width/height:1600/1200 14:29:42 INFO - PROCESS | 3860 | colorDepth:24 14:29:42 INFO - PROCESS | 3860 | Browser inner width/height: 1024/697 14:29:42 INFO - PROCESS | 3860 | __metrics 14:29:43 INFO - PROCESS | 3860 | 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" 14:29:43 INFO - PROCESS | 3860 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:44 INFO - TEST-INFO | 3860: exit 0 14:29:44 INFO - Browser initialized. 14:29:44 INFO - Running cycle 1/1 for dromaeo_css test... 14:29:44 INFO - TEST-INFO | started process 3955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPhV6Gh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:56 INFO - PROCESS | 3955 | RSS: Main: 141340672 14:29:56 INFO - PROCESS | 3955 | 14:32:58 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:48894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48894/tests/dromaeo/cssquery-ext.html) 14:32:59 INFO - PROCESS | 3955 | RSS: Main: 238522368 14:32:59 INFO - PROCESS | 3955 | 14:36:01 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:48894/tests/dromaeo/cssquery-ext.html (next: http://localhost:48894/tests/dromaeo/cssquery-jquery.html) 14:36:02 INFO - PROCESS | 3955 | RSS: Main: 232513536 14:36:02 INFO - PROCESS | 3955 | 14:39:03 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:48894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48894/tests/dromaeo/cssquery-mootools.html) 14:39:04 INFO - PROCESS | 3955 | RSS: Main: 220545024 14:39:04 INFO - PROCESS | 3955 | 14:42:06 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:48894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48894/tests/dromaeo/cssquery-prototype.html) 14:42:06 INFO - PROCESS | 3955 | RSS: Main: 218198016 14:42:06 INFO - PROCESS | 3955 | 14:45:09 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:48894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48894/tests/dromaeo/cssquery-yui.html) 14:45:10 INFO - PROCESS | 3955 | RSS: Main: 175816704 14:45:10 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:48894/tests/dromaeo/cssquery-yui.html (next: http://localhost:48894/tests/dromaeo/cssquery-dojo.html) 14:48:12 INFO - PROCESS | 3955 | RSS: Main: 262074368 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | __start_tp_report 14:48:12 INFO - PROCESS | 3955 | _x_x_mozilla_page_load 14:48:12 INFO - PROCESS | 3955 | _x_x_mozilla_page_load_details 14:48:12 INFO - PROCESS | 3955 | |i|pagename|runs| 14:48:12 INFO - PROCESS | 3955 | |0;dojo.html;3219.67803219678;3257.65794591568;3265.4611989021805;3292.0617623977173;3294.6705329467054;5493.2034854946005;5596.860078498029;5617.9438205617935;5625;5642.915356269659;5584.888302233953;5653.180288858123;5673.546116310696;5674.943250567493;5692.0608099663505;5103.106956282654;5123.154679477901;5155.329807125068;5170.172772356424;5192.688438693672;5031.823886163985;5189.792408303663;5211.765470553834;5223.71269580173;5225.634205605609;5003.724795136266;5103.795848166069;5112.105381558231;5127.154019586764;5151.716655583941;5155.432902380754;5194.4805519447755;5198.610104242178;5261.552768014723;5276.7889284428575;5114.130597798383;5158.587313014949;5239.79040838366;5243.632945693803;5274.525292723635;5337.733113344318;5350.571954243651;5485.369182544018;5532.1425179097305;5541;5979.760809567612;5997;6008.879822403571;6082.026875699911;6093.421124993119;6105.8168254952425;6122.418370254819;6128.693565321761;6137.938620613826;6148.477379422754;5457.754401051962;5485.588580856452;5497.780088796403;5555.388907220203;5560.443955604407;6065.727042283108;6098.939010609837;6103.664298463627;6116.938830611637;6124.540659450559;5863.179154918314;5863.442972917566;5871.911921321183;5874.530037596982;5875.441833025941;5749.3963133871175;5796.652200867961;5875.41245875409;5912.881742365214;5913.49735272498;5947.851303717355;5957.195778569838;5960.37416071315;5992.221011268507;5998.910016349758;5901.144334071621;5943.435373639584;5963.522918166536;5966.492848107872;5969.343372229051;4445.644348452181;4470.441194850644;4563.315502674625;4582.175208462442;4609.262517997105;4108.856190033334;4112.794360281974;4115.794210289474;4137.379393091001;4152.086540960984;5749.310082790008;5749.850029993934;5752.626079304916;5757.165211044375;5762.625429347079;5751.9424805751405;5790.276215473066;5904.232449781501;6015.729292181863;6022.759089636453;5672.347680016768;5739.282589676291;5748.597598168171;5766.336871259775;5773.336066352339;5131.384233891957;5136.049830781242;5139.486051394831;5146.047981123429;5169.147090729987;5979.790707325223;6095.725692343944;6233.906491402633;6282.246130464465;6283.434490895841;5957.195778569838;5967.731452084579;5990.6705131218205;6035.36628653985;6099.237595300588;6286.717097730704;6292.498327525378;6327.303996560467;6328.177336946167;6331.176946996861;5649.4633009864;5923.141144534105;5941.881162376815;5944.910826337695;5945.821625351246;5747.8563035924435;5885.117232415001;5896.410358964069;5908.468237858441;6025.457708806229;5824.5631577631;5864.765409383747;5870.677112758839;5871.794487193099;5882.352941176553;5841.211436456024;5850.619709719025;5850.912236316373;5852.795152169653;5855.59010869235;5465.562754979672;5569.248151499496;5714.3999880012;5739.311282646109;5748.48263656273;5903.2325797646035;5908.113782932594;5912.438318359921;5913.231279933581;5937.584369094122;5577.944220557904;5616.1856530803625;5762.481376676119;5769.278840144982;5772.797952071657 14:48:12 INFO - PROCESS | 3955 | |1;ext.html;581.2501872584367;609.0954931926091;634.6699716147602;645.4062262718298;653.9634679033732;33109.33781324372;44236.778816105914;44930.55069449309;45126;45166.54833451673;44813.327800083025;44993;45106;45141;45320.3201951971;8268.131846156157;9014.233790127848;9172.08279172084;9173.58718857653;9174.357794954356;8286.958565207196;8485.278751306147;8492.957535212316;10630.521626526786;10890.836637450444;11005.064569511602;11031.944840275788;11053.502592383322;11063.834042489369;11075.446227688624;10919.12646988239;10958.890411095907;10969.506372213269;10976.451177441097;11006.449677516131;10820;10865.619703310345;10865.891341086566;10874.401907895062;10883.346999180074;43122;43394.78302608467;43400;43407.782961084995;43446.56553434457;3556.946645800315;3791.6018818023986;3796.8481260749536;3808.847646094153;4256.2764330063965;31946.520802187984;32697.6730232697;32846.17884552881;33010.66989330124;33657;4412.867613971586;4451.706139719209;4482.731036137842;4517.59341659249;4560.361549383089;317305;319425;321694;321911;322730.9999999977;37848.24303513969;60443.09335359973;60908.69545652244;60941.39058609446;61191.69404152951;37753.244935101146;40457.190856182715;40508.59491405107;40544.79727601343;40562.79718601447;17024.14879256032;17284;17305;17318.047507386964;17326.56683582895;12970.80543791844;14328.283585820876;14410.783838242434;14512.782308265385;14578.635534111732;8782.780430489289;9025.368224224372;9157.587908544132;9181;9451.763705907408;3593.5328407306883;3597.334493118781;3617.5297211362354;3620.4388319810473;3671.4492826076303;1034.04350975349;1044.289882879634;1092.721356054217;1121.2655710509466;1125.2854437432127;33296.3340733184;33707;33781;33846;34252.486212706826;1132.0773569540963;1149.4252873563219;1163.4473625028045;1216.793145165324;1257.8805013523884;17444;17462.912685436746;17565.473035808947;17704.911475442797;17768.644627107384;501343;505187;506085;508026;508838;59187.40812591819;59220.70389648024;59385;59728;60053;1300.5708116321591;1303.8565757766637;1391.7146984868077;1417.1426287096365;1427.2792239918774;31816.36367272688;32981.340373191924;33560.66439335576;34100.82949585236;34310.313793723486;51249.23126153036;51758.74120629373;51768.223476648636;51832.740836295576;51919.480805191466;371277;374026;375794;376136;457710;24958.75041249637;29633.259168520097;29741.85129074341;31408.68591314149;31691;47569.52430475789;47750;48334;48784.75607621939;49105.50894491009;41303.58696412997;41305.1738965225;41747.58252417558;43018.56981430146;43050.35424468573;40666;42081.57918420777;42373.576264238196;43528;43607.56392436162;40947.38578921378;41234;42614;42626.78686606547;42848.35727464153;35085.82457087698;36929.44605830861;37241.62758372381;37348.43977340397;37529.4370584436;27783;27886;28275;28355.716442835306;28532.286692832844 14:48:12 INFO - PROCESS | 3955 | |2;jquery.html;429.3774027659893;433.1575086456843;438.47602115472006;445.1630933844372;448.20220008385087;18323.26706931723;18381.81618183816;19578.608427831434;19772.406827795152;19779.604407911833;19597.706034409497;19748.70376944347;19790.40628781135;20355.59288814223;20361.490962725904;5674.432556744334;5931.436513531207;5939.55453340999;5940.2277703898435;5944.4352786485215;5754.482096611304;5838.620489668179;5847.941520584804;5957.374475680056;6190.81427557174;6292.0876472911405;6298.055291706258;6306.243250809909;6309.242890853104;6314.273858506284;6300.30696623371;6378.107065010902;6732.29310922351;6735.225449073346;6796.728130874759;5250.159974404077;6085.300190478108;6085.4827339676185;6093.969530152321;6095.695215239265;14655.193964331958;14806.259687015714;21437;22670.773292267033;23551.29346119619;2371.454565449939;2454.914078007279;2572.897084116633;2718.4563087382603;3008.39832033592;10311.22665800068;10609.68170954865;10817.621383251548;10897.455127243606;11233.269837460539;1944.980550194494;1973.9703904441444;1976.5355141541727;1980.9405717828488;2030.6953956906434;80142;81042.59478702628;82484.17515824825;82721.17278827255;84538.57730711368;11508.309501429942;11559.942200289113;11666.88333116675;11684.47419866108;11886.821697674543;16880.324787008383;16906.74639880403;16914.83085169157;16915.40796072156;16922.74615880763;8441.831163376699;8608.440451370641;8641.265492433213;8672.783180420414;8710.608022638997;8361.540115293596;8385.916140838635;8451.732240164025;8588.39881208322;8603.354748393895;4834.516548345137;4984.40187177541;5119.360079990001;5139.486051394831;5253.789848406097;2091.4248581639868;2115.9894200528897;2145.581611585757;2180.400389892792;2188.89055547222;987.2586261475105;991.980160396788;1048.9055984961237;1076.7361996310954;1114.9777004459866;19616.411507654793;20287;20557.177712891316;20578.897105514377;20637.89681051615;1005.5676059294574;1023.7338292044122;1031.7265924530006;1032.9431881246603;1038.8182068138046;10410.167186625053;11146.665600032013;11218.997836157616;11285.887141128484;11352.602658907064;443234;448017;462632;468681;469871;59411.10883336667;64245.678771605846;86085;87235.69146462808;90875;1018.5060245780791;1038.2524582300732;1049.637874933162;1057.5241141486208;1061.0609610494769;16746.1626918656;16830.242639081516;17083.40208092711;17694.469165925042;18079.36722214716;28361.14916552507;30222.54666180053;41067.58932410757;42071.57928420799;42426.575734242266;58499.34760764426;58947.70526147342;59474.405255946884;60136.69931650314;60656.69671651613;8586.356023298153;8600.612972416382;8883.333749968908;8894.466332019842;8994.955025224832;9595.376300540442;12599.055070869537;13211.471541138248;13224.140430871963;13320.400581973641;10623.521941512805;10727.463626818784;10832;10840.186985976241;10961.397123157984;10944.616938407118;11286.379249141377;11347.943260283646;11659.358735269303;11776.941115294369;10328.896711033094;11210.430539724608;11297.15271354668;11325.830112548154;11342.97913187817;7647.158812530506;8127.918720812716;8178.672853086048;8432.241098301183;9102;10046.246531510313;10234;10381.480925953823;10400.27198096126;10594.4702764863 14:48:12 INFO - PROCESS | 3955 | |3;mootools.html;1370.1162750026226;1543.9614009649758;1552.9378824847004;1750.8249175082494;1865.5242913057177;7864.803379915498;8369.790755231123;8482.660693572258;8871.290296776258;8894.73315800527;8667.566621668922;8974.461532308065;8978.685745998891;8979.41633793803;8988.460692358463;2412.059296874216;2453.0800949643885;2454.3250606083293;2454.5581795276844;2455.4475243070347;2456.226288719057;2486.689163854518;2488.228649118779;2488.6764720586298;2491.4394261291245;2409.5421869844763;2411.3730430088217;2411.807055435561;2439.865807380593;2450.9754902451014;2379.89290481927;2385.6779334789753;2404.663347131403;2412.0472413396697;2414;2322.291701031185;2342.320726989171;2362.7637236276405;2363.314638754759;2367.9408014799596;8710.172533609297;8774.692885749031;8824.338174636929;8842.823143537158;8862.335324850597;5269;5451.400345961941;5455.5908306877145;5458.563314934835;5468.152436372368;3605.2248766515327;3627.72792040598;3704.9444258335875;3715.7956312402807;3796.1648437343742;1164.1443538998915;1180.1208099965581;1193.9820902686467;1220.6033039262275;1223.131576580629;12380.071494637938;12702.237865728086;12711.68220794469;12719.93640031794;12722.10945233834;4781.617470602343;4922.261660750916;4974.253861920741;4989.725565093955;5017.272495488134;10759.408232547285;10768.246222764332;10773.946130269298;10780.94609526963;10781.676549703521;5628.690422026828;5630.774769009194;5631.971840140773;5635.492805647511;5637.943620563824;4147;4453.354263631755;4603.608693261111;5103.7192954387865;5126.5898728101665;4246.893827654333;4259.8083086261195;4311.439512863308;4346.8043938022865;4373.868783936423;1342.8183198785007;1371.3280492558574;1372.766629672958;1381.550995926308;1394.065975796219;975.7999610079917;978.3493976505687;1001.2390583156853;1016.3292227130058;1023.8054769593754;6005;6027.939720602738;6127.479164271087;6156.6921653917125;6157.107219453154;906.1255888068046;921.8110287391069;933.5658918602883;962.4706411473661;994.6866736977973;3938.7242892997215;4099.508059032935;4102.077032667626;4170.4995400551525;4181.268278051329;10667.359958402521;10771.138308935424;10954.452277386099;11063.391513466837;11094.223404361617;10794.892051079389;11016.394098324508;11025.173112016631;11025.6141035065;11041.558337666404;8424.620892059873;8538.188872057144;8617.052124266325;8619.267362274151;8624.956875215585;5786.161006654096;5792.478676919098;5908.438698323653;5936.495397891227;5994.28068631767;10208.336458130198;10276.434796086287;10283.07452329294;10339.483025848527;10349.223808214565;9107.453552786854;9303.255739540957;9946.900530994886;10304.278700490893;10327.586896524355;7752.4573279869865;7893.802654933673;7950.642221099949;7950.880736789069;8061.556614386265;8684;8698.738682891071;8722.65109395617;8748.606312715816;8783.956080219557;7591;7659.923400765921;7744.961275193813;7798.571078590505;7845.3723702104835;7617.124030736314;7730.033745781778;7731.304182623591;7782.455228133977;7813.3749300057;7231.710731570678;7285.927140728737;7354.411647068328;7363.447741419308;7370.742024029133;5342.252084708066;5380.515753582196;5410.161424979135;5431.34823821144;5474.8357549272;5200.6619569727845;5298.549623282064;5341.732913354394;5377.838664840061;5456.672599644034 14:48:12 INFO - PROCESS | 3955 | |4;prototype.html;341.8735068024831;356;356.47598030894585;358.1529682301358;361.9384704600218;5148.536631703146;5279.472052794728;5313.734313284335;5375.75809088591;5383.246345511631;5123.180291153416;5227.947720522794;5244;5244.449332820056;5258.973705131479;4213.873583792491;4219.2405367033925;4224.640905523019;4224.809883555247;4242.533321334666;3993.6605388542007;4160.167966406731;4226.577342265779;4227.281362168439;4228.5982831630945;4110.91778164438;4127.772972486512;4164.063085805685;4165.937510937339;4177.770222637754;4111.368724016632;4125.257453658341;4143.047099167194;4145.859888530663;4179.749215047107;3596.7841929484316;3669.3945498992903;3699.6300369963055;3714.8699795507296;3729.198222382201;5126.871828204287;5135.639055650256;5158.690478571298;5160.303359046518;5162.277281180638;4734.526547345238;4740.454847692525;4747.548982846624;4777.378940737682;4781.6891902026255;5368.355797304349;5471.206675032138;5482.945170548283;5523.392426833045;5526.171074338841;4040.2323558523785;4064.1465292288653;4068.816903239361;4069.3895915612893;4078.9796051019853;5654.717264136777;5670.461306175906;5698.6865722385255;5704.716438801278;5747.425257474303;4019.698522610757;4146.543880173179;4153.7507749535125;4155.210510003089;4177.1411721784125;4235.385869048971;4237.216115018731;4240;4245.257080011047;4256;4730.88172795676;4757.191277482836;4767.356406885026;4811.254255590389;4813.927791083137;5379.596530260246;5525.806596769094;5561.332640083135;5601.243832082698;5610.551155907518;1336.2383441438287;1356.891448684103;1378.620879258192;1406.521782593923;1411.2097225553723;952.6522819171091;974.1476208317722;974.8683927669815;992.3301771304341;996.003996003996;5130.999455106218;5142.6914385137015;5167.586593072545;5204.9219261711105;5224.190250511177;5425.80632260902;5466.644668096561;5467.45325467458;5477.342718873681;5479.6164268500825;5148.536631703165;5214.869628259324;5216.660917040456;5238.345206849144;5494.80768173112;2903.274181454636;2903.941921161565;2926.590277361171;2931.9560206596916;2949.8967536136133;5704.543636509069;5735;5758.712064396764;5761.337446193657;5766.3368712598585;5445.972770136124;5521.67479804844;5555.722213889289;5577.386487486373;5604.3835178130375;5733.71331433435;5734.885302293931;5739.282589676291;5741.382928754858;5770.798022069207;5355.116405793156;5491.75287112073;5521.254630624814;5529.253550770755;5588.776448941997;5388.892222155457;5408.188256933814;5439.9456005441025;5461.180822876441;5473.101574091245;5705.088795253637;5725.484706376279;5730.163569033355;5735.8566035849435;5798.507126894261;4013.979930100331;4030.3551431770775;4031.4154447604346;4214.388913607571;4241.34259189826;5441.619086663895;5574.191742197439;5638.351589567253;5663.688497132697;5678.4605462480995;5449.621234834428;5456.972715136399;5578.71272778159;5589.469000444951;5616.297962754656;5536.283752036881;5594.832155035356;5604.663720176803;5622.8313150605545;5641.182028605911;5324.4675532446445;5473.8357849264585;5504.284443022381;5507.889842203213;5535.391106978149;5544.833654990357;5582.358028826575;5606.971965140148;5607.691576963143;5624.184493248375;5463.53559947393;5470;5479.369872464717;5480.287562616834;5490.80782172638 14:48:12 INFO - PROCESS | 3955 | |5;yui.html;804.3002587748659;812.7033632724053;822.2106777493606;824.332290844416;897.358388752043;14780.704385912275;15001.549953501413;15002;15155.696886062273;15253.847461525382;13381.330933453337;14766.335514901828;14809.11145331281;14906.925465372686;14942.252887355644;857.9485230886152;872.97817554561;874.2350443362059;874.2830878679486;874.5321253129576;849.3290300662469;850.7702920211539;851.2338894994492;851.5827244650108;860.8106216632331;878.6485405837684;879.2218886285619;880.8986966498838;881.7575166829141;883.3595643158691;873.3057219510505;874.2787200559532;876.3427429427898;876.3821505838432;876.8071024374691;653.4478365780908;660.7257987935001;662.7050962321769;663.698017402081;664.2825748191989;13370.598882033555;13610.251436171007;13700.040997130205;13716.177029378268;13742.175469471764;12217.389130543526;12375.886170244632;12880.291583962879;12883.806742898863;12975.675608109872;10977.451127443675;10979.560817567288;11091.112710983101;11245.83131253032;11290.435478226056;3793.1655035892336;3798.696104311676;3847.8460861565504;3877.806109694504;3899.610038996106;55468.445315547135;56948.14577781336;57376.42623573794;60146;63619;11640.243384180001;11676.76646467066;11771.882281177079;11928.284302941851;12057.457414416373;20356;20380.592388152152;20523.17907283692;20808.79191208099;21186.15255389798;8519.190676885686;8521.318294536422;8539.231469167804;8615.138486151334;8967.551622418852;4558.703684260512;4575.794089265991;4581.129585378767;4663.417072865892;4741.241401375763;3395.0833275015607;3529.6470352964498;3532.116970757311;3534.452159915217;3537.0980399998352;621.9129321894939;636.7707625254905;643.7135474713801;646.1309538670481;648.9740410383532;727.3453891497588;741.4142827166478;742.8699977503916;768.8462307538402;775.9573223472763;9476.857847132298;9641.662541811003;9793.167580755573;9841.360311579725;9908.7027389177;655.3217419970308;713.8144082538473;733.9559626422432;750.2307257192175;754.7509321923752;4326.63223625989;4585.862424127282;4604.355390245369;4659.813607455664;4709.62323014158;84223.5788821052;85968;86725;89134.55432722924;93828.0617193833;49283;63653;79580;80139.59930200312;80633.59683201664;58497.70751146217;67922.66038669775;68583.31416685769;68892.3110768886;70787.64606176937;8829.558522073743;9696.5636546357;10110.747231319276;10149.289549731448;10235.692929212135;32256.516152257267;42524.362134568626;44809.327860081474;45605.543944561454;46312.30531542097;51095.74452127864;61395.38604613897;62280;63509.364906352195;63773;10275.537600807833;10600.628977985734;10651;10718.303310284806;11129.554817807197;11644.767104658029;13321.200727956353;13798.310084495935;14192.929035354757;14459.493917713251;12617.558385456465;13823.79264311016;14126.364313606118;14219;14282.285885705882;12183.695407614881;12424.378781061092;13822.892011465014;13914.791278131039;13975.930120349332;13333.466661333438;13750.793738094137;13842.169469831842;13952.16287022782;14185;11191.776164476501;11307.547698091985;11316.15128865322;11483.712907177387;11530.538778449103;11065.391403472886;11493.68244483915;11701.473433695333;11789.76420471603;11954.282743035446 14:48:12 INFO - PROCESS | 3955 | __end_tp_report 14:48:12 INFO - PROCESS | 3955 | __start_cc_report 14:48:12 INFO - PROCESS | 3955 | _x_x_mozilla_cycle_collect,1010 14:48:12 INFO - PROCESS | 3955 | __end_cc_report 14:48:12 INFO - PROCESS | 3955 | __startTimestamp1486766892829__endTimestamp 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | ------- Summary: start ------- 14:48:12 INFO - PROCESS | 3955 | Number of tests: 6 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | [#0] dojo.html Cycles:165 Average:5565.78 Median:5757.17 stddev:621.50 (10.8%) stddev-sans-first:595.54 14:48:12 INFO - PROCESS | 3955 | Values: 3219.7 3257.7 3265.5 3292.1 3294.7 5493.2 5596.9 5617.9 5625.0 5642.9 5584.9 5653.2 5673.5 5674.9 5692.1 5103.1 5123.2 5155.3 5170.2 5192.7 5031.8 5189.8 5211.8 5223.7 5225.6 5003.7 5103.8 5112.1 5127.2 5151.7 5155.4 5194.5 5198.6 5261.6 5276.8 5114.1 5158.6 5239.8 5243.6 5274.5 5337.7 5350.6 5485.4 5532.1 5541.0 5979.8 5997.0 6008.9 6082.0 6093.4 6105.8 6122.4 6128.7 6137.9 6148.5 5457.8 5485.6 5497.8 5555.4 5560.4 6065.7 6098.9 6103.7 6116.9 6124.5 5863.2 5863.4 5871.9 5874.5 5875.4 5749.4 5796.7 5875.4 5912.9 5913.5 5947.9 5957.2 5960.4 5992.2 5998.9 5901.1 5943.4 5963.5 5966.5 5969.3 4445.6 4470.4 4563.3 4582.2 4609.3 4108.9 4112.8 4115.8 4137.4 4152.1 5749.3 5749.9 5752.6 5757.2 5762.6 5751.9 5790.3 5904.2 6015.7 6022.8 5672.3 5739.3 5748.6 5766.3 5773.3 5131.4 5136.0 5139.5 5146.0 5169.1 5979.8 6095.7 6233.9 6282.2 6283.4 5957.2 5967.7 5990.7 6035.4 6099.2 6286.7 6292.5 6327.3 6328.2 6331.2 5649.5 5923.1 5941.9 5944.9 5945.8 5747.9 5885.1 5896.4 5908.5 6025.5 5824.6 5864.8 5870.7 5871.8 5882.4 5841.2 5850.6 5850.9 5852.8 5855.6 5465.6 5569.2 5714.4 5739.3 5748.5 5903.2 5908.1 5912.4 5913.2 5937.6 5577.9 5616.2 5762.5 5769.3 5772.8 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | [#1] ext.html Cycles:180 Average:56965.40 Median:206661.72 stddev:109367.93 (52.9%) stddev-sans-first:109592.81 14:48:12 INFO - PROCESS | 3955 | Values: 581.3 609.1 634.7 645.4 654.0 33109.3 44236.8 44930.6 45126.0 45166.5 44813.3 44993.0 45106.0 45141.0 45320.3 8268.1 9014.2 9172.1 9173.6 9174.4 8287.0 8485.3 8493.0 10630.5 10890.8 11005.1 11031.9 11053.5 11063.8 11075.4 10919.1 10958.9 10969.5 10976.5 11006.4 10820.0 10865.6 10865.9 10874.4 10883.3 43122.0 43394.8 43400.0 43407.8 43446.6 3556.9 3791.6 3796.8 3808.8 4256.3 31946.5 32697.7 32846.2 33010.7 33657.0 4412.9 4451.7 4482.7 4517.6 4560.4 317305.0 319425.0 321694.0 321911.0 322731.0 37848.2 60443.1 60908.7 60941.4 61191.7 37753.2 40457.2 40508.6 40544.8 40562.8 17024.1 17284.0 17305.0 17318.0 17326.6 12970.8 14328.3 14410.8 14512.8 14578.6 8782.8 9025.4 9157.6 9181.0 9451.8 3593.5 3597.3 3617.5 3620.4 3671.4 1034.0 1044.3 1092.7 1121.3 1125.3 33296.3 33707.0 33781.0 33846.0 34252.5 1132.1 1149.4 1163.4 1216.8 1257.9 17444.0 17462.9 17565.5 17704.9 17768.6 501343.0 505187.0 506085.0 508026.0 508838.0 59187.4 59220.7 59385.0 59728.0 60053.0 1300.6 1303.9 1391.7 1417.1 1427.3 31816.4 32981.3 33560.7 34100.8 34310.3 51249.2 51758.7 51768.2 51832.7 51919.5 371277.0 374026.0 375794.0 376136.0 457710.0 24958.8 29633.3 29741.9 31408.7 31691.0 47569.5 47750.0 48334.0 48784.8 49105.5 41303.6 41305.2 41747.6 43018.6 43050.4 40666.0 42081.6 42373.6 43528.0 43607.6 40947.4 41234.0 42614.0 42626.8 42848.4 35085.8 36929.4 37241.6 37348.4 37529.4 27783.0 27886.0 28275.0 28355.7 28532.3 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | [#2] jquery.html Cycles:180 Average:27706.16 Median:23111.03 stddev:75537.10 (326.8%) stddev-sans-first:75721.24 14:48:12 INFO - PROCESS | 3955 | Values: 429.4 433.2 438.5 445.2 448.2 18323.3 18381.8 19578.6 19772.4 19779.6 19597.7 19748.7 19790.4 20355.6 20361.5 5674.4 5931.4 5939.6 5940.2 5944.4 5754.5 5838.6 5847.9 5957.4 6190.8 6292.1 6298.1 6306.2 6309.2 6314.3 6300.3 6378.1 6732.3 6735.2 6796.7 5250.2 6085.3 6085.5 6094.0 6095.7 14655.2 14806.3 21437.0 22670.8 23551.3 2371.5 2454.9 2572.9 2718.5 3008.4 10311.2 10609.7 10817.6 10897.5 11233.3 1945.0 1974.0 1976.5 1980.9 2030.7 80142.0 81042.6 82484.2 82721.2 84538.6 11508.3 11559.9 11666.9 11684.5 11886.8 16880.3 16906.7 16914.8 16915.4 16922.7 8441.8 8608.4 8641.3 8672.8 8710.6 8361.5 8385.9 8451.7 8588.4 8603.4 4834.5 4984.4 5119.4 5139.5 5253.8 2091.4 2116.0 2145.6 2180.4 2188.9 987.3 992.0 1048.9 1076.7 1115.0 19616.4 20287.0 20557.2 20578.9 20637.9 1005.6 1023.7 1031.7 1032.9 1038.8 10410.2 11146.7 11219.0 11285.9 11352.6 443234.0 448017.0 462632.0 468681.0 469871.0 59411.1 64245.7 86085.0 87235.7 90875.0 1018.5 1038.3 1049.6 1057.5 1061.1 16746.2 16830.2 17083.4 17694.5 18079.4 28361.1 30222.5 41067.6 42071.6 42426.6 58499.3 58947.7 59474.4 60136.7 60656.7 8586.4 8600.6 8883.3 8894.5 8995.0 9595.4 12599.1 13211.5 13224.1 13320.4 10623.5 10727.5 10832.0 10840.2 10961.4 10944.6 11286.4 11347.9 11659.4 11776.9 10328.9 11210.4 11297.2 11325.8 11343.0 7647.2 8127.9 8178.7 8432.2 9102.0 10046.2 10234.0 10381.5 10400.3 10594.5 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | [#3] mootools.html Cycles:180 Average:5926.19 Median:4981.99 stddev:3307.39 (66.4%) stddev-sans-first:3298.94 14:48:12 INFO - PROCESS | 3955 | Values: 1370.1 1544.0 1552.9 1750.8 1865.5 7864.8 8369.8 8482.7 8871.3 8894.7 8667.6 8974.5 8978.7 8979.4 8988.5 2412.1 2453.1 2454.3 2454.6 2455.4 2456.2 2486.7 2488.2 2488.7 2491.4 2409.5 2411.4 2411.8 2439.9 2451.0 2379.9 2385.7 2404.7 2412.0 2414.0 2322.3 2342.3 2362.8 2363.3 2367.9 8710.2 8774.7 8824.3 8842.8 8862.3 5269.0 5451.4 5455.6 5458.6 5468.2 3605.2 3627.7 3704.9 3715.8 3796.2 1164.1 1180.1 1194.0 1220.6 1223.1 12380.1 12702.2 12711.7 12719.9 12722.1 4781.6 4922.3 4974.3 4989.7 5017.3 10759.4 10768.2 10773.9 10780.9 10781.7 5628.7 5630.8 5632.0 5635.5 5637.9 4147.0 4453.4 4603.6 5103.7 5126.6 4246.9 4259.8 4311.4 4346.8 4373.9 1342.8 1371.3 1372.8 1381.6 1394.1 975.8 978.3 1001.2 1016.3 1023.8 6005.0 6027.9 6127.5 6156.7 6157.1 906.1 921.8 933.6 962.5 994.7 3938.7 4099.5 4102.1 4170.5 4181.3 10667.4 10771.1 10954.5 11063.4 11094.2 10794.9 11016.4 11025.2 11025.6 11041.6 8424.6 8538.2 8617.1 8619.3 8625.0 5786.2 5792.5 5908.4 5936.5 5994.3 10208.3 10276.4 10283.1 10339.5 10349.2 9107.5 9303.3 9946.9 10304.3 10327.6 7752.5 7893.8 7950.6 7950.9 8061.6 8684.0 8698.7 8722.7 8748.6 8784.0 7591.0 7659.9 7745.0 7798.6 7845.4 7617.1 7730.0 7731.3 7782.5 7813.4 7231.7 7285.9 7354.4 7363.4 7370.7 5342.3 5380.5 5410.2 5431.3 5474.8 5200.7 5298.5 5341.7 5377.8 5456.7 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | [#4] prototype.html Cycles:180 Average:4647.95 Median:5296.60 stddev:1337.98 (25.3%) stddev-sans-first:1302.12 14:48:12 INFO - PROCESS | 3955 | Values: 341.9 356.0 356.5 358.2 361.9 5148.5 5279.5 5313.7 5375.8 5383.2 5123.2 5227.9 5244.0 5244.4 5259.0 4213.9 4219.2 4224.6 4224.8 4242.5 3993.7 4160.2 4226.6 4227.3 4228.6 4110.9 4127.8 4164.1 4165.9 4177.8 4111.4 4125.3 4143.0 4145.9 4179.7 3596.8 3669.4 3699.6 3714.9 3729.2 5126.9 5135.6 5158.7 5160.3 5162.3 4734.5 4740.5 4747.5 4777.4 4781.7 5368.4 5471.2 5482.9 5523.4 5526.2 4040.2 4064.1 4068.8 4069.4 4079.0 5654.7 5670.5 5698.7 5704.7 5747.4 4019.7 4146.5 4153.8 4155.2 4177.1 4235.4 4237.2 4240.0 4245.3 4256.0 4730.9 4757.2 4767.4 4811.3 4813.9 5379.6 5525.8 5561.3 5601.2 5610.6 1336.2 1356.9 1378.6 1406.5 1411.2 952.7 974.1 974.9 992.3 996.0 5131.0 5142.7 5167.6 5204.9 5224.2 5425.8 5466.6 5467.5 5477.3 5479.6 5148.5 5214.9 5216.7 5238.3 5494.8 2903.3 2903.9 2926.6 2932.0 2949.9 5704.5 5735.0 5758.7 5761.3 5766.3 5446.0 5521.7 5555.7 5577.4 5604.4 5733.7 5734.9 5739.3 5741.4 5770.8 5355.1 5491.8 5521.3 5529.3 5588.8 5388.9 5408.2 5439.9 5461.2 5473.1 5705.1 5725.5 5730.2 5735.9 5798.5 4014.0 4030.4 4031.4 4214.4 4241.3 5441.6 5574.2 5638.4 5663.7 5678.5 5449.6 5457.0 5578.7 5589.5 5616.3 5536.3 5594.8 5604.7 5622.8 5641.2 5324.5 5473.8 5504.3 5507.9 5535.4 5544.8 5582.4 5607.0 5607.7 5624.2 5463.5 5470.0 5479.4 5480.3 5490.8 14:48:12 INFO - PROCESS | 3955 | 14:48:12 INFO - PROCESS | 3955 | [#5] yui.html Cycles:180 Average:17397.01 Median:4583.50 stddev:22658.62 (494.4%) stddev-sans-first:22687.93 14:48:12 INFO - PROCESS | 3955 | Values: 804.3 812.7 822.2 824.3 897.4 14780.7 15001.5 15002.0 15155.7 15253.8 13381.3 14766.3 14809.1 14906.9 14942.3 857.9 873.0 874.2 874.3 874.5 849.3 850.8 851.2 851.6 860.8 878.6 879.2 880.9 881.8 883.4 873.3 874.3 876.3 876.4 876.8 653.4 660.7 662.7 663.7 664.3 13370.6 13610.3 13700.0 13716.2 13742.2 12217.4 12375.9 12880.3 12883.8 12975.7 10977.5 10979.6 11091.1 11245.8 11290.4 3793.2 3798.7 3847.8 3877.8 3899.6 55468.4 56948.1 57376.4 60146.0 63619.0 11640.2 11676.8 11771.9 11928.3 12057.5 20356.0 20380.6 20523.2 20808.8 21186.2 8519.2 8521.3 8539.2 8615.1 8967.6 4558.7 4575.8 4581.1 4663.4 4741.2 3395.1 3529.6 3532.1 3534.5 3537.1 621.9 636.8 643.7 646.1 649.0 727.3 741.4 742.9 768.8 776.0 9476.9 9641.7 9793.2 9841.4 9908.7 655.3 713.8 734.0 750.2 754.8 4326.6 4585.9 4604.4 4659.8 4709.6 84223.6 85968.0 86725.0 89134.6 93828.1 49283.0 63653.0 79580.0 80139.6 80633.6 58497.7 67922.7 68583.3 68892.3 70787.6 8829.6 9696.6 10110.7 10149.3 10235.7 32256.5 42524.4 44809.3 45605.5 46312.3 51095.7 61395.4 62280.0 63509.4 63773.0 10275.5 10600.6 10651.0 10718.3 11129.6 11644.8 13321.2 13798.3 14192.9 14459.5 12617.6 13823.8 14126.4 14219.0 14282.3 12183.7 12424.4 13822.9 13914.8 13975.9 13333.5 13750.8 13842.2 13952.2 14185.0 11191.8 11307.5 11316.2 11483.7 11530.5 11065.4 11493.7 11701.5 11789.8 11954.3 14:48:12 INFO - PROCESS | 3955 | -------- Summary: end -------- 14:48:12 INFO - PROCESS | 3955 | 14:48:13 INFO - TEST-INFO | 3955: exit 0 14:48:13 INFO - TEST-OK | dromaeo_css | took 1114931ms 14:48:13 INFO - TEST-START | kraken 14:48:13 INFO - operating with platform_type : linux_ 14:48:13 INFO - Initialising browser for kraken test... 14:48:13 INFO - TEST-INFO | started process 4254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq5_lfz/profile http://localhost:48894/getInfo.html) 14:48:17 INFO - PROCESS | 4254 | __metrics Screen width/height:1600/1200 14:48:17 INFO - PROCESS | 4254 | colorDepth:24 14:48:17 INFO - PROCESS | 4254 | Browser inner width/height: 1024/697 14:48:17 INFO - PROCESS | 4254 | __metrics 14:48:18 INFO - PROCESS | 4254 | 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" 14:48:18 INFO - PROCESS | 4254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:48:19 INFO - TEST-INFO | 4254: exit 0 14:48:19 INFO - Browser initialized. 14:48:19 INFO - Running cycle 1/1 for kraken test... 14:48:19 INFO - TEST-INFO | started process 4345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq5_lfz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:31 INFO - PROCESS | 4345 | RSS: Main: 142180352 14:48:31 INFO - PROCESS | 4345 | 14:48:33 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48894/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:34 INFO - PROCESS | 4345 | RSS: Main: 183156736 14:48:34 INFO - PROCESS | 4345 | 14:48:37 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48894/tests/kraken/driver.html?testName=audio-dft) 14:48:37 INFO - PROCESS | 4345 | RSS: Main: 173133824 14:48:37 INFO - PROCESS | 4345 | 14:48:40 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48894/tests/kraken/driver.html?testName=audio-fft) 14:48:41 INFO - PROCESS | 4345 | RSS: Main: 264638464 14:48:41 INFO - PROCESS | 4345 | 14:48:43 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48894/tests/kraken/driver.html?testName=audio-oscillator) 14:48:43 INFO - PROCESS | 4345 | RSS: Main: 171167744 14:48:43 INFO - PROCESS | 4345 | 14:48:45 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:46 INFO - PROCESS | 4345 | RSS: Main: 173404160 14:48:46 INFO - PROCESS | 4345 | 14:48:49 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48894/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:49 INFO - PROCESS | 4345 | RSS: Main: 212983808 14:48:49 INFO - PROCESS | 4345 | 14:48:53 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48894/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:53 INFO - PROCESS | 4345 | RSS: Main: 211238912 14:48:53 INFO - PROCESS | 4345 | 14:48:56 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48894/tests/kraken/driver.html?testName=json-parse-financial) 14:48:57 INFO - PROCESS | 4345 | RSS: Main: 210501632 14:48:57 INFO - PROCESS | 4345 | 14:48:58 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:59 INFO - PROCESS | 4345 | RSS: Main: 172560384 14:48:59 INFO - PROCESS | 4345 | 14:49:00 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:49:01 INFO - PROCESS | 4345 | RSS: Main: 179138560 14:49:01 INFO - PROCESS | 4345 | 14:49:03 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:49:04 INFO - PROCESS | 4345 | RSS: Main: 188448768 14:49:04 INFO - PROCESS | 4345 | 14:49:06 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:49:07 INFO - PROCESS | 4345 | RSS: Main: 197169152 14:49:07 INFO - PROCESS | 4345 | 14:49:10 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:49:10 INFO - PROCESS | 4345 | RSS: Main: 194187264 14:49:10 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:48894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48894/tests/kraken/driver.html?testName=ai-astar) 14:49:12 INFO - PROCESS | 4345 | RSS: Main: 244252672 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | __start_tp_report 14:49:12 INFO - PROCESS | 4345 | _x_x_mozilla_page_load 14:49:12 INFO - PROCESS | 4345 | _x_x_mozilla_page_load_details 14:49:12 INFO - PROCESS | 4345 | |i|pagename|runs| 14:49:12 INFO - PROCESS | 4345 | |0;ai-astar;102;110;113;110;111;111;111;114;111;111 14:49:12 INFO - PROCESS | 4345 | |1;audio-beat-detection;145;118;119;155;119;121;118;117;148;119 14:49:12 INFO - PROCESS | 4345 | |2;audio-dft;161;162;159;160;162;159;160;159;160;163 14:49:12 INFO - PROCESS | 4345 | |3;audio-fft;76;75;76;114;76;79;76;77;105;78 14:49:12 INFO - PROCESS | 4345 | |4;audio-oscillator;82;81;110;82;82;82;97;82;82;113 14:49:12 INFO - PROCESS | 4345 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;116 14:49:12 INFO - PROCESS | 4345 | |6;imaging-darkroom;147;146;147;146;147;147;146;146;147;147 14:49:12 INFO - PROCESS | 4345 | |7;imaging-desaturate;86;84;85;85;85;85;84;84;86;86 14:49:12 INFO - PROCESS | 4345 | |8;json-parse-financial;51;50;52;50;52;49;49;49;50;50 14:49:12 INFO - PROCESS | 4345 | |9;json-stringify-tinderbox;60;61;59;60;62;60;63;60;60;60 14:49:12 INFO - PROCESS | 4345 | |10;stanford-crypto-aes;76;75;76;76;76;85;76;75;78;81 14:49:12 INFO - PROCESS | 4345 | |11;stanford-crypto-ccm;127;138;131;130;132;123;124;123;178;127 14:49:12 INFO - PROCESS | 4345 | |12;stanford-crypto-pbkdf2;166;157;158;156;157;157;158;160;156;161 14:49:12 INFO - PROCESS | 4345 | |13;stanford-crypto-sha256-iterative;64;68;64;64;63;63;63;62;62;65 14:49:12 INFO - PROCESS | 4345 | __end_tp_report 14:49:12 INFO - PROCESS | 4345 | __start_cc_report 14:49:12 INFO - PROCESS | 4345 | _x_x_mozilla_cycle_collect,1562 14:49:12 INFO - PROCESS | 4345 | __end_cc_report 14:49:12 INFO - PROCESS | 4345 | __startTimestamp1486766952606__endTimestamp 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | ------- Summary: start ------- 14:49:12 INFO - PROCESS | 4345 | Number of tests: 14 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:1.32 14:49:12 INFO - PROCESS | 4345 | Values: 102.0 110.0 113.0 110.0 111.0 111.0 111.0 114.0 111.0 111.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:120.00 stddev:15.02 (12.5%) stddev-sans-first:14.60 14:49:12 INFO - PROCESS | 4345 | Values: 145.0 118.0 119.0 155.0 119.0 121.0 118.0 117.0 148.0 119.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 14:49:12 INFO - PROCESS | 4345 | Values: 161.0 162.0 159.0 160.0 162.0 159.0 160.0 159.0 160.0 163.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:14.07 (18.5%) stddev-sans-first:14.68 14:49:12 INFO - PROCESS | 4345 | Values: 76.0 75.0 76.0 114.0 76.0 79.0 76.0 77.0 105.0 78.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:12.64 (15.4%) stddev-sans-first:13.13 14:49:12 INFO - PROCESS | 4345 | Values: 82.0 81.0 110.0 82.0 82.0 82.0 97.0 82.0 82.0 113.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:49:12 INFO - PROCESS | 4345 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:49:12 INFO - PROCESS | 4345 | Values: 147.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 14:49:12 INFO - PROCESS | 4345 | Values: 86.0 84.0 85.0 85.0 85.0 85.0 84.0 84.0 86.0 86.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.14 (2.3%) stddev-sans-first:1.17 14:49:12 INFO - PROCESS | 4345 | Values: 51.0 50.0 52.0 50.0 52.0 49.0 49.0 49.0 50.0 50.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:1.18 (2.0%) stddev-sans-first:1.24 14:49:12 INFO - PROCESS | 4345 | Values: 60.0 61.0 59.0 60.0 62.0 60.0 63.0 60.0 60.0 60.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:76.00 stddev:3.20 (4.2%) stddev-sans-first:3.36 14:49:12 INFO - PROCESS | 4345 | Values: 76.0 75.0 76.0 76.0 76.0 85.0 76.0 75.0 78.0 81.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:130.50 stddev:16.38 (12.6%) stddev-sans-first:17.22 14:49:12 INFO - PROCESS | 4345 | Values: 127.0 138.0 131.0 130.0 132.0 123.0 124.0 123.0 178.0 127.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.00 stddev:3.06 (1.9%) stddev-sans-first:1.72 14:49:12 INFO - PROCESS | 4345 | Values: 166.0 157.0 158.0 156.0 157.0 157.0 158.0 160.0 156.0 161.0 14:49:12 INFO - PROCESS | 4345 | 14:49:12 INFO - PROCESS | 4345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.75 (2.7%) stddev-sans-first:1.86 14:49:12 INFO - PROCESS | 4345 | Values: 64.0 68.0 64.0 64.0 63.0 63.0 63.0 62.0 62.0 65.0 14:49:12 INFO - PROCESS | 4345 | -------- Summary: end -------- 14:49:12 INFO - PROCESS | 4345 | 14:49:13 INFO - TEST-INFO | 4345: exit 0 14:49:13 INFO - TEST-OK | kraken | took 60090ms 14:49:13 INFO - SUITE-END | took 1175s 14:49:13 INFO - Completed test suite (00:19:35) 14:49:13 INFO - javascript benchmark 14:49:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3219.67803219678, 3257.65794591568, 3265.4611989021805, 3292.0617623977173, 3294.6705329467054, 5493.2034854946005, 5596.860078498029, 5617.9438205617935, 5625.0, 5642.915356269659, 5584.888302233953, 5653.180288858123, 5673.546116310696, 5674.943250567493, 5692.0608099663505, 5103.106956282654, 5123.154679477901, 5155.329807125068, 5170.172772356424, 5192.688438693672, 5031.823886163985, 5189.792408303663, 5211.765470553834, 5223.71269580173, 5225.634205605609, 5003.724795136266, 5103.795848166069, 5112.105381558231, 5127.154019586764, 5151.716655583941, 5155.432902380754, 5194.4805519447755, 5198.610104242178, 5261.552768014723, 5276.7889284428575, 5114.130597798383, 5158.587313014949, 5239.79040838366, 5243.632945693803, 5274.525292723635, 5337.733113344318, 5350.571954243651, 5485.369182544018, 5532.1425179097305, 5541.0, 5979.760809567612, 5997.0, 6008.879822403571, 6082.026875699911, 6093.421124993119, 6105.8168254952425, 6122.418370254819, 6128.693565321761, 6137.938620613826, 6148.477379422754, 5457.754401051962, 5485.588580856452, 5497.780088796403, 5555.388907220203, 5560.443955604407, 6065.727042283108, 6098.939010609837, 6103.664298463627, 6116.938830611637, 6124.540659450559, 5863.179154918314, 5863.442972917566, 5871.911921321183, 5874.530037596982, 5875.441833025941, 5749.3963133871175, 5796.652200867961, 5875.41245875409, 5912.881742365214, 5913.49735272498, 5947.851303717355, 5957.195778569838, 5960.37416071315, 5992.221011268507, 5998.910016349758, 5901.144334071621, 5943.435373639584, 5963.522918166536, 5966.492848107872, 5969.343372229051, 4445.644348452181, 4470.441194850644, 4563.315502674625, 4582.175208462442, 4609.262517997105, 4108.856190033334, 4112.794360281974, 4115.794210289474, 4137.379393091001, 4152.086540960984, 5749.310082790008, 5749.850029993934, 5752.626079304916, 5757.165211044375, 5762.625429347079, 5751.9424805751405, 5790.276215473066, 5904.232449781501, 6015.729292181863, 6022.759089636453, 5672.347680016768, 5739.282589676291, 5748.597598168171, 5766.336871259775, 5773.336066352339, 5131.384233891957, 5136.049830781242, 5139.486051394831, 5146.047981123429, 5169.147090729987, 5979.790707325223, 6095.725692343944, 6233.906491402633, 6282.246130464465, 6283.434490895841, 5957.195778569838, 5967.731452084579, 5990.6705131218205, 6035.36628653985, 6099.237595300588, 6286.717097730704, 6292.498327525378, 6327.303996560467, 6328.177336946167, 6331.176946996861, 5649.4633009864, 5923.141144534105, 5941.881162376815, 5944.910826337695, 5945.821625351246, 5747.8563035924435, 5885.117232415001, 5896.410358964069, 5908.468237858441, 6025.457708806229, 5824.5631577631, 5864.765409383747, 5870.677112758839, 5871.794487193099, 5882.352941176553, 5841.211436456024, 5850.619709719025, 5850.912236316373, 5852.795152169653, 5855.59010869235, 5465.562754979672, 5569.248151499496, 5714.3999880012, 5739.311282646109, 5748.48263656273, 5903.2325797646035, 5908.113782932594, 5912.438318359921, 5913.231279933581, 5937.584369094122, 5577.944220557904, 5616.1856530803625, 5762.481376676119, 5769.278840144982, 5772.797952071657], "value": 5524.646279430519, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2501872584367, 609.0954931926091, 634.6699716147602, 645.4062262718298, 653.9634679033732, 33109.33781324372, 44236.778816105914, 44930.55069449309, 45126.0, 45166.54833451673, 44813.327800083025, 44993.0, 45106.0, 45141.0, 45320.3201951971, 8268.131846156157, 9014.233790127848, 9172.08279172084, 9173.58718857653, 9174.357794954356, 8286.958565207196, 8485.278751306147, 8492.957535212316, 10630.521626526786, 10890.836637450444, 11005.064569511602, 11031.944840275788, 11053.502592383322, 11063.834042489369, 11075.446227688624, 10919.12646988239, 10958.890411095907, 10969.506372213269, 10976.451177441097, 11006.449677516131, 10820.0, 10865.619703310345, 10865.891341086566, 10874.401907895062, 10883.346999180074, 43122.0, 43394.78302608467, 43400.0, 43407.782961084995, 43446.56553434457, 3556.946645800315, 3791.6018818023986, 3796.8481260749536, 3808.847646094153, 4256.2764330063965, 31946.520802187984, 32697.6730232697, 32846.17884552881, 33010.66989330124, 33657.0, 4412.867613971586, 4451.706139719209, 4482.731036137842, 4517.59341659249, 4560.361549383089, 317305.0, 319425.0, 321694.0, 321911.0, 322730.9999999977, 37848.24303513969, 60443.09335359973, 60908.69545652244, 60941.39058609446, 61191.69404152951, 37753.244935101146, 40457.190856182715, 40508.59491405107, 40544.79727601343, 40562.79718601447, 17024.14879256032, 17284.0, 17305.0, 17318.047507386964, 17326.56683582895, 12970.80543791844, 14328.283585820876, 14410.783838242434, 14512.782308265385, 14578.635534111732, 8782.780430489289, 9025.368224224372, 9157.587908544132, 9181.0, 9451.763705907408, 3593.5328407306883, 3597.334493118781, 3617.5297211362354, 3620.4388319810473, 3671.4492826076303, 1034.04350975349, 1044.289882879634, 1092.721356054217, 1121.2655710509466, 1125.2854437432127, 33296.3340733184, 33707.0, 33781.0, 33846.0, 34252.486212706826, 1132.0773569540963, 1149.4252873563219, 1163.4473625028045, 1216.793145165324, 1257.8805013523884, 17444.0, 17462.912685436746, 17565.473035808947, 17704.911475442797, 17768.644627107384, 501343.0, 505187.0, 506085.0, 508026.0, 508838.0, 59187.40812591819, 59220.70389648024, 59385.0, 59728.0, 60053.0, 1300.5708116321591, 1303.8565757766637, 1391.7146984868077, 1417.1426287096365, 1427.2792239918774, 31816.36367272688, 32981.340373191924, 33560.66439335576, 34100.82949585236, 34310.313793723486, 51249.23126153036, 51758.74120629373, 51768.223476648636, 51832.740836295576, 51919.480805191466, 371277.0, 374026.0, 375794.0, 376136.0, 457710.0, 24958.75041249637, 29633.259168520097, 29741.85129074341, 31408.68591314149, 31691.0, 47569.52430475789, 47750.0, 48334.0, 48784.75607621939, 49105.50894491009, 41303.58696412997, 41305.1738965225, 41747.58252417558, 43018.56981430146, 43050.35424468573, 40666.0, 42081.57918420777, 42373.576264238196, 43528.0, 43607.56392436162, 40947.38578921378, 41234.0, 42614.0, 42626.78686606547, 42848.35727464153, 35085.82457087698, 36929.44605830861, 37241.62758372381, 37348.43977340397, 37529.4370584436, 27783.0, 27886.0, 28275.0, 28355.716442835306, 28532.286692832844], "value": 19759.55191324946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.3774027659893, 433.1575086456843, 438.47602115472006, 445.1630933844372, 448.20220008385087, 18323.26706931723, 18381.81618183816, 19578.608427831434, 19772.406827795152, 19779.604407911833, 19597.706034409497, 19748.70376944347, 19790.40628781135, 20355.59288814223, 20361.490962725904, 5674.432556744334, 5931.436513531207, 5939.55453340999, 5940.2277703898435, 5944.4352786485215, 5754.482096611304, 5838.620489668179, 5847.941520584804, 5957.374475680056, 6190.81427557174, 6292.0876472911405, 6298.055291706258, 6306.243250809909, 6309.242890853104, 6314.273858506284, 6300.30696623371, 6378.107065010902, 6732.29310922351, 6735.225449073346, 6796.728130874759, 5250.159974404077, 6085.300190478108, 6085.4827339676185, 6093.969530152321, 6095.695215239265, 14655.193964331958, 14806.259687015714, 21437.0, 22670.773292267033, 23551.29346119619, 2371.454565449939, 2454.914078007279, 2572.897084116633, 2718.4563087382603, 3008.39832033592, 10311.22665800068, 10609.68170954865, 10817.621383251548, 10897.455127243606, 11233.269837460539, 1944.980550194494, 1973.9703904441444, 1976.5355141541727, 1980.9405717828488, 2030.6953956906434, 80142.0, 81042.59478702628, 82484.17515824825, 82721.17278827255, 84538.57730711368, 11508.309501429942, 11559.942200289113, 11666.88333116675, 11684.47419866108, 11886.821697674543, 16880.324787008383, 16906.74639880403, 16914.83085169157, 16915.40796072156, 16922.74615880763, 8441.831163376699, 8608.440451370641, 8641.265492433213, 8672.783180420414, 8710.608022638997, 8361.540115293596, 8385.916140838635, 8451.732240164025, 8588.39881208322, 8603.354748393895, 4834.516548345137, 4984.40187177541, 5119.360079990001, 5139.486051394831, 5253.789848406097, 2091.4248581639868, 2115.9894200528897, 2145.581611585757, 2180.400389892792, 2188.89055547222, 987.2586261475105, 991.980160396788, 1048.9055984961237, 1076.7361996310954, 1114.9777004459866, 19616.411507654793, 20287.0, 20557.177712891316, 20578.897105514377, 20637.89681051615, 1005.5676059294574, 1023.7338292044122, 1031.7265924530006, 1032.9431881246603, 1038.8182068138046, 10410.167186625053, 11146.665600032013, 11218.997836157616, 11285.887141128484, 11352.602658907064, 443234.0, 448017.0, 462632.0, 468681.0, 469871.0, 59411.10883336667, 64245.678771605846, 86085.0, 87235.69146462808, 90875.0, 1018.5060245780791, 1038.2524582300732, 1049.637874933162, 1057.5241141486208, 1061.0609610494769, 16746.1626918656, 16830.242639081516, 17083.40208092711, 17694.469165925042, 18079.36722214716, 28361.14916552507, 30222.54666180053, 41067.58932410757, 42071.57928420799, 42426.575734242266, 58499.34760764426, 58947.70526147342, 59474.405255946884, 60136.69931650314, 60656.69671651613, 8586.356023298153, 8600.612972416382, 8883.333749968908, 8894.466332019842, 8994.955025224832, 9595.376300540442, 12599.055070869537, 13211.471541138248, 13224.140430871963, 13320.400581973641, 10623.521941512805, 10727.463626818784, 10832.0, 10840.186985976241, 10961.397123157984, 10944.616938407118, 11286.379249141377, 11347.943260283646, 11659.358735269303, 11776.941115294369, 10328.896711033094, 11210.430539724608, 11297.15271354668, 11325.830112548154, 11342.97913187817, 7647.158812530506, 8127.918720812716, 8178.672853086048, 8432.241098301183, 9102.0, 10046.246531510313, 10234.0, 10381.480925953823, 10400.27198096126, 10594.4702764863], "value": 9347.066455620405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.1162750026226, 1543.9614009649758, 1552.9378824847004, 1750.8249175082494, 1865.5242913057177, 7864.803379915498, 8369.790755231123, 8482.660693572258, 8871.290296776258, 8894.73315800527, 8667.566621668922, 8974.461532308065, 8978.685745998891, 8979.41633793803, 8988.460692358463, 2412.059296874216, 2453.0800949643885, 2454.3250606083293, 2454.5581795276844, 2455.4475243070347, 2456.226288719057, 2486.689163854518, 2488.228649118779, 2488.6764720586298, 2491.4394261291245, 2409.5421869844763, 2411.3730430088217, 2411.807055435561, 2439.865807380593, 2450.9754902451014, 2379.89290481927, 2385.6779334789753, 2404.663347131403, 2412.0472413396697, 2414.0, 2322.291701031185, 2342.320726989171, 2362.7637236276405, 2363.314638754759, 2367.9408014799596, 8710.172533609297, 8774.692885749031, 8824.338174636929, 8842.823143537158, 8862.335324850597, 5269.0, 5451.400345961941, 5455.5908306877145, 5458.563314934835, 5468.152436372368, 3605.2248766515327, 3627.72792040598, 3704.9444258335875, 3715.7956312402807, 3796.1648437343742, 1164.1443538998915, 1180.1208099965581, 1193.9820902686467, 1220.6033039262275, 1223.131576580629, 12380.071494637938, 12702.237865728086, 12711.68220794469, 12719.93640031794, 12722.10945233834, 4781.617470602343, 4922.261660750916, 4974.253861920741, 4989.725565093955, 5017.272495488134, 10759.408232547285, 10768.246222764332, 10773.946130269298, 10780.94609526963, 10781.676549703521, 5628.690422026828, 5630.774769009194, 5631.971840140773, 5635.492805647511, 5637.943620563824, 4147.0, 4453.354263631755, 4603.608693261111, 5103.7192954387865, 5126.5898728101665, 4246.893827654333, 4259.8083086261195, 4311.439512863308, 4346.8043938022865, 4373.868783936423, 1342.8183198785007, 1371.3280492558574, 1372.766629672958, 1381.550995926308, 1394.065975796219, 975.7999610079917, 978.3493976505687, 1001.2390583156853, 1016.3292227130058, 1023.8054769593754, 6005.0, 6027.939720602738, 6127.479164271087, 6156.6921653917125, 6157.107219453154, 906.1255888068046, 921.8110287391069, 933.5658918602883, 962.4706411473661, 994.6866736977973, 3938.7242892997215, 4099.508059032935, 4102.077032667626, 4170.4995400551525, 4181.268278051329, 10667.359958402521, 10771.138308935424, 10954.452277386099, 11063.391513466837, 11094.223404361617, 10794.892051079389, 11016.394098324508, 11025.173112016631, 11025.6141035065, 11041.558337666404, 8424.620892059873, 8538.188872057144, 8617.052124266325, 8619.267362274151, 8624.956875215585, 5786.161006654096, 5792.478676919098, 5908.438698323653, 5936.495397891227, 5994.28068631767, 10208.336458130198, 10276.434796086287, 10283.07452329294, 10339.483025848527, 10349.223808214565, 9107.453552786854, 9303.255739540957, 9946.900530994886, 10304.278700490893, 10327.586896524355, 7752.4573279869865, 7893.802654933673, 7950.642221099949, 7950.880736789069, 8061.556614386265, 8684.0, 8698.738682891071, 8722.65109395617, 8748.606312715816, 8783.956080219557, 7591.0, 7659.923400765921, 7744.961275193813, 7798.571078590505, 7845.3723702104835, 7617.124030736314, 7730.033745781778, 7731.304182623591, 7782.455228133977, 7813.3749300057, 7231.710731570678, 7285.927140728737, 7354.411647068328, 7363.447741419308, 7370.742024029133, 5342.252084708066, 5380.515753582196, 5410.161424979135, 5431.34823821144, 5474.8357549272, 5200.6619569727845, 5298.549623282064, 5341.732913354394, 5377.838664840061, 5456.672599644034], "value": 4777.3929372430275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8735068024831, 356.0, 356.47598030894585, 358.1529682301358, 361.9384704600218, 5148.536631703146, 5279.472052794728, 5313.734313284335, 5375.75809088591, 5383.246345511631, 5123.180291153416, 5227.947720522794, 5244.0, 5244.449332820056, 5258.973705131479, 4213.873583792491, 4219.2405367033925, 4224.640905523019, 4224.809883555247, 4242.533321334666, 3993.6605388542007, 4160.167966406731, 4226.577342265779, 4227.281362168439, 4228.5982831630945, 4110.91778164438, 4127.772972486512, 4164.063085805685, 4165.937510937339, 4177.770222637754, 4111.368724016632, 4125.257453658341, 4143.047099167194, 4145.859888530663, 4179.749215047107, 3596.7841929484316, 3669.3945498992903, 3699.6300369963055, 3714.8699795507296, 3729.198222382201, 5126.871828204287, 5135.639055650256, 5158.690478571298, 5160.303359046518, 5162.277281180638, 4734.526547345238, 4740.454847692525, 4747.548982846624, 4777.378940737682, 4781.6891902026255, 5368.355797304349, 5471.206675032138, 5482.945170548283, 5523.392426833045, 5526.171074338841, 4040.2323558523785, 4064.1465292288653, 4068.816903239361, 4069.3895915612893, 4078.9796051019853, 5654.717264136777, 5670.461306175906, 5698.6865722385255, 5704.716438801278, 5747.425257474303, 4019.698522610757, 4146.543880173179, 4153.7507749535125, 4155.210510003089, 4177.1411721784125, 4235.385869048971, 4237.216115018731, 4240.0, 4245.257080011047, 4256.0, 4730.88172795676, 4757.191277482836, 4767.356406885026, 4811.254255590389, 4813.927791083137, 5379.596530260246, 5525.806596769094, 5561.332640083135, 5601.243832082698, 5610.551155907518, 1336.2383441438287, 1356.891448684103, 1378.620879258192, 1406.521782593923, 1411.2097225553723, 952.6522819171091, 974.1476208317722, 974.8683927669815, 992.3301771304341, 996.003996003996, 5130.999455106218, 5142.6914385137015, 5167.586593072545, 5204.9219261711105, 5224.190250511177, 5425.80632260902, 5466.644668096561, 5467.45325467458, 5477.342718873681, 5479.6164268500825, 5148.536631703165, 5214.869628259324, 5216.660917040456, 5238.345206849144, 5494.80768173112, 2903.274181454636, 2903.941921161565, 2926.590277361171, 2931.9560206596916, 2949.8967536136133, 5704.543636509069, 5735.0, 5758.712064396764, 5761.337446193657, 5766.3368712598585, 5445.972770136124, 5521.67479804844, 5555.722213889289, 5577.386487486373, 5604.3835178130375, 5733.71331433435, 5734.885302293931, 5739.282589676291, 5741.382928754858, 5770.798022069207, 5355.116405793156, 5491.75287112073, 5521.254630624814, 5529.253550770755, 5588.776448941997, 5388.892222155457, 5408.188256933814, 5439.9456005441025, 5461.180822876441, 5473.101574091245, 5705.088795253637, 5725.484706376279, 5730.163569033355, 5735.8566035849435, 5798.507126894261, 4013.979930100331, 4030.3551431770775, 4031.4154447604346, 4214.388913607571, 4241.34259189826, 5441.619086663895, 5574.191742197439, 5638.351589567253, 5663.688497132697, 5678.4605462480995, 5449.621234834428, 5456.972715136399, 5578.71272778159, 5589.469000444951, 5616.297962754656, 5536.283752036881, 5594.832155035356, 5604.663720176803, 5622.8313150605545, 5641.182028605911, 5324.4675532446445, 5473.8357849264585, 5504.284443022381, 5507.889842203213, 5535.391106978149, 5544.833654990357, 5582.358028826575, 5606.971965140148, 5607.691576963143, 5624.184493248375, 5463.53559947393, 5470.0, 5479.369872464717, 5480.287562616834, 5490.80782172638], "value": 4227.547784473693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.3002587748659, 812.7033632724053, 822.2106777493606, 824.332290844416, 897.358388752043, 14780.704385912275, 15001.549953501413, 15002.0, 15155.696886062273, 15253.847461525382, 13381.330933453337, 14766.335514901828, 14809.11145331281, 14906.925465372686, 14942.252887355644, 857.9485230886152, 872.97817554561, 874.2350443362059, 874.2830878679486, 874.5321253129576, 849.3290300662469, 850.7702920211539, 851.2338894994492, 851.5827244650108, 860.8106216632331, 878.6485405837684, 879.2218886285619, 880.8986966498838, 881.7575166829141, 883.3595643158691, 873.3057219510505, 874.2787200559532, 876.3427429427898, 876.3821505838432, 876.8071024374691, 653.4478365780908, 660.7257987935001, 662.7050962321769, 663.698017402081, 664.2825748191989, 13370.598882033555, 13610.251436171007, 13700.040997130205, 13716.177029378268, 13742.175469471764, 12217.389130543526, 12375.886170244632, 12880.291583962879, 12883.806742898863, 12975.675608109872, 10977.451127443675, 10979.560817567288, 11091.112710983101, 11245.83131253032, 11290.435478226056, 3793.1655035892336, 3798.696104311676, 3847.8460861565504, 3877.806109694504, 3899.610038996106, 55468.445315547135, 56948.14577781336, 57376.42623573794, 60146.0, 63619.0, 11640.243384180001, 11676.76646467066, 11771.882281177079, 11928.284302941851, 12057.457414416373, 20356.0, 20380.592388152152, 20523.17907283692, 20808.79191208099, 21186.15255389798, 8519.190676885686, 8521.318294536422, 8539.231469167804, 8615.138486151334, 8967.551622418852, 4558.703684260512, 4575.794089265991, 4581.129585378767, 4663.417072865892, 4741.241401375763, 3395.0833275015607, 3529.6470352964498, 3532.116970757311, 3534.452159915217, 3537.0980399998352, 621.9129321894939, 636.7707625254905, 643.7135474713801, 646.1309538670481, 648.9740410383532, 727.3453891497588, 741.4142827166478, 742.8699977503916, 768.8462307538402, 775.9573223472763, 9476.857847132298, 9641.662541811003, 9793.167580755573, 9841.360311579725, 9908.7027389177, 655.3217419970308, 713.8144082538473, 733.9559626422432, 750.2307257192175, 754.7509321923752, 4326.63223625989, 4585.862424127282, 4604.355390245369, 4659.813607455664, 4709.62323014158, 84223.5788821052, 85968.0, 86725.0, 89134.55432722924, 93828.0617193833, 49283.0, 63653.0, 79580.0, 80139.59930200312, 80633.59683201664, 58497.70751146217, 67922.66038669775, 68583.31416685769, 68892.3110768886, 70787.64606176937, 8829.558522073743, 9696.5636546357, 10110.747231319276, 10149.289549731448, 10235.692929212135, 32256.516152257267, 42524.362134568626, 44809.327860081474, 45605.543944561454, 46312.30531542097, 51095.74452127864, 61395.38604613897, 62280.0, 63509.364906352195, 63773.0, 10275.537600807833, 10600.628977985734, 10651.0, 10718.303310284806, 11129.554817807197, 11644.767104658029, 13321.200727956353, 13798.310084495935, 14192.929035354757, 14459.493917713251, 12617.558385456465, 13823.79264311016, 14126.364313606118, 14219.0, 14282.285885705882, 12183.695407614881, 12424.378781061092, 13822.892011465014, 13914.791278131039, 13975.930120349332, 13333.466661333438, 13750.793738094137, 13842.169469831842, 13952.16287022782, 14185.0, 11191.776164476501, 11307.547698091985, 11316.15128865322, 11483.712907177387, 11530.538778449103, 11065.391403472886, 11493.68244483915, 11701.473433695333, 11789.76420471603, 11954.282743035446], "value": 7216.970898812134, "unit": "score"}], "name": "dromaeo_css", "value": 7279.010882439237, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 113.0, 110.0, 111.0, 111.0, 111.0, 114.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 119.0, 155.0, 119.0, 121.0, 118.0, 117.0, 148.0, 119.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 160.0, 162.0, 159.0, 160.0, 159.0, 160.0, 163.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 114.0, 76.0, 79.0, 76.0, 77.0, 105.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 82.0, 82.0, 82.0, 97.0, 82.0, 82.0, 113.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 86.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 50.0, 52.0, 49.0, 49.0, 49.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 62.0, 60.0, 63.0, 60.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 76.0, 85.0, 76.0, 75.0, 78.0, 81.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 138.0, 131.0, 130.0, 132.0, 123.0, 124.0, 123.0, 178.0, 127.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 157.0, 158.0, 156.0, 157.0, 157.0, 158.0, 160.0, 156.0, 161.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 64.0, 64.0, 63.0, 63.0, 63.0, 62.0, 62.0, 65.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1463.3, "alertThreshold": 2.0}]} 14:49:13 INFO - Return code: 0 14:49:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:49:13 INFO - # TBPL SUCCESS # 14:49:13 INFO - Running post-action listener: _resource_record_post_action 14:49:13 INFO - [mozharness: 2017-02-10 22:49:13.922783Z] Finished run-tests step (success) 14:49:13 INFO - Running post-run listener: _resource_record_post_run 14:49:13 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322113536; Read time: 16; Write time: 190700 14:49:13 INFO - TinderboxPrint: CPU usage
13.0% 14:49:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:49:13 INFO - TinderboxPrint: I/O write bytes / time
322,113,536 / 190,700 14:49:13 INFO - TinderboxPrint: CPU idle
8,259.2 (87.0%) 14:49:13 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 14:49:13 INFO - TinderboxPrint: Swap in / out
0 / 0 14:49:13 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101023744; Read time: 0; Write time: 61520 14:49:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221089792; Read time: 16; Write time: 129180 14:49:14 INFO - Running post-run listener: _upload_blobber_files 14:49:14 INFO - Blob upload gear active. 14:49:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:49:14 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 14:49:14 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:49:14 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:49:14 INFO - (blobuploader) - INFO - Open directory for files ... 14:49:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:49:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:49:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:18 INFO - (blobuploader) - INFO - Done attempting. 14:49:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:49:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:19 INFO - (blobuploader) - INFO - Done attempting. 14:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:19 INFO - (blobuploader) - INFO - Done attempting. 14:49:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:19 INFO - Return code: 0 14:49:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:49:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/157870b703213bdf3038a101f6c28b5e9815237e3ee69f8f4566193f5d331318302db1eafc3ac65cc717912021f45902cb56dfbcb14b28e95c2042e766871e36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/809104b2bbb722827886c6a0a2bf958174b16be7ffb7af7e9b41c35f179c6f031ec7504f6b2a07be59dc3757955bb5ddbfc5bf8fd191111808e28bc00fa813d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9d690cf7a89e420e704ae53e67b4ac31ec25b84232aab5d9f4a243da20fa2d268990dcf7ec89bf8892ad4709a35e8e43cf19f70d851eb8c19bbac13fd29e15"} 14:49:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:49:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:49:19 INFO - Contents: 14:49:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/157870b703213bdf3038a101f6c28b5e9815237e3ee69f8f4566193f5d331318302db1eafc3ac65cc717912021f45902cb56dfbcb14b28e95c2042e766871e36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/809104b2bbb722827886c6a0a2bf958174b16be7ffb7af7e9b41c35f179c6f031ec7504f6b2a07be59dc3757955bb5ddbfc5bf8fd191111808e28bc00fa813d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9d690cf7a89e420e704ae53e67b4ac31ec25b84232aab5d9f4a243da20fa2d268990dcf7ec89bf8892ad4709a35e8e43cf19f70d851eb8c19bbac13fd29e15"} 14:49:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:19 INFO - Copying logs to upload dir... 14:49:19 INFO - mkdir: /builds/slave/test/build/upload/logs 14:49:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.836208 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-10 14:49:19.438156) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:49:19.446029) ========= 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=52faae308a556c440401f8e5000001e8-1486764764.395598-424435108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/157870b703213bdf3038a101f6c28b5e9815237e3ee69f8f4566193f5d331318302db1eafc3ac65cc717912021f45902cb56dfbcb14b28e95c2042e766871e36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/809104b2bbb722827886c6a0a2bf958174b16be7ffb7af7e9b41c35f179c6f031ec7504f6b2a07be59dc3757955bb5ddbfc5bf8fd191111808e28bc00fa813d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9d690cf7a89e420e704ae53e67b4ac31ec25b84232aab5d9f4a243da20fa2d268990dcf7ec89bf8892ad4709a35e8e43cf19f70d851eb8c19bbac13fd29e15"} build_url:https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/OBVVQUdeRQ6XdSaxpuYDcw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/157870b703213bdf3038a101f6c28b5e9815237e3ee69f8f4566193f5d331318302db1eafc3ac65cc717912021f45902cb56dfbcb14b28e95c2042e766871e36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/809104b2bbb722827886c6a0a2bf958174b16be7ffb7af7e9b41c35f179c6f031ec7504f6b2a07be59dc3757955bb5ddbfc5bf8fd191111808e28bc00fa813d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9d690cf7a89e420e704ae53e67b4ac31ec25b84232aab5d9f4a243da20fa2d268990dcf7ec89bf8892ad4709a35e8e43cf19f70d851eb8c19bbac13fd29e15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:49:19.473824) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:49:19.474186) ========= 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=52faae308a556c440401f8e5000001e8-1486764764.395598-424435108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:49:19.559680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:49:19.560053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:49:19.560397) ========= ========= Total master_lag: 0.18 =========