builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1475535645.18 results: success (0) buildid: 20161003153656 builduid: 7ebd5e7ac83f4f11bc83df58466a1be4 revision: 1a4288cc3cead7e7026ea5e2594b6041e69dd13b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.181857) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.182316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.182601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.197099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.197367) ========= 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=fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 16:00:47-- 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% 219M=0s 2016-10-03 16:00:47 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106925 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.317783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.318100) ========= 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=fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018753 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.367199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:45.367526) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1a4288cc3cead7e7026ea5e2594b6041e69dd13b --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 1a4288cc3cead7e7026ea5e2594b6041e69dd13b --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=fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 16:00:47,340 truncating revision to first 12 chars 2016-10-03 16:00:47,340 Setting DEBUG logging. 2016-10-03 16:00:47,340 attempt 1/10 2016-10-03 16:00:47,340 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1a4288cc3cea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 16:00:47,644 unpacking tar archive at: autoland-1a4288cc3cea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:46.013771) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:46.014099) ========= script_repo_revision: 1a4288cc3cead7e7026ea5e2594b6041e69dd13b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:46.014481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:46.014760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 16:00:46.023772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-03 16:00:46.024050) ========= /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=fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:00:48 INFO - MultiFileLogger online at 20161003 16:00:48 in /builds/slave/test 16:00:48 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 16:00:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:00:48 INFO - {'append_to_log': False, 16:00:48 INFO - 'base_work_dir': '/builds/slave/test', 16:00:48 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 16:00:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:00:48 INFO - 'branch': 'Autoland-Non-PGO', 16:00:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:00:48 INFO - 'config_files': ('talos/linux_config.py',), 16:00:48 INFO - 'default_actions': ('clobber', 16:00:48 INFO - 'read-buildbot-config', 16:00:48 INFO - 'download-and-extract', 16:00:48 INFO - 'populate-webroot', 16:00:48 INFO - 'create-virtualenv', 16:00:48 INFO - 'install', 16:00:48 INFO - 'run-tests'), 16:00:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:00:48 INFO - 'download_minidump_stackwalk': True, 16:00:48 INFO - 'download_symbols': 'ondemand', 16:00:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:00:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:00:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:00:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:00:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:00:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:00:48 INFO - 'installer_path': 'installer.exe', 16:00:48 INFO - 'log_level': 'info', 16:00:48 INFO - 'log_name': 'talos', 16:00:48 INFO - 'log_to_console': True, 16:00:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:00:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:00:48 INFO - 'opt_config_files': (), 16:00:48 INFO - 'pip_index': False, 16:00:48 INFO - 'sps_profile': False, 16:00:48 INFO - 'sps_profile_interval': 0, 16:00:48 INFO - 'suite': 'dromaeojs', 16:00:48 INFO - 'system_bits': '32', 16:00:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:48 INFO - 'title': 'talos-linux64-ix-048', 16:00:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:00:48 INFO - 'use_talos_json': True, 16:00:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:00:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:00:48 INFO - 'work_dir': 'build'} 16:00:48 INFO - [mozharness: 2016-10-03 23:00:48.099557Z] Running clobber step. 16:00:48 INFO - Running pre-action listener: _resource_record_pre_action 16:00:48 INFO - Running main action method: clobber 16:00:48 INFO - rmtree: /builds/slave/test/build 16:00:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:00:49 INFO - Running post-action listener: _resource_record_post_action 16:00:49 INFO - [mozharness: 2016-10-03 23:00:49.132185Z] Finished clobber step (success) 16:00:49 INFO - [mozharness: 2016-10-03 23:00:49.132285Z] Running read-buildbot-config step. 16:00:49 INFO - Running pre-action listener: _resource_record_pre_action 16:00:49 INFO - Running main action method: read_buildbot_config 16:00:49 INFO - Using buildbot properties: 16:00:49 INFO - { 16:00:49 INFO - "project": "", 16:00:49 INFO - "product": "firefox", 16:00:49 INFO - "script_repo_revision": "production", 16:00:49 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 16:00:49 INFO - "repository": "", 16:00:49 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 16:00:49 INFO - "buildid": "20161003153656", 16:00:49 INFO - "pgo_build": "False", 16:00:49 INFO - "basedir": "/builds/slave/test", 16:00:49 INFO - "buildnumber": 688, 16:00:49 INFO - "slavename": "talos-linux64-ix-048", 16:00:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:00:49 INFO - "platform": "ubuntu64_hw", 16:00:49 INFO - "scheduler": "tests-autoland-linux64-talos", 16:00:49 INFO - "branch": "autoland", 16:00:49 INFO - "repo_path": "integration/autoland", 16:00:49 INFO - "revision": "1a4288cc3cead7e7026ea5e2594b6041e69dd13b", 16:00:49 INFO - "stage_platform": "linux64", 16:00:49 INFO - "builduid": "7ebd5e7ac83f4f11bc83df58466a1be4", 16:00:49 INFO - "slavebuilddir": "test" 16:00:49 INFO - } 16:00:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:00:49 INFO - Running post-action listener: _resource_record_post_action 16:00:49 INFO - [mozharness: 2016-10-03 23:00:49.134920Z] Finished read-buildbot-config step (success) 16:00:49 INFO - [mozharness: 2016-10-03 23:00:49.135009Z] Running download-and-extract step. 16:00:49 INFO - Running pre-action listener: _resource_record_pre_action 16:00:49 INFO - Running main action method: download_and_extract 16:00:49 INFO - mkdir: /builds/slave/test/build/tests 16:00:49 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')]} 16:00:49 INFO - trying https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:00:49 INFO - Downloading https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/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 16:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/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 16:00:49 INFO - Downloaded 1361 bytes. 16:00:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:00:49 INFO - Using the following test package requirements: 16:00:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:00:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:00:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:00:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'jsshell-linux-x86_64.zip'], 16:00:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:00:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:00:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:00:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:00:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:00:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:00:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:00:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:00:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:00:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:00:49 INFO - Fetch https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:00:50 INFO - Http code: 200 16:00:50 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 16:00:50 INFO - x-amz-cf-id: JxadyZD97_LDJo1x9_VrIsZVgGEUYbbCL15oUsIYq86aX42tB82BzQ== 16:00:50 INFO - x-amz-version-id: 50NIpwNRHFfdsTjsbGzxr5nB762c5MN1 16:00:50 INFO - Expected file size: 20421149 16:00:50 INFO - Obtained file size: 20421149 16:00:54 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 16:00:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:00:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:00:54 INFO - Fetch https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:00:55 INFO - Http code: 200 16:00:55 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 16:00:55 INFO - x-amz-cf-id: qrmjfCdSMt31NFBmkErsrvBG9qiBc3M_MEtcIM4DlKrdyW2qcnS54g== 16:00:55 INFO - x-amz-version-id: 50NIpwNRHFfdsTjsbGzxr5nB762c5MN1 16:00:55 INFO - Expected file size: 20421149 16:00:55 INFO - Obtained file size: 20421149 16:00:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:00:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:00:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:01:00 INFO - Http code: 200 16:01:00 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 16:01:00 INFO - x-amz-cf-id: cUrhGOvVl-PZ7FuMZvSotGl8eynAHmmI42bUKX9da-MpkROtcOSpdQ== 16:01:00 INFO - x-amz-version-id: YKjV0Ui5Ta.AWPjDFwaErlht1Izk_Qfq 16:01:00 INFO - Expected file size: 14408522 16:01:00 INFO - Obtained file size: 14408522 16:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:00 INFO - trying https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:00 INFO - Downloading https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/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 16:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/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 16:01:02 INFO - Downloaded 55829826 bytes. 16:01:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:02 INFO - mkdir: /builds/slave/test/properties 16:01:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:02 INFO - Contents: 16:01:02 INFO - build_url:https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:01:02 INFO - Running post-action listener: _resource_record_post_action 16:01:02 INFO - Running post-action listener: set_extra_try_arguments 16:01:02 INFO - [mozharness: 2016-10-03 23:01:02.690840Z] Finished download-and-extract step (success) 16:01:02 INFO - [mozharness: 2016-10-03 23:01:02.691067Z] Running populate-webroot step. 16:01:02 INFO - Running pre-action listener: _resource_record_pre_action 16:01:02 INFO - Running main action method: populate_webroot 16:01:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:02 INFO - '--tppagecycles', 16:01:02 INFO - '7'], 16:01:02 INFO - 'tests': ['tsvgm']}}, 16:01:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['damp', 'tps']}, 16:01:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'tests': ['damp', 'tps']}, 16:01:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['dromaeo_dom']}, 16:01:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['basic_compositor_video']}, 16:01:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:01:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['a11yr', 16:01:02 INFO - 'ts_paint', 16:01:02 INFO - 'tpaint', 16:01:02 INFO - 'sessionrestore', 16:01:02 INFO - 'sessionrestore_no_auto_restore', 16:01:02 INFO - 'tabpaint']}, 16:01:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:02 INFO - 'ts_paint', 16:01:02 INFO - 'tpaint', 16:01:02 INFO - 'sessionrestore', 16:01:02 INFO - 'sessionrestore_no_auto_restore', 16:01:02 INFO - 'tabpaint']}, 16:01:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:01:02 INFO - 'ts_paint', 16:01:02 INFO - 'tpaint', 16:01:02 INFO - 'sessionrestore', 16:01:02 INFO - 'sessionrestore_no_auto_restore', 16:01:02 INFO - 'tabpaint']}, 16:01:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:01:02 INFO - 'ts_paint', 16:01:02 INFO - 'tpaint', 16:01:02 INFO - 'sessionrestore', 16:01:02 INFO - 'sessionrestore_no_auto_restore', 16:01:02 INFO - 'tabpaint']}, 16:01:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['a11yr', 16:01:02 INFO - 'ts_paint', 16:01:02 INFO - 'tpaint', 16:01:02 INFO - 'sessionrestore', 16:01:02 INFO - 'sessionrestore_no_auto_restore', 16:01:02 INFO - 'tabpaint']}, 16:01:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['a11yr', 16:01:02 INFO - 'ts_paint', 16:01:02 INFO - 'tpaint', 16:01:02 INFO - 'sessionrestore', 16:01:02 INFO - 'sessionrestore_no_auto_restore', 16:01:02 INFO - 'tabpaint']}, 16:01:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['tsvgx', 16:01:02 INFO - 'tsvgr_opacity', 16:01:02 INFO - 'tart', 16:01:02 INFO - 'tscrollx', 16:01:02 INFO - 'cart']}, 16:01:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:02 INFO - 'tsvgr_opacity', 16:01:02 INFO - 'tart', 16:01:02 INFO - 'tscrollx', 16:01:02 INFO - 'cart']}, 16:01:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'talos_options': ['--disable-e10s'], 16:01:02 INFO - 'tests': ['tp5o']}, 16:01:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'tests': ['tp5o']}, 16:01:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'talos_options': ['--disable-e10s', 16:01:02 INFO - '--xperf_path', 16:01:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:02 INFO - 'tests': ['tp5n']}, 16:01:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:02 INFO - 'talos_options': ['--xperf_path', 16:01:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:02 INFO - 'tests': ['tp5n']}}, 16:01:02 INFO - 'talos.zip': {'path': '', 16:01:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:02 INFO - Running post-action listener: _resource_record_post_action 16:01:02 INFO - [mozharness: 2016-10-03 23:01:02.710582Z] Finished populate-webroot step (success) 16:01:02 INFO - [mozharness: 2016-10-03 23:01:02.710671Z] Running create-virtualenv step. 16:01:02 INFO - Running pre-action listener: _resource_record_pre_action 16:01:02 INFO - Running main action method: create_virtualenv 16:01:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:02 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 16:01:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:02 INFO - Using real prefix '/usr' 16:01:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:05 INFO - Installing pip.................done. 16:01:05 INFO - Return code: 0 16:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:01:05 INFO - Reading from file tmpfile_stdout 16:01:05 INFO - Output received: 16:01:05 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) 16:01:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:05 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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:05 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 16:01:05 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 16:01:05 INFO - Using env: {'DISPLAY': ':0', 16:01:05 INFO - 'HOME': '/home/cltbld', 16:01:05 INFO - 'LANG': 'en_US.UTF-8', 16:01:05 INFO - 'LANGUAGE': 'en_US:en', 16:01:05 INFO - 'LOGNAME': 'cltbld', 16:01:05 INFO - 'MAIL': '/var/mail/cltbld', 16:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:05 INFO - 'MOZ_NO_REMOTE': '1', 16:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:05 INFO - 'NO_EM_RESTART': '1', 16:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:05 INFO - 'PWD': '/builds/slave/test', 16:01:05 INFO - 'SHELL': '/bin/bash', 16:01:05 INFO - 'SHLVL': '1', 16:01:05 INFO - 'TERM': 'linux', 16:01:05 INFO - 'TMOUT': '86400', 16:01:05 INFO - 'USER': 'cltbld', 16:01:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:05 INFO - '_': '/tools/buildbot/bin/python'} 16:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:05 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 16:01:05 INFO - Cleaning up... 16:01:05 INFO - Return code: 0 16:01:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:05 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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:05 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 16:01:05 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 16:01:05 INFO - Using env: {'DISPLAY': ':0', 16:01:05 INFO - 'HOME': '/home/cltbld', 16:01:05 INFO - 'LANG': 'en_US.UTF-8', 16:01:05 INFO - 'LANGUAGE': 'en_US:en', 16:01:05 INFO - 'LOGNAME': 'cltbld', 16:01:05 INFO - 'MAIL': '/var/mail/cltbld', 16:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:05 INFO - 'MOZ_NO_REMOTE': '1', 16:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:05 INFO - 'NO_EM_RESTART': '1', 16:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:05 INFO - 'PWD': '/builds/slave/test', 16:01:05 INFO - 'SHELL': '/bin/bash', 16:01:05 INFO - 'SHLVL': '1', 16:01:05 INFO - 'TERM': 'linux', 16:01:05 INFO - 'TMOUT': '86400', 16:01:05 INFO - 'USER': 'cltbld', 16:01:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:05 INFO - '_': '/tools/buildbot/bin/python'} 16:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:05 INFO - Downloading/unpacking psutil>=3.1.1 16:01:05 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 16:01:05 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 16:01:05 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 16:01:05 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 16:01:05 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 16:01:05 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 16:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:08 INFO - Installing collected packages: psutil 16:01:08 INFO - Running setup.py install for psutil 16:01:08 INFO - building 'psutil._psutil_linux' extension 16:01:08 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 16:01:08 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 16:01:08 INFO - building 'psutil._psutil_posix' extension 16:01:08 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 16:01:08 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 16:01:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:08 INFO - Successfully installed psutil 16:01:08 INFO - Cleaning up... 16:01:08 INFO - Return code: 0 16:01:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:08 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')]} 16:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:08 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')]} 16:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:08 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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:08 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 16:01:08 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 16:01:08 INFO - Using env: {'DISPLAY': ':0', 16:01:08 INFO - 'HOME': '/home/cltbld', 16:01:08 INFO - 'LANG': 'en_US.UTF-8', 16:01:08 INFO - 'LANGUAGE': 'en_US:en', 16:01:08 INFO - 'LOGNAME': 'cltbld', 16:01:08 INFO - 'MAIL': '/var/mail/cltbld', 16:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:08 INFO - 'MOZ_NO_REMOTE': '1', 16:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:08 INFO - 'NO_EM_RESTART': '1', 16:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:08 INFO - 'PWD': '/builds/slave/test', 16:01:08 INFO - 'SHELL': '/bin/bash', 16:01:08 INFO - 'SHLVL': '1', 16:01:08 INFO - 'TERM': 'linux', 16:01:08 INFO - 'TMOUT': '86400', 16:01:08 INFO - 'USER': 'cltbld', 16:01:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:08 INFO - '_': '/tools/buildbot/bin/python'} 16:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:08 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 16:01:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:10 INFO - Installing collected packages: mozsystemmonitor 16:01:10 INFO - Running setup.py install for mozsystemmonitor 16:01:10 INFO - Successfully installed mozsystemmonitor 16:01:10 INFO - Cleaning up... 16:01:10 INFO - Return code: 0 16:01:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:01:10 INFO - Using env: {'DISPLAY': ':0', 16:01:10 INFO - 'HOME': '/home/cltbld', 16:01:10 INFO - 'LANG': 'en_US.UTF-8', 16:01:10 INFO - 'LANGUAGE': 'en_US:en', 16:01:10 INFO - 'LOGNAME': 'cltbld', 16:01:10 INFO - 'MAIL': '/var/mail/cltbld', 16:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:10 INFO - 'MOZ_NO_REMOTE': '1', 16:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:10 INFO - 'NO_EM_RESTART': '1', 16:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:10 INFO - 'PWD': '/builds/slave/test', 16:01:10 INFO - 'SHELL': '/bin/bash', 16:01:10 INFO - 'SHLVL': '1', 16:01:10 INFO - 'TERM': 'linux', 16:01:10 INFO - 'TMOUT': '86400', 16:01:10 INFO - 'USER': 'cltbld', 16:01:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:10 INFO - '_': '/tools/buildbot/bin/python'} 16:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:11 INFO - Downloading/unpacking jsonschema==2.5.1 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:13 INFO - warning: no files found matching '*.txt' 16:01:13 INFO - no previously-included directories found matching 'build' 16:01:13 INFO - no previously-included directories found matching 'dist' 16:01:13 INFO - no previously-included directories found matching '.git*' 16:01:13 INFO - Installing collected packages: jsonschema, functools32 16:01:13 INFO - Running setup.py install for functools32 16:01:13 INFO - warning: no files found matching '*.txt' 16:01:13 INFO - no previously-included directories found matching 'build' 16:01:13 INFO - no previously-included directories found matching 'dist' 16:01:13 INFO - no previously-included directories found matching '.git*' 16:01:13 INFO - Successfully installed jsonschema functools32 16:01:13 INFO - Cleaning up... 16:01:13 INFO - Return code: 0 16:01:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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', '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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:01: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 functools32==3.2.3-2 16:01:13 INFO - Using env: {'DISPLAY': ':0', 16:01:13 INFO - 'HOME': '/home/cltbld', 16:01:13 INFO - 'LANG': 'en_US.UTF-8', 16:01:13 INFO - 'LANGUAGE': 'en_US:en', 16:01:13 INFO - 'LOGNAME': 'cltbld', 16:01:13 INFO - 'MAIL': '/var/mail/cltbld', 16:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:13 INFO - 'MOZ_NO_REMOTE': '1', 16:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:13 INFO - 'NO_EM_RESTART': '1', 16:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:13 INFO - 'PWD': '/builds/slave/test', 16:01:13 INFO - 'SHELL': '/bin/bash', 16:01:13 INFO - 'SHLVL': '1', 16:01:13 INFO - 'TERM': 'linux', 16:01:13 INFO - 'TMOUT': '86400', 16:01:13 INFO - 'USER': 'cltbld', 16:01:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:13 INFO - '_': '/tools/buildbot/bin/python'} 16:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:01:14 INFO - Cleaning up... 16:01:14 INFO - Return code: 0 16:01:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01:14 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')]} 16:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:14 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')]} 16:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:14 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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:14 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 16:01:14 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 16:01:14 INFO - Using env: {'DISPLAY': ':0', 16:01:14 INFO - 'HOME': '/home/cltbld', 16:01:14 INFO - 'LANG': 'en_US.UTF-8', 16:01:14 INFO - 'LANGUAGE': 'en_US:en', 16:01:14 INFO - 'LOGNAME': 'cltbld', 16:01:14 INFO - 'MAIL': '/var/mail/cltbld', 16:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:14 INFO - 'MOZ_NO_REMOTE': '1', 16:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:14 INFO - 'NO_EM_RESTART': '1', 16:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:14 INFO - 'PWD': '/builds/slave/test', 16:01:14 INFO - 'SHELL': '/bin/bash', 16:01:14 INFO - 'SHLVL': '1', 16:01:14 INFO - 'TERM': 'linux', 16:01:14 INFO - 'TMOUT': '86400', 16:01:14 INFO - 'USER': 'cltbld', 16:01:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:14 INFO - '_': '/tools/buildbot/bin/python'} 16:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:14 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 16:01:14 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 16:01:14 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 16:01:14 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 16:01:14 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 16:01:14 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 16:01:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:16 INFO - Downloading docopt-0.6.1.tar.gz 16:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:16 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:16 INFO - Running setup.py install for blobuploader 16:01:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:17 INFO - Running setup.py install for requests 16:01:17 INFO - Running setup.py install for docopt 16:01:17 INFO - Successfully installed blobuploader requests docopt 16:01:17 INFO - Cleaning up... 16:01:17 INFO - Return code: 0 16:01:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:17 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')]} 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 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')]} 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:17 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 16:01:17 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 16:01:17 INFO - Using env: {'DISPLAY': ':0', 16:01:17 INFO - 'HOME': '/home/cltbld', 16:01:17 INFO - 'LANG': 'en_US.UTF-8', 16:01:17 INFO - 'LANGUAGE': 'en_US:en', 16:01:17 INFO - 'LOGNAME': 'cltbld', 16:01:17 INFO - 'MAIL': '/var/mail/cltbld', 16:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:17 INFO - 'MOZ_NO_REMOTE': '1', 16:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:17 INFO - 'NO_EM_RESTART': '1', 16:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:17 INFO - 'PWD': '/builds/slave/test', 16:01:17 INFO - 'SHELL': '/bin/bash', 16:01:17 INFO - 'SHLVL': '1', 16:01:17 INFO - 'TERM': 'linux', 16:01:17 INFO - 'TMOUT': '86400', 16:01:17 INFO - 'USER': 'cltbld', 16:01:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:17 INFO - '_': '/tools/buildbot/bin/python'} 16:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:17 INFO - Running setup.py (path:/tmp/pip-FLT_SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:17 INFO - Running setup.py (path:/tmp/pip-HgzrYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:17 INFO - Running setup.py (path:/tmp/pip-PXJyeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:18 INFO - Running setup.py (path:/tmp/pip-fYP1P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:18 INFO - Running setup.py (path:/tmp/pip-Z78zuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:18 INFO - Running setup.py (path:/tmp/pip-qH2ZQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:18 INFO - Running setup.py (path:/tmp/pip-E8g4m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:18 INFO - Running setup.py (path:/tmp/pip-ReEDXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:18 INFO - Running setup.py (path:/tmp/pip-RAb6rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:18 INFO - Running setup.py (path:/tmp/pip-JzvpAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:18 INFO - Running setup.py (path:/tmp/pip-tWNBKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:18 INFO - Running setup.py (path:/tmp/pip-5diX_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:18 INFO - Running setup.py (path:/tmp/pip-15qBuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:18 INFO - Running setup.py (path:/tmp/pip-BP1gZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:18 INFO - Running setup.py (path:/tmp/pip-IbTeQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:18 INFO - Running setup.py (path:/tmp/pip-pUTvRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:18 INFO - Running setup.py (path:/tmp/pip-yt76PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:19 INFO - Running setup.py install for manifestparser 16:01:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Running setup.py install for mozcrash 16:01:19 INFO - Running setup.py install for mozdebug 16:01:19 INFO - Running setup.py install for mozdevice 16:01:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Running setup.py install for mozfile 16:01:19 INFO - Running setup.py install for mozhttpd 16:01:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Running setup.py install for mozinfo 16:01:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Running setup.py install for mozInstall 16:01:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:19 INFO - Running setup.py install for mozleak 16:01:19 INFO - Running setup.py install for mozlog 16:01:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Running setup.py install for moznetwork 16:01:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Running setup.py install for mozprocess 16:01:20 INFO - Running setup.py install for mozprofile 16:01:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Running setup.py install for mozrunner 16:01:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Running setup.py install for mozscreenshot 16:01:20 INFO - Running setup.py install for moztest 16:01:20 INFO - Running setup.py install for mozversion 16:01:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:20 INFO - Cleaning up... 16:01:20 INFO - Return code: 0 16:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:20 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')]} 16:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:20 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')]} 16:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:20 INFO - Using env: {'DISPLAY': ':0', 16:01:20 INFO - 'HOME': '/home/cltbld', 16:01:20 INFO - 'LANG': 'en_US.UTF-8', 16:01:20 INFO - 'LANGUAGE': 'en_US:en', 16:01:20 INFO - 'LOGNAME': 'cltbld', 16:01:20 INFO - 'MAIL': '/var/mail/cltbld', 16:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:20 INFO - 'MOZ_NO_REMOTE': '1', 16:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:20 INFO - 'NO_EM_RESTART': '1', 16:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:20 INFO - 'PWD': '/builds/slave/test', 16:01:20 INFO - 'SHELL': '/bin/bash', 16:01:20 INFO - 'SHLVL': '1', 16:01:20 INFO - 'TERM': 'linux', 16:01:20 INFO - 'TMOUT': '86400', 16:01:20 INFO - 'USER': 'cltbld', 16:01:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:20 INFO - '_': '/tools/buildbot/bin/python'} 16:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:21 INFO - Running setup.py (path:/tmp/pip-PXZRT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:21 INFO - Running setup.py (path:/tmp/pip-cJ8ji8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:21 INFO - Running setup.py (path:/tmp/pip-ujpGW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:21 INFO - Running setup.py (path:/tmp/pip-zEpkhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:21 INFO - Running setup.py (path:/tmp/pip-zLy4uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:21 INFO - Running setup.py (path:/tmp/pip-2pJRrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:21 INFO - Running setup.py (path:/tmp/pip-43hgUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:21 INFO - Running setup.py (path:/tmp/pip-B5Wb9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:21 INFO - Running setup.py (path:/tmp/pip-3Pb7tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:21 INFO - Running setup.py (path:/tmp/pip-gPxoo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:21 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)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:21 INFO - Running setup.py (path:/tmp/pip-SI9W1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:21 INFO - Running setup.py (path:/tmp/pip-I5GR4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:21 INFO - Running setup.py (path:/tmp/pip-tTsPvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:22 INFO - Running setup.py (path:/tmp/pip-iisqH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:22 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)) 16:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:22 INFO - Running setup.py (path:/tmp/pip-WQUkH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:22 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)) 16:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:22 INFO - Running setup.py (path:/tmp/pip-3Mp9y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:22 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)) 16:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:22 INFO - Running setup.py (path:/tmp/pip-vxD7Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:22 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)) 16:01:22 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)) 16:01:22 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)) 16:01:22 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)) 16:01:22 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)) 16:01:22 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)) 16:01:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:24 INFO - Downloading blessings-1.6.tar.gz 16:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:24 INFO - Installing collected packages: blessings 16:01:24 INFO - Running setup.py install for blessings 16:01:24 INFO - Successfully installed blessings 16:01:24 INFO - Cleaning up... 16:01:24 INFO - Return code: 0 16:01:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:24 INFO - Reading from file tmpfile_stdout 16:01:24 INFO - Current package versions: 16:01:24 INFO - argparse == 1.2.1 16:01:24 INFO - blessings == 1.6 16:01:24 INFO - blobuploader == 1.2.4 16:01:24 INFO - docopt == 0.6.1 16:01:24 INFO - functools32 == 3.2.3-2 16:01:24 INFO - jsonschema == 2.5.1 16:01:24 INFO - manifestparser == 1.1 16:01:24 INFO - mozInstall == 1.12 16:01:24 INFO - mozcrash == 0.17 16:01:24 INFO - mozdebug == 0.1 16:01:24 INFO - mozdevice == 0.48 16:01:24 INFO - mozfile == 1.2 16:01:24 INFO - mozhttpd == 0.7 16:01:24 INFO - mozinfo == 0.9 16:01:24 INFO - mozleak == 0.1 16:01:24 INFO - mozlog == 3.4 16:01:24 INFO - moznetwork == 0.27 16:01:24 INFO - mozprocess == 0.23 16:01:24 INFO - mozprofile == 0.28 16:01:24 INFO - mozrunner == 6.12 16:01:24 INFO - mozscreenshot == 0.1 16:01:24 INFO - mozsystemmonitor == 0.3 16:01:24 INFO - moztest == 0.7 16:01:24 INFO - mozversion == 1.4 16:01:24 INFO - psutil == 3.1.1 16:01:24 INFO - requests == 1.2.3 16:01:24 INFO - wsgiref == 0.1.2 16:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:24 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 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:24 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 16:01:24 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 16:01:24 INFO - Using env: {'DISPLAY': ':0', 16:01:24 INFO - 'HOME': '/home/cltbld', 16:01:24 INFO - 'LANG': 'en_US.UTF-8', 16:01:24 INFO - 'LANGUAGE': 'en_US:en', 16:01:24 INFO - 'LOGNAME': 'cltbld', 16:01:24 INFO - 'MAIL': '/var/mail/cltbld', 16:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:24 INFO - 'MOZ_NO_REMOTE': '1', 16:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:24 INFO - 'NO_EM_RESTART': '1', 16:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:24 INFO - 'PWD': '/builds/slave/test', 16:01:24 INFO - 'SHELL': '/bin/bash', 16:01:24 INFO - 'SHLVL': '1', 16:01:24 INFO - 'TERM': 'linux', 16:01:24 INFO - 'TMOUT': '86400', 16:01:24 INFO - 'USER': 'cltbld', 16:01:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:24 INFO - '_': '/tools/buildbot/bin/python'} 16:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 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)) 16:01:25 INFO - Cleaning up... 16:01:25 INFO - Return code: 0 16:01:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1045bd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', '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 16:01:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:01:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:01:25 INFO - Using env: {'DISPLAY': ':0', 16:01:25 INFO - 'HOME': '/home/cltbld', 16:01:25 INFO - 'LANG': 'en_US.UTF-8', 16:01:25 INFO - 'LANGUAGE': 'en_US:en', 16:01:25 INFO - 'LOGNAME': 'cltbld', 16:01:25 INFO - 'MAIL': '/var/mail/cltbld', 16:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:25 INFO - 'MOZ_NO_REMOTE': '1', 16:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:25 INFO - 'NO_EM_RESTART': '1', 16:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:25 INFO - 'PWD': '/builds/slave/test', 16:01:25 INFO - 'SHELL': '/bin/bash', 16:01:25 INFO - 'SHLVL': '1', 16:01:25 INFO - 'TERM': 'linux', 16:01:25 INFO - 'TMOUT': '86400', 16:01:25 INFO - 'USER': 'cltbld', 16:01:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:25 INFO - '_': '/tools/buildbot/bin/python'} 16:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:01:25 INFO - Cleaning up... 16:01:25 INFO - Return code: 0 16:01:25 INFO - Running post-action listener: _resource_record_post_action 16:01:25 INFO - Running post-action listener: _start_resource_monitoring 16:01:25 INFO - Starting resource monitoring. 16:01:25 INFO - [mozharness: 2016-10-03 23:01:25.347650Z] Finished create-virtualenv step (success) 16:01:25 INFO - [mozharness: 2016-10-03 23:01:25.348169Z] Running install step. 16:01:25 INFO - Running pre-action listener: _resource_record_pre_action 16:01:25 INFO - Running main action method: install 16:01:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:25 INFO - Reading from file tmpfile_stdout 16:01:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:25 INFO - Reading from file tmpfile_stdout 16:01:25 INFO - Output received: 16:01:25 INFO - Usage: mozinstall [options] installer 16:01:25 INFO - Options: 16:01:25 INFO - -h, --help show this help message and exit 16:01:25 INFO - -d DEST, --destination=DEST 16:01:25 INFO - Directory to install application into. [default: 16:01:25 INFO - "/builds/slave/test"] 16:01:25 INFO - --app=APP Application being installed. [default: firefox] 16:01:25 INFO - mkdir: /builds/slave/test/build/application 16:01:25 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'] 16:01:25 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 16:01:41 INFO - Reading from file tmpfile_stdout 16:01:41 INFO - Output received: 16:01:41 INFO - /builds/slave/test/build/application/firefox/firefox 16:01:41 INFO - Running post-action listener: _resource_record_post_action 16:01:41 INFO - [mozharness: 2016-10-03 23:01:41.795842Z] Finished install step (success) 16:01:41 INFO - [mozharness: 2016-10-03 23:01:41.796088Z] Running run-tests step. 16:01:41 INFO - Running pre-action listener: _resource_record_pre_action 16:01:41 INFO - Running main action method: run_tests 16:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:01:41 INFO - Python 2.7.3 16:01:41 INFO - Return code: 0 16:01:41 INFO - grabbing minidump binary from tooltool 16:01:41 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')]} 16:01:41 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 0x13e9f60>, '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 0x13ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13eb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:01:41 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 16:01:41 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 16:01:41 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 16:01:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:41 INFO - Return code: 0 16:01:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:01:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:01:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:01:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:01:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:01:41 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/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 16:01:41 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/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 16:01:41 INFO - Using env: {'DISPLAY': ':0', 16:01:41 INFO - 'HOME': '/home/cltbld', 16:01:41 INFO - 'LANG': 'en_US.UTF-8', 16:01:41 INFO - 'LANGUAGE': 'en_US:en', 16:01:41 INFO - 'LOGNAME': 'cltbld', 16:01:41 INFO - 'MAIL': '/var/mail/cltbld', 16:01:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:41 INFO - 'MOZ_NO_REMOTE': '1', 16:01:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:41 INFO - 'NO_EM_RESTART': '1', 16:01:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:41 INFO - 'PWD': '/builds/slave/test', 16:01:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:41 INFO - 'SHELL': '/bin/bash', 16:01:41 INFO - 'SHLVL': '1', 16:01:41 INFO - 'TERM': 'linux', 16:01:41 INFO - 'TMOUT': '86400', 16:01:41 INFO - 'USER': 'cltbld', 16:01:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633', 16:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:41 INFO - '_': '/tools/buildbot/bin/python'} 16:01:41 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/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 16:01:42 INFO - mozversion application_buildid: 20161003153656 16:01:42 INFO - mozversion application_changeset: 1a4288cc3cead7e7026ea5e2594b6041e69dd13b 16:01:42 INFO - mozversion application_display_name: Nightly 16:01:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:42 INFO - mozversion application_name: Firefox 16:01:42 INFO - mozversion application_remotingname: firefox 16:01:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:01:42 INFO - mozversion application_vendor: Mozilla 16:01:42 INFO - mozversion application_version: 52.0a1 16:01:42 INFO - mozversion platform_buildid: 20161003153656 16:01:42 INFO - mozversion platform_changeset: 1a4288cc3cead7e7026ea5e2594b6041e69dd13b 16:01:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:01:42 INFO - mozversion platform_version: 52.0a1 16:01:42 INFO - using testdate: 1475535702 16:01:42 INFO - actual date: 1475535702 16:01:42 INFO - starting webserver on 'localhost:59006' 16:01:42 INFO - SUITE-START | Running 2 tests 16:01:42 INFO - TEST-START | dromaeo_css 16:01:42 INFO - operating with platform_type : linux_ 16:01:42 INFO - Initialising browser for dromaeo_css test... 16:01:42 INFO - TEST-INFO | started process 12090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGEpCf/profile http://localhost:59006/getInfo.html) 16:01:46 INFO - PROCESS | 12090 | __metrics Screen width/height:1600/1200 16:01:46 INFO - PROCESS | 12090 | colorDepth:24 16:01:46 INFO - PROCESS | 12090 | Browser inner width/height: 1024/697 16:01:46 INFO - PROCESS | 12090 | __metrics 16:01:47 INFO - PROCESS | 12090 | 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" 16:01:47 INFO - PROCESS | 12090 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:01:48 INFO - PROCESS | 12090 | console.error: PushService: 16:01:48 INFO - PROCESS | 12090 | stateChangeProcessEnqueue: Error transitioning state 16:01:48 INFO - PROCESS | 12090 | UnknownError 16:01:48 INFO - TEST-INFO | 12090: exit 0 16:01:48 INFO - Browser initialized. 16:01:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:48 INFO - TEST-INFO | started process 12170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGEpCf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:01 INFO - PROCESS | 12170 | RSS: Main: 175329280 16:02:01 INFO - PROCESS | 12170 | 16:02:51 INFO - PROCESS | 12170 | 1475535771892 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] 16:05:07 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:59006/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59006/tests/dromaeo/cssquery-ext.html) 16:05:08 INFO - PROCESS | 12170 | RSS: Main: 268713984 16:05:08 INFO - PROCESS | 12170 | 16:08:11 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:59006/tests/dromaeo/cssquery-ext.html (next: http://localhost:59006/tests/dromaeo/cssquery-jquery.html) 16:08:11 INFO - PROCESS | 12170 | RSS: Main: 277159936 16:08:11 INFO - PROCESS | 12170 | 16:11:13 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:59006/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59006/tests/dromaeo/cssquery-mootools.html) 16:11:14 INFO - PROCESS | 12170 | RSS: Main: 220053504 16:11:14 INFO - PROCESS | 12170 | 16:14:16 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:59006/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59006/tests/dromaeo/cssquery-prototype.html) 16:14:17 INFO - PROCESS | 12170 | RSS: Main: 244375552 16:14:17 INFO - PROCESS | 12170 | 16:17:20 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:59006/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59006/tests/dromaeo/cssquery-yui.html) 16:17:21 INFO - PROCESS | 12170 | RSS: Main: 219992064 16:17:21 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | Cycle 1(1): loaded http://localhost:59006/tests/dromaeo/cssquery-yui.html (next: http://localhost:59006/tests/dromaeo/cssquery-dojo.html) 16:20:24 INFO - PROCESS | 12170 | RSS: Main: 311312384 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | __start_tp_report 16:20:24 INFO - PROCESS | 12170 | _x_x_mozilla_page_load 16:20:24 INFO - PROCESS | 12170 | _x_x_mozilla_page_load_details 16:20:24 INFO - PROCESS | 12170 | |i|pagename|runs| 16:20:24 INFO - PROCESS | 12170 | |0;dojo.html;2577;2606.530824451598;2607.4394005288864;2652.4164683769577;2667.1731763153425;4565.7717114144325;4645.837395691152;4672.112298663252;4698.483166851648;4726.692764970275;4690.57784799368;4697.084068606623;4727.22000869856;4784.258439941806;4827.8310259140935;4196.538380778112;4259.275923093066;4303.203907277148;4325;4338.479382474092;4052.149048699762;4341.587549182823;4342.522322544518;4381.737095774264;4430.26900561407;4253.404523366731;4344.413504176927;4359.149965756678;4448.221561226788;4481.014176881081;4263.296556068245;4287.442632457761;4300.161468513641;4304.569543045702;4353.085851971058;4256.08494173751;4256.914861702749;4272.9145417091795;4317.956820431818;4326.307790753496;4682;4685.812567497296;4703.15343238217;4706.082313948781;4713.764311784432;4816.54242846929;4863.124637565237;4906.092372911023;4942.283368911523;4989.900201995976;5032.345795046657;5036.823711170128;5040.218766091225;5080.263361812516;5086.949130508685;4669.39297891272;4681.578657920803;4682.929756053662;4688.203005489075;4740.1230772307235;4957.3059771632;5052.671576347526;5068.670536415121;5147.099257629975;5200;4890.804367825318;4911.336969509142;4918.0901533216465;4973.52751488608;4975.4527002029745;5002.499750025041;5012.523810238022;5013.89972200554;5015.04714104319;5077.390713114376;4827.468978412372;4954.3063971044085;4959.13215187348;5026.195808670595;5026.949730502648;4862.197737373364;4884.462709101996;4908.607311415079;4934.1118598651865;4938.037082768898;4245.766482843412;4252.659787217015;4253.128108737701;4255.3616957456625;4256.212600668886;3676.742628016013;3696.094456858033;3777.962220377816;3790.962090379116;3791.0332865119217;4351.543087975717;4355.346697995263;4368.694191406571;4416.66874984371;4456.197884380843;5064.392272927199;5067.771950262247;5070.645054846199;5072.4673909239;5087.364079490064;4296.699231053859;4337.566243375701;4376.081022985209;4406.1187762447;4409.470863496401;4571.9314210286875;4596.2416201326405;4597.632189424838;4605.148047611203;4658.114958157939;4799.232122860465;4804.279358096313;4826.32431459603;4866.756662166948;4869.488703686062;4887.706737595756;4944.92582611254;5006.5994720423005;5113.284140220447;5121.334226550524;4763.261694437368;4773.498782627913;4778.593819525379;4813.229883218668;4823.2282834746275;4982.626303027215;4985.651004429655;4989.900201996013;4994.1260279450225;5049.621278404061;4925.9014819704125;4986.9251961221335;5032.119379108714;5042.445331013659;5099.592032637306;4815.133276010211;4856.247281671346;4875.829345972874;4893.339399181065;4947.579455746302;4881.341018962395;4883.316335712932;4884.535969082932;4885.90228195427;4950.084234416644;4655.790489428052;4800.183968725395;4804.615630749601;4811.663183577116;4879.56083952446;4804.42346918372;4849.4908034655855;4878.658493905393;4901.754912254301;4976.925346119883;4798.088363210979;4815.831445899376;4820.517948205152;4822.758862056813;4882.92675609859 16:20:24 INFO - PROCESS | 12170 | |1;ext.html;542.723211162307;545.1250742558194;561.7556362982102;561.9631779367071;562.741139076025;27661.861690691545;37773.81113094438;39182.21635567287;39256.60743392569;43014.7849260754;40524.59475405245;40902.59097409025;40979.59020409795;40985;40989;7596.012518372618;7744.651490682904;7747.147813740484;7751.6124193790365;7752.379809615245;7532.661030253625;7611.238876112372;7622.961885190566;7626.275503827128;7626.961865190667;7577.962110189469;7643.044619422572;7653.540787552737;7658.617069146549;7658.846823063535;7613.124490683559;7648.120466146409;7651.273129052731;7659.195784442665;7664.693412263503;7514.549127052394;7575.242475752436;7583.62081895903;7594.924050759532;7598.696052157907;37533.81233093817;37918.81040594779;37955.620443795764;37978.81010594957;37991.81004094962;2934.457125431802;2984.1196846930206;3003;3023.6069310989433;3066.8159910405225;28435.289117772016;28592.714072859213;28679.713202868123;29127.708722912925;30615;2641.8414895106357;2686.9731302687114;2694.528457519926;2701;2792.9581056284173;246187;247425;247474.76262618753;247560;247985.9999999982;31185.376292474022;50421.747891261046;50618.49381506212;50755.23867141996;50839.74580127076;32212.516812247835;32323.676763232535;32365.51451728226;32370.190745231557;32385.838070809496;12032.09759268041;12205.145639805305;12205.633830984907;12205.633830985085;12213.633590992284;9636.036396360449;9790.363626364264;9798.951005245071;9805.411675299505;9807.901920980841;7949.284564389117;7951.602419878983;7991.2807847294025;8046.678132874619;8064.354851611857;3145.984270078635;3155.542446345313;3155.9053228403186;3184.7611429142908;3202.2154572129975;825.8059356051323;854.8803167556547;864.312871267344;889.8754174415587;911.7492689510306;24755.62866557003;25881.09416170425;26029.609555856678;26061.869690651427;26136;871.6426265231352;946.3044662173297;974.9512524373753;982.106283282224;1016.9542370593341;13526.797098043537;13790.65523361924;14007.579772606838;14041.227732474812;14184.503542375967;384225.261979041;387856;388182;388237;389045;48191.27713084307;48893;49073;49097.50902491001;49164.625306204354;1147.4893672315739;1151;1187.8396416483838;1191.5591231244496;1200.9219400738923;23952.576216794547;25158.874205628854;25165;25853.612195817455;26047.479050419264;41907.161856763305;42163.36754948617;42175;42198.367024495274;42258;262407;263332;263337;263453;264417;25150.24549263525;25423.36441588975;25569;26131.477370452863;27061.59407608927;40050;40710.79644601758;40869;42171.78914105533;42505.787471062446;35089.824550877085;35098.298034038664;35401.82299088488;35446.645533545365;36038;34624.48063279002;34888.65111348854;34955.30089398147;35220.64779352173;35275;32687.836560817042;33765.83117084399;33893.491597625565;34081.31837363189;35166.29667406587;29717;31939.36121277515;32070.358592827546;32283.19292017718;32353.044095519577;24743.62884556769;24910.37724056913;24990.250292491255;25069;25243.87378063098 16:20:24 INFO - PROCESS | 12170 | |2;jquery.html;347.43368309655256;360.97292703047276;363.77264209868827;371.99070023249413;391.9274934137185;12149;15748.921255393721;16345;16696.74954875678;17671.911640441813;16347.34610615577;16523;16751.413700520483;17089.060101694402;17196.656066878688;4956.355673762415;5016.949830501703;5130.486951304877;5164.819231326905;5167.974160129194;3730.4963829883027;3925.725199236055;5077.187649976005;5195;5237.423883372826;3651.5070465487083;3911.706622003347;3963.1479231965122;3964.6035396460265;3968.2658708138943;5927.644341339534;6016.879662406749;6019.277686677583;6045.274567051982;6050.2437195350585;5122.897542049138;5278.9208161877605;5293.417724050351;5294.52349288562;5303.443138470444;20314.79685203144;20461.386158415273;20479.69280460794;20571.38285851427;20699.27552535654;1923.5671973805922;1980.7226988221516;2473.888675009629;2482.615194644833;2539.6444497770326;12158.392080395945;12871.871281287162;13283.86716132836;13334.599962001155;13773.724525509433;1700.523853321072;1702.9659406811918;1775.9289628414847;1780.0565700178927;1781.1895587507654;66405.66797165983;68796;69642.65178674125;71232.64383678048;71587;9116.128419547822;9290.88509378879;9434.481103539234;9685.515724213761;9752.366096203867;13112.737745245233;13220.471181152647;13228.867711322957;13232.272225027524;13246.271455069871;6734.46124310054;6799.456043516507;6947.444204463631;6978;7004.334588214111;6291.528135389773;6336.904946425807;6375.936240637627;6492.967535162294;6509.576877502947;5137.8201762938115;5552.3892371839065;5594.776208951596;5945.137954996501;6147.477464415485;1613.7014652289129;1714.691355555987;1788.624388878324;1792.3816283382212;1796.2006906926292;829.8713699376606;853.8249658819927;896.820635872828;918.9172974432333;920.9953950230206;15067.849321506865;15858.762118568231;16020.839791602168;16568;17157.57106072333;811.8173410982482;817.8037271054905;830.7839961610025;830.8006078541227;837.6021389839899;8953.328500362499;9492.90507094934;9915.950420247853;9978.201743860474;10324.741881452874;333312;350523.1636779954;380627;383590;383988;72326.63836680783;75007.24992750112;75321.24678753142;76044;77000.61499692466;871.9869201962102;895.5656506594297;922.9400088994194;925.6852670092067;927.758782716485;15338.923305383401;15361.155136467602;15662.608434788766;16208.67582648364;16269.186540673156;35496.82251588725;35999.28001440009;36479.635203647624;36569.634303656625;37172.81413592915;48175.51824481851;48719.75640121919;48912.266316006004;49271.260931085344;51524.742376287875;7239.203687594466;7253;7476.401887849068;7541.283578060075;7890.605469726376;8028.59857007159;11137.331760094095;11197.328160310408;11401;11630.185886987829;9792;9921.107100361001;10120.746981325527;10170.542325595514;10857.565697372333;9865.161461275871;10009.299349045497;10011.399316041061;10226.130778883879;10238.18094552449;9761.316707830383;10085.495725213857;10489.108425783894;10588.947055264674;10991.61529346469;7317.853642927218;7352.889706654511;7444;7599.4680372375615;7644.120926093348;7565;8828.735137945872;9456.148946594565;9636.46999415039;9851.655192068243 16:20:24 INFO - PROCESS | 12170 | |3;mootools.html;1143.7026373142985;1159.6521043686892;1291.1994563370708;1476.0331982551434;1485.7251408489424;6624.370684784938;6767.0864433301485;6804.2175149857785;7265.963670181648;7273.963630181842;7022.9297707022915;7302.050733404663;7374.778756637296;7573.1669516353295;7587.127480339763;1965.6953172258286;1988.980110198894;1990.8208261256484;1991.8705284156483;1994.451525830401;1699.7620333153368;2100.9264675736354;2117.587070521249;2129.5315030693223;2138.615049291127;1757.8242175782384;2049.077914938284;2114.8413868959815;2122.8726276423463;2150.3011521255653;2045.9974612439946;2064.2465500092508;2066.4214020074255;2070.523779530716;2072.2643461571074;2047.648551955717;2050.3131450963947;2051.3845846246068;2052.0970772859896;2053.917843286267;7468.2531746825425;7472.738454154133;7524.28519290672;7537.0955485341565;7589.165191828894;4284.314509678467;4401.977990110029;4408.6032257096695;4408.867733967986;4411.514733379326;2592.7148013718474;2797.146870204587;2804.3129433288973;2810.0445848411637;2813.7326953939546;807.3581502705305;815.384384789486;864.5547543015289;865.485036403339;869.4565896314804;9872.654457094039;9930.255230857714;9957.502124893726;9993.600255989752;10011.79976400468;3660.816959152032;3845.0964023454467;3913.2369188008634;3917.1186483041656;4032.395140728914;8577.528235947082;8582.699605513902;8589;8589.398742088119;8601.61292741828;4415.955840441618;4425.35832304314;4427.933580996223;4429.2913133899065;4431.490378606437;3981.283368993551;4029.6373326400767;4031.2061132795625;4038.7778672172726;4066.8576599818866;3462.6191118976894;3512.6838584527513;3514.332276867387;3522.7357948153476;3526;997.9900200997897;1075.6772968109535;1126.5268587193398;1135.6649788312468;1154.7113221694576;658.6377492379172;753.5704648350388;774.5275382016965;822.2188920525405;833.7707130539151;4947.282644016597;5049.141645920203;5055.620828437882;5144.202648589475;5159.458256883048;761.9123800762873;771.2133623703903;782.984340313202;814.4014149600039;817.5993763056059;3434.9484757728655;3458.4466485362223;3467.4798780183173;3499.9650003499637;3575.1419659281587;8718.346124040723;8949.149830766068;9074.86387704185;9075.319351048565;9080.31897607682;8891.4665120093;8985.865212021825;9015.323850711091;9018.909810901938;9030.413023153475;6811.727530898807;6872.587644741331;6913.654317284116;6919.446444284546;6921.204061532888;4954.702717836942;5055.216441451581;5093.083245015784;5102.872428189176;5172.71550064735;8106.83786324282;8269.338452923872;8473.067962523994;8489.915100848912;8541.615627296911;8132;8226.095129535866;8444.240018398374;8518.829623407373;8525.701600443954;6260.968695156495;6325.588836725598;6368.808935731936;6369.299377068612;6412.102305677302;6911.619860907698;6938.93061069403;6939;6982.301769822977;7042.542234754725;5006.299118123538;6318.557700960889;6350.618962862243;6351.2060992375955;6501.609903405811;6295.527835412271;6364.840878977878;6371.299157092623;6427.775027874002;6489.156409666713;6027.457528822427;6040.607360521552;6077.24034495688;6083.908741368795;6094.421030002142;4363.716358436692;4377.190219809346;4382.167388196232;4419.80198019802;4525.253333200117;3937.7440466369594;3991.5409727880506;4097.405876148002;4141.461609990682;4196.853110141131 16:20:24 INFO - PROCESS | 12170 | |4;prototype.html;286.62309063581387;288.5239355064144;295.79590082842844;298.75949860362397;298.8431073686316;4593.03749081842;4713.505081966391;4739.7059043964455;4768.284757286408;4800.927986080212;4541.409616749818;4628.305754136881;4678.251479763238;4698.436187657478;4706.411698537683;3727.235916637083;3743.9251214975684;3744.3447396705606;3744.7191460640424;3745.3445647011663;3565.3047655707146;3754.117782321166;3757.4739536464917;3758.2295629396044;3759.4924685167425;3487.860485580574;3737.140457694732;3751.249750049987;3764.454154147647;3765.9831845401727;3701.9629803701887;3702.7222958277966;3720.6093360197196;3724.510195921626;3750.4186851038135;3289.7039266465895;3292.44028515153;3294.225856923621;3296.126526470487;3307.570015897918;4503.932441013388;4566.611837993742;4572.977135114304;4624.5144259852905;4627.305904114376;4206.495220573551;4211.389348544474;4222.408862759216;4225.535191128974;4231.576842315774;4895.9510404895855;4898.2162853943555;4908.7300198489065;4933.309336692866;4938.975305123451;3491.3366460372704;3580.7314451416246;3582.874599389009;3586.4799604057266;3603.1532589841368;5124.385073791169;5131.512506311894;5133.948660513384;5142.922856157161;5151.175811870083;3654.634536546377;3659.1949771050326;3666.926661466756;3671.4676371926457;3680.834362453696;3736.308782875177;3736.9065773355883;3754.5869954305003;3764.6800021997888;3766.811659417073;4076.694247931417;4193.7483750974425;4213.199492096492;4243.384709217208;4254.936175957301;4924.187509060965;4925.87685307863;4941.65408421407;4943.604511639061;4944.283078953532;1217.7564487102616;1249.787536118862;1286.8713128687057;1299.402274953532;1304.4064950447523;871.5642178910545;881.4750481666624;888.1828717579842;896.9237614802815;897.3808072430003;4439.448441246989;4452.220861349251;4452.398926144929;4454.86635400932;4462.687611867138;5073.594112470993;5076.6446348755235;5078.263651770472;5095.541401273903;5114.744262786846;4307.870763877088;4462.464504259445;4534.478534968455;4580.831887868639;4583.358329833826;2726.086760935109;2738.5755207942802;2739.6164536964843;2741.684706258766;2757.2831063923522;4897.8285759998225;4911;4915.3855768029;4915.58217551505;4919.458859525521;5087.771050302746;5239;5260.447652996457;5272.551833094153;5288.524032837063;4899.706017638953;4904.288878112654;4912.803487860517;4913.533214344631;4916.434610019751;4960.70235785854;5152.608795625085;5167.974160129175;5169.81905633301;5175.508326708957;5029.547340739205;5032.917922646649;5052.9747351263;5059.797608095635;5064.139096353702;4904.008554781509;4905.190643543775;4919.827806026772;4923.901521969469;4929.975350123226;3605.729570282187;3633.9636603633626;3651.287998840307;3657.725670574771;3666.633336666312;4931.802727890844;5082.916004438162;5116.411612664591;5149.382074150976;5165.974170129125;4920.950790492049;4931.235658472942;4960.975195124001;5012.343457967283;5014.247862820606;4935.851924442272;4955.6531042826655;4968.453470118212;5017.397912250407;5035.219540971156;4677.976610116928;4722.433308003062;4836.75937122136;4905.2151655734915;4960.578350840219;4829.348038014964;5004.6246531511015;5019.247112932943;5028.64799464034;5060.266261392151;4905.828296009622;4907.877303067452;4914.729689867092;4916.139675556692;4919.434265059564 16:20:24 INFO - PROCESS | 12170 | |5;yui.html;586.8268860686097;590.7814108779752;649.2187074105093;657.9671016449176;658.7826017414254;11515.48180331886;12218.32799196044;12244.448999795008;12582.307973061477;12602.684932876682;10740;12517.43671534783;12637.178583392073;12640.494380224804;12650.683732906682;752.6951584608242;771.7723271634882;780.2470615855698;780.5355813291083;780.5394817057935;773.3735674103966;776.8252143267777;780.0171783552736;780.4341852157197;780.9960950195269;822.2147848804377;822.8683410654296;823.0329362998452;823.5758584329076;824.4640983360804;808.7169490678274;809.1786836361098;809.4414853750893;809.5385630190793;810.2059981218439;598.4344794169511;602.6625089949642;603.4659326496038;604.1722839709626;604.3684349854369;10485.842712359321;10591.894081059168;10614.840777388345;10615.31000484966;10620.150387968944;10173.84739228912;10221.488925553693;10323.535440905178;10340.534675939525;10689.091427228695;9117.270618350516;9119.215525556885;9402.482863442508;9403.952980235123;9470.14768670816;3089.304906396043;3105.673904240045;3174.825384603846;3189.6331921829055;3291.637919828817;42573;43727.56272437298;49646.75176624094;57379.71310143422;58188;9572.138507534217;9746.561404736804;9845.409275443497;9906.306558540977;10006.19950403966;18188.454346369632;18206.271749130152;18213.817861821477;18229.088545572667;18229.908850455664;6696.330366963362;6716;6717.865642687118;6828.351306625863;6928.064711264015;3537.7346698997676;3571.7321200909514;3595.7303202259413;3647.28877868813;3721.7394782364972;2483.838550494212;2595.247378260321;2598;2601.622764699108;2603.388203772112;452.6039715249157;460.4957571459247;465.62982428969053;466.1050782497613;472.4260024070771;431.47144747683836;482.8382491865194;508.87532554523636;513.2942204468856;515.9767810448539;7339.559626422431;7680.923190768132;7821.178776228528;8260.339172866155;8476.982762068592;455.9361689363492;463.1917304303944;525.9244844293429;532.4196625678029;573.9770409183669;3553.9111522211633;3654.9634503655157;3773.4339849022867;3933.9803300983313;3951.8616848410165;98297;101701.49149254354;102405;104485.47757261318;104908.47545762375;85632;85678;86185;86893.48298877483;87270.1272987262;46528.5347146531;59006;74137.62931185418;75554.62222688961;75964.62017689877;7110.25342339047;7409.666565004695;7425.554466732014;7532.54804711719;7607.581583012988;43179.568204317555;43997.34003990007;44073.77963110292;44672;44854.77572612116;60122.69938650454;60205;64101.35898640954;66718;67270.66364668145;9367.297452691211;9509.42943423369;9512.667056653261;9546.52267386614;9762.365446246255;10957;11179.60871369498;11180.105591552494;11891.643250702493;12135.575254866037;9257.074292570689;9377.484238366955;9538.713838584854;9833.311668183445;9840.3603765755;9902.554385052546;10364.689059328231;10659.360438373722;10839.783204336027;11165.720856978316;9486.241100711788;9976.2517811163;10094.8485772712;10144.391336519833;10517.9474102629;8790.384673072824;9138.177564019004;9162.31282653817;9389.953050234704;9764.609415623296;8366.290089095324;8608.827823443622;8980.236679882284;8998.685046023358;9128.726138215865 16:20:24 INFO - PROCESS | 12170 | __end_tp_report 16:20:24 INFO - PROCESS | 12170 | __start_cc_report 16:20:24 INFO - PROCESS | 12170 | _x_x_mozilla_cycle_collect,1312 16:20:24 INFO - PROCESS | 12170 | __end_cc_report 16:20:24 INFO - PROCESS | 12170 | __startTimestamp1475536824415__endTimestamp 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | ------- Summary: start ------- 16:20:24 INFO - PROCESS | 12170 | Number of tests: 6 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | [#0] dojo.html Cycles:165 Average:4642.71 Median:4804.42 stddev:479.92 (10.0%) stddev-sans-first:453.21 16:20:24 INFO - PROCESS | 12170 | Values: 2577.0 2606.5 2607.4 2652.4 2667.2 4565.8 4645.8 4672.1 4698.5 4726.7 4690.6 4697.1 4727.2 4784.3 4827.8 4196.5 4259.3 4303.2 4325.0 4338.5 4052.1 4341.6 4342.5 4381.7 4430.3 4253.4 4344.4 4359.1 4448.2 4481.0 4263.3 4287.4 4300.2 4304.6 4353.1 4256.1 4256.9 4272.9 4318.0 4326.3 4682.0 4685.8 4703.2 4706.1 4713.8 4816.5 4863.1 4906.1 4942.3 4989.9 5032.3 5036.8 5040.2 5080.3 5086.9 4669.4 4681.6 4682.9 4688.2 4740.1 4957.3 5052.7 5068.7 5147.1 5200.0 4890.8 4911.3 4918.1 4973.5 4975.5 5002.5 5012.5 5013.9 5015.0 5077.4 4827.5 4954.3 4959.1 5026.2 5026.9 4862.2 4884.5 4908.6 4934.1 4938.0 4245.8 4252.7 4253.1 4255.4 4256.2 3676.7 3696.1 3778.0 3791.0 3791.0 4351.5 4355.3 4368.7 4416.7 4456.2 5064.4 5067.8 5070.6 5072.5 5087.4 4296.7 4337.6 4376.1 4406.1 4409.5 4571.9 4596.2 4597.6 4605.1 4658.1 4799.2 4804.3 4826.3 4866.8 4869.5 4887.7 4944.9 5006.6 5113.3 5121.3 4763.3 4773.5 4778.6 4813.2 4823.2 4982.6 4985.7 4989.9 4994.1 5049.6 4925.9 4986.9 5032.1 5042.4 5099.6 4815.1 4856.2 4875.8 4893.3 4947.6 4881.3 4883.3 4884.5 4885.9 4950.1 4655.8 4800.2 4804.6 4811.7 4879.6 4804.4 4849.5 4878.7 4901.8 4976.9 4798.1 4815.8 4820.5 4822.8 4882.9 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | [#1] ext.html Cycles:180 Average:44087.72 Median:35424.23 stddev:80731.23 (227.9%) stddev-sans-first:80891.50 16:20:24 INFO - PROCESS | 12170 | Values: 542.7 545.1 561.8 562.0 562.7 27661.9 37773.8 39182.2 39256.6 43014.8 40524.6 40902.6 40979.6 40985.0 40989.0 7596.0 7744.7 7747.1 7751.6 7752.4 7532.7 7611.2 7623.0 7626.3 7627.0 7578.0 7643.0 7653.5 7658.6 7658.8 7613.1 7648.1 7651.3 7659.2 7664.7 7514.5 7575.2 7583.6 7594.9 7598.7 37533.8 37918.8 37955.6 37978.8 37991.8 2934.5 2984.1 3003.0 3023.6 3066.8 28435.3 28592.7 28679.7 29127.7 30615.0 2641.8 2687.0 2694.5 2701.0 2793.0 246187.0 247425.0 247474.8 247560.0 247986.0 31185.4 50421.7 50618.5 50755.2 50839.7 32212.5 32323.7 32365.5 32370.2 32385.8 12032.1 12205.1 12205.6 12205.6 12213.6 9636.0 9790.4 9799.0 9805.4 9807.9 7949.3 7951.6 7991.3 8046.7 8064.4 3146.0 3155.5 3155.9 3184.8 3202.2 825.8 854.9 864.3 889.9 911.7 24755.6 25881.1 26029.6 26061.9 26136.0 871.6 946.3 975.0 982.1 1017.0 13526.8 13790.7 14007.6 14041.2 14184.5 384225.3 387856.0 388182.0 388237.0 389045.0 48191.3 48893.0 49073.0 49097.5 49164.6 1147.5 1151.0 1187.8 1191.6 1200.9 23952.6 25158.9 25165.0 25853.6 26047.5 41907.2 42163.4 42175.0 42198.4 42258.0 262407.0 263332.0 263337.0 263453.0 264417.0 25150.2 25423.4 25569.0 26131.5 27061.6 40050.0 40710.8 40869.0 42171.8 42505.8 35089.8 35098.3 35401.8 35446.6 36038.0 34624.5 34888.7 34955.3 35220.6 35275.0 32687.8 33765.8 33893.5 34081.3 35166.3 29717.0 31939.4 32070.4 32283.2 32353.0 24743.6 24910.4 24990.3 25069.0 25243.9 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | [#2] jquery.html Cycles:180 Average:23474.17 Median:49091.76 stddev:60714.58 (123.7%) stddev-sans-first:60860.07 16:20:24 INFO - PROCESS | 12170 | Values: 347.4 361.0 363.8 372.0 391.9 12149.0 15748.9 16345.0 16696.7 17671.9 16347.3 16523.0 16751.4 17089.1 17196.7 4956.4 5016.9 5130.5 5164.8 5168.0 3730.5 3925.7 5077.2 5195.0 5237.4 3651.5 3911.7 3963.1 3964.6 3968.3 5927.6 6016.9 6019.3 6045.3 6050.2 5122.9 5278.9 5293.4 5294.5 5303.4 20314.8 20461.4 20479.7 20571.4 20699.3 1923.6 1980.7 2473.9 2482.6 2539.6 12158.4 12871.9 13283.9 13334.6 13773.7 1700.5 1703.0 1775.9 1780.1 1781.2 66405.7 68796.0 69642.7 71232.6 71587.0 9116.1 9290.9 9434.5 9685.5 9752.4 13112.7 13220.5 13228.9 13232.3 13246.3 6734.5 6799.5 6947.4 6978.0 7004.3 6291.5 6336.9 6375.9 6493.0 6509.6 5137.8 5552.4 5594.8 5945.1 6147.5 1613.7 1714.7 1788.6 1792.4 1796.2 829.9 853.8 896.8 918.9 921.0 15067.8 15858.8 16020.8 16568.0 17157.6 811.8 817.8 830.8 830.8 837.6 8953.3 9492.9 9916.0 9978.2 10324.7 333312.0 350523.2 380627.0 383590.0 383988.0 72326.6 75007.2 75321.2 76044.0 77000.6 872.0 895.6 922.9 925.7 927.8 15338.9 15361.2 15662.6 16208.7 16269.2 35496.8 35999.3 36479.6 36569.6 37172.8 48175.5 48719.8 48912.3 49271.3 51524.7 7239.2 7253.0 7476.4 7541.3 7890.6 8028.6 11137.3 11197.3 11401.0 11630.2 9792.0 9921.1 10120.7 10170.5 10857.6 9865.2 10009.3 10011.4 10226.1 10238.2 9761.3 10085.5 10489.1 10588.9 10991.6 7317.9 7352.9 7444.0 7599.5 7644.1 7565.0 8828.7 9456.1 9636.5 9851.7 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | [#3] mootools.html Cycles:180 Average:4831.78 Median:5600.09 stddev:2695.62 (48.1%) stddev-sans-first:2688.93 16:20:24 INFO - PROCESS | 12170 | Values: 1143.7 1159.7 1291.2 1476.0 1485.7 6624.4 6767.1 6804.2 7266.0 7274.0 7022.9 7302.1 7374.8 7573.2 7587.1 1965.7 1989.0 1990.8 1991.9 1994.5 1699.8 2100.9 2117.6 2129.5 2138.6 1757.8 2049.1 2114.8 2122.9 2150.3 2046.0 2064.2 2066.4 2070.5 2072.3 2047.6 2050.3 2051.4 2052.1 2053.9 7468.3 7472.7 7524.3 7537.1 7589.2 4284.3 4402.0 4408.6 4408.9 4411.5 2592.7 2797.1 2804.3 2810.0 2813.7 807.4 815.4 864.6 865.5 869.5 9872.7 9930.3 9957.5 9993.6 10011.8 3660.8 3845.1 3913.2 3917.1 4032.4 8577.5 8582.7 8589.0 8589.4 8601.6 4416.0 4425.4 4427.9 4429.3 4431.5 3981.3 4029.6 4031.2 4038.8 4066.9 3462.6 3512.7 3514.3 3522.7 3526.0 998.0 1075.7 1126.5 1135.7 1154.7 658.6 753.6 774.5 822.2 833.8 4947.3 5049.1 5055.6 5144.2 5159.5 761.9 771.2 783.0 814.4 817.6 3434.9 3458.4 3467.5 3500.0 3575.1 8718.3 8949.1 9074.9 9075.3 9080.3 8891.5 8985.9 9015.3 9018.9 9030.4 6811.7 6872.6 6913.7 6919.4 6921.2 4954.7 5055.2 5093.1 5102.9 5172.7 8106.8 8269.3 8473.1 8489.9 8541.6 8132.0 8226.1 8444.2 8518.8 8525.7 6261.0 6325.6 6368.8 6369.3 6412.1 6911.6 6938.9 6939.0 6982.3 7042.5 5006.3 6318.6 6350.6 6351.2 6501.6 6295.5 6364.8 6371.3 6427.8 6489.2 6027.5 6040.6 6077.2 6083.9 6094.4 4363.7 4377.2 4382.2 4419.8 4525.3 3937.7 3991.5 4097.4 4141.5 4196.9 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | [#4] prototype.html Cycles:180 Average:4147.04 Median:4702.42 stddev:1193.73 (25.4%) stddev-sans-first:1161.38 16:20:24 INFO - PROCESS | 12170 | Values: 286.6 288.5 295.8 298.8 298.8 4593.0 4713.5 4739.7 4768.3 4800.9 4541.4 4628.3 4678.3 4698.4 4706.4 3727.2 3743.9 3744.3 3744.7 3745.3 3565.3 3754.1 3757.5 3758.2 3759.5 3487.9 3737.1 3751.2 3764.5 3766.0 3702.0 3702.7 3720.6 3724.5 3750.4 3289.7 3292.4 3294.2 3296.1 3307.6 4503.9 4566.6 4573.0 4624.5 4627.3 4206.5 4211.4 4222.4 4225.5 4231.6 4896.0 4898.2 4908.7 4933.3 4939.0 3491.3 3580.7 3582.9 3586.5 3603.2 5124.4 5131.5 5133.9 5142.9 5151.2 3654.6 3659.2 3666.9 3671.5 3680.8 3736.3 3736.9 3754.6 3764.7 3766.8 4076.7 4193.7 4213.2 4243.4 4254.9 4924.2 4925.9 4941.7 4943.6 4944.3 1217.8 1249.8 1286.9 1299.4 1304.4 871.6 881.5 888.2 896.9 897.4 4439.4 4452.2 4452.4 4454.9 4462.7 5073.6 5076.6 5078.3 5095.5 5114.7 4307.9 4462.5 4534.5 4580.8 4583.4 2726.1 2738.6 2739.6 2741.7 2757.3 4897.8 4911.0 4915.4 4915.6 4919.5 5087.8 5239.0 5260.4 5272.6 5288.5 4899.7 4904.3 4912.8 4913.5 4916.4 4960.7 5152.6 5168.0 5169.8 5175.5 5029.5 5032.9 5053.0 5059.8 5064.1 4904.0 4905.2 4919.8 4923.9 4930.0 3605.7 3634.0 3651.3 3657.7 3666.6 4931.8 5082.9 5116.4 5149.4 5166.0 4921.0 4931.2 4961.0 5012.3 5014.2 4935.9 4955.7 4968.5 5017.4 5035.2 4678.0 4722.4 4836.8 4905.2 4960.6 4829.3 5004.6 5019.2 5028.6 5060.3 4905.8 4907.9 4914.7 4916.1 4919.4 16:20:24 INFO - PROCESS | 12170 | 16:20:24 INFO - PROCESS | 12170 | [#5] yui.html Cycles:180 Average:16839.08 Median:29802.22 stddev:25224.47 (84.6%) stddev-sans-first:25265.72 16:20:24 INFO - PROCESS | 12170 | Values: 586.8 590.8 649.2 658.0 658.8 11515.5 12218.3 12244.4 12582.3 12602.7 10740.0 12517.4 12637.2 12640.5 12650.7 752.7 771.8 780.2 780.5 780.5 773.4 776.8 780.0 780.4 781.0 822.2 822.9 823.0 823.6 824.5 808.7 809.2 809.4 809.5 810.2 598.4 602.7 603.5 604.2 604.4 10485.8 10591.9 10614.8 10615.3 10620.2 10173.8 10221.5 10323.5 10340.5 10689.1 9117.3 9119.2 9402.5 9404.0 9470.1 3089.3 3105.7 3174.8 3189.6 3291.6 42573.0 43727.6 49646.8 57379.7 58188.0 9572.1 9746.6 9845.4 9906.3 10006.2 18188.5 18206.3 18213.8 18229.1 18229.9 6696.3 6716.0 6717.9 6828.4 6928.1 3537.7 3571.7 3595.7 3647.3 3721.7 2483.8 2595.2 2598.0 2601.6 2603.4 452.6 460.5 465.6 466.1 472.4 431.5 482.8 508.9 513.3 516.0 7339.6 7680.9 7821.2 8260.3 8477.0 455.9 463.2 525.9 532.4 574.0 3553.9 3655.0 3773.4 3934.0 3951.9 98297.0 101701.5 102405.0 104485.5 104908.5 85632.0 85678.0 86185.0 86893.5 87270.1 46528.5 59006.0 74137.6 75554.6 75964.6 7110.3 7409.7 7425.6 7532.5 7607.6 43179.6 43997.3 44073.8 44672.0 44854.8 60122.7 60205.0 64101.4 66718.0 67270.7 9367.3 9509.4 9512.7 9546.5 9762.4 10957.0 11179.6 11180.1 11891.6 12135.6 9257.1 9377.5 9538.7 9833.3 9840.4 9902.6 10364.7 10659.4 10839.8 11165.7 9486.2 9976.3 10094.8 10144.4 10517.9 8790.4 9138.2 9162.3 9390.0 9764.6 8366.3 8608.8 8980.2 8998.7 9128.7 16:20:24 INFO - PROCESS | 12170 | -------- Summary: end -------- 16:20:24 INFO - PROCESS | 12170 | 16:20:25 INFO - TEST-INFO | 12170: exit 0 16:20:25 INFO - TEST-OK | dromaeo_css | took 1123415ms 16:20:25 INFO - TEST-START | kraken 16:20:25 INFO - operating with platform_type : linux_ 16:20:25 INFO - Initialising browser for kraken test... 16:20:25 INFO - TEST-INFO | started process 12476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEitI1e/profile http://localhost:59006/getInfo.html) 16:20:30 INFO - PROCESS | 12476 | __metrics Screen width/height:1600/1200 16:20:30 INFO - PROCESS | 12476 | colorDepth:24 16:20:30 INFO - PROCESS | 12476 | Browser inner width/height: 1024/697 16:20:30 INFO - PROCESS | 12476 | __metrics 16:20:30 INFO - PROCESS | 12476 | 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" 16:20:30 INFO - PROCESS | 12476 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:20:31 INFO - PROCESS | 12476 | console.error: PushService: 16:20:31 INFO - PROCESS | 12476 | stateChangeProcessEnqueue: Error transitioning state 16:20:31 INFO - PROCESS | 12476 | UnknownError 16:20:32 INFO - TEST-INFO | 12476: exit 0 16:20:32 INFO - Browser initialized. 16:20:32 INFO - Running cycle 1/1 for kraken test... 16:20:32 INFO - TEST-INFO | started process 12557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEitI1e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:44 INFO - PROCESS | 12557 | RSS: Main: 175468544 16:20:44 INFO - PROCESS | 12557 | 16:20:47 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59006/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:48 INFO - PROCESS | 12557 | RSS: Main: 238276608 16:20:48 INFO - PROCESS | 12557 | 16:20:51 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59006/tests/kraken/driver.html?testName=audio-dft) 16:20:51 INFO - PROCESS | 12557 | RSS: Main: 218951680 16:20:51 INFO - PROCESS | 12557 | 16:20:54 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59006/tests/kraken/driver.html?testName=audio-fft) 16:20:55 INFO - PROCESS | 12557 | RSS: Main: 301600768 16:20:55 INFO - PROCESS | 12557 | 16:20:57 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59006/tests/kraken/driver.html?testName=audio-oscillator) 16:20:58 INFO - PROCESS | 12557 | RSS: Main: 211714048 16:20:58 INFO - PROCESS | 12557 | 16:21:00 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59006/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:01 INFO - PROCESS | 12557 | RSS: Main: 214458368 16:21:01 INFO - PROCESS | 12557 | 16:21:04 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59006/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:05 INFO - PROCESS | 12557 | RSS: Main: 250388480 16:21:05 INFO - PROCESS | 12557 | 16:21:08 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59006/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:09 INFO - PROCESS | 12557 | RSS: Main: 250028032 16:21:09 INFO - PROCESS | 12557 | 16:21:11 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59006/tests/kraken/driver.html?testName=json-parse-financial) 16:21:12 INFO - PROCESS | 12557 | RSS: Main: 249491456 16:21:12 INFO - PROCESS | 12557 | 16:21:14 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59006/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:14 INFO - PROCESS | 12557 | RSS: Main: 211709952 16:21:14 INFO - PROCESS | 12557 | 16:21:16 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:17 INFO - PROCESS | 12557 | RSS: Main: 219410432 16:21:17 INFO - PROCESS | 12557 | 16:21:19 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:20 INFO - PROCESS | 12557 | RSS: Main: 227979264 16:21:20 INFO - PROCESS | 12557 | 16:21:23 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:23 INFO - PROCESS | 12557 | RSS: Main: 237232128 16:21:23 INFO - PROCESS | 12557 | 16:21:26 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:27 INFO - PROCESS | 12557 | RSS: Main: 233488384 16:21:27 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | Cycle 1(1): loaded http://localhost:59006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59006/tests/kraken/driver.html?testName=ai-astar) 16:21:29 INFO - PROCESS | 12557 | RSS: Main: 285294592 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | __start_tp_report 16:21:29 INFO - PROCESS | 12557 | _x_x_mozilla_page_load 16:21:29 INFO - PROCESS | 12557 | _x_x_mozilla_page_load_details 16:21:29 INFO - PROCESS | 12557 | |i|pagename|runs| 16:21:29 INFO - PROCESS | 12557 | |0;ai-astar;113;115;115;115;114;115;113;114;113;114 16:21:29 INFO - PROCESS | 12557 | |1;audio-beat-detection;157;126;126;169;133;131;125;125;159;126 16:21:29 INFO - PROCESS | 12557 | |2;audio-dft;160;162;162;162;162;161;163;161;161;162 16:21:29 INFO - PROCESS | 12557 | |3;audio-fft;76;76;76;111;78;77;77;77;106;76 16:21:29 INFO - PROCESS | 12557 | |4;audio-oscillator;83;84;123;82;83;83;114;85;84;115 16:21:29 INFO - PROCESS | 12557 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 16:21:29 INFO - PROCESS | 12557 | |6;imaging-darkroom;146;146;145;147;146;146;146;146;146;147 16:21:29 INFO - PROCESS | 12557 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;95;96 16:21:29 INFO - PROCESS | 12557 | |8;json-parse-financial;63;63;62;62;64;63;64;64;64;64 16:21:29 INFO - PROCESS | 12557 | |9;json-stringify-tinderbox;65;65;65;66;66;66;65;68;66;67 16:21:29 INFO - PROCESS | 12557 | |10;stanford-crypto-aes;84;83;83;83;90;83;87;87;83;83 16:21:29 INFO - PROCESS | 12557 | |11;stanford-crypto-ccm;147;140;157;140;147;139;139;139;178;137 16:21:29 INFO - PROCESS | 12557 | |12;stanford-crypto-pbkdf2;175;174;178;178;178;176;172;172;172;172 16:21:29 INFO - PROCESS | 12557 | |13;stanford-crypto-sha256-iterative;70;72;71;71;70;74;74;75;68;69 16:21:29 INFO - PROCESS | 12557 | __end_tp_report 16:21:29 INFO - PROCESS | 12557 | __start_cc_report 16:21:29 INFO - PROCESS | 12557 | _x_x_mozilla_cycle_collect,1894 16:21:29 INFO - PROCESS | 12557 | __end_cc_report 16:21:29 INFO - PROCESS | 12557 | __startTimestamp1475536889443__endTimestamp 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | ------- Summary: start ------- 16:21:29 INFO - PROCESS | 12557 | Number of tests: 14 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:0.88 (0.8%) stddev-sans-first:0.83 16:21:29 INFO - PROCESS | 12557 | Values: 113.0 115.0 115.0 115.0 114.0 115.0 113.0 114.0 113.0 114.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:132.00 stddev:17.02 (12.9%) stddev-sans-first:16.55 16:21:29 INFO - PROCESS | 12557 | Values: 157.0 126.0 126.0 169.0 133.0 131.0 125.0 125.0 159.0 126.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.67 16:21:29 INFO - PROCESS | 12557 | Values: 160.0 162.0 162.0 162.0 162.0 161.0 163.0 161.0 161.0 162.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.51 (17.7%) stddev-sans-first:14.09 16:21:29 INFO - PROCESS | 12557 | Values: 76.0 76.0 76.0 111.0 78.0 77.0 77.0 77.0 106.0 76.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:16.56 (20.0%) stddev-sans-first:17.12 16:21:29 INFO - PROCESS | 12557 | Values: 83.0 84.0 123.0 82.0 83.0 83.0 114.0 85.0 84.0 115.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:21:29 INFO - PROCESS | 12557 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:21:29 INFO - PROCESS | 12557 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:21:29 INFO - PROCESS | 12557 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 16:21:29 INFO - PROCESS | 12557 | Values: 63.0 63.0 62.0 62.0 64.0 63.0 64.0 64.0 64.0 64.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 16:21:29 INFO - PROCESS | 12557 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 65.0 68.0 66.0 67.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.50 stddev:2.50 (3.0%) stddev-sans-first:2.65 16:21:29 INFO - PROCESS | 12557 | Values: 84.0 83.0 83.0 83.0 90.0 83.0 87.0 87.0 83.0 83.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:143.50 stddev:12.68 (8.8%) stddev-sans-first:13.44 16:21:29 INFO - PROCESS | 12557 | Values: 147.0 140.0 157.0 140.0 147.0 139.0 139.0 139.0 178.0 137.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.50 stddev:2.67 (1.5%) stddev-sans-first:2.83 16:21:29 INFO - PROCESS | 12557 | Values: 175.0 174.0 178.0 178.0 178.0 176.0 172.0 172.0 172.0 172.0 16:21:29 INFO - PROCESS | 12557 | 16:21:29 INFO - PROCESS | 12557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:2.32 (3.2%) stddev-sans-first:2.40 16:21:29 INFO - PROCESS | 12557 | Values: 70.0 72.0 71.0 71.0 70.0 74.0 74.0 75.0 68.0 69.0 16:21:29 INFO - PROCESS | 12557 | -------- Summary: end -------- 16:21:29 INFO - PROCESS | 12557 | 16:21:30 INFO - TEST-INFO | 12557: exit 0 16:21:30 INFO - TEST-OK | kraken | took 65288ms 16:21:30 INFO - SUITE-END | took 1188s 16:21:31 INFO - Completed test suite (00:19:49) 16:21:31 INFO - javascript benchmark 16:21:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.0, 2606.530824451598, 2607.4394005288864, 2652.4164683769577, 2667.1731763153425, 4565.7717114144325, 4645.837395691152, 4672.112298663252, 4698.483166851648, 4726.692764970275, 4690.57784799368, 4697.084068606623, 4727.22000869856, 4784.258439941806, 4827.8310259140935, 4196.538380778112, 4259.275923093066, 4303.203907277148, 4325.0, 4338.479382474092, 4052.149048699762, 4341.587549182823, 4342.522322544518, 4381.737095774264, 4430.26900561407, 4253.404523366731, 4344.413504176927, 4359.149965756678, 4448.221561226788, 4481.014176881081, 4263.296556068245, 4287.442632457761, 4300.161468513641, 4304.569543045702, 4353.085851971058, 4256.08494173751, 4256.914861702749, 4272.9145417091795, 4317.956820431818, 4326.307790753496, 4682.0, 4685.812567497296, 4703.15343238217, 4706.082313948781, 4713.764311784432, 4816.54242846929, 4863.124637565237, 4906.092372911023, 4942.283368911523, 4989.900201995976, 5032.345795046657, 5036.823711170128, 5040.218766091225, 5080.263361812516, 5086.949130508685, 4669.39297891272, 4681.578657920803, 4682.929756053662, 4688.203005489075, 4740.1230772307235, 4957.3059771632, 5052.671576347526, 5068.670536415121, 5147.099257629975, 5200.0, 4890.804367825318, 4911.336969509142, 4918.0901533216465, 4973.52751488608, 4975.4527002029745, 5002.499750025041, 5012.523810238022, 5013.89972200554, 5015.04714104319, 5077.390713114376, 4827.468978412372, 4954.3063971044085, 4959.13215187348, 5026.195808670595, 5026.949730502648, 4862.197737373364, 4884.462709101996, 4908.607311415079, 4934.1118598651865, 4938.037082768898, 4245.766482843412, 4252.659787217015, 4253.128108737701, 4255.3616957456625, 4256.212600668886, 3676.742628016013, 3696.094456858033, 3777.962220377816, 3790.962090379116, 3791.0332865119217, 4351.543087975717, 4355.346697995263, 4368.694191406571, 4416.66874984371, 4456.197884380843, 5064.392272927199, 5067.771950262247, 5070.645054846199, 5072.4673909239, 5087.364079490064, 4296.699231053859, 4337.566243375701, 4376.081022985209, 4406.1187762447, 4409.470863496401, 4571.9314210286875, 4596.2416201326405, 4597.632189424838, 4605.148047611203, 4658.114958157939, 4799.232122860465, 4804.279358096313, 4826.32431459603, 4866.756662166948, 4869.488703686062, 4887.706737595756, 4944.92582611254, 5006.5994720423005, 5113.284140220447, 5121.334226550524, 4763.261694437368, 4773.498782627913, 4778.593819525379, 4813.229883218668, 4823.2282834746275, 4982.626303027215, 4985.651004429655, 4989.900201996013, 4994.1260279450225, 5049.621278404061, 4925.9014819704125, 4986.9251961221335, 5032.119379108714, 5042.445331013659, 5099.592032637306, 4815.133276010211, 4856.247281671346, 4875.829345972874, 4893.339399181065, 4947.579455746302, 4881.341018962395, 4883.316335712932, 4884.535969082932, 4885.90228195427, 4950.084234416644, 4655.790489428052, 4800.183968725395, 4804.615630749601, 4811.663183577116, 4879.56083952446, 4804.42346918372, 4849.4908034655855, 4878.658493905393, 4901.754912254301, 4976.925346119883, 4798.088363210979, 4815.831445899376, 4820.517948205152, 4822.758862056813, 4882.92675609859], "value": 4612.354189363118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.723211162307, 545.1250742558194, 561.7556362982102, 561.9631779367071, 562.741139076025, 27661.861690691545, 37773.81113094438, 39182.21635567287, 39256.60743392569, 43014.7849260754, 40524.59475405245, 40902.59097409025, 40979.59020409795, 40985.0, 40989.0, 7596.012518372618, 7744.651490682904, 7747.147813740484, 7751.6124193790365, 7752.379809615245, 7532.661030253625, 7611.238876112372, 7622.961885190566, 7626.275503827128, 7626.961865190667, 7577.962110189469, 7643.044619422572, 7653.540787552737, 7658.617069146549, 7658.846823063535, 7613.124490683559, 7648.120466146409, 7651.273129052731, 7659.195784442665, 7664.693412263503, 7514.549127052394, 7575.242475752436, 7583.62081895903, 7594.924050759532, 7598.696052157907, 37533.81233093817, 37918.81040594779, 37955.620443795764, 37978.81010594957, 37991.81004094962, 2934.457125431802, 2984.1196846930206, 3003.0, 3023.6069310989433, 3066.8159910405225, 28435.289117772016, 28592.714072859213, 28679.713202868123, 29127.708722912925, 30615.0, 2641.8414895106357, 2686.9731302687114, 2694.528457519926, 2701.0, 2792.9581056284173, 246187.0, 247425.0, 247474.76262618753, 247560.0, 247985.9999999982, 31185.376292474022, 50421.747891261046, 50618.49381506212, 50755.23867141996, 50839.74580127076, 32212.516812247835, 32323.676763232535, 32365.51451728226, 32370.190745231557, 32385.838070809496, 12032.09759268041, 12205.145639805305, 12205.633830984907, 12205.633830985085, 12213.633590992284, 9636.036396360449, 9790.363626364264, 9798.951005245071, 9805.411675299505, 9807.901920980841, 7949.284564389117, 7951.602419878983, 7991.2807847294025, 8046.678132874619, 8064.354851611857, 3145.984270078635, 3155.542446345313, 3155.9053228403186, 3184.7611429142908, 3202.2154572129975, 825.8059356051323, 854.8803167556547, 864.312871267344, 889.8754174415587, 911.7492689510306, 24755.62866557003, 25881.09416170425, 26029.609555856678, 26061.869690651427, 26136.0, 871.6426265231352, 946.3044662173297, 974.9512524373753, 982.106283282224, 1016.9542370593341, 13526.797098043537, 13790.65523361924, 14007.579772606838, 14041.227732474812, 14184.503542375967, 384225.261979041, 387856.0, 388182.0, 388237.0, 389045.0, 48191.27713084307, 48893.0, 49073.0, 49097.50902491001, 49164.625306204354, 1147.4893672315739, 1151.0, 1187.8396416483838, 1191.5591231244496, 1200.9219400738923, 23952.576216794547, 25158.874205628854, 25165.0, 25853.612195817455, 26047.479050419264, 41907.161856763305, 42163.36754948617, 42175.0, 42198.367024495274, 42258.0, 262407.0, 263332.0, 263337.0, 263453.0, 264417.0, 25150.24549263525, 25423.36441588975, 25569.0, 26131.477370452863, 27061.59407608927, 40050.0, 40710.79644601758, 40869.0, 42171.78914105533, 42505.787471062446, 35089.824550877085, 35098.298034038664, 35401.82299088488, 35446.645533545365, 36038.0, 34624.48063279002, 34888.65111348854, 34955.30089398147, 35220.64779352173, 35275.0, 32687.836560817042, 33765.83117084399, 33893.491597625565, 34081.31837363189, 35166.29667406587, 29717.0, 31939.36121277515, 32070.358592827546, 32283.19292017718, 32353.044095519577, 24743.62884556769, 24910.37724056913, 24990.250292491255, 25069.0, 25243.87378063098], "value": 15817.586146900903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.43368309655256, 360.97292703047276, 363.77264209868827, 371.99070023249413, 391.9274934137185, 12149.0, 15748.921255393721, 16345.0, 16696.74954875678, 17671.911640441813, 16347.34610615577, 16523.0, 16751.413700520483, 17089.060101694402, 17196.656066878688, 4956.355673762415, 5016.949830501703, 5130.486951304877, 5164.819231326905, 5167.974160129194, 3730.4963829883027, 3925.725199236055, 5077.187649976005, 5195.0, 5237.423883372826, 3651.5070465487083, 3911.706622003347, 3963.1479231965122, 3964.6035396460265, 3968.2658708138943, 5927.644341339534, 6016.879662406749, 6019.277686677583, 6045.274567051982, 6050.2437195350585, 5122.897542049138, 5278.9208161877605, 5293.417724050351, 5294.52349288562, 5303.443138470444, 20314.79685203144, 20461.386158415273, 20479.69280460794, 20571.38285851427, 20699.27552535654, 1923.5671973805922, 1980.7226988221516, 2473.888675009629, 2482.615194644833, 2539.6444497770326, 12158.392080395945, 12871.871281287162, 13283.86716132836, 13334.599962001155, 13773.724525509433, 1700.523853321072, 1702.9659406811918, 1775.9289628414847, 1780.0565700178927, 1781.1895587507654, 66405.66797165983, 68796.0, 69642.65178674125, 71232.64383678048, 71587.0, 9116.128419547822, 9290.88509378879, 9434.481103539234, 9685.515724213761, 9752.366096203867, 13112.737745245233, 13220.471181152647, 13228.867711322957, 13232.272225027524, 13246.271455069871, 6734.46124310054, 6799.456043516507, 6947.444204463631, 6978.0, 7004.334588214111, 6291.528135389773, 6336.904946425807, 6375.936240637627, 6492.967535162294, 6509.576877502947, 5137.8201762938115, 5552.3892371839065, 5594.776208951596, 5945.137954996501, 6147.477464415485, 1613.7014652289129, 1714.691355555987, 1788.624388878324, 1792.3816283382212, 1796.2006906926292, 829.8713699376606, 853.8249658819927, 896.820635872828, 918.9172974432333, 920.9953950230206, 15067.849321506865, 15858.762118568231, 16020.839791602168, 16568.0, 17157.57106072333, 811.8173410982482, 817.8037271054905, 830.7839961610025, 830.8006078541227, 837.6021389839899, 8953.328500362499, 9492.90507094934, 9915.950420247853, 9978.201743860474, 10324.741881452874, 333312.0, 350523.1636779954, 380627.0, 383590.0, 383988.0, 72326.63836680783, 75007.24992750112, 75321.24678753142, 76044.0, 77000.61499692466, 871.9869201962102, 895.5656506594297, 922.9400088994194, 925.6852670092067, 927.758782716485, 15338.923305383401, 15361.155136467602, 15662.608434788766, 16208.67582648364, 16269.186540673156, 35496.82251588725, 35999.28001440009, 36479.635203647624, 36569.634303656625, 37172.81413592915, 48175.51824481851, 48719.75640121919, 48912.266316006004, 49271.260931085344, 51524.742376287875, 7239.203687594466, 7253.0, 7476.401887849068, 7541.283578060075, 7890.605469726376, 8028.59857007159, 11137.331760094095, 11197.328160310408, 11401.0, 11630.185886987829, 9792.0, 9921.107100361001, 10120.746981325527, 10170.542325595514, 10857.565697372333, 9865.161461275871, 10009.299349045497, 10011.399316041061, 10226.130778883879, 10238.18094552449, 9761.316707830383, 10085.495725213857, 10489.108425783894, 10588.947055264674, 10991.61529346469, 7317.853642927218, 7352.889706654511, 7444.0, 7599.4680372375615, 7644.120926093348, 7565.0, 8828.735137945872, 9456.148946594565, 9636.46999415039, 9851.655192068243], "value": 8111.594350850032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1143.7026373142985, 1159.6521043686892, 1291.1994563370708, 1476.0331982551434, 1485.7251408489424, 6624.370684784938, 6767.0864433301485, 6804.2175149857785, 7265.963670181648, 7273.963630181842, 7022.9297707022915, 7302.050733404663, 7374.778756637296, 7573.1669516353295, 7587.127480339763, 1965.6953172258286, 1988.980110198894, 1990.8208261256484, 1991.8705284156483, 1994.451525830401, 1699.7620333153368, 2100.9264675736354, 2117.587070521249, 2129.5315030693223, 2138.615049291127, 1757.8242175782384, 2049.077914938284, 2114.8413868959815, 2122.8726276423463, 2150.3011521255653, 2045.9974612439946, 2064.2465500092508, 2066.4214020074255, 2070.523779530716, 2072.2643461571074, 2047.648551955717, 2050.3131450963947, 2051.3845846246068, 2052.0970772859896, 2053.917843286267, 7468.2531746825425, 7472.738454154133, 7524.28519290672, 7537.0955485341565, 7589.165191828894, 4284.314509678467, 4401.977990110029, 4408.6032257096695, 4408.867733967986, 4411.514733379326, 2592.7148013718474, 2797.146870204587, 2804.3129433288973, 2810.0445848411637, 2813.7326953939546, 807.3581502705305, 815.384384789486, 864.5547543015289, 865.485036403339, 869.4565896314804, 9872.654457094039, 9930.255230857714, 9957.502124893726, 9993.600255989752, 10011.79976400468, 3660.816959152032, 3845.0964023454467, 3913.2369188008634, 3917.1186483041656, 4032.395140728914, 8577.528235947082, 8582.699605513902, 8589.0, 8589.398742088119, 8601.61292741828, 4415.955840441618, 4425.35832304314, 4427.933580996223, 4429.2913133899065, 4431.490378606437, 3981.283368993551, 4029.6373326400767, 4031.2061132795625, 4038.7778672172726, 4066.8576599818866, 3462.6191118976894, 3512.6838584527513, 3514.332276867387, 3522.7357948153476, 3526.0, 997.9900200997897, 1075.6772968109535, 1126.5268587193398, 1135.6649788312468, 1154.7113221694576, 658.6377492379172, 753.5704648350388, 774.5275382016965, 822.2188920525405, 833.7707130539151, 4947.282644016597, 5049.141645920203, 5055.620828437882, 5144.202648589475, 5159.458256883048, 761.9123800762873, 771.2133623703903, 782.984340313202, 814.4014149600039, 817.5993763056059, 3434.9484757728655, 3458.4466485362223, 3467.4798780183173, 3499.9650003499637, 3575.1419659281587, 8718.346124040723, 8949.149830766068, 9074.86387704185, 9075.319351048565, 9080.31897607682, 8891.4665120093, 8985.865212021825, 9015.323850711091, 9018.909810901938, 9030.413023153475, 6811.727530898807, 6872.587644741331, 6913.654317284116, 6919.446444284546, 6921.204061532888, 4954.702717836942, 5055.216441451581, 5093.083245015784, 5102.872428189176, 5172.71550064735, 8106.83786324282, 8269.338452923872, 8473.067962523994, 8489.915100848912, 8541.615627296911, 8132.0, 8226.095129535866, 8444.240018398374, 8518.829623407373, 8525.701600443954, 6260.968695156495, 6325.588836725598, 6368.808935731936, 6369.299377068612, 6412.102305677302, 6911.619860907698, 6938.93061069403, 6939.0, 6982.301769822977, 7042.542234754725, 5006.299118123538, 6318.557700960889, 6350.618962862243, 6351.2060992375955, 6501.609903405811, 6295.527835412271, 6364.840878977878, 6371.299157092623, 6427.775027874002, 6489.156409666713, 6027.457528822427, 6040.607360521552, 6077.24034495688, 6083.908741368795, 6094.421030002142, 4363.716358436692, 4377.190219809346, 4382.167388196232, 4419.80198019802, 4525.253333200117, 3937.7440466369594, 3991.5409727880506, 4097.405876148002, 4141.461609990682, 4196.853110141131], "value": 3884.3966211900406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.62309063581387, 288.5239355064144, 295.79590082842844, 298.75949860362397, 298.8431073686316, 4593.03749081842, 4713.505081966391, 4739.7059043964455, 4768.284757286408, 4800.927986080212, 4541.409616749818, 4628.305754136881, 4678.251479763238, 4698.436187657478, 4706.411698537683, 3727.235916637083, 3743.9251214975684, 3744.3447396705606, 3744.7191460640424, 3745.3445647011663, 3565.3047655707146, 3754.117782321166, 3757.4739536464917, 3758.2295629396044, 3759.4924685167425, 3487.860485580574, 3737.140457694732, 3751.249750049987, 3764.454154147647, 3765.9831845401727, 3701.9629803701887, 3702.7222958277966, 3720.6093360197196, 3724.510195921626, 3750.4186851038135, 3289.7039266465895, 3292.44028515153, 3294.225856923621, 3296.126526470487, 3307.570015897918, 4503.932441013388, 4566.611837993742, 4572.977135114304, 4624.5144259852905, 4627.305904114376, 4206.495220573551, 4211.389348544474, 4222.408862759216, 4225.535191128974, 4231.576842315774, 4895.9510404895855, 4898.2162853943555, 4908.7300198489065, 4933.309336692866, 4938.975305123451, 3491.3366460372704, 3580.7314451416246, 3582.874599389009, 3586.4799604057266, 3603.1532589841368, 5124.385073791169, 5131.512506311894, 5133.948660513384, 5142.922856157161, 5151.175811870083, 3654.634536546377, 3659.1949771050326, 3666.926661466756, 3671.4676371926457, 3680.834362453696, 3736.308782875177, 3736.9065773355883, 3754.5869954305003, 3764.6800021997888, 3766.811659417073, 4076.694247931417, 4193.7483750974425, 4213.199492096492, 4243.384709217208, 4254.936175957301, 4924.187509060965, 4925.87685307863, 4941.65408421407, 4943.604511639061, 4944.283078953532, 1217.7564487102616, 1249.787536118862, 1286.8713128687057, 1299.402274953532, 1304.4064950447523, 871.5642178910545, 881.4750481666624, 888.1828717579842, 896.9237614802815, 897.3808072430003, 4439.448441246989, 4452.220861349251, 4452.398926144929, 4454.86635400932, 4462.687611867138, 5073.594112470993, 5076.6446348755235, 5078.263651770472, 5095.541401273903, 5114.744262786846, 4307.870763877088, 4462.464504259445, 4534.478534968455, 4580.831887868639, 4583.358329833826, 2726.086760935109, 2738.5755207942802, 2739.6164536964843, 2741.684706258766, 2757.2831063923522, 4897.8285759998225, 4911.0, 4915.3855768029, 4915.58217551505, 4919.458859525521, 5087.771050302746, 5239.0, 5260.447652996457, 5272.551833094153, 5288.524032837063, 4899.706017638953, 4904.288878112654, 4912.803487860517, 4913.533214344631, 4916.434610019751, 4960.70235785854, 5152.608795625085, 5167.974160129175, 5169.81905633301, 5175.508326708957, 5029.547340739205, 5032.917922646649, 5052.9747351263, 5059.797608095635, 5064.139096353702, 4904.008554781509, 4905.190643543775, 4919.827806026772, 4923.901521969469, 4929.975350123226, 3605.729570282187, 3633.9636603633626, 3651.287998840307, 3657.725670574771, 3666.633336666312, 4931.802727890844, 5082.916004438162, 5116.411612664591, 5149.382074150976, 5165.974170129125, 4920.950790492049, 4931.235658472942, 4960.975195124001, 5012.343457967283, 5014.247862820606, 4935.851924442272, 4955.6531042826655, 4968.453470118212, 5017.397912250407, 5035.219540971156, 4677.976610116928, 4722.433308003062, 4836.75937122136, 4905.2151655734915, 4960.578350840219, 4829.348038014964, 5004.6246531511015, 5019.247112932943, 5028.64799464034, 5060.266261392151, 4905.828296009622, 4907.877303067452, 4914.729689867092, 4916.139675556692, 4919.434265059564], "value": 3769.0321287565052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8268860686097, 590.7814108779752, 649.2187074105093, 657.9671016449176, 658.7826017414254, 11515.48180331886, 12218.32799196044, 12244.448999795008, 12582.307973061477, 12602.684932876682, 10740.0, 12517.43671534783, 12637.178583392073, 12640.494380224804, 12650.683732906682, 752.6951584608242, 771.7723271634882, 780.2470615855698, 780.5355813291083, 780.5394817057935, 773.3735674103966, 776.8252143267777, 780.0171783552736, 780.4341852157197, 780.9960950195269, 822.2147848804377, 822.8683410654296, 823.0329362998452, 823.5758584329076, 824.4640983360804, 808.7169490678274, 809.1786836361098, 809.4414853750893, 809.5385630190793, 810.2059981218439, 598.4344794169511, 602.6625089949642, 603.4659326496038, 604.1722839709626, 604.3684349854369, 10485.842712359321, 10591.894081059168, 10614.840777388345, 10615.31000484966, 10620.150387968944, 10173.84739228912, 10221.488925553693, 10323.535440905178, 10340.534675939525, 10689.091427228695, 9117.270618350516, 9119.215525556885, 9402.482863442508, 9403.952980235123, 9470.14768670816, 3089.304906396043, 3105.673904240045, 3174.825384603846, 3189.6331921829055, 3291.637919828817, 42573.0, 43727.56272437298, 49646.75176624094, 57379.71310143422, 58188.0, 9572.138507534217, 9746.561404736804, 9845.409275443497, 9906.306558540977, 10006.19950403966, 18188.454346369632, 18206.271749130152, 18213.817861821477, 18229.088545572667, 18229.908850455664, 6696.330366963362, 6716.0, 6717.865642687118, 6828.351306625863, 6928.064711264015, 3537.7346698997676, 3571.7321200909514, 3595.7303202259413, 3647.28877868813, 3721.7394782364972, 2483.838550494212, 2595.247378260321, 2598.0, 2601.622764699108, 2603.388203772112, 452.6039715249157, 460.4957571459247, 465.62982428969053, 466.1050782497613, 472.4260024070771, 431.47144747683836, 482.8382491865194, 508.87532554523636, 513.2942204468856, 515.9767810448539, 7339.559626422431, 7680.923190768132, 7821.178776228528, 8260.339172866155, 8476.982762068592, 455.9361689363492, 463.1917304303944, 525.9244844293429, 532.4196625678029, 573.9770409183669, 3553.9111522211633, 3654.9634503655157, 3773.4339849022867, 3933.9803300983313, 3951.8616848410165, 98297.0, 101701.49149254354, 102405.0, 104485.47757261318, 104908.47545762375, 85632.0, 85678.0, 86185.0, 86893.48298877483, 87270.1272987262, 46528.5347146531, 59006.0, 74137.62931185418, 75554.62222688961, 75964.62017689877, 7110.25342339047, 7409.666565004695, 7425.554466732014, 7532.54804711719, 7607.581583012988, 43179.568204317555, 43997.34003990007, 44073.77963110292, 44672.0, 44854.77572612116, 60122.69938650454, 60205.0, 64101.35898640954, 66718.0, 67270.66364668145, 9367.297452691211, 9509.42943423369, 9512.667056653261, 9546.52267386614, 9762.365446246255, 10957.0, 11179.60871369498, 11180.105591552494, 11891.643250702493, 12135.575254866037, 9257.074292570689, 9377.484238366955, 9538.713838584854, 9833.311668183445, 9840.3603765755, 9902.554385052546, 10364.689059328231, 10659.360438373722, 10839.783204336027, 11165.720856978316, 9486.241100711788, 9976.2517811163, 10094.8485772712, 10144.391336519833, 10517.9474102629, 8790.384673072824, 9138.177564019004, 9162.31282653817, 9389.953050234704, 9764.609415623296, 8366.290089095324, 8608.827823443622, 8980.236679882284, 8998.685046023358, 9128.726138215865], "value": 6075.74885797956, "unit": "score"}], "name": "dromaeo_css", "value": 6122.024354301247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 115.0, 114.0, 115.0, 113.0, 114.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 126.0, 169.0, 133.0, 131.0, 125.0, 125.0, 159.0, 126.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 111.0, 78.0, 77.0, 77.0, 77.0, 106.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 123.0, 82.0, 83.0, 83.0, 114.0, 85.0, 84.0, 115.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 68.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 90.0, 83.0, 87.0, 87.0, 83.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 157.0, 140.0, 147.0, 139.0, 139.0, 139.0, 178.0, 137.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 178.0, 178.0, 178.0, 176.0, 172.0, 172.0, 172.0, 172.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 71.0, 71.0, 70.0, 74.0, 74.0, 75.0, 68.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1554.6, "alertThreshold": 2.0}]} 16:21:31 INFO - Return code: 0 16:21:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:21:31 INFO - # TBPL SUCCESS # 16:21:31 INFO - Running post-action listener: _resource_record_post_action 16:21:31 INFO - [mozharness: 2016-10-03 23:21:31.243278Z] Finished run-tests step (success) 16:21:31 INFO - Running post-run listener: _resource_record_post_run 16:21:31 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392151040; Read time: 16; Write time: 306196 16:21:31 INFO - TinderboxPrint: CPU usage
13.0% 16:21:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:21:31 INFO - TinderboxPrint: I/O write bytes / time
392,151,040 / 306,196 16:21:31 INFO - TinderboxPrint: CPU idle
8,363.0 (87.0%) 16:21:31 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 16:21:31 INFO - TinderboxPrint: Swap in / out
0 / 0 16:21:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103120896; Read time: 0; Write time: 114048 16:21:31 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289030144; Read time: 16; Write time: 192148 16:21:31 INFO - Running post-run listener: _upload_blobber_files 16:21:31 INFO - Blob upload gear active. 16:21:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:31 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 16:21:31 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'] 16:21:31 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 16:21:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:21:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:35 INFO - (blobuploader) - INFO - Done attempting. 16:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:36 INFO - (blobuploader) - INFO - Done attempting. 16:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:36 INFO - (blobuploader) - INFO - Done attempting. 16:21:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:36 INFO - Return code: 0 16:21:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2841364b96f4fb3997fb0e19649e690edb602f82cc0e612d9925f85a24c08ce7f5593ab996299ed6e7e7b83a67c83fadf86664f2fa8adbecc2271b86686c396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c49362cd5001ebacdf917943f3155c4348f26f0ea75d692b16fe96bb09bd764daf9e6abfc6ce0b3c3d304ed86bc9c9389d3de8dde784a59cd5de116db1f79c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/69007a35e5ea1e7d26e0730c91088dac3c0396d58ec2234ce5c2ad03ff46586bcf80bcdbd720c6f1f1921c1e5507221254bba58e448b5d4f2d5159cf4548408f"} 16:21:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:36 INFO - Contents: 16:21:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2841364b96f4fb3997fb0e19649e690edb602f82cc0e612d9925f85a24c08ce7f5593ab996299ed6e7e7b83a67c83fadf86664f2fa8adbecc2271b86686c396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c49362cd5001ebacdf917943f3155c4348f26f0ea75d692b16fe96bb09bd764daf9e6abfc6ce0b3c3d304ed86bc9c9389d3de8dde784a59cd5de116db1f79c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/69007a35e5ea1e7d26e0730c91088dac3c0396d58ec2234ce5c2ad03ff46586bcf80bcdbd720c6f1f1921c1e5507221254bba58e448b5d4f2d5159cf4548408f"} 16:21:36 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:36 INFO - Copying logs to upload dir... 16:21:36 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.043170 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-03 16:21:35.073482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 16:21:35.077124) ========= 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=fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633 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/a2841364b96f4fb3997fb0e19649e690edb602f82cc0e612d9925f85a24c08ce7f5593ab996299ed6e7e7b83a67c83fadf86664f2fa8adbecc2271b86686c396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c49362cd5001ebacdf917943f3155c4348f26f0ea75d692b16fe96bb09bd764daf9e6abfc6ce0b3c3d304ed86bc9c9389d3de8dde784a59cd5de116db1f79c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/69007a35e5ea1e7d26e0730c91088dac3c0396d58ec2234ce5c2ad03ff46586bcf80bcdbd720c6f1f1921c1e5507221254bba58e448b5d4f2d5159cf4548408f"} build_url:https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011539 build_url: 'https://queue.taskcluster.net/v1/task/YGm7p7CuQbqvZzUsiSc9zA/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/a2841364b96f4fb3997fb0e19649e690edb602f82cc0e612d9925f85a24c08ce7f5593ab996299ed6e7e7b83a67c83fadf86664f2fa8adbecc2271b86686c396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c49362cd5001ebacdf917943f3155c4348f26f0ea75d692b16fe96bb09bd764daf9e6abfc6ce0b3c3d304ed86bc9c9389d3de8dde784a59cd5de116db1f79c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/69007a35e5ea1e7d26e0730c91088dac3c0396d58ec2234ce5c2ad03ff46586bcf80bcdbd720c6f1f1921c1e5507221254bba58e448b5d4f2d5159cf4548408f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 16:21:35.103766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:21:35.104141) ========= 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=fa44defc139c4ba8574fe040000001db-1475535646.452252-700251633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:21:35.185906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 16:21:35.186270) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 16:21:35.186601) ========= ========= Total master_lag: 0.16 =========