builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1475176610.12 results: success (0) buildid: 20160929105520 builduid: 06113576b4b14cc7a151977f6f7568b1 revision: b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.119853) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.120375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.120671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.153648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.154238) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 12:16:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.5M=0s 2016-09-29 12:16:51 (66.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115512 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.642264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.642603) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015287 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:50.699774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:16:50.700176) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5 --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=97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 12:16:51,393 truncating revision to first 12 chars 2016-09-29 12:16:51,393 Setting DEBUG logging. 2016-09-29 12:16:51,393 attempt 1/10 2016-09-29 12:16:51,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b9b87a4102da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 12:16:52,790 unpacking tar archive at: autoland-b9b87a4102da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.732969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:16:52.446845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:52.447176) ========= script_repo_revision: b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:52.447610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:52.447883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:16:52.456330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-29 12:16:52.456604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:53 INFO - MultiFileLogger online at 20160929 12:16:53 in /builds/slave/test 12:16:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 12:16:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:53 INFO - {'append_to_log': False, 12:16:53 INFO - 'base_work_dir': '/builds/slave/test', 12:16:53 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:16:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:53 INFO - 'branch': 'Autoland-Non-PGO', 12:16:53 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:53 INFO - 'config_files': ('talos/linux_config.py',), 12:16:53 INFO - 'default_actions': ('clobber', 12:16:53 INFO - 'read-buildbot-config', 12:16:53 INFO - 'download-and-extract', 12:16:53 INFO - 'populate-webroot', 12:16:53 INFO - 'create-virtualenv', 12:16:53 INFO - 'install', 12:16:53 INFO - 'run-tests'), 12:16:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:53 INFO - 'download_minidump_stackwalk': True, 12:16:53 INFO - 'download_symbols': 'ondemand', 12:16:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:53 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:53 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:53 INFO - 'installer_path': 'installer.exe', 12:16:53 INFO - 'log_level': 'info', 12:16:53 INFO - 'log_name': 'talos', 12:16:53 INFO - 'log_to_console': True, 12:16:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:53 INFO - 'opt_config_files': (), 12:16:53 INFO - 'pip_index': False, 12:16:53 INFO - 'sps_profile': False, 12:16:53 INFO - 'sps_profile_interval': 0, 12:16:53 INFO - 'suite': 'dromaeojs', 12:16:53 INFO - 'system_bits': '32', 12:16:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:53 INFO - 'title': 'talos-linux64-ix-068', 12:16:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:53 INFO - 'use_talos_json': True, 12:16:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:53 INFO - 'work_dir': 'build'} 12:16:53 INFO - [mozharness: 2016-09-29 19:16:53.252150Z] Running clobber step. 12:16:53 INFO - Running pre-action listener: _resource_record_pre_action 12:16:53 INFO - Running main action method: clobber 12:16:53 INFO - rmtree: /builds/slave/test/build 12:16:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:53 INFO - Running post-action listener: _resource_record_post_action 12:16:53 INFO - [mozharness: 2016-09-29 19:16:53.711878Z] Finished clobber step (success) 12:16:53 INFO - [mozharness: 2016-09-29 19:16:53.711978Z] Running read-buildbot-config step. 12:16:53 INFO - Running pre-action listener: _resource_record_pre_action 12:16:53 INFO - Running main action method: read_buildbot_config 12:16:53 INFO - Using buildbot properties: 12:16:53 INFO - { 12:16:53 INFO - "project": "", 12:16:53 INFO - "product": "firefox", 12:16:53 INFO - "script_repo_revision": "production", 12:16:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:16:53 INFO - "repository": "", 12:16:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:16:53 INFO - "buildid": "20160929105520", 12:16:53 INFO - "pgo_build": "False", 12:16:53 INFO - "basedir": "/builds/slave/test", 12:16:53 INFO - "buildnumber": 572, 12:16:53 INFO - "slavename": "talos-linux64-ix-068", 12:16:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:16:53 INFO - "platform": "ubuntu64_hw", 12:16:53 INFO - "scheduler": "tests-autoland-linux64-talos", 12:16:53 INFO - "branch": "autoland", 12:16:53 INFO - "repo_path": "integration/autoland", 12:16:53 INFO - "revision": "b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5", 12:16:53 INFO - "stage_platform": "linux64", 12:16:53 INFO - "builduid": "06113576b4b14cc7a151977f6f7568b1", 12:16:53 INFO - "slavebuilddir": "test" 12:16:53 INFO - } 12:16:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:16:53 INFO - Running post-action listener: _resource_record_post_action 12:16:53 INFO - [mozharness: 2016-09-29 19:16:53.714407Z] Finished read-buildbot-config step (success) 12:16:53 INFO - [mozharness: 2016-09-29 19:16:53.714495Z] Running download-and-extract step. 12:16:53 INFO - Running pre-action listener: _resource_record_pre_action 12:16:53 INFO - Running main action method: download_and_extract 12:16:53 INFO - mkdir: /builds/slave/test/build/tests 12:16:53 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')]} 12:16:53 INFO - trying https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:16:54 INFO - Downloaded 1361 bytes. 12:16:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:16:54 INFO - Using the following test package requirements: 12:16:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:16:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'jsshell-linux-x86_64.zip'], 12:16:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:16:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:54 INFO - Fetch https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:16:55 INFO - Http code: 200 12:16:55 INFO - Content-Encoding: None 12:16:55 INFO - Content-Type: application/zip 12:16:55 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 12:16:55 INFO - x-amz-cf-id: nrMeSdHodioqPwlJFJkFTihyP1MBIvM12bTvqhX1Ln36aMDo-GRsuw== 12:16:55 INFO - x-amz-version-id: 9KLn4kDA2_pZQ.67ETIlY033IGylWPbf 12:16:55 INFO - x-cache: Hit from cloudfront 12:16:55 INFO - Expected file size: 20417649 12:16:55 INFO - Obtained file size: 20417649 12:16:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:16:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:16:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:59 INFO - Fetch https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:17:00 INFO - Http code: 200 12:17:00 INFO - Content-Encoding: None 12:17:00 INFO - Content-Type: application/zip 12:17:00 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 12:17:00 INFO - x-amz-cf-id: iROd7lwaAMNNSo-d_Px2NgurV5GwtPDtsRC7I7SKt5dGXQx6_2CWOA== 12:17:00 INFO - x-amz-version-id: 9KLn4kDA2_pZQ.67ETIlY033IGylWPbf 12:17:00 INFO - x-cache: Hit from cloudfront 12:17:00 INFO - Expected file size: 20417649 12:17:00 INFO - Obtained file size: 20417649 12:17:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:17:04 INFO - Fetch https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:17:05 INFO - Http code: 200 12:17:05 INFO - Content-Encoding: None 12:17:05 INFO - Content-Type: application/zip 12:17:05 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 12:17:05 INFO - x-amz-cf-id: TPs6StCxOsUF9g6iAfUBC_Bu5lKfF21tRMaCvg1_vMyz3jZDZckcug== 12:17:05 INFO - x-amz-version-id: 5ZgBj8cStaHgvZfjcL_DE6bL16ygdVHL 12:17:05 INFO - x-cache: Hit from cloudfront 12:17:05 INFO - Expected file size: 14414067 12:17:05 INFO - Obtained file size: 14414067 12:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:05 INFO - trying https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:17:05 INFO - Downloading https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:17:07 INFO - Downloaded 55744275 bytes. 12:17:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:17:07 INFO - mkdir: /builds/slave/test/properties 12:17:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:07 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:07 INFO - Contents: 12:17:07 INFO - build_url:https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:17:07 INFO - Running post-action listener: _resource_record_post_action 12:17:07 INFO - Running post-action listener: set_extra_try_arguments 12:17:07 INFO - [mozharness: 2016-09-29 19:17:07.817309Z] Finished download-and-extract step (success) 12:17:07 INFO - [mozharness: 2016-09-29 19:17:07.817537Z] Running populate-webroot step. 12:17:07 INFO - Running pre-action listener: _resource_record_pre_action 12:17:07 INFO - Running main action method: populate_webroot 12:17:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:07 INFO - '--tppagecycles', 12:17:07 INFO - '7'], 12:17:07 INFO - 'tests': ['tsvgm']}}, 12:17:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:17:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:17:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:17:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['damp', 'tps']}, 12:17:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'tests': ['damp', 'tps']}, 12:17:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['dromaeo_dom']}, 12:17:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['basic_compositor_video']}, 12:17:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:17:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['a11yr', 12:17:07 INFO - 'ts_paint', 12:17:07 INFO - 'tpaint', 12:17:07 INFO - 'sessionrestore', 12:17:07 INFO - 'sessionrestore_no_auto_restore', 12:17:07 INFO - 'tabpaint']}, 12:17:07 INFO - 'other-e10s': {'tests': ['a11yr', 12:17:07 INFO - 'ts_paint', 12:17:07 INFO - 'tpaint', 12:17:07 INFO - 'sessionrestore', 12:17:07 INFO - 'sessionrestore_no_auto_restore', 12:17:07 INFO - 'tabpaint']}, 12:17:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:17:07 INFO - 'ts_paint', 12:17:07 INFO - 'tpaint', 12:17:07 INFO - 'sessionrestore', 12:17:07 INFO - 'sessionrestore_no_auto_restore', 12:17:07 INFO - 'tabpaint']}, 12:17:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:17:07 INFO - 'ts_paint', 12:17:07 INFO - 'tpaint', 12:17:07 INFO - 'sessionrestore', 12:17:07 INFO - 'sessionrestore_no_auto_restore', 12:17:07 INFO - 'tabpaint']}, 12:17:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['a11yr', 12:17:07 INFO - 'ts_paint', 12:17:07 INFO - 'tpaint', 12:17:07 INFO - 'sessionrestore', 12:17:07 INFO - 'sessionrestore_no_auto_restore', 12:17:07 INFO - 'tabpaint']}, 12:17:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['a11yr', 12:17:07 INFO - 'ts_paint', 12:17:07 INFO - 'tpaint', 12:17:07 INFO - 'sessionrestore', 12:17:07 INFO - 'sessionrestore_no_auto_restore', 12:17:07 INFO - 'tabpaint']}, 12:17:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['tsvgx', 12:17:07 INFO - 'tsvgr_opacity', 12:17:07 INFO - 'tart', 12:17:07 INFO - 'tscrollx', 12:17:07 INFO - 'cart']}, 12:17:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:17:07 INFO - 'tsvgr_opacity', 12:17:07 INFO - 'tart', 12:17:07 INFO - 'tscrollx', 12:17:07 INFO - 'cart']}, 12:17:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'talos_options': ['--disable-e10s'], 12:17:07 INFO - 'tests': ['tp5o']}, 12:17:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'tests': ['tp5o']}, 12:17:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'talos_options': ['--disable-e10s', 12:17:07 INFO - '--xperf_path', 12:17:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:07 INFO - 'tests': ['tp5n']}, 12:17:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:07 INFO - 'talos_options': ['--xperf_path', 12:17:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:07 INFO - 'tests': ['tp5n']}}, 12:17:07 INFO - 'talos.zip': {'path': '', 12:17:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:07 INFO - Running post-action listener: _resource_record_post_action 12:17:07 INFO - [mozharness: 2016-09-29 19:17:07.833098Z] Finished populate-webroot step (success) 12:17:07 INFO - [mozharness: 2016-09-29 19:17:07.833185Z] Running create-virtualenv step. 12:17:07 INFO - Running pre-action listener: _resource_record_pre_action 12:17:07 INFO - Running main action method: create_virtualenv 12:17:07 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:07 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 12:17:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:07 INFO - Using real prefix '/usr' 12:17:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:08 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:10 INFO - Installing pip.................done. 12:17:10 INFO - Return code: 0 12:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:17:10 INFO - Reading from file tmpfile_stdout 12:17:10 INFO - Output received: 12:17:10 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) 12:17:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:17:10 INFO - Using env: {'DISPLAY': ':0', 12:17:10 INFO - 'HOME': '/home/cltbld', 12:17:10 INFO - 'LANG': 'en_US.UTF-8', 12:17:10 INFO - 'LANGUAGE': 'en_US:en', 12:17:10 INFO - 'LOGNAME': 'cltbld', 12:17:10 INFO - 'MAIL': '/var/mail/cltbld', 12:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:10 INFO - 'MOZ_NO_REMOTE': '1', 12:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:10 INFO - 'NO_EM_RESTART': '1', 12:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:10 INFO - 'PWD': '/builds/slave/test', 12:17:10 INFO - 'SHELL': '/bin/bash', 12:17:10 INFO - 'SHLVL': '1', 12:17:10 INFO - 'TERM': 'linux', 12:17:10 INFO - 'TMOUT': '86400', 12:17:10 INFO - 'USER': 'cltbld', 12:17:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:10 INFO - '_': '/tools/buildbot/bin/python'} 12:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:10 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 12:17:10 INFO - Cleaning up... 12:17:10 INFO - Return code: 0 12:17:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:17:10 INFO - Using env: {'DISPLAY': ':0', 12:17:10 INFO - 'HOME': '/home/cltbld', 12:17:10 INFO - 'LANG': 'en_US.UTF-8', 12:17:10 INFO - 'LANGUAGE': 'en_US:en', 12:17:10 INFO - 'LOGNAME': 'cltbld', 12:17:10 INFO - 'MAIL': '/var/mail/cltbld', 12:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:10 INFO - 'MOZ_NO_REMOTE': '1', 12:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:10 INFO - 'NO_EM_RESTART': '1', 12:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:10 INFO - 'PWD': '/builds/slave/test', 12:17:10 INFO - 'SHELL': '/bin/bash', 12:17:10 INFO - 'SHLVL': '1', 12:17:10 INFO - 'TERM': 'linux', 12:17:10 INFO - 'TMOUT': '86400', 12:17:10 INFO - 'USER': 'cltbld', 12:17:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:10 INFO - '_': '/tools/buildbot/bin/python'} 12:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:11 INFO - Downloading/unpacking psutil>=3.1.1 12:17:11 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 12:17:11 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 12:17:11 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 12:17:11 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 12:17:11 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 12:17:11 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 12:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:13 INFO - Installing collected packages: psutil 12:17:13 INFO - Running setup.py install for psutil 12:17:13 INFO - building 'psutil._psutil_linux' extension 12:17:13 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 12:17:13 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 12:17:13 INFO - building 'psutil._psutil_posix' extension 12:17:13 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 12:17:13 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 12:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:13 INFO - Successfully installed psutil 12:17:13 INFO - Cleaning up... 12:17:13 INFO - Return code: 0 12:17:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:17:13 INFO - Using env: {'DISPLAY': ':0', 12:17:13 INFO - 'HOME': '/home/cltbld', 12:17:13 INFO - 'LANG': 'en_US.UTF-8', 12:17:13 INFO - 'LANGUAGE': 'en_US:en', 12:17:13 INFO - 'LOGNAME': 'cltbld', 12:17:13 INFO - 'MAIL': '/var/mail/cltbld', 12:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:13 INFO - 'MOZ_NO_REMOTE': '1', 12:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:13 INFO - 'NO_EM_RESTART': '1', 12:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:13 INFO - 'PWD': '/builds/slave/test', 12:17:13 INFO - 'SHELL': '/bin/bash', 12:17:13 INFO - 'SHLVL': '1', 12:17:13 INFO - 'TERM': 'linux', 12:17:13 INFO - 'TMOUT': '86400', 12:17:13 INFO - 'USER': 'cltbld', 12:17:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:13 INFO - '_': '/tools/buildbot/bin/python'} 12:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:17:15 INFO - Installing collected packages: mozsystemmonitor 12:17:15 INFO - Running setup.py install for mozsystemmonitor 12:17:15 INFO - Successfully installed mozsystemmonitor 12:17:15 INFO - Cleaning up... 12:17:15 INFO - Return code: 0 12:17:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:15 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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:15 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 12:17:15 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 12:17:15 INFO - Using env: {'DISPLAY': ':0', 12:17:15 INFO - 'HOME': '/home/cltbld', 12:17:15 INFO - 'LANG': 'en_US.UTF-8', 12:17:15 INFO - 'LANGUAGE': 'en_US:en', 12:17:15 INFO - 'LOGNAME': 'cltbld', 12:17:15 INFO - 'MAIL': '/var/mail/cltbld', 12:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:15 INFO - 'MOZ_NO_REMOTE': '1', 12:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:15 INFO - 'NO_EM_RESTART': '1', 12:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:15 INFO - 'PWD': '/builds/slave/test', 12:17:15 INFO - 'SHELL': '/bin/bash', 12:17:15 INFO - 'SHLVL': '1', 12:17:15 INFO - 'TERM': 'linux', 12:17:15 INFO - 'TMOUT': '86400', 12:17:15 INFO - 'USER': 'cltbld', 12:17:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:15 INFO - '_': '/tools/buildbot/bin/python'} 12:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:16 INFO - Downloading/unpacking jsonschema==2.5.1 12:17:16 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 12:17:16 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 12:17:16 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 12:17:16 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 12:17:16 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 12:17:16 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 12:17:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:18 INFO - warning: no files found matching '*.txt' 12:17:18 INFO - no previously-included directories found matching 'build' 12:17:18 INFO - no previously-included directories found matching 'dist' 12:17:18 INFO - no previously-included directories found matching '.git*' 12:17:18 INFO - Installing collected packages: jsonschema, functools32 12:17:18 INFO - Running setup.py install for functools32 12:17:18 INFO - warning: no files found matching '*.txt' 12:17:18 INFO - no previously-included directories found matching 'build' 12:17:18 INFO - no previously-included directories found matching 'dist' 12:17:18 INFO - no previously-included directories found matching '.git*' 12:17:18 INFO - Successfully installed jsonschema functools32 12:17:18 INFO - Cleaning up... 12:17:18 INFO - Return code: 0 12:17:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:17:18 INFO - Using env: {'DISPLAY': ':0', 12:17:18 INFO - 'HOME': '/home/cltbld', 12:17:18 INFO - 'LANG': 'en_US.UTF-8', 12:17:18 INFO - 'LANGUAGE': 'en_US:en', 12:17:18 INFO - 'LOGNAME': 'cltbld', 12:17:18 INFO - 'MAIL': '/var/mail/cltbld', 12:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:18 INFO - 'MOZ_NO_REMOTE': '1', 12:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:18 INFO - 'NO_EM_RESTART': '1', 12:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:18 INFO - 'PWD': '/builds/slave/test', 12:17:18 INFO - 'SHELL': '/bin/bash', 12:17:18 INFO - 'SHLVL': '1', 12:17:18 INFO - 'TERM': 'linux', 12:17:18 INFO - 'TMOUT': '86400', 12:17:18 INFO - 'USER': 'cltbld', 12:17:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:18 INFO - '_': '/tools/buildbot/bin/python'} 12:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:17:18 INFO - Cleaning up... 12:17:18 INFO - Return code: 0 12:17:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:17:18 INFO - Using env: {'DISPLAY': ':0', 12:17:18 INFO - 'HOME': '/home/cltbld', 12:17:18 INFO - 'LANG': 'en_US.UTF-8', 12:17:18 INFO - 'LANGUAGE': 'en_US:en', 12:17:18 INFO - 'LOGNAME': 'cltbld', 12:17:18 INFO - 'MAIL': '/var/mail/cltbld', 12:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:18 INFO - 'MOZ_NO_REMOTE': '1', 12:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:18 INFO - 'NO_EM_RESTART': '1', 12:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:18 INFO - 'PWD': '/builds/slave/test', 12:17:18 INFO - 'SHELL': '/bin/bash', 12:17:18 INFO - 'SHLVL': '1', 12:17:18 INFO - 'TERM': 'linux', 12:17:18 INFO - 'TMOUT': '86400', 12:17:18 INFO - 'USER': 'cltbld', 12:17:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:18 INFO - '_': '/tools/buildbot/bin/python'} 12:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:21 INFO - Downloading docopt-0.6.1.tar.gz 12:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:21 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:21 INFO - Running setup.py install for blobuploader 12:17:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:21 INFO - Running setup.py install for requests 12:17:22 INFO - Running setup.py install for docopt 12:17:22 INFO - Successfully installed blobuploader requests docopt 12:17:22 INFO - Cleaning up... 12:17:22 INFO - Return code: 0 12:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:22 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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:22 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 12:17:22 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 12:17:22 INFO - Using env: {'DISPLAY': ':0', 12:17:22 INFO - 'HOME': '/home/cltbld', 12:17:22 INFO - 'LANG': 'en_US.UTF-8', 12:17:22 INFO - 'LANGUAGE': 'en_US:en', 12:17:22 INFO - 'LOGNAME': 'cltbld', 12:17:22 INFO - 'MAIL': '/var/mail/cltbld', 12:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:22 INFO - 'MOZ_NO_REMOTE': '1', 12:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:22 INFO - 'NO_EM_RESTART': '1', 12:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:22 INFO - 'PWD': '/builds/slave/test', 12:17:22 INFO - 'SHELL': '/bin/bash', 12:17:22 INFO - 'SHLVL': '1', 12:17:22 INFO - 'TERM': 'linux', 12:17:22 INFO - 'TMOUT': '86400', 12:17:22 INFO - 'USER': 'cltbld', 12:17:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:22 INFO - '_': '/tools/buildbot/bin/python'} 12:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:22 INFO - Running setup.py (path:/tmp/pip-VGeTgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:22 INFO - Running setup.py (path:/tmp/pip-0JKFgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:22 INFO - Running setup.py (path:/tmp/pip-7cqEOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:22 INFO - Running setup.py (path:/tmp/pip-rXo1f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:22 INFO - Running setup.py (path:/tmp/pip-AwnrYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:22 INFO - Running setup.py (path:/tmp/pip-Hb1d7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:22 INFO - Running setup.py (path:/tmp/pip-crx1lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:23 INFO - Running setup.py (path:/tmp/pip-s20Tfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:23 INFO - Running setup.py (path:/tmp/pip-D7du9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:23 INFO - Running setup.py (path:/tmp/pip-iwjsIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:23 INFO - Running setup.py (path:/tmp/pip-GkKXBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:23 INFO - Running setup.py (path:/tmp/pip-tjVPYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:23 INFO - Running setup.py (path:/tmp/pip-IEapk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:23 INFO - Running setup.py (path:/tmp/pip-hKyfre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:23 INFO - Running setup.py (path:/tmp/pip-pxwXVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:23 INFO - Running setup.py (path:/tmp/pip-rhpPJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:23 INFO - Running setup.py (path:/tmp/pip-my2zDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:23 INFO - Running setup.py install for manifestparser 12:17:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:23 INFO - Running setup.py install for mozcrash 12:17:23 INFO - Running setup.py install for mozdebug 12:17:24 INFO - Running setup.py install for mozdevice 12:17:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Running setup.py install for mozfile 12:17:24 INFO - Running setup.py install for mozhttpd 12:17:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Running setup.py install for mozinfo 12:17:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Running setup.py install for mozInstall 12:17:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Running setup.py install for mozleak 12:17:24 INFO - Running setup.py install for mozlog 12:17:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Running setup.py install for moznetwork 12:17:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:24 INFO - Running setup.py install for mozprocess 12:17:25 INFO - Running setup.py install for mozprofile 12:17:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:25 INFO - Running setup.py install for mozrunner 12:17:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:25 INFO - Running setup.py install for mozscreenshot 12:17:25 INFO - Running setup.py install for moztest 12:17:25 INFO - Running setup.py install for mozversion 12:17:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:25 INFO - Cleaning up... 12:17:25 INFO - Return code: 0 12:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:25 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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:25 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 12:17:25 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 12:17:25 INFO - Using env: {'DISPLAY': ':0', 12:17:25 INFO - 'HOME': '/home/cltbld', 12:17:25 INFO - 'LANG': 'en_US.UTF-8', 12:17:25 INFO - 'LANGUAGE': 'en_US:en', 12:17:25 INFO - 'LOGNAME': 'cltbld', 12:17:25 INFO - 'MAIL': '/var/mail/cltbld', 12:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:25 INFO - 'MOZ_NO_REMOTE': '1', 12:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:25 INFO - 'NO_EM_RESTART': '1', 12:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:25 INFO - 'PWD': '/builds/slave/test', 12:17:25 INFO - 'SHELL': '/bin/bash', 12:17:25 INFO - 'SHLVL': '1', 12:17:25 INFO - 'TERM': 'linux', 12:17:25 INFO - 'TMOUT': '86400', 12:17:25 INFO - 'USER': 'cltbld', 12:17:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:25 INFO - '_': '/tools/buildbot/bin/python'} 12:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:25 INFO - Running setup.py (path:/tmp/pip-_QonQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:25 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)) 12:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:25 INFO - Running setup.py (path:/tmp/pip-hKScHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:26 INFO - Running setup.py (path:/tmp/pip-ZbNZDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:26 INFO - Running setup.py (path:/tmp/pip-06ZYZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:26 INFO - Running setup.py (path:/tmp/pip-C88FDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:26 INFO - Running setup.py (path:/tmp/pip-EpVQWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:26 INFO - Running setup.py (path:/tmp/pip-IEaMEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:26 INFO - Running setup.py (path:/tmp/pip-H6r5Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:26 INFO - Running setup.py (path:/tmp/pip-aug3mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:26 INFO - Running setup.py (path:/tmp/pip-TlOZHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:26 INFO - Running setup.py (path:/tmp/pip-pVX8yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:26 INFO - Running setup.py (path:/tmp/pip-WXJZJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:26 INFO - Running setup.py (path:/tmp/pip-kf_n3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:26 INFO - Running setup.py (path:/tmp/pip-LFTXvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:26 INFO - Running setup.py (path:/tmp/pip-1SCiK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:26 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)) 12:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:26 INFO - Running setup.py (path:/tmp/pip-pcPAQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:27 INFO - Running setup.py (path:/tmp/pip-JfMSqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:27 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)) 12:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:27 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)) 12:17:27 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)) 12:17:27 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)) 12:17:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:28 INFO - Downloading blessings-1.6.tar.gz 12:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:29 INFO - Installing collected packages: blessings 12:17:29 INFO - Running setup.py install for blessings 12:17:29 INFO - Successfully installed blessings 12:17:29 INFO - Cleaning up... 12:17:29 INFO - Return code: 0 12:17:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:29 INFO - Reading from file tmpfile_stdout 12:17:29 INFO - Current package versions: 12:17:29 INFO - argparse == 1.2.1 12:17:29 INFO - blessings == 1.6 12:17:29 INFO - blobuploader == 1.2.4 12:17:29 INFO - docopt == 0.6.1 12:17:29 INFO - functools32 == 3.2.3-2 12:17:29 INFO - jsonschema == 2.5.1 12:17:29 INFO - manifestparser == 1.1 12:17:29 INFO - mozInstall == 1.12 12:17:29 INFO - mozcrash == 0.17 12:17:29 INFO - mozdebug == 0.1 12:17:29 INFO - mozdevice == 0.48 12:17:29 INFO - mozfile == 1.2 12:17:29 INFO - mozhttpd == 0.7 12:17:29 INFO - mozinfo == 0.9 12:17:29 INFO - mozleak == 0.1 12:17:29 INFO - mozlog == 3.4 12:17:29 INFO - moznetwork == 0.27 12:17:29 INFO - mozprocess == 0.23 12:17:29 INFO - mozprofile == 0.28 12:17:29 INFO - mozrunner == 6.12 12:17:29 INFO - mozscreenshot == 0.1 12:17:29 INFO - mozsystemmonitor == 0.3 12:17:29 INFO - moztest == 0.7 12:17:29 INFO - mozversion == 1.4 12:17:29 INFO - psutil == 3.1.1 12:17:29 INFO - requests == 1.2.3 12:17:29 INFO - wsgiref == 0.1.2 12:17:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:29 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')]} 12:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:29 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')]} 12:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:29 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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:29 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 12:17:29 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 12:17:29 INFO - Using env: {'DISPLAY': ':0', 12:17:29 INFO - 'HOME': '/home/cltbld', 12:17:29 INFO - 'LANG': 'en_US.UTF-8', 12:17:29 INFO - 'LANGUAGE': 'en_US:en', 12:17:29 INFO - 'LOGNAME': 'cltbld', 12:17:29 INFO - 'MAIL': '/var/mail/cltbld', 12:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:29 INFO - 'MOZ_NO_REMOTE': '1', 12:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:29 INFO - 'NO_EM_RESTART': '1', 12:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:29 INFO - 'PWD': '/builds/slave/test', 12:17:29 INFO - 'SHELL': '/bin/bash', 12:17:29 INFO - 'SHLVL': '1', 12:17:29 INFO - 'TERM': 'linux', 12:17:29 INFO - 'TMOUT': '86400', 12:17:29 INFO - 'USER': 'cltbld', 12:17:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:29 INFO - '_': '/tools/buildbot/bin/python'} 12:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 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)) 12:17:29 INFO - Cleaning up... 12:17:29 INFO - Return code: 0 12:17:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17:29 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')]} 12:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:29 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')]} 12:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:29 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 0x7fd2a8843f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d85ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', '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 12:17:29 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 12:17:29 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 12:17:29 INFO - Using env: {'DISPLAY': ':0', 12:17:29 INFO - 'HOME': '/home/cltbld', 12:17:29 INFO - 'LANG': 'en_US.UTF-8', 12:17:29 INFO - 'LANGUAGE': 'en_US:en', 12:17:29 INFO - 'LOGNAME': 'cltbld', 12:17:29 INFO - 'MAIL': '/var/mail/cltbld', 12:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:29 INFO - 'MOZ_NO_REMOTE': '1', 12:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:29 INFO - 'NO_EM_RESTART': '1', 12:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:29 INFO - 'PWD': '/builds/slave/test', 12:17:29 INFO - 'SHELL': '/bin/bash', 12:17:29 INFO - 'SHLVL': '1', 12:17:29 INFO - 'TERM': 'linux', 12:17:29 INFO - 'TMOUT': '86400', 12:17:29 INFO - 'USER': 'cltbld', 12:17:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:29 INFO - '_': '/tools/buildbot/bin/python'} 12:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:17:29 INFO - Cleaning up... 12:17:29 INFO - Return code: 0 12:17:29 INFO - Running post-action listener: _resource_record_post_action 12:17:29 INFO - Running post-action listener: _start_resource_monitoring 12:17:29 INFO - Starting resource monitoring. 12:17:30 INFO - [mozharness: 2016-09-29 19:17:30.001814Z] Finished create-virtualenv step (success) 12:17:30 INFO - [mozharness: 2016-09-29 19:17:30.002279Z] Running install step. 12:17:30 INFO - Running pre-action listener: _resource_record_pre_action 12:17:30 INFO - Running main action method: install 12:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:30 INFO - Reading from file tmpfile_stdout 12:17:30 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:30 INFO - Reading from file tmpfile_stdout 12:17:30 INFO - Output received: 12:17:30 INFO - Usage: mozinstall [options] installer 12:17:30 INFO - Options: 12:17:30 INFO - -h, --help show this help message and exit 12:17:30 INFO - -d DEST, --destination=DEST 12:17:30 INFO - Directory to install application into. [default: 12:17:30 INFO - "/builds/slave/test"] 12:17:30 INFO - --app=APP Application being installed. [default: firefox] 12:17:30 INFO - mkdir: /builds/slave/test/build/application 12:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:17:46 INFO - Reading from file tmpfile_stdout 12:17:46 INFO - Output received: 12:17:46 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:46 INFO - Running post-action listener: _resource_record_post_action 12:17:46 INFO - [mozharness: 2016-09-29 19:17:46.445567Z] Finished install step (success) 12:17:46 INFO - [mozharness: 2016-09-29 19:17:46.445811Z] Running run-tests step. 12:17:46 INFO - Running pre-action listener: _resource_record_pre_action 12:17:46 INFO - Running main action method: run_tests 12:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:46 INFO - Python 2.7.3 12:17:46 INFO - Return code: 0 12:17:46 INFO - grabbing minidump binary from tooltool 12:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:46 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 0x1d82f60>, '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 0x1d83d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d841d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:46 INFO - Return code: 0 12:17:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 12:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 12:17:46 INFO - Using env: {'DISPLAY': ':0', 12:17:46 INFO - 'HOME': '/home/cltbld', 12:17:46 INFO - 'LANG': 'en_US.UTF-8', 12:17:46 INFO - 'LANGUAGE': 'en_US:en', 12:17:46 INFO - 'LOGNAME': 'cltbld', 12:17:46 INFO - 'MAIL': '/var/mail/cltbld', 12:17:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:46 INFO - 'MOZ_NO_REMOTE': '1', 12:17:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:46 INFO - 'NO_EM_RESTART': '1', 12:17:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:46 INFO - 'PWD': '/builds/slave/test', 12:17:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:46 INFO - 'SHELL': '/bin/bash', 12:17:46 INFO - 'SHLVL': '1', 12:17:46 INFO - 'TERM': 'linux', 12:17:46 INFO - 'TMOUT': '86400', 12:17:46 INFO - 'USER': 'cltbld', 12:17:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791', 12:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:46 INFO - '_': '/tools/buildbot/bin/python'} 12:17:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 12:17:46 INFO - mozversion application_buildid: 20160929105520 12:17:46 INFO - mozversion application_changeset: b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5 12:17:46 INFO - mozversion application_display_name: Nightly 12:17:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:46 INFO - mozversion application_name: Firefox 12:17:46 INFO - mozversion application_remotingname: firefox 12:17:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:17:46 INFO - mozversion application_vendor: Mozilla 12:17:46 INFO - mozversion application_version: 52.0a1 12:17:46 INFO - mozversion platform_buildid: 20160929105520 12:17:46 INFO - mozversion platform_changeset: b9b87a4102da1a9857a89cfbc859a6bf23bfe0e5 12:17:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:17:46 INFO - mozversion platform_version: 52.0a1 12:17:46 INFO - using testdate: 1475176666 12:17:46 INFO - actual date: 1475176666 12:17:46 INFO - starting webserver on 'localhost:55780' 12:17:46 INFO - SUITE-START | Running 2 tests 12:17:46 INFO - TEST-START | dromaeo_css 12:17:46 INFO - operating with platform_type : linux_ 12:17:46 INFO - Initialising browser for dromaeo_css test... 12:17:46 INFO - TEST-INFO | started process 21666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpddl90N/profile http://localhost:55780/getInfo.html) 12:17:51 INFO - PROCESS | 21666 | __metrics Screen width/height:1600/1200 12:17:51 INFO - PROCESS | 21666 | colorDepth:24 12:17:51 INFO - PROCESS | 21666 | Browser inner width/height: 1024/697 12:17:51 INFO - PROCESS | 21666 | __metrics 12:17:51 INFO - PROCESS | 21666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:17:51 INFO - PROCESS | 21666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:52 INFO - PROCESS | 21666 | console.error: PushService: 12:17:52 INFO - PROCESS | 21666 | stateChangeProcessEnqueue: Error transitioning state 12:17:52 INFO - PROCESS | 21666 | UnknownError 12:17:53 INFO - TEST-INFO | 21666: exit 0 12:17:53 INFO - Browser initialized. 12:17:53 INFO - Running cycle 1/1 for dromaeo_css test... 12:17:53 INFO - TEST-INFO | started process 21749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpddl90N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:05 INFO - PROCESS | 21749 | RSS: Main: 175394816 12:18:05 INFO - PROCESS | 21749 | 12:18:56 INFO - PROCESS | 21749 | 1475176736413 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:21:10 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:55780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55780/tests/dromaeo/cssquery-ext.html) 12:21:11 INFO - PROCESS | 21749 | RSS: Main: 256106496 12:21:11 INFO - PROCESS | 21749 | 12:24:14 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:55780/tests/dromaeo/cssquery-ext.html (next: http://localhost:55780/tests/dromaeo/cssquery-jquery.html) 12:24:14 INFO - PROCESS | 21749 | RSS: Main: 267079680 12:24:14 INFO - PROCESS | 21749 | 12:27:17 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:55780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55780/tests/dromaeo/cssquery-mootools.html) 12:27:17 INFO - PROCESS | 21749 | RSS: Main: 215339008 12:27:17 INFO - PROCESS | 21749 | 12:30:20 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:55780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55780/tests/dromaeo/cssquery-prototype.html) 12:30:20 INFO - PROCESS | 21749 | RSS: Main: 214265856 12:30:20 INFO - PROCESS | 21749 | 12:33:23 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:55780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55780/tests/dromaeo/cssquery-yui.html) 12:33:24 INFO - PROCESS | 21749 | RSS: Main: 215961600 12:33:24 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | Cycle 1(1): loaded http://localhost:55780/tests/dromaeo/cssquery-yui.html (next: http://localhost:55780/tests/dromaeo/cssquery-dojo.html) 12:36:27 INFO - PROCESS | 21749 | RSS: Main: 299044864 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | __start_tp_report 12:36:27 INFO - PROCESS | 21749 | _x_x_mozilla_page_load 12:36:27 INFO - PROCESS | 21749 | _x_x_mozilla_page_load_details 12:36:27 INFO - PROCESS | 21749 | |i|pagename|runs| 12:36:27 INFO - PROCESS | 21749 | |0;dojo.html;2580.8064395170363;2611.856347900865;2634.920952371427;2641.141628970585;2649.7350264973506;4600.516945720693;4686.789094490748;4745.928811067833;4760.904781904364;4773.7374444405505;4650.976745116278;4665.626749860012;4681.133990211813;4717.669763116583;4782.665213435061;4255.659547236213;4267.978660106695;4309.181255561449;4311.504177019636;4355.412019377391;4142.979285103585;4424.867253982386;4429.114177164563;4461.085477477126;4517.41273634427;4317.7193482423545;4370.047031450422;4378.781060946956;4381.948332400233;4414;4289.6139347458875;4321.416608757841;4322.827086916551;4331.047169622678;4364.563543645641;4350.151720414488;4361.931326824916;4401.735895846259;4403.075354175627;4415.8233670653135;4722.858314250578;4726.172919739032;4729.148753224418;4765.21373973294;4808.917993451445;4960.305557221992;5022.799088036474;5025.497450254982;5087.49125087492;5096.719680417576;5078.568321692661;5087.771050302708;5101.897962040738;5121.180611102243;5142.871428214325;4736.573708366194;4738.549837765407;4739.265413860822;4741.1465936131135;4798.664093513421;5109.591232701375;5158.09733296679;5188.818391356284;5190.455002224712;5259.789608415697;4891;4922.827701030446;4924.679895806761;4935.087008903364;4963.950360496348;5013.448520662724;5018.473060328686;5085.898282034339;5092.159793634083;5158.148905430562;4917.483664215278;5058.241263810458;5069.290299358093;5069.518395752398;5076.44159142494;4953.23224900141;4958;4966.875828104254;5011.674241174312;5080.568151707146;4028.2547728669706;4036.313826649418;4036.5761595032686;4038.0712436139265;4072.8778136655947;3557.9110522236633;3564.4475106358555;3569.8572057117944;3597.190632107755;3609.1698909251018;4279.593438623326;4328.826846926151;4328.891777705582;4371.75955322454;4381.627561657231;5022.773975171126;5048.192289233705;5049.722265275445;5061.2661164131;5102.515261050268;4385.473743150842;4388.100439409914;4389.034412429261;4397.120575884772;4433;4498.370228168059;4538.092381523708;4575.977120114445;4584.770761461914;4585.449746030497;4812.51874812523;4826.034793041335;4828.637852161172;4879.951200488092;4894.2169252920785;5105.31078304439;5118;5121.615878809179;5122.487751224997;5179.81870634526;4731.479537250831;4764.976175119103;4812.5668689818085;4831.830885918976;4893.510648935078;4971.751412429292;5010.49895010496;5013.072581572275;5014;5088.974555127201;5070.847874563769;5105.540501354896;5110.48895110486;5114.71869047206;5179.430262671028;4863.173260545786;4972.328735620789;4975.626827987843;4975.626827987988;4983.177775666974;4906.337644417958;5005.824796132118;5067.366579177603;5082.288479612783;5085.237214417867;4935.506449355035;4939.506049395031;4943.159662857251;4953.504649535018;5016.448190699093;4811.639127065414;4919.581835544019;4932.3094766731965;4934.753262336941;5021.422536408214;4871.318015477765;4891.755412229445;4896;4897.0450762101045;4949.6287778416045 12:36:27 INFO - PROCESS | 21749 | |1;ext.html;529.6768970927733;559.6893723983189;578.8871170121826;579.959402841801;585.701292340906;27562.310942226453;29975.250618734517;36941;38197;38346.80826595863;38982.610173898254;39033.804830975874;39049.41425878614;39054.21891562167;39097.804510977476;7266.781996540112;7499.212582678809;7645.579493127903;7647.694092236304;7649.885251721229;7299.927000730005;7560.848783024337;7562.281583249583;9485.193758530533;9716.854247186298;9968.252381071412;10003.89996100037;10024.248181386389;10024.949875250613;10025;9927.404355738643;10000.699979000641;10000.999999999964;10012.449315287657;10016.79966400668;9613.51932403377;9673.274504412197;9678.854817177747;9680.128788409007;9692.079252471003;37983.43024854629;38306.61693383086;38363.396392432805;38646.61353386458;38657.806710966266;3001.9099427017222;3052.9847350763102;3061.9540706889416;3171.762117841171;3269.2480729432127;28241;28434.289142771388;28488.86044558215;28638.856805715837;30114.24714382136;2919.372334947975;2950.7491863191653;2975.7619390448713;3004.3390454100063;3010.0518336723862;247480;248372;248871;248911;249941.9999999982;31071.844640777104;32015.359692806014;50948.490515095116;51135.488645113815;51297.487025129274;32736.345273094405;32852.67147328544;32881.67118328786;33002.339953200804;33016.174595634824;12463;12674.112812103065;12675.04937129719;12679.746405072032;12689.555865544662;9459.716208513755;9461;9479.336446448682;9513.904860951301;9534.666286680073;7144.1784194818265;7337;7373.520721153108;7585.317321441097;7636.350910172587;2987.067998903654;3086.36729470458;3104.8447577621027;3108.331708682644;3132.1856317357197;859.3984211052289;867.9609417576224;868;891.6727341638319;924.7410724997012;26534;27880.860595697297;27897.860510697723;28038.579421308288;28310.292242693686;902.8420026495469;936.8032713130183;940.7695114696943;983.6163896080534;1025.6410256410197;13639.863601363859;14785.852141478663;14885.404583816526;14963.925180374028;15160.31778569967;369103;371067;371936.24510039133;373050;373794;48784;49174.754126229855;49210.507894921306;49250.26124608134;49314;1056.587930707025;1107.4960892793758;1122.6744244169427;1145.2098052343856;1176.3588844079825;25880.741192587833;29479.11562653124;29482.852585736935;29527.26181845471;29680.554791678573;40799.1840163201;46484.30273545832;47779;47831.76084119557;52367.47632523626;326238;328828;329237;329392;329927;24394.146204882745;25122.37194070163;25463.23610291694;37951.240975180895;38392.2321553573;39802.60197398105;40034.59965400309;40142.397864032646;40281.1943761129;40404.79797600993;33167.502487462225;33529.49705754464;33708;33855.15362115967;34259.314813704084;33311.66688333086;34002.319953600294;34017.31965360729;34122.829385852914;34725.652743473256;34368.48447273343;34374.82812585921;34942.12644683903;35202;35297;29882.402351953275;31367.84316078405;31385.215369615027;31634.367312654078;32199.195020124684;24686.876565617058;24949.625755613317;25056.123035694392;25116.12093576716;25446.745532545177 12:36:27 INFO - PROCESS | 21749 | |2;jquery.html;338.3809315894974;352.93117842020814;354.67724370822555;362.93285742137704;388.0531503132357;12436.626901192967;13268.800967985477;13424.731505369888;14873.405063797449;17153.82846171538;15567.766483502728;15694;15766;16100.436484723037;16428.67142657146;4798.352222449959;4869.805207791684;4958.652894297401;4967.428745694256;5001.17480615698;3670;3858.8070596470066;4925.926111108336;5012.348394708701;5017.874553136165;3836.3669994450884;3879.4374815651713;3884.5726970033274;3884.611538846121;4155.709100362976;5790.507806836424;5910.172575839386;5911.083782013752;5917.437843404869;5919.112133180014;4694.81220751173;4951.653384263103;4978.8257410990445;5184.326037615124;5186.092433824066;12056.397180140957;12263.141580089397;12278.938605307005;12305.44625491855;17823;1816.727490876366;1838.4852241372437;1910.1881700277327;1914.4352416037302;1950.2686492565288;8987.37088403812;9325.813483730288;9795.853062204002;10269.229807764374;13294.734105317839;1610.474046017815;1676.6395225026556;1677.8070521890018;1701;1716.5107944235833;67268.66365668189;67325.66337168282;67922.66038669825;68268;69365.65317173432;9396.624135034659;9550.140487356033;9566.952165239129;9672.56473458696;9754.0733630305;13178.868211317764;13220.867791322156;13233.933830330787;13238.602841914759;13258.73482530344;6860.622665753332;6911.054725680524;6981.30186981308;7020.508564400443;7094.042304288958;6672.766453174116;6768.661566921733;6881.827954301182;7076.398506126934;7105.111861017373;3867.400552914303;3881.844726210976;3912.295786758411;3955.0903292242947;3955.228730397545;1770.2653398839595;1778.3242367900116;1788.320438233463;1791.9552011199564;1803.9368622098164;831.5301854452215;839.0895877972346;843.2663582683105;888.7778055486128;898.4788822482944;14636.780448293284;16442.61582070617;16812.495625131265;16844.74732879008;17541.473755787345;781.2773184804147;781.6404453951246;829.5271695133716;860.548212188606;887.0464250930147;9150.954245228731;9588.808223835484;9618.086281803218;9646.565904534313;9895.158911492459;295850;300192;301046;377669;379223;82017;85269;88562;88835;89110.55444722864;879.8768172455862;913.4747520175926;920.4017388697266;924.0297687428174;924.5192499900014;15513.689726205186;15792.92103539475;16180.595485112966;16496.67006659884;16663.250153743353;31259.84370078135;34909.301813964084;37915.241695165394;38947.02632434212;39567;48852.755736221094;52332;54108.18837717516;54819.45180548143;55438;7062.364387204971;7204.639768011683;7414.62926853666;7434.3309102181065;7678.040244969379;10758.193135515025;11305.886941130484;11320;11320.660380188607;11684.649460516199;9985.550650220903;10322.535485903303;10622.415767132881;10639.680809575726;10705.304155229886;9757.51212439361;9822.361546499455;9863.408195508293;10094.091531761884;10236.283460157718;10074.14369778577;10096.79806403853;10104.595816167272;10264.127549158406;10564.524596393027;7343.963280183565;7379.963100184465;7498.887516687363;7530.171681114964;7832.138464768985;8639.438436501607;9854.655087071918;9869.259805514472;10105.343152695052;10162.847557286499 12:36:27 INFO - PROCESS | 21749 | |3;mootools.html;1257.5724253753722;1385.6258810121265;1411.9788203176952;1461.627285042314;1690.366112707734;6544.149260596122;7249.202587715354;7480.738174163906;7501.849963000744;7687.2312768723095;7624.466287359887;7679.232076792318;7681.039870016248;7702.8844567331535;7704.6918123275145;2119.4277545062823;2154.4183070570934;2156.590247852903;2158.2446143849606;2162.610730068595;2084.6664533674616;2124.033564728045;2152.1714140056033;2154.482924098213;2157.0832396231617;2108.9789102108934;2121.469632591852;2126.8936553172357;2135.1566131378095;2184.322859913432;2098.664213725804;2103.6739305407687;2108.2515706923973;2113.4505028692497;2114.598226336991;2058.5677007828376;2075.9169633214806;2096.727425434699;2098.4858709616087;2099.3177217404404;7381.815454613624;7486.550806951546;7521.736739214156;7550.0939887213335;7563.205863384321;4468.687191896569;4580.473245576768;4583.4041574595085;4590.196715574761;4591.79336929839;2782.8191167574246;2863.4130003349264;2914.0529327968493;2915.023467138511;2923.4007028559095;871.5685735560875;871.6469829718974;878.3105262369073;883.5758835758871;890.7238755985666;9839.262055345878;9930.155936745385;9939.403635781877;10098.747531311703;10104.343217690826;3643.617420170844;3850.8844734658005;3948.0919388540797;3968.9603103969166;4018.2967980603275;7910.52536847791;7911.841763164704;7920.5247685139075;7951.204879512003;7980.122186559473;4467.285234362486;4519.909601807945;4536.160810250114;4537.069900670354;4539.205639013226;3628.800415977094;3746.8688595899557;4010.979945100256;4187;4189;3156.6054243219596;3190.9418425116132;3283.441814891474;3320.9169770755443;3328.4341661917533;958.2286259560981;958.3339578992533;961.7932144588947;964.0985678390728;964.1852634523816;668.1848145262771;708.1325376413852;808.5472135604081;838.8448137094657;841.8526757817358;5058.367704036996;5172.120739474223;5230.503102205284;5379.1662292344745;5492.144886504261;789.7630710786741;801.3749275565068;814.5112932240609;864.9481031138026;906.7007887397143;3416.1506130468106;3601.1537288737127;3690.1697118148204;3775.433684947225;3793.279276937373;8839.602217900081;9042.18620324174;9122.042185570552;9140;9141.77145571366;9101.499417531966;9104.499252541174;9112.362134650512;9112.544372781334;9117.772055698528;6747.291534388818;6842.897356539655;6887;6892.414144797648;6899.103116594811;4970.428400733962;5005.174146265826;5074.188129899198;5079.593632509464;5341.786328546815;8299.668013279643;8499.490030598185;8536.70121545743;8620.956895215484;8705.173008564176;8723.869141962748;8779.25376343018;8819.514926679094;8864.468131912106;8961.731148065568;5520.1167813149705;6215.378462153749;6334.461570766352;6504.772332968323;6570.901436478553;6524.3149469305035;6776.864462710817;6781.0845535854005;6823.38589526945;7014.894776578458;6373.968130159319;6574.11249481333;6661.733530658719;6695.363940425652;6698.698558564779;6501.219853617407;6533.281339052795;6559.344065593403;6566.770163044271;6607.041978912935;5826.213461182686;5936.525077993837;5939.46544810969;5939.4951429129005;5951.196588460502;4334.5882141196535;4372.80322385487;4422.75674837887;4504.189245935763;4556.726596404226;4334.349847522897;4498.167838949805;4542.046170304141;4586.472555656009;4641.3734145889875 12:36:27 INFO - PROCESS | 21749 | |4;prototype.html;283.83679384354;289.4919416424176;293.0373722322172;293.9015429831006;298.1324346152695;4870.269459581064;4870.586000189984;4878.292647566101;4898.53463920927;4913.115639184945;4760.714357138574;4774.713517188971;4775.641826862981;4812.494688057747;4817.7109373437615;3792.6207379262128;3825.407061905409;3825.7895815730126;3826.1199924017424;3844.8462061517507;3698.7041036716996;3833.4633151358694;3833.5591406988274;3843.8270277837423;3853.499045124144;3712.1276500022473;3715.405535114382;3737.663610275075;3760;3772.9434058489146;3711.42472916697;3716.1267102230954;3723.858781200793;3734.6452087051684;3762.9435558466644;3062.525308577174;3141.7643676724338;3216.790908590934;3333.516640087174;3335.816530090844;4627.976860115711;4629.7916593753025;4641.605463535603;4650.162970665279;4657.928676404412;4262.488501379823;4276.786160691953;4282.143571285756;4283.87148385549;4295.548967358445;4635.9536404635855;4774.474807771142;4947.529984651453;5004.374453193351;5034.51481812866;3588.4437912123662;3616.7468277220605;3617.7286703497343;3620.420732682758;3641.5266015417824;5211.5049070338255;5241.9213711794355;5242.6330156889035;5247.39654939683;5282.815101471469;3654.1778099927305;3717.7211709121925;3733.9439908401396;3739.7569158004644;3744.648539557081;3768.1333293342686;3774.3017541754316;3780.7542509736777;3783.1487915218854;3790.9241815164096;4295.634871035934;4302.483701955785;4307.612314891675;4316.719413238129;4322.935155972663;5039.732120545769;5055.823046193365;5069.264956581349;5074.426927652439;5076.44159142494;1241.211830487647;1292.5023865811543;1305.106002388367;1311.6524121107914;1312.6324629103867;827.755812035451;842.4439869685978;853.5902766672032;859.6088779605265;864.0236532717988;3974.741641793274;3982.108498463265;3984.7210695251633;4000.539937907178;4014.297497937849;4525.728456292567;4527.320901864747;4531.274996000624;4558.931616025762;4578.793954272066;3947.822347994347;3955.881323560298;3963.4847469828737;3974.8608798691907;4007.158496715664;2304.2971893572285;2409.6265078912797;2421.0436877433317;2439.243834411338;2454.3005243505513;4327.805248763751;4336.6122840691305;4624.237000894882;4775.880602984884;4803.967147063398;5284.180951952453;5285.180796976475;5297.860959893641;5320.17537281722;5332.093544097513;4909.754512274443;4922.753862306942;4924.823488849672;4935.161022626162;4944.884722624652;4980.576650984707;5178.789150726574;5213.618391126431;5226.163813789927;5235.910812620572;5155.355580552431;5163.767630456563;5174.27560141588;5180.870478238075;5184.559312458483;4921.557059864629;4927.211646136601;4928.852134435972;4931.211006239128;4979.975100124621;3630.8003059831963;3718.981405092957;3740.1397678534636;3740.775553466801;3746.269477451871;5234.319538459976;5241.737913104405;5248.921266180934;5251.186066159751;5263.710495922761;5076.416212135504;5115.948840511547;5126.256692779601;5127.46161653021;5131.307273518177;4810.518948105161;5061.190209566452;5062.924056139087;5068.467810879804;5085.567726743268;4996.200607902718;4999;4999.200127979506;5001.274815151855;5002.274215395682;5116.7953281869795;5135.435102138837;5141.203113517411;5158.8392611662075;5177.378714554277;4776.522347765195;4906.975465122651;4960.677555958851;4962.156433406258;4979.377577802775 12:36:27 INFO - PROCESS | 21749 | |5;yui.html;615.9106929495223;636.7007506471956;642.8585711143548;644.642223565921;660.2868901586285;12439.253644781309;12849.743005139891;13193;13197.406116724758;13197.802032969501;12641.178323408994;12677.366131693425;12720;12737;12761.361931903413;616.4020899727258;641.1312671330351;754.7697952124599;772.8492943875947;774.9225077492262;758.1698040645484;781.0900301149182;786.7915002524308;788.1802924958065;788.5190034079208;821.8849361089452;825.2820046559501;825.781167990483;826.5825757992205;826.8263664630434;645.9741610335581;665.1452883045312;819.0335404223015;819.0539926385035;819.692615269277;579.8144593730008;594.8810237952426;597.3280059932575;598.1416667082707;598.6288501129284;11845.348505832177;11917.702057448632;11965.042796576254;11985.520579176822;12004;11439.942800286028;12009.45957431909;12103.394830258452;12122.878771212263;12817.295048772314;10895.182861285435;10950.945245273802;11257.324560526313;11260.718482038015;11421.771564568662;3926.9214615707524;3950.1112249743865;3961.9009524761823;3979.900502487432;3997.72015958883;52929.73535132338;54555.18167227495;54868.17697734537;62477.687611562105;65702.67148664274;8956.462612243286;9569.138777509917;9570.282228832866;9783.951080244695;9828.508574571242;17652.91173544124;17654;17688;17689.292428302982;17699.73450398245;6595.472362211011;6673.366030227217;6688.933110668929;6846.520743547904;6935.583864968118;3646.4165733482514;3648.5621725392593;3687.410014397737;3697.926041479155;3734.6638802507905;2862.355969906796;2988.208124846917;3109.455845227076;3218.340240250743;3251.8048917065053;503.4839289727985;513.7148882370245;532.4302995794462;532.7469452010264;542.1623591551063;592.2744637818638;607.6202373516552;626.1077963901422;627.5795217204484;630.7445484578753;8524.616392262364;8627.137286271449;8912.955435222782;8916.509591972504;9038.457692538468;550.9449055094459;581.8080033588906;593.5844908564022;625.6371304643296;626.9592476489014;3750.849966001384;3855.768653880776;3878.3794592865006;3928.685705143582;4120.21715873983;77076.61461692768;77265;79392;88540.55729721439;104215;73745.6312718433;77075.61462192766;77409.61295193488;77937.61031194922;78557.60721196471;58311;67100.66449667818;68489.65755171192;68660;72184.63907680428;8066.717664881701;8288.70989515364;8444.408891377545;8568;8742.300615950582;39786.801065994485;40571.39142912918;42183;42352.5764742361;43735.34396983984;51447.48552514577;54474.45525544694;55726;61732.69133654303;64048.35951640424;11507.597234096766;11562.595309164139;11881;11895.821562676394;12528.248305101723;11919.702007449883;12144.089193310714;12241.0819188563;12477.188982716094;12809;10271.383716977005;10981.011708946233;11866.466009029442;12908.290044047668;13186.076974611686;11947.880521195024;12080.8991459316;12393.690157745768;12538.185017973803;12802.551910683082;8338;8433.83132337362;10002.399856008371;12196.878031219929;12217.93891030539;9189;9539.282467097017;9957.502124893872;10285.74285642865;10505.26463147603;9061.68284110053;9096.784457215403;9718.514074296398;9726.76348444793;10383.844242336521 12:36:27 INFO - PROCESS | 21749 | __end_tp_report 12:36:27 INFO - PROCESS | 21749 | __start_cc_report 12:36:27 INFO - PROCESS | 21749 | _x_x_mozilla_cycle_collect,843 12:36:27 INFO - PROCESS | 21749 | __end_cc_report 12:36:27 INFO - PROCESS | 21749 | __startTimestamp1475177787296__endTimestamp 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | ------- Summary: start ------- 12:36:27 INFO - PROCESS | 21749 | Number of tests: 6 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | [#0] dojo.html Cycles:165 Average:4676.87 Median:4831.83 stddev:516.48 (10.7%) stddev-sans-first:491.20 12:36:27 INFO - PROCESS | 21749 | Values: 2580.8 2611.9 2634.9 2641.1 2649.7 4600.5 4686.8 4745.9 4760.9 4773.7 4651.0 4665.6 4681.1 4717.7 4782.7 4255.7 4268.0 4309.2 4311.5 4355.4 4143.0 4424.9 4429.1 4461.1 4517.4 4317.7 4370.0 4378.8 4381.9 4414.0 4289.6 4321.4 4322.8 4331.0 4364.6 4350.2 4361.9 4401.7 4403.1 4415.8 4722.9 4726.2 4729.1 4765.2 4808.9 4960.3 5022.8 5025.5 5087.5 5096.7 5078.6 5087.8 5101.9 5121.2 5142.9 4736.6 4738.5 4739.3 4741.1 4798.7 5109.6 5158.1 5188.8 5190.5 5259.8 4891.0 4922.8 4924.7 4935.1 4964.0 5013.4 5018.5 5085.9 5092.2 5158.1 4917.5 5058.2 5069.3 5069.5 5076.4 4953.2 4958.0 4966.9 5011.7 5080.6 4028.3 4036.3 4036.6 4038.1 4072.9 3557.9 3564.4 3569.9 3597.2 3609.2 4279.6 4328.8 4328.9 4371.8 4381.6 5022.8 5048.2 5049.7 5061.3 5102.5 4385.5 4388.1 4389.0 4397.1 4433.0 4498.4 4538.1 4576.0 4584.8 4585.4 4812.5 4826.0 4828.6 4880.0 4894.2 5105.3 5118.0 5121.6 5122.5 5179.8 4731.5 4765.0 4812.6 4831.8 4893.5 4971.8 5010.5 5013.1 5014.0 5089.0 5070.8 5105.5 5110.5 5114.7 5179.4 4863.2 4972.3 4975.6 4975.6 4983.2 4906.3 5005.8 5067.4 5082.3 5085.2 4935.5 4939.5 4943.2 4953.5 5016.4 4811.6 4919.6 4932.3 4934.8 5021.4 4871.3 4891.8 4896.0 4897.0 4949.6 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | [#1] ext.html Cycles:180 Average:45843.47 Median:33928.74 stddev:84473.73 (249.0%) stddev-sans-first:84642.18 12:36:27 INFO - PROCESS | 21749 | Values: 529.7 559.7 578.9 580.0 585.7 27562.3 29975.3 36941.0 38197.0 38346.8 38982.6 39033.8 39049.4 39054.2 39097.8 7266.8 7499.2 7645.6 7647.7 7649.9 7299.9 7560.8 7562.3 9485.2 9716.9 9968.3 10003.9 10024.2 10024.9 10025.0 9927.4 10000.7 10001.0 10012.4 10016.8 9613.5 9673.3 9678.9 9680.1 9692.1 37983.4 38306.6 38363.4 38646.6 38657.8 3001.9 3053.0 3062.0 3171.8 3269.2 28241.0 28434.3 28488.9 28638.9 30114.2 2919.4 2950.7 2975.8 3004.3 3010.1 247480.0 248372.0 248871.0 248911.0 249942.0 31071.8 32015.4 50948.5 51135.5 51297.5 32736.3 32852.7 32881.7 33002.3 33016.2 12463.0 12674.1 12675.0 12679.7 12689.6 9459.7 9461.0 9479.3 9513.9 9534.7 7144.2 7337.0 7373.5 7585.3 7636.4 2987.1 3086.4 3104.8 3108.3 3132.2 859.4 868.0 868.0 891.7 924.7 26534.0 27880.9 27897.9 28038.6 28310.3 902.8 936.8 940.8 983.6 1025.6 13639.9 14785.9 14885.4 14963.9 15160.3 369103.0 371067.0 371936.2 373050.0 373794.0 48784.0 49174.8 49210.5 49250.3 49314.0 1056.6 1107.5 1122.7 1145.2 1176.4 25880.7 29479.1 29482.9 29527.3 29680.6 40799.2 46484.3 47779.0 47831.8 52367.5 326238.0 328828.0 329237.0 329392.0 329927.0 24394.1 25122.4 25463.2 37951.2 38392.2 39802.6 40034.6 40142.4 40281.2 40404.8 33167.5 33529.5 33708.0 33855.2 34259.3 33311.7 34002.3 34017.3 34122.8 34725.7 34368.5 34374.8 34942.1 35202.0 35297.0 29882.4 31367.8 31385.2 31634.4 32199.2 24686.9 24949.6 25056.1 25116.1 25446.7 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | [#2] jquery.html Cycles:180 Average:22523.84 Median:21861.35 stddev:55818.75 (255.3%) stddev-sans-first:55950.48 12:36:27 INFO - PROCESS | 21749 | Values: 338.4 352.9 354.7 362.9 388.1 12436.6 13268.8 13424.7 14873.4 17153.8 15567.8 15694.0 15766.0 16100.4 16428.7 4798.4 4869.8 4958.7 4967.4 5001.2 3670.0 3858.8 4925.9 5012.3 5017.9 3836.4 3879.4 3884.6 3884.6 4155.7 5790.5 5910.2 5911.1 5917.4 5919.1 4694.8 4951.7 4978.8 5184.3 5186.1 12056.4 12263.1 12278.9 12305.4 17823.0 1816.7 1838.5 1910.2 1914.4 1950.3 8987.4 9325.8 9795.9 10269.2 13294.7 1610.5 1676.6 1677.8 1701.0 1716.5 67268.7 67325.7 67922.7 68268.0 69365.7 9396.6 9550.1 9567.0 9672.6 9754.1 13178.9 13220.9 13233.9 13238.6 13258.7 6860.6 6911.1 6981.3 7020.5 7094.0 6672.8 6768.7 6881.8 7076.4 7105.1 3867.4 3881.8 3912.3 3955.1 3955.2 1770.3 1778.3 1788.3 1792.0 1803.9 831.5 839.1 843.3 888.8 898.5 14636.8 16442.6 16812.5 16844.7 17541.5 781.3 781.6 829.5 860.5 887.0 9151.0 9588.8 9618.1 9646.6 9895.2 295850.0 300192.0 301046.0 377669.0 379223.0 82017.0 85269.0 88562.0 88835.0 89110.6 879.9 913.5 920.4 924.0 924.5 15513.7 15792.9 16180.6 16496.7 16663.3 31259.8 34909.3 37915.2 38947.0 39567.0 48852.8 52332.0 54108.2 54819.5 55438.0 7062.4 7204.6 7414.6 7434.3 7678.0 10758.2 11305.9 11320.0 11320.7 11684.6 9985.6 10322.5 10622.4 10639.7 10705.3 9757.5 9822.4 9863.4 10094.1 10236.3 10074.1 10096.8 10104.6 10264.1 10564.5 7344.0 7380.0 7498.9 7530.2 7832.1 8639.4 9854.7 9869.3 10105.3 10162.8 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | [#3] mootools.html Cycles:180 Average:4899.83 Median:5939.48 stddev:2705.70 (45.6%) stddev-sans-first:2699.44 12:36:27 INFO - PROCESS | 21749 | Values: 1257.6 1385.6 1412.0 1461.6 1690.4 6544.1 7249.2 7480.7 7501.8 7687.2 7624.5 7679.2 7681.0 7702.9 7704.7 2119.4 2154.4 2156.6 2158.2 2162.6 2084.7 2124.0 2152.2 2154.5 2157.1 2109.0 2121.5 2126.9 2135.2 2184.3 2098.7 2103.7 2108.3 2113.5 2114.6 2058.6 2075.9 2096.7 2098.5 2099.3 7381.8 7486.6 7521.7 7550.1 7563.2 4468.7 4580.5 4583.4 4590.2 4591.8 2782.8 2863.4 2914.1 2915.0 2923.4 871.6 871.6 878.3 883.6 890.7 9839.3 9930.2 9939.4 10098.7 10104.3 3643.6 3850.9 3948.1 3969.0 4018.3 7910.5 7911.8 7920.5 7951.2 7980.1 4467.3 4519.9 4536.2 4537.1 4539.2 3628.8 3746.9 4011.0 4187.0 4189.0 3156.6 3190.9 3283.4 3320.9 3328.4 958.2 958.3 961.8 964.1 964.2 668.2 708.1 808.5 838.8 841.9 5058.4 5172.1 5230.5 5379.2 5492.1 789.8 801.4 814.5 864.9 906.7 3416.2 3601.2 3690.2 3775.4 3793.3 8839.6 9042.2 9122.0 9140.0 9141.8 9101.5 9104.5 9112.4 9112.5 9117.8 6747.3 6842.9 6887.0 6892.4 6899.1 4970.4 5005.2 5074.2 5079.6 5341.8 8299.7 8499.5 8536.7 8621.0 8705.2 8723.9 8779.3 8819.5 8864.5 8961.7 5520.1 6215.4 6334.5 6504.8 6570.9 6524.3 6776.9 6781.1 6823.4 7014.9 6374.0 6574.1 6661.7 6695.4 6698.7 6501.2 6533.3 6559.3 6566.8 6607.0 5826.2 5936.5 5939.5 5939.5 5951.2 4334.6 4372.8 4422.8 4504.2 4556.7 4334.3 4498.2 4542.0 4586.5 4641.4 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | [#4] prototype.html Cycles:180 Average:4142.12 Median:4638.78 stddev:1220.79 (26.3%) stddev-sans-first:1189.37 12:36:27 INFO - PROCESS | 21749 | Values: 283.8 289.5 293.0 293.9 298.1 4870.3 4870.6 4878.3 4898.5 4913.1 4760.7 4774.7 4775.6 4812.5 4817.7 3792.6 3825.4 3825.8 3826.1 3844.8 3698.7 3833.5 3833.6 3843.8 3853.5 3712.1 3715.4 3737.7 3760.0 3772.9 3711.4 3716.1 3723.9 3734.6 3762.9 3062.5 3141.8 3216.8 3333.5 3335.8 4628.0 4629.8 4641.6 4650.2 4657.9 4262.5 4276.8 4282.1 4283.9 4295.5 4636.0 4774.5 4947.5 5004.4 5034.5 3588.4 3616.7 3617.7 3620.4 3641.5 5211.5 5241.9 5242.6 5247.4 5282.8 3654.2 3717.7 3733.9 3739.8 3744.6 3768.1 3774.3 3780.8 3783.1 3790.9 4295.6 4302.5 4307.6 4316.7 4322.9 5039.7 5055.8 5069.3 5074.4 5076.4 1241.2 1292.5 1305.1 1311.7 1312.6 827.8 842.4 853.6 859.6 864.0 3974.7 3982.1 3984.7 4000.5 4014.3 4525.7 4527.3 4531.3 4558.9 4578.8 3947.8 3955.9 3963.5 3974.9 4007.2 2304.3 2409.6 2421.0 2439.2 2454.3 4327.8 4336.6 4624.2 4775.9 4804.0 5284.2 5285.2 5297.9 5320.2 5332.1 4909.8 4922.8 4924.8 4935.2 4944.9 4980.6 5178.8 5213.6 5226.2 5235.9 5155.4 5163.8 5174.3 5180.9 5184.6 4921.6 4927.2 4928.9 4931.2 4980.0 3630.8 3719.0 3740.1 3740.8 3746.3 5234.3 5241.7 5248.9 5251.2 5263.7 5076.4 5115.9 5126.3 5127.5 5131.3 4810.5 5061.2 5062.9 5068.5 5085.6 4996.2 4999.0 4999.2 5001.3 5002.3 5116.8 5135.4 5141.2 5158.8 5177.4 4776.5 4907.0 4960.7 4962.2 4979.4 12:36:27 INFO - PROCESS | 21749 | 12:36:27 INFO - PROCESS | 21749 | [#5] yui.html Cycles:180 Average:16594.07 Median:54711.68 stddev:22826.19 (41.7%) stddev-sans-first:22858.69 12:36:27 INFO - PROCESS | 21749 | Values: 615.9 636.7 642.9 644.6 660.3 12439.3 12849.7 13193.0 13197.4 13197.8 12641.2 12677.4 12720.0 12737.0 12761.4 616.4 641.1 754.8 772.8 774.9 758.2 781.1 786.8 788.2 788.5 821.9 825.3 825.8 826.6 826.8 646.0 665.1 819.0 819.1 819.7 579.8 594.9 597.3 598.1 598.6 11845.3 11917.7 11965.0 11985.5 12004.0 11439.9 12009.5 12103.4 12122.9 12817.3 10895.2 10950.9 11257.3 11260.7 11421.8 3926.9 3950.1 3961.9 3979.9 3997.7 52929.7 54555.2 54868.2 62477.7 65702.7 8956.5 9569.1 9570.3 9784.0 9828.5 17652.9 17654.0 17688.0 17689.3 17699.7 6595.5 6673.4 6688.9 6846.5 6935.6 3646.4 3648.6 3687.4 3697.9 3734.7 2862.4 2988.2 3109.5 3218.3 3251.8 503.5 513.7 532.4 532.7 542.2 592.3 607.6 626.1 627.6 630.7 8524.6 8627.1 8913.0 8916.5 9038.5 550.9 581.8 593.6 625.6 627.0 3750.8 3855.8 3878.4 3928.7 4120.2 77076.6 77265.0 79392.0 88540.6 104215.0 73745.6 77075.6 77409.6 77937.6 78557.6 58311.0 67100.7 68489.7 68660.0 72184.6 8066.7 8288.7 8444.4 8568.0 8742.3 39786.8 40571.4 42183.0 42352.6 43735.3 51447.5 54474.5 55726.0 61732.7 64048.4 11507.6 11562.6 11881.0 11895.8 12528.2 11919.7 12144.1 12241.1 12477.2 12809.0 10271.4 10981.0 11866.5 12908.3 13186.1 11947.9 12080.9 12393.7 12538.2 12802.6 8338.0 8433.8 10002.4 12196.9 12217.9 9189.0 9539.3 9957.5 10285.7 10505.3 9061.7 9096.8 9718.5 9726.8 10383.8 12:36:27 INFO - PROCESS | 21749 | -------- Summary: end -------- 12:36:27 INFO - PROCESS | 21749 | 12:36:28 INFO - TEST-INFO | 21749: exit 0 12:36:28 INFO - TEST-OK | dromaeo_css | took 1121610ms 12:36:28 INFO - TEST-START | kraken 12:36:28 INFO - operating with platform_type : linux_ 12:36:28 INFO - Initialising browser for kraken test... 12:36:28 INFO - TEST-INFO | started process 22054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD77iy3/profile http://localhost:55780/getInfo.html) 12:36:32 INFO - PROCESS | 22054 | __metrics Screen width/height:1600/1200 12:36:32 INFO - PROCESS | 22054 | colorDepth:24 12:36:32 INFO - PROCESS | 22054 | Browser inner width/height: 1024/697 12:36:32 INFO - PROCESS | 22054 | __metrics 12:36:33 INFO - PROCESS | 22054 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:36:33 INFO - PROCESS | 22054 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:34 INFO - PROCESS | 22054 | console.error: PushService: 12:36:34 INFO - PROCESS | 22054 | stateChangeProcessEnqueue: Error transitioning state 12:36:34 INFO - PROCESS | 22054 | UnknownError 12:36:34 INFO - TEST-INFO | 22054: exit 0 12:36:34 INFO - Browser initialized. 12:36:34 INFO - Running cycle 1/1 for kraken test... 12:36:34 INFO - TEST-INFO | started process 22135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD77iy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:47 INFO - PROCESS | 22135 | RSS: Main: 175443968 12:36:47 INFO - PROCESS | 22135 | 12:36:49 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55780/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:50 INFO - PROCESS | 22135 | RSS: Main: 233639936 12:36:50 INFO - PROCESS | 22135 | 12:36:53 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55780/tests/kraken/driver.html?testName=audio-dft) 12:36:54 INFO - PROCESS | 22135 | RSS: Main: 217567232 12:36:54 INFO - PROCESS | 22135 | 12:36:57 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55780/tests/kraken/driver.html?testName=audio-fft) 12:36:58 INFO - PROCESS | 22135 | RSS: Main: 299872256 12:36:58 INFO - PROCESS | 22135 | 12:37:00 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55780/tests/kraken/driver.html?testName=audio-oscillator) 12:37:00 INFO - PROCESS | 22135 | RSS: Main: 210063360 12:37:00 INFO - PROCESS | 22135 | 12:37:03 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:03 INFO - PROCESS | 22135 | RSS: Main: 213164032 12:37:03 INFO - PROCESS | 22135 | 12:37:06 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55780/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:07 INFO - PROCESS | 22135 | RSS: Main: 249839616 12:37:07 INFO - PROCESS | 22135 | 12:37:10 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55780/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:11 INFO - PROCESS | 22135 | RSS: Main: 249434112 12:37:11 INFO - PROCESS | 22135 | 12:37:14 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55780/tests/kraken/driver.html?testName=json-parse-financial) 12:37:15 INFO - PROCESS | 22135 | RSS: Main: 249286656 12:37:15 INFO - PROCESS | 22135 | 12:37:16 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:17 INFO - PROCESS | 22135 | RSS: Main: 211288064 12:37:17 INFO - PROCESS | 22135 | 12:37:19 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:19 INFO - PROCESS | 22135 | RSS: Main: 218705920 12:37:19 INFO - PROCESS | 22135 | 12:37:22 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:22 INFO - PROCESS | 22135 | RSS: Main: 223420416 12:37:22 INFO - PROCESS | 22135 | 12:37:25 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:26 INFO - PROCESS | 22135 | RSS: Main: 224006144 12:37:26 INFO - PROCESS | 22135 | 12:37:29 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:29 INFO - PROCESS | 22135 | RSS: Main: 222175232 12:37:29 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | Cycle 1(1): loaded http://localhost:55780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55780/tests/kraken/driver.html?testName=ai-astar) 12:37:31 INFO - PROCESS | 22135 | RSS: Main: 272445440 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | __start_tp_report 12:37:31 INFO - PROCESS | 22135 | _x_x_mozilla_page_load 12:37:31 INFO - PROCESS | 22135 | _x_x_mozilla_page_load_details 12:37:31 INFO - PROCESS | 22135 | |i|pagename|runs| 12:37:31 INFO - PROCESS | 22135 | |0;ai-astar;115;114;115;114;114;117;114;115;114;113 12:37:31 INFO - PROCESS | 22135 | |1;audio-beat-detection;151;127;127;172;125;125;126;124;155;124 12:37:31 INFO - PROCESS | 22135 | |2;audio-dft;162;161;162;162;161;162;161;160;161;162 12:37:31 INFO - PROCESS | 22135 | |3;audio-fft;76;77;77;117;76;76;77;76;105;77 12:37:31 INFO - PROCESS | 22135 | |4;audio-oscillator;83;83;126;84;85;85;106;84;84;113 12:37:31 INFO - PROCESS | 22135 | |5;imaging-gaussian-blur;116;117;117;117;119;119;117;117;117;117 12:37:31 INFO - PROCESS | 22135 | |6;imaging-darkroom;147;146;147;146;146;146;150;146;147;147 12:37:31 INFO - PROCESS | 22135 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 12:37:31 INFO - PROCESS | 22135 | |8;json-parse-financial;72;64;63;63;67;65;64;64;64;64 12:37:31 INFO - PROCESS | 22135 | |9;json-stringify-tinderbox;67;67;67;67;67;66;67;67;65;67 12:37:31 INFO - PROCESS | 22135 | |10;stanford-crypto-aes;85;84;83;82;84;83;97;84;84;83 12:37:31 INFO - PROCESS | 22135 | |11;stanford-crypto-ccm;136;136;139;140;136;144;138;146;175;135 12:37:31 INFO - PROCESS | 22135 | |12;stanford-crypto-pbkdf2;173;174;176;173;171;172;173;171;170;174 12:37:31 INFO - PROCESS | 22135 | |13;stanford-crypto-sha256-iterative;71;70;70;69;76;68;74;71;69;69 12:37:31 INFO - PROCESS | 22135 | __end_tp_report 12:37:31 INFO - PROCESS | 22135 | __start_cc_report 12:37:31 INFO - PROCESS | 22135 | _x_x_mozilla_cycle_collect,1883 12:37:31 INFO - PROCESS | 22135 | __end_cc_report 12:37:31 INFO - PROCESS | 22135 | __startTimestamp1475177851967__endTimestamp 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | ------- Summary: start ------- 12:37:31 INFO - PROCESS | 22135 | Number of tests: 14 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 12:37:31 INFO - PROCESS | 22135 | Values: 115.0 114.0 115.0 114.0 114.0 117.0 114.0 115.0 114.0 113.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:127.00 stddev:17.23 (13.6%) stddev-sans-first:17.35 12:37:31 INFO - PROCESS | 22135 | Values: 151.0 127.0 127.0 172.0 125.0 125.0 126.0 124.0 155.0 124.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 12:37:31 INFO - PROCESS | 22135 | Values: 162.0 161.0 162.0 162.0 161.0 162.0 161.0 160.0 161.0 162.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:14.83 (19.4%) stddev-sans-first:15.48 12:37:31 INFO - PROCESS | 22135 | Values: 76.0 77.0 77.0 117.0 76.0 76.0 77.0 76.0 105.0 77.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:84.00 stddev:15.73 (18.7%) stddev-sans-first:16.24 12:37:31 INFO - PROCESS | 22135 | Values: 83.0 83.0 126.0 84.0 85.0 85.0 106.0 84.0 84.0 113.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:0.88 12:37:31 INFO - PROCESS | 22135 | Values: 116.0 117.0 117.0 117.0 119.0 119.0 117.0 117.0 117.0 117.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 12:37:31 INFO - PROCESS | 22135 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 150.0 146.0 147.0 147.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:37:31 INFO - PROCESS | 22135 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:2.71 (4.2%) stddev-sans-first:1.20 12:37:31 INFO - PROCESS | 22135 | Values: 72.0 64.0 63.0 63.0 67.0 65.0 64.0 64.0 64.0 64.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 12:37:31 INFO - PROCESS | 22135 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 65.0 67.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:4.33 (5.2%) stddev-sans-first:4.59 12:37:31 INFO - PROCESS | 22135 | Values: 85.0 84.0 83.0 82.0 84.0 83.0 97.0 84.0 84.0 83.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:139.50 stddev:11.98 (8.6%) stddev-sans-first:12.48 12:37:31 INFO - PROCESS | 22135 | Values: 136.0 136.0 139.0 140.0 136.0 144.0 138.0 146.0 175.0 135.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:1.77 (1.0%) stddev-sans-first:1.87 12:37:31 INFO - PROCESS | 22135 | Values: 173.0 174.0 176.0 173.0 171.0 172.0 173.0 171.0 170.0 174.0 12:37:31 INFO - PROCESS | 22135 | 12:37:31 INFO - PROCESS | 22135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:2.50 (3.5%) stddev-sans-first:2.65 12:37:31 INFO - PROCESS | 22135 | Values: 71.0 70.0 70.0 69.0 76.0 68.0 74.0 71.0 69.0 69.0 12:37:31 INFO - PROCESS | 22135 | -------- Summary: end -------- 12:37:31 INFO - PROCESS | 22135 | 12:37:33 INFO - TEST-INFO | 22135: exit 0 12:37:33 INFO - TEST-OK | kraken | took 65011ms 12:37:33 INFO - SUITE-END | took 1186s 12:37:33 INFO - Completed test suite (00:19:46) 12:37:33 INFO - javascript benchmark 12:37:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.8064395170363, 2611.856347900865, 2634.920952371427, 2641.141628970585, 2649.7350264973506, 4600.516945720693, 4686.789094490748, 4745.928811067833, 4760.904781904364, 4773.7374444405505, 4650.976745116278, 4665.626749860012, 4681.133990211813, 4717.669763116583, 4782.665213435061, 4255.659547236213, 4267.978660106695, 4309.181255561449, 4311.504177019636, 4355.412019377391, 4142.979285103585, 4424.867253982386, 4429.114177164563, 4461.085477477126, 4517.41273634427, 4317.7193482423545, 4370.047031450422, 4378.781060946956, 4381.948332400233, 4414.0, 4289.6139347458875, 4321.416608757841, 4322.827086916551, 4331.047169622678, 4364.563543645641, 4350.151720414488, 4361.931326824916, 4401.735895846259, 4403.075354175627, 4415.8233670653135, 4722.858314250578, 4726.172919739032, 4729.148753224418, 4765.21373973294, 4808.917993451445, 4960.305557221992, 5022.799088036474, 5025.497450254982, 5087.49125087492, 5096.719680417576, 5078.568321692661, 5087.771050302708, 5101.897962040738, 5121.180611102243, 5142.871428214325, 4736.573708366194, 4738.549837765407, 4739.265413860822, 4741.1465936131135, 4798.664093513421, 5109.591232701375, 5158.09733296679, 5188.818391356284, 5190.455002224712, 5259.789608415697, 4891.0, 4922.827701030446, 4924.679895806761, 4935.087008903364, 4963.950360496348, 5013.448520662724, 5018.473060328686, 5085.898282034339, 5092.159793634083, 5158.148905430562, 4917.483664215278, 5058.241263810458, 5069.290299358093, 5069.518395752398, 5076.44159142494, 4953.23224900141, 4958.0, 4966.875828104254, 5011.674241174312, 5080.568151707146, 4028.2547728669706, 4036.313826649418, 4036.5761595032686, 4038.0712436139265, 4072.8778136655947, 3557.9110522236633, 3564.4475106358555, 3569.8572057117944, 3597.190632107755, 3609.1698909251018, 4279.593438623326, 4328.826846926151, 4328.891777705582, 4371.75955322454, 4381.627561657231, 5022.773975171126, 5048.192289233705, 5049.722265275445, 5061.2661164131, 5102.515261050268, 4385.473743150842, 4388.100439409914, 4389.034412429261, 4397.120575884772, 4433.0, 4498.370228168059, 4538.092381523708, 4575.977120114445, 4584.770761461914, 4585.449746030497, 4812.51874812523, 4826.034793041335, 4828.637852161172, 4879.951200488092, 4894.2169252920785, 5105.31078304439, 5118.0, 5121.615878809179, 5122.487751224997, 5179.81870634526, 4731.479537250831, 4764.976175119103, 4812.5668689818085, 4831.830885918976, 4893.510648935078, 4971.751412429292, 5010.49895010496, 5013.072581572275, 5014.0, 5088.974555127201, 5070.847874563769, 5105.540501354896, 5110.48895110486, 5114.71869047206, 5179.430262671028, 4863.173260545786, 4972.328735620789, 4975.626827987843, 4975.626827987988, 4983.177775666974, 4906.337644417958, 5005.824796132118, 5067.366579177603, 5082.288479612783, 5085.237214417867, 4935.506449355035, 4939.506049395031, 4943.159662857251, 4953.504649535018, 5016.448190699093, 4811.639127065414, 4919.581835544019, 4932.3094766731965, 4934.753262336941, 5021.422536408214, 4871.318015477765, 4891.755412229445, 4896.0, 4897.0450762101045, 4949.6287778416045], "value": 4642.199235698846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.6768970927733, 559.6893723983189, 578.8871170121826, 579.959402841801, 585.701292340906, 27562.310942226453, 29975.250618734517, 36941.0, 38197.0, 38346.80826595863, 38982.610173898254, 39033.804830975874, 39049.41425878614, 39054.21891562167, 39097.804510977476, 7266.781996540112, 7499.212582678809, 7645.579493127903, 7647.694092236304, 7649.885251721229, 7299.927000730005, 7560.848783024337, 7562.281583249583, 9485.193758530533, 9716.854247186298, 9968.252381071412, 10003.89996100037, 10024.248181386389, 10024.949875250613, 10025.0, 9927.404355738643, 10000.699979000641, 10000.999999999964, 10012.449315287657, 10016.79966400668, 9613.51932403377, 9673.274504412197, 9678.854817177747, 9680.128788409007, 9692.079252471003, 37983.43024854629, 38306.61693383086, 38363.396392432805, 38646.61353386458, 38657.806710966266, 3001.9099427017222, 3052.9847350763102, 3061.9540706889416, 3171.762117841171, 3269.2480729432127, 28241.0, 28434.289142771388, 28488.86044558215, 28638.856805715837, 30114.24714382136, 2919.372334947975, 2950.7491863191653, 2975.7619390448713, 3004.3390454100063, 3010.0518336723862, 247480.0, 248372.0, 248871.0, 248911.0, 249941.9999999982, 31071.844640777104, 32015.359692806014, 50948.490515095116, 51135.488645113815, 51297.487025129274, 32736.345273094405, 32852.67147328544, 32881.67118328786, 33002.339953200804, 33016.174595634824, 12463.0, 12674.112812103065, 12675.04937129719, 12679.746405072032, 12689.555865544662, 9459.716208513755, 9461.0, 9479.336446448682, 9513.904860951301, 9534.666286680073, 7144.1784194818265, 7337.0, 7373.520721153108, 7585.317321441097, 7636.350910172587, 2987.067998903654, 3086.36729470458, 3104.8447577621027, 3108.331708682644, 3132.1856317357197, 859.3984211052289, 867.9609417576224, 868.0, 891.6727341638319, 924.7410724997012, 26534.0, 27880.860595697297, 27897.860510697723, 28038.579421308288, 28310.292242693686, 902.8420026495469, 936.8032713130183, 940.7695114696943, 983.6163896080534, 1025.6410256410197, 13639.863601363859, 14785.852141478663, 14885.404583816526, 14963.925180374028, 15160.31778569967, 369103.0, 371067.0, 371936.24510039133, 373050.0, 373794.0, 48784.0, 49174.754126229855, 49210.507894921306, 49250.26124608134, 49314.0, 1056.587930707025, 1107.4960892793758, 1122.6744244169427, 1145.2098052343856, 1176.3588844079825, 25880.741192587833, 29479.11562653124, 29482.852585736935, 29527.26181845471, 29680.554791678573, 40799.1840163201, 46484.30273545832, 47779.0, 47831.76084119557, 52367.47632523626, 326238.0, 328828.0, 329237.0, 329392.0, 329927.0, 24394.146204882745, 25122.37194070163, 25463.23610291694, 37951.240975180895, 38392.2321553573, 39802.60197398105, 40034.59965400309, 40142.397864032646, 40281.1943761129, 40404.79797600993, 33167.502487462225, 33529.49705754464, 33708.0, 33855.15362115967, 34259.314813704084, 33311.66688333086, 34002.319953600294, 34017.31965360729, 34122.829385852914, 34725.652743473256, 34368.48447273343, 34374.82812585921, 34942.12644683903, 35202.0, 35297.0, 29882.402351953275, 31367.84316078405, 31385.215369615027, 31634.367312654078, 32199.195020124684, 24686.876565617058, 24949.625755613317, 25056.123035694392, 25116.12093576716, 25446.745532545177], "value": 16405.013283727883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.3809315894974, 352.93117842020814, 354.67724370822555, 362.93285742137704, 388.0531503132357, 12436.626901192967, 13268.800967985477, 13424.731505369888, 14873.405063797449, 17153.82846171538, 15567.766483502728, 15694.0, 15766.0, 16100.436484723037, 16428.67142657146, 4798.352222449959, 4869.805207791684, 4958.652894297401, 4967.428745694256, 5001.17480615698, 3670.0, 3858.8070596470066, 4925.926111108336, 5012.348394708701, 5017.874553136165, 3836.3669994450884, 3879.4374815651713, 3884.5726970033274, 3884.611538846121, 4155.709100362976, 5790.507806836424, 5910.172575839386, 5911.083782013752, 5917.437843404869, 5919.112133180014, 4694.81220751173, 4951.653384263103, 4978.8257410990445, 5184.326037615124, 5186.092433824066, 12056.397180140957, 12263.141580089397, 12278.938605307005, 12305.44625491855, 17823.0, 1816.727490876366, 1838.4852241372437, 1910.1881700277327, 1914.4352416037302, 1950.2686492565288, 8987.37088403812, 9325.813483730288, 9795.853062204002, 10269.229807764374, 13294.734105317839, 1610.474046017815, 1676.6395225026556, 1677.8070521890018, 1701.0, 1716.5107944235833, 67268.66365668189, 67325.66337168282, 67922.66038669825, 68268.0, 69365.65317173432, 9396.624135034659, 9550.140487356033, 9566.952165239129, 9672.56473458696, 9754.0733630305, 13178.868211317764, 13220.867791322156, 13233.933830330787, 13238.602841914759, 13258.73482530344, 6860.622665753332, 6911.054725680524, 6981.30186981308, 7020.508564400443, 7094.042304288958, 6672.766453174116, 6768.661566921733, 6881.827954301182, 7076.398506126934, 7105.111861017373, 3867.400552914303, 3881.844726210976, 3912.295786758411, 3955.0903292242947, 3955.228730397545, 1770.2653398839595, 1778.3242367900116, 1788.320438233463, 1791.9552011199564, 1803.9368622098164, 831.5301854452215, 839.0895877972346, 843.2663582683105, 888.7778055486128, 898.4788822482944, 14636.780448293284, 16442.61582070617, 16812.495625131265, 16844.74732879008, 17541.473755787345, 781.2773184804147, 781.6404453951246, 829.5271695133716, 860.548212188606, 887.0464250930147, 9150.954245228731, 9588.808223835484, 9618.086281803218, 9646.565904534313, 9895.158911492459, 295850.0, 300192.0, 301046.0, 377669.0, 379223.0, 82017.0, 85269.0, 88562.0, 88835.0, 89110.55444722864, 879.8768172455862, 913.4747520175926, 920.4017388697266, 924.0297687428174, 924.5192499900014, 15513.689726205186, 15792.92103539475, 16180.595485112966, 16496.67006659884, 16663.250153743353, 31259.84370078135, 34909.301813964084, 37915.241695165394, 38947.02632434212, 39567.0, 48852.755736221094, 52332.0, 54108.18837717516, 54819.45180548143, 55438.0, 7062.364387204971, 7204.639768011683, 7414.62926853666, 7434.3309102181065, 7678.040244969379, 10758.193135515025, 11305.886941130484, 11320.0, 11320.660380188607, 11684.649460516199, 9985.550650220903, 10322.535485903303, 10622.415767132881, 10639.680809575726, 10705.304155229886, 9757.51212439361, 9822.361546499455, 9863.408195508293, 10094.091531761884, 10236.283460157718, 10074.14369778577, 10096.79806403853, 10104.595816167272, 10264.127549158406, 10564.524596393027, 7343.963280183565, 7379.963100184465, 7498.887516687363, 7530.171681114964, 7832.138464768985, 8639.438436501607, 9854.655087071918, 9869.259805514472, 10105.343152695052, 10162.847557286499], "value": 7841.01698967373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.5724253753722, 1385.6258810121265, 1411.9788203176952, 1461.627285042314, 1690.366112707734, 6544.149260596122, 7249.202587715354, 7480.738174163906, 7501.849963000744, 7687.2312768723095, 7624.466287359887, 7679.232076792318, 7681.039870016248, 7702.8844567331535, 7704.6918123275145, 2119.4277545062823, 2154.4183070570934, 2156.590247852903, 2158.2446143849606, 2162.610730068595, 2084.6664533674616, 2124.033564728045, 2152.1714140056033, 2154.482924098213, 2157.0832396231617, 2108.9789102108934, 2121.469632591852, 2126.8936553172357, 2135.1566131378095, 2184.322859913432, 2098.664213725804, 2103.6739305407687, 2108.2515706923973, 2113.4505028692497, 2114.598226336991, 2058.5677007828376, 2075.9169633214806, 2096.727425434699, 2098.4858709616087, 2099.3177217404404, 7381.815454613624, 7486.550806951546, 7521.736739214156, 7550.0939887213335, 7563.205863384321, 4468.687191896569, 4580.473245576768, 4583.4041574595085, 4590.196715574761, 4591.79336929839, 2782.8191167574246, 2863.4130003349264, 2914.0529327968493, 2915.023467138511, 2923.4007028559095, 871.5685735560875, 871.6469829718974, 878.3105262369073, 883.5758835758871, 890.7238755985666, 9839.262055345878, 9930.155936745385, 9939.403635781877, 10098.747531311703, 10104.343217690826, 3643.617420170844, 3850.8844734658005, 3948.0919388540797, 3968.9603103969166, 4018.2967980603275, 7910.52536847791, 7911.841763164704, 7920.5247685139075, 7951.204879512003, 7980.122186559473, 4467.285234362486, 4519.909601807945, 4536.160810250114, 4537.069900670354, 4539.205639013226, 3628.800415977094, 3746.8688595899557, 4010.979945100256, 4187.0, 4189.0, 3156.6054243219596, 3190.9418425116132, 3283.441814891474, 3320.9169770755443, 3328.4341661917533, 958.2286259560981, 958.3339578992533, 961.7932144588947, 964.0985678390728, 964.1852634523816, 668.1848145262771, 708.1325376413852, 808.5472135604081, 838.8448137094657, 841.8526757817358, 5058.367704036996, 5172.120739474223, 5230.503102205284, 5379.1662292344745, 5492.144886504261, 789.7630710786741, 801.3749275565068, 814.5112932240609, 864.9481031138026, 906.7007887397143, 3416.1506130468106, 3601.1537288737127, 3690.1697118148204, 3775.433684947225, 3793.279276937373, 8839.602217900081, 9042.18620324174, 9122.042185570552, 9140.0, 9141.77145571366, 9101.499417531966, 9104.499252541174, 9112.362134650512, 9112.544372781334, 9117.772055698528, 6747.291534388818, 6842.897356539655, 6887.0, 6892.414144797648, 6899.103116594811, 4970.428400733962, 5005.174146265826, 5074.188129899198, 5079.593632509464, 5341.786328546815, 8299.668013279643, 8499.490030598185, 8536.70121545743, 8620.956895215484, 8705.173008564176, 8723.869141962748, 8779.25376343018, 8819.514926679094, 8864.468131912106, 8961.731148065568, 5520.1167813149705, 6215.378462153749, 6334.461570766352, 6504.772332968323, 6570.901436478553, 6524.3149469305035, 6776.864462710817, 6781.0845535854005, 6823.38589526945, 7014.894776578458, 6373.968130159319, 6574.11249481333, 6661.733530658719, 6695.363940425652, 6698.698558564779, 6501.219853617407, 6533.281339052795, 6559.344065593403, 6566.770163044271, 6607.041978912935, 5826.213461182686, 5936.525077993837, 5939.46544810969, 5939.4951429129005, 5951.196588460502, 4334.5882141196535, 4372.80322385487, 4422.75674837887, 4504.189245935763, 4556.726596404226, 4334.349847522897, 4498.167838949805, 4542.046170304141, 4586.472555656009, 4641.3734145889875], "value": 3951.662873049783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.83679384354, 289.4919416424176, 293.0373722322172, 293.9015429831006, 298.1324346152695, 4870.269459581064, 4870.586000189984, 4878.292647566101, 4898.53463920927, 4913.115639184945, 4760.714357138574, 4774.713517188971, 4775.641826862981, 4812.494688057747, 4817.7109373437615, 3792.6207379262128, 3825.407061905409, 3825.7895815730126, 3826.1199924017424, 3844.8462061517507, 3698.7041036716996, 3833.4633151358694, 3833.5591406988274, 3843.8270277837423, 3853.499045124144, 3712.1276500022473, 3715.405535114382, 3737.663610275075, 3760.0, 3772.9434058489146, 3711.42472916697, 3716.1267102230954, 3723.858781200793, 3734.6452087051684, 3762.9435558466644, 3062.525308577174, 3141.7643676724338, 3216.790908590934, 3333.516640087174, 3335.816530090844, 4627.976860115711, 4629.7916593753025, 4641.605463535603, 4650.162970665279, 4657.928676404412, 4262.488501379823, 4276.786160691953, 4282.143571285756, 4283.87148385549, 4295.548967358445, 4635.9536404635855, 4774.474807771142, 4947.529984651453, 5004.374453193351, 5034.51481812866, 3588.4437912123662, 3616.7468277220605, 3617.7286703497343, 3620.420732682758, 3641.5266015417824, 5211.5049070338255, 5241.9213711794355, 5242.6330156889035, 5247.39654939683, 5282.815101471469, 3654.1778099927305, 3717.7211709121925, 3733.9439908401396, 3739.7569158004644, 3744.648539557081, 3768.1333293342686, 3774.3017541754316, 3780.7542509736777, 3783.1487915218854, 3790.9241815164096, 4295.634871035934, 4302.483701955785, 4307.612314891675, 4316.719413238129, 4322.935155972663, 5039.732120545769, 5055.823046193365, 5069.264956581349, 5074.426927652439, 5076.44159142494, 1241.211830487647, 1292.5023865811543, 1305.106002388367, 1311.6524121107914, 1312.6324629103867, 827.755812035451, 842.4439869685978, 853.5902766672032, 859.6088779605265, 864.0236532717988, 3974.741641793274, 3982.108498463265, 3984.7210695251633, 4000.539937907178, 4014.297497937849, 4525.728456292567, 4527.320901864747, 4531.274996000624, 4558.931616025762, 4578.793954272066, 3947.822347994347, 3955.881323560298, 3963.4847469828737, 3974.8608798691907, 4007.158496715664, 2304.2971893572285, 2409.6265078912797, 2421.0436877433317, 2439.243834411338, 2454.3005243505513, 4327.805248763751, 4336.6122840691305, 4624.237000894882, 4775.880602984884, 4803.967147063398, 5284.180951952453, 5285.180796976475, 5297.860959893641, 5320.17537281722, 5332.093544097513, 4909.754512274443, 4922.753862306942, 4924.823488849672, 4935.161022626162, 4944.884722624652, 4980.576650984707, 5178.789150726574, 5213.618391126431, 5226.163813789927, 5235.910812620572, 5155.355580552431, 5163.767630456563, 5174.27560141588, 5180.870478238075, 5184.559312458483, 4921.557059864629, 4927.211646136601, 4928.852134435972, 4931.211006239128, 4979.975100124621, 3630.8003059831963, 3718.981405092957, 3740.1397678534636, 3740.775553466801, 3746.269477451871, 5234.319538459976, 5241.737913104405, 5248.921266180934, 5251.186066159751, 5263.710495922761, 5076.416212135504, 5115.948840511547, 5126.256692779601, 5127.46161653021, 5131.307273518177, 4810.518948105161, 5061.190209566452, 5062.924056139087, 5068.467810879804, 5085.567726743268, 4996.200607902718, 4999.0, 4999.200127979506, 5001.274815151855, 5002.274215395682, 5116.7953281869795, 5135.435102138837, 5141.203113517411, 5158.8392611662075, 5177.378714554277, 4776.522347765195, 4906.975465122651, 4960.677555958851, 4962.156433406258, 4979.377577802775], "value": 3753.8213624256523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9106929495223, 636.7007506471956, 642.8585711143548, 644.642223565921, 660.2868901586285, 12439.253644781309, 12849.743005139891, 13193.0, 13197.406116724758, 13197.802032969501, 12641.178323408994, 12677.366131693425, 12720.0, 12737.0, 12761.361931903413, 616.4020899727258, 641.1312671330351, 754.7697952124599, 772.8492943875947, 774.9225077492262, 758.1698040645484, 781.0900301149182, 786.7915002524308, 788.1802924958065, 788.5190034079208, 821.8849361089452, 825.2820046559501, 825.781167990483, 826.5825757992205, 826.8263664630434, 645.9741610335581, 665.1452883045312, 819.0335404223015, 819.0539926385035, 819.692615269277, 579.8144593730008, 594.8810237952426, 597.3280059932575, 598.1416667082707, 598.6288501129284, 11845.348505832177, 11917.702057448632, 11965.042796576254, 11985.520579176822, 12004.0, 11439.942800286028, 12009.45957431909, 12103.394830258452, 12122.878771212263, 12817.295048772314, 10895.182861285435, 10950.945245273802, 11257.324560526313, 11260.718482038015, 11421.771564568662, 3926.9214615707524, 3950.1112249743865, 3961.9009524761823, 3979.900502487432, 3997.72015958883, 52929.73535132338, 54555.18167227495, 54868.17697734537, 62477.687611562105, 65702.67148664274, 8956.462612243286, 9569.138777509917, 9570.282228832866, 9783.951080244695, 9828.508574571242, 17652.91173544124, 17654.0, 17688.0, 17689.292428302982, 17699.73450398245, 6595.472362211011, 6673.366030227217, 6688.933110668929, 6846.520743547904, 6935.583864968118, 3646.4165733482514, 3648.5621725392593, 3687.410014397737, 3697.926041479155, 3734.6638802507905, 2862.355969906796, 2988.208124846917, 3109.455845227076, 3218.340240250743, 3251.8048917065053, 503.4839289727985, 513.7148882370245, 532.4302995794462, 532.7469452010264, 542.1623591551063, 592.2744637818638, 607.6202373516552, 626.1077963901422, 627.5795217204484, 630.7445484578753, 8524.616392262364, 8627.137286271449, 8912.955435222782, 8916.509591972504, 9038.457692538468, 550.9449055094459, 581.8080033588906, 593.5844908564022, 625.6371304643296, 626.9592476489014, 3750.849966001384, 3855.768653880776, 3878.3794592865006, 3928.685705143582, 4120.21715873983, 77076.61461692768, 77265.0, 79392.0, 88540.55729721439, 104215.0, 73745.6312718433, 77075.61462192766, 77409.61295193488, 77937.61031194922, 78557.60721196471, 58311.0, 67100.66449667818, 68489.65755171192, 68660.0, 72184.63907680428, 8066.717664881701, 8288.70989515364, 8444.408891377545, 8568.0, 8742.300615950582, 39786.801065994485, 40571.39142912918, 42183.0, 42352.5764742361, 43735.34396983984, 51447.48552514577, 54474.45525544694, 55726.0, 61732.69133654303, 64048.35951640424, 11507.597234096766, 11562.595309164139, 11881.0, 11895.821562676394, 12528.248305101723, 11919.702007449883, 12144.089193310714, 12241.0819188563, 12477.188982716094, 12809.0, 10271.383716977005, 10981.011708946233, 11866.466009029442, 12908.290044047668, 13186.076974611686, 11947.880521195024, 12080.8991459316, 12393.690157745768, 12538.185017973803, 12802.551910683082, 8338.0, 8433.83132337362, 10002.399856008371, 12196.878031219929, 12217.93891030539, 9189.0, 9539.282467097017, 9957.502124893872, 10285.74285642865, 10505.26463147603, 9061.68284110053, 9096.784457215403, 9718.514074296398, 9726.76348444793, 10383.844242336521], "value": 6436.04068094887, "unit": "score"}], "name": "dromaeo_css", "value": 6203.911299528905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 114.0, 117.0, 114.0, 115.0, 114.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 127.0, 172.0, 125.0, 125.0, 126.0, 124.0, 155.0, 124.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 117.0, 76.0, 76.0, 77.0, 76.0, 105.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 126.0, 84.0, 85.0, 85.0, 106.0, 84.0, 84.0, 113.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 119.0, 119.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 150.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 64.0, 63.0, 63.0, 67.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 65.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 82.0, 84.0, 83.0, 97.0, 84.0, 84.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 139.0, 140.0, 136.0, 144.0, 138.0, 146.0, 175.0, 135.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 176.0, 173.0, 171.0, 172.0, 173.0, 171.0, 170.0, 174.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 76.0, 68.0, 74.0, 71.0, 69.0, 69.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1549.7, "alertThreshold": 2.0}]} 12:37:33 INFO - Return code: 0 12:37:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:37:33 INFO - # TBPL SUCCESS # 12:37:33 INFO - Running post-action listener: _resource_record_post_action 12:37:33 INFO - [mozharness: 2016-09-29 19:37:33.757057Z] Finished run-tests step (success) 12:37:33 INFO - Running post-run listener: _resource_record_post_run 12:37:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401547264; Read time: 16; Write time: 292344 12:37:33 INFO - TinderboxPrint: CPU usage
13.0% 12:37:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:37:33 INFO - TinderboxPrint: I/O write bytes / time
401,547,264 / 292,344 12:37:33 INFO - TinderboxPrint: CPU idle
8,346.0 (86.9%) 12:37:33 INFO - TinderboxPrint: CPU user
1,204.3 (12.5%) 12:37:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:37:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99422208; Read time: 0; Write time: 109312 12:37:33 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290078720; Read time: 0; Write time: 180704 12:37:34 INFO - Running post-run listener: _upload_blobber_files 12:37:34 INFO - Blob upload gear active. 12:37:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:34 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 12:37:34 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:37:34 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:37:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:38 INFO - (blobuploader) - INFO - Done attempting. 12:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:37:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:39 INFO - (blobuploader) - INFO - Done attempting. 12:37:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:37:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:40 INFO - (blobuploader) - INFO - Done attempting. 12:37:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:37:40 INFO - Return code: 0 12:37:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:37:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:37:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ee855f2557e0db18b59bb860ac5f0becb5e514afddea6476e089b5008a33c0f6569d7abd69f98f8591dfa9ec2a77660bedb2ff0f623d75917ae7225ab6c3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/934cc74d2bbd9717e301dcabbd6e3e484485d9175806667db384cba649b0e36af9383f6fa134ad7583f4dc0515ef6429285d01820db2d29cd5dd3e0a3ec7c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06814631769cf95eb0a782f8cf2038e55b02bcf845a7e5b5fbfc5977c3d6b7fe297093023ae34a383647c514a28ac8886d0d508a0f284d023569049449ce2c92"} 12:37:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:37:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:37:40 INFO - Contents: 12:37:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ee855f2557e0db18b59bb860ac5f0becb5e514afddea6476e089b5008a33c0f6569d7abd69f98f8591dfa9ec2a77660bedb2ff0f623d75917ae7225ab6c3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/934cc74d2bbd9717e301dcabbd6e3e484485d9175806667db384cba649b0e36af9383f6fa134ad7583f4dc0515ef6429285d01820db2d29cd5dd3e0a3ec7c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06814631769cf95eb0a782f8cf2038e55b02bcf845a7e5b5fbfc5977c3d6b7fe297093023ae34a383647c514a28ac8886d0d508a0f284d023569049449ce2c92"} 12:37:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:37:40 INFO - Copying logs to upload dir... 12:37:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:37:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.079060 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-29 12:37:39.530983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:37:39.534890) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ee855f2557e0db18b59bb860ac5f0becb5e514afddea6476e089b5008a33c0f6569d7abd69f98f8591dfa9ec2a77660bedb2ff0f623d75917ae7225ab6c3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/934cc74d2bbd9717e301dcabbd6e3e484485d9175806667db384cba649b0e36af9383f6fa134ad7583f4dc0515ef6429285d01820db2d29cd5dd3e0a3ec7c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06814631769cf95eb0a782f8cf2038e55b02bcf845a7e5b5fbfc5977c3d6b7fe297093023ae34a383647c514a28ac8886d0d508a0f284d023569049449ce2c92"} build_url:https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/XHWns43BQW2QmNPzSdEuJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/44ee855f2557e0db18b59bb860ac5f0becb5e514afddea6476e089b5008a33c0f6569d7abd69f98f8591dfa9ec2a77660bedb2ff0f623d75917ae7225ab6c3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/934cc74d2bbd9717e301dcabbd6e3e484485d9175806667db384cba649b0e36af9383f6fa134ad7583f4dc0515ef6429285d01820db2d29cd5dd3e0a3ec7c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06814631769cf95eb0a782f8cf2038e55b02bcf845a7e5b5fbfc5977c3d6b7fe297093023ae34a383647c514a28ac8886d0d508a0f284d023569049449ce2c92"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:37:39.561111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:37:39.561477) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475175966.153566-1688520791 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:37:39.646365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:37:39.646922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:37:39.647518) ========= ========= Total master_lag: 0.52 =========