builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1475664458.8 results: success (0) buildid: 20161005022600 builduid: 3928946ae9084ae08307f52d1d3a2bcc revision: 4dc7f22c700fdbfd0328e64e20be6b65408bb098 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.802126) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.802584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.802871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.818828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.819100) ========= 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=523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 03:47:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.0M=0s 2016-10-05 03:47:39 (24.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.955457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:38.955816) ========= 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=523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:39.007499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 03:47:39.007843) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4dc7f22c700fdbfd0328e64e20be6b65408bb098 --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 4dc7f22c700fdbfd0328e64e20be6b65408bb098 --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=523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 03:47:40,004 truncating revision to first 12 chars 2016-10-05 03:47:40,004 Setting DEBUG logging. 2016-10-05 03:47:40,004 attempt 1/10 2016-10-05 03:47:40,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4dc7f22c700f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 03:47:40,778 unpacking tar archive at: autoland-4dc7f22c700f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.101513 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 03:47:40.123115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:40.123464) ========= script_repo_revision: 4dc7f22c700fdbfd0328e64e20be6b65408bb098 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:40.123873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:40.124166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 03:47:40.134676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-05 03:47:40.135023) ========= /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=523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:41 INFO - MultiFileLogger online at 20161005 03:47:41 in /builds/slave/test 03:47:41 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 03:47:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:41 INFO - {'append_to_log': False, 03:47:41 INFO - 'base_work_dir': '/builds/slave/test', 03:47:41 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:47:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:41 INFO - 'branch': 'Autoland-Non-PGO', 03:47:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:41 INFO - 'config_files': ('talos/linux_config.py',), 03:47:41 INFO - 'default_actions': ('clobber', 03:47:41 INFO - 'read-buildbot-config', 03:47:41 INFO - 'download-and-extract', 03:47:41 INFO - 'populate-webroot', 03:47:41 INFO - 'create-virtualenv', 03:47:41 INFO - 'install', 03:47:41 INFO - 'run-tests'), 03:47:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:41 INFO - 'download_minidump_stackwalk': True, 03:47:41 INFO - 'download_symbols': 'ondemand', 03:47:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:41 INFO - 'installer_path': 'installer.exe', 03:47:41 INFO - 'log_level': 'info', 03:47:41 INFO - 'log_name': 'talos', 03:47:41 INFO - 'log_to_console': True, 03:47:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:41 INFO - 'opt_config_files': (), 03:47:41 INFO - 'pip_index': False, 03:47:41 INFO - 'sps_profile': False, 03:47:41 INFO - 'sps_profile_interval': 0, 03:47:41 INFO - 'suite': 'dromaeojs', 03:47:41 INFO - 'system_bits': '32', 03:47:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:41 INFO - 'title': 'talos-linux64-ix-065', 03:47:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:41 INFO - 'use_talos_json': True, 03:47:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:41 INFO - 'work_dir': 'build'} 03:47:41 INFO - [mozharness: 2016-10-05 10:47:41.224457Z] Running clobber step. 03:47:41 INFO - Running pre-action listener: _resource_record_pre_action 03:47:41 INFO - Running main action method: clobber 03:47:41 INFO - rmtree: /builds/slave/test/build 03:47:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:42 INFO - Running post-action listener: _resource_record_post_action 03:47:42 INFO - [mozharness: 2016-10-05 10:47:42.208324Z] Finished clobber step (success) 03:47:42 INFO - [mozharness: 2016-10-05 10:47:42.208425Z] Running read-buildbot-config step. 03:47:42 INFO - Running pre-action listener: _resource_record_pre_action 03:47:42 INFO - Running main action method: read_buildbot_config 03:47:42 INFO - Using buildbot properties: 03:47:42 INFO - { 03:47:42 INFO - "project": "", 03:47:42 INFO - "product": "firefox", 03:47:42 INFO - "script_repo_revision": "production", 03:47:42 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:47:42 INFO - "repository": "", 03:47:42 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:47:42 INFO - "buildid": "20161005022600", 03:47:42 INFO - "pgo_build": "False", 03:47:42 INFO - "basedir": "/builds/slave/test", 03:47:42 INFO - "buildnumber": 635, 03:47:42 INFO - "slavename": "talos-linux64-ix-065", 03:47:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:47:42 INFO - "platform": "ubuntu64_hw", 03:47:42 INFO - "scheduler": "tests-autoland-linux64-talos", 03:47:42 INFO - "branch": "autoland", 03:47:42 INFO - "repo_path": "integration/autoland", 03:47:42 INFO - "revision": "4dc7f22c700fdbfd0328e64e20be6b65408bb098", 03:47:42 INFO - "stage_platform": "linux64", 03:47:42 INFO - "builduid": "3928946ae9084ae08307f52d1d3a2bcc", 03:47:42 INFO - "slavebuilddir": "test" 03:47:42 INFO - } 03:47:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:47:42 INFO - Running post-action listener: _resource_record_post_action 03:47:42 INFO - [mozharness: 2016-10-05 10:47:42.211173Z] Finished read-buildbot-config step (success) 03:47:42 INFO - [mozharness: 2016-10-05 10:47:42.211260Z] Running download-and-extract step. 03:47:42 INFO - Running pre-action listener: _resource_record_pre_action 03:47:42 INFO - Running main action method: download_and_extract 03:47:42 INFO - mkdir: /builds/slave/test/build/tests 03:47:42 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')]} 03:47:42 INFO - trying https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:47:42 INFO - Downloading https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/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 03:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/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 03:47:42 INFO - Downloaded 1361 bytes. 03:47:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:47:42 INFO - Using the following test package requirements: 03:47:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:47:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:47:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'jsshell-linux-x86_64.zip'], 03:47:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:47:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:47:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:47:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:47:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:47:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:47:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:47:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:47:42 INFO - Fetch https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:47:43 INFO - Http code: 200 03:47:43 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 03:47:43 INFO - x-amz-cf-id: HtMYJLaKx5rkbQ11U_hJDoLssR5pDd-lP8-1lN-aGEdCngIFdxvf0A== 03:47:43 INFO - x-amz-version-id: Dj0nibWRws_TgvmR7NdJq5cCByReSxVw 03:47:43 INFO - Expected file size: 20421250 03:47:43 INFO - Obtained file size: 20421250 03:47:47 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 03:47:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:47:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:47:47 INFO - Fetch https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:47:48 INFO - Http code: 200 03:47:48 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 03:47:48 INFO - x-amz-cf-id: DmevKdNyWI-_HekVJvStlRKcdlF2NrosThrrYKqqB8Ji7srUB6Iotg== 03:47:48 INFO - x-amz-version-id: Dj0nibWRws_TgvmR7NdJq5cCByReSxVw 03:47:48 INFO - Expected file size: 20421250 03:47:48 INFO - Obtained file size: 20421250 03:47:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:47:52 INFO - Fetch https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:47:53 INFO - Http code: 200 03:47:53 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 03:47:53 INFO - x-amz-cf-id: E0--6yu_dsXKjz6RA41bI2ioSVqRQGjKb51dE2Ub6ZGXfzzh3LNvIQ== 03:47:53 INFO - x-amz-version-id: 7OQQ9aYVysOGtb5qq8VPe_OXYAa87DrI 03:47:54 INFO - Expected file size: 14409006 03:47:54 INFO - Obtained file size: 14409006 03:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:54 INFO - trying https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:47:54 INFO - Downloading https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/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 03:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/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 03:47:56 INFO - Downloaded 55803186 bytes. 03:47:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:47:56 INFO - mkdir: /builds/slave/test/properties 03:47:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:56 INFO - Contents: 03:47:56 INFO - build_url:https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:47:57 INFO - Running post-action listener: _resource_record_post_action 03:47:57 INFO - Running post-action listener: set_extra_try_arguments 03:47:57 INFO - [mozharness: 2016-10-05 10:47:57.292246Z] Finished download-and-extract step (success) 03:47:57 INFO - [mozharness: 2016-10-05 10:47:57.292471Z] Running populate-webroot step. 03:47:57 INFO - Running pre-action listener: _resource_record_pre_action 03:47:57 INFO - Running main action method: populate_webroot 03:47:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:57 INFO - '--tppagecycles', 03:47:57 INFO - '7'], 03:47:57 INFO - 'tests': ['tsvgm']}}, 03:47:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:47:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:47:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:47:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['damp', 'tps']}, 03:47:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'tests': ['damp', 'tps']}, 03:47:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['dromaeo_dom']}, 03:47:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['basic_compositor_video']}, 03:47:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:47:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['a11yr', 03:47:57 INFO - 'ts_paint', 03:47:57 INFO - 'tpaint', 03:47:57 INFO - 'sessionrestore', 03:47:57 INFO - 'sessionrestore_no_auto_restore', 03:47:57 INFO - 'tabpaint']}, 03:47:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:47:57 INFO - 'ts_paint', 03:47:57 INFO - 'tpaint', 03:47:57 INFO - 'sessionrestore', 03:47:57 INFO - 'sessionrestore_no_auto_restore', 03:47:57 INFO - 'tabpaint']}, 03:47:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:47:57 INFO - 'ts_paint', 03:47:57 INFO - 'tpaint', 03:47:57 INFO - 'sessionrestore', 03:47:57 INFO - 'sessionrestore_no_auto_restore', 03:47:57 INFO - 'tabpaint']}, 03:47:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:47:57 INFO - 'ts_paint', 03:47:57 INFO - 'tpaint', 03:47:57 INFO - 'sessionrestore', 03:47:57 INFO - 'sessionrestore_no_auto_restore', 03:47:57 INFO - 'tabpaint']}, 03:47:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['a11yr', 03:47:57 INFO - 'ts_paint', 03:47:57 INFO - 'tpaint', 03:47:57 INFO - 'sessionrestore', 03:47:57 INFO - 'sessionrestore_no_auto_restore', 03:47:57 INFO - 'tabpaint']}, 03:47:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['a11yr', 03:47:57 INFO - 'ts_paint', 03:47:57 INFO - 'tpaint', 03:47:57 INFO - 'sessionrestore', 03:47:57 INFO - 'sessionrestore_no_auto_restore', 03:47:57 INFO - 'tabpaint']}, 03:47:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['tsvgx', 03:47:57 INFO - 'tsvgr_opacity', 03:47:57 INFO - 'tart', 03:47:57 INFO - 'tscrollx', 03:47:57 INFO - 'cart']}, 03:47:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:47:57 INFO - 'tsvgr_opacity', 03:47:57 INFO - 'tart', 03:47:57 INFO - 'tscrollx', 03:47:57 INFO - 'cart']}, 03:47:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'talos_options': ['--disable-e10s'], 03:47:57 INFO - 'tests': ['tp5o']}, 03:47:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'tests': ['tp5o']}, 03:47:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'talos_options': ['--disable-e10s', 03:47:57 INFO - '--xperf_path', 03:47:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:57 INFO - 'tests': ['tp5n']}, 03:47:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:57 INFO - 'talos_options': ['--xperf_path', 03:47:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:57 INFO - 'tests': ['tp5n']}}, 03:47:57 INFO - 'talos.zip': {'path': '', 03:47:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:57 INFO - Running post-action listener: _resource_record_post_action 03:47:57 INFO - [mozharness: 2016-10-05 10:47:57.309484Z] Finished populate-webroot step (success) 03:47:57 INFO - [mozharness: 2016-10-05 10:47:57.309572Z] Running create-virtualenv step. 03:47:57 INFO - Running pre-action listener: _resource_record_pre_action 03:47:57 INFO - Running main action method: create_virtualenv 03:47:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:57 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 03:47:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:47:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:57 INFO - Using real prefix '/usr' 03:47:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:59 INFO - Installing pip.................done. 03:47:59 INFO - Return code: 0 03:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:48:00 INFO - Reading from file tmpfile_stdout 03:48:00 INFO - Output received: 03:48:00 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) 03:48:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:00 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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:00 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 03:48:00 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 03:48:00 INFO - Using env: {'DISPLAY': ':0', 03:48:00 INFO - 'HOME': '/home/cltbld', 03:48:00 INFO - 'LANG': 'en_US.UTF-8', 03:48:00 INFO - 'LANGUAGE': 'en_US:en', 03:48:00 INFO - 'LOGNAME': 'cltbld', 03:48:00 INFO - 'MAIL': '/var/mail/cltbld', 03:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:00 INFO - 'MOZ_NO_REMOTE': '1', 03:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:00 INFO - 'NO_EM_RESTART': '1', 03:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:00 INFO - 'PWD': '/builds/slave/test', 03:48:00 INFO - 'SHELL': '/bin/bash', 03:48:00 INFO - 'SHLVL': '1', 03:48:00 INFO - 'TERM': 'linux', 03:48:00 INFO - 'TMOUT': '86400', 03:48:00 INFO - 'USER': 'cltbld', 03:48:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:00 INFO - '_': '/tools/buildbot/bin/python'} 03:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:00 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 03:48:00 INFO - Cleaning up... 03:48:00 INFO - Return code: 0 03:48:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:00 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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:00 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 03:48:00 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 03:48:00 INFO - Using env: {'DISPLAY': ':0', 03:48:00 INFO - 'HOME': '/home/cltbld', 03:48:00 INFO - 'LANG': 'en_US.UTF-8', 03:48:00 INFO - 'LANGUAGE': 'en_US:en', 03:48:00 INFO - 'LOGNAME': 'cltbld', 03:48:00 INFO - 'MAIL': '/var/mail/cltbld', 03:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:00 INFO - 'MOZ_NO_REMOTE': '1', 03:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:00 INFO - 'NO_EM_RESTART': '1', 03:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:00 INFO - 'PWD': '/builds/slave/test', 03:48:00 INFO - 'SHELL': '/bin/bash', 03:48:00 INFO - 'SHLVL': '1', 03:48:00 INFO - 'TERM': 'linux', 03:48:00 INFO - 'TMOUT': '86400', 03:48:00 INFO - 'USER': 'cltbld', 03:48:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:00 INFO - '_': '/tools/buildbot/bin/python'} 03:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:00 INFO - Downloading/unpacking psutil>=3.1.1 03:48:00 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 03:48:00 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 03:48:00 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 03:48:00 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 03:48:00 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 03:48:00 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 03:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:02 INFO - Installing collected packages: psutil 03:48:02 INFO - Running setup.py install for psutil 03:48:02 INFO - building 'psutil._psutil_linux' extension 03:48:02 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 03:48:02 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 03:48:02 INFO - building 'psutil._psutil_posix' extension 03:48:02 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 03:48:02 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 03:48:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:03 INFO - Successfully installed psutil 03:48:03 INFO - Cleaning up... 03:48:03 INFO - Return code: 0 03:48:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:48:03 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')]} 03:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:03 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')]} 03:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:03 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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:03 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 03:48:03 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 03:48:03 INFO - Using env: {'DISPLAY': ':0', 03:48:03 INFO - 'HOME': '/home/cltbld', 03:48:03 INFO - 'LANG': 'en_US.UTF-8', 03:48:03 INFO - 'LANGUAGE': 'en_US:en', 03:48:03 INFO - 'LOGNAME': 'cltbld', 03:48:03 INFO - 'MAIL': '/var/mail/cltbld', 03:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:03 INFO - 'MOZ_NO_REMOTE': '1', 03:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:03 INFO - 'NO_EM_RESTART': '1', 03:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:03 INFO - 'PWD': '/builds/slave/test', 03:48:03 INFO - 'SHELL': '/bin/bash', 03:48:03 INFO - 'SHLVL': '1', 03:48:03 INFO - 'TERM': 'linux', 03:48:03 INFO - 'TMOUT': '86400', 03:48:03 INFO - 'USER': 'cltbld', 03:48:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:03 INFO - '_': '/tools/buildbot/bin/python'} 03:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:48:03 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 03:48:03 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 03:48:03 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 03:48:03 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 03:48:03 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 03:48:03 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 03:48:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:48:05 INFO - Installing collected packages: mozsystemmonitor 03:48:05 INFO - Running setup.py install for mozsystemmonitor 03:48:05 INFO - Successfully installed mozsystemmonitor 03:48:05 INFO - Cleaning up... 03:48:05 INFO - Return code: 0 03:48:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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', '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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:48: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 jsonschema==2.5.1 03:48:05 INFO - Using env: {'DISPLAY': ':0', 03:48:05 INFO - 'HOME': '/home/cltbld', 03:48:05 INFO - 'LANG': 'en_US.UTF-8', 03:48:05 INFO - 'LANGUAGE': 'en_US:en', 03:48:05 INFO - 'LOGNAME': 'cltbld', 03:48:05 INFO - 'MAIL': '/var/mail/cltbld', 03:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:05 INFO - 'MOZ_NO_REMOTE': '1', 03:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:05 INFO - 'NO_EM_RESTART': '1', 03:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:05 INFO - 'PWD': '/builds/slave/test', 03:48:05 INFO - 'SHELL': '/bin/bash', 03:48:05 INFO - 'SHLVL': '1', 03:48:05 INFO - 'TERM': 'linux', 03:48:05 INFO - 'TMOUT': '86400', 03:48:05 INFO - 'USER': 'cltbld', 03:48:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:05 INFO - '_': '/tools/buildbot/bin/python'} 03:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:05 INFO - Downloading/unpacking jsonschema==2.5.1 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:07 INFO - warning: no files found matching '*.txt' 03:48:07 INFO - no previously-included directories found matching 'build' 03:48:07 INFO - no previously-included directories found matching 'dist' 03:48:07 INFO - no previously-included directories found matching '.git*' 03:48:07 INFO - Installing collected packages: jsonschema, functools32 03:48:07 INFO - Running setup.py install for functools32 03:48:07 INFO - warning: no files found matching '*.txt' 03:48:07 INFO - no previously-included directories found matching 'build' 03:48:07 INFO - no previously-included directories found matching 'dist' 03:48:07 INFO - no previously-included directories found matching '.git*' 03:48:07 INFO - Successfully installed jsonschema functools32 03:48:07 INFO - Cleaning up... 03:48:08 INFO - Return code: 0 03:48:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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', '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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:48: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 functools32==3.2.3-2 03:48:08 INFO - Using env: {'DISPLAY': ':0', 03:48:08 INFO - 'HOME': '/home/cltbld', 03:48:08 INFO - 'LANG': 'en_US.UTF-8', 03:48:08 INFO - 'LANGUAGE': 'en_US:en', 03:48:08 INFO - 'LOGNAME': 'cltbld', 03:48:08 INFO - 'MAIL': '/var/mail/cltbld', 03:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:08 INFO - 'MOZ_NO_REMOTE': '1', 03:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:08 INFO - 'NO_EM_RESTART': '1', 03:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:08 INFO - 'PWD': '/builds/slave/test', 03:48:08 INFO - 'SHELL': '/bin/bash', 03:48:08 INFO - 'SHLVL': '1', 03:48:08 INFO - 'TERM': 'linux', 03:48:08 INFO - 'TMOUT': '86400', 03:48:08 INFO - 'USER': 'cltbld', 03:48:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:08 INFO - '_': '/tools/buildbot/bin/python'} 03:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:48:08 INFO - Cleaning up... 03:48:08 INFO - Return code: 0 03:48:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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', '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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:48: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 blobuploader==1.2.4 03:48:08 INFO - Using env: {'DISPLAY': ':0', 03:48:08 INFO - 'HOME': '/home/cltbld', 03:48:08 INFO - 'LANG': 'en_US.UTF-8', 03:48:08 INFO - 'LANGUAGE': 'en_US:en', 03:48:08 INFO - 'LOGNAME': 'cltbld', 03:48:08 INFO - 'MAIL': '/var/mail/cltbld', 03:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:08 INFO - 'MOZ_NO_REMOTE': '1', 03:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:08 INFO - 'NO_EM_RESTART': '1', 03:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:08 INFO - 'PWD': '/builds/slave/test', 03:48:08 INFO - 'SHELL': '/bin/bash', 03:48:08 INFO - 'SHLVL': '1', 03:48:08 INFO - 'TERM': 'linux', 03:48:08 INFO - 'TMOUT': '86400', 03:48:08 INFO - 'USER': 'cltbld', 03:48:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:08 INFO - '_': '/tools/buildbot/bin/python'} 03:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:11 INFO - Downloading docopt-0.6.1.tar.gz 03:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:11 INFO - Running setup.py install for blobuploader 03:48:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:11 INFO - Running setup.py install for requests 03:48:11 INFO - Running setup.py install for docopt 03:48:11 INFO - Successfully installed blobuploader requests docopt 03:48:11 INFO - Cleaning up... 03:48:11 INFO - Return code: 0 03:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:11 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')]} 03:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:11 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')]} 03:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:11 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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:11 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 03:48:11 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 03:48:11 INFO - Using env: {'DISPLAY': ':0', 03:48:11 INFO - 'HOME': '/home/cltbld', 03:48:11 INFO - 'LANG': 'en_US.UTF-8', 03:48:11 INFO - 'LANGUAGE': 'en_US:en', 03:48:11 INFO - 'LOGNAME': 'cltbld', 03:48:11 INFO - 'MAIL': '/var/mail/cltbld', 03:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:11 INFO - 'MOZ_NO_REMOTE': '1', 03:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:11 INFO - 'NO_EM_RESTART': '1', 03:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:11 INFO - 'PWD': '/builds/slave/test', 03:48:11 INFO - 'SHELL': '/bin/bash', 03:48:11 INFO - 'SHLVL': '1', 03:48:11 INFO - 'TERM': 'linux', 03:48:11 INFO - 'TMOUT': '86400', 03:48:11 INFO - 'USER': 'cltbld', 03:48:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:11 INFO - '_': '/tools/buildbot/bin/python'} 03:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:11 INFO - Running setup.py (path:/tmp/pip-jv0T4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:12 INFO - Running setup.py (path:/tmp/pip-L3JYvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:12 INFO - Running setup.py (path:/tmp/pip-LFLSoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:12 INFO - Running setup.py (path:/tmp/pip-Zw_QwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:12 INFO - Running setup.py (path:/tmp/pip-HwbEsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:12 INFO - Running setup.py (path:/tmp/pip-lnRXgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:12 INFO - Running setup.py (path:/tmp/pip-Kw3WeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:12 INFO - Running setup.py (path:/tmp/pip-2gblC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:12 INFO - Running setup.py (path:/tmp/pip-niArOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:12 INFO - Running setup.py (path:/tmp/pip-hFUfIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:12 INFO - Running setup.py (path:/tmp/pip-BI2sDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:12 INFO - Running setup.py (path:/tmp/pip-HwtPFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:12 INFO - Running setup.py (path:/tmp/pip-Fdvcjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:12 INFO - Running setup.py (path:/tmp/pip-A1gFwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:12 INFO - Running setup.py (path:/tmp/pip-A1k4YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:13 INFO - Running setup.py (path:/tmp/pip-vuHkEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:13 INFO - Running setup.py (path:/tmp/pip-Jtb40X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:13 INFO - Running setup.py install for manifestparser 03:48:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:13 INFO - Running setup.py install for mozcrash 03:48:13 INFO - Running setup.py install for mozdebug 03:48:13 INFO - Running setup.py install for mozdevice 03:48:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:13 INFO - Running setup.py install for mozfile 03:48:13 INFO - Running setup.py install for mozhttpd 03:48:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:13 INFO - Running setup.py install for mozinfo 03:48:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:13 INFO - Running setup.py install for mozInstall 03:48:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Running setup.py install for mozleak 03:48:14 INFO - Running setup.py install for mozlog 03:48:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Running setup.py install for moznetwork 03:48:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Running setup.py install for mozprocess 03:48:14 INFO - Running setup.py install for mozprofile 03:48:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Running setup.py install for mozrunner 03:48:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Running setup.py install for mozscreenshot 03:48:14 INFO - Running setup.py install for moztest 03:48:14 INFO - Running setup.py install for mozversion 03:48:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:14 INFO - Cleaning up... 03:48:15 INFO - Return code: 0 03:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:15 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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:15 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 03:48:15 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 03:48:15 INFO - Using env: {'DISPLAY': ':0', 03:48:15 INFO - 'HOME': '/home/cltbld', 03:48:15 INFO - 'LANG': 'en_US.UTF-8', 03:48:15 INFO - 'LANGUAGE': 'en_US:en', 03:48:15 INFO - 'LOGNAME': 'cltbld', 03:48:15 INFO - 'MAIL': '/var/mail/cltbld', 03:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:15 INFO - 'MOZ_NO_REMOTE': '1', 03:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:15 INFO - 'NO_EM_RESTART': '1', 03:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:15 INFO - 'PWD': '/builds/slave/test', 03:48:15 INFO - 'SHELL': '/bin/bash', 03:48:15 INFO - 'SHLVL': '1', 03:48:15 INFO - 'TERM': 'linux', 03:48:15 INFO - 'TMOUT': '86400', 03:48:15 INFO - 'USER': 'cltbld', 03:48:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:15 INFO - '_': '/tools/buildbot/bin/python'} 03:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:15 INFO - Running setup.py (path:/tmp/pip-VdUWKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:15 INFO - Running setup.py (path:/tmp/pip-dfUAhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:15 INFO - Running setup.py (path:/tmp/pip-lblgo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:15 INFO - Running setup.py (path:/tmp/pip-cGsWCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:15 INFO - Running setup.py (path:/tmp/pip-HmGtDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:15 INFO - Running setup.py (path:/tmp/pip-5WTtIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:15 INFO - Running setup.py (path:/tmp/pip-dsEDhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:15 INFO - Running setup.py (path:/tmp/pip-wl5nYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:15 INFO - Running setup.py (path:/tmp/pip-xnBGHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:15 INFO - Running setup.py (path:/tmp/pip-J74JHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:15 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)) 03:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:15 INFO - Running setup.py (path:/tmp/pip-IB8k3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:16 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)) 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:16 INFO - Running setup.py (path:/tmp/pip-s6hJmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:16 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)) 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:16 INFO - Running setup.py (path:/tmp/pip-BbiDsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:16 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)) 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:16 INFO - Running setup.py (path:/tmp/pip-DuMXr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:16 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)) 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:16 INFO - Running setup.py (path:/tmp/pip-T_td9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:16 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)) 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:16 INFO - Running setup.py (path:/tmp/pip-pggA1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:16 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)) 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:16 INFO - Running setup.py (path:/tmp/pip-6g8U9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:16 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)) 03:48:16 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)) 03:48:16 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)) 03:48:16 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)) 03:48:16 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)) 03:48:16 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)) 03:48:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:18 INFO - Downloading blessings-1.6.tar.gz 03:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:18 INFO - Installing collected packages: blessings 03:48:18 INFO - Running setup.py install for blessings 03:48:18 INFO - Successfully installed blessings 03:48:18 INFO - Cleaning up... 03:48:18 INFO - Return code: 0 03:48:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:18 INFO - Reading from file tmpfile_stdout 03:48:18 INFO - Current package versions: 03:48:18 INFO - argparse == 1.2.1 03:48:18 INFO - blessings == 1.6 03:48:18 INFO - blobuploader == 1.2.4 03:48:18 INFO - docopt == 0.6.1 03:48:18 INFO - functools32 == 3.2.3-2 03:48:18 INFO - jsonschema == 2.5.1 03:48:18 INFO - manifestparser == 1.1 03:48:18 INFO - mozInstall == 1.12 03:48:18 INFO - mozcrash == 0.17 03:48:18 INFO - mozdebug == 0.1 03:48:18 INFO - mozdevice == 0.48 03:48:18 INFO - mozfile == 1.2 03:48:18 INFO - mozhttpd == 0.7 03:48:18 INFO - mozinfo == 0.9 03:48:18 INFO - mozleak == 0.1 03:48:18 INFO - mozlog == 3.4 03:48:18 INFO - moznetwork == 0.27 03:48:18 INFO - mozprocess == 0.23 03:48:18 INFO - mozprofile == 0.28 03:48:18 INFO - mozrunner == 6.12 03:48:18 INFO - mozscreenshot == 0.1 03:48:18 INFO - mozsystemmonitor == 0.3 03:48:18 INFO - moztest == 0.7 03:48:18 INFO - mozversion == 1.4 03:48:18 INFO - psutil == 3.1.1 03:48:18 INFO - requests == 1.2.3 03:48:18 INFO - wsgiref == 0.1.2 03:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:18 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 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:18 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 03:48:18 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 03:48:18 INFO - Using env: {'DISPLAY': ':0', 03:48:18 INFO - 'HOME': '/home/cltbld', 03:48:18 INFO - 'LANG': 'en_US.UTF-8', 03:48:18 INFO - 'LANGUAGE': 'en_US:en', 03:48:18 INFO - 'LOGNAME': 'cltbld', 03:48:18 INFO - 'MAIL': '/var/mail/cltbld', 03:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:18 INFO - 'MOZ_NO_REMOTE': '1', 03:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:18 INFO - 'NO_EM_RESTART': '1', 03:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:18 INFO - 'PWD': '/builds/slave/test', 03:48:18 INFO - 'SHELL': '/bin/bash', 03:48:18 INFO - 'SHLVL': '1', 03:48:18 INFO - 'TERM': 'linux', 03:48:18 INFO - 'TMOUT': '86400', 03:48:18 INFO - 'USER': 'cltbld', 03:48:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:18 INFO - '_': '/tools/buildbot/bin/python'} 03:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 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)) 03:48:19 INFO - Cleaning up... 03:48:19 INFO - Return code: 0 03:48:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe626467f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, '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': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', '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 03:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:19 INFO - Using env: {'DISPLAY': ':0', 03:48:19 INFO - 'HOME': '/home/cltbld', 03:48:19 INFO - 'LANG': 'en_US.UTF-8', 03:48:19 INFO - 'LANGUAGE': 'en_US:en', 03:48:19 INFO - 'LOGNAME': 'cltbld', 03:48:19 INFO - 'MAIL': '/var/mail/cltbld', 03:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:19 INFO - 'MOZ_NO_REMOTE': '1', 03:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:19 INFO - 'NO_EM_RESTART': '1', 03:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:19 INFO - 'PWD': '/builds/slave/test', 03:48:19 INFO - 'SHELL': '/bin/bash', 03:48:19 INFO - 'SHLVL': '1', 03:48:19 INFO - 'TERM': 'linux', 03:48:19 INFO - 'TMOUT': '86400', 03:48:19 INFO - 'USER': 'cltbld', 03:48:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:19 INFO - '_': '/tools/buildbot/bin/python'} 03:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:48:19 INFO - Cleaning up... 03:48:19 INFO - Return code: 0 03:48:19 INFO - Running post-action listener: _resource_record_post_action 03:48:19 INFO - Running post-action listener: _start_resource_monitoring 03:48:19 INFO - Starting resource monitoring. 03:48:19 INFO - [mozharness: 2016-10-05 10:48:19.368539Z] Finished create-virtualenv step (success) 03:48:19 INFO - [mozharness: 2016-10-05 10:48:19.369041Z] Running install step. 03:48:19 INFO - Running pre-action listener: _resource_record_pre_action 03:48:19 INFO - Running main action method: install 03:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:19 INFO - Reading from file tmpfile_stdout 03:48:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:19 INFO - Reading from file tmpfile_stdout 03:48:19 INFO - Output received: 03:48:19 INFO - Usage: mozinstall [options] installer 03:48:19 INFO - Options: 03:48:19 INFO - -h, --help show this help message and exit 03:48:19 INFO - -d DEST, --destination=DEST 03:48:19 INFO - Directory to install application into. [default: 03:48:19 INFO - "/builds/slave/test"] 03:48:19 INFO - --app=APP Application being installed. [default: firefox] 03:48:19 INFO - mkdir: /builds/slave/test/build/application 03:48:19 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'] 03:48:19 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 03:48:36 INFO - Reading from file tmpfile_stdout 03:48:36 INFO - Output received: 03:48:36 INFO - /builds/slave/test/build/application/firefox/firefox 03:48:36 INFO - Running post-action listener: _resource_record_post_action 03:48:36 INFO - [mozharness: 2016-10-05 10:48:36.337969Z] Finished install step (success) 03:48:36 INFO - [mozharness: 2016-10-05 10:48:36.338213Z] Running run-tests step. 03:48:36 INFO - Running pre-action listener: _resource_record_pre_action 03:48:36 INFO - Running main action method: run_tests 03:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:36 INFO - Python 2.7.3 03:48:36 INFO - Return code: 0 03:48:36 INFO - grabbing minidump binary from tooltool 03:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:36 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 0x110bf60>, '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 0x110cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:36 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 03:48:36 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 03:48:36 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 03:48:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:36 INFO - Return code: 0 03:48:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:48:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:48:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:36 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/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:48:36 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/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 03:48:36 INFO - Using env: {'DISPLAY': ':0', 03:48:36 INFO - 'HOME': '/home/cltbld', 03:48:36 INFO - 'LANG': 'en_US.UTF-8', 03:48:36 INFO - 'LANGUAGE': 'en_US:en', 03:48:36 INFO - 'LOGNAME': 'cltbld', 03:48:36 INFO - 'MAIL': '/var/mail/cltbld', 03:48:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:36 INFO - 'MOZ_NO_REMOTE': '1', 03:48:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:36 INFO - 'NO_EM_RESTART': '1', 03:48:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:36 INFO - 'PWD': '/builds/slave/test', 03:48:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:36 INFO - 'SHELL': '/bin/bash', 03:48:36 INFO - 'SHLVL': '1', 03:48:36 INFO - 'TERM': 'linux', 03:48:36 INFO - 'TMOUT': '86400', 03:48:36 INFO - 'USER': 'cltbld', 03:48:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873', 03:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:36 INFO - '_': '/tools/buildbot/bin/python'} 03:48:36 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/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:48:36 INFO - mozversion application_buildid: 20161005022600 03:48:36 INFO - mozversion application_changeset: 4dc7f22c700fdbfd0328e64e20be6b65408bb098 03:48:36 INFO - mozversion application_display_name: Nightly 03:48:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:36 INFO - mozversion application_name: Firefox 03:48:36 INFO - mozversion application_remotingname: firefox 03:48:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:48:36 INFO - mozversion application_vendor: Mozilla 03:48:36 INFO - mozversion application_version: 52.0a1 03:48:36 INFO - mozversion platform_buildid: 20161005022600 03:48:36 INFO - mozversion platform_changeset: 4dc7f22c700fdbfd0328e64e20be6b65408bb098 03:48:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:48:36 INFO - mozversion platform_version: 52.0a1 03:48:36 INFO - using testdate: 1475664516 03:48:36 INFO - actual date: 1475664516 03:48:36 INFO - starting webserver on 'localhost:39466' 03:48:36 INFO - SUITE-START | Running 2 tests 03:48:36 INFO - TEST-START | dromaeo_css 03:48:36 INFO - operating with platform_type : linux_ 03:48:36 INFO - Initialising browser for dromaeo_css test... 03:48:36 INFO - TEST-INFO | started process 10661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxRwDe/profile http://localhost:39466/getInfo.html) 03:48:41 INFO - PROCESS | 10661 | __metrics Screen width/height:1600/1200 03:48:41 INFO - PROCESS | 10661 | colorDepth:24 03:48:41 INFO - PROCESS | 10661 | Browser inner width/height: 1024/697 03:48:41 INFO - PROCESS | 10661 | __metrics 03:48:41 INFO - PROCESS | 10661 | 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" 03:48:41 INFO - PROCESS | 10661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:42 INFO - PROCESS | 10661 | console.error: PushService: 03:48:42 INFO - PROCESS | 10661 | stateChangeProcessEnqueue: Error transitioning state 03:48:42 INFO - PROCESS | 10661 | UnknownError 03:48:42 INFO - TEST-INFO | 10661: exit 0 03:48:42 INFO - Browser initialized. 03:48:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:42 INFO - TEST-INFO | started process 10740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxRwDe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:54 INFO - PROCESS | 10740 | RSS: Main: 175267840 03:48:54 INFO - PROCESS | 10740 | 03:49:45 INFO - PROCESS | 10740 | 1475664585825 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] 03:51:59 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:39466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39466/tests/dromaeo/cssquery-ext.html) 03:52:01 INFO - PROCESS | 10740 | RSS: Main: 312922112 03:52:01 INFO - PROCESS | 10740 | 03:55:04 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:39466/tests/dromaeo/cssquery-ext.html (next: http://localhost:39466/tests/dromaeo/cssquery-jquery.html) 03:55:04 INFO - PROCESS | 10740 | RSS: Main: 278712320 03:55:04 INFO - PROCESS | 10740 | 03:58:06 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:39466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39466/tests/dromaeo/cssquery-mootools.html) 03:58:07 INFO - PROCESS | 10740 | RSS: Main: 221278208 03:58:07 INFO - PROCESS | 10740 | 04:01:09 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:39466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39466/tests/dromaeo/cssquery-prototype.html) 04:01:10 INFO - PROCESS | 10740 | RSS: Main: 238727168 04:01:10 INFO - PROCESS | 10740 | 04:04:13 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:39466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39466/tests/dromaeo/cssquery-yui.html) 04:04:14 INFO - PROCESS | 10740 | RSS: Main: 222076928 04:04:14 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:39466/tests/dromaeo/cssquery-yui.html (next: http://localhost:39466/tests/dromaeo/cssquery-dojo.html) 04:07:17 INFO - PROCESS | 10740 | RSS: Main: 309706752 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | __start_tp_report 04:07:17 INFO - PROCESS | 10740 | _x_x_mozilla_page_load 04:07:17 INFO - PROCESS | 10740 | _x_x_mozilla_page_load_details 04:07:17 INFO - PROCESS | 10740 | |i|pagename|runs| 04:07:17 INFO - PROCESS | 10740 | |0;dojo.html;2593.714691383948;2615.2023632791993;2645.061003343813;2649.0728245114215;2664.853433061181;4671.182543054961;4712.5994290485305;4743.383360163182;4820.204666230068;4871.2936624189515;4775.90448191036;4790.089882922242;4813.037392521493;4844.951550484494;4893.4861839506875;4264.189803937257;4293.463317085364;4319.848805291816;4325.9351109733225;4461.107778444316;4398.912021759563;4438.267685831834;4439.067795762894;4442.577955094261;4466.749310193151;4395.384646149541;4428.446444194476;4437.179121862466;4442.267025940716;4482.731036137826;4248.235317642823;4284.742915425085;4287.121140166259;4337.414449049369;4377.321515165155;4304.6771492137905;4312.116016216668;4339.631131353839;4406.493253275882;4422.491413487458;4757.643176761722;4757.833475828364;4758.072175925696;4795.856124316276;4836.51634836517;4998.450170481244;5023.397192336906;5028.899422011576;5095.694258344474;5131.384233891919;5045.974770126162;5085.211792172219;5115.872103197413;5153;5166.43169251382;4734.526547345273;4743.051389722001;4761.738104404291;4770.689905156154;4805.327254184417;5020.447750747415;5062.316587260746;5162.45794191612;5175.301334319894;5225.50357716024;4943;4943.777530011158;4944.653874228841;4947.282644016669;4949.307097006422;5003.149464591028;5005.299258103868;5010.473900240495;5017.698938063655;5018.2974383586325;4940.530649588283;4975;4980.676256043345;4994.225894986283;5011.6241281904;4978.8257410990445;5030.144875371196;5031.622628302892;5078.644494885322;5095.719735414514;4349.630281426114;4351.73889566627;4351.9564804352185;4391.3193455014525;4403.9779801100785;3795.8481660733814;3796.145867179918;3797.9810100949317;3803.391457366808;3821.121142137324;4353.6299414549485;4357.1939191249085;4375.78121093944;4384.714993525411;4432;5119.513646203604;5151.5363617274625;5160.716160611202;5160.819371322061;5225.6603320784025;4248.553901840262;4388.561143885586;4389.780510974439;4398.208322501916;4449.621782148553;4524.5927866492175;4559.772011399483;4580.496145424001;4597.103564804898;4671.8364857229835;4764.30917516965;4768.856934291976;4770.117528257353;4770.260609605517;4826.444958829779;5077.619178561697;5096.1336572781975;5107.284980102714;5110.131277682728;5174.560162386088;4606.723596584216;4643.698159619614;4719.457262414729;4747.691400058985;4781.378420805273;5043.99120175959;5049.798008079782;5051.469595692546;5053.67151135175;5113.667611605382;5117.488251174853;5118.718470484159;5119.539241468136;5120.462351453044;5166.2508936203285;4872.123017856678;4916;4916.606671466346;4919.0407870464915;4973.577245934136;4933.432655244693;4994.625403094709;5052.065367906949;5056.974715126401;5057.8229761958155;4913.65604407688;4935.950640493549;4938.456769755252;4946.208606623067;4999.875003124951;4820;5000.274960130833;5043.773030213722;5052.621053420935;5100.132977393778;4740.881477963078;4787.42550893895;4838.201696720002;4849.539293767087;4932.383452068491 04:07:17 INFO - PROCESS | 10740 | |1;ext.html;545.0543307361727;556.6910364747566;570.6889745088926;571.6027360984115;573.3692937768454;27689;37894.43158352623;39062.804685976604;39144.60855391449;42896.356554651706;39653.206935861264;40130.39804402936;40184.79907600465;40186.79906600463;40232;7611.505252158606;7757.10793258774;7758.806029849243;7760.262775036391;7763.146053934062;7525.9463675085535;7610.467267291292;7611.048618922635;7617.314441700246;7620.542767433944;7592;7638.8472230555635;7639.04511936008;7640.044994375703;7642.273983971514;7578.166401695809;7587.241275872424;7602.277783610548;7610.1628820829665;7627.237276272356;7533.623318834091;7619.885701714478;7629.046369203849;7630.961845190794;7639;37198.09420010914;37527.24945501102;37539.812300938596;37573.248535029146;37574.624253757385;2923.7368636822575;2983.149802306354;3058.01303496643;3229.160418291261;3240.1575590346442;27622.723772762216;28098.173618714718;28517.429651407063;29065;29663.55504667432;3443.4318337474288;3472.635373285794;3482.4776283557417;3485.8431370588382;3542.681158695704;247843;249298;249372;251463;252186;31254.21864453407;32252.516212256836;49693;50158.247626285636;50192;33096.3380732384;33376;33411.83294083514;33426.49860252098;33429.83285083559;12608.243505389706;12689.682757931125;12693.174943628635;12719.046071544486;12722.300273485047;10264.178865690727;10329.070383665507;10340.793184136275;10342.482875856178;10350.378977261389;7819.491733037335;7850.136484986647;7875.291223789886;7949.682012719542;7974.840503189904;3082.892098776532;3083.383323335342;3089.7991630543943;3101.3177101037736;3151.416987857254;816.4285000499674;816.6284340625001;838.9622466989;878.5255961780695;930.9813803723888;26823;27247.501387423486;28068;28322.85838570794;28507.42985140327;759.2635143910398;923.9769005774775;939.5818860607101;981.6760469045198;992.369845148336;14091.78862317066;15008.699826003418;15071.4724984625;15273.159976201194;15363.155026473427;374432;375586;375955;377027;377493.1125344356;48158;48382.27426588604;48749;48904.75547622239;48923;1015.7663737340453;1100.1089117814595;1136.0911270983345;1147.9827802582968;1175.58854400959;25288;28461.637499876433;28937;29333.26666833346;29488.705112949454;40193.59806402015;40645.56126632293;40665.796671016455;40736.388954165115;40737.38893916653;291260;293545;293765;293934;294123;24545.14092006771;24547.75452245526;25312.367190820376;25334.49331013406;26513.734862651898;40317;40552.391714124904;40838.79580602197;41012.97467563335;41623.37564936589;34645.826770865984;34970.82514587411;35003.47494787529;35176.648233517335;35376;34659.4801077979;34765;34987.47518787271;35199.296014080086;35321.823390882884;33745;34181.829090854386;34552;34797.82601086979;35062.82468587641;29724;31798.682013179572;31925.6807431932;32176.517352239265;32264.032079037668;24437.51124977526;24792.380190495383;24885.129020484197;25261.368465788502;25265.873670632263 04:07:17 INFO - PROCESS | 10740 | |2;jquery.html;340.2327750921671;355.18130708716416;358.33707640864395;361.3477672800595;384.4617535450369;12283.385830708463;15442.150681712501;15952.202389880504;16392;17326.220320085595;16286.592835179126;16492.670146597062;16724.2474088666;16943.745843812354;17090.658186836255;3912.1784425270725;4822.9035419291595;5004.824831130893;5037.622178336621;5059.139946209135;4952.826651067214;5045.899082018375;5046.318746969149;5048.1670524363435;5048.217526283432;4817.349657796205;4974.403071631391;5005;5008.198688209887;5012.398512178544;4972.477889821571;5020.322256495363;5024.673396229234;5024.723640199788;5024.924626130611;4286.57134286572;4429.180601588684;4433.689641725081;4491.146682130385;4494.393256910341;19842.70235946462;19864.106115224706;20042.1983120675;20061.996900155078;20457.590848183103;1832.8808627439173;1874.5313671582105;1886.5566591850904;1953.9511512212166;2346.9295921122393;12635.178713383693;12657;12854.421551030133;13409.396577154052;13489.527866524624;1705.914704264782;1734.6964281250857;1737.7740893683867;1765.205657454138;1786.8391844734037;67289.66355168192;68852.65573672099;69000;70560;70845.56121607209;9115.262742275636;9333.439993600407;9407.858882116774;9479.431234125837;10194.490275486196;12364.948979336858;12409;12447.821631214501;12461.93769031149;12476.313802740755;6704.430123439464;6864.862702745917;6908.481863860231;7043.295670433018;7096.574205547684;6545.672716364163;6573.0463881609985;6736.595804251662;6821.829454263584;6827.897581536281;5693.459121383462;5761.683107429131;5769.913451298234;5844.035734103825;6010.188624535632;1665.8667306615441;1688.9493315200564;1689.6705142497342;1695.4314213965852;1696.177353983317;795.908470525897;878.4334104502688;880.6125304865967;942.1191186240886;976.3751199232497;16691.582710432336;16766;17399.826001740075;17420.65158696819;17793.911030444764;829.2992421403904;868.3443999780126;880.9867851982225;883.0551310098133;911.2618778789202;8748.256398206096;9137;9337.859932101024;9400.717978460658;9567.473788941676;372779;375510;395800;403000.4749168942;405094;77664;81803;82816;84758.57620711857;85709;408.7036898248746;429.0753426366186;429.7421547071732;429.7765162115682;431.17430121317324;13733.244671543162;14605.488807891672;15618.765718514003;15668;16300.799392081917;37778.43332350072;38049.809750952176;38601.29790914609;38737.225255494166;38918.4162237561;46508;47549.28676069793;47721.28418073662;49978.75010624924;50104.24843627421;7583;7713.112992005991;7766.7768974853925;8006.07930088024;8061.596920154087;8783.648654053766;11923.701907452383;11964.940175299067;11990.160688751703;12033.63899083029;9845.803083938425;10290.485475726035;10573.4713264338;10744;10892.673219803419;9768.218542516439;10492.842607361048;10538.525766340379;10716;10725.678229653124;10584.788304234025;10630.946845265724;10753.516091776046;10865.565377384815;11176.27354221973;7713.382929365525;7755;7942.722004729807;8003.59982000886;8050.315723163597;7928.405369597419;9147.268218542367;10279.897201027894;10518.316309439862;10599.8940010602 04:07:17 INFO - PROCESS | 10740 | |3;mootools.html;1194.8088305871063;1282.6793301674584;1346.1519242876989;1369.2332293915408;1657.4447560067376;6858.828529286764;7588.051493563305;7835;7853.136155022958;8047.074586422563;7851.411144164182;7938.9603051984805;7940.444168908164;7946.046474423078;7947.960260198691;2128.1061953979365;2149.5163588192686;2151.4621344663833;2153.4616345913523;2155.4288113649895;2068.121048554366;2108.546662467569;2128.106195397929;2137.1771867830844;2137.7969092936223;2066.5246993191577;2080.282302605606;2083.062621820187;2090.4042347930845;2093.3510611710344;2078.896055197242;2086.082123865502;2090.0385822521657;2092.5605622819226;2093.235968871351;2018.9495262618404;2087.686846972951;2091;2097.2030628361276;2098.9370318890456;7408.111026676779;7729.072511298624;7826.960865195694;7849.372050236025;7875.4487185897015;4537.160625284333;4678.625709943196;4681.321208424793;4684.906301873943;4686.7656617169005;2753.2841461220028;2866.082853486885;2895.406441679451;2935.6623988241413;2937.2950491882007;925.4493576322078;930.15356026016;937.3672770879629;938.3191675272038;944.6599224279254;10339.638112666096;10397.740056498573;10406.167506599453;10437.634682786065;10445.582176712998;3771.7548359356556;3832.080300727861;3942.2010372635177;3952.0317522207242;3960.326779423935;8084.151164127799;8214.178582141858;8215.917840821634;8219.136990616018;8225.136360682161;4450.154470650631;4451.6883818133065;4451.866444006685;4477.888052798641;4491.528389519119;3706.5181526401934;3718.6839118675216;3821.522309711286;4172.895677608084;4174.686898482626;3029.560713696546;3432.3650124727005;3435.3129374124774;3462.4286992646435;3485.5294535237417;992.1913640383065;1017.1151098544314;1026.0509029148009;1028.377831411985;1033.3593172233263;638.444553238676;651.5048563092084;701.6141122382669;717.046328383249;739.648666883237;4701.694389864648;4850.684705494132;4927.211646136601;4959.330490383824;5027.396712394463;353.28988732647565;358.9730770192246;359.8830380126417;364.74285628631753;370.30198076625214;3325.534425180477;3395.898123056312;3410.9147271318416;3433.8626454941523;3471.0454624978333;9025.954870225738;9635;9710.17463515595;9754.317197796086;9765.072318129767;9617.23062155026;9622.711318660451;9623.470709110927;9628.75928101789;9637.42175469474;7131.679074441663;7314.670839812221;7337.0828646419195;7358.374538164316;7358.816029599303;4949.084419382426;4982.451930287738;4987.600991920565;4989.575886049726;5048.924266135938;8595.82808343842;8826.602802873758;8980.371374003757;8993.415427997159;9014.2788576915;8909.910900891167;8958.10418958099;9023.097690230925;9032.096790321179;9071.637134514545;5834.474897259097;6045.848853778691;6046.244219472566;6208.379162083756;6209.068639704081;7161.9641901790155;7384.9261507384235;7434.59109748969;7602.543847369176;7617.238276172338;6670.366315200048;6835.760748373783;6841.350071743176;6892.483063770137;6905.136857892763;6805;6812;6825.078614386995;6868.175818901764;6877;5842.970785146217;5962.821115366546;5994.850128746816;6032;6058.757649693963;4312.547182545787;4320.524742278284;4383.452068491439;4444.511103778517;4483.327500874764;4323.675724320626;4332.978335108431;4348.978255108705;4360.040791025969;4443.178012067778 04:07:17 INFO - PROCESS | 10740 | |4;prototype.html;288.6262290334017;299.4310809462022;303.44318176146777;304.1104768551985;305.5813535456425;4661.184292748772;4793.736344501055;4839.951600483994;4861.347141971729;4889.291052797343;4675.672702910798;4785.497522760113;4811.663183577151;4830.44449888263;4849.763310355855;3813.1420430403214;3838.750481218726;3839;3851.1527463957955;3855.6722678572355;3560.412531932241;3609.5127157833617;3849.191669749356;3856.3058649443087;3865.5168103987003;3760.830762615675;3762.3039737648487;3777.2067865748227;3781;3795.2219794942107;3772.2832661794446;3775.9993601695573;3781.149241420686;3787.337215987191;3792.374258247386;3317.4526203176447;3322.4850148227065;3336.8498417571027;3338.6160591532043;3343.8829640962695;4508.864734057984;4638.2115040443205;4664.137134630104;4684.882877928045;4702.388689470381;4302.462192225972;4313.892152696177;4319.892002699926;4326.935095973563;4329.7618630975285;4992.251162325644;5003;5007.974960125212;5011.098002359574;5081.923771143436;3361.2437201629436;3567.6075631680496;3666.4500324951205;3685.981570092132;3703.4444833274956;5243.187305967581;5256.132738098209;5271.683698978035;5277.366715994105;5281;3634.582023067328;3636.254567813592;3639.6706108090843;3641.5812181598926;3642.5264715586804;3680.0983758979223;3688.409854423333;3702.4631428442726;3712.5916149223563;3714.832832522543;4150.768356002469;4208.957910420918;4222.662187025031;4239.448871646728;4239.851605193803;4987.152184128634;4997.0011995201485;5003.099442100457;5045.47022562633;5078.5937125029905;1199.2924174736772;1205.6624145239348;1236.7402845402387;1259.2192840438804;1277.8849903508542;858.1161403754144;860.5912191709014;878.4904755241944;880.2483058713243;884.6992022712309;4378.540253273361;4384.386185933972;4393.648508119343;4394.472663280427;4399.780010999501;5061.342025536656;5073.34046573943;5078.669886457443;5103.923441148386;5139.58883289336;4363.192809330284;4371.207804800017;4401.2297847877135;4402.7358358498595;4403.207422663952;2306.4695120122465;2408.8193385495806;2412;2412.7707867752533;2433.7444568320425;4272.679549033773;4278.277898228561;4288.7212331199;4308.5045219799495;4312.353147027971;4627.755538563794;4633.235516139799;4636.095961287517;4675.929861052087;4706.51717728885;4073.307537718595;4306.913861722748;4328.848490302824;4339.956600433955;4345;4508.526604706459;4543.227651299221;4569;4572.839950601713;4582.656300777388;4448.466184057934;4483.730976141442;4491.528389519184;4507.932381014353;4522.389477420506;4105.815238314223;4258.913976935862;4265.87202383929;4280.400743895795;4308.396824444643;3292.506124081407;3300.224447254941;3312.9189853436537;3316.403047451385;3346.314005628889;4569.29175977724;4577.496475387638;4586.26219631013;4615.399988009358;4952.876178095432;4927.482614325588;4948.307236986897;4952.4057113146655;5004.549590536869;5010;4985.277134815504;4988.476209997898;5027.924581131359;5032.3206367139965;5034.521720436553;4820.807167713252;4973.9751301244705;4990.6506544541535;5008.223725322581;5033.798648054183;4991.700497970133;5009.148444764472;5010.674306170087;5040.5382439092255;5053.140966035709;4885.633577481632;4900.823802287354;4934.111859865258;4947.356843610308;4953.826616068421 04:07:17 INFO - PROCESS | 10740 | |5;yui.html;593.9368530330709;628.4155735166294;641.4675819070169;704.9013138160656;715.1561157833755;11782.823257651131;12655.303958282291;12704.4918203272;12737.299448530328;12741.299228542426;13064.346782660876;13103.934480327585;13134;13190.142640728345;13220.801687974688;598.3836648252307;612.6936531734133;735.9926400735991;739.9778006659809;751.6241879060469;745.1542499263348;757.9696812127536;760.243557660129;760.6310939194486;761.0106861080601;790.8853216283635;793.5159552672894;793.761871438569;793.9960300198491;794.2295972906271;633.6134957675814;648.8929326661096;766.2146300042501;787.358302983067;787.472393496356;575.5395683453221;579.5247896724687;579.6058680097532;580.9767609295623;581.0934941491245;12024.278543287432;12081.516739330416;12090.516379344816;12130;12140.817887731691;12222;12403;12625.558105466356;13077.869221307856;13152.736945261042;11143.387113708743;11487.540498380054;11754.764904701944;11782;12639;4053.8175782089875;4060.3503439449546;4122.690798190148;4143.254214241435;4179.435776170209;60884;61010;61065.694671526355;61117.08324375138;61222;9745.220382369393;9872.923261951108;10388.428636424918;10495.160387169008;10743.14054875608;19043.14305856212;19043.143058562397;19045.809921817177;19054.42836714901;19076.71384929227;6637.502187335969;6642.933570664328;6656.4009239167735;6665.166854143232;6677.432418244406;3360.327934413127;3417.5044618530173;3460.0830779843363;3623.3840247158046;3625.12996880752;2740.5615101583653;2833.957490637642;2843.6018957345987;2846.146156153146;2853.6004959305715;473.07749887719086;479.9736014519165;482.582566080338;484.46224690593414;487.58555228056576;425.6594724220673;501.79677230721614;550.1637510983282;554.5064892245904;569.39359582045;7750.496217745828;8006.559639219782;8059.395545334006;8108.513489190667;8277.255047045795;426.6288329153594;485.381139047717;514.3442111308112;600.5825950964038;606.824021033904;3760.1163726524246;3906.921861562753;3924.17592305619;3995.0411901143516;4055.229506393776;55436;55686.44313556894;55987.44012559822;56121.158182627296;58158.418415816144;89217;89288;89357;90723;91382;58971.115433267674;60418.697906510184;72969;75225.24774752292;75572;8099.352051835721;8381.580920953806;8938.597763100806;8939.59771810283;9038.276937844825;43239.35140972951;43604;43631.56368436275;43907.78046109749;44232;48978.5102148974;60836.39163608307;61356.386436135064;62364.37635623767;63307.6834615824;11190.776184476428;11194.83207751868;11255.66233013011;11422.485988130387;11716.179867409199;11837.368988099053;11874.346910919638;12055.698607534881;12056.51773929033;12140.150189487005;11724.680958535657;11828.112891533341;11847.348395838311;12190.634280971584;12307.967397296916;11240.325580465198;11781.469833857669;12208.938955305523;12526.937365313115;12625.747485050431;11338.943305283421;11340.6030788922;11498.13763967689;11707.121965852424;11795.407619971194;9692.41845489273;9804.215662746821;10118.79762404733;10274.890965732087;10383.428911409945;10052.810260279093;10351.689449316533;10371.636992705218;10373.533191006272;10445.373277603368 04:07:17 INFO - PROCESS | 10740 | __end_tp_report 04:07:17 INFO - PROCESS | 10740 | __start_cc_report 04:07:17 INFO - PROCESS | 10740 | _x_x_mozilla_cycle_collect,1356 04:07:17 INFO - PROCESS | 10740 | __end_cc_report 04:07:17 INFO - PROCESS | 10740 | __startTimestamp1475665637534__endTimestamp 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | ------- Summary: start ------- 04:07:17 INFO - PROCESS | 10740 | Number of tests: 6 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | [#0] dojo.html Cycles:165 Average:4699.86 Median:4820.20 stddev:490.99 (10.2%) stddev-sans-first:463.86 04:07:17 INFO - PROCESS | 10740 | Values: 2593.7 2615.2 2645.1 2649.1 2664.9 4671.2 4712.6 4743.4 4820.2 4871.3 4775.9 4790.1 4813.0 4845.0 4893.5 4264.2 4293.5 4319.8 4325.9 4461.1 4398.9 4438.3 4439.1 4442.6 4466.7 4395.4 4428.4 4437.2 4442.3 4482.7 4248.2 4284.7 4287.1 4337.4 4377.3 4304.7 4312.1 4339.6 4406.5 4422.5 4757.6 4757.8 4758.1 4795.9 4836.5 4998.5 5023.4 5028.9 5095.7 5131.4 5046.0 5085.2 5115.9 5153.0 5166.4 4734.5 4743.1 4761.7 4770.7 4805.3 5020.4 5062.3 5162.5 5175.3 5225.5 4943.0 4943.8 4944.7 4947.3 4949.3 5003.1 5005.3 5010.5 5017.7 5018.3 4940.5 4975.0 4980.7 4994.2 5011.6 4978.8 5030.1 5031.6 5078.6 5095.7 4349.6 4351.7 4352.0 4391.3 4404.0 3795.8 3796.1 3798.0 3803.4 3821.1 4353.6 4357.2 4375.8 4384.7 4432.0 5119.5 5151.5 5160.7 5160.8 5225.7 4248.6 4388.6 4389.8 4398.2 4449.6 4524.6 4559.8 4580.5 4597.1 4671.8 4764.3 4768.9 4770.1 4770.3 4826.4 5077.6 5096.1 5107.3 5110.1 5174.6 4606.7 4643.7 4719.5 4747.7 4781.4 5044.0 5049.8 5051.5 5053.7 5113.7 5117.5 5118.7 5119.5 5120.5 5166.3 4872.1 4916.0 4916.6 4919.0 4973.6 4933.4 4994.6 5052.1 5057.0 5057.8 4913.7 4936.0 4938.5 4946.2 4999.9 4820.0 5000.3 5043.8 5052.6 5100.1 4740.9 4787.4 4838.2 4849.5 4932.4 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | [#1] ext.html Cycles:180 Average:44683.33 Median:34995.48 stddev:81951.71 (234.2%) stddev-sans-first:82114.60 04:07:17 INFO - PROCESS | 10740 | Values: 545.1 556.7 570.7 571.6 573.4 27689.0 37894.4 39062.8 39144.6 42896.4 39653.2 40130.4 40184.8 40186.8 40232.0 7611.5 7757.1 7758.8 7760.3 7763.1 7525.9 7610.5 7611.0 7617.3 7620.5 7592.0 7638.8 7639.0 7640.0 7642.3 7578.2 7587.2 7602.3 7610.2 7627.2 7533.6 7619.9 7629.0 7631.0 7639.0 37198.1 37527.2 37539.8 37573.2 37574.6 2923.7 2983.1 3058.0 3229.2 3240.2 27622.7 28098.2 28517.4 29065.0 29663.6 3443.4 3472.6 3482.5 3485.8 3542.7 247843.0 249298.0 249372.0 251463.0 252186.0 31254.2 32252.5 49693.0 50158.2 50192.0 33096.3 33376.0 33411.8 33426.5 33429.8 12608.2 12689.7 12693.2 12719.0 12722.3 10264.2 10329.1 10340.8 10342.5 10350.4 7819.5 7850.1 7875.3 7949.7 7974.8 3082.9 3083.4 3089.8 3101.3 3151.4 816.4 816.6 839.0 878.5 931.0 26823.0 27247.5 28068.0 28322.9 28507.4 759.3 924.0 939.6 981.7 992.4 14091.8 15008.7 15071.5 15273.2 15363.2 374432.0 375586.0 375955.0 377027.0 377493.1 48158.0 48382.3 48749.0 48904.8 48923.0 1015.8 1100.1 1136.1 1148.0 1175.6 25288.0 28461.6 28937.0 29333.3 29488.7 40193.6 40645.6 40665.8 40736.4 40737.4 291260.0 293545.0 293765.0 293934.0 294123.0 24545.1 24547.8 25312.4 25334.5 26513.7 40317.0 40552.4 40838.8 41013.0 41623.4 34645.8 34970.8 35003.5 35176.6 35376.0 34659.5 34765.0 34987.5 35199.3 35321.8 33745.0 34181.8 34552.0 34797.8 35062.8 29724.0 31798.7 31925.7 32176.5 32264.0 24437.5 24792.4 24885.1 25261.4 25265.9 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | [#2] jquery.html Cycles:180 Average:24388.65 Median:429.76 stddev:64633.31 (15039.4%) stddev-sans-first:64789.40 04:07:17 INFO - PROCESS | 10740 | Values: 340.2 355.2 358.3 361.3 384.5 12283.4 15442.2 15952.2 16392.0 17326.2 16286.6 16492.7 16724.2 16943.7 17090.7 3912.2 4822.9 5004.8 5037.6 5059.1 4952.8 5045.9 5046.3 5048.2 5048.2 4817.3 4974.4 5005.0 5008.2 5012.4 4972.5 5020.3 5024.7 5024.7 5024.9 4286.6 4429.2 4433.7 4491.1 4494.4 19842.7 19864.1 20042.2 20062.0 20457.6 1832.9 1874.5 1886.6 1954.0 2346.9 12635.2 12657.0 12854.4 13409.4 13489.5 1705.9 1734.7 1737.8 1765.2 1786.8 67289.7 68852.7 69000.0 70560.0 70845.6 9115.3 9333.4 9407.9 9479.4 10194.5 12364.9 12409.0 12447.8 12461.9 12476.3 6704.4 6864.9 6908.5 7043.3 7096.6 6545.7 6573.0 6736.6 6821.8 6827.9 5693.5 5761.7 5769.9 5844.0 6010.2 1665.9 1688.9 1689.7 1695.4 1696.2 795.9 878.4 880.6 942.1 976.4 16691.6 16766.0 17399.8 17420.7 17793.9 829.3 868.3 881.0 883.1 911.3 8748.3 9137.0 9337.9 9400.7 9567.5 372779.0 375510.0 395800.0 403000.5 405094.0 77664.0 81803.0 82816.0 84758.6 85709.0 408.7 429.1 429.7 429.8 431.2 13733.2 14605.5 15618.8 15668.0 16300.8 37778.4 38049.8 38601.3 38737.2 38918.4 46508.0 47549.3 47721.3 49978.8 50104.2 7583.0 7713.1 7766.8 8006.1 8061.6 8783.6 11923.7 11964.9 11990.2 12033.6 9845.8 10290.5 10573.5 10744.0 10892.7 9768.2 10492.8 10538.5 10716.0 10725.7 10584.8 10630.9 10753.5 10865.6 11176.3 7713.4 7755.0 7942.7 8003.6 8050.3 7928.4 9147.3 10279.9 10518.3 10599.9 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | [#3] mootools.html Cycles:180 Average:4987.29 Median:4888.95 stddev:2881.85 (58.9%) stddev-sans-first:2875.84 04:07:17 INFO - PROCESS | 10740 | Values: 1194.8 1282.7 1346.2 1369.2 1657.4 6858.8 7588.1 7835.0 7853.1 8047.1 7851.4 7939.0 7940.4 7946.0 7948.0 2128.1 2149.5 2151.5 2153.5 2155.4 2068.1 2108.5 2128.1 2137.2 2137.8 2066.5 2080.3 2083.1 2090.4 2093.4 2078.9 2086.1 2090.0 2092.6 2093.2 2018.9 2087.7 2091.0 2097.2 2098.9 7408.1 7729.1 7827.0 7849.4 7875.4 4537.2 4678.6 4681.3 4684.9 4686.8 2753.3 2866.1 2895.4 2935.7 2937.3 925.4 930.2 937.4 938.3 944.7 10339.6 10397.7 10406.2 10437.6 10445.6 3771.8 3832.1 3942.2 3952.0 3960.3 8084.2 8214.2 8215.9 8219.1 8225.1 4450.2 4451.7 4451.9 4477.9 4491.5 3706.5 3718.7 3821.5 4172.9 4174.7 3029.6 3432.4 3435.3 3462.4 3485.5 992.2 1017.1 1026.1 1028.4 1033.4 638.4 651.5 701.6 717.0 739.6 4701.7 4850.7 4927.2 4959.3 5027.4 353.3 359.0 359.9 364.7 370.3 3325.5 3395.9 3410.9 3433.9 3471.0 9026.0 9635.0 9710.2 9754.3 9765.1 9617.2 9622.7 9623.5 9628.8 9637.4 7131.7 7314.7 7337.1 7358.4 7358.8 4949.1 4982.5 4987.6 4989.6 5048.9 8595.8 8826.6 8980.4 8993.4 9014.3 8909.9 8958.1 9023.1 9032.1 9071.6 5834.5 6045.8 6046.2 6208.4 6209.1 7162.0 7384.9 7434.6 7602.5 7617.2 6670.4 6835.8 6841.4 6892.5 6905.1 6805.0 6812.0 6825.1 6868.2 6877.0 5843.0 5962.8 5994.9 6032.0 6058.8 4312.5 4320.5 4383.5 4444.5 4483.3 4323.7 4333.0 4349.0 4360.0 4443.2 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | [#4] prototype.html Cycles:180 Average:4042.97 Median:4397.13 stddev:1165.90 (26.5%) stddev-sans-first:1134.61 04:07:17 INFO - PROCESS | 10740 | Values: 288.6 299.4 303.4 304.1 305.6 4661.2 4793.7 4840.0 4861.3 4889.3 4675.7 4785.5 4811.7 4830.4 4849.8 3813.1 3838.8 3839.0 3851.2 3855.7 3560.4 3609.5 3849.2 3856.3 3865.5 3760.8 3762.3 3777.2 3781.0 3795.2 3772.3 3776.0 3781.1 3787.3 3792.4 3317.5 3322.5 3336.8 3338.6 3343.9 4508.9 4638.2 4664.1 4684.9 4702.4 4302.5 4313.9 4319.9 4326.9 4329.8 4992.3 5003.0 5008.0 5011.1 5081.9 3361.2 3567.6 3666.5 3686.0 3703.4 5243.2 5256.1 5271.7 5277.4 5281.0 3634.6 3636.3 3639.7 3641.6 3642.5 3680.1 3688.4 3702.5 3712.6 3714.8 4150.8 4209.0 4222.7 4239.4 4239.9 4987.2 4997.0 5003.1 5045.5 5078.6 1199.3 1205.7 1236.7 1259.2 1277.9 858.1 860.6 878.5 880.2 884.7 4378.5 4384.4 4393.6 4394.5 4399.8 5061.3 5073.3 5078.7 5103.9 5139.6 4363.2 4371.2 4401.2 4402.7 4403.2 2306.5 2408.8 2412.0 2412.8 2433.7 4272.7 4278.3 4288.7 4308.5 4312.4 4627.8 4633.2 4636.1 4675.9 4706.5 4073.3 4306.9 4328.8 4340.0 4345.0 4508.5 4543.2 4569.0 4572.8 4582.7 4448.5 4483.7 4491.5 4507.9 4522.4 4105.8 4258.9 4265.9 4280.4 4308.4 3292.5 3300.2 3312.9 3316.4 3346.3 4569.3 4577.5 4586.3 4615.4 4952.9 4927.5 4948.3 4952.4 5004.5 5010.0 4985.3 4988.5 5027.9 5032.3 5034.5 4820.8 4974.0 4990.7 5008.2 5033.8 4991.7 5009.1 5010.7 5040.5 5053.1 4885.6 4900.8 4934.1 4947.4 4953.8 04:07:17 INFO - PROCESS | 10740 | 04:07:17 INFO - PROCESS | 10740 | [#5] yui.html Cycles:180 Average:16482.02 Median:43769.67 stddev:22318.92 (51.0%) stddev-sans-first:22349.64 04:07:17 INFO - PROCESS | 10740 | Values: 593.9 628.4 641.5 704.9 715.2 11782.8 12655.3 12704.5 12737.3 12741.3 13064.3 13103.9 13134.0 13190.1 13220.8 598.4 612.7 736.0 740.0 751.6 745.2 758.0 760.2 760.6 761.0 790.9 793.5 793.8 794.0 794.2 633.6 648.9 766.2 787.4 787.5 575.5 579.5 579.6 581.0 581.1 12024.3 12081.5 12090.5 12130.0 12140.8 12222.0 12403.0 12625.6 13077.9 13152.7 11143.4 11487.5 11754.8 11782.0 12639.0 4053.8 4060.4 4122.7 4143.3 4179.4 60884.0 61010.0 61065.7 61117.1 61222.0 9745.2 9872.9 10388.4 10495.2 10743.1 19043.1 19043.1 19045.8 19054.4 19076.7 6637.5 6642.9 6656.4 6665.2 6677.4 3360.3 3417.5 3460.1 3623.4 3625.1 2740.6 2834.0 2843.6 2846.1 2853.6 473.1 480.0 482.6 484.5 487.6 425.7 501.8 550.2 554.5 569.4 7750.5 8006.6 8059.4 8108.5 8277.3 426.6 485.4 514.3 600.6 606.8 3760.1 3906.9 3924.2 3995.0 4055.2 55436.0 55686.4 55987.4 56121.2 58158.4 89217.0 89288.0 89357.0 90723.0 91382.0 58971.1 60418.7 72969.0 75225.2 75572.0 8099.4 8381.6 8938.6 8939.6 9038.3 43239.4 43604.0 43631.6 43907.8 44232.0 48978.5 60836.4 61356.4 62364.4 63307.7 11190.8 11194.8 11255.7 11422.5 11716.2 11837.4 11874.3 12055.7 12056.5 12140.2 11724.7 11828.1 11847.3 12190.6 12308.0 11240.3 11781.5 12208.9 12526.9 12625.7 11338.9 11340.6 11498.1 11707.1 11795.4 9692.4 9804.2 10118.8 10274.9 10383.4 10052.8 10351.7 10371.6 10373.5 10445.4 04:07:17 INFO - PROCESS | 10740 | -------- Summary: end -------- 04:07:17 INFO - PROCESS | 10740 | 04:07:18 INFO - TEST-INFO | 10740: exit 0 04:07:18 INFO - TEST-OK | dromaeo_css | took 1121930ms 04:07:18 INFO - TEST-START | kraken 04:07:18 INFO - operating with platform_type : linux_ 04:07:18 INFO - Initialising browser for kraken test... 04:07:18 INFO - TEST-INFO | started process 11050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKuVVYU/profile http://localhost:39466/getInfo.html) 04:07:23 INFO - PROCESS | 11050 | __metrics Screen width/height:1600/1200 04:07:23 INFO - PROCESS | 11050 | colorDepth:24 04:07:23 INFO - PROCESS | 11050 | Browser inner width/height: 1024/697 04:07:23 INFO - PROCESS | 11050 | __metrics 04:07:23 INFO - PROCESS | 11050 | 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" 04:07:23 INFO - PROCESS | 11050 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:24 INFO - PROCESS | 11050 | console.error: PushService: 04:07:24 INFO - PROCESS | 11050 | stateChangeProcessEnqueue: Error transitioning state 04:07:24 INFO - PROCESS | 11050 | UnknownError 04:07:24 INFO - TEST-INFO | 11050: exit 0 04:07:24 INFO - Browser initialized. 04:07:24 INFO - Running cycle 1/1 for kraken test... 04:07:24 INFO - TEST-INFO | started process 11135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKuVVYU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:37 INFO - PROCESS | 11135 | RSS: Main: 175476736 04:07:37 INFO - PROCESS | 11135 | 04:07:39 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39466/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:40 INFO - PROCESS | 11135 | RSS: Main: 233807872 04:07:40 INFO - PROCESS | 11135 | 04:07:43 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39466/tests/kraken/driver.html?testName=audio-dft) 04:07:44 INFO - PROCESS | 11135 | RSS: Main: 219230208 04:07:44 INFO - PROCESS | 11135 | 04:07:47 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39466/tests/kraken/driver.html?testName=audio-fft) 04:07:48 INFO - PROCESS | 11135 | RSS: Main: 300298240 04:07:48 INFO - PROCESS | 11135 | 04:07:50 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39466/tests/kraken/driver.html?testName=audio-oscillator) 04:07:50 INFO - PROCESS | 11135 | RSS: Main: 211599360 04:07:50 INFO - PROCESS | 11135 | 04:07:53 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:53 INFO - PROCESS | 11135 | RSS: Main: 214884352 04:07:53 INFO - PROCESS | 11135 | 04:07:56 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39466/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:57 INFO - PROCESS | 11135 | RSS: Main: 250945536 04:07:57 INFO - PROCESS | 11135 | 04:08:01 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39466/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:01 INFO - PROCESS | 11135 | RSS: Main: 245510144 04:08:01 INFO - PROCESS | 11135 | 04:08:04 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39466/tests/kraken/driver.html?testName=json-parse-financial) 04:08:05 INFO - PROCESS | 11135 | RSS: Main: 247545856 04:08:05 INFO - PROCESS | 11135 | 04:08:06 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:07 INFO - PROCESS | 11135 | RSS: Main: 211275776 04:08:07 INFO - PROCESS | 11135 | 04:08:09 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:10 INFO - PROCESS | 11135 | RSS: Main: 218583040 04:08:10 INFO - PROCESS | 11135 | 04:08:12 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:12 INFO - PROCESS | 11135 | RSS: Main: 228253696 04:08:12 INFO - PROCESS | 11135 | 04:08:15 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:16 INFO - PROCESS | 11135 | RSS: Main: 236105728 04:08:16 INFO - PROCESS | 11135 | 04:08:19 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:20 INFO - PROCESS | 11135 | RSS: Main: 233340928 04:08:20 INFO - PROCESS | 11135 | 04:08:21 INFO - PROCESS | 11135 | Cycle 1(1): loaded http://localhost:39466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39466/tests/kraken/driver.html?testName=ai-astar) 04:08:22 INFO - PROCESS | 11135 | RSS: Main: 283906048 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | __start_tp_report 04:08:22 INFO - PROCESS | 11135 | _x_x_mozilla_page_load 04:08:22 INFO - PROCESS | 11135 | _x_x_mozilla_page_load_details 04:08:22 INFO - PROCESS | 11135 | |i|pagename|runs| 04:08:22 INFO - PROCESS | 11135 | |0;ai-astar;112;115;114;117;116;116;113;116;115;112 04:08:22 INFO - PROCESS | 11135 | |1;audio-beat-detection;156;132;132;169;128;128;127;129;176;128 04:08:22 INFO - PROCESS | 11135 | |2;audio-dft;161;162;162;162;162;161;161;161;162;163 04:08:22 INFO - PROCESS | 11135 | |3;audio-fft;76;75;75;105;77;77;76;75;101;78 04:08:22 INFO - PROCESS | 11135 | |4;audio-oscillator;84;84;126;84;83;85;107;84;84;118 04:08:22 INFO - PROCESS | 11135 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;119;118;125 04:08:22 INFO - PROCESS | 11135 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;146 04:08:22 INFO - PROCESS | 11135 | |7;imaging-desaturate;95;95;95;95;96;96;96;96;95;95 04:08:22 INFO - PROCESS | 11135 | |8;json-parse-financial;64;64;64;64;64;65;65;66;72;71 04:08:22 INFO - PROCESS | 11135 | |9;json-stringify-tinderbox;66;67;67;66;66;67;68;67;66;68 04:08:22 INFO - PROCESS | 11135 | |10;stanford-crypto-aes;93;85;84;84;89;82;84;96;82;96 04:08:22 INFO - PROCESS | 11135 | |11;stanford-crypto-ccm;141;146;138;136;136;136;148;136;182;142 04:08:22 INFO - PROCESS | 11135 | |12;stanford-crypto-pbkdf2;175;173;175;181;175;180;176;177;174;174 04:08:22 INFO - PROCESS | 11135 | |13;stanford-crypto-sha256-iterative;71;77;70;69;77;71;70;69;68;68 04:08:22 INFO - PROCESS | 11135 | __end_tp_report 04:08:22 INFO - PROCESS | 11135 | __start_cc_report 04:08:22 INFO - PROCESS | 11135 | _x_x_mozilla_cycle_collect,1964 04:08:22 INFO - PROCESS | 11135 | __end_cc_report 04:08:22 INFO - PROCESS | 11135 | __startTimestamp1475665702146__endTimestamp 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | ------- Summary: start ------- 04:08:22 INFO - PROCESS | 11135 | Number of tests: 14 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.50 stddev:1.78 (1.5%) stddev-sans-first:1.62 04:08:22 INFO - PROCESS | 11135 | Values: 112.0 115.0 114.0 117.0 116.0 116.0 113.0 116.0 115.0 112.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:132.00 stddev:18.98 (14.4%) stddev-sans-first:19.28 04:08:22 INFO - PROCESS | 11135 | Values: 156.0 132.0 132.0 169.0 128.0 128.0 127.0 129.0 176.0 128.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:08:22 INFO - PROCESS | 11135 | Values: 161.0 162.0 162.0 162.0 162.0 161.0 161.0 161.0 162.0 163.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.41 (15.0%) stddev-sans-first:11.93 04:08:22 INFO - PROCESS | 11135 | Values: 76.0 75.0 75.0 105.0 77.0 77.0 76.0 75.0 101.0 78.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:16.57 (19.7%) stddev-sans-first:17.18 04:08:22 INFO - PROCESS | 11135 | Values: 84.0 84.0 126.0 84.0 83.0 85.0 107.0 84.0 84.0 118.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:118.00 stddev:2.26 (1.9%) stddev-sans-first:2.39 04:08:22 INFO - PROCESS | 11135 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 125.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:08:22 INFO - PROCESS | 11135 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:08:22 INFO - PROCESS | 11135 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:3.03 (4.7%) stddev-sans-first:3.14 04:08:22 INFO - PROCESS | 11135 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 65.0 66.0 72.0 71.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 04:08:22 INFO - PROCESS | 11135 | Values: 66.0 67.0 67.0 66.0 66.0 67.0 68.0 67.0 66.0 68.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:5.58 (6.4%) stddev-sans-first:5.56 04:08:22 INFO - PROCESS | 11135 | Values: 93.0 85.0 84.0 84.0 89.0 82.0 84.0 96.0 82.0 96.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:141.50 stddev:14.02 (9.9%) stddev-sans-first:14.82 04:08:22 INFO - PROCESS | 11135 | Values: 141.0 146.0 138.0 136.0 136.0 136.0 148.0 136.0 182.0 142.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:175.50 stddev:2.62 (1.5%) stddev-sans-first:2.76 04:08:22 INFO - PROCESS | 11135 | Values: 175.0 173.0 175.0 181.0 175.0 180.0 176.0 177.0 174.0 174.0 04:08:22 INFO - PROCESS | 11135 | 04:08:22 INFO - PROCESS | 11135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:3.33 (4.7%) stddev-sans-first:3.54 04:08:22 INFO - PROCESS | 11135 | Values: 71.0 77.0 70.0 69.0 77.0 71.0 70.0 69.0 68.0 68.0 04:08:22 INFO - PROCESS | 11135 | -------- Summary: end -------- 04:08:22 INFO - PROCESS | 11135 | 04:08:23 INFO - TEST-INFO | 11135: exit 0 04:08:23 INFO - TEST-OK | kraken | took 64941ms 04:08:23 INFO - SUITE-END | took 1186s 04:08:23 INFO - Completed test suite (00:19:47) 04:08:23 INFO - javascript benchmark 04:08:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.714691383948, 2615.2023632791993, 2645.061003343813, 2649.0728245114215, 2664.853433061181, 4671.182543054961, 4712.5994290485305, 4743.383360163182, 4820.204666230068, 4871.2936624189515, 4775.90448191036, 4790.089882922242, 4813.037392521493, 4844.951550484494, 4893.4861839506875, 4264.189803937257, 4293.463317085364, 4319.848805291816, 4325.9351109733225, 4461.107778444316, 4398.912021759563, 4438.267685831834, 4439.067795762894, 4442.577955094261, 4466.749310193151, 4395.384646149541, 4428.446444194476, 4437.179121862466, 4442.267025940716, 4482.731036137826, 4248.235317642823, 4284.742915425085, 4287.121140166259, 4337.414449049369, 4377.321515165155, 4304.6771492137905, 4312.116016216668, 4339.631131353839, 4406.493253275882, 4422.491413487458, 4757.643176761722, 4757.833475828364, 4758.072175925696, 4795.856124316276, 4836.51634836517, 4998.450170481244, 5023.397192336906, 5028.899422011576, 5095.694258344474, 5131.384233891919, 5045.974770126162, 5085.211792172219, 5115.872103197413, 5153.0, 5166.43169251382, 4734.526547345273, 4743.051389722001, 4761.738104404291, 4770.689905156154, 4805.327254184417, 5020.447750747415, 5062.316587260746, 5162.45794191612, 5175.301334319894, 5225.50357716024, 4943.0, 4943.777530011158, 4944.653874228841, 4947.282644016669, 4949.307097006422, 5003.149464591028, 5005.299258103868, 5010.473900240495, 5017.698938063655, 5018.2974383586325, 4940.530649588283, 4975.0, 4980.676256043345, 4994.225894986283, 5011.6241281904, 4978.8257410990445, 5030.144875371196, 5031.622628302892, 5078.644494885322, 5095.719735414514, 4349.630281426114, 4351.73889566627, 4351.9564804352185, 4391.3193455014525, 4403.9779801100785, 3795.8481660733814, 3796.145867179918, 3797.9810100949317, 3803.391457366808, 3821.121142137324, 4353.6299414549485, 4357.1939191249085, 4375.78121093944, 4384.714993525411, 4432.0, 5119.513646203604, 5151.5363617274625, 5160.716160611202, 5160.819371322061, 5225.6603320784025, 4248.553901840262, 4388.561143885586, 4389.780510974439, 4398.208322501916, 4449.621782148553, 4524.5927866492175, 4559.772011399483, 4580.496145424001, 4597.103564804898, 4671.8364857229835, 4764.30917516965, 4768.856934291976, 4770.117528257353, 4770.260609605517, 4826.444958829779, 5077.619178561697, 5096.1336572781975, 5107.284980102714, 5110.131277682728, 5174.560162386088, 4606.723596584216, 4643.698159619614, 4719.457262414729, 4747.691400058985, 4781.378420805273, 5043.99120175959, 5049.798008079782, 5051.469595692546, 5053.67151135175, 5113.667611605382, 5117.488251174853, 5118.718470484159, 5119.539241468136, 5120.462351453044, 5166.2508936203285, 4872.123017856678, 4916.0, 4916.606671466346, 4919.0407870464915, 4973.577245934136, 4933.432655244693, 4994.625403094709, 5052.065367906949, 5056.974715126401, 5057.8229761958155, 4913.65604407688, 4935.950640493549, 4938.456769755252, 4946.208606623067, 4999.875003124951, 4820.0, 5000.274960130833, 5043.773030213722, 5052.621053420935, 5100.132977393778, 4740.881477963078, 4787.42550893895, 4838.201696720002, 4849.539293767087, 4932.383452068491], "value": 4668.3571669441435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.0543307361727, 556.6910364747566, 570.6889745088926, 571.6027360984115, 573.3692937768454, 27689.0, 37894.43158352623, 39062.804685976604, 39144.60855391449, 42896.356554651706, 39653.206935861264, 40130.39804402936, 40184.79907600465, 40186.79906600463, 40232.0, 7611.505252158606, 7757.10793258774, 7758.806029849243, 7760.262775036391, 7763.146053934062, 7525.9463675085535, 7610.467267291292, 7611.048618922635, 7617.314441700246, 7620.542767433944, 7592.0, 7638.8472230555635, 7639.04511936008, 7640.044994375703, 7642.273983971514, 7578.166401695809, 7587.241275872424, 7602.277783610548, 7610.1628820829665, 7627.237276272356, 7533.623318834091, 7619.885701714478, 7629.046369203849, 7630.961845190794, 7639.0, 37198.09420010914, 37527.24945501102, 37539.812300938596, 37573.248535029146, 37574.624253757385, 2923.7368636822575, 2983.149802306354, 3058.01303496643, 3229.160418291261, 3240.1575590346442, 27622.723772762216, 28098.173618714718, 28517.429651407063, 29065.0, 29663.55504667432, 3443.4318337474288, 3472.635373285794, 3482.4776283557417, 3485.8431370588382, 3542.681158695704, 247843.0, 249298.0, 249372.0, 251463.0, 252186.0, 31254.21864453407, 32252.516212256836, 49693.0, 50158.247626285636, 50192.0, 33096.3380732384, 33376.0, 33411.83294083514, 33426.49860252098, 33429.83285083559, 12608.243505389706, 12689.682757931125, 12693.174943628635, 12719.046071544486, 12722.300273485047, 10264.178865690727, 10329.070383665507, 10340.793184136275, 10342.482875856178, 10350.378977261389, 7819.491733037335, 7850.136484986647, 7875.291223789886, 7949.682012719542, 7974.840503189904, 3082.892098776532, 3083.383323335342, 3089.7991630543943, 3101.3177101037736, 3151.416987857254, 816.4285000499674, 816.6284340625001, 838.9622466989, 878.5255961780695, 930.9813803723888, 26823.0, 27247.501387423486, 28068.0, 28322.85838570794, 28507.42985140327, 759.2635143910398, 923.9769005774775, 939.5818860607101, 981.6760469045198, 992.369845148336, 14091.78862317066, 15008.699826003418, 15071.4724984625, 15273.159976201194, 15363.155026473427, 374432.0, 375586.0, 375955.0, 377027.0, 377493.1125344356, 48158.0, 48382.27426588604, 48749.0, 48904.75547622239, 48923.0, 1015.7663737340453, 1100.1089117814595, 1136.0911270983345, 1147.9827802582968, 1175.58854400959, 25288.0, 28461.637499876433, 28937.0, 29333.26666833346, 29488.705112949454, 40193.59806402015, 40645.56126632293, 40665.796671016455, 40736.388954165115, 40737.38893916653, 291260.0, 293545.0, 293765.0, 293934.0, 294123.0, 24545.14092006771, 24547.75452245526, 25312.367190820376, 25334.49331013406, 26513.734862651898, 40317.0, 40552.391714124904, 40838.79580602197, 41012.97467563335, 41623.37564936589, 34645.826770865984, 34970.82514587411, 35003.47494787529, 35176.648233517335, 35376.0, 34659.4801077979, 34765.0, 34987.47518787271, 35199.296014080086, 35321.823390882884, 33745.0, 34181.829090854386, 34552.0, 34797.82601086979, 35062.82468587641, 29724.0, 31798.682013179572, 31925.6807431932, 32176.517352239265, 32264.032079037668, 24437.51124977526, 24792.380190495383, 24885.129020484197, 25261.368465788502, 25265.873670632263], "value": 16000.847756228131, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.2327750921671, 355.18130708716416, 358.33707640864395, 361.3477672800595, 384.4617535450369, 12283.385830708463, 15442.150681712501, 15952.202389880504, 16392.0, 17326.220320085595, 16286.592835179126, 16492.670146597062, 16724.2474088666, 16943.745843812354, 17090.658186836255, 3912.1784425270725, 4822.9035419291595, 5004.824831130893, 5037.622178336621, 5059.139946209135, 4952.826651067214, 5045.899082018375, 5046.318746969149, 5048.1670524363435, 5048.217526283432, 4817.349657796205, 4974.403071631391, 5005.0, 5008.198688209887, 5012.398512178544, 4972.477889821571, 5020.322256495363, 5024.673396229234, 5024.723640199788, 5024.924626130611, 4286.57134286572, 4429.180601588684, 4433.689641725081, 4491.146682130385, 4494.393256910341, 19842.70235946462, 19864.106115224706, 20042.1983120675, 20061.996900155078, 20457.590848183103, 1832.8808627439173, 1874.5313671582105, 1886.5566591850904, 1953.9511512212166, 2346.9295921122393, 12635.178713383693, 12657.0, 12854.421551030133, 13409.396577154052, 13489.527866524624, 1705.914704264782, 1734.6964281250857, 1737.7740893683867, 1765.205657454138, 1786.8391844734037, 67289.66355168192, 68852.65573672099, 69000.0, 70560.0, 70845.56121607209, 9115.262742275636, 9333.439993600407, 9407.858882116774, 9479.431234125837, 10194.490275486196, 12364.948979336858, 12409.0, 12447.821631214501, 12461.93769031149, 12476.313802740755, 6704.430123439464, 6864.862702745917, 6908.481863860231, 7043.295670433018, 7096.574205547684, 6545.672716364163, 6573.0463881609985, 6736.595804251662, 6821.829454263584, 6827.897581536281, 5693.459121383462, 5761.683107429131, 5769.913451298234, 5844.035734103825, 6010.188624535632, 1665.8667306615441, 1688.9493315200564, 1689.6705142497342, 1695.4314213965852, 1696.177353983317, 795.908470525897, 878.4334104502688, 880.6125304865967, 942.1191186240886, 976.3751199232497, 16691.582710432336, 16766.0, 17399.826001740075, 17420.65158696819, 17793.911030444764, 829.2992421403904, 868.3443999780126, 880.9867851982225, 883.0551310098133, 911.2618778789202, 8748.256398206096, 9137.0, 9337.859932101024, 9400.717978460658, 9567.473788941676, 372779.0, 375510.0, 395800.0, 403000.4749168942, 405094.0, 77664.0, 81803.0, 82816.0, 84758.57620711857, 85709.0, 408.7036898248746, 429.0753426366186, 429.7421547071732, 429.7765162115682, 431.17430121317324, 13733.244671543162, 14605.488807891672, 15618.765718514003, 15668.0, 16300.799392081917, 37778.43332350072, 38049.809750952176, 38601.29790914609, 38737.225255494166, 38918.4162237561, 46508.0, 47549.28676069793, 47721.28418073662, 49978.75010624924, 50104.24843627421, 7583.0, 7713.112992005991, 7766.7768974853925, 8006.07930088024, 8061.596920154087, 8783.648654053766, 11923.701907452383, 11964.940175299067, 11990.160688751703, 12033.63899083029, 9845.803083938425, 10290.485475726035, 10573.4713264338, 10744.0, 10892.673219803419, 9768.218542516439, 10492.842607361048, 10538.525766340379, 10716.0, 10725.678229653124, 10584.788304234025, 10630.946845265724, 10753.516091776046, 10865.565377384815, 11176.27354221973, 7713.382929365525, 7755.0, 7942.722004729807, 8003.59982000886, 8050.315723163597, 7928.405369597419, 9147.268218542367, 10279.897201027894, 10518.316309439862, 10599.8940010602], "value": 7998.157309812473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1194.8088305871063, 1282.6793301674584, 1346.1519242876989, 1369.2332293915408, 1657.4447560067376, 6858.828529286764, 7588.051493563305, 7835.0, 7853.136155022958, 8047.074586422563, 7851.411144164182, 7938.9603051984805, 7940.444168908164, 7946.046474423078, 7947.960260198691, 2128.1061953979365, 2149.5163588192686, 2151.4621344663833, 2153.4616345913523, 2155.4288113649895, 2068.121048554366, 2108.546662467569, 2128.106195397929, 2137.1771867830844, 2137.7969092936223, 2066.5246993191577, 2080.282302605606, 2083.062621820187, 2090.4042347930845, 2093.3510611710344, 2078.896055197242, 2086.082123865502, 2090.0385822521657, 2092.5605622819226, 2093.235968871351, 2018.9495262618404, 2087.686846972951, 2091.0, 2097.2030628361276, 2098.9370318890456, 7408.111026676779, 7729.072511298624, 7826.960865195694, 7849.372050236025, 7875.4487185897015, 4537.160625284333, 4678.625709943196, 4681.321208424793, 4684.906301873943, 4686.7656617169005, 2753.2841461220028, 2866.082853486885, 2895.406441679451, 2935.6623988241413, 2937.2950491882007, 925.4493576322078, 930.15356026016, 937.3672770879629, 938.3191675272038, 944.6599224279254, 10339.638112666096, 10397.740056498573, 10406.167506599453, 10437.634682786065, 10445.582176712998, 3771.7548359356556, 3832.080300727861, 3942.2010372635177, 3952.0317522207242, 3960.326779423935, 8084.151164127799, 8214.178582141858, 8215.917840821634, 8219.136990616018, 8225.136360682161, 4450.154470650631, 4451.6883818133065, 4451.866444006685, 4477.888052798641, 4491.528389519119, 3706.5181526401934, 3718.6839118675216, 3821.522309711286, 4172.895677608084, 4174.686898482626, 3029.560713696546, 3432.3650124727005, 3435.3129374124774, 3462.4286992646435, 3485.5294535237417, 992.1913640383065, 1017.1151098544314, 1026.0509029148009, 1028.377831411985, 1033.3593172233263, 638.444553238676, 651.5048563092084, 701.6141122382669, 717.046328383249, 739.648666883237, 4701.694389864648, 4850.684705494132, 4927.211646136601, 4959.330490383824, 5027.396712394463, 353.28988732647565, 358.9730770192246, 359.8830380126417, 364.74285628631753, 370.30198076625214, 3325.534425180477, 3395.898123056312, 3410.9147271318416, 3433.8626454941523, 3471.0454624978333, 9025.954870225738, 9635.0, 9710.17463515595, 9754.317197796086, 9765.072318129767, 9617.23062155026, 9622.711318660451, 9623.470709110927, 9628.75928101789, 9637.42175469474, 7131.679074441663, 7314.670839812221, 7337.0828646419195, 7358.374538164316, 7358.816029599303, 4949.084419382426, 4982.451930287738, 4987.600991920565, 4989.575886049726, 5048.924266135938, 8595.82808343842, 8826.602802873758, 8980.371374003757, 8993.415427997159, 9014.2788576915, 8909.910900891167, 8958.10418958099, 9023.097690230925, 9032.096790321179, 9071.637134514545, 5834.474897259097, 6045.848853778691, 6046.244219472566, 6208.379162083756, 6209.068639704081, 7161.9641901790155, 7384.9261507384235, 7434.59109748969, 7602.543847369176, 7617.238276172338, 6670.366315200048, 6835.760748373783, 6841.350071743176, 6892.483063770137, 6905.136857892763, 6805.0, 6812.0, 6825.078614386995, 6868.175818901764, 6877.0, 5842.970785146217, 5962.821115366546, 5994.850128746816, 6032.0, 6058.757649693963, 4312.547182545787, 4320.524742278284, 4383.452068491439, 4444.511103778517, 4483.327500874764, 4323.675724320626, 4332.978335108431, 4348.978255108705, 4360.040791025969, 4443.178012067778], "value": 3893.0670359630963, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.6262290334017, 299.4310809462022, 303.44318176146777, 304.1104768551985, 305.5813535456425, 4661.184292748772, 4793.736344501055, 4839.951600483994, 4861.347141971729, 4889.291052797343, 4675.672702910798, 4785.497522760113, 4811.663183577151, 4830.44449888263, 4849.763310355855, 3813.1420430403214, 3838.750481218726, 3839.0, 3851.1527463957955, 3855.6722678572355, 3560.412531932241, 3609.5127157833617, 3849.191669749356, 3856.3058649443087, 3865.5168103987003, 3760.830762615675, 3762.3039737648487, 3777.2067865748227, 3781.0, 3795.2219794942107, 3772.2832661794446, 3775.9993601695573, 3781.149241420686, 3787.337215987191, 3792.374258247386, 3317.4526203176447, 3322.4850148227065, 3336.8498417571027, 3338.6160591532043, 3343.8829640962695, 4508.864734057984, 4638.2115040443205, 4664.137134630104, 4684.882877928045, 4702.388689470381, 4302.462192225972, 4313.892152696177, 4319.892002699926, 4326.935095973563, 4329.7618630975285, 4992.251162325644, 5003.0, 5007.974960125212, 5011.098002359574, 5081.923771143436, 3361.2437201629436, 3567.6075631680496, 3666.4500324951205, 3685.981570092132, 3703.4444833274956, 5243.187305967581, 5256.132738098209, 5271.683698978035, 5277.366715994105, 5281.0, 3634.582023067328, 3636.254567813592, 3639.6706108090843, 3641.5812181598926, 3642.5264715586804, 3680.0983758979223, 3688.409854423333, 3702.4631428442726, 3712.5916149223563, 3714.832832522543, 4150.768356002469, 4208.957910420918, 4222.662187025031, 4239.448871646728, 4239.851605193803, 4987.152184128634, 4997.0011995201485, 5003.099442100457, 5045.47022562633, 5078.5937125029905, 1199.2924174736772, 1205.6624145239348, 1236.7402845402387, 1259.2192840438804, 1277.8849903508542, 858.1161403754144, 860.5912191709014, 878.4904755241944, 880.2483058713243, 884.6992022712309, 4378.540253273361, 4384.386185933972, 4393.648508119343, 4394.472663280427, 4399.780010999501, 5061.342025536656, 5073.34046573943, 5078.669886457443, 5103.923441148386, 5139.58883289336, 4363.192809330284, 4371.207804800017, 4401.2297847877135, 4402.7358358498595, 4403.207422663952, 2306.4695120122465, 2408.8193385495806, 2412.0, 2412.7707867752533, 2433.7444568320425, 4272.679549033773, 4278.277898228561, 4288.7212331199, 4308.5045219799495, 4312.353147027971, 4627.755538563794, 4633.235516139799, 4636.095961287517, 4675.929861052087, 4706.51717728885, 4073.307537718595, 4306.913861722748, 4328.848490302824, 4339.956600433955, 4345.0, 4508.526604706459, 4543.227651299221, 4569.0, 4572.839950601713, 4582.656300777388, 4448.466184057934, 4483.730976141442, 4491.528389519184, 4507.932381014353, 4522.389477420506, 4105.815238314223, 4258.913976935862, 4265.87202383929, 4280.400743895795, 4308.396824444643, 3292.506124081407, 3300.224447254941, 3312.9189853436537, 3316.403047451385, 3346.314005628889, 4569.29175977724, 4577.496475387638, 4586.26219631013, 4615.399988009358, 4952.876178095432, 4927.482614325588, 4948.307236986897, 4952.4057113146655, 5004.549590536869, 5010.0, 4985.277134815504, 4988.476209997898, 5027.924581131359, 5032.3206367139965, 5034.521720436553, 4820.807167713252, 4973.9751301244705, 4990.6506544541535, 5008.223725322581, 5033.798648054183, 4991.700497970133, 5009.148444764472, 5010.674306170087, 5040.5382439092255, 5053.140966035709, 4885.633577481632, 4900.823802287354, 4934.111859865258, 4947.356843610308, 4953.826616068421], "value": 3677.4267867205685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.9368530330709, 628.4155735166294, 641.4675819070169, 704.9013138160656, 715.1561157833755, 11782.823257651131, 12655.303958282291, 12704.4918203272, 12737.299448530328, 12741.299228542426, 13064.346782660876, 13103.934480327585, 13134.0, 13190.142640728345, 13220.801687974688, 598.3836648252307, 612.6936531734133, 735.9926400735991, 739.9778006659809, 751.6241879060469, 745.1542499263348, 757.9696812127536, 760.243557660129, 760.6310939194486, 761.0106861080601, 790.8853216283635, 793.5159552672894, 793.761871438569, 793.9960300198491, 794.2295972906271, 633.6134957675814, 648.8929326661096, 766.2146300042501, 787.358302983067, 787.472393496356, 575.5395683453221, 579.5247896724687, 579.6058680097532, 580.9767609295623, 581.0934941491245, 12024.278543287432, 12081.516739330416, 12090.516379344816, 12130.0, 12140.817887731691, 12222.0, 12403.0, 12625.558105466356, 13077.869221307856, 13152.736945261042, 11143.387113708743, 11487.540498380054, 11754.764904701944, 11782.0, 12639.0, 4053.8175782089875, 4060.3503439449546, 4122.690798190148, 4143.254214241435, 4179.435776170209, 60884.0, 61010.0, 61065.694671526355, 61117.08324375138, 61222.0, 9745.220382369393, 9872.923261951108, 10388.428636424918, 10495.160387169008, 10743.14054875608, 19043.14305856212, 19043.143058562397, 19045.809921817177, 19054.42836714901, 19076.71384929227, 6637.502187335969, 6642.933570664328, 6656.4009239167735, 6665.166854143232, 6677.432418244406, 3360.327934413127, 3417.5044618530173, 3460.0830779843363, 3623.3840247158046, 3625.12996880752, 2740.5615101583653, 2833.957490637642, 2843.6018957345987, 2846.146156153146, 2853.6004959305715, 473.07749887719086, 479.9736014519165, 482.582566080338, 484.46224690593414, 487.58555228056576, 425.6594724220673, 501.79677230721614, 550.1637510983282, 554.5064892245904, 569.39359582045, 7750.496217745828, 8006.559639219782, 8059.395545334006, 8108.513489190667, 8277.255047045795, 426.6288329153594, 485.381139047717, 514.3442111308112, 600.5825950964038, 606.824021033904, 3760.1163726524246, 3906.921861562753, 3924.17592305619, 3995.0411901143516, 4055.229506393776, 55436.0, 55686.44313556894, 55987.44012559822, 56121.158182627296, 58158.418415816144, 89217.0, 89288.0, 89357.0, 90723.0, 91382.0, 58971.115433267674, 60418.697906510184, 72969.0, 75225.24774752292, 75572.0, 8099.352051835721, 8381.580920953806, 8938.597763100806, 8939.59771810283, 9038.276937844825, 43239.35140972951, 43604.0, 43631.56368436275, 43907.78046109749, 44232.0, 48978.5102148974, 60836.39163608307, 61356.386436135064, 62364.37635623767, 63307.6834615824, 11190.776184476428, 11194.83207751868, 11255.66233013011, 11422.485988130387, 11716.179867409199, 11837.368988099053, 11874.346910919638, 12055.698607534881, 12056.51773929033, 12140.150189487005, 11724.680958535657, 11828.112891533341, 11847.348395838311, 12190.634280971584, 12307.967397296916, 11240.325580465198, 11781.469833857669, 12208.938955305523, 12526.937365313115, 12625.747485050431, 11338.943305283421, 11340.6030788922, 11498.13763967689, 11707.121965852424, 11795.407619971194, 9692.41845489273, 9804.215662746821, 10118.79762404733, 10274.890965732087, 10383.428911409945, 10052.810260279093, 10351.689449316533, 10371.636992705218, 10373.533191006272, 10445.373277603368], "value": 6361.947229801188, "unit": "score"}], "name": "dromaeo_css", "value": 6155.953704969467, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 117.0, 116.0, 116.0, 113.0, 116.0, 115.0, 112.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 132.0, 169.0, 128.0, 128.0, 127.0, 129.0, 176.0, 128.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 105.0, 77.0, 77.0, 76.0, 75.0, 101.0, 78.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 84.0, 83.0, 85.0, 107.0, 84.0, 84.0, 118.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 125.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 72.0, 71.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 68.0, 67.0, 66.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 84.0, 84.0, 89.0, 82.0, 84.0, 96.0, 82.0, 96.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 146.0, 138.0, 136.0, 136.0, 136.0, 148.0, 136.0, 182.0, 142.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 175.0, 181.0, 175.0, 180.0, 176.0, 177.0, 174.0, 174.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 77.0, 70.0, 69.0, 77.0, 71.0, 70.0, 69.0, 68.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1563.7999999999997, "alertThreshold": 2.0}]} 04:08:23 INFO - Return code: 0 04:08:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:23 INFO - # TBPL SUCCESS # 04:08:23 INFO - Running post-action listener: _resource_record_post_action 04:08:23 INFO - [mozharness: 2016-10-05 11:08:23.942029Z] Finished run-tests step (success) 04:08:23 INFO - Running post-run listener: _resource_record_post_run 04:08:24 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407846912; Read time: 8; Write time: 195784 04:08:24 INFO - TinderboxPrint: CPU usage
13.1% 04:08:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:08:24 INFO - TinderboxPrint: I/O write bytes / time
407,846,912 / 195,784 04:08:24 INFO - TinderboxPrint: CPU idle
8,349.7 (86.9%) 04:08:24 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 04:08:24 INFO - TinderboxPrint: Swap in / out
0 / 0 04:08:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100003840; Read time: 0; Write time: 46880 04:08:24 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291065856; Read time: 8; Write time: 143144 04:08:24 INFO - Running post-run listener: _upload_blobber_files 04:08:24 INFO - Blob upload gear active. 04:08:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:24 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 04:08:24 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'] 04:08:24 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 04:08:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:28 INFO - (blobuploader) - INFO - Done attempting. 04:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:28 INFO - (blobuploader) - INFO - Done attempting. 04:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:29 INFO - (blobuploader) - INFO - Done attempting. 04:08:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:29 INFO - Return code: 0 04:08:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e68e57a99afebbd9b28a0c3b2376baa51f91037cd1b8a2078a3dd4d6f74713e2aec8a1bdd497cbbdfc81c3e098ddac99aca8359ea2ed3a5314b1862dae8babb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2f790c52d4d429dca27afd834739a8bf996324a8b711107ade2954331404cba6b424ce0347dbff6c6a20e3d793d220dfa7cb25bf93e1c649ed070e3aeaf91614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39c72716cced475fc3ea645a24b477ec16efc35c85f7508181413f412da275be06000e547249bd60e378b7a5aeb613b35a804bb0244a9bc174d18522754e1e35"} 04:08:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:29 INFO - Contents: 04:08:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e68e57a99afebbd9b28a0c3b2376baa51f91037cd1b8a2078a3dd4d6f74713e2aec8a1bdd497cbbdfc81c3e098ddac99aca8359ea2ed3a5314b1862dae8babb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2f790c52d4d429dca27afd834739a8bf996324a8b711107ade2954331404cba6b424ce0347dbff6c6a20e3d793d220dfa7cb25bf93e1c649ed070e3aeaf91614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39c72716cced475fc3ea645a24b477ec16efc35c85f7508181413f412da275be06000e547249bd60e378b7a5aeb613b35a804bb0244a9bc174d18522754e1e35"} 04:08:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:29 INFO - Copying logs to upload dir... 04:08:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.698412 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-05 04:08:28.841159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 04:08:28.844630) ========= 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=523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873 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/e68e57a99afebbd9b28a0c3b2376baa51f91037cd1b8a2078a3dd4d6f74713e2aec8a1bdd497cbbdfc81c3e098ddac99aca8359ea2ed3a5314b1862dae8babb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2f790c52d4d429dca27afd834739a8bf996324a8b711107ade2954331404cba6b424ce0347dbff6c6a20e3d793d220dfa7cb25bf93e1c649ed070e3aeaf91614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39c72716cced475fc3ea645a24b477ec16efc35c85f7508181413f412da275be06000e547249bd60e378b7a5aeb613b35a804bb0244a9bc174d18522754e1e35"} build_url:https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/bZ-hGejeSKa6nWFsfxYKNA/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/e68e57a99afebbd9b28a0c3b2376baa51f91037cd1b8a2078a3dd4d6f74713e2aec8a1bdd497cbbdfc81c3e098ddac99aca8359ea2ed3a5314b1862dae8babb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2f790c52d4d429dca27afd834739a8bf996324a8b711107ade2954331404cba6b424ce0347dbff6c6a20e3d793d220dfa7cb25bf93e1c649ed070e3aeaf91614", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39c72716cced475fc3ea645a24b477ec16efc35c85f7508181413f412da275be06000e547249bd60e378b7a5aeb613b35a804bb0244a9bc174d18522754e1e35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 04:08:28.870232) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 04:08:28.870570) ========= 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=523ca41ca1e0623de333ad52000001bf-1475664291.966563-327084873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 04:08:28.956212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 04:08:28.956526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 04:08:28.956856) ========= ========= Total master_lag: 0.17 =========