builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1475360878.68 results: success (0) buildid: 20161001140056 builduid: c662ee81b72940c1a74adc2002f36ae7 revision: d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.676982) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.677504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.677827) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.697338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.697659) ========= 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=4300f881736b422476174874000001bc-1475359532.513902-257154763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 15:27:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-10-01 15:27:59 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151036 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.874958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.875370) ========= 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=4300f881736b422476174874000001bc-1475359532.513902-257154763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015413 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:27:58.939385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 15:27:58.939766) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373 --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=4300f881736b422476174874000001bc-1475359532.513902-257154763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 15:27:59,415 truncating revision to first 12 chars 2016-10-01 15:27:59,415 Setting DEBUG logging. 2016-10-01 15:27:59,415 attempt 1/10 2016-10-01 15:27:59,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1fd56faaeb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 15:28:00,690 unpacking tar archive at: mozilla-central-d1fd56faaeb9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 15:28:00.553193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 15:28:00.553975) ========= script_repo_revision: d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 15:28:00.555016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 15:28:00.555755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 15:28:00.567677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-01 15:28:00.568001) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1475359532.513902-257154763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:01 INFO - MultiFileLogger online at 20161001 15:28:01 in /builds/slave/test 15:28:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:28:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:01 INFO - {'append_to_log': False, 15:28:01 INFO - 'base_work_dir': '/builds/slave/test', 15:28:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:28:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:01 INFO - 'branch': 'Firefox-Non-PGO', 15:28:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:01 INFO - 'config_files': ('talos/linux_config.py',), 15:28:01 INFO - 'default_actions': ('clobber', 15:28:01 INFO - 'read-buildbot-config', 15:28:01 INFO - 'download-and-extract', 15:28:01 INFO - 'populate-webroot', 15:28:01 INFO - 'create-virtualenv', 15:28:01 INFO - 'install', 15:28:01 INFO - 'run-tests'), 15:28:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:01 INFO - 'download_minidump_stackwalk': True, 15:28:01 INFO - 'download_symbols': 'ondemand', 15:28:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:01 INFO - 'installer_path': 'installer.exe', 15:28:01 INFO - 'log_level': 'info', 15:28:01 INFO - 'log_name': 'talos', 15:28:01 INFO - 'log_to_console': True, 15:28:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:01 INFO - 'opt_config_files': (), 15:28:01 INFO - 'pip_index': False, 15:28:01 INFO - 'sps_profile': False, 15:28:01 INFO - 'sps_profile_interval': 0, 15:28:01 INFO - 'suite': 'dromaeojs', 15:28:01 INFO - 'system_bits': '32', 15:28:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:01 INFO - 'title': 'talos-linux64-ix-045', 15:28:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:01 INFO - 'use_talos_json': True, 15:28:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:01 INFO - 'work_dir': 'build'} 15:28:01 INFO - [mozharness: 2016-10-01 22:28:01.137682Z] Running clobber step. 15:28:01 INFO - Running pre-action listener: _resource_record_pre_action 15:28:01 INFO - Running main action method: clobber 15:28:01 INFO - rmtree: /builds/slave/test/build 15:28:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:01 INFO - Running post-action listener: _resource_record_post_action 15:28:01 INFO - [mozharness: 2016-10-01 22:28:01.597694Z] Finished clobber step (success) 15:28:01 INFO - [mozharness: 2016-10-01 22:28:01.597793Z] Running read-buildbot-config step. 15:28:01 INFO - Running pre-action listener: _resource_record_pre_action 15:28:01 INFO - Running main action method: read_buildbot_config 15:28:01 INFO - Using buildbot properties: 15:28:01 INFO - { 15:28:01 INFO - "project": "", 15:28:01 INFO - "product": "firefox", 15:28:01 INFO - "script_repo_revision": "production", 15:28:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:28:01 INFO - "repository": "", 15:28:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:28:01 INFO - "buildid": "20161001140056", 15:28:01 INFO - "pgo_build": "False", 15:28:01 INFO - "basedir": "/builds/slave/test", 15:28:01 INFO - "buildnumber": 228, 15:28:01 INFO - "slavename": "talos-linux64-ix-045", 15:28:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:28:01 INFO - "platform": "ubuntu64_hw", 15:28:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:28:01 INFO - "branch": "mozilla-central", 15:28:01 INFO - "repo_path": "mozilla-central", 15:28:01 INFO - "revision": "d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373", 15:28:01 INFO - "stage_platform": "linux64", 15:28:01 INFO - "builduid": "c662ee81b72940c1a74adc2002f36ae7", 15:28:01 INFO - "slavebuilddir": "test" 15:28:01 INFO - } 15:28:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:28:01 INFO - Running post-action listener: _resource_record_post_action 15:28:01 INFO - [mozharness: 2016-10-01 22:28:01.600203Z] Finished read-buildbot-config step (success) 15:28:01 INFO - [mozharness: 2016-10-01 22:28:01.600291Z] Running download-and-extract step. 15:28:01 INFO - Running pre-action listener: _resource_record_pre_action 15:28:01 INFO - Running main action method: download_and_extract 15:28:01 INFO - mkdir: /builds/slave/test/build/tests 15:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:01 INFO - trying https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:28:01 INFO - Downloading https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:28:02 INFO - Downloaded 1361 bytes. 15:28:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:28:02 INFO - Using the following test package requirements: 15:28:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:28:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:28:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'jsshell-linux-x86_64.zip'], 15:28:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:28:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:28:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:28:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:28:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:28:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:28:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:28:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:28:02 INFO - Fetch https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:28:02 INFO - Http code: 200 15:28:02 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 15:28:02 INFO - x-amz-cf-id: MqOI_QCW9g_pyGVutuHBIQr5YG2vicJbzH5H24xnyluQ8lpjf3dc4Q== 15:28:02 INFO - x-amz-version-id: f7aKIfqQX4YnEZAOX6.BP0QQVq7Fx_gC 15:28:02 INFO - Expected file size: 20419727 15:28:02 INFO - Obtained file size: 20419727 15:28:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:28:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:28:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:28:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:28:07 INFO - Http code: 200 15:28:07 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 15:28:07 INFO - x-amz-cf-id: 1UAc17NMMN5odrw_8WxYQNJKGtCGlSZf_MWzOJsLlX7xazvIiMESRA== 15:28:07 INFO - x-amz-version-id: f7aKIfqQX4YnEZAOX6.BP0QQVq7Fx_gC 15:28:07 INFO - Expected file size: 20419727 15:28:07 INFO - Obtained file size: 20419727 15:28:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:28:12 INFO - Fetch https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:28:12 INFO - Http code: 200 15:28:12 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 15:28:12 INFO - x-amz-cf-id: 1W8_FFOfktdf3759975zQUI77UlTFRFc7XE3q6K5Qnx7cbPP12k7bQ== 15:28:12 INFO - x-amz-version-id: jAUIwQx0JYBx7fs0aReHHJHh6TOCKwm0 15:28:13 INFO - Expected file size: 14408522 15:28:13 INFO - Obtained file size: 14408522 15:28: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')]} 15:28:13 INFO - trying https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:28:14 INFO - Downloaded 55813067 bytes. 15:28:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:28:14 INFO - mkdir: /builds/slave/test/properties 15:28:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:28:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:28:14 INFO - Contents: 15:28:14 INFO - build_url:https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:28:15 INFO - Running post-action listener: _resource_record_post_action 15:28:15 INFO - Running post-action listener: set_extra_try_arguments 15:28:15 INFO - [mozharness: 2016-10-01 22:28:15.432782Z] Finished download-and-extract step (success) 15:28:15 INFO - [mozharness: 2016-10-01 22:28:15.433006Z] Running populate-webroot step. 15:28:15 INFO - Running pre-action listener: _resource_record_pre_action 15:28:15 INFO - Running main action method: populate_webroot 15:28:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:15 INFO - '--tppagecycles', 15:28:15 INFO - '7'], 15:28:15 INFO - 'tests': ['tsvgm']}}, 15:28:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:28:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:28:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:28:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['damp', 'tps']}, 15:28:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'tests': ['damp', 'tps']}, 15:28:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['dromaeo_dom']}, 15:28:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['basic_compositor_video']}, 15:28:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:28:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['a11yr', 15:28:15 INFO - 'ts_paint', 15:28:15 INFO - 'tpaint', 15:28:15 INFO - 'sessionrestore', 15:28:15 INFO - 'sessionrestore_no_auto_restore', 15:28:15 INFO - 'tabpaint']}, 15:28:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:28:15 INFO - 'ts_paint', 15:28:15 INFO - 'tpaint', 15:28:15 INFO - 'sessionrestore', 15:28:15 INFO - 'sessionrestore_no_auto_restore', 15:28:15 INFO - 'tabpaint']}, 15:28:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:28:15 INFO - 'ts_paint', 15:28:15 INFO - 'tpaint', 15:28:15 INFO - 'sessionrestore', 15:28:15 INFO - 'sessionrestore_no_auto_restore', 15:28:15 INFO - 'tabpaint']}, 15:28:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:28:15 INFO - 'ts_paint', 15:28:15 INFO - 'tpaint', 15:28:15 INFO - 'sessionrestore', 15:28:15 INFO - 'sessionrestore_no_auto_restore', 15:28:15 INFO - 'tabpaint']}, 15:28:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['a11yr', 15:28:15 INFO - 'ts_paint', 15:28:15 INFO - 'tpaint', 15:28:15 INFO - 'sessionrestore', 15:28:15 INFO - 'sessionrestore_no_auto_restore', 15:28:15 INFO - 'tabpaint']}, 15:28:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['a11yr', 15:28:15 INFO - 'ts_paint', 15:28:15 INFO - 'tpaint', 15:28:15 INFO - 'sessionrestore', 15:28:15 INFO - 'sessionrestore_no_auto_restore', 15:28:15 INFO - 'tabpaint']}, 15:28:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['tsvgx', 15:28:15 INFO - 'tsvgr_opacity', 15:28:15 INFO - 'tart', 15:28:15 INFO - 'tscrollx', 15:28:15 INFO - 'cart']}, 15:28:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:28:15 INFO - 'tsvgr_opacity', 15:28:15 INFO - 'tart', 15:28:15 INFO - 'tscrollx', 15:28:15 INFO - 'cart']}, 15:28:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'talos_options': ['--disable-e10s'], 15:28:15 INFO - 'tests': ['tp5o']}, 15:28:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'tests': ['tp5o']}, 15:28:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'talos_options': ['--disable-e10s', 15:28:15 INFO - '--xperf_path', 15:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:15 INFO - 'tests': ['tp5n']}, 15:28:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:15 INFO - 'talos_options': ['--xperf_path', 15:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:15 INFO - 'tests': ['tp5n']}}, 15:28:15 INFO - 'talos.zip': {'path': '', 15:28:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:15 INFO - Running post-action listener: _resource_record_post_action 15:28:15 INFO - [mozharness: 2016-10-01 22:28:15.449098Z] Finished populate-webroot step (success) 15:28:15 INFO - [mozharness: 2016-10-01 22:28:15.449186Z] Running create-virtualenv step. 15:28:15 INFO - Running pre-action listener: _resource_record_pre_action 15:28:15 INFO - Running main action method: create_virtualenv 15:28:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:28:15 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 15:28:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:28:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:15 INFO - Using real prefix '/usr' 15:28:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:28:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:18 INFO - Installing pip.................done. 15:28:18 INFO - Return code: 0 15:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:28:18 INFO - Reading from file tmpfile_stdout 15:28:18 INFO - Output received: 15:28:18 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) 15:28:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:28:18 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')]} 15:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:18 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')]} 15:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:18 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:18 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 15:28:18 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 15:28:18 INFO - Using env: {'DISPLAY': ':0', 15:28:18 INFO - 'HOME': '/home/cltbld', 15:28:18 INFO - 'LANG': 'en_US.UTF-8', 15:28:18 INFO - 'LANGUAGE': 'en_US:en', 15:28:18 INFO - 'LOGNAME': 'cltbld', 15:28:18 INFO - 'MAIL': '/var/mail/cltbld', 15:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:18 INFO - 'MOZ_NO_REMOTE': '1', 15:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:18 INFO - 'NO_EM_RESTART': '1', 15:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:18 INFO - 'PWD': '/builds/slave/test', 15:28:18 INFO - 'SHELL': '/bin/bash', 15:28:18 INFO - 'SHLVL': '1', 15:28:18 INFO - 'TERM': 'linux', 15:28:18 INFO - 'TMOUT': '86400', 15:28:18 INFO - 'USER': 'cltbld', 15:28:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:18 INFO - '_': '/tools/buildbot/bin/python'} 15:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:18 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 15:28:18 INFO - Cleaning up... 15:28:18 INFO - Return code: 0 15:28:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:28:18 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')]} 15:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:18 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')]} 15:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:18 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:18 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 15:28:18 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 15:28:18 INFO - Using env: {'DISPLAY': ':0', 15:28:18 INFO - 'HOME': '/home/cltbld', 15:28:18 INFO - 'LANG': 'en_US.UTF-8', 15:28:18 INFO - 'LANGUAGE': 'en_US:en', 15:28:18 INFO - 'LOGNAME': 'cltbld', 15:28:18 INFO - 'MAIL': '/var/mail/cltbld', 15:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:18 INFO - 'MOZ_NO_REMOTE': '1', 15:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:18 INFO - 'NO_EM_RESTART': '1', 15:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:18 INFO - 'PWD': '/builds/slave/test', 15:28:18 INFO - 'SHELL': '/bin/bash', 15:28:18 INFO - 'SHLVL': '1', 15:28:18 INFO - 'TERM': 'linux', 15:28:18 INFO - 'TMOUT': '86400', 15:28:18 INFO - 'USER': 'cltbld', 15:28:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:18 INFO - '_': '/tools/buildbot/bin/python'} 15:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:18 INFO - Downloading/unpacking psutil>=3.1.1 15:28:18 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 15:28:18 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 15:28:18 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 15:28:18 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 15:28:18 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 15:28:18 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 15:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:20 INFO - Installing collected packages: psutil 15:28:20 INFO - Running setup.py install for psutil 15:28:20 INFO - building 'psutil._psutil_linux' extension 15:28:20 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 15:28:20 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 15:28:20 INFO - building 'psutil._psutil_posix' extension 15:28:20 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 15:28:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:21 INFO - Successfully installed psutil 15:28:21 INFO - Cleaning up... 15:28:21 INFO - Return code: 0 15:28:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:21 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:21 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 15:28:21 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 15:28:21 INFO - Using env: {'DISPLAY': ':0', 15:28:21 INFO - 'HOME': '/home/cltbld', 15:28:21 INFO - 'LANG': 'en_US.UTF-8', 15:28:21 INFO - 'LANGUAGE': 'en_US:en', 15:28:21 INFO - 'LOGNAME': 'cltbld', 15:28:21 INFO - 'MAIL': '/var/mail/cltbld', 15:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:21 INFO - 'MOZ_NO_REMOTE': '1', 15:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:21 INFO - 'NO_EM_RESTART': '1', 15:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:21 INFO - 'PWD': '/builds/slave/test', 15:28:21 INFO - 'SHELL': '/bin/bash', 15:28:21 INFO - 'SHLVL': '1', 15:28:21 INFO - 'TERM': 'linux', 15:28:21 INFO - 'TMOUT': '86400', 15:28:21 INFO - 'USER': 'cltbld', 15:28:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:21 INFO - '_': '/tools/buildbot/bin/python'} 15:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:28:23 INFO - Installing collected packages: mozsystemmonitor 15:28:23 INFO - Running setup.py install for mozsystemmonitor 15:28:23 INFO - Successfully installed mozsystemmonitor 15:28:23 INFO - Cleaning up... 15:28:23 INFO - Return code: 0 15:28:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:28: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')]} 15:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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')]} 15:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:23 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:23 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 15:28:23 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 15:28:23 INFO - Using env: {'DISPLAY': ':0', 15:28:23 INFO - 'HOME': '/home/cltbld', 15:28:23 INFO - 'LANG': 'en_US.UTF-8', 15:28:23 INFO - 'LANGUAGE': 'en_US:en', 15:28:23 INFO - 'LOGNAME': 'cltbld', 15:28:23 INFO - 'MAIL': '/var/mail/cltbld', 15:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:23 INFO - 'MOZ_NO_REMOTE': '1', 15:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:23 INFO - 'NO_EM_RESTART': '1', 15:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:23 INFO - 'PWD': '/builds/slave/test', 15:28:23 INFO - 'SHELL': '/bin/bash', 15:28:23 INFO - 'SHLVL': '1', 15:28:23 INFO - 'TERM': 'linux', 15:28:23 INFO - 'TMOUT': '86400', 15:28:23 INFO - 'USER': 'cltbld', 15:28:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:23 INFO - '_': '/tools/buildbot/bin/python'} 15:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:28:23 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 15:28:23 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 15:28:23 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 15:28:23 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 15:28:23 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 15:28:23 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 15:28:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:28:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 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 15:28:25 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 15:28:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:28:26 INFO - warning: no files found matching '*.txt' 15:28:26 INFO - no previously-included directories found matching 'build' 15:28:26 INFO - no previously-included directories found matching 'dist' 15:28:26 INFO - no previously-included directories found matching '.git*' 15:28:26 INFO - Installing collected packages: jsonschema, functools32 15:28:26 INFO - Running setup.py install for functools32 15:28:26 INFO - warning: no files found matching '*.txt' 15:28:26 INFO - no previously-included directories found matching 'build' 15:28:26 INFO - no previously-included directories found matching 'dist' 15:28:26 INFO - no previously-included directories found matching '.git*' 15:28:26 INFO - Successfully installed jsonschema functools32 15:28:26 INFO - Cleaning up... 15:28:26 INFO - Return code: 0 15:28:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:28:26 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')]} 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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')]} 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:26 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 15:28:26 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 15:28:26 INFO - Using env: {'DISPLAY': ':0', 15:28:26 INFO - 'HOME': '/home/cltbld', 15:28:26 INFO - 'LANG': 'en_US.UTF-8', 15:28:26 INFO - 'LANGUAGE': 'en_US:en', 15:28:26 INFO - 'LOGNAME': 'cltbld', 15:28:26 INFO - 'MAIL': '/var/mail/cltbld', 15:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:26 INFO - 'MOZ_NO_REMOTE': '1', 15:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:26 INFO - 'NO_EM_RESTART': '1', 15:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:26 INFO - 'PWD': '/builds/slave/test', 15:28:26 INFO - 'SHELL': '/bin/bash', 15:28:26 INFO - 'SHLVL': '1', 15:28:26 INFO - 'TERM': 'linux', 15:28:26 INFO - 'TMOUT': '86400', 15:28:26 INFO - 'USER': 'cltbld', 15:28:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:26 INFO - '_': '/tools/buildbot/bin/python'} 15:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:28:26 INFO - Cleaning up... 15:28:26 INFO - Return code: 0 15:28:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:28:26 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')]} 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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')]} 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:26 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 15:28:26 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 15:28:26 INFO - Using env: {'DISPLAY': ':0', 15:28:26 INFO - 'HOME': '/home/cltbld', 15:28:26 INFO - 'LANG': 'en_US.UTF-8', 15:28:26 INFO - 'LANGUAGE': 'en_US:en', 15:28:26 INFO - 'LOGNAME': 'cltbld', 15:28:26 INFO - 'MAIL': '/var/mail/cltbld', 15:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:26 INFO - 'MOZ_NO_REMOTE': '1', 15:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:26 INFO - 'NO_EM_RESTART': '1', 15:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:26 INFO - 'PWD': '/builds/slave/test', 15:28:26 INFO - 'SHELL': '/bin/bash', 15:28:26 INFO - 'SHLVL': '1', 15:28:26 INFO - 'TERM': 'linux', 15:28:26 INFO - 'TMOUT': '86400', 15:28:26 INFO - 'USER': 'cltbld', 15:28:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:26 INFO - '_': '/tools/buildbot/bin/python'} 15:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:28 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 15:28:28 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 15:28:28 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 15:28:28 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 15:28:28 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 15:28:28 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 15:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:28:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:29 INFO - Downloading docopt-0.6.1.tar.gz 15:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:29 INFO - Running setup.py install for blobuploader 15:28:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:28:29 INFO - Running setup.py install for requests 15:28:29 INFO - Running setup.py install for docopt 15:28:30 INFO - Successfully installed blobuploader requests docopt 15:28:30 INFO - Cleaning up... 15:28:30 INFO - Return code: 0 15:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:28:30 INFO - Using env: {'DISPLAY': ':0', 15:28:30 INFO - 'HOME': '/home/cltbld', 15:28:30 INFO - 'LANG': 'en_US.UTF-8', 15:28:30 INFO - 'LANGUAGE': 'en_US:en', 15:28:30 INFO - 'LOGNAME': 'cltbld', 15:28:30 INFO - 'MAIL': '/var/mail/cltbld', 15:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:30 INFO - 'MOZ_NO_REMOTE': '1', 15:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:30 INFO - 'NO_EM_RESTART': '1', 15:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:30 INFO - 'PWD': '/builds/slave/test', 15:28:30 INFO - 'SHELL': '/bin/bash', 15:28:30 INFO - 'SHLVL': '1', 15:28:30 INFO - 'TERM': 'linux', 15:28:30 INFO - 'TMOUT': '86400', 15:28:30 INFO - 'USER': 'cltbld', 15:28:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:30 INFO - '_': '/tools/buildbot/bin/python'} 15:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:30 INFO - Running setup.py (path:/tmp/pip-NyYlzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:30 INFO - Running setup.py (path:/tmp/pip-loTieo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:30 INFO - Running setup.py (path:/tmp/pip-4Q7Sep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:30 INFO - Running setup.py (path:/tmp/pip-_xgJFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:30 INFO - Running setup.py (path:/tmp/pip-0LDbx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:30 INFO - Running setup.py (path:/tmp/pip-mlqimA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:30 INFO - Running setup.py (path:/tmp/pip-xhPS0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:30 INFO - Running setup.py (path:/tmp/pip-87FyFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:30 INFO - Running setup.py (path:/tmp/pip-2H0rww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:30 INFO - Running setup.py (path:/tmp/pip-B2QCzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:31 INFO - Running setup.py (path:/tmp/pip-m6FdRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:31 INFO - Running setup.py (path:/tmp/pip-OpeUoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:31 INFO - Running setup.py (path:/tmp/pip-pEbFOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:31 INFO - Running setup.py (path:/tmp/pip-icAtMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:31 INFO - Running setup.py (path:/tmp/pip-SRG87g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:31 INFO - Running setup.py (path:/tmp/pip-ioYZ31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:31 INFO - Running setup.py (path:/tmp/pip-8B4jcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:31 INFO - Running setup.py install for manifestparser 15:28:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:28:31 INFO - Running setup.py install for mozcrash 15:28:31 INFO - Running setup.py install for mozdebug 15:28:31 INFO - Running setup.py install for mozdevice 15:28:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:28:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:28:31 INFO - Running setup.py install for mozfile 15:28:32 INFO - Running setup.py install for mozhttpd 15:28:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Running setup.py install for mozinfo 15:28:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Running setup.py install for mozInstall 15:28:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Running setup.py install for mozleak 15:28:32 INFO - Running setup.py install for mozlog 15:28:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Running setup.py install for moznetwork 15:28:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Running setup.py install for mozprocess 15:28:32 INFO - Running setup.py install for mozprofile 15:28:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:28:32 INFO - Running setup.py install for mozrunner 15:28:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:28:33 INFO - Running setup.py install for mozscreenshot 15:28:33 INFO - Running setup.py install for moztest 15:28:33 INFO - Running setup.py install for mozversion 15:28:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:28:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:28:33 INFO - Cleaning up... 15:28:33 INFO - Return code: 0 15:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:33 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:33 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 15:28:33 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 15:28:33 INFO - Using env: {'DISPLAY': ':0', 15:28:33 INFO - 'HOME': '/home/cltbld', 15:28:33 INFO - 'LANG': 'en_US.UTF-8', 15:28:33 INFO - 'LANGUAGE': 'en_US:en', 15:28:33 INFO - 'LOGNAME': 'cltbld', 15:28:33 INFO - 'MAIL': '/var/mail/cltbld', 15:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:33 INFO - 'MOZ_NO_REMOTE': '1', 15:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:33 INFO - 'NO_EM_RESTART': '1', 15:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:33 INFO - 'PWD': '/builds/slave/test', 15:28:33 INFO - 'SHELL': '/bin/bash', 15:28:33 INFO - 'SHLVL': '1', 15:28:33 INFO - 'TERM': 'linux', 15:28:33 INFO - 'TMOUT': '86400', 15:28:33 INFO - 'USER': 'cltbld', 15:28:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:33 INFO - '_': '/tools/buildbot/bin/python'} 15:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:33 INFO - Running setup.py (path:/tmp/pip-bFbSLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:33 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)) 15:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:33 INFO - Running setup.py (path:/tmp/pip-5amnLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:33 INFO - Running setup.py (path:/tmp/pip-lY_D5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:33 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)) 15:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:33 INFO - Running setup.py (path:/tmp/pip-dxexz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:33 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)) 15:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:33 INFO - Running setup.py (path:/tmp/pip-7jAIb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:33 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)) 15:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:33 INFO - Running setup.py (path:/tmp/pip-oaE3EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:34 INFO - Running setup.py (path:/tmp/pip-qzs5jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:34 INFO - Running setup.py (path:/tmp/pip-U6llQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:34 INFO - Running setup.py (path:/tmp/pip-4En57r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:34 INFO - Running setup.py (path:/tmp/pip-c314ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:34 INFO - Running setup.py (path:/tmp/pip-gSytRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:34 INFO - Running setup.py (path:/tmp/pip-3zh9XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:34 INFO - Running setup.py (path:/tmp/pip-UvBC9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:34 INFO - Running setup.py (path:/tmp/pip-ouxe2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:34 INFO - Running setup.py (path:/tmp/pip-Hvy19W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:34 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)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:34 INFO - Running setup.py (path:/tmp/pip-DK216T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:34 INFO - Running setup.py (path:/tmp/pip-ywNgn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:34 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)) 15:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:28:34 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)) 15:28:34 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)) 15:28:34 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)) 15:28:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:28:34 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 15:28:34 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 15:28:34 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 15:28:34 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 15:28:34 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 15:28:34 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 15:28:36 INFO - Downloading blessings-1.6.tar.gz 15:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:28:36 INFO - Installing collected packages: blessings 15:28:36 INFO - Running setup.py install for blessings 15:28:36 INFO - Successfully installed blessings 15:28:36 INFO - Cleaning up... 15:28:36 INFO - Return code: 0 15:28:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:37 INFO - Reading from file tmpfile_stdout 15:28:37 INFO - Current package versions: 15:28:37 INFO - argparse == 1.2.1 15:28:37 INFO - blessings == 1.6 15:28:37 INFO - blobuploader == 1.2.4 15:28:37 INFO - docopt == 0.6.1 15:28:37 INFO - functools32 == 3.2.3-2 15:28:37 INFO - jsonschema == 2.5.1 15:28:37 INFO - manifestparser == 1.1 15:28:37 INFO - mozInstall == 1.12 15:28:37 INFO - mozcrash == 0.17 15:28:37 INFO - mozdebug == 0.1 15:28:37 INFO - mozdevice == 0.48 15:28:37 INFO - mozfile == 1.2 15:28:37 INFO - mozhttpd == 0.7 15:28:37 INFO - mozinfo == 0.9 15:28:37 INFO - mozleak == 0.1 15:28:37 INFO - mozlog == 3.4 15:28:37 INFO - moznetwork == 0.27 15:28:37 INFO - mozprocess == 0.23 15:28:37 INFO - mozprofile == 0.28 15:28:37 INFO - mozrunner == 6.12 15:28:37 INFO - mozscreenshot == 0.1 15:28:37 INFO - mozsystemmonitor == 0.3 15:28:37 INFO - moztest == 0.7 15:28:37 INFO - mozversion == 1.4 15:28:37 INFO - psutil == 3.1.1 15:28:37 INFO - requests == 1.2.3 15:28:37 INFO - wsgiref == 0.1.2 15:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:37 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:37 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 15:28:37 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 15:28:37 INFO - Using env: {'DISPLAY': ':0', 15:28:37 INFO - 'HOME': '/home/cltbld', 15:28:37 INFO - 'LANG': 'en_US.UTF-8', 15:28:37 INFO - 'LANGUAGE': 'en_US:en', 15:28:37 INFO - 'LOGNAME': 'cltbld', 15:28:37 INFO - 'MAIL': '/var/mail/cltbld', 15:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:37 INFO - 'MOZ_NO_REMOTE': '1', 15:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:37 INFO - 'NO_EM_RESTART': '1', 15:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:37 INFO - 'PWD': '/builds/slave/test', 15:28:37 INFO - 'SHELL': '/bin/bash', 15:28:37 INFO - 'SHLVL': '1', 15:28:37 INFO - 'TERM': 'linux', 15:28:37 INFO - 'TMOUT': '86400', 15:28:37 INFO - 'USER': 'cltbld', 15:28:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:37 INFO - '_': '/tools/buildbot/bin/python'} 15:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 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)) 15:28:37 INFO - Cleaning up... 15:28:37 INFO - Return code: 0 15:28:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:37 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 0x7fd8b7f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, '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': '4300f881736b422476174874000001bc-1475359532.513902-257154763', '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 15:28:37 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 15:28:37 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 15:28:37 INFO - Using env: {'DISPLAY': ':0', 15:28:37 INFO - 'HOME': '/home/cltbld', 15:28:37 INFO - 'LANG': 'en_US.UTF-8', 15:28:37 INFO - 'LANGUAGE': 'en_US:en', 15:28:37 INFO - 'LOGNAME': 'cltbld', 15:28:37 INFO - 'MAIL': '/var/mail/cltbld', 15:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:37 INFO - 'MOZ_NO_REMOTE': '1', 15:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:37 INFO - 'NO_EM_RESTART': '1', 15:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:37 INFO - 'PWD': '/builds/slave/test', 15:28:37 INFO - 'SHELL': '/bin/bash', 15:28:37 INFO - 'SHLVL': '1', 15:28:37 INFO - 'TERM': 'linux', 15:28:37 INFO - 'TMOUT': '86400', 15:28:37 INFO - 'USER': 'cltbld', 15:28:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:37 INFO - '_': '/tools/buildbot/bin/python'} 15:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:28:37 INFO - Cleaning up... 15:28:37 INFO - Return code: 0 15:28:37 INFO - Running post-action listener: _resource_record_post_action 15:28:37 INFO - Running post-action listener: _start_resource_monitoring 15:28:37 INFO - Starting resource monitoring. 15:28:37 INFO - [mozharness: 2016-10-01 22:28:37.688040Z] Finished create-virtualenv step (success) 15:28:37 INFO - [mozharness: 2016-10-01 22:28:37.688500Z] Running install step. 15:28:37 INFO - Running pre-action listener: _resource_record_pre_action 15:28:37 INFO - Running main action method: install 15:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:37 INFO - Reading from file tmpfile_stdout 15:28:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:28:37 INFO - Reading from file tmpfile_stdout 15:28:37 INFO - Output received: 15:28:37 INFO - Usage: mozinstall [options] installer 15:28:37 INFO - Options: 15:28:37 INFO - -h, --help show this help message and exit 15:28:37 INFO - -d DEST, --destination=DEST 15:28:37 INFO - Directory to install application into. [default: 15:28:37 INFO - "/builds/slave/test"] 15:28:37 INFO - --app=APP Application being installed. [default: firefox] 15:28:37 INFO - mkdir: /builds/slave/test/build/application 15:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:28:54 INFO - Reading from file tmpfile_stdout 15:28:54 INFO - Output received: 15:28:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:28:54 INFO - Running post-action listener: _resource_record_post_action 15:28:54 INFO - [mozharness: 2016-10-01 22:28:54.116985Z] Finished install step (success) 15:28:54 INFO - [mozharness: 2016-10-01 22:28:54.117228Z] Running run-tests step. 15:28:54 INFO - Running pre-action listener: _resource_record_pre_action 15:28:54 INFO - Running main action method: run_tests 15:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:28:54 INFO - Python 2.7.3 15:28:54 INFO - Return code: 0 15:28:54 INFO - grabbing minidump binary from tooltool 15:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:54 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 0x18c2f60>, '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 0x18c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:28:54 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 15:28:54 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 15:28:54 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 15:28:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:28:54 INFO - Return code: 0 15:28:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:28:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:28:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:28:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:28:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 15:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 15:28:54 INFO - Using env: {'DISPLAY': ':0', 15:28:54 INFO - 'HOME': '/home/cltbld', 15:28:54 INFO - 'LANG': 'en_US.UTF-8', 15:28:54 INFO - 'LANGUAGE': 'en_US:en', 15:28:54 INFO - 'LOGNAME': 'cltbld', 15:28:54 INFO - 'MAIL': '/var/mail/cltbld', 15:28:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:28:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:54 INFO - 'MOZ_NO_REMOTE': '1', 15:28:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:54 INFO - 'NO_EM_RESTART': '1', 15:28:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:54 INFO - 'PWD': '/builds/slave/test', 15:28:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:28:54 INFO - 'SHELL': '/bin/bash', 15:28:54 INFO - 'SHLVL': '1', 15:28:54 INFO - 'TERM': 'linux', 15:28:54 INFO - 'TMOUT': '86400', 15:28:54 INFO - 'USER': 'cltbld', 15:28:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1475359532.513902-257154763', 15:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:54 INFO - '_': '/tools/buildbot/bin/python'} 15:28:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 15:28:54 INFO - mozversion application_buildid: 20161001140056 15:28:54 INFO - mozversion application_changeset: d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373 15:28:54 INFO - mozversion application_display_name: Nightly 15:28:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:28:54 INFO - mozversion application_name: Firefox 15:28:54 INFO - mozversion application_remotingname: firefox 15:28:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:28:54 INFO - mozversion application_vendor: Mozilla 15:28:54 INFO - mozversion application_version: 52.0a1 15:28:54 INFO - mozversion platform_buildid: 20161001140056 15:28:54 INFO - mozversion platform_changeset: d1fd56faaeb92f9c931e6a85d61b0e22a1ff4373 15:28:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:28:54 INFO - mozversion platform_version: 52.0a1 15:28:54 INFO - using testdate: 1475360934 15:28:54 INFO - actual date: 1475360934 15:28:54 INFO - starting webserver on 'localhost:60072' 15:28:54 INFO - SUITE-START | Running 2 tests 15:28:54 INFO - TEST-START | dromaeo_css 15:28:54 INFO - operating with platform_type : linux_ 15:28:54 INFO - Initialising browser for dromaeo_css test... 15:28:54 INFO - TEST-INFO | started process 18124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2cU8Z/profile http://localhost:60072/getInfo.html) 15:28:59 INFO - PROCESS | 18124 | __metrics Screen width/height:1600/1200 15:28:59 INFO - PROCESS | 18124 | colorDepth:24 15:28:59 INFO - PROCESS | 18124 | Browser inner width/height: 1024/697 15:28:59 INFO - PROCESS | 18124 | __metrics 15:28:59 INFO - PROCESS | 18124 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:28:59 INFO - PROCESS | 18124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:00 INFO - PROCESS | 18124 | console.error: PushService: 15:29:00 INFO - PROCESS | 18124 | stateChangeProcessEnqueue: Error transitioning state 15:29:00 INFO - PROCESS | 18124 | UnknownError 15:29:00 INFO - TEST-INFO | 18124: exit 0 15:29:00 INFO - Browser initialized. 15:29:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:29:00 INFO - TEST-INFO | started process 18206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2cU8Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:13 INFO - PROCESS | 18206 | RSS: Main: 175521792 15:29:13 INFO - PROCESS | 18206 | 15:30:04 INFO - PROCESS | 18206 | 1475361004104 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:32:19 INFO - PROCESS | 18206 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60072/tests/dromaeo/cssquery-ext.html) 15:32:20 INFO - PROCESS | 18206 | RSS: Main: 261607424 15:32:20 INFO - PROCESS | 18206 | 15:35:22 INFO - PROCESS | 18206 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-ext.html (next: http://localhost:60072/tests/dromaeo/cssquery-jquery.html) 15:35:23 INFO - PROCESS | 18206 | RSS: Main: 270438400 15:35:23 INFO - PROCESS | 18206 | 15:38:25 INFO - PROCESS | 18206 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60072/tests/dromaeo/cssquery-mootools.html) 15:38:26 INFO - PROCESS | 18206 | RSS: Main: 218341376 15:38:26 INFO - PROCESS | 18206 | 15:41:28 INFO - PROCESS | 18206 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60072/tests/dromaeo/cssquery-prototype.html) 15:41:29 INFO - PROCESS | 18206 | RSS: Main: 219512832 15:41:29 INFO - PROCESS | 18206 | 15:44:32 INFO - PROCESS | 18206 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60072/tests/dromaeo/cssquery-yui.html) 15:44:32 INFO - PROCESS | 18206 | RSS: Main: 222253056 15:44:32 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | Cycle 1(1): loaded http://localhost:60072/tests/dromaeo/cssquery-yui.html (next: http://localhost:60072/tests/dromaeo/cssquery-dojo.html) 15:47:35 INFO - PROCESS | 18206 | RSS: Main: 311230464 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | __start_tp_report 15:47:35 INFO - PROCESS | 18206 | _x_x_mozilla_page_load 15:47:35 INFO - PROCESS | 18206 | _x_x_mozilla_page_load_details 15:47:35 INFO - PROCESS | 18206 | |i|pagename|runs| 15:47:35 INFO - PROCESS | 18206 | |0;dojo.html;2576.0339872547793;2636.1827833371644;2661.1085286429047;2668.2262143978246;2681.7720493758015;4690.718556886589;4778.9044219115685;4794.328793968843;4864.513548645134;4906.681065730725;4805.423349198092;4878.170710979133;4918.975405122969;4971.030649023442;4998.7250701211415;4281.7002809803325;4295.140971805636;4330.783460826962;4350.6519478441805;4352.934705979413;4398.626116780078;4424.756638384888;4433.091216300667;4435.8225670973125;4480.955190448102;4370.125974805052;4464.977675111603;4474.8433804817005;4485.484169320521;4573.588377046065;4383.473983122046;4400.031992961543;4413.426254586883;4499.707519011286;4505.144022635722;4402.603765661106;4407.07451435199;4462.085272519158;4464.821407143743;4486.4616246050355;4786.186348320759;4797.544233297831;4834.129856625806;4838.080764654739;4908.9263661045115;5025.924611130836;5086.694798312114;5158.3552055993005;5162.716050617215;5167.147420675584;5219.034478621429;5221.503957124067;5230.895382092375;5270.104082305978;5291.86770330741;4865;4870.537298956593;4875.414950205998;4875.756212189376;4937.703737775745;5108.489151084862;5176.3270774799785;5338.813141540028;5340.893182136336;5341.679499230058;5028.622853286018;5032.647714659939;5077.822276220389;5128.897422051538;5130.230465430215;5086.135356989321;5111.5655169310285;5187.221916712523;5188.143956247177;5252.501012403892;4964.726940018334;5117.232415137684;5140.588752899834;5155.716435596079;5160.92258616121;5032.622553308516;5126;5158.845234642967;5180.637355385087;5196.142636465017;4429.424174857248;4435.756033418128;4446.644268458515;4453.51011388747;4504.977475112669;3746;3861.304965106308;3866.7293289469467;3893.162969961472;3921.7254792164845;4369.453818272716;4487.798049087799;4523.140603285431;4537.6143027842345;4589.426321709786;5259.815906443256;5286.36563612369;5299.708516031656;5300.178472336794;5303.893922121536;4532.9320060199125;4535.138323718483;4538.977305113453;4577.7482238477205;4595.747233902168;4565.771711414416;4603.033362993809;4606.838760643362;4670.346151538787;4674.205385084544;4885.828995985124;4895.853124406273;4924.089043526959;4932.926006109983;4957.330760347307;5232.136697444879;5235.738213089254;5237.921431178459;5247.947520524746;5307.01820163271;4758;4803.471618121934;4876.171050921281;4883.462819089968;4886.486918873609;5101.744912754421;5118.078745825638;5137.974310128426;5152.355955505562;5227.320448341843;5192.24712416705;5194.454582268807;5230.241614965885;5238.869028274171;5296.841094767009;4861.465238823655;5079.11115554769;5084.872878178076;5089.923651145162;5091.236314552699;4879.585235255043;4993.051320249287;5061.342025536656;5080.187170052774;5148.76830542634;4978.4025916890205;4986.950130498793;4987.027529631687;4995.600351971761;5056.266841307916;4938.061768264019;4978.228374601942;4981.227909674007;5052.873678158076;5088.033273677989;4978.30303757467;4978.47725988766;4987.226979818134;5024.045431368028;5060.1903695408555 15:47:35 INFO - PROCESS | 18206 | |1;ext.html;556.2268446858865;562.7242651100961;573.1374281706031;573.7848306884919;578.0260261459441;28095.578566321496;42131.57868421315;43753.343699844525;43787.78106109469;43880.78059609706;40162;40386;40616.59383406172;40625.18749625013;40686.38970415439;7458.888116678268;7608.6195690215545;7608.771736847903;7614.695412183533;7615.46691731579;7159.964200179018;7359.264073592652;9527.618895244183;9754.951225243864;9756.853647195263;9961.750956226117;10086.596536138546;10089.596416143382;10092;10094;9849.90150098497;9904.702858914172;9916.950415247878;9918.05778451046;9921.702348929544;9735.247655422021;9738.853917191247;9818.116369526777;9824.656137035241;9825.803483930282;37439;37746.81126594377;37756;37763;37767.43348849769;2966.8813247470075;3074.8770049198006;3097.349556593118;3154.463741164008;3331.3503866745996;28364.858175709196;28440.71559284422;28850.42299154026;28884.42231155365;29130.271743206376;3012.4426981008364;3046.588710524073;3110.1602567306927;3205.759568032407;3214.6624604416434;247848;248102;248879;248919;250118.99999999817;31204.219894502367;32224.19439514031;51927.74036129871;52137.2179417309;52171.47828521742;34056.31887362239;34118.48822267668;34122.48816267758;34251.486227706606;34266.657333426345;13134.211947283193;13203;13252.072354935255;13260.602181934557;13265.867341326657;8828.293736501064;9047.638094476148;10683.14534837211;10716.464176791129;10729.62446314391;7656.73201437947;7976.122626511079;7988.081370642451;8044.074931382849;8071.4349995500925;3105.3323535439536;3120.3632930173967;3149.653538110806;3153.6373317068833;3196;837.8994520657438;902.4224496322358;902.6434558349547;964.4984608003799;977.3354119198871;26981;27530.724692753218;27676.30809229745;28324.575131373047;28397.432051358857;954.2556805691572;975.531744762518;994.5723338964315;1027.1885210683627;1029.917606591471;13832.654183645489;14863.33115009827;14898.106113633217;14919;15072.54782356531;348686;350740;351106;352850;353655;48779;49071.75464122728;49091.263631045564;49214.261786073235;49311.260331095065;1125.7579620381657;1169.1640477058943;1170.5025364220173;1193.3376975778353;1196.1925700152535;26473.073442429424;27043;27567.586486202323;27971.021014264403;28006;42302.36546451867;42645;42674;42739.78630106829;42754.572454276306;307621;308777;309262;309436;309870;21574;22245.666315004964;24479.877600612595;25420.237392878244;25460.236192914243;39171.41242881416;39721.60278397179;39764;43939.78030109829;44224.77887610541;35500.11249718778;35586.82206588951;35616;35666.46500302549;36076.27847442984;35344.29311413706;35399;35422.29155416826;35857.46213806847;36009.459858101625;31630.525542117346;34061.48907766435;34586.13534661553;35261.471077934366;35538.28923421465;30406.239844004078;33018.834905825315;33084.503732443554;33140.502892457116;33299.500507491925;24351.634725479485;25048;25126.874365628053;25204.369890752878;25451.490970180123 15:47:35 INFO - PROCESS | 18206 | |2;jquery.html;364.77201748906936;373.9177380976185;376.8341929550998;383.08251737089654;383.8541354285371;15366;15570.299336529855;16884.831151688493;16999.49001529953;17018.48944531666;14445.422183112689;17007.23467443965;17160.742588861176;17200.483985480423;17215.741763873553;4888.340074090006;5142.305788718531;5152.124138896378;5159.303494028314;5160.56135228506;4886;4959.082569724595;5043.394792624872;5054.721990290533;5056.443791182967;5092.770825312869;5115.872103197431;5117.02776472469;5119.12974794284;5124.897502049976;4891.266310053485;5101.566366858821;5104.3619547556555;5106.540411362995;5109.846704598868;4449.79975901082;4484.215262329079;4514;4533.659975501851;4535.387722657432;19826.603467930705;20132.49668758278;20158.49603759903;20217.191312347488;20490.795092049037;1828.9908550457162;1879.877807942493;2054.9280775172797;2357.846739961897;2406.566817972782;12526.874731252754;12901.483940642363;13087.607371778862;13160.53938112171;13530.526431574946;1741.2338571028833;1821.6174603333316;1836.40316897009;1993.3521605478277;2009.5378063045582;65091.67454162699;67204.6639766803;67425.3257467424;68338;68548.31451685469;9244.583993720298;9380.29647776406;9382.48396338208;9525.095115963972;9618.615255389846;12346.382680865921;12353.3823308836;12361.690957726129;12366;12389.194702344319;6562.146920900253;6903.689333979983;7021.087258656444;7040.964795175992;7071.752488662872;6698.765543205965;6747.763828265987;6828.760993365208;6959.617221052789;7033.507654464241;3850.172212974224;3888.669463095612;3934.7048971327263;4155.625993660585;4447;1817.8729187903584;1877.643247782917;1892.924283028691;1906.7997860224755;1912.2789489459597;742.524784138152;864.5849992003748;892.7634176943116;907.682311191091;938.2634631814129;16244;16526.83473165277;16849.494515164566;17041.659166816593;17789.110544472984;850.5067061104545;858.5020688000944;859.6991053131479;861.4486728493769;907.1971305394641;9215.400998935047;9357.812843743088;9408.294377921684;9714.174295184988;9929.751756206153;364835;366599;368295;375216;376017;73119;73565.26434735584;74760.62619686975;74862.25137748553;75015;876.093243492969;883.5582208895552;911.3711539038043;914.8261830252363;915.1900567997237;11164.553417863195;14722.55832325032;15068.849311506745;15862.7620585689;16041.117738524026;34298.48552271668;34737.82631086828;35659.28681426409;36785.26429471449;36867.81566092152;41849.790751047265;43190.56809431865;43935.56064439443;44312.77843610761;46406.53593464022;6551.934480655133;7012.964935175291;7101.928980710127;7308.5614863108385;7503.737369192052;9668.178204852666;9674.661386851427;10576.726003909196;10917.617883374043;10995.725106872393;9494.192993595621;9666.565004574952;9852.113309802153;9869.753256168653;10041.011043723774;9667.661631842851;9771.413715177112;9821.85267220978;9942.801143977225;9995.800083998425;9005.909940900769;9244.260459163384;9535.094166054214;9603.991580883907;9657.372270802376;6871.793846184622;7135.785926422215;7280.162781280221;7283.8543229136185;7318.414526837733;8247.505149691038;9464.290178236797;9535.046495350409;9598.808023839623;10014.19886409071 15:47:35 INFO - PROCESS | 18206 | |3;mootools.html;1379.6619828142107;1396.322783450027;1499.3927459378956;1691.0783622925505;1734.6964281250778;6928.653567321639;7211.855762884752;7541.773746787591;8038.879416808745;8066.757997260084;7476.962615186916;7789.688412463494;7792.727254546092;7954.602269886512;7955.363570914327;2175.0647221694703;2193.3419974007816;2203.592335417945;2205.702230198927;2214.5017371091535;1808.3670715249689;1879.0229080877934;2010.7386039814803;2136.903839327234;2145.313499680103;2174.249883790098;2200.9779902200935;2204.096320508592;2206.6138425775507;2207.459172502739;2131.445824085749;2140.5183833637384;2146.6350720377495;2192.2217612747563;2192.3861318830754;2116.3650904728675;2124.5113623866596;2154.116812107044;2158.201465457775;2163.0482587661377;7993.560354180518;8084.959575202145;8087.312578430781;8092.878606820902;8101.230383113595;4385.451818522684;4586.839460618862;4586.839460618896;4594.310853371988;4607.7004994675235;2785.6517935258094;2931.4869897767803;3002.489576771954;3007.08283973388;3014.201236672284;899.1907283444887;901.9729408117767;908.2597682888425;920.052346083535;921.7373048681161;11127;11132.220744547885;11144.554217831359;11148.108151347873;11154.386508742016;4181.937270940938;4194.454720886265;4313;4326.480822301344;4458.4426946631675;8433;8488.490690558463;8547.444416112932;8550.144985501525;8555.871661925075;4516.593506584423;4548.204064288736;4549.772511374418;4550.817967281338;4551.0215303709865;4119.073208528057;4195.475565554306;4218.831246750157;4226.894327641833;4231;3154.747620190379;3246.642869284377;3265.1837040739815;3273.083536609753;3386.559747232844;877.3113106211594;898.4788822482944;944.7118628818276;945.2579724915907;954.9045095490395;743.1750756660103;759.4683721395046;790.5335851847437;804.1917872538179;843.9240468357877;4829.203181475087;4863.829765958245;4910;4938.160512712848;4938.753062346868;418;432.7684688691535;434.72612254280233;443.3726277317559;584.5937073733714;3223.113643747988;3224.774265801418;3246.5617141686043;3308.8841890534195;3363.899083027513;9112.726618201332;9539.618415263312;9611.183049440875;9902.851457228147;9939.65211217604;9717.416954982582;9839.311248212556;9852.753681158028;9861.063198996084;9864.802703946025;7298.56208627484;7483.4013278937555;7544.509606875536;7547.849043019109;7555.206703296185;5070.391553013662;5100.795968161232;5126.487351264844;5133.255677926754;5391.110466773095;8951.149640784115;9003.324750643596;9017.81964360696;9121.498317592595;9139.771505712144;8688.913110869064;9191.954040229755;9208.401453905475;9290.442573445614;9336.533173341442;6682.899756503753;6766.560173588701;6788.219354774066;6914.170299563883;6922.584644921119;7593.430492713179;7639.923600764144;7651.234876512527;7651.311381975649;7658.425618078778;6385.45723613498;6439.549231553934;6514.73941042353;6546.378094081055;6692.431143352869;6234.532410069172;6533.952489385103;6688.83277918056;6890.827729306808;6996.160460744743;5895.233619629592;6003.729832157476;6027.035674292092;6032.245969253843;6038.879222415615;4306.913861722685;4388.934165987449;4454.376387305844;4459.576340247671;4461.286194209041;4135.19363724083;4434.157510073076;4443.866683999485;4491.505934347154;4501.07727915783 15:47:35 INFO - PROCESS | 18206 | |4;prototype.html;297.28799525137293;302.08920105880776;305.9770517211209;312.5873846522591;313.9058282515243;4841.636877234208;4873.610111191105;4886.584640305574;4902.926456103161;4932.802687892489;4826.975865120669;4834.9033019339595;4876.805437553097;4883.218685010399;4906.509349065092;3859.7105217108688;3876.4960555127795;3882.3594106972314;3886.8250928708135;3909.7849618270984;3763.454299126625;3766.9452553284987;3792.3363411403034;3882.320593896071;3896.6687831534355;3807.809609519527;3810.1808111256073;3811.7331786774935;3846.6535413397805;3848.6151384861428;3794.829232684536;3798.6514787250403;3800.992736924717;3811.256804923027;3813.3326667833016;3168.239622490609;3251.479763237894;3291.489819078047;3348.497725341194;3395.5246265522846;4684.508126646687;4696.600788932945;4715.693479923794;4721.693089949176;4730.692504987199;4330.458692663417;4334.414853994702;4346.500152482474;4361.476622805252;4399.978000110011;4738.4550776660435;4815.49437309081;5039.420466646309;5040.36995375578;5048.394192696863;3691.575468821093;3692.7599706019023;3697.9445308320396;3698.1124530112847;3701.167237371597;5293.391260005072;5296.523312901819;5306.416294207634;5318.867028324285;5357.303550538444;3698.7225958053255;3747.793871337048;3761.4578023010436;3776.8866933991476;3810.161764411825;3824.7513911595656;3825.2731980923536;3826.904327391782;3828.789416582059;3852;4303.4190384298345;4339.240632889232;4350.521442641307;4366.3013917773005;4367.148406060851;4955.950440495621;5091.770870310845;5092.668976516515;5093.923591146136;5110;1296.682312833362;1329.2423318708243;1331.9600411987656;1335.9866401336058;1337.5452346202337;842;868.5917618719192;869.556526171657;882.4572887674034;884.6417201033591;4021.3565829467143;4050.311447054008;4060.5939406059156;4070.898227544335;4075.409065685459;4584.862454126382;4596.333531637961;4603.869368829229;4625.468071171791;4629.587975667387;4062.695297852673;4062.7968601569805;4085;4109.6574952277515;4127.587241275848;2491.788198003154;2593.6757905261843;2775.306173456636;2788.1078055022604;2795.2452837734104;4690.507496712864;4763.76181190939;4827.300041493963;4926.137925863031;4956.306117143603;5372.489613486712;5373.650712703662;5374.3013408256675;5387.164989426645;5392.73036348181;4744.644151688706;4937.333459982857;4961.950380496221;4974.179260422062;4975.676581022222;5195.740212989411;5196.077451342876;5212.947870521246;5213.218017297436;5214.634975551827;5148.3564554430695;5178.300929374637;5178.32681751385;5193.532582067632;5201.817936372209;4758.262469317261;4897.534734200245;4960.032793605213;4960.330355402119;4967.652264341461;3657.524521812147;3667.541557305337;3706.6478684524927;3714.9814250929653;3720.5721342046013;5275.630705850554;5308.362996440452;5327.680339179662;5342.813001544927;5351.946480535301;5085.466026067357;5090.760065571137;5188.325517682677;5197.480251974772;5201.855591769805;5069.695818250917;5073.416557095834;5082.669626474268;5085.898282034413;5106.591472682102;4975.577075948585;5006.849794506171;5039.0929632666475;5048.949510504995;5059.45686565601;4934.383202099738;5077.847664570068;5136.5377116059735;5152.3044389007;5196.194589838581;5004.824831130893;5008.148614735576;5014.473480284663;5018.648694591344;5023.246513022929 15:47:35 INFO - PROCESS | 18206 | |5;yui.html;621.285521650102;629.5781826176461;681.5501768832571;697.3793323941693;721.4553012475582;11700.531978720852;12457.563985260518;12477.563285285018;12501.749965000694;12525;12111.394430278473;12180.81728774069;12211.816822747665;12216.45025973831;12238.20451670643;619.2816333053659;637.3817397124782;749.4828568287891;750.8648443280234;765.7664412354229;755.7090520149754;756.6632848382473;757.4394947738689;757.7385801898337;757.8787394016958;813.0203105258149;814.4380377539509;814.9062857771344;815.1481701621819;815.282551354807;646.7348387161288;663.9966800166017;790.8971833661644;807.4105902691039;816.143049797716;592.3839207224481;592.7540070870583;592.8340064781868;592.9288485381738;594.678873408359;11329.773404531863;11367;11382.94308528452;11392.601258955896;11409.885901140966;12472;12934.611961641165;13473.865261347359;13499.460021599125;13627.659308517268;9839.950800246024;9975.800483990279;10072.546735396925;10120.443375614412;10472.109870661003;3226.1128189747774;3233.644299127094;3261.8205998670064;3269.1663625775277;3323.069540528656;63112.368876311106;63712;64807;65193.67403162954;65831.34168658347;9807.166390856715;10041.849322557826;10088;10117.494125293853;10229.641962531425;20344.796552034586;20465.897670511553;20467.79532204659;20478.488037799176;20543.28098516545;6226.470749986302;6257.217847769029;6332.715027823759;6339.334369891188;6370.490360771128;3371.983140084284;3421.4183588789965;3557.964420355815;3617.782933024027;3694.1503454205144;3030.9696903030685;3126.4059828632485;3136.310011797401;3141.104785136225;3152.2277042124824;504.7905119375491;514.4161376837242;523.0428316181454;530.3238371076908;530.9469053094659;499.60609898383103;519.7972790611665;527.1907621800594;533.757140501071;556.9721513924287;7309.269073092754;7470.887936680954;7596.240375962359;7767.572783496962;7959.721409750631;510.9565686916654;524.590819161055;526.6260954722113;545.0298468725674;548.5885585810641;3616.674499295076;3660.213054193361;3680.1351682354625;3760.5111335526753;3793.8103094845146;55723;55767;56967.430325696216;74321;77440;46329.768351158025;46526.53473465222;46569;62489.687551561954;68999.3100068993;67219.66390168018;69120.6543967277;69723;70426;74585;7987.600619968862;8494.447860889022;8533.74398768038;8931.508767017616;8974.237189838937;30543.2364190897;32292.677073228966;40792.592074080065;41963.7901810489;43950.12099758051;53930.73034634802;59922.70038649779;60465.697671513124;60550.69724651348;60659;10084.495775211064;10488.475576221312;10535.841962370723;10568.682939511827;10620.734481637712;11611.825822612498;12237.75524489523;12273.202241854608;12361.62915112548;12650.746985060063;11352.659420217407;11545.909351121421;11649.359285239054;11862.940685296864;12048.51805927753;11224.10207183407;11230.438478076227;11235.382053987109;11663.475143618727;11781.352025638673;11151.72120696989;11467.139964502529;11575.71060723455;11853.703657408634;12203.14577979533;9202.953985230299;9481.383710058824;9503.809923801624;9515.111505988503;9569.28230382738;9067.95466022692;9536.713898583053;9606.298426890064;9647.469389183661;9690.321677482509 15:47:35 INFO - PROCESS | 18206 | __end_tp_report 15:47:35 INFO - PROCESS | 18206 | __start_cc_report 15:47:35 INFO - PROCESS | 18206 | _x_x_mozilla_cycle_collect,955 15:47:35 INFO - PROCESS | 18206 | __end_cc_report 15:47:35 INFO - PROCESS | 18206 | __startTimestamp1475362055922__endTimestamp 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | ------- Summary: start ------- 15:47:35 INFO - PROCESS | 18206 | Number of tests: 6 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | [#0] dojo.html Cycles:165 Average:4790.35 Median:4932.93 stddev:512.29 (10.4%) stddev-sans-first:483.51 15:47:35 INFO - PROCESS | 18206 | Values: 2576.0 2636.2 2661.1 2668.2 2681.8 4690.7 4778.9 4794.3 4864.5 4906.7 4805.4 4878.2 4919.0 4971.0 4998.7 4281.7 4295.1 4330.8 4350.7 4352.9 4398.6 4424.8 4433.1 4435.8 4481.0 4370.1 4465.0 4474.8 4485.5 4573.6 4383.5 4400.0 4413.4 4499.7 4505.1 4402.6 4407.1 4462.1 4464.8 4486.5 4786.2 4797.5 4834.1 4838.1 4908.9 5025.9 5086.7 5158.4 5162.7 5167.1 5219.0 5221.5 5230.9 5270.1 5291.9 4865.0 4870.5 4875.4 4875.8 4937.7 5108.5 5176.3 5338.8 5340.9 5341.7 5028.6 5032.6 5077.8 5128.9 5130.2 5086.1 5111.6 5187.2 5188.1 5252.5 4964.7 5117.2 5140.6 5155.7 5160.9 5032.6 5126.0 5158.8 5180.6 5196.1 4429.4 4435.8 4446.6 4453.5 4505.0 3746.0 3861.3 3866.7 3893.2 3921.7 4369.5 4487.8 4523.1 4537.6 4589.4 5259.8 5286.4 5299.7 5300.2 5303.9 4532.9 4535.1 4539.0 4577.7 4595.7 4565.8 4603.0 4606.8 4670.3 4674.2 4885.8 4895.9 4924.1 4932.9 4957.3 5232.1 5235.7 5237.9 5247.9 5307.0 4758.0 4803.5 4876.2 4883.5 4886.5 5101.7 5118.1 5138.0 5152.4 5227.3 5192.2 5194.5 5230.2 5238.9 5296.8 4861.5 5079.1 5084.9 5089.9 5091.2 4879.6 4993.1 5061.3 5080.2 5148.8 4978.4 4987.0 4987.0 4995.6 5056.3 4938.1 4978.2 4981.2 5052.9 5088.0 4978.3 4978.5 4987.2 5024.0 5060.2 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | [#1] ext.html Cycles:180 Average:44854.18 Median:349713.00 stddev:80438.14 (23.0%) stddev-sans-first:80595.02 15:47:35 INFO - PROCESS | 18206 | Values: 556.2 562.7 573.1 573.8 578.0 28095.6 42131.6 43753.3 43787.8 43880.8 40162.0 40386.0 40616.6 40625.2 40686.4 7458.9 7608.6 7608.8 7614.7 7615.5 7160.0 7359.3 9527.6 9755.0 9756.9 9961.8 10086.6 10089.6 10092.0 10094.0 9849.9 9904.7 9917.0 9918.1 9921.7 9735.2 9738.9 9818.1 9824.7 9825.8 37439.0 37746.8 37756.0 37763.0 37767.4 2966.9 3074.9 3097.3 3154.5 3331.4 28364.9 28440.7 28850.4 28884.4 29130.3 3012.4 3046.6 3110.2 3205.8 3214.7 247848.0 248102.0 248879.0 248919.0 250119.0 31204.2 32224.2 51927.7 52137.2 52171.5 34056.3 34118.5 34122.5 34251.5 34266.7 13134.2 13203.0 13252.1 13260.6 13265.9 8828.3 9047.6 10683.1 10716.5 10729.6 7656.7 7976.1 7988.1 8044.1 8071.4 3105.3 3120.4 3149.7 3153.6 3196.0 837.9 902.4 902.6 964.5 977.3 26981.0 27530.7 27676.3 28324.6 28397.4 954.3 975.5 994.6 1027.2 1029.9 13832.7 14863.3 14898.1 14919.0 15072.5 348686.0 350740.0 351106.0 352850.0 353655.0 48779.0 49071.8 49091.3 49214.3 49311.3 1125.8 1169.2 1170.5 1193.3 1196.2 26473.1 27043.0 27567.6 27971.0 28006.0 42302.4 42645.0 42674.0 42739.8 42754.6 307621.0 308777.0 309262.0 309436.0 309870.0 21574.0 22245.7 24479.9 25420.2 25460.2 39171.4 39721.6 39764.0 43939.8 44224.8 35500.1 35586.8 35616.0 35666.5 36076.3 35344.3 35399.0 35422.3 35857.5 36009.5 31630.5 34061.5 34586.1 35261.5 35538.3 30406.2 33018.8 33084.5 33140.5 33299.5 24351.6 25048.0 25126.9 25204.4 25451.5 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | [#2] jquery.html Cycles:180 Average:23191.25 Median:5055.58 stddev:61120.97 (1209.0%) stddev-sans-first:61268.40 15:47:35 INFO - PROCESS | 18206 | Values: 364.8 373.9 376.8 383.1 383.9 15366.0 15570.3 16884.8 16999.5 17018.5 14445.4 17007.2 17160.7 17200.5 17215.7 4888.3 5142.3 5152.1 5159.3 5160.6 4886.0 4959.1 5043.4 5054.7 5056.4 5092.8 5115.9 5117.0 5119.1 5124.9 4891.3 5101.6 5104.4 5106.5 5109.8 4449.8 4484.2 4514.0 4533.7 4535.4 19826.6 20132.5 20158.5 20217.2 20490.8 1829.0 1879.9 2054.9 2357.8 2406.6 12526.9 12901.5 13087.6 13160.5 13530.5 1741.2 1821.6 1836.4 1993.4 2009.5 65091.7 67204.7 67425.3 68338.0 68548.3 9244.6 9380.3 9382.5 9525.1 9618.6 12346.4 12353.4 12361.7 12366.0 12389.2 6562.1 6903.7 7021.1 7041.0 7071.8 6698.8 6747.8 6828.8 6959.6 7033.5 3850.2 3888.7 3934.7 4155.6 4447.0 1817.9 1877.6 1892.9 1906.8 1912.3 742.5 864.6 892.8 907.7 938.3 16244.0 16526.8 16849.5 17041.7 17789.1 850.5 858.5 859.7 861.4 907.2 9215.4 9357.8 9408.3 9714.2 9929.8 364835.0 366599.0 368295.0 375216.0 376017.0 73119.0 73565.3 74760.6 74862.3 75015.0 876.1 883.6 911.4 914.8 915.2 11164.6 14722.6 15068.8 15862.8 16041.1 34298.5 34737.8 35659.3 36785.3 36867.8 41849.8 43190.6 43935.6 44312.8 46406.5 6551.9 7013.0 7101.9 7308.6 7503.7 9668.2 9674.7 10576.7 10917.6 10995.7 9494.2 9666.6 9852.1 9869.8 10041.0 9667.7 9771.4 9821.9 9942.8 9995.8 9005.9 9244.3 9535.1 9604.0 9657.4 6871.8 7135.8 7280.2 7283.9 7318.4 8247.5 9464.3 9535.0 9598.8 10014.2 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | [#3] mootools.html Cycles:180 Average:5086.54 Median:5113.64 stddev:2952.04 (57.7%) stddev-sans-first:2947.18 15:47:35 INFO - PROCESS | 18206 | Values: 1379.7 1396.3 1499.4 1691.1 1734.7 6928.7 7211.9 7541.8 8038.9 8066.8 7477.0 7789.7 7792.7 7954.6 7955.4 2175.1 2193.3 2203.6 2205.7 2214.5 1808.4 1879.0 2010.7 2136.9 2145.3 2174.2 2201.0 2204.1 2206.6 2207.5 2131.4 2140.5 2146.6 2192.2 2192.4 2116.4 2124.5 2154.1 2158.2 2163.0 7993.6 8085.0 8087.3 8092.9 8101.2 4385.5 4586.8 4586.8 4594.3 4607.7 2785.7 2931.5 3002.5 3007.1 3014.2 899.2 902.0 908.3 920.1 921.7 11127.0 11132.2 11144.6 11148.1 11154.4 4181.9 4194.5 4313.0 4326.5 4458.4 8433.0 8488.5 8547.4 8550.1 8555.9 4516.6 4548.2 4549.8 4550.8 4551.0 4119.1 4195.5 4218.8 4226.9 4231.0 3154.7 3246.6 3265.2 3273.1 3386.6 877.3 898.5 944.7 945.3 954.9 743.2 759.5 790.5 804.2 843.9 4829.2 4863.8 4910.0 4938.2 4938.8 418.0 432.8 434.7 443.4 584.6 3223.1 3224.8 3246.6 3308.9 3363.9 9112.7 9539.6 9611.2 9902.9 9939.7 9717.4 9839.3 9852.8 9861.1 9864.8 7298.6 7483.4 7544.5 7547.8 7555.2 5070.4 5100.8 5126.5 5133.3 5391.1 8951.1 9003.3 9017.8 9121.5 9139.8 8688.9 9192.0 9208.4 9290.4 9336.5 6682.9 6766.6 6788.2 6914.2 6922.6 7593.4 7639.9 7651.2 7651.3 7658.4 6385.5 6439.5 6514.7 6546.4 6692.4 6234.5 6534.0 6688.8 6890.8 6996.2 5895.2 6003.7 6027.0 6032.2 6038.9 4306.9 4388.9 4454.4 4459.6 4461.3 4135.2 4434.2 4443.9 4491.5 4501.1 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | [#4] prototype.html Cycles:180 Average:4198.74 Median:4734.57 stddev:1216.04 (25.7%) stddev-sans-first:1183.67 15:47:35 INFO - PROCESS | 18206 | Values: 297.3 302.1 306.0 312.6 313.9 4841.6 4873.6 4886.6 4902.9 4932.8 4827.0 4834.9 4876.8 4883.2 4906.5 3859.7 3876.5 3882.4 3886.8 3909.8 3763.5 3766.9 3792.3 3882.3 3896.7 3807.8 3810.2 3811.7 3846.7 3848.6 3794.8 3798.7 3801.0 3811.3 3813.3 3168.2 3251.5 3291.5 3348.5 3395.5 4684.5 4696.6 4715.7 4721.7 4730.7 4330.5 4334.4 4346.5 4361.5 4400.0 4738.5 4815.5 5039.4 5040.4 5048.4 3691.6 3692.8 3697.9 3698.1 3701.2 5293.4 5296.5 5306.4 5318.9 5357.3 3698.7 3747.8 3761.5 3776.9 3810.2 3824.8 3825.3 3826.9 3828.8 3852.0 4303.4 4339.2 4350.5 4366.3 4367.1 4956.0 5091.8 5092.7 5093.9 5110.0 1296.7 1329.2 1332.0 1336.0 1337.5 842.0 868.6 869.6 882.5 884.6 4021.4 4050.3 4060.6 4070.9 4075.4 4584.9 4596.3 4603.9 4625.5 4629.6 4062.7 4062.8 4085.0 4109.7 4127.6 2491.8 2593.7 2775.3 2788.1 2795.2 4690.5 4763.8 4827.3 4926.1 4956.3 5372.5 5373.7 5374.3 5387.2 5392.7 4744.6 4937.3 4962.0 4974.2 4975.7 5195.7 5196.1 5212.9 5213.2 5214.6 5148.4 5178.3 5178.3 5193.5 5201.8 4758.3 4897.5 4960.0 4960.3 4967.7 3657.5 3667.5 3706.6 3715.0 3720.6 5275.6 5308.4 5327.7 5342.8 5351.9 5085.5 5090.8 5188.3 5197.5 5201.9 5069.7 5073.4 5082.7 5085.9 5106.6 4975.6 5006.8 5039.1 5048.9 5059.5 4934.4 5077.8 5136.5 5152.3 5196.2 5004.8 5008.1 5014.5 5018.6 5023.2 15:47:35 INFO - PROCESS | 18206 | 15:47:35 INFO - PROCESS | 18206 | [#5] yui.html Cycles:180 Average:15503.10 Median:523.82 stddev:20422.74 (3898.8%) stddev-sans-first:20449.45 15:47:35 INFO - PROCESS | 18206 | Values: 621.3 629.6 681.6 697.4 721.5 11700.5 12457.6 12477.6 12501.7 12525.0 12111.4 12180.8 12211.8 12216.5 12238.2 619.3 637.4 749.5 750.9 765.8 755.7 756.7 757.4 757.7 757.9 813.0 814.4 814.9 815.1 815.3 646.7 664.0 790.9 807.4 816.1 592.4 592.8 592.8 592.9 594.7 11329.8 11367.0 11382.9 11392.6 11409.9 12472.0 12934.6 13473.9 13499.5 13627.7 9840.0 9975.8 10072.5 10120.4 10472.1 3226.1 3233.6 3261.8 3269.2 3323.1 63112.4 63712.0 64807.0 65193.7 65831.3 9807.2 10041.8 10088.0 10117.5 10229.6 20344.8 20465.9 20467.8 20478.5 20543.3 6226.5 6257.2 6332.7 6339.3 6370.5 3372.0 3421.4 3558.0 3617.8 3694.2 3031.0 3126.4 3136.3 3141.1 3152.2 504.8 514.4 523.0 530.3 530.9 499.6 519.8 527.2 533.8 557.0 7309.3 7470.9 7596.2 7767.6 7959.7 511.0 524.6 526.6 545.0 548.6 3616.7 3660.2 3680.1 3760.5 3793.8 55723.0 55767.0 56967.4 74321.0 77440.0 46329.8 46526.5 46569.0 62489.7 68999.3 67219.7 69120.7 69723.0 70426.0 74585.0 7987.6 8494.4 8533.7 8931.5 8974.2 30543.2 32292.7 40792.6 41963.8 43950.1 53930.7 59922.7 60465.7 60550.7 60659.0 10084.5 10488.5 10535.8 10568.7 10620.7 11611.8 12237.8 12273.2 12361.6 12650.7 11352.7 11545.9 11649.4 11862.9 12048.5 11224.1 11230.4 11235.4 11663.5 11781.4 11151.7 11467.1 11575.7 11853.7 12203.1 9203.0 9481.4 9503.8 9515.1 9569.3 9068.0 9536.7 9606.3 9647.5 9690.3 15:47:35 INFO - PROCESS | 18206 | -------- Summary: end -------- 15:47:35 INFO - PROCESS | 18206 | 15:47:36 INFO - TEST-INFO | 18206: exit 0 15:47:37 INFO - TEST-OK | dromaeo_css | took 1122611ms 15:47:37 INFO - TEST-START | kraken 15:47:37 INFO - operating with platform_type : linux_ 15:47:37 INFO - Initialising browser for kraken test... 15:47:37 INFO - TEST-INFO | started process 18513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps2DJot/profile http://localhost:60072/getInfo.html) 15:47:41 INFO - PROCESS | 18513 | __metrics Screen width/height:1600/1200 15:47:41 INFO - PROCESS | 18513 | colorDepth:24 15:47:41 INFO - PROCESS | 18513 | Browser inner width/height: 1024/697 15:47:41 INFO - PROCESS | 18513 | __metrics 15:47:42 INFO - PROCESS | 18513 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:47:42 INFO - PROCESS | 18513 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:47:42 INFO - PROCESS | 18513 | console.error: PushService: 15:47:42 INFO - PROCESS | 18513 | stateChangeProcessEnqueue: Error transitioning state 15:47:42 INFO - PROCESS | 18513 | UnknownError 15:47:43 INFO - TEST-INFO | 18513: exit 0 15:47:43 INFO - Browser initialized. 15:47:43 INFO - Running cycle 1/1 for kraken test... 15:47:43 INFO - TEST-INFO | started process 18595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps2DJot/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:55 INFO - PROCESS | 18595 | RSS: Main: 175321088 15:47:55 INFO - PROCESS | 18595 | 15:47:58 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-beat-detection) 15:47:59 INFO - PROCESS | 18595 | RSS: Main: 233189376 15:47:59 INFO - PROCESS | 18595 | 15:48:02 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-dft) 15:48:03 INFO - PROCESS | 18595 | RSS: Main: 219070464 15:48:03 INFO - PROCESS | 18595 | 15:48:06 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-fft) 15:48:06 INFO - PROCESS | 18595 | RSS: Main: 300994560 15:48:06 INFO - PROCESS | 18595 | 15:48:09 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60072/tests/kraken/driver.html?testName=audio-oscillator) 15:48:09 INFO - PROCESS | 18595 | RSS: Main: 209989632 15:48:09 INFO - PROCESS | 18595 | 15:48:11 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60072/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:12 INFO - PROCESS | 18595 | RSS: Main: 213762048 15:48:12 INFO - PROCESS | 18595 | 15:48:15 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60072/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:16 INFO - PROCESS | 18595 | RSS: Main: 250302464 15:48:16 INFO - PROCESS | 18595 | 15:48:19 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60072/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:20 INFO - PROCESS | 18595 | RSS: Main: 244551680 15:48:20 INFO - PROCESS | 18595 | 15:48:23 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60072/tests/kraken/driver.html?testName=json-parse-financial) 15:48:24 INFO - PROCESS | 18595 | RSS: Main: 247926784 15:48:24 INFO - PROCESS | 18595 | 15:48:25 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60072/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:26 INFO - PROCESS | 18595 | RSS: Main: 211173376 15:48:26 INFO - PROCESS | 18595 | 15:48:28 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:28 INFO - PROCESS | 18595 | RSS: Main: 218570752 15:48:28 INFO - PROCESS | 18595 | 15:48:31 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:31 INFO - PROCESS | 18595 | RSS: Main: 223981568 15:48:31 INFO - PROCESS | 18595 | 15:48:34 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:35 INFO - PROCESS | 18595 | RSS: Main: 224645120 15:48:35 INFO - PROCESS | 18595 | 15:48:38 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:38 INFO - PROCESS | 18595 | RSS: Main: 222375936 15:48:38 INFO - PROCESS | 18595 | 15:48:40 INFO - PROCESS | 18595 | Cycle 1(1): loaded http://localhost:60072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60072/tests/kraken/driver.html?testName=ai-astar) 15:48:41 INFO - PROCESS | 18595 | RSS: Main: 274571264 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | __start_tp_report 15:48:41 INFO - PROCESS | 18595 | _x_x_mozilla_page_load 15:48:41 INFO - PROCESS | 18595 | _x_x_mozilla_page_load_details 15:48:41 INFO - PROCESS | 18595 | |i|pagename|runs| 15:48:41 INFO - PROCESS | 18595 | |0;ai-astar;113;114;113;114;113;115;113;113;115;114 15:48:41 INFO - PROCESS | 18595 | |1;audio-beat-detection;173;130;125;165;127;128;131;126;166;132 15:48:41 INFO - PROCESS | 18595 | |2;audio-dft;162;163;164;163;162;162;160;160;160;161 15:48:41 INFO - PROCESS | 18595 | |3;audio-fft;76;77;77;105;78;77;78;77;109;77 15:48:41 INFO - PROCESS | 18595 | |4;audio-oscillator;84;83;118;83;85;83;113;83;84;115 15:48:41 INFO - PROCESS | 18595 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;119;118;118 15:48:41 INFO - PROCESS | 18595 | |6;imaging-darkroom;148;147;147;147;146;147;146;147;146;148 15:48:41 INFO - PROCESS | 18595 | |7;imaging-desaturate;95;94;95;94;94;95;95;94;94;94 15:48:41 INFO - PROCESS | 18595 | |8;json-parse-financial;65;62;64;62;64;64;63;70;64;64 15:48:41 INFO - PROCESS | 18595 | |9;json-stringify-tinderbox;67;67;66;66;68;70;66;67;67;67 15:48:41 INFO - PROCESS | 18595 | |10;stanford-crypto-aes;85;84;89;82;84;83;82;87;83;89 15:48:41 INFO - PROCESS | 18595 | |11;stanford-crypto-ccm;151;145;139;141;142;138;150;147;190;142 15:48:41 INFO - PROCESS | 18595 | |12;stanford-crypto-pbkdf2;177;179;175;177;171;178;173;182;174;172 15:48:41 INFO - PROCESS | 18595 | |13;stanford-crypto-sha256-iterative;72;71;71;73;71;70;71;69;69;69 15:48:41 INFO - PROCESS | 18595 | __end_tp_report 15:48:41 INFO - PROCESS | 18595 | __start_cc_report 15:48:41 INFO - PROCESS | 18595 | _x_x_mozilla_cycle_collect,1956 15:48:41 INFO - PROCESS | 18595 | __end_cc_report 15:48:41 INFO - PROCESS | 18595 | __startTimestamp1475362121021__endTimestamp 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | ------- Summary: start ------- 15:48:41 INFO - PROCESS | 18595 | Number of tests: 14 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 15:48:41 INFO - PROCESS | 18595 | Values: 113.0 114.0 113.0 114.0 113.0 115.0 113.0 113.0 115.0 114.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:131.50 stddev:19.35 (14.7%) stddev-sans-first:16.51 15:48:41 INFO - PROCESS | 18595 | Values: 173.0 130.0 125.0 165.0 127.0 128.0 131.0 126.0 166.0 132.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 15:48:41 INFO - PROCESS | 18595 | Values: 162.0 163.0 164.0 163.0 162.0 162.0 160.0 160.0 160.0 161.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:12.64 (16.4%) stddev-sans-first:13.15 15:48:41 INFO - PROCESS | 18595 | Values: 76.0 77.0 77.0 105.0 78.0 77.0 78.0 77.0 109.0 77.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:83.00 stddev:15.40 (18.6%) stddev-sans-first:15.98 15:48:41 INFO - PROCESS | 18595 | Values: 84.0 83.0 118.0 83.0 85.0 83.0 113.0 83.0 84.0 115.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:48:41 INFO - PROCESS | 18595 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 118.0 118.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 15:48:41 INFO - PROCESS | 18595 | Values: 148.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 148.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:48:41 INFO - PROCESS | 18595 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.25 (3.5%) stddev-sans-first:2.37 15:48:41 INFO - PROCESS | 18595 | Values: 65.0 62.0 64.0 62.0 64.0 64.0 63.0 70.0 64.0 64.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 15:48:41 INFO - PROCESS | 18595 | Values: 67.0 67.0 66.0 66.0 68.0 70.0 66.0 67.0 67.0 67.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:2.66 (3.1%) stddev-sans-first:2.82 15:48:41 INFO - PROCESS | 18595 | Values: 85.0 84.0 89.0 82.0 84.0 83.0 82.0 87.0 83.0 89.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:146.00 stddev:15.23 (10.4%) stddev-sans-first:16.12 15:48:41 INFO - PROCESS | 18595 | Values: 151.0 145.0 139.0 141.0 142.0 138.0 150.0 147.0 190.0 142.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:177.00 stddev:3.43 (1.9%) stddev-sans-first:3.61 15:48:41 INFO - PROCESS | 18595 | Values: 177.0 179.0 175.0 177.0 171.0 178.0 173.0 182.0 174.0 172.0 15:48:41 INFO - PROCESS | 18595 | 15:48:41 INFO - PROCESS | 18595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.35 (1.9%) stddev-sans-first:1.33 15:48:41 INFO - PROCESS | 18595 | Values: 72.0 71.0 71.0 73.0 71.0 70.0 71.0 69.0 69.0 69.0 15:48:41 INFO - PROCESS | 18595 | -------- Summary: end -------- 15:48:41 INFO - PROCESS | 18595 | 15:48:42 INFO - TEST-INFO | 18595: exit 0 15:48:42 INFO - TEST-OK | kraken | took 65435ms 15:48:42 INFO - SUITE-END | took 1188s 15:48:42 INFO - Completed test suite (00:19:48) 15:48:42 INFO - javascript benchmark 15:48:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.0339872547793, 2636.1827833371644, 2661.1085286429047, 2668.2262143978246, 2681.7720493758015, 4690.718556886589, 4778.9044219115685, 4794.328793968843, 4864.513548645134, 4906.681065730725, 4805.423349198092, 4878.170710979133, 4918.975405122969, 4971.030649023442, 4998.7250701211415, 4281.7002809803325, 4295.140971805636, 4330.783460826962, 4350.6519478441805, 4352.934705979413, 4398.626116780078, 4424.756638384888, 4433.091216300667, 4435.8225670973125, 4480.955190448102, 4370.125974805052, 4464.977675111603, 4474.8433804817005, 4485.484169320521, 4573.588377046065, 4383.473983122046, 4400.031992961543, 4413.426254586883, 4499.707519011286, 4505.144022635722, 4402.603765661106, 4407.07451435199, 4462.085272519158, 4464.821407143743, 4486.4616246050355, 4786.186348320759, 4797.544233297831, 4834.129856625806, 4838.080764654739, 4908.9263661045115, 5025.924611130836, 5086.694798312114, 5158.3552055993005, 5162.716050617215, 5167.147420675584, 5219.034478621429, 5221.503957124067, 5230.895382092375, 5270.104082305978, 5291.86770330741, 4865.0, 4870.537298956593, 4875.414950205998, 4875.756212189376, 4937.703737775745, 5108.489151084862, 5176.3270774799785, 5338.813141540028, 5340.893182136336, 5341.679499230058, 5028.622853286018, 5032.647714659939, 5077.822276220389, 5128.897422051538, 5130.230465430215, 5086.135356989321, 5111.5655169310285, 5187.221916712523, 5188.143956247177, 5252.501012403892, 4964.726940018334, 5117.232415137684, 5140.588752899834, 5155.716435596079, 5160.92258616121, 5032.622553308516, 5126.0, 5158.845234642967, 5180.637355385087, 5196.142636465017, 4429.424174857248, 4435.756033418128, 4446.644268458515, 4453.51011388747, 4504.977475112669, 3746.0, 3861.304965106308, 3866.7293289469467, 3893.162969961472, 3921.7254792164845, 4369.453818272716, 4487.798049087799, 4523.140603285431, 4537.6143027842345, 4589.426321709786, 5259.815906443256, 5286.36563612369, 5299.708516031656, 5300.178472336794, 5303.893922121536, 4532.9320060199125, 4535.138323718483, 4538.977305113453, 4577.7482238477205, 4595.747233902168, 4565.771711414416, 4603.033362993809, 4606.838760643362, 4670.346151538787, 4674.205385084544, 4885.828995985124, 4895.853124406273, 4924.089043526959, 4932.926006109983, 4957.330760347307, 5232.136697444879, 5235.738213089254, 5237.921431178459, 5247.947520524746, 5307.01820163271, 4758.0, 4803.471618121934, 4876.171050921281, 4883.462819089968, 4886.486918873609, 5101.744912754421, 5118.078745825638, 5137.974310128426, 5152.355955505562, 5227.320448341843, 5192.24712416705, 5194.454582268807, 5230.241614965885, 5238.869028274171, 5296.841094767009, 4861.465238823655, 5079.11115554769, 5084.872878178076, 5089.923651145162, 5091.236314552699, 4879.585235255043, 4993.051320249287, 5061.342025536656, 5080.187170052774, 5148.76830542634, 4978.4025916890205, 4986.950130498793, 4987.027529631687, 4995.600351971761, 5056.266841307916, 4938.061768264019, 4978.228374601942, 4981.227909674007, 5052.873678158076, 5088.033273677989, 4978.30303757467, 4978.47725988766, 4987.226979818134, 5024.045431368028, 5060.1903695408555], "value": 4756.651218885235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2268446858865, 562.7242651100961, 573.1374281706031, 573.7848306884919, 578.0260261459441, 28095.578566321496, 42131.57868421315, 43753.343699844525, 43787.78106109469, 43880.78059609706, 40162.0, 40386.0, 40616.59383406172, 40625.18749625013, 40686.38970415439, 7458.888116678268, 7608.6195690215545, 7608.771736847903, 7614.695412183533, 7615.46691731579, 7159.964200179018, 7359.264073592652, 9527.618895244183, 9754.951225243864, 9756.853647195263, 9961.750956226117, 10086.596536138546, 10089.596416143382, 10092.0, 10094.0, 9849.90150098497, 9904.702858914172, 9916.950415247878, 9918.05778451046, 9921.702348929544, 9735.247655422021, 9738.853917191247, 9818.116369526777, 9824.656137035241, 9825.803483930282, 37439.0, 37746.81126594377, 37756.0, 37763.0, 37767.43348849769, 2966.8813247470075, 3074.8770049198006, 3097.349556593118, 3154.463741164008, 3331.3503866745996, 28364.858175709196, 28440.71559284422, 28850.42299154026, 28884.42231155365, 29130.271743206376, 3012.4426981008364, 3046.588710524073, 3110.1602567306927, 3205.759568032407, 3214.6624604416434, 247848.0, 248102.0, 248879.0, 248919.0, 250118.99999999817, 31204.219894502367, 32224.19439514031, 51927.74036129871, 52137.2179417309, 52171.47828521742, 34056.31887362239, 34118.48822267668, 34122.48816267758, 34251.486227706606, 34266.657333426345, 13134.211947283193, 13203.0, 13252.072354935255, 13260.602181934557, 13265.867341326657, 8828.293736501064, 9047.638094476148, 10683.14534837211, 10716.464176791129, 10729.62446314391, 7656.73201437947, 7976.122626511079, 7988.081370642451, 8044.074931382849, 8071.4349995500925, 3105.3323535439536, 3120.3632930173967, 3149.653538110806, 3153.6373317068833, 3196.0, 837.8994520657438, 902.4224496322358, 902.6434558349547, 964.4984608003799, 977.3354119198871, 26981.0, 27530.724692753218, 27676.30809229745, 28324.575131373047, 28397.432051358857, 954.2556805691572, 975.531744762518, 994.5723338964315, 1027.1885210683627, 1029.917606591471, 13832.654183645489, 14863.33115009827, 14898.106113633217, 14919.0, 15072.54782356531, 348686.0, 350740.0, 351106.0, 352850.0, 353655.0, 48779.0, 49071.75464122728, 49091.263631045564, 49214.261786073235, 49311.260331095065, 1125.7579620381657, 1169.1640477058943, 1170.5025364220173, 1193.3376975778353, 1196.1925700152535, 26473.073442429424, 27043.0, 27567.586486202323, 27971.021014264403, 28006.0, 42302.36546451867, 42645.0, 42674.0, 42739.78630106829, 42754.572454276306, 307621.0, 308777.0, 309262.0, 309436.0, 309870.0, 21574.0, 22245.666315004964, 24479.877600612595, 25420.237392878244, 25460.236192914243, 39171.41242881416, 39721.60278397179, 39764.0, 43939.78030109829, 44224.77887610541, 35500.11249718778, 35586.82206588951, 35616.0, 35666.46500302549, 36076.27847442984, 35344.29311413706, 35399.0, 35422.29155416826, 35857.46213806847, 36009.459858101625, 31630.525542117346, 34061.48907766435, 34586.13534661553, 35261.471077934366, 35538.28923421465, 30406.239844004078, 33018.834905825315, 33084.503732443554, 33140.502892457116, 33299.500507491925, 24351.634725479485, 25048.0, 25126.874365628053, 25204.369890752878, 25451.490970180123], "value": 16546.084029210666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.77201748906936, 373.9177380976185, 376.8341929550998, 383.08251737089654, 383.8541354285371, 15366.0, 15570.299336529855, 16884.831151688493, 16999.49001529953, 17018.48944531666, 14445.422183112689, 17007.23467443965, 17160.742588861176, 17200.483985480423, 17215.741763873553, 4888.340074090006, 5142.305788718531, 5152.124138896378, 5159.303494028314, 5160.56135228506, 4886.0, 4959.082569724595, 5043.394792624872, 5054.721990290533, 5056.443791182967, 5092.770825312869, 5115.872103197431, 5117.02776472469, 5119.12974794284, 5124.897502049976, 4891.266310053485, 5101.566366858821, 5104.3619547556555, 5106.540411362995, 5109.846704598868, 4449.79975901082, 4484.215262329079, 4514.0, 4533.659975501851, 4535.387722657432, 19826.603467930705, 20132.49668758278, 20158.49603759903, 20217.191312347488, 20490.795092049037, 1828.9908550457162, 1879.877807942493, 2054.9280775172797, 2357.846739961897, 2406.566817972782, 12526.874731252754, 12901.483940642363, 13087.607371778862, 13160.53938112171, 13530.526431574946, 1741.2338571028833, 1821.6174603333316, 1836.40316897009, 1993.3521605478277, 2009.5378063045582, 65091.67454162699, 67204.6639766803, 67425.3257467424, 68338.0, 68548.31451685469, 9244.583993720298, 9380.29647776406, 9382.48396338208, 9525.095115963972, 9618.615255389846, 12346.382680865921, 12353.3823308836, 12361.690957726129, 12366.0, 12389.194702344319, 6562.146920900253, 6903.689333979983, 7021.087258656444, 7040.964795175992, 7071.752488662872, 6698.765543205965, 6747.763828265987, 6828.760993365208, 6959.617221052789, 7033.507654464241, 3850.172212974224, 3888.669463095612, 3934.7048971327263, 4155.625993660585, 4447.0, 1817.8729187903584, 1877.643247782917, 1892.924283028691, 1906.7997860224755, 1912.2789489459597, 742.524784138152, 864.5849992003748, 892.7634176943116, 907.682311191091, 938.2634631814129, 16244.0, 16526.83473165277, 16849.494515164566, 17041.659166816593, 17789.110544472984, 850.5067061104545, 858.5020688000944, 859.6991053131479, 861.4486728493769, 907.1971305394641, 9215.400998935047, 9357.812843743088, 9408.294377921684, 9714.174295184988, 9929.751756206153, 364835.0, 366599.0, 368295.0, 375216.0, 376017.0, 73119.0, 73565.26434735584, 74760.62619686975, 74862.25137748553, 75015.0, 876.093243492969, 883.5582208895552, 911.3711539038043, 914.8261830252363, 915.1900567997237, 11164.553417863195, 14722.55832325032, 15068.849311506745, 15862.7620585689, 16041.117738524026, 34298.48552271668, 34737.82631086828, 35659.28681426409, 36785.26429471449, 36867.81566092152, 41849.790751047265, 43190.56809431865, 43935.56064439443, 44312.77843610761, 46406.53593464022, 6551.934480655133, 7012.964935175291, 7101.928980710127, 7308.5614863108385, 7503.737369192052, 9668.178204852666, 9674.661386851427, 10576.726003909196, 10917.617883374043, 10995.725106872393, 9494.192993595621, 9666.565004574952, 9852.113309802153, 9869.753256168653, 10041.011043723774, 9667.661631842851, 9771.413715177112, 9821.85267220978, 9942.801143977225, 9995.800083998425, 9005.909940900769, 9244.260459163384, 9535.094166054214, 9603.991580883907, 9657.372270802376, 6871.793846184622, 7135.785926422215, 7280.162781280221, 7283.8543229136185, 7318.414526837733, 8247.505149691038, 9464.290178236797, 9535.046495350409, 9598.808023839623, 10014.19886409071], "value": 7965.93715232992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.6619828142107, 1396.322783450027, 1499.3927459378956, 1691.0783622925505, 1734.6964281250778, 6928.653567321639, 7211.855762884752, 7541.773746787591, 8038.879416808745, 8066.757997260084, 7476.962615186916, 7789.688412463494, 7792.727254546092, 7954.602269886512, 7955.363570914327, 2175.0647221694703, 2193.3419974007816, 2203.592335417945, 2205.702230198927, 2214.5017371091535, 1808.3670715249689, 1879.0229080877934, 2010.7386039814803, 2136.903839327234, 2145.313499680103, 2174.249883790098, 2200.9779902200935, 2204.096320508592, 2206.6138425775507, 2207.459172502739, 2131.445824085749, 2140.5183833637384, 2146.6350720377495, 2192.2217612747563, 2192.3861318830754, 2116.3650904728675, 2124.5113623866596, 2154.116812107044, 2158.201465457775, 2163.0482587661377, 7993.560354180518, 8084.959575202145, 8087.312578430781, 8092.878606820902, 8101.230383113595, 4385.451818522684, 4586.839460618862, 4586.839460618896, 4594.310853371988, 4607.7004994675235, 2785.6517935258094, 2931.4869897767803, 3002.489576771954, 3007.08283973388, 3014.201236672284, 899.1907283444887, 901.9729408117767, 908.2597682888425, 920.052346083535, 921.7373048681161, 11127.0, 11132.220744547885, 11144.554217831359, 11148.108151347873, 11154.386508742016, 4181.937270940938, 4194.454720886265, 4313.0, 4326.480822301344, 4458.4426946631675, 8433.0, 8488.490690558463, 8547.444416112932, 8550.144985501525, 8555.871661925075, 4516.593506584423, 4548.204064288736, 4549.772511374418, 4550.817967281338, 4551.0215303709865, 4119.073208528057, 4195.475565554306, 4218.831246750157, 4226.894327641833, 4231.0, 3154.747620190379, 3246.642869284377, 3265.1837040739815, 3273.083536609753, 3386.559747232844, 877.3113106211594, 898.4788822482944, 944.7118628818276, 945.2579724915907, 954.9045095490395, 743.1750756660103, 759.4683721395046, 790.5335851847437, 804.1917872538179, 843.9240468357877, 4829.203181475087, 4863.829765958245, 4910.0, 4938.160512712848, 4938.753062346868, 418.0, 432.7684688691535, 434.72612254280233, 443.3726277317559, 584.5937073733714, 3223.113643747988, 3224.774265801418, 3246.5617141686043, 3308.8841890534195, 3363.899083027513, 9112.726618201332, 9539.618415263312, 9611.183049440875, 9902.851457228147, 9939.65211217604, 9717.416954982582, 9839.311248212556, 9852.753681158028, 9861.063198996084, 9864.802703946025, 7298.56208627484, 7483.4013278937555, 7544.509606875536, 7547.849043019109, 7555.206703296185, 5070.391553013662, 5100.795968161232, 5126.487351264844, 5133.255677926754, 5391.110466773095, 8951.149640784115, 9003.324750643596, 9017.81964360696, 9121.498317592595, 9139.771505712144, 8688.913110869064, 9191.954040229755, 9208.401453905475, 9290.442573445614, 9336.533173341442, 6682.899756503753, 6766.560173588701, 6788.219354774066, 6914.170299563883, 6922.584644921119, 7593.430492713179, 7639.923600764144, 7651.234876512527, 7651.311381975649, 7658.425618078778, 6385.45723613498, 6439.549231553934, 6514.73941042353, 6546.378094081055, 6692.431143352869, 6234.532410069172, 6533.952489385103, 6688.83277918056, 6890.827729306808, 6996.160460744743, 5895.233619629592, 6003.729832157476, 6027.035674292092, 6032.245969253843, 6038.879222415615, 4306.913861722685, 4388.934165987449, 4454.376387305844, 4459.576340247671, 4461.286194209041, 4135.19363724083, 4434.157510073076, 4443.866683999485, 4491.505934347154, 4501.07727915783], "value": 3991.798149027195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.28799525137293, 302.08920105880776, 305.9770517211209, 312.5873846522591, 313.9058282515243, 4841.636877234208, 4873.610111191105, 4886.584640305574, 4902.926456103161, 4932.802687892489, 4826.975865120669, 4834.9033019339595, 4876.805437553097, 4883.218685010399, 4906.509349065092, 3859.7105217108688, 3876.4960555127795, 3882.3594106972314, 3886.8250928708135, 3909.7849618270984, 3763.454299126625, 3766.9452553284987, 3792.3363411403034, 3882.320593896071, 3896.6687831534355, 3807.809609519527, 3810.1808111256073, 3811.7331786774935, 3846.6535413397805, 3848.6151384861428, 3794.829232684536, 3798.6514787250403, 3800.992736924717, 3811.256804923027, 3813.3326667833016, 3168.239622490609, 3251.479763237894, 3291.489819078047, 3348.497725341194, 3395.5246265522846, 4684.508126646687, 4696.600788932945, 4715.693479923794, 4721.693089949176, 4730.692504987199, 4330.458692663417, 4334.414853994702, 4346.500152482474, 4361.476622805252, 4399.978000110011, 4738.4550776660435, 4815.49437309081, 5039.420466646309, 5040.36995375578, 5048.394192696863, 3691.575468821093, 3692.7599706019023, 3697.9445308320396, 3698.1124530112847, 3701.167237371597, 5293.391260005072, 5296.523312901819, 5306.416294207634, 5318.867028324285, 5357.303550538444, 3698.7225958053255, 3747.793871337048, 3761.4578023010436, 3776.8866933991476, 3810.161764411825, 3824.7513911595656, 3825.2731980923536, 3826.904327391782, 3828.789416582059, 3852.0, 4303.4190384298345, 4339.240632889232, 4350.521442641307, 4366.3013917773005, 4367.148406060851, 4955.950440495621, 5091.770870310845, 5092.668976516515, 5093.923591146136, 5110.0, 1296.682312833362, 1329.2423318708243, 1331.9600411987656, 1335.9866401336058, 1337.5452346202337, 842.0, 868.5917618719192, 869.556526171657, 882.4572887674034, 884.6417201033591, 4021.3565829467143, 4050.311447054008, 4060.5939406059156, 4070.898227544335, 4075.409065685459, 4584.862454126382, 4596.333531637961, 4603.869368829229, 4625.468071171791, 4629.587975667387, 4062.695297852673, 4062.7968601569805, 4085.0, 4109.6574952277515, 4127.587241275848, 2491.788198003154, 2593.6757905261843, 2775.306173456636, 2788.1078055022604, 2795.2452837734104, 4690.507496712864, 4763.76181190939, 4827.300041493963, 4926.137925863031, 4956.306117143603, 5372.489613486712, 5373.650712703662, 5374.3013408256675, 5387.164989426645, 5392.73036348181, 4744.644151688706, 4937.333459982857, 4961.950380496221, 4974.179260422062, 4975.676581022222, 5195.740212989411, 5196.077451342876, 5212.947870521246, 5213.218017297436, 5214.634975551827, 5148.3564554430695, 5178.300929374637, 5178.32681751385, 5193.532582067632, 5201.817936372209, 4758.262469317261, 4897.534734200245, 4960.032793605213, 4960.330355402119, 4967.652264341461, 3657.524521812147, 3667.541557305337, 3706.6478684524927, 3714.9814250929653, 3720.5721342046013, 5275.630705850554, 5308.362996440452, 5327.680339179662, 5342.813001544927, 5351.946480535301, 5085.466026067357, 5090.760065571137, 5188.325517682677, 5197.480251974772, 5201.855591769805, 5069.695818250917, 5073.416557095834, 5082.669626474268, 5085.898282034413, 5106.591472682102, 4975.577075948585, 5006.849794506171, 5039.0929632666475, 5048.949510504995, 5059.45686565601, 4934.383202099738, 5077.847664570068, 5136.5377116059735, 5152.3044389007, 5196.194589838581, 5004.824831130893, 5008.148614735576, 5014.473480284663, 5018.648694591344, 5023.246513022929], "value": 3816.3425760066457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.285521650102, 629.5781826176461, 681.5501768832571, 697.3793323941693, 721.4553012475582, 11700.531978720852, 12457.563985260518, 12477.563285285018, 12501.749965000694, 12525.0, 12111.394430278473, 12180.81728774069, 12211.816822747665, 12216.45025973831, 12238.20451670643, 619.2816333053659, 637.3817397124782, 749.4828568287891, 750.8648443280234, 765.7664412354229, 755.7090520149754, 756.6632848382473, 757.4394947738689, 757.7385801898337, 757.8787394016958, 813.0203105258149, 814.4380377539509, 814.9062857771344, 815.1481701621819, 815.282551354807, 646.7348387161288, 663.9966800166017, 790.8971833661644, 807.4105902691039, 816.143049797716, 592.3839207224481, 592.7540070870583, 592.8340064781868, 592.9288485381738, 594.678873408359, 11329.773404531863, 11367.0, 11382.94308528452, 11392.601258955896, 11409.885901140966, 12472.0, 12934.611961641165, 13473.865261347359, 13499.460021599125, 13627.659308517268, 9839.950800246024, 9975.800483990279, 10072.546735396925, 10120.443375614412, 10472.109870661003, 3226.1128189747774, 3233.644299127094, 3261.8205998670064, 3269.1663625775277, 3323.069540528656, 63112.368876311106, 63712.0, 64807.0, 65193.67403162954, 65831.34168658347, 9807.166390856715, 10041.849322557826, 10088.0, 10117.494125293853, 10229.641962531425, 20344.796552034586, 20465.897670511553, 20467.79532204659, 20478.488037799176, 20543.28098516545, 6226.470749986302, 6257.217847769029, 6332.715027823759, 6339.334369891188, 6370.490360771128, 3371.983140084284, 3421.4183588789965, 3557.964420355815, 3617.782933024027, 3694.1503454205144, 3030.9696903030685, 3126.4059828632485, 3136.310011797401, 3141.104785136225, 3152.2277042124824, 504.7905119375491, 514.4161376837242, 523.0428316181454, 530.3238371076908, 530.9469053094659, 499.60609898383103, 519.7972790611665, 527.1907621800594, 533.757140501071, 556.9721513924287, 7309.269073092754, 7470.887936680954, 7596.240375962359, 7767.572783496962, 7959.721409750631, 510.9565686916654, 524.590819161055, 526.6260954722113, 545.0298468725674, 548.5885585810641, 3616.674499295076, 3660.213054193361, 3680.1351682354625, 3760.5111335526753, 3793.8103094845146, 55723.0, 55767.0, 56967.430325696216, 74321.0, 77440.0, 46329.768351158025, 46526.53473465222, 46569.0, 62489.687551561954, 68999.3100068993, 67219.66390168018, 69120.6543967277, 69723.0, 70426.0, 74585.0, 7987.600619968862, 8494.447860889022, 8533.74398768038, 8931.508767017616, 8974.237189838937, 30543.2364190897, 32292.677073228966, 40792.592074080065, 41963.7901810489, 43950.12099758051, 53930.73034634802, 59922.70038649779, 60465.697671513124, 60550.69724651348, 60659.0, 10084.495775211064, 10488.475576221312, 10535.841962370723, 10568.682939511827, 10620.734481637712, 11611.825822612498, 12237.75524489523, 12273.202241854608, 12361.62915112548, 12650.746985060063, 11352.659420217407, 11545.909351121421, 11649.359285239054, 11862.940685296864, 12048.51805927753, 11224.10207183407, 11230.438478076227, 11235.382053987109, 11663.475143618727, 11781.352025638673, 11151.72120696989, 11467.139964502529, 11575.71060723455, 11853.703657408634, 12203.14577979533, 9202.953985230299, 9481.383710058824, 9503.809923801624, 9515.111505988503, 9569.28230382738, 9067.95466022692, 9536.713898583053, 9606.298426890064, 9647.469389183661, 9690.321677482509], "value": 6185.211683336709, "unit": "score"}], "name": "dromaeo_css", "value": 6240.823091075295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 115.0, 113.0, 113.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 130.0, 125.0, 165.0, 127.0, 128.0, 131.0, 126.0, 166.0, 132.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 162.0, 162.0, 160.0, 160.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 105.0, 78.0, 77.0, 78.0, 77.0, 109.0, 77.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 83.0, 85.0, 83.0, 113.0, 83.0, 84.0, 115.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 62.0, 64.0, 64.0, 63.0, 70.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 68.0, 70.0, 66.0, 67.0, 67.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 89.0, 82.0, 84.0, 83.0, 82.0, 87.0, 83.0, 89.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 145.0, 139.0, 141.0, 142.0, 138.0, 150.0, 147.0, 190.0, 142.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 175.0, 177.0, 171.0, 178.0, 173.0, 182.0, 174.0, 172.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 73.0, 71.0, 70.0, 71.0, 69.0, 69.0, 69.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1561.7999999999997, "alertThreshold": 2.0}]} 15:48:42 INFO - Return code: 0 15:48:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:48:42 INFO - # TBPL SUCCESS # 15:48:42 INFO - Running post-action listener: _resource_record_post_action 15:48:42 INFO - [mozharness: 2016-10-01 22:48:42.817961Z] Finished run-tests step (success) 15:48:42 INFO - Running post-run listener: _resource_record_post_run 15:48:42 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 12288; Write bytes: 401399808; Read time: 288; Write time: 238860 15:48:42 INFO - TinderboxPrint: CPU usage
13.0% 15:48:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 288 15:48:42 INFO - TinderboxPrint: I/O write bytes / time
401,399,808 / 238,860 15:48:42 INFO - TinderboxPrint: CPU idle
8,359.4 (86.9%) 15:48:42 INFO - TinderboxPrint: CPU user
1,206.4 (12.5%) 15:48:42 INFO - TinderboxPrint: Swap in / out
0 / 0 15:48:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110579712; Read time: 152; Write time: 64784 15:48:42 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289910784; Read time: 116; Write time: 174040 15:48:43 INFO - Running post-run listener: _upload_blobber_files 15:48:43 INFO - Blob upload gear active. 15:48:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:48:43 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 15:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:48:43 INFO - (blobuploader) - INFO - Open directory for files ... 15:48:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:48:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:48:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:44 INFO - (blobuploader) - INFO - Done attempting. 15:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:49 INFO - (blobuploader) - INFO - Done attempting. 15:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:48:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:50 INFO - (blobuploader) - INFO - Done attempting. 15:48:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:48:50 INFO - Return code: 0 15:48:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:48:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:48:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd7cf6f7f3157795e1dab4656ae436a59d0dd481afb07aada2f7837680ab890dce73e2702f6e6964bcf02082dc5ba96ed8c82ed6ff8fa61a790d84c6011329a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30293f2748b3d726c54a3e89d9b29429723d54e60f0714268af9d9d487769e7ccbfcd7563ed8dfd9f3ee7834ca3234e3b4a6d5a90de0b71b43679f0b60399427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d965f8b37e526eeb0d5b7366d745a664cac610bd0f8d6a3cd17ee0f3900d8ffea649bb834d12c73b7bda124a0722fdb9286b863e9e478dfd838a16195d8b8e"} 15:48:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:48:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:48:50 INFO - Contents: 15:48:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd7cf6f7f3157795e1dab4656ae436a59d0dd481afb07aada2f7837680ab890dce73e2702f6e6964bcf02082dc5ba96ed8c82ed6ff8fa61a790d84c6011329a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30293f2748b3d726c54a3e89d9b29429723d54e60f0714268af9d9d487769e7ccbfcd7563ed8dfd9f3ee7834ca3234e3b4a6d5a90de0b71b43679f0b60399427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d965f8b37e526eeb0d5b7366d745a664cac610bd0f8d6a3cd17ee0f3900d8ffea649bb834d12c73b7bda124a0722fdb9286b863e9e478dfd838a16195d8b8e"} 15:48:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:48:50 INFO - Copying logs to upload dir... 15:48:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:48:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.371176 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-01 15:48:49.964541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 15:48:49.967571) ========= 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=4300f881736b422476174874000001bc-1475359532.513902-257154763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd7cf6f7f3157795e1dab4656ae436a59d0dd481afb07aada2f7837680ab890dce73e2702f6e6964bcf02082dc5ba96ed8c82ed6ff8fa61a790d84c6011329a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30293f2748b3d726c54a3e89d9b29429723d54e60f0714268af9d9d487769e7ccbfcd7563ed8dfd9f3ee7834ca3234e3b4a6d5a90de0b71b43679f0b60399427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d965f8b37e526eeb0d5b7366d745a664cac610bd0f8d6a3cd17ee0f3900d8ffea649bb834d12c73b7bda124a0722fdb9286b863e9e478dfd838a16195d8b8e"} build_url:https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011559 build_url: 'https://queue.taskcluster.net/v1/task/LaTaKwabRYivYiF37k8VgA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fd7cf6f7f3157795e1dab4656ae436a59d0dd481afb07aada2f7837680ab890dce73e2702f6e6964bcf02082dc5ba96ed8c82ed6ff8fa61a790d84c6011329a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30293f2748b3d726c54a3e89d9b29429723d54e60f0714268af9d9d487769e7ccbfcd7563ed8dfd9f3ee7834ca3234e3b4a6d5a90de0b71b43679f0b60399427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0d965f8b37e526eeb0d5b7366d745a664cac610bd0f8d6a3cd17ee0f3900d8ffea649bb834d12c73b7bda124a0722fdb9286b863e9e478dfd838a16195d8b8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 15:48:50.002651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:48:50.003022) ========= 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=4300f881736b422476174874000001bc-1475359532.513902-257154763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 15:48:50.055878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 15:48:50.056497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 15:48:50.056980) ========= ========= Total master_lag: 0.19 =========