builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1485483118.56 results: success (0) buildid: 20170126162220 builduid: 32c2c5ea9ad04312a9563dba285358d9 revision: 560f5defe1af6334b77e179620a9907c7e693d9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.560396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.560876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.561159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.577518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.577910) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-26 18:11:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.3M=0s 2017-01-26 18:11:58 (50.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.699825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.700158) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:58.749752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 18:11:58.750108) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 560f5defe1af6334b77e179620a9907c7e693d9f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 560f5defe1af6334b77e179620a9907c7e693d9f --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=9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-26 18:11:58,971 truncating revision to first 12 chars 2017-01-26 18:11:58,971 Setting DEBUG logging. 2017-01-26 18:11:58,971 attempt 1/10 2017-01-26 18:11:58,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/560f5defe1af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 18:11:59,797 unpacking tar archive at: mozilla-beta-560f5defe1af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.128699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 18:11:59.892199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:59.892583) ========= script_repo_revision: 560f5defe1af6334b77e179620a9907c7e693d9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:59.892991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:59.893268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 18:11:59.906528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-26 18:11:59.906929) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:12:00 INFO - MultiFileLogger online at 20170126 18:12:00 in /builds/slave/test 18:12:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:12:00 INFO - {'append_to_log': False, 18:12:00 INFO - 'base_work_dir': '/builds/slave/test', 18:12:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:12:00 INFO - 'branch': 'Mozilla-Beta', 18:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 18:12:00 INFO - 'config_files': ('talos/linux_config.py',), 18:12:00 INFO - 'default_actions': ('clobber', 18:12:00 INFO - 'read-buildbot-config', 18:12:00 INFO - 'download-and-extract', 18:12:00 INFO - 'populate-webroot', 18:12:00 INFO - 'create-virtualenv', 18:12:00 INFO - 'install', 18:12:00 INFO - 'run-tests'), 18:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:12:00 INFO - 'download_minidump_stackwalk': True, 18:12:00 INFO - 'download_symbols': 'ondemand', 18:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 18:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 18:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:12:00 INFO - 'installer_path': 'installer.exe', 18:12:00 INFO - 'log_level': 'info', 18:12:00 INFO - 'log_name': 'talos', 18:12:00 INFO - 'log_to_console': True, 18:12:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:12:00 INFO - 'opt_config_files': (), 18:12:00 INFO - 'pip_index': False, 18:12:00 INFO - 'sps_profile': False, 18:12:00 INFO - 'sps_profile_interval': 0, 18:12:00 INFO - 'suite': 'dromaeojs', 18:12:00 INFO - 'system_bits': '32', 18:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:12:00 INFO - 'title': 'talos-linux64-ix-040', 18:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:12:00 INFO - 'use_talos_json': True, 18:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:12:00 INFO - 'work_dir': 'build'} 18:12:00 INFO - [mozharness: 2017-01-27 02:12:00.224463Z] Running clobber step. 18:12:00 INFO - Running pre-action listener: _resource_record_pre_action 18:12:00 INFO - Running main action method: clobber 18:12:00 INFO - rmtree: /builds/slave/test/build 18:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:12:00 INFO - Running post-action listener: _resource_record_post_action 18:12:00 INFO - [mozharness: 2017-01-27 02:12:00.687247Z] Finished clobber step (success) 18:12:00 INFO - [mozharness: 2017-01-27 02:12:00.687348Z] Running read-buildbot-config step. 18:12:00 INFO - Running pre-action listener: _resource_record_pre_action 18:12:00 INFO - Running main action method: read_buildbot_config 18:12:00 INFO - Using buildbot properties: 18:12:00 INFO - { 18:12:00 INFO - "project": "", 18:12:00 INFO - "product": "firefox", 18:12:00 INFO - "script_repo_revision": "production", 18:12:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:12:00 INFO - "repository": "", 18:12:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:12:00 INFO - "buildid": "20170126162220", 18:12:00 INFO - "pgo_build": "True", 18:12:00 INFO - "basedir": "/builds/slave/test", 18:12:00 INFO - "buildnumber": 527, 18:12:00 INFO - "slavename": "talos-linux64-ix-040", 18:12:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:12:00 INFO - "platform": "ubuntu64_hw", 18:12:00 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:12:00 INFO - "branch": "mozilla-beta", 18:12:00 INFO - "repo_path": "releases/mozilla-beta", 18:12:00 INFO - "revision": "560f5defe1af6334b77e179620a9907c7e693d9f", 18:12:00 INFO - "stage_platform": "linux64-pgo", 18:12:00 INFO - "builduid": "32c2c5ea9ad04312a9563dba285358d9", 18:12:00 INFO - "slavebuilddir": "test" 18:12:00 INFO - } 18:12:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 18:12:00 INFO - Running post-action listener: _resource_record_post_action 18:12:00 INFO - [mozharness: 2017-01-27 02:12:00.689794Z] Finished read-buildbot-config step (success) 18:12:00 INFO - [mozharness: 2017-01-27 02:12:00.689882Z] Running download-and-extract step. 18:12:00 INFO - Running pre-action listener: _resource_record_pre_action 18:12:00 INFO - Running main action method: download_and_extract 18:12:00 INFO - mkdir: /builds/slave/test/build/tests 18:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:00 INFO - trying https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:12:00 INFO - Downloading https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:12:01 INFO - Downloaded 1327 bytes. 18:12:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:12:01 INFO - Using the following test package requirements: 18:12:01 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 18:12:01 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:12:01 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 18:12:01 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'jsshell-linux-x86_64.zip'], 18:12:01 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:12:01 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 18:12:01 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 18:12:01 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 18:12:01 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:12:01 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:12:01 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:12:01 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:12:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 18:12:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:12:01 INFO - Fetch https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 18:12:01 INFO - Http code: 200 18:12:01 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 18:12:01 INFO - x-amz-cf-id: WtXzthgQNzmn7FM3UEWjBSgl1kPOVdsKSbyal_GKIgrNDkN5AItB4A== 18:12:01 INFO - x-amz-version-id: Z9hvuvwKH9r2jhtL6hA1FljXbCxrqA4m 18:12:02 INFO - Expected file size: 21951558 18:12:02 INFO - Obtained file size: 21951558 18:12:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:12:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 18:12:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:12:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 18:12:06 INFO - Http code: 200 18:12:06 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 18:12:06 INFO - x-amz-cf-id: s-AwIWbjrqhT9klVKkGlUDeKTaZ4GM1bk31WGI6-WCbR3YDICGmiUw== 18:12:06 INFO - x-amz-version-id: Z9hvuvwKH9r2jhtL6hA1FljXbCxrqA4m 18:12:06 INFO - Expected file size: 21951558 18:12:06 INFO - Obtained file size: 21951558 18:12:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 18:12:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:12:11 INFO - Fetch https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 18:12:11 INFO - Http code: 200 18:12:11 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 18:12:11 INFO - x-amz-cf-id: VYNg66Wx9Ym2OBSanRv4-26rBxgUKJxxlHrks676U8x_02F2ez8vww== 18:12:11 INFO - x-amz-version-id: FExYfHdrV6ea4MPt8aQ9Qg1eG82RS_yp 18:12:11 INFO - Expected file size: 14402992 18:12:11 INFO - Obtained file size: 14402992 18:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:12 INFO - trying https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:12:12 INFO - Downloading https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:12:13 INFO - Downloaded 57700195 bytes. 18:12:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:12:13 INFO - mkdir: /builds/slave/test/properties 18:12:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:13 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:13 INFO - Contents: 18:12:13 INFO - build_url:https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:12:13 INFO - Running post-action listener: _resource_record_post_action 18:12:13 INFO - Running post-action listener: set_extra_try_arguments 18:12:13 INFO - [mozharness: 2017-01-27 02:12:13.903398Z] Finished download-and-extract step (success) 18:12:13 INFO - [mozharness: 2017-01-27 02:12:13.903627Z] Running populate-webroot step. 18:12:13 INFO - Running pre-action listener: _resource_record_pre_action 18:12:13 INFO - Running main action method: populate_webroot 18:12:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:13 INFO - '--tppagecycles', 18:12:13 INFO - '7'], 18:12:13 INFO - 'tests': ['tsvgm']}}, 18:12:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:12:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:12:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:12:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:12:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['damp', 'tps']}, 18:12:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'tests': ['damp', 'tps']}, 18:12:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['dromaeo_dom']}, 18:12:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['basic_compositor_video']}, 18:12:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:12:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['a11yr', 18:12:13 INFO - 'ts_paint', 18:12:13 INFO - 'tpaint', 18:12:13 INFO - 'sessionrestore', 18:12:13 INFO - 'sessionrestore_no_auto_restore', 18:12:13 INFO - 'tabpaint']}, 18:12:13 INFO - 'other-e10s': {'tests': ['a11yr', 18:12:13 INFO - 'ts_paint', 18:12:13 INFO - 'tpaint', 18:12:13 INFO - 'sessionrestore', 18:12:13 INFO - 'sessionrestore_no_auto_restore', 18:12:13 INFO - 'tabpaint']}, 18:12:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:12:13 INFO - 'ts_paint', 18:12:13 INFO - 'tpaint', 18:12:13 INFO - 'sessionrestore', 18:12:13 INFO - 'sessionrestore_no_auto_restore', 18:12:13 INFO - 'tabpaint']}, 18:12:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:12:13 INFO - 'ts_paint', 18:12:13 INFO - 'tpaint', 18:12:13 INFO - 'sessionrestore', 18:12:13 INFO - 'sessionrestore_no_auto_restore', 18:12:13 INFO - 'tabpaint']}, 18:12:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['a11yr', 18:12:13 INFO - 'ts_paint', 18:12:13 INFO - 'tpaint', 18:12:13 INFO - 'sessionrestore', 18:12:13 INFO - 'sessionrestore_no_auto_restore', 18:12:13 INFO - 'tabpaint']}, 18:12:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['a11yr', 18:12:13 INFO - 'ts_paint', 18:12:13 INFO - 'tpaint', 18:12:13 INFO - 'sessionrestore', 18:12:13 INFO - 'sessionrestore_no_auto_restore', 18:12:13 INFO - 'tabpaint']}, 18:12:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['tsvgx', 18:12:13 INFO - 'tsvgr_opacity', 18:12:13 INFO - 'tart', 18:12:13 INFO - 'tscrollx', 18:12:13 INFO - 'cart']}, 18:12:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:12:13 INFO - 'tsvgr_opacity', 18:12:13 INFO - 'tart', 18:12:13 INFO - 'tscrollx', 18:12:13 INFO - 'cart']}, 18:12:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'talos_options': ['--disable-e10s'], 18:12:13 INFO - 'tests': ['tp5o']}, 18:12:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'tests': ['tp5o']}, 18:12:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'talos_options': ['--disable-e10s', 18:12:13 INFO - '--xperf_path', 18:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:13 INFO - 'tests': ['tp5n']}, 18:12:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:13 INFO - 'talos_options': ['--xperf_path', 18:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:13 INFO - 'tests': ['tp5n']}}, 18:12:13 INFO - 'talos.zip': {'path': '', 18:12:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:13 INFO - Running post-action listener: _resource_record_post_action 18:12:13 INFO - [mozharness: 2017-01-27 02:12:13.922506Z] Finished populate-webroot step (success) 18:12:13 INFO - [mozharness: 2017-01-27 02:12:13.922594Z] Running create-virtualenv step. 18:12:13 INFO - Running pre-action listener: _resource_record_pre_action 18:12:13 INFO - Running main action method: create_virtualenv 18:12:13 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:12:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:14 INFO - Using real prefix '/usr' 18:12:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:14 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:16 INFO - Installing pip.................done. 18:12:16 INFO - Return code: 0 18:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:12:16 INFO - Reading from file tmpfile_stdout 18:12:16 INFO - Output received: 18:12:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:12:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:16 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:12:16 INFO - Using env: {'DISPLAY': ':0', 18:12:16 INFO - 'HOME': '/home/cltbld', 18:12:16 INFO - 'LANG': 'en_US.UTF-8', 18:12:16 INFO - 'LANGUAGE': 'en_US:en', 18:12:16 INFO - 'LOGNAME': 'cltbld', 18:12:16 INFO - 'MAIL': '/var/mail/cltbld', 18:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:16 INFO - 'MOZ_NO_REMOTE': '1', 18:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:16 INFO - 'NO_EM_RESTART': '1', 18:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:16 INFO - 'PWD': '/builds/slave/test', 18:12:16 INFO - 'SHELL': '/bin/bash', 18:12:16 INFO - 'SHLVL': '1', 18:12:16 INFO - 'TERM': 'linux', 18:12:16 INFO - 'TMOUT': '86400', 18:12:16 INFO - 'USER': 'cltbld', 18:12:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:16 INFO - '_': '/tools/buildbot/bin/python'} 18:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:12:16 INFO - Cleaning up... 18:12:16 INFO - Return code: 0 18:12:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:16 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:12:16 INFO - Using env: {'DISPLAY': ':0', 18:12:16 INFO - 'HOME': '/home/cltbld', 18:12:16 INFO - 'LANG': 'en_US.UTF-8', 18:12:16 INFO - 'LANGUAGE': 'en_US:en', 18:12:16 INFO - 'LOGNAME': 'cltbld', 18:12:16 INFO - 'MAIL': '/var/mail/cltbld', 18:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:16 INFO - 'MOZ_NO_REMOTE': '1', 18:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:16 INFO - 'NO_EM_RESTART': '1', 18:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:16 INFO - 'PWD': '/builds/slave/test', 18:12:16 INFO - 'SHELL': '/bin/bash', 18:12:16 INFO - 'SHLVL': '1', 18:12:16 INFO - 'TERM': 'linux', 18:12:16 INFO - 'TMOUT': '86400', 18:12:16 INFO - 'USER': 'cltbld', 18:12:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:16 INFO - '_': '/tools/buildbot/bin/python'} 18:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:17 INFO - Downloading/unpacking psutil>=3.1.1 18:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:19 INFO - Installing collected packages: psutil 18:12:19 INFO - Running setup.py install for psutil 18:12:19 INFO - building 'psutil._psutil_linux' extension 18:12:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:12:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:12:19 INFO - building 'psutil._psutil_posix' extension 18:12:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:12:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:19 INFO - Successfully installed psutil 18:12:19 INFO - Cleaning up... 18:12:19 INFO - Return code: 0 18:12:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:12:19 INFO - Using env: {'DISPLAY': ':0', 18:12:19 INFO - 'HOME': '/home/cltbld', 18:12:19 INFO - 'LANG': 'en_US.UTF-8', 18:12:19 INFO - 'LANGUAGE': 'en_US:en', 18:12:19 INFO - 'LOGNAME': 'cltbld', 18:12:19 INFO - 'MAIL': '/var/mail/cltbld', 18:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:19 INFO - 'MOZ_NO_REMOTE': '1', 18:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:19 INFO - 'NO_EM_RESTART': '1', 18:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:19 INFO - 'PWD': '/builds/slave/test', 18:12:19 INFO - 'SHELL': '/bin/bash', 18:12:19 INFO - 'SHLVL': '1', 18:12:19 INFO - 'TERM': 'linux', 18:12:19 INFO - 'TMOUT': '86400', 18:12:19 INFO - 'USER': 'cltbld', 18:12:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:19 INFO - '_': '/tools/buildbot/bin/python'} 18:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:22 INFO - Installing collected packages: mozsystemmonitor 18:12:22 INFO - Running setup.py install for mozsystemmonitor 18:12:22 INFO - Successfully installed mozsystemmonitor 18:12:22 INFO - Cleaning up... 18:12:22 INFO - Return code: 0 18:12:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:12:22 INFO - Using env: {'DISPLAY': ':0', 18:12:22 INFO - 'HOME': '/home/cltbld', 18:12:22 INFO - 'LANG': 'en_US.UTF-8', 18:12:22 INFO - 'LANGUAGE': 'en_US:en', 18:12:22 INFO - 'LOGNAME': 'cltbld', 18:12:22 INFO - 'MAIL': '/var/mail/cltbld', 18:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:22 INFO - 'MOZ_NO_REMOTE': '1', 18:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:22 INFO - 'NO_EM_RESTART': '1', 18:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:22 INFO - 'PWD': '/builds/slave/test', 18:12:22 INFO - 'SHELL': '/bin/bash', 18:12:22 INFO - 'SHLVL': '1', 18:12:22 INFO - 'TERM': 'linux', 18:12:22 INFO - 'TMOUT': '86400', 18:12:22 INFO - 'USER': 'cltbld', 18:12:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:22 INFO - '_': '/tools/buildbot/bin/python'} 18:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:22 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:24 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:24 INFO - warning: no files found matching '*.txt' 18:12:24 INFO - no previously-included directories found matching 'build' 18:12:24 INFO - no previously-included directories found matching 'dist' 18:12:24 INFO - no previously-included directories found matching '.git*' 18:12:24 INFO - Installing collected packages: jsonschema, functools32 18:12:24 INFO - Running setup.py install for functools32 18:12:24 INFO - warning: no files found matching '*.txt' 18:12:24 INFO - no previously-included directories found matching 'build' 18:12:24 INFO - no previously-included directories found matching 'dist' 18:12:24 INFO - no previously-included directories found matching '.git*' 18:12:24 INFO - Successfully installed jsonschema functools32 18:12:24 INFO - Cleaning up... 18:12:25 INFO - Return code: 0 18:12:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:12:25 INFO - Using env: {'DISPLAY': ':0', 18:12:25 INFO - 'HOME': '/home/cltbld', 18:12:25 INFO - 'LANG': 'en_US.UTF-8', 18:12:25 INFO - 'LANGUAGE': 'en_US:en', 18:12:25 INFO - 'LOGNAME': 'cltbld', 18:12:25 INFO - 'MAIL': '/var/mail/cltbld', 18:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:25 INFO - 'MOZ_NO_REMOTE': '1', 18:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:25 INFO - 'NO_EM_RESTART': '1', 18:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:25 INFO - 'PWD': '/builds/slave/test', 18:12:25 INFO - 'SHELL': '/bin/bash', 18:12:25 INFO - 'SHLVL': '1', 18:12:25 INFO - 'TERM': 'linux', 18:12:25 INFO - 'TMOUT': '86400', 18:12:25 INFO - 'USER': 'cltbld', 18:12:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:25 INFO - '_': '/tools/buildbot/bin/python'} 18:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:25 INFO - Cleaning up... 18:12:25 INFO - Return code: 0 18:12:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:25 INFO - Using env: {'DISPLAY': ':0', 18:12:25 INFO - 'HOME': '/home/cltbld', 18:12:25 INFO - 'LANG': 'en_US.UTF-8', 18:12:25 INFO - 'LANGUAGE': 'en_US:en', 18:12:25 INFO - 'LOGNAME': 'cltbld', 18:12:25 INFO - 'MAIL': '/var/mail/cltbld', 18:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:25 INFO - 'MOZ_NO_REMOTE': '1', 18:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:25 INFO - 'NO_EM_RESTART': '1', 18:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:25 INFO - 'PWD': '/builds/slave/test', 18:12:25 INFO - 'SHELL': '/bin/bash', 18:12:25 INFO - 'SHLVL': '1', 18:12:25 INFO - 'TERM': 'linux', 18:12:25 INFO - 'TMOUT': '86400', 18:12:25 INFO - 'USER': 'cltbld', 18:12:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:25 INFO - '_': '/tools/buildbot/bin/python'} 18:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:25 INFO - Downloading/unpacking blobuploader==1.2.4 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12:27 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:28 INFO - Downloading docopt-0.6.1.tar.gz 18:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:28 INFO - Running setup.py install for blobuploader 18:12:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:28 INFO - Running setup.py install for requests 18:12:28 INFO - Running setup.py install for docopt 18:12:28 INFO - Successfully installed blobuploader requests docopt 18:12:28 INFO - Cleaning up... 18:12:28 INFO - Return code: 0 18:12:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:28 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:28 INFO - Using env: {'DISPLAY': ':0', 18:12:28 INFO - 'HOME': '/home/cltbld', 18:12:28 INFO - 'LANG': 'en_US.UTF-8', 18:12:28 INFO - 'LANGUAGE': 'en_US:en', 18:12:28 INFO - 'LOGNAME': 'cltbld', 18:12:28 INFO - 'MAIL': '/var/mail/cltbld', 18:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:28 INFO - 'MOZ_NO_REMOTE': '1', 18:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:28 INFO - 'NO_EM_RESTART': '1', 18:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:28 INFO - 'PWD': '/builds/slave/test', 18:12:28 INFO - 'SHELL': '/bin/bash', 18:12:28 INFO - 'SHLVL': '1', 18:12:28 INFO - 'TERM': 'linux', 18:12:28 INFO - 'TMOUT': '86400', 18:12:28 INFO - 'USER': 'cltbld', 18:12:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:28 INFO - '_': '/tools/buildbot/bin/python'} 18:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:29 INFO - Running setup.py (path:/tmp/pip-OfHeEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:29 INFO - Running setup.py (path:/tmp/pip-5nao94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:29 INFO - Running setup.py (path:/tmp/pip-UPj8mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:29 INFO - Running setup.py (path:/tmp/pip-hUb0y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:29 INFO - Running setup.py (path:/tmp/pip-Dzpax4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:29 INFO - Running setup.py (path:/tmp/pip-c98tu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:29 INFO - Running setup.py (path:/tmp/pip-3RvxIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:29 INFO - Running setup.py (path:/tmp/pip-gEMgDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:29 INFO - Running setup.py (path:/tmp/pip-tFRUC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:29 INFO - Running setup.py (path:/tmp/pip-1gO2oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:29 INFO - Running setup.py (path:/tmp/pip-Ei1v3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:29 INFO - Running setup.py (path:/tmp/pip-18XSAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:29 INFO - Running setup.py (path:/tmp/pip-ngbunm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:30 INFO - Running setup.py (path:/tmp/pip-zxoOvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:30 INFO - Running setup.py (path:/tmp/pip-KVHHf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:30 INFO - Running setup.py (path:/tmp/pip-_PjCvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:30 INFO - Running setup.py (path:/tmp/pip-j6NDA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:30 INFO - Running setup.py install for manifestparser 18:12:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:30 INFO - Running setup.py install for mozcrash 18:12:30 INFO - Running setup.py install for mozdebug 18:12:30 INFO - Running setup.py install for mozdevice 18:12:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:30 INFO - Running setup.py install for mozfile 18:12:30 INFO - Running setup.py install for mozhttpd 18:12:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:30 INFO - Running setup.py install for mozinfo 18:12:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for mozInstall 18:12:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for mozleak 18:12:31 INFO - Running setup.py install for mozlog 18:12:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for moznetwork 18:12:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for mozprocess 18:12:31 INFO - Running setup.py install for mozprofile 18:12:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for mozrunner 18:12:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:31 INFO - Running setup.py install for mozscreenshot 18:12:31 INFO - Running setup.py install for moztest 18:12:32 INFO - Running setup.py install for mozversion 18:12:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:32 INFO - Cleaning up... 18:12:32 INFO - Return code: 0 18:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:32 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:32 INFO - Using env: {'DISPLAY': ':0', 18:12:32 INFO - 'HOME': '/home/cltbld', 18:12:32 INFO - 'LANG': 'en_US.UTF-8', 18:12:32 INFO - 'LANGUAGE': 'en_US:en', 18:12:32 INFO - 'LOGNAME': 'cltbld', 18:12:32 INFO - 'MAIL': '/var/mail/cltbld', 18:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:32 INFO - 'MOZ_NO_REMOTE': '1', 18:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:32 INFO - 'NO_EM_RESTART': '1', 18:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:32 INFO - 'PWD': '/builds/slave/test', 18:12:32 INFO - 'SHELL': '/bin/bash', 18:12:32 INFO - 'SHLVL': '1', 18:12:32 INFO - 'TERM': 'linux', 18:12:32 INFO - 'TMOUT': '86400', 18:12:32 INFO - 'USER': 'cltbld', 18:12:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:32 INFO - '_': '/tools/buildbot/bin/python'} 18:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:32 INFO - Running setup.py (path:/tmp/pip-SRymh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:32 INFO - Running setup.py (path:/tmp/pip-4jdlBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:32 INFO - Running setup.py (path:/tmp/pip-xhEtMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:32 INFO - Running setup.py (path:/tmp/pip-F4yxnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:32 INFO - Running setup.py (path:/tmp/pip-xHVsxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:32 INFO - Running setup.py (path:/tmp/pip-7r8bDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:32 INFO - Running setup.py (path:/tmp/pip-z_XKhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:32 INFO - Running setup.py (path:/tmp/pip-0cmNBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:32 INFO - Running setup.py (path:/tmp/pip-hG6ua9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:33 INFO - Running setup.py (path:/tmp/pip-Wr840h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:33 INFO - Running setup.py (path:/tmp/pip-pHTBkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:33 INFO - Running setup.py (path:/tmp/pip-ERUhFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:33 INFO - Running setup.py (path:/tmp/pip-kOWEpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:33 INFO - Running setup.py (path:/tmp/pip-tGMmgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:33 INFO - Running setup.py (path:/tmp/pip-l_tQ9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:33 INFO - Running setup.py (path:/tmp/pip-rR6cvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:33 INFO - Running setup.py (path:/tmp/pip-BDbEpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:35 INFO - Downloading blessings-1.6.tar.gz 18:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:35 INFO - Installing collected packages: blessings 18:12:35 INFO - Running setup.py install for blessings 18:12:35 INFO - Successfully installed blessings 18:12:35 INFO - Cleaning up... 18:12:35 INFO - Return code: 0 18:12:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:36 INFO - Reading from file tmpfile_stdout 18:12:36 INFO - Current package versions: 18:12:36 INFO - argparse == 1.2.1 18:12:36 INFO - blessings == 1.6 18:12:36 INFO - blobuploader == 1.2.4 18:12:36 INFO - docopt == 0.6.1 18:12:36 INFO - functools32 == 3.2.3-2 18:12:36 INFO - jsonschema == 2.5.1 18:12:36 INFO - manifestparser == 1.1 18:12:36 INFO - mozInstall == 1.12 18:12:36 INFO - mozcrash == 1.0 18:12:36 INFO - mozdebug == 0.1 18:12:36 INFO - mozdevice == 0.48 18:12:36 INFO - mozfile == 1.2 18:12:36 INFO - mozhttpd == 0.7 18:12:36 INFO - mozinfo == 0.9 18:12:36 INFO - mozleak == 0.1 18:12:36 INFO - mozlog == 3.4 18:12:36 INFO - moznetwork == 0.27 18:12:36 INFO - mozprocess == 0.23 18:12:36 INFO - mozprofile == 0.28 18:12:36 INFO - mozrunner == 6.13 18:12:36 INFO - mozscreenshot == 0.1 18:12:36 INFO - mozsystemmonitor == 0.3 18:12:36 INFO - moztest == 0.8 18:12:36 INFO - mozversion == 1.4 18:12:36 INFO - psutil == 3.1.1 18:12:36 INFO - requests == 1.2.3 18:12:36 INFO - wsgiref == 0.1.2 18:12:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:36 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:12:36 INFO - Using env: {'DISPLAY': ':0', 18:12:36 INFO - 'HOME': '/home/cltbld', 18:12:36 INFO - 'LANG': 'en_US.UTF-8', 18:12:36 INFO - 'LANGUAGE': 'en_US:en', 18:12:36 INFO - 'LOGNAME': 'cltbld', 18:12:36 INFO - 'MAIL': '/var/mail/cltbld', 18:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:36 INFO - 'MOZ_NO_REMOTE': '1', 18:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:36 INFO - 'NO_EM_RESTART': '1', 18:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:36 INFO - 'PWD': '/builds/slave/test', 18:12:36 INFO - 'SHELL': '/bin/bash', 18:12:36 INFO - 'SHLVL': '1', 18:12:36 INFO - 'TERM': 'linux', 18:12:36 INFO - 'TMOUT': '86400', 18:12:36 INFO - 'USER': 'cltbld', 18:12:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:36 INFO - '_': '/tools/buildbot/bin/python'} 18:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:12:36 INFO - Cleaning up... 18:12:36 INFO - Return code: 0 18:12:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:36 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 0x7f999441ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:12:36 INFO - Using env: {'DISPLAY': ':0', 18:12:36 INFO - 'HOME': '/home/cltbld', 18:12:36 INFO - 'LANG': 'en_US.UTF-8', 18:12:36 INFO - 'LANGUAGE': 'en_US:en', 18:12:36 INFO - 'LOGNAME': 'cltbld', 18:12:36 INFO - 'MAIL': '/var/mail/cltbld', 18:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:36 INFO - 'MOZ_NO_REMOTE': '1', 18:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:36 INFO - 'NO_EM_RESTART': '1', 18:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:36 INFO - 'PWD': '/builds/slave/test', 18:12:36 INFO - 'SHELL': '/bin/bash', 18:12:36 INFO - 'SHLVL': '1', 18:12:36 INFO - 'TERM': 'linux', 18:12:36 INFO - 'TMOUT': '86400', 18:12:36 INFO - 'USER': 'cltbld', 18:12:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:36 INFO - '_': '/tools/buildbot/bin/python'} 18:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:36 INFO - Cleaning up... 18:12:36 INFO - Return code: 0 18:12:36 INFO - Running post-action listener: _resource_record_post_action 18:12:36 INFO - Running post-action listener: _start_resource_monitoring 18:12:36 INFO - Starting resource monitoring. 18:12:36 INFO - [mozharness: 2017-01-27 02:12:36.607415Z] Finished create-virtualenv step (success) 18:12:36 INFO - [mozharness: 2017-01-27 02:12:36.607916Z] Running install step. 18:12:36 INFO - Running pre-action listener: _resource_record_pre_action 18:12:36 INFO - Running main action method: install 18:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:36 INFO - Reading from file tmpfile_stdout 18:12:36 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:36 INFO - Reading from file tmpfile_stdout 18:12:36 INFO - Output received: 18:12:36 INFO - Usage: mozinstall [options] installer 18:12:36 INFO - Options: 18:12:36 INFO - -h, --help show this help message and exit 18:12:36 INFO - -d DEST, --destination=DEST 18:12:36 INFO - Directory to install application into. [default: 18:12:36 INFO - "/builds/slave/test"] 18:12:36 INFO - --app=APP Application being installed. [default: firefox] 18:12:36 INFO - mkdir: /builds/slave/test/build/application 18:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:12:50 INFO - Reading from file tmpfile_stdout 18:12:50 INFO - Output received: 18:12:50 INFO - /builds/slave/test/build/application/firefox/firefox 18:12:50 INFO - Running post-action listener: _resource_record_post_action 18:12:50 INFO - [mozharness: 2017-01-27 02:12:50.531035Z] Finished install step (success) 18:12:50 INFO - [mozharness: 2017-01-27 02:12:50.531278Z] Running run-tests step. 18:12:50 INFO - Running pre-action listener: _resource_record_pre_action 18:12:50 INFO - Running main action method: run_tests 18:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:50 INFO - Python 2.7.3 18:12:50 INFO - Return code: 0 18:12:50 INFO - grabbing minidump binary from tooltool 18:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:50 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 0x1a9cf60>, '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 0x1a9dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:12:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:12:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:12:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:50 INFO - Return code: 0 18:12:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:12:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:12:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:12:50 INFO - Using env: {'DISPLAY': ':0', 18:12:50 INFO - 'HOME': '/home/cltbld', 18:12:50 INFO - 'LANG': 'en_US.UTF-8', 18:12:50 INFO - 'LANGUAGE': 'en_US:en', 18:12:50 INFO - 'LOGNAME': 'cltbld', 18:12:50 INFO - 'MAIL': '/var/mail/cltbld', 18:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:50 INFO - 'MOZ_NO_REMOTE': '1', 18:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:50 INFO - 'NO_EM_RESTART': '1', 18:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:50 INFO - 'PWD': '/builds/slave/test', 18:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:50 INFO - 'SHELL': '/bin/bash', 18:12:50 INFO - 'SHLVL': '1', 18:12:50 INFO - 'TERM': 'linux', 18:12:50 INFO - 'TMOUT': '86400', 18:12:50 INFO - 'USER': 'cltbld', 18:12:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206', 18:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:50 INFO - '_': '/tools/buildbot/bin/python'} 18:12:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:12:50 INFO - mozversion application_buildid: 20170126162220 18:12:50 INFO - mozversion application_changeset: 560f5defe1af6334b77e179620a9907c7e693d9f 18:12:50 INFO - mozversion application_display_name: Firefox 18:12:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:50 INFO - mozversion application_name: Firefox 18:12:50 INFO - mozversion application_remotingname: firefox 18:12:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:12:50 INFO - mozversion application_vendor: Mozilla 18:12:50 INFO - mozversion application_version: 52.0 18:12:50 INFO - mozversion platform_buildid: 20170126162220 18:12:50 INFO - mozversion platform_changeset: 560f5defe1af6334b77e179620a9907c7e693d9f 18:12:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:12:50 INFO - mozversion platform_version: 52.0 18:12:50 INFO - using testdate: 1485483170 18:12:50 INFO - actual date: 1485483170 18:12:50 INFO - starting webserver on 'localhost:56618' 18:12:50 INFO - SUITE-START | Running 2 tests 18:12:50 INFO - TEST-START | dromaeo_css 18:12:50 INFO - operating with platform_type : linux_ 18:12:50 INFO - Initialising browser for dromaeo_css test... 18:12:50 INFO - TEST-INFO | started process 5376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7BACm/profile http://localhost:56618/getInfo.html) 18:12:55 INFO - PROCESS | 5376 | __metrics Screen width/height:1600/1200 18:12:55 INFO - PROCESS | 5376 | colorDepth:24 18:12:55 INFO - PROCESS | 5376 | Browser inner width/height: 1024/697 18:12:55 INFO - PROCESS | 5376 | __metrics 18:12:55 INFO - PROCESS | 5376 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:12:55 INFO - PROCESS | 5376 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:12:56 INFO - PROCESS | 5376 | console.error: PushService: 18:12:56 INFO - PROCESS | 5376 | stateChangeProcessEnqueue: Error transitioning state 18:12:56 INFO - PROCESS | 5376 | UnknownError 18:12:56 INFO - TEST-INFO | 5376: exit 0 18:12:56 INFO - Browser initialized. 18:12:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:56 INFO - TEST-INFO | started process 5470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7BACm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:08 INFO - PROCESS | 5470 | RSS: Main: 145276928 18:13:08 INFO - PROCESS | 5470 | 18:16:09 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:56618/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56618/tests/dromaeo/cssquery-ext.html) 18:16:10 INFO - PROCESS | 5470 | RSS: Main: 245661696 18:16:10 INFO - PROCESS | 5470 | 18:19:13 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:56618/tests/dromaeo/cssquery-ext.html (next: http://localhost:56618/tests/dromaeo/cssquery-jquery.html) 18:19:13 INFO - PROCESS | 5470 | RSS: Main: 228585472 18:19:13 INFO - PROCESS | 5470 | 18:22:15 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:56618/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56618/tests/dromaeo/cssquery-mootools.html) 18:22:16 INFO - PROCESS | 5470 | RSS: Main: 178937856 18:22:16 INFO - PROCESS | 5470 | 18:25:18 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:56618/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56618/tests/dromaeo/cssquery-prototype.html) 18:25:18 INFO - PROCESS | 5470 | RSS: Main: 216526848 18:25:18 INFO - PROCESS | 5470 | 18:28:21 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:56618/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56618/tests/dromaeo/cssquery-yui.html) 18:28:21 INFO - PROCESS | 5470 | RSS: Main: 177106944 18:28:21 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | Cycle 1(1): loaded http://localhost:56618/tests/dromaeo/cssquery-yui.html (next: http://localhost:56618/tests/dromaeo/cssquery-dojo.html) 18:31:24 INFO - PROCESS | 5470 | RSS: Main: 261226496 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | __start_tp_report 18:31:24 INFO - PROCESS | 5470 | _x_x_mozilla_page_load 18:31:24 INFO - PROCESS | 5470 | _x_x_mozilla_page_load_details 18:31:24 INFO - PROCESS | 5470 | |i|pagename|runs| 18:31:24 INFO - PROCESS | 5470 | |0;dojo.html;3228.564143840581;3252.495863141214;3270.182454386402;3288.4245257080006;3300.026492184805;5524.530414914732;5622.35342935562;5639.6334238274485;5642.069058605325;5645.576581756364;5696.344920334162;5767;5775.133729940511;5776.82669519914;5806.187133801272;5171.146760784475;5193.402758682762;5219.791208351661;5235.371755389358;5279.604029697788;4911.729854857981;4939;5277.393099793515;5290.338707661543;5313.840584782462;5039.7732102055315;5040.949590504085;5080.79676812927;5104.64267501275;5147.974260128694;5182.3262975813095;5198.558122559568;5270.578353731692;5278.287431196778;5295.682259064469;4884.829030983934;5110.718910459923;5183.688978661293;5222.477752224785;5237.240600113;5411.377691565481;5471.835844924659;5515.310586176728;5530.336359636869;5531.1426728857095;5958.165856780054;6036.0644100164545;6062.545309101791;6067.150598916155;6072;5774;6099.57302988791;6104.389561043905;6106.786262480792;6108.144859719643;5419.5393391561765;5531.2809334786625;5550.611457198038;5559.054960656698;5618.690971996498;6109;6121.4490695837585;6125.663088530174;6127.724252408652;6134.202553668084;5651.773929042874;5896.174535565025;5897.056470964625;5901.970490147608;5903.3801450847905;5773.653580785166;5936.8218953430605;5970.880582388415;5994.730237139339;6077.604955677867;6018.277806663228;6029.728662210211;6030.547708921848;6030.909536356959;6035.517158627299;5996.4003599640555;6048.425399587032;6049.304330002106;6054.606450580698;6068.726907289182;4507.616852567503;4528.456585209796;4599.770011499411;4631.652626052992;4635.7450340230935;4150.667946564267;4161.375793630919;4162.937555936664;4164.541900390955;4188.937165942513;5775.624584402;5777.62445441045;5781.075027995501;5792.420757924174;5797.768089276382;5808.651480911159;5830.41695830422;5892.558058145656;5911.586188966731;6053.27360716708;5725.456081672234;5730.398308177581;5740.712964351849;5747.626404283708;5773.39379365169;5135.6405051646025;5145.588352931756;5149.047426226085;5149.742512874342;5183.870403239874;6005.579609427386;6119.082137679384;6130.63216207029;6230.158928544679;6238.469730072995;5970.522358211246;6089.269287685506;6104.694765261808;6128.080787881675;6136.6011209271255;6300.275468321019;6326.240851097898;6332.810015699536;6341.112244285896;6348.587341822767;5690.231818704588;5716.657000579979;5987.281526216708;5990.101484777319;5993.910091348721;5932.377100404568;5964;5978.641281523122;6080.361562035922;6115.969420152871;5886.293644762656;5929;5941.821745347646;5942.286925568959;5942.376050514807;5566.248556444828;5909.084091965752;5928.970355148369;5929.0513517836935;5931.13998470228;5594.328680558359;5775.7400916957995;5801.680907550125;5805.419458054161;5906.940930590639;5949.405059494016;5966.164736936746;5968.343482217039;5969.194158788681;5977.671228082497;5634.718264086861;5660.122680984454;5684.289463817023;5813.302403711582;5829.650220986754 18:31:24 INFO - PROCESS | 5470 | |1;ext.html;577.8006587727235;625.4496043481737;629.9968500157498;632.4624069540888;639.3127388057839;35444.29111417774;46410.303845442344;47564.76217618916;47572.28641570379;47589.7620511897;48610.27084593734;49030.26454603184;49133.50866491334;49179.50820491794;49301;8493.915060849406;9026.142516460943;9151.405158664698;9165.266778657691;9171.266298696122;8565.95717021414;10738.838917416206;10995.285306455095;11014.339139651647;11315.490802913848;11125.666230013072;11200.831987520194;11210.27133236337;11210.327380357205;11212.10303175744;11042.723931901686;11084.778304433867;11093.3898635575;11094.057005154571;11098.50170227017;10874;10939;10940.781184376268;10948.835767463494;10960.56157753689;46638.300425493646;46727.29909051367;46811;46812.297815532795;46870.53129468696;3601.4237721964623;3668.046307959923;3860.3437415639128;4052.3111071117983;4321.252305698172;34342.82828585866;34390.48414273788;34542.82728586366;34808.47787283193;34828.651713482795;4586.816527338902;4650.767461626905;4653.906921861578;4671.392718946549;4676.041411510632;376335;377488;378342;378632;378689;68547.3145268541;68805.65597171983;68947.31052689509;68962;69097;41113.383299250534;41774;41840.16319673589;44603;44687.10625787466;19308.613827723366;19553.41339759781;19570;19596.216151353787;19603.411897643095;13836.930815345859;13906.93046534781;14396.352164152639;14895.329710163069;15162.696746065018;20329.390118296476;21355.46611334729;21457.78542214558;21473.355799326044;21540.784592154192;7438.5536867788105;7592.240775922363;7596.354309883612;7598.582077985653;7713.575753333621;1052.305478384278;1071.7052810477026;1101.9889801101885;1133.3992983718642;1137.670075678044;33911.152221194665;34066;34387.656123438945;34575.30849383049;34578.48132278018;1131.4569006876745;1137.113051819582;1146.2091157101572;1156.346664134761;1196.1626861197024;17799.911000444914;18209.180586873623;18230.45308640743;18253.17860696272;18268.54328641768;572913;575651;576095;576110;576465;64074.679626601566;64279.35720642827;64552.35447645558;64559;64632.676836615516;1311.672081979505;1373.0731756064815;1402.7895815627737;1428.057482061855;1457.154850186889;30254.394912102074;34728.305433891685;35427.29145417129;35561;35783.46324805182;56179;56770.71614641901;56779.71610141923;56811.71594142003;56982.430175697715;402025;404071;404318;404959;405814;28534.286642834097;29148.562771558867;29295.121146365644;30180.84909575438;30230.84884575651;49167;49490.50509495003;49497.25754113619;50240;50750;42392.788036060854;42436.575634243265;42948.926276843325;42995.78502107469;44095.77952110219;42676.14647706966;42910.35634465423;43403.78298108489;44268.335974961046;44406.77796610996;40685.98285042779;43404.78297608492;43645.345319820866;44352.778236108614;44746;35776;38639.6136038636;39194.21611567696;39380.40929386119;39594;29904.85047574748;30034.249143770707;30094.699053010067;30450.84774576113;30532 18:31:24 INFO - PROCESS | 5470 | |2;jquery.html;409.8872809977254;413.87169977307053;420.82325423322203;426.8954106243971;435.9193549193399;18807.905960470194;19613.607727845454;20457.590848183027;20473.283435079775;20841.374758757225;19378.031098445055;19448.902755486237;19494.512637184078;19794.406167814952;19841.503962400948;5831.88336233274;6029.457348838604;6053.061775424816;6055.969720151393;6064.818055458343;5775.249217601727;5908.88182236355;5921.378255283176;6007.219061521996;6012.128241404994;5914;5915.763369465216;5916.349201587822;5917.40825917407;5926.496247818941;5725.513331366818;5903.5572332074835;5903.704814759245;5906.05503119501;5936.465718085393;5334.706591137486;5339.038972984861;5344.0915044442145;5344.9732751336;5347.278117454132;23858.880705596534;24371.26886193417;24453.26640200797;24481.510369792682;24534.386640333956;2429.161939130997;2447.3636854417978;2488.30327508298;2759.1998320487037;2869.727375899286;14988.700225995528;15188.772168417483;15351.385944562204;15425.691486170326;16153.192340382933;1992.980070199294;2015.9798402015938;2044.0801639262243;2058.073866759964;2080.251109600543;82141;83268.58365708133;84093.57953210257;84396.57801710952;84921.15078849194;11056.447177641086;11151.330920144817;11159.38623375722;11202.327860328407;11374.838780631653;15435.228238588026;15454.768178477332;15455;15469.84530154684;15483.84516154824;8396.118407567117;8397;8503.319734421231;8622.956885215659;8690.391672582986;8432.45189062709;8477.23704866565;8518.531480768617;8695.956520217485;8732.476051436934;6840.931590684129;6930.237673855871;6932.688029038705;7006.601798127904;7089.149302083783;1910.5414700471786;1976.940691779249;1984.9404517864486;2001.8298444632078;2045.5295282085203;935.4013431403907;984.3798407003685;993.7465946183677;1008.2135933971514;1123.6572845282267;20080.297189598587;20931.47671308199;20968.89515552443;21172.682409763867;21272.893635531724;1024.4877561219391;1053.262716098734;1066.4880857188439;1070.063694267516;1085.6525911708177;10955.34267943926;11792.469338879771;12115.212511186744;12117.697057573454;12160.635180944586;476003;481286;497951;503772;504263;78330.6083469579;83705;85030;85043;85409.57295213484;1055.6516349604765;1060.55986765493;1087.9238453308192;1092.257265059751;1095.2990086344746;17631.294748209926;17874.46376608704;18303.816961830744;18480.63038739191;18789.96655183978;45738.54261457343;46253.30620040635;46918.53081469142;47073.293900590834;47671.523284768096;61746.38253617406;62142;62537.68731156315;63109.36890631035;63976.36023639704;8808.823823523366;9118.863217051618;9137;9193.908060919573;9318.813623727623;10113.5448904798;13357.198568085945;13693.931530342285;14201.573952781433;14437.711245775236;11927.582534611594;12249.938750306192;12331.198472099284;12456.439460224494;12730.554430595255;11888.227265228079;11996.76006479883;12105.636830895088;12131.696707582381;12216.938915305367;12118.333491657691;12228.388580571114;12484.937575312066;12564.937175314431;12619.053570982396;8809.471431714117;8987.236084932592;9109.407888487227;9209.401388909699;9295.163435290857;9674.274429417681;11995.460204290654;12397.504099836266;12427.502899883903;12544.31006294626 18:31:24 INFO - PROCESS | 5470 | |3;mootools.html;1374.1686279800726;1521.1329542160966;1546.5515000649812;1698.3885801111605;1874.5594785225478;7889.723859664913;8864.601092950817;9085.40944838585;9109.544522773867;9328.766780830465;9054.864177037332;9110.772230694236;9133.634654613808;9134.269258459324;9136.543172841364;2386.8209884258663;2415.2995631266913;2415.5651982643117;2417.540667273221;2425.514897020594;2417.9153729619466;2441.9377570756687;2477.863717495537;2480.3675062858947;2482.751724827521;2387.3673476528647;2406.3021723700194;2416.6858308419883;2420.092465325503;2428.3564855313357;2309.6997390339316;2336.754640762721;2339.204670412051;2355.634876594122;2356.45801465663;2299.0344055496566;2323.2449453927543;2351.130081869719;2355.0344358812977;2355.587772139869;8933.374663773538;9008.549572521348;9066.5920033598;9069.546522673905;9069.727908162766;5349.5720342372515;5548.861278468071;5562.638428502134;5564.4991950724625;5567.2762540869835;3355.4966754986704;3501.159721666807;3552.271784284241;3558.395072837624;3561.5013898054294;1193.8746431624727;1198.2630682130514;1221.7617564574823;1247.9563215287421;1271.3071376100047;12139.575114870937;12256.81614775779;12274.570390036306;12310.13829031968;12315.75368492643;4353.325234588644;4649.349480934287;4732.976335118303;4735.668503204812;4752.097101550694;9946.552405141785;9951.054649808257;9966.103050725469;9966.302358834957;9970.50147492637;5382.650127741685;5398.055340315507;5402.243685883979;5402.702851343135;5411.702356370359;4174.227767862955;4334.414853994734;4547.045120524727;4990.2764099205415;5072.644914855925;3824.9808750956067;3854.190619969838;3951.6838652908273;3959.7228194026143;3966.1076257842333;1197.9221350612183;1226.399064458409;1226.4603574427224;1232.6979889926845;1237.8638349781518;989.6734077754468;1003.2275148135894;1013.6654903881702;1024.7591815923251;1037.8443233514881;6021.187139736167;6063.999440092335;6102.786402475892;6366.554341196072;6396.584222025646;433.6552440809564;451.23740877916214;455.6354916067133;458.191292368969;1036.8185567525804;3924.3524818404644;4149.605787450188;4190.53904070552;4200.789960501963;4290.635295999875;11192.776144477228;11419.60031398897;11468.254563453349;11470.254433461798;11572.47923843429;11036.11711063113;11119.666410007712;11332.320060796379;11390.430478476042;11410.543578256942;8346.165383461726;8346.4157508975;8514.74455766328;8529.061803201643;8530.189631984951;5926.585139040399;6069.362716914837;6131.938680613137;6189.690515474298;6204.069389591597;10212.489375531046;10363.015513526203;10367.844482332923;10377.429241391494;10382.273240873066;9081.54592270397;9345.018773028734;10488.05607495329;10558.736031599272;10567.418791966209;6996;7241.5293005954445;7250.9637451812405;7326.120865496175;7403.629818508945;8606.354523410644;8610.913890861011;8624.310055195443;8633.91366086331;8658.177473140042;7609.429292802951;7738.651760670671;7821.335186508983;7839.490433122057;7851.214878512332;7559.5464272143845;7731.729389471341;7732.420068494998;7782.299593036428;7963.044434667877;6755.256921738506;6847.828804279933;6848.3494068063455;6852.417544508772;6859.519833611599;5132.3327967364;5246.868828279171;5343.732813359395;5345.866353341197;5512.724363781715;5042.193249080129;5170.948290517047;5256.789728410974;5258.106121959199;5423.728813559385 18:31:24 INFO - PROCESS | 5470 | |4;prototype.html;350.71767227381946;353.3057541930108;360.9602943676195;362.89838845123376;363.3332834249153;5503.761653627932;5510.760078982237;5547;5578.330600327956;5598.636088654234;5153.76808043638;5271.182966640167;5293.6294459387855;5386.569074474042;5427.185922111686;4299.935500967473;4304.117655880553;4311.870643880673;4329.242382583051;4338.457692788402;4303.376010478479;4310.310350343945;4320.675949303799;4334.804933777988;4336;4053.5204650302576;4230.625046859767;4251.97874010631;4252.766097864616;4280.208161490119;4225.753402746166;4235.152969406131;4235.639970602502;4257.233697934371;4258.850940217078;3756.398976163801;3763.172102137525;3770.886873393775;3772.2832661794173;3778.6599206071587;5197.246399272084;5290.55030322423;5290.788368465257;5331.493508116722;5338.893222135574;4868.488808675073;4884.120858245515;4892.192788189945;4906.632002599784;4907.312976183337;5649.4633009864;5655.349634791969;5684.943150568482;5686.687232202227;5712.400197979236;3935.4490371348033;4085.1421201547414;4108.534879072562;4162.064639942441;4183.6234738873345;5896.705164741746;5914.940850591482;5927.2590926134235;5937.376575459601;5938.584299099065;4247.97876010618;4257.297545904891;4257.957420425756;4266.360045993064;4274.2733735264455;4187.32290224451;4279.743215407086;4304.5480224576595;4326.766871441624;4327.879339123807;4848.612111031109;4865.245886887538;4886.291487734258;4907.582855457326;4933.827316043921;5727.971360143172;5736.483716465538;5736.655800651891;5768.826935191951;5785.27684039495;1378.4692893236177;1435.2608406670572;1440.4670271999219;1441.445043658178;1449.159487497249;980.6562316064611;990.4057565460666;999.5701848205196;1000.1948431512557;1004.5233506745074;5302.893942121136;5307.522322990872;5344.198370244494;5367.329083864517;5396.21754845553;5599.972000139973;5621.213030175779;5621.690807005654;5633.661980281115;5647;5245.685258884403;5334.679919204783;5337.919931201035;5416.9729151353995;5425.376081750649;2957.3050333171686;2980.1953472562286;2981.6869228731107;3013.352129292213;3014.623172103487;5836.941630583639;5867.735951882176;5880.794172203952;5884.323302820145;5899.46904778572;5453.945460545344;5702.971485142548;5719.7712091516705;5720.685362305113;5762.683052432073;5841.299044114733;5859.853503662443;5862.886051650258;5865.35481097079;5878.676672782953;5573.191887176417;5597.216389705363;5614.803481878114;5640.182173584889;5909.70451477433;5869.354371019099;5876.236089308362;5877;5883.676397798162;5890.617109888015;6132.202813634199;6167.876642467215;6168.290646575521;6194.907076393948;6196.659183744938;4034.4150098235004;4044.4742183515955;4191.245575796386;4199.643030342455;4211.399668126215;5749.252597162509;5765.164051212467;5869.295684517885;5893.406900963734;5918.822435326947;5765.183967050366;5769.59612827098;5778.728679690461;5780.364159942487;5781.4507621775865;5638.802641907513;5698.230738850202;5733.3406658234835;5751;5761.8559536011935;5665.12190610456;5666.090397625625;5681.829545113488;5687.554351628839;5696.715164241688;5638.971805140948;5769.798057067983;5778.56660750437;5803.274590676166;5814.592978491634;5601.663900166003;5603.551715862803;5649.887002259849;5651.4348565143155;5664.5751568631695 18:31:24 INFO - PROCESS | 5470 | |5;yui.html;775.2247752247753;802.8394321135771;817.1297568089984;862.693743720979;891.8662200669895;12970.351482425876;14410.423583056678;14424.27878606068;14779;14862.628434289134;13228.867711322884;13363.465461381533;14417.990740648158;14784.334704938277;14904.18027008514;742.8699977503942;861.6424183963663;873.0963452826326;877.1842186766305;877.6664867350398;754.5548126605302;840.815020695446;861.9267362274214;866.164151593712;876.2508055612456;921.0973246218709;922.9400088994194;924.0620769918538;924.1682485762834;924.2790623313792;914.1224424552438;922.6032805893464;922.6401703335705;922.9584668689891;923.9630414783401;675.0549231076483;677.4580335731396;677.7255211639294;678.3250665587723;678.6335378895391;13802.102863313852;13816.861831381659;13820.585382438543;13905.374258158407;13926.303684815719;14354.64113397163;14937.775933361008;15376.846231537653;15458.1498017609;15509.379624814994;12284.14011019229;12401.75196496074;12418.751624967541;12557.372131393393;12597.937010314981;3756.4177552479136;3782.829772660237;3786.772793632363;3826.2730081284744;3896.045468860119;63891;65902.3409765901;66700.33299667039;67042.66478667624;69529.30470695329;11186.440677966231;11701.356425396685;11755;11759.529618815322;12011.87988120125;22086.889565552392;22344.776552234594;22411.88794056019;22566.21018264353;22734;8495.1080136586;8502.574871256413;8552.61513231906;8670.219680228809;8692.348073894484;4671.602913752301;4962.702237865739;4981.078500477423;4988.326575912205;5006.849794506171;3639.836207370675;3761.3417651910804;3773.3208022555655;3774.6225377462033;3775.6224377562025;595.4730063893486;600.7596961215548;602.1690067706537;602.5029350785532;604.1873679900526;620.1565870416231;626.5582764151262;673.1659712609869;738.1474397071283;754.607604045893;9638.855417168748;9850;10109.39343639384;10138.188944884392;10203.693889183336;609.2110716621985;621.6145989486547;719.2591630620469;726.2628432141381;743.4572761883855;4700.412448443944;4811.687240329367;4831.758412079453;4995.200767877122;5020.849374518771;62127;91214.0878591219;95591.52204238935;96133.5193324029;97177;82787.5860620705;82806;83887;86217.56891215504;88829;73645;73714.26285737181;74089.25910740823;74599.25400745923;76508;9261.44431334122;9475.47884866339;9556.610847288179;9670.854937175807;9730.318877678494;36053;37604;48943.26585101155;50485.49514504808;52044;38620.420693689055;39506;56505.43494565002;57177.01806347315;66991.66504167448;11530.82703759461;11637.709057273636;11874.643760687193;12308.384580770746;12954;13158.934205328913;13741.656458588615;13864.168149911038;14086.295685215493;14146.22195779242;12313.199642023239;12428.81356779631;12950.97224365056;13228.007899407776;13425.127366721132;11756.118291128028;11871.76256474883;12150.878491214975;12442.937785311016;12937.223766574036;12605.684857878627;12835.550755723878;12914.67713307175;13280.136791108547;13317.067805253539;10063.446510441996;10083.596656133966;10131.240156988108;10173.898261017592;10214.693559193236;10205.438700871524;10231;10482.318649288078;10588.470576470992;10628.946855265674 18:31:24 INFO - PROCESS | 5470 | __end_tp_report 18:31:24 INFO - PROCESS | 5470 | __start_cc_report 18:31:24 INFO - PROCESS | 5470 | _x_x_mozilla_cycle_collect,1061 18:31:24 INFO - PROCESS | 5470 | __end_cc_report 18:31:24 INFO - PROCESS | 5470 | __startTimestamp1485484284314__endTimestamp 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | ------- Summary: start ------- 18:31:24 INFO - PROCESS | 5470 | Number of tests: 6 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | [#0] dojo.html Cycles:165 Average:5593.86 Median:5781.08 stddev:628.80 (10.9%) stddev-sans-first:602.73 18:31:24 INFO - PROCESS | 5470 | Values: 3228.6 3252.5 3270.2 3288.4 3300.0 5524.5 5622.4 5639.6 5642.1 5645.6 5696.3 5767.0 5775.1 5776.8 5806.2 5171.1 5193.4 5219.8 5235.4 5279.6 4911.7 4939.0 5277.4 5290.3 5313.8 5039.8 5040.9 5080.8 5104.6 5148.0 5182.3 5198.6 5270.6 5278.3 5295.7 4884.8 5110.7 5183.7 5222.5 5237.2 5411.4 5471.8 5515.3 5530.3 5531.1 5958.2 6036.1 6062.5 6067.2 6072.0 5774.0 6099.6 6104.4 6106.8 6108.1 5419.5 5531.3 5550.6 5559.1 5618.7 6109.0 6121.4 6125.7 6127.7 6134.2 5651.8 5896.2 5897.1 5902.0 5903.4 5773.7 5936.8 5970.9 5994.7 6077.6 6018.3 6029.7 6030.5 6030.9 6035.5 5996.4 6048.4 6049.3 6054.6 6068.7 4507.6 4528.5 4599.8 4631.7 4635.7 4150.7 4161.4 4162.9 4164.5 4188.9 5775.6 5777.6 5781.1 5792.4 5797.8 5808.7 5830.4 5892.6 5911.6 6053.3 5725.5 5730.4 5740.7 5747.6 5773.4 5135.6 5145.6 5149.0 5149.7 5183.9 6005.6 6119.1 6130.6 6230.2 6238.5 5970.5 6089.3 6104.7 6128.1 6136.6 6300.3 6326.2 6332.8 6341.1 6348.6 5690.2 5716.7 5987.3 5990.1 5993.9 5932.4 5964.0 5978.6 6080.4 6116.0 5886.3 5929.0 5941.8 5942.3 5942.4 5566.2 5909.1 5929.0 5929.1 5931.1 5594.3 5775.7 5801.7 5805.4 5906.9 5949.4 5966.2 5968.3 5969.2 5977.7 5634.7 5660.1 5684.3 5813.3 5829.7 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | [#1] ext.html Cycles:180 Average:62742.99 Median:39287.31 stddev:122037.77 (310.6%) stddev-sans-first:122290.86 18:31:24 INFO - PROCESS | 5470 | Values: 577.8 625.4 630.0 632.5 639.3 35444.3 46410.3 47564.8 47572.3 47589.8 48610.3 49030.3 49133.5 49179.5 49301.0 8493.9 9026.1 9151.4 9165.3 9171.3 8566.0 10738.8 10995.3 11014.3 11315.5 11125.7 11200.8 11210.3 11210.3 11212.1 11042.7 11084.8 11093.4 11094.1 11098.5 10874.0 10939.0 10940.8 10948.8 10960.6 46638.3 46727.3 46811.0 46812.3 46870.5 3601.4 3668.0 3860.3 4052.3 4321.3 34342.8 34390.5 34542.8 34808.5 34828.7 4586.8 4650.8 4653.9 4671.4 4676.0 376335.0 377488.0 378342.0 378632.0 378689.0 68547.3 68805.7 68947.3 68962.0 69097.0 41113.4 41774.0 41840.2 44603.0 44687.1 19308.6 19553.4 19570.0 19596.2 19603.4 13836.9 13906.9 14396.4 14895.3 15162.7 20329.4 21355.5 21457.8 21473.4 21540.8 7438.6 7592.2 7596.4 7598.6 7713.6 1052.3 1071.7 1102.0 1133.4 1137.7 33911.2 34066.0 34387.7 34575.3 34578.5 1131.5 1137.1 1146.2 1156.3 1196.2 17799.9 18209.2 18230.5 18253.2 18268.5 572913.0 575651.0 576095.0 576110.0 576465.0 64074.7 64279.4 64552.4 64559.0 64632.7 1311.7 1373.1 1402.8 1428.1 1457.2 30254.4 34728.3 35427.3 35561.0 35783.5 56179.0 56770.7 56779.7 56811.7 56982.4 402025.0 404071.0 404318.0 404959.0 405814.0 28534.3 29148.6 29295.1 30180.8 30230.8 49167.0 49490.5 49497.3 50240.0 50750.0 42392.8 42436.6 42948.9 42995.8 44095.8 42676.1 42910.4 43403.8 44268.3 44406.8 40686.0 43404.8 43645.3 44352.8 44746.0 35776.0 38639.6 39194.2 39380.4 39594.0 29904.9 30034.2 30094.7 30450.8 30532.0 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | [#2] jquery.html Cycles:180 Average:29711.46 Median:13464.44 stddev:81086.64 (602.2%) stddev-sans-first:81284.27 18:31:24 INFO - PROCESS | 5470 | Values: 409.9 413.9 420.8 426.9 435.9 18807.9 19613.6 20457.6 20473.3 20841.4 19378.0 19448.9 19494.5 19794.4 19841.5 5831.9 6029.5 6053.1 6056.0 6064.8 5775.2 5908.9 5921.4 6007.2 6012.1 5914.0 5915.8 5916.3 5917.4 5926.5 5725.5 5903.6 5903.7 5906.1 5936.5 5334.7 5339.0 5344.1 5345.0 5347.3 23858.9 24371.3 24453.3 24481.5 24534.4 2429.2 2447.4 2488.3 2759.2 2869.7 14988.7 15188.8 15351.4 15425.7 16153.2 1993.0 2016.0 2044.1 2058.1 2080.3 82141.0 83268.6 84093.6 84396.6 84921.2 11056.4 11151.3 11159.4 11202.3 11374.8 15435.2 15454.8 15455.0 15469.8 15483.8 8396.1 8397.0 8503.3 8623.0 8690.4 8432.5 8477.2 8518.5 8696.0 8732.5 6840.9 6930.2 6932.7 7006.6 7089.1 1910.5 1976.9 1984.9 2001.8 2045.5 935.4 984.4 993.7 1008.2 1123.7 20080.3 20931.5 20968.9 21172.7 21272.9 1024.5 1053.3 1066.5 1070.1 1085.7 10955.3 11792.5 12115.2 12117.7 12160.6 476003.0 481286.0 497951.0 503772.0 504263.0 78330.6 83705.0 85030.0 85043.0 85409.6 1055.7 1060.6 1087.9 1092.3 1095.3 17631.3 17874.5 18303.8 18480.6 18790.0 45738.5 46253.3 46918.5 47073.3 47671.5 61746.4 62142.0 62537.7 63109.4 63976.4 8808.8 9118.9 9137.0 9193.9 9318.8 10113.5 13357.2 13693.9 14201.6 14437.7 11927.6 12249.9 12331.2 12456.4 12730.6 11888.2 11996.8 12105.6 12131.7 12216.9 12118.3 12228.4 12484.9 12564.9 12619.1 8809.5 8987.2 9109.4 9209.4 9295.2 9674.3 11995.5 12397.5 12427.5 12544.3 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | [#3] mootools.html Cycles:180 Average:5864.54 Median:2553.77 stddev:3340.70 (130.8%) stddev-sans-first:3333.03 18:31:24 INFO - PROCESS | 5470 | Values: 1374.2 1521.1 1546.6 1698.4 1874.6 7889.7 8864.6 9085.4 9109.5 9328.8 9054.9 9110.8 9133.6 9134.3 9136.5 2386.8 2415.3 2415.6 2417.5 2425.5 2417.9 2441.9 2477.9 2480.4 2482.8 2387.4 2406.3 2416.7 2420.1 2428.4 2309.7 2336.8 2339.2 2355.6 2356.5 2299.0 2323.2 2351.1 2355.0 2355.6 8933.4 9008.5 9066.6 9069.5 9069.7 5349.6 5548.9 5562.6 5564.5 5567.3 3355.5 3501.2 3552.3 3558.4 3561.5 1193.9 1198.3 1221.8 1248.0 1271.3 12139.6 12256.8 12274.6 12310.1 12315.8 4353.3 4649.3 4733.0 4735.7 4752.1 9946.6 9951.1 9966.1 9966.3 9970.5 5382.7 5398.1 5402.2 5402.7 5411.7 4174.2 4334.4 4547.0 4990.3 5072.6 3825.0 3854.2 3951.7 3959.7 3966.1 1197.9 1226.4 1226.5 1232.7 1237.9 989.7 1003.2 1013.7 1024.8 1037.8 6021.2 6064.0 6102.8 6366.6 6396.6 433.7 451.2 455.6 458.2 1036.8 3924.4 4149.6 4190.5 4200.8 4290.6 11192.8 11419.6 11468.3 11470.3 11572.5 11036.1 11119.7 11332.3 11390.4 11410.5 8346.2 8346.4 8514.7 8529.1 8530.2 5926.6 6069.4 6131.9 6189.7 6204.1 10212.5 10363.0 10367.8 10377.4 10382.3 9081.5 9345.0 10488.1 10558.7 10567.4 6996.0 7241.5 7251.0 7326.1 7403.6 8606.4 8610.9 8624.3 8633.9 8658.2 7609.4 7738.7 7821.3 7839.5 7851.2 7559.5 7731.7 7732.4 7782.3 7963.0 6755.3 6847.8 6848.3 6852.4 6859.5 5132.3 5246.9 5343.7 5345.9 5512.7 5042.2 5170.9 5256.8 5258.1 5423.7 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | [#4] prototype.html Cycles:180 Average:4792.75 Median:5426.28 stddev:1398.33 (25.8%) stddev-sans-first:1361.92 18:31:24 INFO - PROCESS | 5470 | Values: 350.7 353.3 361.0 362.9 363.3 5503.8 5510.8 5547.0 5578.3 5598.6 5153.8 5271.2 5293.6 5386.6 5427.2 4299.9 4304.1 4311.9 4329.2 4338.5 4303.4 4310.3 4320.7 4334.8 4336.0 4053.5 4230.6 4252.0 4252.8 4280.2 4225.8 4235.2 4235.6 4257.2 4258.9 3756.4 3763.2 3770.9 3772.3 3778.7 5197.2 5290.6 5290.8 5331.5 5338.9 4868.5 4884.1 4892.2 4906.6 4907.3 5649.5 5655.3 5684.9 5686.7 5712.4 3935.4 4085.1 4108.5 4162.1 4183.6 5896.7 5914.9 5927.3 5937.4 5938.6 4248.0 4257.3 4258.0 4266.4 4274.3 4187.3 4279.7 4304.5 4326.8 4327.9 4848.6 4865.2 4886.3 4907.6 4933.8 5728.0 5736.5 5736.7 5768.8 5785.3 1378.5 1435.3 1440.5 1441.4 1449.2 980.7 990.4 999.6 1000.2 1004.5 5302.9 5307.5 5344.2 5367.3 5396.2 5600.0 5621.2 5621.7 5633.7 5647.0 5245.7 5334.7 5337.9 5417.0 5425.4 2957.3 2980.2 2981.7 3013.4 3014.6 5836.9 5867.7 5880.8 5884.3 5899.5 5453.9 5703.0 5719.8 5720.7 5762.7 5841.3 5859.9 5862.9 5865.4 5878.7 5573.2 5597.2 5614.8 5640.2 5909.7 5869.4 5876.2 5877.0 5883.7 5890.6 6132.2 6167.9 6168.3 6194.9 6196.7 4034.4 4044.5 4191.2 4199.6 4211.4 5749.3 5765.2 5869.3 5893.4 5918.8 5765.2 5769.6 5778.7 5780.4 5781.5 5638.8 5698.2 5733.3 5751.0 5761.9 5665.1 5666.1 5681.8 5687.6 5696.7 5639.0 5769.8 5778.6 5803.3 5814.6 5601.7 5603.6 5649.9 5651.4 5664.6 18:31:24 INFO - PROCESS | 5470 | 18:31:24 INFO - PROCESS | 5470 | [#5] yui.html Cycles:180 Average:18117.10 Median:26887.51 stddev:24372.34 (90.6%) stddev-sans-first:24405.92 18:31:24 INFO - PROCESS | 5470 | Values: 775.2 802.8 817.1 862.7 891.9 12970.4 14410.4 14424.3 14779.0 14862.6 13228.9 13363.5 14418.0 14784.3 14904.2 742.9 861.6 873.1 877.2 877.7 754.6 840.8 861.9 866.2 876.3 921.1 922.9 924.1 924.2 924.3 914.1 922.6 922.6 923.0 924.0 675.1 677.5 677.7 678.3 678.6 13802.1 13816.9 13820.6 13905.4 13926.3 14354.6 14937.8 15376.8 15458.1 15509.4 12284.1 12401.8 12418.8 12557.4 12597.9 3756.4 3782.8 3786.8 3826.3 3896.0 63891.0 65902.3 66700.3 67042.7 69529.3 11186.4 11701.4 11755.0 11759.5 12011.9 22086.9 22344.8 22411.9 22566.2 22734.0 8495.1 8502.6 8552.6 8670.2 8692.3 4671.6 4962.7 4981.1 4988.3 5006.8 3639.8 3761.3 3773.3 3774.6 3775.6 595.5 600.8 602.2 602.5 604.2 620.2 626.6 673.2 738.1 754.6 9638.9 9850.0 10109.4 10138.2 10203.7 609.2 621.6 719.3 726.3 743.5 4700.4 4811.7 4831.8 4995.2 5020.8 62127.0 91214.1 95591.5 96133.5 97177.0 82787.6 82806.0 83887.0 86217.6 88829.0 73645.0 73714.3 74089.3 74599.3 76508.0 9261.4 9475.5 9556.6 9670.9 9730.3 36053.0 37604.0 48943.3 50485.5 52044.0 38620.4 39506.0 56505.4 57177.0 66991.7 11530.8 11637.7 11874.6 12308.4 12954.0 13158.9 13741.7 13864.2 14086.3 14146.2 12313.2 12428.8 12951.0 13228.0 13425.1 11756.1 11871.8 12150.9 12442.9 12937.2 12605.7 12835.6 12914.7 13280.1 13317.1 10063.4 10083.6 10131.2 10173.9 10214.7 10205.4 10231.0 10482.3 10588.5 10628.9 18:31:24 INFO - PROCESS | 5470 | -------- Summary: end -------- 18:31:24 INFO - PROCESS | 5470 | 18:31:25 INFO - TEST-INFO | 5470: exit 0 18:31:25 INFO - TEST-OK | dromaeo_css | took 1114235ms 18:31:25 INFO - TEST-START | kraken 18:31:25 INFO - operating with platform_type : linux_ 18:31:25 INFO - Initialising browser for kraken test... 18:31:25 INFO - TEST-INFO | started process 5777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSmW0ow/profile http://localhost:56618/getInfo.html) 18:31:28 INFO - PROCESS | 5777 | __metrics Screen width/height:1600/1200 18:31:28 INFO - PROCESS | 5777 | colorDepth:24 18:31:28 INFO - PROCESS | 5777 | Browser inner width/height: 1024/697 18:31:28 INFO - PROCESS | 5777 | __metrics 18:31:29 INFO - PROCESS | 5777 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:31:29 INFO - PROCESS | 5777 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:31:30 INFO - PROCESS | 5777 | console.error: PushService: 18:31:30 INFO - PROCESS | 5777 | stateChangeProcessEnqueue: Error transitioning state 18:31:30 INFO - PROCESS | 5777 | UnknownError 18:31:30 INFO - TEST-INFO | 5777: exit 0 18:31:30 INFO - Browser initialized. 18:31:30 INFO - Running cycle 1/1 for kraken test... 18:31:30 INFO - TEST-INFO | started process 5870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSmW0ow/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:42 INFO - PROCESS | 5870 | RSS: Main: 141565952 18:31:42 INFO - PROCESS | 5870 | 18:31:44 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56618/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:45 INFO - PROCESS | 5870 | RSS: Main: 183844864 18:31:45 INFO - PROCESS | 5870 | 18:31:48 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56618/tests/kraken/driver.html?testName=audio-dft) 18:31:48 INFO - PROCESS | 5870 | RSS: Main: 172916736 18:31:48 INFO - PROCESS | 5870 | 18:31:51 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56618/tests/kraken/driver.html?testName=audio-fft) 18:31:52 INFO - PROCESS | 5870 | RSS: Main: 264384512 18:31:52 INFO - PROCESS | 5870 | 18:31:54 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56618/tests/kraken/driver.html?testName=audio-oscillator) 18:31:54 INFO - PROCESS | 5870 | RSS: Main: 171106304 18:31:54 INFO - PROCESS | 5870 | 18:31:56 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56618/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:57 INFO - PROCESS | 5870 | RSS: Main: 173330432 18:31:57 INFO - PROCESS | 5870 | 18:32:00 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56618/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:01 INFO - PROCESS | 5870 | RSS: Main: 210350080 18:32:01 INFO - PROCESS | 5870 | 18:32:04 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56618/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:04 INFO - PROCESS | 5870 | RSS: Main: 210694144 18:32:04 INFO - PROCESS | 5870 | 18:32:07 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56618/tests/kraken/driver.html?testName=json-parse-financial) 18:32:08 INFO - PROCESS | 5870 | RSS: Main: 209231872 18:32:08 INFO - PROCESS | 5870 | 18:32:09 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56618/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:10 INFO - PROCESS | 5870 | RSS: Main: 171110400 18:32:10 INFO - PROCESS | 5870 | 18:32:11 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:12 INFO - PROCESS | 5870 | RSS: Main: 178888704 18:32:12 INFO - PROCESS | 5870 | 18:32:14 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:15 INFO - PROCESS | 5870 | RSS: Main: 188518400 18:32:15 INFO - PROCESS | 5870 | 18:32:17 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:18 INFO - PROCESS | 5870 | RSS: Main: 196575232 18:32:18 INFO - PROCESS | 5870 | 18:32:20 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:21 INFO - PROCESS | 5870 | RSS: Main: 192634880 18:32:21 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | Cycle 1(1): loaded http://localhost:56618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56618/tests/kraken/driver.html?testName=ai-astar) 18:32:23 INFO - PROCESS | 5870 | RSS: Main: 245219328 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | __start_tp_report 18:32:23 INFO - PROCESS | 5870 | _x_x_mozilla_page_load 18:32:23 INFO - PROCESS | 5870 | _x_x_mozilla_page_load_details 18:32:23 INFO - PROCESS | 5870 | |i|pagename|runs| 18:32:23 INFO - PROCESS | 5870 | |0;ai-astar;102;113;112;111;111;112;111;111;113;112 18:32:23 INFO - PROCESS | 5870 | |1;audio-beat-detection;145;122;117;163;124;123;118;117;148;118 18:32:23 INFO - PROCESS | 5870 | |2;audio-dft;162;160;160;161;160;161;159;161;161;160 18:32:23 INFO - PROCESS | 5870 | |3;audio-fft;74;75;77;122;76;75;77;76;107;86 18:32:23 INFO - PROCESS | 5870 | |4;audio-oscillator;82;82;110;82;82;81;98;81;81;109 18:32:23 INFO - PROCESS | 5870 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 18:32:23 INFO - PROCESS | 5870 | |6;imaging-darkroom;145;146;147;146;146;146;145;146;146;145 18:32:23 INFO - PROCESS | 5870 | |7;imaging-desaturate;85;85;85;85;84;84;84;85;84;85 18:32:23 INFO - PROCESS | 5870 | |8;json-parse-financial;50;51;50;49;50;51;52;49;50;49 18:32:23 INFO - PROCESS | 5870 | |9;json-stringify-tinderbox;60;60;68;60;60;59;58;60;60;60 18:32:23 INFO - PROCESS | 5870 | |10;stanford-crypto-aes;76;77;75;76;77;75;82;76;75;74 18:32:23 INFO - PROCESS | 5870 | |11;stanford-crypto-ccm;121;129;130;122;119;136;121;131;175;120 18:32:23 INFO - PROCESS | 5870 | |12;stanford-crypto-pbkdf2;157;155;154;161;163;160;158;156;159;157 18:32:23 INFO - PROCESS | 5870 | |13;stanford-crypto-sha256-iterative;64;69;63;66;63;63;66;62;63;61 18:32:23 INFO - PROCESS | 5870 | __end_tp_report 18:32:23 INFO - PROCESS | 5870 | __start_cc_report 18:32:23 INFO - PROCESS | 5870 | _x_x_mozilla_cycle_collect,1561 18:32:23 INFO - PROCESS | 5870 | __end_cc_report 18:32:23 INFO - PROCESS | 5870 | __startTimestamp1485484343479__endTimestamp 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | ------- Summary: start ------- 18:32:23 INFO - PROCESS | 5870 | Number of tests: 14 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.19 (2.8%) stddev-sans-first:0.83 18:32:23 INFO - PROCESS | 5870 | Values: 102.0 113.0 112.0 111.0 111.0 112.0 111.0 111.0 113.0 112.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:123.50 stddev:16.37 (13.3%) stddev-sans-first:16.37 18:32:23 INFO - PROCESS | 5870 | Values: 145.0 122.0 117.0 163.0 124.0 123.0 118.0 117.0 148.0 118.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 18:32:23 INFO - PROCESS | 5870 | Values: 162.0 160.0 160.0 161.0 160.0 161.0 159.0 161.0 161.0 160.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.00 stddev:16.54 (21.8%) stddev-sans-first:17.10 18:32:23 INFO - PROCESS | 5870 | Values: 74.0 75.0 77.0 122.0 76.0 75.0 77.0 76.0 107.0 86.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:12.06 (14.7%) stddev-sans-first:12.54 18:32:23 INFO - PROCESS | 5870 | Values: 82.0 82.0 110.0 82.0 82.0 81.0 98.0 81.0 81.0 109.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:32:23 INFO - PROCESS | 5870 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 18:32:23 INFO - PROCESS | 5870 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 18:32:23 INFO - PROCESS | 5870 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 85.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.99 (2.0%) stddev-sans-first:1.05 18:32:23 INFO - PROCESS | 5870 | Values: 50.0 51.0 50.0 49.0 50.0 51.0 52.0 49.0 50.0 49.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:2.72 (4.5%) stddev-sans-first:2.88 18:32:23 INFO - PROCESS | 5870 | Values: 60.0 60.0 68.0 60.0 60.0 59.0 58.0 60.0 60.0 60.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:2.21 (2.9%) stddev-sans-first:2.35 18:32:23 INFO - PROCESS | 5870 | Values: 76.0 77.0 75.0 76.0 77.0 75.0 82.0 76.0 75.0 74.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:129.50 stddev:16.69 (12.9%) stddev-sans-first:17.36 18:32:23 INFO - PROCESS | 5870 | Values: 121.0 129.0 130.0 122.0 119.0 136.0 121.0 131.0 175.0 120.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.50 stddev:2.79 (1.8%) stddev-sans-first:2.93 18:32:23 INFO - PROCESS | 5870 | Values: 157.0 155.0 154.0 161.0 163.0 160.0 158.0 156.0 159.0 157.0 18:32:23 INFO - PROCESS | 5870 | 18:32:23 INFO - PROCESS | 5870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.50 stddev:2.36 (3.7%) stddev-sans-first:2.50 18:32:23 INFO - PROCESS | 5870 | Values: 64.0 69.0 63.0 66.0 63.0 63.0 66.0 62.0 63.0 61.0 18:32:23 INFO - PROCESS | 5870 | -------- Summary: end -------- 18:32:23 INFO - PROCESS | 5870 | 18:32:24 INFO - TEST-INFO | 5870: exit 0 18:32:24 INFO - TEST-OK | kraken | took 59483ms 18:32:24 INFO - SUITE-END | took 1173s 18:32:24 INFO - Completed test suite (00:19:33) 18:32:24 INFO - javascript benchmark 18:32:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.564143840581, 3252.495863141214, 3270.182454386402, 3288.4245257080006, 3300.026492184805, 5524.530414914732, 5622.35342935562, 5639.6334238274485, 5642.069058605325, 5645.576581756364, 5696.344920334162, 5767.0, 5775.133729940511, 5776.82669519914, 5806.187133801272, 5171.146760784475, 5193.402758682762, 5219.791208351661, 5235.371755389358, 5279.604029697788, 4911.729854857981, 4939.0, 5277.393099793515, 5290.338707661543, 5313.840584782462, 5039.7732102055315, 5040.949590504085, 5080.79676812927, 5104.64267501275, 5147.974260128694, 5182.3262975813095, 5198.558122559568, 5270.578353731692, 5278.287431196778, 5295.682259064469, 4884.829030983934, 5110.718910459923, 5183.688978661293, 5222.477752224785, 5237.240600113, 5411.377691565481, 5471.835844924659, 5515.310586176728, 5530.336359636869, 5531.1426728857095, 5958.165856780054, 6036.0644100164545, 6062.545309101791, 6067.150598916155, 6072.0, 5774.0, 6099.57302988791, 6104.389561043905, 6106.786262480792, 6108.144859719643, 5419.5393391561765, 5531.2809334786625, 5550.611457198038, 5559.054960656698, 5618.690971996498, 6109.0, 6121.4490695837585, 6125.663088530174, 6127.724252408652, 6134.202553668084, 5651.773929042874, 5896.174535565025, 5897.056470964625, 5901.970490147608, 5903.3801450847905, 5773.653580785166, 5936.8218953430605, 5970.880582388415, 5994.730237139339, 6077.604955677867, 6018.277806663228, 6029.728662210211, 6030.547708921848, 6030.909536356959, 6035.517158627299, 5996.4003599640555, 6048.425399587032, 6049.304330002106, 6054.606450580698, 6068.726907289182, 4507.616852567503, 4528.456585209796, 4599.770011499411, 4631.652626052992, 4635.7450340230935, 4150.667946564267, 4161.375793630919, 4162.937555936664, 4164.541900390955, 4188.937165942513, 5775.624584402, 5777.62445441045, 5781.075027995501, 5792.420757924174, 5797.768089276382, 5808.651480911159, 5830.41695830422, 5892.558058145656, 5911.586188966731, 6053.27360716708, 5725.456081672234, 5730.398308177581, 5740.712964351849, 5747.626404283708, 5773.39379365169, 5135.6405051646025, 5145.588352931756, 5149.047426226085, 5149.742512874342, 5183.870403239874, 6005.579609427386, 6119.082137679384, 6130.63216207029, 6230.158928544679, 6238.469730072995, 5970.522358211246, 6089.269287685506, 6104.694765261808, 6128.080787881675, 6136.6011209271255, 6300.275468321019, 6326.240851097898, 6332.810015699536, 6341.112244285896, 6348.587341822767, 5690.231818704588, 5716.657000579979, 5987.281526216708, 5990.101484777319, 5993.910091348721, 5932.377100404568, 5964.0, 5978.641281523122, 6080.361562035922, 6115.969420152871, 5886.293644762656, 5929.0, 5941.821745347646, 5942.286925568959, 5942.376050514807, 5566.248556444828, 5909.084091965752, 5928.970355148369, 5929.0513517836935, 5931.13998470228, 5594.328680558359, 5775.7400916957995, 5801.680907550125, 5805.419458054161, 5906.940930590639, 5949.405059494016, 5966.164736936746, 5968.343482217039, 5969.194158788681, 5977.671228082497, 5634.718264086861, 5660.122680984454, 5684.289463817023, 5813.302403711582, 5829.650220986754], "value": 5552.1584882864045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8006587727235, 625.4496043481737, 629.9968500157498, 632.4624069540888, 639.3127388057839, 35444.29111417774, 46410.303845442344, 47564.76217618916, 47572.28641570379, 47589.7620511897, 48610.27084593734, 49030.26454603184, 49133.50866491334, 49179.50820491794, 49301.0, 8493.915060849406, 9026.142516460943, 9151.405158664698, 9165.266778657691, 9171.266298696122, 8565.95717021414, 10738.838917416206, 10995.285306455095, 11014.339139651647, 11315.490802913848, 11125.666230013072, 11200.831987520194, 11210.27133236337, 11210.327380357205, 11212.10303175744, 11042.723931901686, 11084.778304433867, 11093.3898635575, 11094.057005154571, 11098.50170227017, 10874.0, 10939.0, 10940.781184376268, 10948.835767463494, 10960.56157753689, 46638.300425493646, 46727.29909051367, 46811.0, 46812.297815532795, 46870.53129468696, 3601.4237721964623, 3668.046307959923, 3860.3437415639128, 4052.3111071117983, 4321.252305698172, 34342.82828585866, 34390.48414273788, 34542.82728586366, 34808.47787283193, 34828.651713482795, 4586.816527338902, 4650.767461626905, 4653.906921861578, 4671.392718946549, 4676.041411510632, 376335.0, 377488.0, 378342.0, 378632.0, 378689.0, 68547.3145268541, 68805.65597171983, 68947.31052689509, 68962.0, 69097.0, 41113.383299250534, 41774.0, 41840.16319673589, 44603.0, 44687.10625787466, 19308.613827723366, 19553.41339759781, 19570.0, 19596.216151353787, 19603.411897643095, 13836.930815345859, 13906.93046534781, 14396.352164152639, 14895.329710163069, 15162.696746065018, 20329.390118296476, 21355.46611334729, 21457.78542214558, 21473.355799326044, 21540.784592154192, 7438.5536867788105, 7592.240775922363, 7596.354309883612, 7598.582077985653, 7713.575753333621, 1052.305478384278, 1071.7052810477026, 1101.9889801101885, 1133.3992983718642, 1137.670075678044, 33911.152221194665, 34066.0, 34387.656123438945, 34575.30849383049, 34578.48132278018, 1131.4569006876745, 1137.113051819582, 1146.2091157101572, 1156.346664134761, 1196.1626861197024, 17799.911000444914, 18209.180586873623, 18230.45308640743, 18253.17860696272, 18268.54328641768, 572913.0, 575651.0, 576095.0, 576110.0, 576465.0, 64074.679626601566, 64279.35720642827, 64552.35447645558, 64559.0, 64632.676836615516, 1311.672081979505, 1373.0731756064815, 1402.7895815627737, 1428.057482061855, 1457.154850186889, 30254.394912102074, 34728.305433891685, 35427.29145417129, 35561.0, 35783.46324805182, 56179.0, 56770.71614641901, 56779.71610141923, 56811.71594142003, 56982.430175697715, 402025.0, 404071.0, 404318.0, 404959.0, 405814.0, 28534.286642834097, 29148.562771558867, 29295.121146365644, 30180.84909575438, 30230.84884575651, 49167.0, 49490.50509495003, 49497.25754113619, 50240.0, 50750.0, 42392.788036060854, 42436.575634243265, 42948.926276843325, 42995.78502107469, 44095.77952110219, 42676.14647706966, 42910.35634465423, 43403.78298108489, 44268.335974961046, 44406.77796610996, 40685.98285042779, 43404.78297608492, 43645.345319820866, 44352.778236108614, 44746.0, 35776.0, 38639.6136038636, 39194.21611567696, 39380.40929386119, 39594.0, 29904.85047574748, 30034.249143770707, 30094.699053010067, 30450.84774576113, 30532.0], "value": 21637.085113878744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.8872809977254, 413.87169977307053, 420.82325423322203, 426.8954106243971, 435.9193549193399, 18807.905960470194, 19613.607727845454, 20457.590848183027, 20473.283435079775, 20841.374758757225, 19378.031098445055, 19448.902755486237, 19494.512637184078, 19794.406167814952, 19841.503962400948, 5831.88336233274, 6029.457348838604, 6053.061775424816, 6055.969720151393, 6064.818055458343, 5775.249217601727, 5908.88182236355, 5921.378255283176, 6007.219061521996, 6012.128241404994, 5914.0, 5915.763369465216, 5916.349201587822, 5917.40825917407, 5926.496247818941, 5725.513331366818, 5903.5572332074835, 5903.704814759245, 5906.05503119501, 5936.465718085393, 5334.706591137486, 5339.038972984861, 5344.0915044442145, 5344.9732751336, 5347.278117454132, 23858.880705596534, 24371.26886193417, 24453.26640200797, 24481.510369792682, 24534.386640333956, 2429.161939130997, 2447.3636854417978, 2488.30327508298, 2759.1998320487037, 2869.727375899286, 14988.700225995528, 15188.772168417483, 15351.385944562204, 15425.691486170326, 16153.192340382933, 1992.980070199294, 2015.9798402015938, 2044.0801639262243, 2058.073866759964, 2080.251109600543, 82141.0, 83268.58365708133, 84093.57953210257, 84396.57801710952, 84921.15078849194, 11056.447177641086, 11151.330920144817, 11159.38623375722, 11202.327860328407, 11374.838780631653, 15435.228238588026, 15454.768178477332, 15455.0, 15469.84530154684, 15483.84516154824, 8396.118407567117, 8397.0, 8503.319734421231, 8622.956885215659, 8690.391672582986, 8432.45189062709, 8477.23704866565, 8518.531480768617, 8695.956520217485, 8732.476051436934, 6840.931590684129, 6930.237673855871, 6932.688029038705, 7006.601798127904, 7089.149302083783, 1910.5414700471786, 1976.940691779249, 1984.9404517864486, 2001.8298444632078, 2045.5295282085203, 935.4013431403907, 984.3798407003685, 993.7465946183677, 1008.2135933971514, 1123.6572845282267, 20080.297189598587, 20931.47671308199, 20968.89515552443, 21172.682409763867, 21272.893635531724, 1024.4877561219391, 1053.262716098734, 1066.4880857188439, 1070.063694267516, 1085.6525911708177, 10955.34267943926, 11792.469338879771, 12115.212511186744, 12117.697057573454, 12160.635180944586, 476003.0, 481286.0, 497951.0, 503772.0, 504263.0, 78330.6083469579, 83705.0, 85030.0, 85043.0, 85409.57295213484, 1055.6516349604765, 1060.55986765493, 1087.9238453308192, 1092.257265059751, 1095.2990086344746, 17631.294748209926, 17874.46376608704, 18303.816961830744, 18480.63038739191, 18789.96655183978, 45738.54261457343, 46253.30620040635, 46918.53081469142, 47073.293900590834, 47671.523284768096, 61746.38253617406, 62142.0, 62537.68731156315, 63109.36890631035, 63976.36023639704, 8808.823823523366, 9118.863217051618, 9137.0, 9193.908060919573, 9318.813623727623, 10113.5448904798, 13357.198568085945, 13693.931530342285, 14201.573952781433, 14437.711245775236, 11927.582534611594, 12249.938750306192, 12331.198472099284, 12456.439460224494, 12730.554430595255, 11888.227265228079, 11996.76006479883, 12105.636830895088, 12131.696707582381, 12216.938915305367, 12118.333491657691, 12228.388580571114, 12484.937575312066, 12564.937175314431, 12619.053570982396, 8809.471431714117, 8987.236084932592, 9109.407888487227, 9209.401388909699, 9295.163435290857, 9674.274429417681, 11995.460204290654, 12397.504099836266, 12427.502899883903, 12544.31006294626], "value": 9795.367964365169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.1686279800726, 1521.1329542160966, 1546.5515000649812, 1698.3885801111605, 1874.5594785225478, 7889.723859664913, 8864.601092950817, 9085.40944838585, 9109.544522773867, 9328.766780830465, 9054.864177037332, 9110.772230694236, 9133.634654613808, 9134.269258459324, 9136.543172841364, 2386.8209884258663, 2415.2995631266913, 2415.5651982643117, 2417.540667273221, 2425.514897020594, 2417.9153729619466, 2441.9377570756687, 2477.863717495537, 2480.3675062858947, 2482.751724827521, 2387.3673476528647, 2406.3021723700194, 2416.6858308419883, 2420.092465325503, 2428.3564855313357, 2309.6997390339316, 2336.754640762721, 2339.204670412051, 2355.634876594122, 2356.45801465663, 2299.0344055496566, 2323.2449453927543, 2351.130081869719, 2355.0344358812977, 2355.587772139869, 8933.374663773538, 9008.549572521348, 9066.5920033598, 9069.546522673905, 9069.727908162766, 5349.5720342372515, 5548.861278468071, 5562.638428502134, 5564.4991950724625, 5567.2762540869835, 3355.4966754986704, 3501.159721666807, 3552.271784284241, 3558.395072837624, 3561.5013898054294, 1193.8746431624727, 1198.2630682130514, 1221.7617564574823, 1247.9563215287421, 1271.3071376100047, 12139.575114870937, 12256.81614775779, 12274.570390036306, 12310.13829031968, 12315.75368492643, 4353.325234588644, 4649.349480934287, 4732.976335118303, 4735.668503204812, 4752.097101550694, 9946.552405141785, 9951.054649808257, 9966.103050725469, 9966.302358834957, 9970.50147492637, 5382.650127741685, 5398.055340315507, 5402.243685883979, 5402.702851343135, 5411.702356370359, 4174.227767862955, 4334.414853994734, 4547.045120524727, 4990.2764099205415, 5072.644914855925, 3824.9808750956067, 3854.190619969838, 3951.6838652908273, 3959.7228194026143, 3966.1076257842333, 1197.9221350612183, 1226.399064458409, 1226.4603574427224, 1232.6979889926845, 1237.8638349781518, 989.6734077754468, 1003.2275148135894, 1013.6654903881702, 1024.7591815923251, 1037.8443233514881, 6021.187139736167, 6063.999440092335, 6102.786402475892, 6366.554341196072, 6396.584222025646, 433.6552440809564, 451.23740877916214, 455.6354916067133, 458.191292368969, 1036.8185567525804, 3924.3524818404644, 4149.605787450188, 4190.53904070552, 4200.789960501963, 4290.635295999875, 11192.776144477228, 11419.60031398897, 11468.254563453349, 11470.254433461798, 11572.47923843429, 11036.11711063113, 11119.666410007712, 11332.320060796379, 11390.430478476042, 11410.543578256942, 8346.165383461726, 8346.4157508975, 8514.74455766328, 8529.061803201643, 8530.189631984951, 5926.585139040399, 6069.362716914837, 6131.938680613137, 6189.690515474298, 6204.069389591597, 10212.489375531046, 10363.015513526203, 10367.844482332923, 10377.429241391494, 10382.273240873066, 9081.54592270397, 9345.018773028734, 10488.05607495329, 10558.736031599272, 10567.418791966209, 6996.0, 7241.5293005954445, 7250.9637451812405, 7326.120865496175, 7403.629818508945, 8606.354523410644, 8610.913890861011, 8624.310055195443, 8633.91366086331, 8658.177473140042, 7609.429292802951, 7738.651760670671, 7821.335186508983, 7839.490433122057, 7851.214878512332, 7559.5464272143845, 7731.729389471341, 7732.420068494998, 7782.299593036428, 7963.044434667877, 6755.256921738506, 6847.828804279933, 6848.3494068063455, 6852.417544508772, 6859.519833611599, 5132.3327967364, 5246.868828279171, 5343.732813359395, 5345.866353341197, 5512.724363781715, 5042.193249080129, 5170.948290517047, 5256.789728410974, 5258.106121959199, 5423.728813559385], "value": 4650.481322465896, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.71767227381946, 353.3057541930108, 360.9602943676195, 362.89838845123376, 363.3332834249153, 5503.761653627932, 5510.760078982237, 5547.0, 5578.330600327956, 5598.636088654234, 5153.76808043638, 5271.182966640167, 5293.6294459387855, 5386.569074474042, 5427.185922111686, 4299.935500967473, 4304.117655880553, 4311.870643880673, 4329.242382583051, 4338.457692788402, 4303.376010478479, 4310.310350343945, 4320.675949303799, 4334.804933777988, 4336.0, 4053.5204650302576, 4230.625046859767, 4251.97874010631, 4252.766097864616, 4280.208161490119, 4225.753402746166, 4235.152969406131, 4235.639970602502, 4257.233697934371, 4258.850940217078, 3756.398976163801, 3763.172102137525, 3770.886873393775, 3772.2832661794173, 3778.6599206071587, 5197.246399272084, 5290.55030322423, 5290.788368465257, 5331.493508116722, 5338.893222135574, 4868.488808675073, 4884.120858245515, 4892.192788189945, 4906.632002599784, 4907.312976183337, 5649.4633009864, 5655.349634791969, 5684.943150568482, 5686.687232202227, 5712.400197979236, 3935.4490371348033, 4085.1421201547414, 4108.534879072562, 4162.064639942441, 4183.6234738873345, 5896.705164741746, 5914.940850591482, 5927.2590926134235, 5937.376575459601, 5938.584299099065, 4247.97876010618, 4257.297545904891, 4257.957420425756, 4266.360045993064, 4274.2733735264455, 4187.32290224451, 4279.743215407086, 4304.5480224576595, 4326.766871441624, 4327.879339123807, 4848.612111031109, 4865.245886887538, 4886.291487734258, 4907.582855457326, 4933.827316043921, 5727.971360143172, 5736.483716465538, 5736.655800651891, 5768.826935191951, 5785.27684039495, 1378.4692893236177, 1435.2608406670572, 1440.4670271999219, 1441.445043658178, 1449.159487497249, 980.6562316064611, 990.4057565460666, 999.5701848205196, 1000.1948431512557, 1004.5233506745074, 5302.893942121136, 5307.522322990872, 5344.198370244494, 5367.329083864517, 5396.21754845553, 5599.972000139973, 5621.213030175779, 5621.690807005654, 5633.661980281115, 5647.0, 5245.685258884403, 5334.679919204783, 5337.919931201035, 5416.9729151353995, 5425.376081750649, 2957.3050333171686, 2980.1953472562286, 2981.6869228731107, 3013.352129292213, 3014.623172103487, 5836.941630583639, 5867.735951882176, 5880.794172203952, 5884.323302820145, 5899.46904778572, 5453.945460545344, 5702.971485142548, 5719.7712091516705, 5720.685362305113, 5762.683052432073, 5841.299044114733, 5859.853503662443, 5862.886051650258, 5865.35481097079, 5878.676672782953, 5573.191887176417, 5597.216389705363, 5614.803481878114, 5640.182173584889, 5909.70451477433, 5869.354371019099, 5876.236089308362, 5877.0, 5883.676397798162, 5890.617109888015, 6132.202813634199, 6167.876642467215, 6168.290646575521, 6194.907076393948, 6196.659183744938, 4034.4150098235004, 4044.4742183515955, 4191.245575796386, 4199.643030342455, 4211.399668126215, 5749.252597162509, 5765.164051212467, 5869.295684517885, 5893.406900963734, 5918.822435326947, 5765.183967050366, 5769.59612827098, 5778.728679690461, 5780.364159942487, 5781.4507621775865, 5638.802641907513, 5698.230738850202, 5733.3406658234835, 5751.0, 5761.8559536011935, 5665.12190610456, 5666.090397625625, 5681.829545113488, 5687.554351628839, 5696.715164241688, 5638.971805140948, 5769.798057067983, 5778.56660750437, 5803.274590676166, 5814.592978491634, 5601.663900166003, 5603.551715862803, 5649.887002259849, 5651.4348565143155, 5664.5751568631695], "value": 4351.710158911795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.2247752247753, 802.8394321135771, 817.1297568089984, 862.693743720979, 891.8662200669895, 12970.351482425876, 14410.423583056678, 14424.27878606068, 14779.0, 14862.628434289134, 13228.867711322884, 13363.465461381533, 14417.990740648158, 14784.334704938277, 14904.18027008514, 742.8699977503942, 861.6424183963663, 873.0963452826326, 877.1842186766305, 877.6664867350398, 754.5548126605302, 840.815020695446, 861.9267362274214, 866.164151593712, 876.2508055612456, 921.0973246218709, 922.9400088994194, 924.0620769918538, 924.1682485762834, 924.2790623313792, 914.1224424552438, 922.6032805893464, 922.6401703335705, 922.9584668689891, 923.9630414783401, 675.0549231076483, 677.4580335731396, 677.7255211639294, 678.3250665587723, 678.6335378895391, 13802.102863313852, 13816.861831381659, 13820.585382438543, 13905.374258158407, 13926.303684815719, 14354.64113397163, 14937.775933361008, 15376.846231537653, 15458.1498017609, 15509.379624814994, 12284.14011019229, 12401.75196496074, 12418.751624967541, 12557.372131393393, 12597.937010314981, 3756.4177552479136, 3782.829772660237, 3786.772793632363, 3826.2730081284744, 3896.045468860119, 63891.0, 65902.3409765901, 66700.33299667039, 67042.66478667624, 69529.30470695329, 11186.440677966231, 11701.356425396685, 11755.0, 11759.529618815322, 12011.87988120125, 22086.889565552392, 22344.776552234594, 22411.88794056019, 22566.21018264353, 22734.0, 8495.1080136586, 8502.574871256413, 8552.61513231906, 8670.219680228809, 8692.348073894484, 4671.602913752301, 4962.702237865739, 4981.078500477423, 4988.326575912205, 5006.849794506171, 3639.836207370675, 3761.3417651910804, 3773.3208022555655, 3774.6225377462033, 3775.6224377562025, 595.4730063893486, 600.7596961215548, 602.1690067706537, 602.5029350785532, 604.1873679900526, 620.1565870416231, 626.5582764151262, 673.1659712609869, 738.1474397071283, 754.607604045893, 9638.855417168748, 9850.0, 10109.39343639384, 10138.188944884392, 10203.693889183336, 609.2110716621985, 621.6145989486547, 719.2591630620469, 726.2628432141381, 743.4572761883855, 4700.412448443944, 4811.687240329367, 4831.758412079453, 4995.200767877122, 5020.849374518771, 62127.0, 91214.0878591219, 95591.52204238935, 96133.5193324029, 97177.0, 82787.5860620705, 82806.0, 83887.0, 86217.56891215504, 88829.0, 73645.0, 73714.26285737181, 74089.25910740823, 74599.25400745923, 76508.0, 9261.44431334122, 9475.47884866339, 9556.610847288179, 9670.854937175807, 9730.318877678494, 36053.0, 37604.0, 48943.26585101155, 50485.49514504808, 52044.0, 38620.420693689055, 39506.0, 56505.43494565002, 57177.01806347315, 66991.66504167448, 11530.82703759461, 11637.709057273636, 11874.643760687193, 12308.384580770746, 12954.0, 13158.934205328913, 13741.656458588615, 13864.168149911038, 14086.295685215493, 14146.22195779242, 12313.199642023239, 12428.81356779631, 12950.97224365056, 13228.007899407776, 13425.127366721132, 11756.118291128028, 11871.76256474883, 12150.878491214975, 12442.937785311016, 12937.223766574036, 12605.684857878627, 12835.550755723878, 12914.67713307175, 13280.136791108547, 13317.067805253539, 10063.446510441996, 10083.596656133966, 10131.240156988108, 10173.898261017592, 10214.693559193236, 10205.438700871524, 10231.0, 10482.318649288078, 10588.470576470992, 10628.946855265674], "value": 7293.404496201088, "unit": "score"}], "name": "dromaeo_css", "value": 7469.691613012344, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 111.0, 111.0, 112.0, 111.0, 111.0, 113.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 117.0, 163.0, 124.0, 123.0, 118.0, 117.0, 148.0, 118.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 122.0, 76.0, 75.0, 77.0, 76.0, 107.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 82.0, 82.0, 81.0, 98.0, 81.0, 81.0, 109.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 49.0, 50.0, 51.0, 52.0, 49.0, 50.0, 49.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 68.0, 60.0, 60.0, 59.0, 58.0, 60.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 76.0, 77.0, 75.0, 82.0, 76.0, 75.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 129.0, 130.0, 122.0, 119.0, 136.0, 121.0, 131.0, 175.0, 120.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 154.0, 161.0, 163.0, 160.0, 158.0, 156.0, 159.0, 157.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 63.0, 66.0, 63.0, 63.0, 66.0, 62.0, 63.0, 61.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1460.9, "alertThreshold": 2.0}]} 18:32:24 INFO - Return code: 0 18:32:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:24 INFO - # TBPL SUCCESS # 18:32:24 INFO - Running post-action listener: _resource_record_post_action 18:32:24 INFO - [mozharness: 2017-01-27 02:32:24.787347Z] Finished run-tests step (success) 18:32:24 INFO - Running post-run listener: _resource_record_post_run 18:32:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322641920; Read time: 12; Write time: 220704 18:32:24 INFO - TinderboxPrint: CPU usage
13.0% 18:32:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:32:24 INFO - TinderboxPrint: I/O write bytes / time
322,641,920 / 220,704 18:32:24 INFO - TinderboxPrint: CPU idle
8,255.4 (87.0%) 18:32:24 INFO - TinderboxPrint: CPU user
1,185.1 (12.5%) 18:32:24 INFO - TinderboxPrint: Swap in / out
0 / 0 18:32:24 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100966400; Read time: 0; Write time: 118948 18:32:24 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221675520; Read time: 12; Write time: 101756 18:32:25 INFO - Running post-run listener: _upload_blobber_files 18:32:25 INFO - Blob upload gear active. 18:32:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:25 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 18:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:25 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:29 INFO - (blobuploader) - INFO - Done attempting. 18:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:29 INFO - (blobuploader) - INFO - Done attempting. 18:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:30 INFO - (blobuploader) - INFO - Done attempting. 18:32:30 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:30 INFO - Return code: 0 18:32:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc65e6609bd2d9f476f5bf600712b47aba95e7b47484c09b28647f89f3489cbdaf6d2f9a95fc3d20b06193e007bf13c3f40e1800d37041539e1efe8cee7b13a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6adc5a7e07041e833226983a5aaf2980d7519cec550ffa24fb9081ec69e2d4cb0013fe1b3acfd85054af402ed7b7bbd5a2ddeab641caad7918c7236b2725b7d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e045d91c1446f60943679841d0a09f08cda0b18081d121f9facc3d5376cd3c484a670f4ce2c381cbb4192b370fc8b0a97bfe2157bcfeac72407832f091d0a08f"} 18:32:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:30 INFO - Contents: 18:32:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc65e6609bd2d9f476f5bf600712b47aba95e7b47484c09b28647f89f3489cbdaf6d2f9a95fc3d20b06193e007bf13c3f40e1800d37041539e1efe8cee7b13a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6adc5a7e07041e833226983a5aaf2980d7519cec550ffa24fb9081ec69e2d4cb0013fe1b3acfd85054af402ed7b7bbd5a2ddeab641caad7918c7236b2725b7d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e045d91c1446f60943679841d0a09f08cda0b18081d121f9facc3d5376cd3c484a670f4ce2c381cbb4192b370fc8b0a97bfe2157bcfeac72407832f091d0a08f"} 18:32:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:30 INFO - Copying logs to upload dir... 18:32:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.784405 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-26 18:32:30.700574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 18:32:30.703970) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc65e6609bd2d9f476f5bf600712b47aba95e7b47484c09b28647f89f3489cbdaf6d2f9a95fc3d20b06193e007bf13c3f40e1800d37041539e1efe8cee7b13a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6adc5a7e07041e833226983a5aaf2980d7519cec550ffa24fb9081ec69e2d4cb0013fe1b3acfd85054af402ed7b7bbd5a2ddeab641caad7918c7236b2725b7d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e045d91c1446f60943679841d0a09f08cda0b18081d121f9facc3d5376cd3c484a670f4ce2c381cbb4192b370fc8b0a97bfe2157bcfeac72407832f091d0a08f"} build_url:https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/OFpBME9gTXW51nWkhwMHeg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfc65e6609bd2d9f476f5bf600712b47aba95e7b47484c09b28647f89f3489cbdaf6d2f9a95fc3d20b06193e007bf13c3f40e1800d37041539e1efe8cee7b13a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6adc5a7e07041e833226983a5aaf2980d7519cec550ffa24fb9081ec69e2d4cb0013fe1b3acfd85054af402ed7b7bbd5a2ddeab641caad7918c7236b2725b7d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e045d91c1446f60943679841d0a09f08cda0b18081d121f9facc3d5376cd3c484a670f4ce2c381cbb4192b370fc8b0a97bfe2157bcfeac72407832f091d0a08f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 18:32:30.729294) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 18:32:30.729653) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1485483117.976855-1720142206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 18:32:30.817615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 18:32:30.817932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 18:32:30.818240) ========= ========= Total master_lag: 0.16 =========