builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1477671254.91 results: success (0) buildid: 20161028073459 builduid: 35b7377895da4d69af434e667a072a13 revision: 04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:14.913465) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:14.914045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:14.914371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:14.962117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:14.962688) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 09:14:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-28 09:14:15 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180670 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:15.170232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:15.170568) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019025 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:15.247158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 09:14:15.247580) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4 --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=9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 09:14:15,576 truncating revision to first 12 chars 2016-10-28 09:14:15,576 Setting DEBUG logging. 2016-10-28 09:14:15,576 attempt 1/10 2016-10-28 09:14:15,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/04aa4dfb6ec5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 09:14:16,950 unpacking tar archive at: cedar-04aa4dfb6ec5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.668604 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 09:14:16.936765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:16.937304) ========= script_repo_revision: 04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:16.937776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:16.938086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:14:16.949080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-28 09:14:16.949499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:17 INFO - MultiFileLogger online at 20161028 09:14:17 in /builds/slave/test 09:14:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 09:14:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:17 INFO - {'append_to_log': False, 09:14:17 INFO - 'base_work_dir': '/builds/slave/test', 09:14:17 INFO - 'blob_upload_branch': 'Cedar', 09:14:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:17 INFO - 'branch': 'Cedar', 09:14:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:17 INFO - 'config_files': ('talos/linux_config.py',), 09:14:17 INFO - 'default_actions': ('clobber', 09:14:17 INFO - 'read-buildbot-config', 09:14:17 INFO - 'download-and-extract', 09:14:17 INFO - 'populate-webroot', 09:14:17 INFO - 'create-virtualenv', 09:14:17 INFO - 'install', 09:14:17 INFO - 'run-tests'), 09:14:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:17 INFO - 'download_minidump_stackwalk': True, 09:14:17 INFO - 'download_symbols': 'ondemand', 09:14:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:17 INFO - 'installer_path': 'installer.exe', 09:14:17 INFO - 'log_level': 'info', 09:14:17 INFO - 'log_name': 'talos', 09:14:17 INFO - 'log_to_console': True, 09:14:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:17 INFO - 'opt_config_files': (), 09:14:17 INFO - 'pip_index': False, 09:14:17 INFO - 'sps_profile': False, 09:14:17 INFO - 'sps_profile_interval': 0, 09:14:17 INFO - 'suite': 'dromaeojs', 09:14:17 INFO - 'system_bits': '32', 09:14:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:17 INFO - 'title': 'talos-linux64-ix-022', 09:14:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:17 INFO - 'use_talos_json': True, 09:14:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:17 INFO - 'work_dir': 'build'} 09:14:17 INFO - [mozharness: 2016-10-28 16:14:17.379702Z] Running clobber step. 09:14:17 INFO - Running pre-action listener: _resource_record_pre_action 09:14:17 INFO - Running main action method: clobber 09:14:17 INFO - rmtree: /builds/slave/test/build 09:14:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:18 INFO - Running post-action listener: _resource_record_post_action 09:14:18 INFO - [mozharness: 2016-10-28 16:14:18.349195Z] Finished clobber step (success) 09:14:18 INFO - [mozharness: 2016-10-28 16:14:18.349295Z] Running read-buildbot-config step. 09:14:18 INFO - Running pre-action listener: _resource_record_pre_action 09:14:18 INFO - Running main action method: read_buildbot_config 09:14:18 INFO - Using buildbot properties: 09:14:18 INFO - { 09:14:18 INFO - "project": "", 09:14:18 INFO - "product": "firefox", 09:14:18 INFO - "script_repo_revision": "default", 09:14:18 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 09:14:18 INFO - "repository": "", 09:14:18 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 09:14:18 INFO - "buildid": "20161028073459", 09:14:18 INFO - "pgo_build": "False", 09:14:18 INFO - "basedir": "/builds/slave/test", 09:14:18 INFO - "buildnumber": 2, 09:14:18 INFO - "slavename": "talos-linux64-ix-022", 09:14:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:14:18 INFO - "platform": "ubuntu64_hw", 09:14:18 INFO - "scheduler": "tests-cedar-linux64-talos", 09:14:18 INFO - "branch": "cedar", 09:14:18 INFO - "repo_path": "projects/cedar", 09:14:18 INFO - "revision": "04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4", 09:14:18 INFO - "stage_platform": "linux64", 09:14:18 INFO - "builduid": "35b7377895da4d69af434e667a072a13", 09:14:18 INFO - "slavebuilddir": "test" 09:14:18 INFO - } 09:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:14:18 INFO - Running post-action listener: _resource_record_post_action 09:14:18 INFO - [mozharness: 2016-10-28 16:14:18.351858Z] Finished read-buildbot-config step (success) 09:14:18 INFO - [mozharness: 2016-10-28 16:14:18.351945Z] Running download-and-extract step. 09:14:18 INFO - Running pre-action listener: _resource_record_pre_action 09:14:18 INFO - Running main action method: download_and_extract 09:14:18 INFO - mkdir: /builds/slave/test/build/tests 09:14: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')]} 09:14:18 INFO - trying https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:14:18 INFO - Downloading https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/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 09:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/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 09:14:18 INFO - Downloaded 1361 bytes. 09:14:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:14:18 INFO - Using the following test package requirements: 09:14:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:14:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'jsshell-linux-x86_64.zip'], 09:14:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:14:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:14:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:14:19 INFO - Http code: 200 09:14:19 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 09:14:19 INFO - x-amz-cf-id: _RH3yEWYGPU0n8DAhKELPtl5X3uog7P5o7F6Tr2veeSYYrGHKzuneQ== 09:14:19 INFO - x-amz-version-id: TYMarISGEy3P455a3K2FrnE6vxa9fzF_ 09:14:19 INFO - Expected file size: 20424473 09:14:19 INFO - Obtained file size: 20424473 09:14:23 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 09:14:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:14:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:23 INFO - Fetch https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:14:24 INFO - Http code: 200 09:14:24 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 09:14:24 INFO - x-amz-cf-id: Q3X9-VVUn57yWYdKD5twBmUbmIPgUy5AlEUmge4mXZRBIFtmeP4tew== 09:14:24 INFO - x-amz-version-id: TYMarISGEy3P455a3K2FrnE6vxa9fzF_ 09:14:24 INFO - Expected file size: 20424473 09:14:24 INFO - Obtained file size: 20424473 09:14:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:14:29 INFO - Fetch https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:14:29 INFO - Http code: 200 09:14:29 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:14:29 INFO - x-amz-cf-id: xZbQZZe_O7JfP0wIFKqM3IO3YkLDr_tqs6XTaNYnozl001kCgMpDcA== 09:14:29 INFO - x-amz-version-id: nbzEkjQ64kkwdyXeXlslxkf3ycyWJrL3 09:14:29 INFO - Expected file size: 14409028 09:14:29 INFO - Obtained file size: 14409028 09:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:30 INFO - trying https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/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 09:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/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 09:14:31 INFO - Downloaded 55480097 bytes. 09:14:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:31 INFO - mkdir: /builds/slave/test/properties 09:14:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:31 INFO - Contents: 09:14:31 INFO - build_url:https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:32 INFO - Running post-action listener: _resource_record_post_action 09:14:32 INFO - Running post-action listener: set_extra_try_arguments 09:14:32 INFO - [mozharness: 2016-10-28 16:14:32.327683Z] Finished download-and-extract step (success) 09:14:32 INFO - [mozharness: 2016-10-28 16:14:32.327910Z] Running populate-webroot step. 09:14:32 INFO - Running pre-action listener: _resource_record_pre_action 09:14:32 INFO - Running main action method: populate_webroot 09:14:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:32 INFO - '--tppagecycles', 09:14:32 INFO - '7'], 09:14:32 INFO - 'tests': ['tsvgm']}}, 09:14:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['damp', 'tps']}, 09:14:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'tests': ['damp', 'tps']}, 09:14:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['dromaeo_dom']}, 09:14:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['basic_compositor_video']}, 09:14:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:14:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['a11yr', 09:14:32 INFO - 'ts_paint', 09:14:32 INFO - 'tpaint', 09:14:32 INFO - 'sessionrestore', 09:14:32 INFO - 'sessionrestore_no_auto_restore', 09:14:32 INFO - 'tabpaint']}, 09:14:32 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:32 INFO - 'ts_paint', 09:14:32 INFO - 'tpaint', 09:14:32 INFO - 'sessionrestore', 09:14:32 INFO - 'sessionrestore_no_auto_restore', 09:14:32 INFO - 'tabpaint']}, 09:14:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:32 INFO - 'ts_paint', 09:14:32 INFO - 'tpaint', 09:14:32 INFO - 'sessionrestore', 09:14:32 INFO - 'sessionrestore_no_auto_restore', 09:14:32 INFO - 'tabpaint']}, 09:14:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:32 INFO - 'ts_paint', 09:14:32 INFO - 'tpaint', 09:14:32 INFO - 'sessionrestore', 09:14:32 INFO - 'sessionrestore_no_auto_restore', 09:14:32 INFO - 'tabpaint']}, 09:14:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['a11yr', 09:14:32 INFO - 'ts_paint', 09:14:32 INFO - 'tpaint', 09:14:32 INFO - 'sessionrestore', 09:14:32 INFO - 'sessionrestore_no_auto_restore', 09:14:32 INFO - 'tabpaint']}, 09:14:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['a11yr', 09:14:32 INFO - 'ts_paint', 09:14:32 INFO - 'tpaint', 09:14:32 INFO - 'sessionrestore', 09:14:32 INFO - 'sessionrestore_no_auto_restore', 09:14:32 INFO - 'tabpaint']}, 09:14:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['tsvgx', 09:14:32 INFO - 'tsvgr_opacity', 09:14:32 INFO - 'tart', 09:14:32 INFO - 'tscrollx', 09:14:32 INFO - 'cart']}, 09:14:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:32 INFO - 'tsvgr_opacity', 09:14:32 INFO - 'tart', 09:14:32 INFO - 'tscrollx', 09:14:32 INFO - 'cart']}, 09:14:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'talos_options': ['--disable-e10s'], 09:14:32 INFO - 'tests': ['tp5o']}, 09:14:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'tests': ['tp5o']}, 09:14:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'talos_options': ['--disable-e10s', 09:14:32 INFO - '--xperf_path', 09:14:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:32 INFO - 'tests': ['tp5n']}, 09:14:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:32 INFO - 'talos_options': ['--xperf_path', 09:14:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:32 INFO - 'tests': ['tp5n']}}, 09:14:32 INFO - 'talos.zip': {'path': '', 09:14:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:32 INFO - Running post-action listener: _resource_record_post_action 09:14:32 INFO - [mozharness: 2016-10-28 16:14:32.348475Z] Finished populate-webroot step (success) 09:14:32 INFO - [mozharness: 2016-10-28 16:14:32.348564Z] Running create-virtualenv step. 09:14:32 INFO - Running pre-action listener: _resource_record_pre_action 09:14:32 INFO - Running main action method: create_virtualenv 09:14:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:32 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 09:14:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:32 INFO - Using real prefix '/usr' 09:14:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:34 INFO - Installing pip.................done. 09:14:34 INFO - Return code: 0 09:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:14:35 INFO - Reading from file tmpfile_stdout 09:14:35 INFO - Output received: 09:14:35 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) 09:14:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:35 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')]} 09:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:35 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')]} 09:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:35 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:35 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 09:14:35 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 09:14:35 INFO - Using env: {'DISPLAY': ':0', 09:14:35 INFO - 'HOME': '/home/cltbld', 09:14:35 INFO - 'LANG': 'en_US.UTF-8', 09:14:35 INFO - 'LANGUAGE': 'en_US:en', 09:14:35 INFO - 'LOGNAME': 'cltbld', 09:14:35 INFO - 'MAIL': '/var/mail/cltbld', 09:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:35 INFO - 'MOZ_NO_REMOTE': '1', 09:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:35 INFO - 'NO_EM_RESTART': '1', 09:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:35 INFO - 'PWD': '/builds/slave/test', 09:14:35 INFO - 'SHELL': '/bin/bash', 09:14:35 INFO - 'SHLVL': '1', 09:14:35 INFO - 'TERM': 'linux', 09:14:35 INFO - 'TMOUT': '86400', 09:14:35 INFO - 'USER': 'cltbld', 09:14:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:35 INFO - '_': '/tools/buildbot/bin/python'} 09:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:35 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 09:14:35 INFO - Cleaning up... 09:14:35 INFO - Return code: 0 09:14:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:35 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')]} 09:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:35 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')]} 09:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:35 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:35 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 09:14:35 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 09:14:35 INFO - Using env: {'DISPLAY': ':0', 09:14:35 INFO - 'HOME': '/home/cltbld', 09:14:35 INFO - 'LANG': 'en_US.UTF-8', 09:14:35 INFO - 'LANGUAGE': 'en_US:en', 09:14:35 INFO - 'LOGNAME': 'cltbld', 09:14:35 INFO - 'MAIL': '/var/mail/cltbld', 09:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:35 INFO - 'MOZ_NO_REMOTE': '1', 09:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:35 INFO - 'NO_EM_RESTART': '1', 09:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:35 INFO - 'PWD': '/builds/slave/test', 09:14:35 INFO - 'SHELL': '/bin/bash', 09:14:35 INFO - 'SHLVL': '1', 09:14:35 INFO - 'TERM': 'linux', 09:14:35 INFO - 'TMOUT': '86400', 09:14:35 INFO - 'USER': 'cltbld', 09:14:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:35 INFO - '_': '/tools/buildbot/bin/python'} 09:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:35 INFO - Downloading/unpacking psutil>=3.1.1 09:14:35 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 09:14:35 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 09:14:35 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 09:14:35 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 09:14:35 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 09:14:35 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 09:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:37 INFO - Installing collected packages: psutil 09:14:37 INFO - Running setup.py install for psutil 09:14:37 INFO - building 'psutil._psutil_linux' extension 09:14:37 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 09:14:37 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 09:14:37 INFO - building 'psutil._psutil_posix' extension 09:14:37 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 09:14:38 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 09:14:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:38 INFO - Successfully installed psutil 09:14:38 INFO - Cleaning up... 09:14:38 INFO - Return code: 0 09:14:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:14:38 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')]} 09:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:38 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')]} 09:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:38 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:38 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 09:14:38 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 09:14:38 INFO - Using env: {'DISPLAY': ':0', 09:14:38 INFO - 'HOME': '/home/cltbld', 09:14:38 INFO - 'LANG': 'en_US.UTF-8', 09:14:38 INFO - 'LANGUAGE': 'en_US:en', 09:14:38 INFO - 'LOGNAME': 'cltbld', 09:14:38 INFO - 'MAIL': '/var/mail/cltbld', 09:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:38 INFO - 'MOZ_NO_REMOTE': '1', 09:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:38 INFO - 'NO_EM_RESTART': '1', 09:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:38 INFO - 'PWD': '/builds/slave/test', 09:14:38 INFO - 'SHELL': '/bin/bash', 09:14:38 INFO - 'SHLVL': '1', 09:14:38 INFO - 'TERM': 'linux', 09:14:38 INFO - 'TMOUT': '86400', 09:14:38 INFO - 'USER': 'cltbld', 09:14:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:38 INFO - '_': '/tools/buildbot/bin/python'} 09:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:14:38 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 09:14:38 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 09:14:38 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 09:14:38 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 09:14:38 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 09:14:38 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 09:14:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:40 INFO - Installing collected packages: mozsystemmonitor 09:14:40 INFO - Running setup.py install for mozsystemmonitor 09:14:40 INFO - Successfully installed mozsystemmonitor 09:14:40 INFO - Cleaning up... 09:14:40 INFO - Return code: 0 09:14:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:14:40 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')]} 09:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:40 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')]} 09:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:40 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:40 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 09:14:40 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 09:14:40 INFO - Using env: {'DISPLAY': ':0', 09:14:40 INFO - 'HOME': '/home/cltbld', 09:14:40 INFO - 'LANG': 'en_US.UTF-8', 09:14:40 INFO - 'LANGUAGE': 'en_US:en', 09:14:40 INFO - 'LOGNAME': 'cltbld', 09:14:40 INFO - 'MAIL': '/var/mail/cltbld', 09:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:40 INFO - 'MOZ_NO_REMOTE': '1', 09:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:40 INFO - 'NO_EM_RESTART': '1', 09:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:40 INFO - 'PWD': '/builds/slave/test', 09:14:40 INFO - 'SHELL': '/bin/bash', 09:14:40 INFO - 'SHLVL': '1', 09:14:40 INFO - 'TERM': 'linux', 09:14:40 INFO - 'TMOUT': '86400', 09:14:40 INFO - 'USER': 'cltbld', 09:14:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:40 INFO - '_': '/tools/buildbot/bin/python'} 09:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:14:40 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 09:14:40 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 09:14:40 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 09:14:40 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 09:14:40 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 09:14:40 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 09:14:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:14:42 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 09:14:42 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 09:14:42 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 09:14:42 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 09:14:42 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 09:14:42 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 09:14:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:42 INFO - warning: no files found matching '*.txt' 09:14:42 INFO - no previously-included directories found matching 'build' 09:14:42 INFO - no previously-included directories found matching 'dist' 09:14:42 INFO - no previously-included directories found matching '.git*' 09:14:42 INFO - Installing collected packages: jsonschema, functools32 09:14:42 INFO - Running setup.py install for functools32 09:14:43 INFO - warning: no files found matching '*.txt' 09:14:43 INFO - no previously-included directories found matching 'build' 09:14:43 INFO - no previously-included directories found matching 'dist' 09:14:43 INFO - no previously-included directories found matching '.git*' 09:14:43 INFO - Successfully installed jsonschema functools32 09:14:43 INFO - Cleaning up... 09:14:43 INFO - Return code: 0 09:14:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:14:43 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')]} 09:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:43 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')]} 09:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:43 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:43 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 09:14:43 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 09:14:43 INFO - Using env: {'DISPLAY': ':0', 09:14:43 INFO - 'HOME': '/home/cltbld', 09:14:43 INFO - 'LANG': 'en_US.UTF-8', 09:14:43 INFO - 'LANGUAGE': 'en_US:en', 09:14:43 INFO - 'LOGNAME': 'cltbld', 09:14:43 INFO - 'MAIL': '/var/mail/cltbld', 09:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:43 INFO - 'MOZ_NO_REMOTE': '1', 09:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:43 INFO - 'NO_EM_RESTART': '1', 09:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:43 INFO - 'PWD': '/builds/slave/test', 09:14:43 INFO - 'SHELL': '/bin/bash', 09:14:43 INFO - 'SHLVL': '1', 09:14:43 INFO - 'TERM': 'linux', 09:14:43 INFO - 'TMOUT': '86400', 09:14:43 INFO - 'USER': 'cltbld', 09:14:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:43 INFO - '_': '/tools/buildbot/bin/python'} 09:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:14:43 INFO - Cleaning up... 09:14:43 INFO - Return code: 0 09:14:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14:43 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')]} 09:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:43 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')]} 09:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:43 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:43 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 09:14:43 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 09:14:43 INFO - Using env: {'DISPLAY': ':0', 09:14:43 INFO - 'HOME': '/home/cltbld', 09:14:43 INFO - 'LANG': 'en_US.UTF-8', 09:14:43 INFO - 'LANGUAGE': 'en_US:en', 09:14:43 INFO - 'LOGNAME': 'cltbld', 09:14:43 INFO - 'MAIL': '/var/mail/cltbld', 09:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:43 INFO - 'MOZ_NO_REMOTE': '1', 09:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:43 INFO - 'NO_EM_RESTART': '1', 09:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:43 INFO - 'PWD': '/builds/slave/test', 09:14:43 INFO - 'SHELL': '/bin/bash', 09:14:43 INFO - 'SHLVL': '1', 09:14:43 INFO - 'TERM': 'linux', 09:14:43 INFO - 'TMOUT': '86400', 09:14:43 INFO - 'USER': 'cltbld', 09:14:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:43 INFO - '_': '/tools/buildbot/bin/python'} 09:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:43 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 09:14:43 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 09:14:43 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 09:14:43 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 09:14:43 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 09:14:43 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 09:14:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 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 09:14:46 INFO - Downloading docopt-0.6.1.tar.gz 09:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:46 INFO - Running setup.py install for blobuploader 09:14:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:46 INFO - Running setup.py install for requests 09:14:46 INFO - Running setup.py install for docopt 09:14:46 INFO - Successfully installed blobuploader requests docopt 09:14:46 INFO - Cleaning up... 09:14:46 INFO - Return code: 0 09:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:46 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:46 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 09:14:46 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 09:14:46 INFO - Using env: {'DISPLAY': ':0', 09:14:46 INFO - 'HOME': '/home/cltbld', 09:14:46 INFO - 'LANG': 'en_US.UTF-8', 09:14:46 INFO - 'LANGUAGE': 'en_US:en', 09:14:46 INFO - 'LOGNAME': 'cltbld', 09:14:46 INFO - 'MAIL': '/var/mail/cltbld', 09:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:46 INFO - 'MOZ_NO_REMOTE': '1', 09:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:46 INFO - 'NO_EM_RESTART': '1', 09:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:46 INFO - 'PWD': '/builds/slave/test', 09:14:46 INFO - 'SHELL': '/bin/bash', 09:14:46 INFO - 'SHLVL': '1', 09:14:46 INFO - 'TERM': 'linux', 09:14:46 INFO - 'TMOUT': '86400', 09:14:46 INFO - 'USER': 'cltbld', 09:14:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:46 INFO - '_': '/tools/buildbot/bin/python'} 09:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:47 INFO - Running setup.py (path:/tmp/pip-lRGVQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:47 INFO - Running setup.py (path:/tmp/pip-kcd7HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:47 INFO - Running setup.py (path:/tmp/pip-322GSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:47 INFO - Running setup.py (path:/tmp/pip-Yt4fJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:47 INFO - Running setup.py (path:/tmp/pip-sy4T5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:47 INFO - Running setup.py (path:/tmp/pip-0K23Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:47 INFO - Running setup.py (path:/tmp/pip-Ym3BCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:47 INFO - Running setup.py (path:/tmp/pip-DRhJJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:47 INFO - Running setup.py (path:/tmp/pip-WpdyHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:47 INFO - Running setup.py (path:/tmp/pip-QMXfxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:47 INFO - Running setup.py (path:/tmp/pip-wPOnNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:47 INFO - Running setup.py (path:/tmp/pip-pbMfWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:48 INFO - Running setup.py (path:/tmp/pip-f05eCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:48 INFO - Running setup.py (path:/tmp/pip-Aeon2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:48 INFO - Running setup.py (path:/tmp/pip-sQmARk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:48 INFO - Running setup.py (path:/tmp/pip-8eC3U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:48 INFO - Running setup.py (path:/tmp/pip-tA_nYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:48 INFO - Running setup.py install for manifestparser 09:14:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:48 INFO - Running setup.py install for mozcrash 09:14:48 INFO - Running setup.py install for mozdebug 09:14:48 INFO - Running setup.py install for mozdevice 09:14:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:14:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:48 INFO - Running setup.py install for mozfile 09:14:48 INFO - Running setup.py install for mozhttpd 09:14:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:48 INFO - Running setup.py install for mozinfo 09:14:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozInstall 09:14:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozleak 09:14:49 INFO - Running setup.py install for mozlog 09:14:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for moznetwork 09:14:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozprocess 09:14:49 INFO - Running setup.py install for mozprofile 09:14:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozrunner 09:14:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:49 INFO - Running setup.py install for mozscreenshot 09:14:49 INFO - Running setup.py install for moztest 09:14:50 INFO - Running setup.py install for mozversion 09:14:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:50 INFO - Cleaning up... 09:14:50 INFO - Return code: 0 09:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:50 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:50 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 09:14:50 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 09:14:50 INFO - Using env: {'DISPLAY': ':0', 09:14:50 INFO - 'HOME': '/home/cltbld', 09:14:50 INFO - 'LANG': 'en_US.UTF-8', 09:14:50 INFO - 'LANGUAGE': 'en_US:en', 09:14:50 INFO - 'LOGNAME': 'cltbld', 09:14:50 INFO - 'MAIL': '/var/mail/cltbld', 09:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:50 INFO - 'MOZ_NO_REMOTE': '1', 09:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:50 INFO - 'NO_EM_RESTART': '1', 09:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:50 INFO - 'PWD': '/builds/slave/test', 09:14:50 INFO - 'SHELL': '/bin/bash', 09:14:50 INFO - 'SHLVL': '1', 09:14:50 INFO - 'TERM': 'linux', 09:14:50 INFO - 'TMOUT': '86400', 09:14:50 INFO - 'USER': 'cltbld', 09:14:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:50 INFO - '_': '/tools/buildbot/bin/python'} 09:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:50 INFO - Running setup.py (path:/tmp/pip-DROLrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:50 INFO - Running setup.py (path:/tmp/pip-cHA5Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:50 INFO - Running setup.py (path:/tmp/pip-Bzhpkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:50 INFO - Running setup.py (path:/tmp/pip-Cr99JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:50 INFO - Running setup.py (path:/tmp/pip-pKkNna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:50 INFO - Running setup.py (path:/tmp/pip-ek_MFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:50 INFO - Running setup.py (path:/tmp/pip-OuCfK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:50 INFO - Running setup.py (path:/tmp/pip-5YiVBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:50 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)) 09:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:50 INFO - Running setup.py (path:/tmp/pip-s0TULs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:51 INFO - Running setup.py (path:/tmp/pip-omIoA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:51 INFO - Running setup.py (path:/tmp/pip-u7bCOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:51 INFO - Running setup.py (path:/tmp/pip-OFEXVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:51 INFO - Running setup.py (path:/tmp/pip-G2cY6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:51 INFO - Running setup.py (path:/tmp/pip-s1ih9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:51 INFO - Running setup.py (path:/tmp/pip-aNV3_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:51 INFO - Running setup.py (path:/tmp/pip-uP1TpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:51 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)) 09:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:51 INFO - Running setup.py (path:/tmp/pip-NGwuxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 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)) 09:14:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:53 INFO - Downloading blessings-1.6.tar.gz 09:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:53 INFO - Installing collected packages: blessings 09:14:53 INFO - Running setup.py install for blessings 09:14:53 INFO - Successfully installed blessings 09:14:53 INFO - Cleaning up... 09:14:53 INFO - Return code: 0 09:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:54 INFO - Reading from file tmpfile_stdout 09:14:54 INFO - Current package versions: 09:14:54 INFO - argparse == 1.2.1 09:14:54 INFO - blessings == 1.6 09:14:54 INFO - blobuploader == 1.2.4 09:14:54 INFO - docopt == 0.6.1 09:14:54 INFO - functools32 == 3.2.3-2 09:14:54 INFO - jsonschema == 2.5.1 09:14:54 INFO - manifestparser == 1.1 09:14:54 INFO - mozInstall == 1.12 09:14:54 INFO - mozcrash == 0.17 09:14:54 INFO - mozdebug == 0.1 09:14:54 INFO - mozdevice == 0.48 09:14:54 INFO - mozfile == 1.2 09:14:54 INFO - mozhttpd == 0.7 09:14:54 INFO - mozinfo == 0.9 09:14:54 INFO - mozleak == 0.1 09:14:54 INFO - mozlog == 3.4 09:14:54 INFO - moznetwork == 0.27 09:14:54 INFO - mozprocess == 0.23 09:14:54 INFO - mozprofile == 0.28 09:14:54 INFO - mozrunner == 6.12 09:14:54 INFO - mozscreenshot == 0.1 09:14:54 INFO - mozsystemmonitor == 0.3 09:14:54 INFO - moztest == 0.7 09:14:54 INFO - mozversion == 1.4 09:14:54 INFO - psutil == 3.1.1 09:14:54 INFO - requests == 1.2.3 09:14:54 INFO - wsgiref == 0.1.2 09:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:54 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:54 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 09:14:54 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 09:14:54 INFO - Using env: {'DISPLAY': ':0', 09:14:54 INFO - 'HOME': '/home/cltbld', 09:14:54 INFO - 'LANG': 'en_US.UTF-8', 09:14:54 INFO - 'LANGUAGE': 'en_US:en', 09:14:54 INFO - 'LOGNAME': 'cltbld', 09:14:54 INFO - 'MAIL': '/var/mail/cltbld', 09:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:54 INFO - 'MOZ_NO_REMOTE': '1', 09:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:54 INFO - 'NO_EM_RESTART': '1', 09:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:54 INFO - 'PWD': '/builds/slave/test', 09:14:54 INFO - 'SHELL': '/bin/bash', 09:14:54 INFO - 'SHLVL': '1', 09:14:54 INFO - 'TERM': 'linux', 09:14:54 INFO - 'TMOUT': '86400', 09:14:54 INFO - 'USER': 'cltbld', 09:14:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:54 INFO - '_': '/tools/buildbot/bin/python'} 09:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 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)) 09:14:54 INFO - Cleaning up... 09:14:54 INFO - Return code: 0 09:14:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:54 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 0x7f436c4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', '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 09:14:54 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 09:14:54 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 09:14:54 INFO - Using env: {'DISPLAY': ':0', 09:14:54 INFO - 'HOME': '/home/cltbld', 09:14:54 INFO - 'LANG': 'en_US.UTF-8', 09:14:54 INFO - 'LANGUAGE': 'en_US:en', 09:14:54 INFO - 'LOGNAME': 'cltbld', 09:14:54 INFO - 'MAIL': '/var/mail/cltbld', 09:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:54 INFO - 'MOZ_NO_REMOTE': '1', 09:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:54 INFO - 'NO_EM_RESTART': '1', 09:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:54 INFO - 'PWD': '/builds/slave/test', 09:14:54 INFO - 'SHELL': '/bin/bash', 09:14:54 INFO - 'SHLVL': '1', 09:14:54 INFO - 'TERM': 'linux', 09:14:54 INFO - 'TMOUT': '86400', 09:14:54 INFO - 'USER': 'cltbld', 09:14:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:54 INFO - '_': '/tools/buildbot/bin/python'} 09:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:54 INFO - Cleaning up... 09:14:54 INFO - Return code: 0 09:14:54 INFO - Running post-action listener: _resource_record_post_action 09:14:54 INFO - Running post-action listener: _start_resource_monitoring 09:14:54 INFO - Starting resource monitoring. 09:14:54 INFO - [mozharness: 2016-10-28 16:14:54.541767Z] Finished create-virtualenv step (success) 09:14:54 INFO - [mozharness: 2016-10-28 16:14:54.542283Z] Running install step. 09:14:54 INFO - Running pre-action listener: _resource_record_pre_action 09:14:54 INFO - Running main action method: install 09:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:54 INFO - Reading from file tmpfile_stdout 09:14:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:54 INFO - Reading from file tmpfile_stdout 09:14:54 INFO - Output received: 09:14:54 INFO - Usage: mozinstall [options] installer 09:14:54 INFO - Options: 09:14:54 INFO - -h, --help show this help message and exit 09:14:54 INFO - -d DEST, --destination=DEST 09:14:54 INFO - Directory to install application into. [default: 09:14:54 INFO - "/builds/slave/test"] 09:14:54 INFO - --app=APP Application being installed. [default: firefox] 09:14:54 INFO - mkdir: /builds/slave/test/build/application 09:14:54 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'] 09:14:54 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 09:15:10 INFO - Reading from file tmpfile_stdout 09:15:10 INFO - Output received: 09:15:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:15:10 INFO - Running post-action listener: _resource_record_post_action 09:15:10 INFO - [mozharness: 2016-10-28 16:15:10.852285Z] Finished install step (success) 09:15:10 INFO - [mozharness: 2016-10-28 16:15:10.852529Z] Running run-tests step. 09:15:10 INFO - Running pre-action listener: _resource_record_pre_action 09:15:10 INFO - Running main action method: run_tests 09:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:10 INFO - Python 2.7.3 09:15:10 INFO - Return code: 0 09:15:10 INFO - grabbing minidump binary from tooltool 09:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:10 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 0x25a3930>, '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 0x25a4830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a4cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:10 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 09:15:10 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 09:15:10 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 09:15:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:10 INFO - Return code: 0 09:15:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:15:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:15:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 09:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 09:15:10 INFO - Using env: {'DISPLAY': ':0', 09:15:10 INFO - 'HOME': '/home/cltbld', 09:15:10 INFO - 'LANG': 'en_US.UTF-8', 09:15:10 INFO - 'LANGUAGE': 'en_US:en', 09:15:10 INFO - 'LOGNAME': 'cltbld', 09:15:10 INFO - 'MAIL': '/var/mail/cltbld', 09:15:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:10 INFO - 'MOZ_NO_REMOTE': '1', 09:15:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:10 INFO - 'NO_EM_RESTART': '1', 09:15:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:10 INFO - 'PWD': '/builds/slave/test', 09:15:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:10 INFO - 'SHELL': '/bin/bash', 09:15:10 INFO - 'SHLVL': '1', 09:15:10 INFO - 'TERM': 'linux', 09:15:10 INFO - 'TMOUT': '86400', 09:15:10 INFO - 'USER': 'cltbld', 09:15:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636', 09:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:10 INFO - '_': '/tools/buildbot/bin/python'} 09:15:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 09:15:11 INFO - mozversion application_buildid: 20161028073459 09:15:11 INFO - mozversion application_changeset: 04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4 09:15:11 INFO - mozversion application_display_name: Nightly 09:15:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:11 INFO - mozversion application_name: Firefox 09:15:11 INFO - mozversion application_remotingname: firefox 09:15:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 09:15:11 INFO - mozversion application_vendor: Mozilla 09:15:11 INFO - mozversion application_version: 52.0a1 09:15:11 INFO - mozversion platform_buildid: 20161028073459 09:15:11 INFO - mozversion platform_changeset: 04aa4dfb6ec598148d2de0cc5fec2a34130cdcf4 09:15:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 09:15:11 INFO - mozversion platform_version: 52.0a1 09:15:11 INFO - using testdate: 1477671311 09:15:11 INFO - actual date: 1477671311 09:15:11 INFO - starting webserver on 'localhost:57912' 09:15:11 INFO - SUITE-START | Running 2 tests 09:15:11 INFO - TEST-START | dromaeo_css 09:15:11 INFO - operating with platform_type : linux_ 09:15:11 INFO - Initialising browser for dromaeo_css test... 09:15:11 INFO - TEST-INFO | started process 16769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3nftNd/profile http://localhost:57912/getInfo.html) 09:15:15 INFO - PROCESS | 16769 | __metrics Screen width/height:1600/1200 09:15:15 INFO - PROCESS | 16769 | colorDepth:24 09:15:15 INFO - PROCESS | 16769 | Browser inner width/height: 1024/697 09:15:15 INFO - PROCESS | 16769 | __metrics 09:15:16 INFO - PROCESS | 16769 | 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" 09:15:16 INFO - PROCESS | 16769 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:16 INFO - PROCESS | 16769 | console.error: PushService: 09:15:16 INFO - PROCESS | 16769 | stateChangeProcessEnqueue: Error transitioning state 09:15:16 INFO - PROCESS | 16769 | UnknownError 09:15:17 INFO - TEST-INFO | 16769: exit 0 09:15:17 INFO - Browser initialized. 09:15:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:17 INFO - TEST-INFO | started process 16853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3nftNd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:29 INFO - PROCESS | 16853 | RSS: Main: 174395392 09:15:29 INFO - PROCESS | 16853 | 09:16:20 INFO - PROCESS | 16853 | 1477671380597 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] 09:18:35 INFO - PROCESS | 16853 | Cycle 1(1): loaded http://localhost:57912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57912/tests/dromaeo/cssquery-ext.html) 09:18:37 INFO - PROCESS | 16853 | RSS: Main: 286359552 09:18:37 INFO - PROCESS | 16853 | 09:21:39 INFO - PROCESS | 16853 | Cycle 1(1): loaded http://localhost:57912/tests/dromaeo/cssquery-ext.html (next: http://localhost:57912/tests/dromaeo/cssquery-jquery.html) 09:21:40 INFO - PROCESS | 16853 | RSS: Main: 275722240 09:21:40 INFO - PROCESS | 16853 | 09:24:42 INFO - PROCESS | 16853 | Cycle 1(1): loaded http://localhost:57912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57912/tests/dromaeo/cssquery-mootools.html) 09:24:43 INFO - PROCESS | 16853 | RSS: Main: 219078656 09:24:43 INFO - PROCESS | 16853 | 09:27:45 INFO - PROCESS | 16853 | Cycle 1(1): loaded http://localhost:57912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57912/tests/dromaeo/cssquery-prototype.html) 09:27:46 INFO - PROCESS | 16853 | RSS: Main: 255332352 09:27:46 INFO - PROCESS | 16853 | 09:30:49 INFO - PROCESS | 16853 | Cycle 1(1): loaded http://localhost:57912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57912/tests/dromaeo/cssquery-yui.html) 09:30:50 INFO - PROCESS | 16853 | RSS: Main: 218652672 09:30:50 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | Cycle 1(1): loaded http://localhost:57912/tests/dromaeo/cssquery-yui.html (next: http://localhost:57912/tests/dromaeo/cssquery-dojo.html) 09:33:53 INFO - PROCESS | 16853 | RSS: Main: 308969472 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | __start_tp_report 09:33:53 INFO - PROCESS | 16853 | _x_x_mozilla_page_load 09:33:53 INFO - PROCESS | 16853 | _x_x_mozilla_page_load_details 09:33:53 INFO - PROCESS | 16853 | |i|pagename|runs| 09:33:53 INFO - PROCESS | 16853 | |0;dojo.html;2528.1151596941068;2571.2029270926005;2580.3033181041123;2606.530824451599;2621.1481268587704;4489.102179564092;4585.082983403316;4670.416197975253;4670.836520721776;4677.602403795677;4550.044490656957;4581.106684196583;4617.030423611046;4617.722936623796;4647.419072615923;4162.1675664867;4168.458100446953;4213.810378532973;4219.367094935754;4286.678499112563;3866.7309591054113;4143.357779544175;4237.152569486099;4285.078708077763;4320.891977700551;4193.706440549163;4237.745735255864;4323.11376167888;4370.672199585044;4383.978080109595;4268.039691069515;4278.529361770203;4282.143571285756;4282.8715138545895;4293.377460268275;4261.552536983634;4261.936070958938;4264.616184543406;4270.145970805851;4272.060146767706;4576.610988066019;4594.081183763261;4596.954030459719;4597.402337696111;4598.011427543061;4842.806287748486;4859.73271470069;4878.024395120954;4890.706557606555;4894.632902532288;4914.606831453475;4922.26166075088;4925.138100832376;4935.481774413671;4935.950640493585;4561.749103799323;4609.516000819865;4610.700304480198;4612.7462989535225;4613.907721845578;4962.33008543842;4975.179095449211;4975.253711943165;5031.748412579356;5062.898742025139;4789.664723469394;4791.47293797682;4804.567588917014;4806.158922188603;4872.756362181947;4750.928736068961;4773.188557945157;4788.11419887322;4792.640551958617;4856.562909338106;4664.533546645308;4737.573618374363;4743.95256047442;4745.620350371962;4745.83389581363;4671.789769460383;4673.112108699336;4673.392458980311;4677.64917631179;4738.715677059387;3734.1598140418732;3768;3772.641599048086;3789.9621003789607;3798.4682144499793;3423.4009048416924;3453.9827300863335;3455.032590874559;3465.3242617689307;3510.8069056201643;4255.404243405926;4257.680673949404;4258.254805409041;4303.569643035671;4303.591158839905;4712.034033023222;4930.2851086592245;4934.9753251233515;4940.827071052496;4994.650374473752;4123.8969025773995;4168.562300958356;4171.666266698657;4176.561461046546;4190.643795277436;4371;4402;4407.801648925806;4411.536788637211;4413.911721765547;4580.24425969718;4620.768961551977;4635.884102897319;4690.413698287714;4691.648126390466;4975.726335051462;4978.925316120189;4982.128127577732;4986.426560945392;5032.295478632921;4583.335416364542;4615.07698460316;4615.861524154281;4671.7430541320555;4672.159011377848;4686.226772582486;4767.165745994368;4840.636952228668;4848.878778030577;4849.636277279147;4946.282788995647;4947.381577302837;4980.05378977993;4988.326575912351;5007.799688012438;4802.399700037496;4816.975915120402;4825.30033145199;4846.297286893451;4877.292792545132;4576.656750743774;4616.746078965555;4619.930701039554;4808.519148085304;4861.975690121527;4528.818847246073;4568.70303430276;4585.10590434862;4585.105904348753;4641.3502109703995;4643.883902902455;4648.395708557866;4657.767111644472;4662.603678687349;4702.318163866289;4505.256632655575;4671.696339737906;4681.087187998444;4696.201645720304;4750.833720819893 09:33:53 INFO - PROCESS | 16853 | |1;ext.html;544.2652419234032;550.0841099569218;560.6411896386317;563.1299642053027;564.723285590061;28418.14745557634;31213.375732485365;37686.43470347947;39596.60403395965;39650;39607.60392396075;39979.60020399795;40056.79971600145;40057;40075;7675.6545955432;7859.764207073797;7861;7862.095858976234;7863.37093032556;7658.234176582353;7727.845443091135;7756.0304961879765;7759.0689117306;7759.224077592252;7681.462297639167;7732.806679833021;7734.226577342249;7735.690572377098;7742.419318551103;7673.884891726629;7710.845783084363;7712.460127791057;7716.884246736304;7719.691212351499;7607.733729319447;7742.341900938427;7742.651580678883;7743.148253692089;7745.806354841117;38127.428088578694;38507.22985540301;38521;38554.22891542153;38610.61389386098;2873.7126287371307;2909.6508418989647;2934.207763903734;3074.6197624382744;3237.320162765822;27816.582751258746;27887;28066.719332806613;28481.287967800763;30916.0725178245;3308.0902751743224;3380.577427821522;3402.931941361159;3443.913902152441;3454.1537323355938;263483;264912.9999999981;266160;266169;267143;30632.69367306343;31961.840190798895;53486.7325663377;53888;53961.730191349576;33525.32949341;33630.159246019044;33731.32537349288;33813.49279760806;33835.432216650435;12623.747525049448;12705.110642255138;12705.682357941125;12709.237445753284;12709.364531773374;11132.554697811996;11209;11223.214374993671;11230.3261804292;11231.66305010851;7733;7751.7674469766;7799.49303295284;7838.804029899298;7902.288794008567;3122.937541249162;3138.6704396038544;3138.9686103139134;3164;3168.4791300176043;813.6175997281268;817.1828171828172;873.7728190670472;874.5802015032692;879.5338470610586;24859.254222373358;26342.94628214888;26584.468310633678;26766;26889.731102688722;842.0947481457458;850.8425941200898;851.5274022917216;852.8251708399763;873.3973558244791;14157.362918668685;14194.503192388423;14369.281535923163;14692.412303507954;14694.485693000694;384253;387009;387505;387823;388611;48514.5148548517;49004.26493602599;49027.75486122618;49040.5095949036;49164;944.7826999790087;991.8165139449225;1004.9799004020025;1052.8894466081103;1077.6066735641434;21168;28026;29281.96915954509;30989.535156973114;31007.68992310048;44636;45305.320420193064;45376.54623453855;45382.546174537834;45406.31890521711;266889;268371;268900;269166;269216;21299.467513311673;22157.224497142524;23453.950986371663;24994;25496;36959.260814784095;41189.1762164749;41300.58699413088;41636.79181604073;41836.3724544126;34033.31933361269;34588.65411345854;35019.47470787889;35051.29897402089;35709.82145089258;34201;34355.82822085873;34876.825615871756;35235.82382088073;35355.646443536265;28655.713442865304;28807.855960720062;31183.220419489695;31277.374452511278;35854.28291434209;29771;31222.531662025543;32483.675163248066;32804;32820.83589582037;24653.63019554744;25180.370490737878;25194.62208066917;25423.36441588901;25593.74406255988 09:33:53 INFO - PROCESS | 16853 | |2;jquery.html;341.651148355059;357.94809752585877;363.8999275199321;366.49972787145555;385.2737589643521;12283.692907677301;13203.2738199399;14736.631584210387;16366.181690915466;17180;16476.176191190454;16512.17439128045;16884.324627014903;17007.659846803057;17035.659286814258;4631.930521042187;5023.447420783729;5068.898622027557;5071.239314102877;5076.796928122871;3694.11341278094;3912.882613521599;4950.455449900508;5003.274525193863;5060.949390506103;3785.5268091488565;3835.1562656215588;3887.105965627907;3945.842166313344;5851.473367396933;5894.793682221123;5906.114082887559;5907.881842363172;5913.822585322404;5915.231019967398;5042.1428357179;5105.846824595268;5136.4606716295;5168.819091331786;5172.2241663750365;16182.757258641012;16299.918500407422;16396.75404868928;20141.697874531892;20292.391228263175;1882.802305757903;1976.1329380403129;1987.7813440521531;2318.9072437102495;2464.396222925395;12130.211536250115;12992.870071299356;13236.86763132366;13514.391852366667;13752.587422377344;1645.5968287769574;1662.9417970370978;1677.1614192903548;1704.1308932444542;1767.3637490503409;65339.673301633666;65497.67251163761;67156.6642166791;67483.66258168677;69092.30907690909;8926.642934282685;9124.58939347731;9373.531323433801;9390.577424015935;9545.331826772059;12935.094543381872;12972.610821675366;12972.870271297355;12977.545785897448;13006.609801705774;7025.047341624143;7132.965719970575;7253.165885923081;7279.4540409468445;7324.780256592311;6467.805965821033;6763.289854565298;6767.240517465494;6895.827604309932;6932.653367331714;5712.714364281769;5875.441833025856;5904.881902362014;5916.49709774674;6122.66325352101;1710.5381546982246;1736.3575477073312;1766.8144844791111;1781.8574514038846;1788.365130378697;769.8806684963839;801.2748462641318;849.2950850793826;864.2826454043129;870.9172628600273;16161.919190403973;16344.427945021867;16830.19358321377;18792.154353054146;18826.529336766416;653.1933062667601;657.3590749019668;669.7321071571411;673.1988933169513;732.3774791427351;9109.498977556166;9303.348765586345;9351.438913665203;9719.757006074764;9929.900700993043;368512;377265;388942.43748312537;389085;390048;80428.76141147324;81077;81990;82010;82547.58726206451;893.946363218209;907.9273658107203;928.7817362919709;929.419113054341;933.7665583604099;15346.846531534988;15359.539213823604;15708.450204242796;16284.348626055298;16302.184890755652;35471.822640887665;36783.26433471262;37536.2492750138;37550;38446.80776596099;51165.23252151146;51533;51875.74062129665;52023.47976520186;52335.73832130815;5080.593552515716;6855.6005398110265;6856.314368563104;7570.507916985378;7810.492317999312;8264.710735124241;10319.432431216355;10970.616028438966;11048.392338421463;11752.58865939688;9028.548572571213;9459.365880199777;9815.36200146988;10343.069123778896;10662.413567253876;9423.952880235554;9682.9031709682;9825.164860986895;9864.309498335047;9961.40231586107;9794.314397992071;9913.702588922344;10292.948535257276;10686.786264274515;10730;7314.670839812327;7319.926800731924;7522.285382888617;7531;7561.659725312485;9596.23230141573;9805.656802011896;9825.803483930424;9895.703128906145;9939.950300248453 09:33:53 INFO - PROCESS | 16853 | |3;mootools.html;1220.9145359824815;1340.3432318164103;1366.4397596985234;1432.369757306785;1679.3198754504422;5945.732442040107;6928.722851085957;7218.96390518048;7220.711171553145;7414.777556673308;7216.530925489839;7281.652894214574;7285.927140728591;7301.744438944625;7302.306280903319;2098.6851972204176;2120.7243058402387;2128.5636444528836;2130.669746189343;2133.168064454856;2052.9486762830975;2097.5490269592033;2129.361191642509;2129.659254519277;2130;2082.5106100066473;2086.926957556486;2117.7246957895527;2125.968110478344;2126.5321629241544;2042.6629606114973;2043.6219299429654;2053.363457328233;2060.103854823157;2068.844836637258;1989.950251243716;1993.8305244054272;2010.5375763574314;2020.2323117215365;2025.463252238158;7183.209846916835;7231.240719724458;7231.529950553249;7246.492745507817;7356.816079597999;4168.333066709342;4306.397104405386;4309.870703878857;4353.869383918487;4363.258246098171;2589.572720501134;2804.186785832106;2836.049923275705;2849.216465471991;2863.9713602863912;888.0897080492482;891.9955400223022;901.5807649442975;910.6175406329357;918.8805455290769;9389.10803473669;9441.716748497556;9451.243900487945;9471.526423678857;9485.905140948571;3549.3256281306467;3685.9078523037138;3790.5451345838674;3808.7143464240294;3821.885343439701;7775.961120194363;7781.182975787574;7782.066152061789;7789.7273595423885;7791.532508049535;4294.527601963781;4376.474823021258;4382.824687012548;4399.780010999437;4401.185780630593;3471.4272145096284;3533.8939831805087;3588.515550400715;4118.5057793064425;4119.176164767058;2779.8610069496444;3124.5781819454537;3154.542591324245;3166.1134882233014;3169.6513383527795;984.6258421799813;987.9259055570861;988.2143695761887;1025.041586116983;1029.7528593137592;762.3329586611715;788.3496115704567;795.2524626850858;799.2207597592301;810.5420437452821;4784.712917224908;4789.616830653539;4883.975580122076;4926.137925863031;5044.545990860766;384.21044753032226;385.51810237203495;394.9308870947573;395.8594698881913;396.10085106807963;3231.1760501072076;3344.347852168804;3377.7804442711636;3414.385410626111;3469.2714529948994;8437.746867593982;8896.5996530155;8898.955505222562;8909;8913.777155571162;8625.827483450295;8854.86717699235;8871.290296776242;8874.378793484524;8879.467231966102;6800.8299792504595;6986.93013069873;6988.545744526691;6990.510664253555;6992.545484543489;4872.9512704872495;4957.677750946321;5021.041793700387;5136.845894623168;5146.562542183956;7811.609419528887;8026.1171271158955;8029.076656184614;8047.356211503183;8222.62998165072;8111.351091912751;8149.144339844468;8275.62759675828;8294.87557686623;8296.502209867427;6294.496440284858;6425.485961123192;6427.775027874002;6429.54993150475;6431.774887878902;6764.661766911733;6791;6875.209350924708;6893.482988775962;6903.482238832007;6347.619142851444;6354.491640668828;6401.263854656774;6409.615423074631;6421.165248517663;6170.444659980444;6275.560710750204;6306.779262725782;6310.432061114522;6317.842053948688;5674.602777805514;5712.057510510719;5750.856228594319;5753.165790960204;5763.077907534775;4277.850275240352;4283.78581070939;4292.549282325311;4382.1016691577515;4434.977825110854;4356.6950313477755;4362.323839804835;4429.778511074369;4527.932081018853;4594.402727645384 09:33:53 INFO - PROCESS | 16853 | |4;prototype.html;272.5081228382771;288.9884404623817;293.9118264520643;303.8146730494398;306.1305891268798;4508.54914508549;4552.817887284509;4621.145088158693;4714.363560919275;4737.573618374346;4695.483496815347;4702.623790096793;4706.811727530895;4708;4719.882002949919;3519.8592056317716;3668.944965825515;3703.4815125882396;3717.1636381814146;3721.572019217784;3610.2418492116685;3686.1337585667347;3697.6335145506896;3722.088088418328;3754.2866855297543;3683.963160368389;3699.8520059197735;3702.389105797554;3704.462852886343;3708.332500149972;3699.7595156314887;3715.5541335039698;3715.5541335039834;3717.126475278307;3723.236736469017;3309.1468777484683;3310.420676381648;3311.106001379638;3320.767546271762;3321.5183798349344;4382.233109205877;4505.36924830524;4531.43357080365;4565.748883811389;4572.690791150481;4209.3054645983375;4222.535521092677;4229.894252643678;4232.217039847638;4240.321548552217;4866.245731911559;4869.683470574437;4872.244802055687;4875.293082503017;4881.608741508653;3376.4428869236544;3577.123604716835;3614.6566076222716;3615.204654975901;3620.818959052037;5051.3433253676785;5070.492950704936;5075.868135383148;5076.796928122871;5114.207297868837;3666.7616604920595;3671.7796932184156;3688.1517251032415;3689.4281386385155;3695.8152092395812;3752.962470375316;3759.642833930772;3762.6237376262156;3776.6034566370686;3782.678472329883;3999.1603862223124;4201.537830838605;4205.474315710536;4218.502431636724;4292.957070429318;4870.488598697086;4878.487758785347;4879.950810575743;4896;4911.993041426499;1296.4425297122139;1302.1275745250705;1312.5537317311969;1313.6124843171287;1316.789313709802;804.6240928013046;851.7019043334907;854.5300084953375;868.3704314372156;873.2926329672986;3918.4710064140977;3920.4119382092344;3932.3708206686792;3936.4685767421033;3937.7440466369594;4461.665375096881;4468.285074388147;4470.798814053375;4484.663650226246;4513.277875539898;3945.5659877413464;3946.4017073085447;3957.426173204869;3961;3987.6442009716834;2303.9769602303763;2362.700514716899;2370.988145059298;2374.5369652917516;2408.590974280066;4172.4784401949755;4196.873329369578;4221.345691417835;4252.447181866338;4268.91462170761;4513.689426597592;4520.638348932143;4527.596445102029;4594.5864872161;4626.352310676508;4184.937225941613;4194.937075943863;4198.467559340879;4404.471463424474;4727.456342520654;5055.898882022412;5065.620078494201;5079.187330027178;5089.872753181052;5110.361204849394;4748.833790817304;4869.513048695102;4935.815404303014;4950.1584730596605;4957.801687932442;4604.263317869125;4756.334113224082;4763.166445872028;4769.070031343855;4779.545943135397;3597.190632107755;3605.3330133925306;3608.332458495187;3613.223157021148;3615.9638403615627;4684.648651351231;4846.781894814671;5081.8475445736685;5093.23601459784;5111.642185047011;4885.218365061573;4924.753762311799;4931.827386041471;4939.4440751163265;4940.2342636891335;4930.8767280818265;4931.901361972812;4942.135126352946;4944.431390390007;4984.352034235526;4661.463931647904;4866.343043689057;4868.41579010521;4891.828785992473;4900.975495122501;4934.18585933317;4934.777934992862;4941.6293777966075;4945.307656927961;4963.329950456642;4874.439439464507;4879.878003049952;4882.170031094794;4891.578668559086;4907.877303067452 09:33:53 INFO - PROCESS | 16853 | |5;yui.html;622.8100429369042;646.113349020859;660.9570377925437;681.366329313738;729.8905164225365;12317.260964342135;13087.541936032228;13190.406431710571;13192.604221873335;13214.801777973325;12547.623571292876;12668.17656852304;12671.936640316786;12704.237745735263;12714.554990575332;603.6076550242334;623.1960770605936;772.5364781131333;779.5089093870868;806.7095845495617;803.995980020102;806.995965020174;807.2855522862279;807.3339494916688;807.3984881263467;843.8692002739585;847.4830353484369;847.4999750147412;847.7414388611471;848.0374774630777;650.9023646453046;664.7341063574561;818.8280461103176;843.8101427178866;844.8974088814095;616.8026231605888;617.1082785375135;617.1699064757894;617.2284644194757;617.9536534759866;12849.229046257255;12863.421146048357;12873.163244389085;12881.871181288161;12898.419571119228;11702.122340824388;11844.526218951232;11975.940120299343;12167.2699638022;12289.446974886152;10778.245522813406;10816.405097719622;11043.337399756041;11055.613053543088;11552.884471155265;3611.2777444511203;3658.5609726832686;3684.428913518409;3740.682042026431;3799.525059367579;47362;48157.11057336571;48671.75664121692;49661.75169124131;50259.49740502621;9315.34792564514;9327.486988215713;9346.626134954662;9365.344425890122;9374.625014999323;15857;15980.200989950688;16064.196790160446;16150.1117438542;16244.75632865508;6426.193063681333;6556.147700798866;6568.047633093175;6579.585389141262;6661.40047395727;3562.8931132066077;3602.819859007039;3613.7109031277437;3659.0669379308106;3687.1703866629796;2470.197185914549;2565.1791426743634;2571.524268010424;2582.4447743735186;2586.8706564671693;449.49880882815427;455.97264164150255;458.2141627109457;464.85821824343225;465.14877773674095;464.3846902853732;484.4549881383444;527.4040334422078;538.3982651611503;598.2730981857064;7163;7491.288327608869;7497.7506747975385;7683.692652293846;7955.8408831823035;471.3565982433953;499.71016810249967;530.3450238954888;542.8724249801294;612.4763327355137;3561.732870034758;3744.812759362021;3745.127436281859;3789.204267103884;3832.6742226911024;63607;63731.36268637347;64146.679266604304;66837.66581167062;66878.66560667165;58388.41611583915;58407.70796146077;58916;59547.404525955055;59780.402195977484;54424.18363724547;54956.72521637366;55123.448765512636;55472.16791748127;55633.72183139058;7494.495948718691;7606.22408489015;7907.644156012878;7980.720674776588;8046.436749427484;37033;37136;37420.251594967405;37480.81259593685;38247.6175238244;41747.16505669809;42749;44429;50684;52294.47705522896;9994.650187243411;10264.897351026395;10277.486125693536;10375.896241037795;10579.89420105789;11664.6500604982;11668.066554675435;11710.590129345432;11813.586524471602;12207.45066471993;10916.836247456136;10985.61550345734;11022.614208502984;11557.364344961108;11792.29246245228;10694.304870183412;10768.246222764332;10891.836622450512;11212.887871121511;11562.248453850472;10515;10602.098821599942;10900.672979810619;11335.376554289593;11369.090472761995;8962.283017358726;9156.084391560791;9240.815183696423;9243.861342080008;9648.421094734338;9383.249340052917;9648.13166814962;9735.799470404285;9770.951145244228;9862.457564834003 09:33:53 INFO - PROCESS | 16853 | __end_tp_report 09:33:53 INFO - PROCESS | 16853 | __start_cc_report 09:33:53 INFO - PROCESS | 16853 | _x_x_mozilla_cycle_collect,1194 09:33:53 INFO - PROCESS | 16853 | __end_cc_report 09:33:53 INFO - PROCESS | 16853 | __startTimestamp1477672433329__endTimestamp 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | ------- Summary: start ------- 09:33:53 INFO - PROCESS | 16853 | Number of tests: 6 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | [#0] dojo.html Cycles:165 Average:4500.09 Median:4619.93 stddev:485.63 (10.5%) stddev-sans-first:461.82 09:33:53 INFO - PROCESS | 16853 | Values: 2528.1 2571.2 2580.3 2606.5 2621.1 4489.1 4585.1 4670.4 4670.8 4677.6 4550.0 4581.1 4617.0 4617.7 4647.4 4162.2 4168.5 4213.8 4219.4 4286.7 3866.7 4143.4 4237.2 4285.1 4320.9 4193.7 4237.7 4323.1 4370.7 4384.0 4268.0 4278.5 4282.1 4282.9 4293.4 4261.6 4261.9 4264.6 4270.1 4272.1 4576.6 4594.1 4597.0 4597.4 4598.0 4842.8 4859.7 4878.0 4890.7 4894.6 4914.6 4922.3 4925.1 4935.5 4936.0 4561.7 4609.5 4610.7 4612.7 4613.9 4962.3 4975.2 4975.3 5031.7 5062.9 4789.7 4791.5 4804.6 4806.2 4872.8 4750.9 4773.2 4788.1 4792.6 4856.6 4664.5 4737.6 4744.0 4745.6 4745.8 4671.8 4673.1 4673.4 4677.6 4738.7 3734.2 3768.0 3772.6 3790.0 3798.5 3423.4 3454.0 3455.0 3465.3 3510.8 4255.4 4257.7 4258.3 4303.6 4303.6 4712.0 4930.3 4935.0 4940.8 4994.7 4123.9 4168.6 4171.7 4176.6 4190.6 4371.0 4402.0 4407.8 4411.5 4413.9 4580.2 4620.8 4635.9 4690.4 4691.6 4975.7 4978.9 4982.1 4986.4 5032.3 4583.3 4615.1 4615.9 4671.7 4672.2 4686.2 4767.2 4840.6 4848.9 4849.6 4946.3 4947.4 4980.1 4988.3 5007.8 4802.4 4817.0 4825.3 4846.3 4877.3 4576.7 4616.7 4619.9 4808.5 4862.0 4528.8 4568.7 4585.1 4585.1 4641.4 4643.9 4648.4 4657.8 4662.6 4702.3 4505.3 4671.7 4681.1 4696.2 4750.8 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | [#1] ext.html Cycles:180 Average:44725.73 Median:34948.15 stddev:82375.63 (235.7%) stddev-sans-first:82539.92 09:33:53 INFO - PROCESS | 16853 | Values: 544.3 550.1 560.6 563.1 564.7 28418.1 31213.4 37686.4 39596.6 39650.0 39607.6 39979.6 40056.8 40057.0 40075.0 7675.7 7859.8 7861.0 7862.1 7863.4 7658.2 7727.8 7756.0 7759.1 7759.2 7681.5 7732.8 7734.2 7735.7 7742.4 7673.9 7710.8 7712.5 7716.9 7719.7 7607.7 7742.3 7742.7 7743.1 7745.8 38127.4 38507.2 38521.0 38554.2 38610.6 2873.7 2909.7 2934.2 3074.6 3237.3 27816.6 27887.0 28066.7 28481.3 30916.1 3308.1 3380.6 3402.9 3443.9 3454.2 263483.0 264913.0 266160.0 266169.0 267143.0 30632.7 31961.8 53486.7 53888.0 53961.7 33525.3 33630.2 33731.3 33813.5 33835.4 12623.7 12705.1 12705.7 12709.2 12709.4 11132.6 11209.0 11223.2 11230.3 11231.7 7733.0 7751.8 7799.5 7838.8 7902.3 3122.9 3138.7 3139.0 3164.0 3168.5 813.6 817.2 873.8 874.6 879.5 24859.3 26342.9 26584.5 26766.0 26889.7 842.1 850.8 851.5 852.8 873.4 14157.4 14194.5 14369.3 14692.4 14694.5 384253.0 387009.0 387505.0 387823.0 388611.0 48514.5 49004.3 49027.8 49040.5 49164.0 944.8 991.8 1005.0 1052.9 1077.6 21168.0 28026.0 29282.0 30989.5 31007.7 44636.0 45305.3 45376.5 45382.5 45406.3 266889.0 268371.0 268900.0 269166.0 269216.0 21299.5 22157.2 23454.0 24994.0 25496.0 36959.3 41189.2 41300.6 41636.8 41836.4 34033.3 34588.7 35019.5 35051.3 35709.8 34201.0 34355.8 34876.8 35235.8 35355.6 28655.7 28807.9 31183.2 31277.4 35854.3 29771.0 31222.5 32483.7 32804.0 32820.8 24653.6 25180.4 25194.6 25423.4 25593.7 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | [#2] jquery.html Cycles:180 Average:24032.80 Median:28135.54 stddev:63372.08 (225.2%) stddev-sans-first:63524.89 09:33:53 INFO - PROCESS | 16853 | Values: 341.7 357.9 363.9 366.5 385.3 12283.7 13203.3 14736.6 16366.2 17180.0 16476.2 16512.2 16884.3 17007.7 17035.7 4631.9 5023.4 5068.9 5071.2 5076.8 3694.1 3912.9 4950.5 5003.3 5060.9 3785.5 3835.2 3887.1 3945.8 5851.5 5894.8 5906.1 5907.9 5913.8 5915.2 5042.1 5105.8 5136.5 5168.8 5172.2 16182.8 16299.9 16396.8 20141.7 20292.4 1882.8 1976.1 1987.8 2318.9 2464.4 12130.2 12992.9 13236.9 13514.4 13752.6 1645.6 1662.9 1677.2 1704.1 1767.4 65339.7 65497.7 67156.7 67483.7 69092.3 8926.6 9124.6 9373.5 9390.6 9545.3 12935.1 12972.6 12972.9 12977.5 13006.6 7025.0 7133.0 7253.2 7279.5 7324.8 6467.8 6763.3 6767.2 6895.8 6932.7 5712.7 5875.4 5904.9 5916.5 6122.7 1710.5 1736.4 1766.8 1781.9 1788.4 769.9 801.3 849.3 864.3 870.9 16161.9 16344.4 16830.2 18792.2 18826.5 653.2 657.4 669.7 673.2 732.4 9109.5 9303.3 9351.4 9719.8 9929.9 368512.0 377265.0 388942.4 389085.0 390048.0 80428.8 81077.0 81990.0 82010.0 82547.6 893.9 907.9 928.8 929.4 933.8 15346.8 15359.5 15708.5 16284.3 16302.2 35471.8 36783.3 37536.2 37550.0 38446.8 51165.2 51533.0 51875.7 52023.5 52335.7 5080.6 6855.6 6856.3 7570.5 7810.5 8264.7 10319.4 10970.6 11048.4 11752.6 9028.5 9459.4 9815.4 10343.1 10662.4 9424.0 9682.9 9825.2 9864.3 9961.4 9794.3 9913.7 10292.9 10686.8 10730.0 7314.7 7319.9 7522.3 7531.0 7561.7 9596.2 9805.7 9825.8 9895.7 9940.0 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | [#3] mootools.html Cycles:180 Average:4727.34 Median:5141.70 stddev:2614.44 (50.8%) stddev-sans-first:2608.50 09:33:53 INFO - PROCESS | 16853 | Values: 1220.9 1340.3 1366.4 1432.4 1679.3 5945.7 6928.7 7219.0 7220.7 7414.8 7216.5 7281.7 7285.9 7301.7 7302.3 2098.7 2120.7 2128.6 2130.7 2133.2 2052.9 2097.5 2129.4 2129.7 2130.0 2082.5 2086.9 2117.7 2126.0 2126.5 2042.7 2043.6 2053.4 2060.1 2068.8 1990.0 1993.8 2010.5 2020.2 2025.5 7183.2 7231.2 7231.5 7246.5 7356.8 4168.3 4306.4 4309.9 4353.9 4363.3 2589.6 2804.2 2836.0 2849.2 2864.0 888.1 892.0 901.6 910.6 918.9 9389.1 9441.7 9451.2 9471.5 9485.9 3549.3 3685.9 3790.5 3808.7 3821.9 7776.0 7781.2 7782.1 7789.7 7791.5 4294.5 4376.5 4382.8 4399.8 4401.2 3471.4 3533.9 3588.5 4118.5 4119.2 2779.9 3124.6 3154.5 3166.1 3169.7 984.6 987.9 988.2 1025.0 1029.8 762.3 788.3 795.3 799.2 810.5 4784.7 4789.6 4884.0 4926.1 5044.5 384.2 385.5 394.9 395.9 396.1 3231.2 3344.3 3377.8 3414.4 3469.3 8437.7 8896.6 8899.0 8909.0 8913.8 8625.8 8854.9 8871.3 8874.4 8879.5 6800.8 6986.9 6988.5 6990.5 6992.5 4873.0 4957.7 5021.0 5136.8 5146.6 7811.6 8026.1 8029.1 8047.4 8222.6 8111.4 8149.1 8275.6 8294.9 8296.5 6294.5 6425.5 6427.8 6429.5 6431.8 6764.7 6791.0 6875.2 6893.5 6903.5 6347.6 6354.5 6401.3 6409.6 6421.2 6170.4 6275.6 6306.8 6310.4 6317.8 5674.6 5712.1 5750.9 5753.2 5763.1 4277.9 4283.8 4292.5 4382.1 4435.0 4356.7 4362.3 4429.8 4527.9 4594.4 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | [#4] prototype.html Cycles:180 Average:4008.80 Median:4464.98 stddev:1149.34 (25.7%) stddev-sans-first:1117.83 09:33:53 INFO - PROCESS | 16853 | Values: 272.5 289.0 293.9 303.8 306.1 4508.5 4552.8 4621.1 4714.4 4737.6 4695.5 4702.6 4706.8 4708.0 4719.9 3519.9 3668.9 3703.5 3717.2 3721.6 3610.2 3686.1 3697.6 3722.1 3754.3 3684.0 3699.9 3702.4 3704.5 3708.3 3699.8 3715.6 3715.6 3717.1 3723.2 3309.1 3310.4 3311.1 3320.8 3321.5 4382.2 4505.4 4531.4 4565.7 4572.7 4209.3 4222.5 4229.9 4232.2 4240.3 4866.2 4869.7 4872.2 4875.3 4881.6 3376.4 3577.1 3614.7 3615.2 3620.8 5051.3 5070.5 5075.9 5076.8 5114.2 3666.8 3671.8 3688.2 3689.4 3695.8 3753.0 3759.6 3762.6 3776.6 3782.7 3999.2 4201.5 4205.5 4218.5 4293.0 4870.5 4878.5 4880.0 4896.0 4912.0 1296.4 1302.1 1312.6 1313.6 1316.8 804.6 851.7 854.5 868.4 873.3 3918.5 3920.4 3932.4 3936.5 3937.7 4461.7 4468.3 4470.8 4484.7 4513.3 3945.6 3946.4 3957.4 3961.0 3987.6 2304.0 2362.7 2371.0 2374.5 2408.6 4172.5 4196.9 4221.3 4252.4 4268.9 4513.7 4520.6 4527.6 4594.6 4626.4 4184.9 4194.9 4198.5 4404.5 4727.5 5055.9 5065.6 5079.2 5089.9 5110.4 4748.8 4869.5 4935.8 4950.2 4957.8 4604.3 4756.3 4763.2 4769.1 4779.5 3597.2 3605.3 3608.3 3613.2 3616.0 4684.6 4846.8 5081.8 5093.2 5111.6 4885.2 4924.8 4931.8 4939.4 4940.2 4930.9 4931.9 4942.1 4944.4 4984.4 4661.5 4866.3 4868.4 4891.8 4901.0 4934.2 4934.8 4941.6 4945.3 4963.3 4874.4 4879.9 4882.2 4891.6 4907.9 09:33:53 INFO - PROCESS | 16853 | 09:33:53 INFO - PROCESS | 16853 | [#5] yui.html Cycles:180 Average:14293.35 Median:24320.78 stddev:17898.76 (73.6%) stddev-sans-first:17919.53 09:33:53 INFO - PROCESS | 16853 | Values: 622.8 646.1 661.0 681.4 729.9 12317.3 13087.5 13190.4 13192.6 13214.8 12547.6 12668.2 12671.9 12704.2 12714.6 603.6 623.2 772.5 779.5 806.7 804.0 807.0 807.3 807.3 807.4 843.9 847.5 847.5 847.7 848.0 650.9 664.7 818.8 843.8 844.9 616.8 617.1 617.2 617.2 618.0 12849.2 12863.4 12873.2 12881.9 12898.4 11702.1 11844.5 11975.9 12167.3 12289.4 10778.2 10816.4 11043.3 11055.6 11552.9 3611.3 3658.6 3684.4 3740.7 3799.5 47362.0 48157.1 48671.8 49661.8 50259.5 9315.3 9327.5 9346.6 9365.3 9374.6 15857.0 15980.2 16064.2 16150.1 16244.8 6426.2 6556.1 6568.0 6579.6 6661.4 3562.9 3602.8 3613.7 3659.1 3687.2 2470.2 2565.2 2571.5 2582.4 2586.9 449.5 456.0 458.2 464.9 465.1 464.4 484.5 527.4 538.4 598.3 7163.0 7491.3 7497.8 7683.7 7955.8 471.4 499.7 530.3 542.9 612.5 3561.7 3744.8 3745.1 3789.2 3832.7 63607.0 63731.4 64146.7 66837.7 66878.7 58388.4 58407.7 58916.0 59547.4 59780.4 54424.2 54956.7 55123.4 55472.2 55633.7 7494.5 7606.2 7907.6 7980.7 8046.4 37033.0 37136.0 37420.3 37480.8 38247.6 41747.2 42749.0 44429.0 50684.0 52294.5 9994.7 10264.9 10277.5 10375.9 10579.9 11664.7 11668.1 11710.6 11813.6 12207.5 10916.8 10985.6 11022.6 11557.4 11792.3 10694.3 10768.2 10891.8 11212.9 11562.2 10515.0 10602.1 10900.7 11335.4 11369.1 8962.3 9156.1 9240.8 9243.9 9648.4 9383.2 9648.1 9735.8 9771.0 9862.5 09:33:53 INFO - PROCESS | 16853 | -------- Summary: end -------- 09:33:53 INFO - PROCESS | 16853 | 09:33:54 INFO - TEST-INFO | 16853: exit 0 09:33:54 INFO - TEST-OK | dromaeo_css | took 1123180ms 09:33:54 INFO - TEST-START | kraken 09:33:54 INFO - operating with platform_type : linux_ 09:33:54 INFO - Initialising browser for kraken test... 09:33:54 INFO - TEST-INFO | started process 17160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJgpRWi/profile http://localhost:57912/getInfo.html) 09:33:58 INFO - PROCESS | 17160 | __metrics Screen width/height:1600/1200 09:33:58 INFO - PROCESS | 17160 | colorDepth:24 09:33:58 INFO - PROCESS | 17160 | Browser inner width/height: 1024/697 09:33:58 INFO - PROCESS | 17160 | __metrics 09:33:59 INFO - PROCESS | 17160 | 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" 09:33:59 INFO - PROCESS | 17160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:59 INFO - PROCESS | 17160 | console.error: PushService: 09:33:59 INFO - PROCESS | 17160 | stateChangeProcessEnqueue: Error transitioning state 09:33:59 INFO - PROCESS | 17160 | UnknownError 09:34:00 INFO - TEST-INFO | 17160: exit 0 09:34:00 INFO - Browser initialized. 09:34:00 INFO - Running cycle 1/1 for kraken test... 09:34:00 INFO - TEST-INFO | started process 17245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJgpRWi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:12 INFO - PROCESS | 17245 | RSS: Main: 173232128 09:34:12 INFO - PROCESS | 17245 | 09:34:15 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57912/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:16 INFO - PROCESS | 17245 | RSS: Main: 238534656 09:34:16 INFO - PROCESS | 17245 | 09:34:19 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57912/tests/kraken/driver.html?testName=audio-dft) 09:34:19 INFO - PROCESS | 17245 | RSS: Main: 217272320 09:34:19 INFO - PROCESS | 17245 | 09:34:23 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57912/tests/kraken/driver.html?testName=audio-fft) 09:34:23 INFO - PROCESS | 17245 | RSS: Main: 299294720 09:34:23 INFO - PROCESS | 17245 | 09:34:25 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57912/tests/kraken/driver.html?testName=audio-oscillator) 09:34:26 INFO - PROCESS | 17245 | RSS: Main: 210206720 09:34:26 INFO - PROCESS | 17245 | 09:34:28 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:29 INFO - PROCESS | 17245 | RSS: Main: 212926464 09:34:29 INFO - PROCESS | 17245 | 09:34:32 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57912/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:33 INFO - PROCESS | 17245 | RSS: Main: 248705024 09:34:33 INFO - PROCESS | 17245 | 09:34:36 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57912/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:37 INFO - PROCESS | 17245 | RSS: Main: 248115200 09:34:37 INFO - PROCESS | 17245 | 09:34:39 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57912/tests/kraken/driver.html?testName=json-parse-financial) 09:34:40 INFO - PROCESS | 17245 | RSS: Main: 247840768 09:34:40 INFO - PROCESS | 17245 | 09:34:42 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:42 INFO - PROCESS | 17245 | RSS: Main: 209760256 09:34:42 INFO - PROCESS | 17245 | 09:34:44 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:45 INFO - PROCESS | 17245 | RSS: Main: 217542656 09:34:45 INFO - PROCESS | 17245 | 09:34:47 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:48 INFO - PROCESS | 17245 | RSS: Main: 226115584 09:34:48 INFO - PROCESS | 17245 | 09:34:50 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:51 INFO - PROCESS | 17245 | RSS: Main: 234905600 09:34:51 INFO - PROCESS | 17245 | 09:34:54 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:55 INFO - PROCESS | 17245 | RSS: Main: 232103936 09:34:55 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | Cycle 1(1): loaded http://localhost:57912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57912/tests/kraken/driver.html?testName=ai-astar) 09:34:57 INFO - PROCESS | 17245 | RSS: Main: 281272320 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | __start_tp_report 09:34:57 INFO - PROCESS | 17245 | _x_x_mozilla_page_load 09:34:57 INFO - PROCESS | 17245 | _x_x_mozilla_page_load_details 09:34:57 INFO - PROCESS | 17245 | |i|pagename|runs| 09:34:57 INFO - PROCESS | 17245 | |0;ai-astar;107;115;115;115;114;116;116;116;115;115 09:34:57 INFO - PROCESS | 17245 | |1;audio-beat-detection;161;129;136;181;130;130;129;129;175;134 09:34:57 INFO - PROCESS | 17245 | |2;audio-dft;162;161;161;161;160;161;163;163;162;159 09:34:57 INFO - PROCESS | 17245 | |3;audio-fft;79;75;76;105;77;76;76;77;99;76 09:34:57 INFO - PROCESS | 17245 | |4;audio-oscillator;82;83;114;85;83;84;105;84;84;113 09:34:57 INFO - PROCESS | 17245 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:34:57 INFO - PROCESS | 17245 | |6;imaging-darkroom;146;148;147;147;145;146;146;146;146;146 09:34:57 INFO - PROCESS | 17245 | |7;imaging-desaturate;86;85;85;85;86;85;86;85;86;85 09:34:57 INFO - PROCESS | 17245 | |8;json-parse-financial;63;63;63;63;64;65;70;62;64;62 09:34:57 INFO - PROCESS | 17245 | |9;json-stringify-tinderbox;65;66;66;65;66;65;65;66;66;66 09:34:57 INFO - PROCESS | 17245 | |10;stanford-crypto-aes;85;84;84;84;94;85;88;85;83;92 09:34:57 INFO - PROCESS | 17245 | |11;stanford-crypto-ccm;165;140;140;141;140;138;154;147;187;141 09:34:57 INFO - PROCESS | 17245 | |12;stanford-crypto-pbkdf2;183;177;177;183;179;176;175;177;176;180 09:34:57 INFO - PROCESS | 17245 | |13;stanford-crypto-sha256-iterative;71;71;70;70;71;71;70;69;69;70 09:34:57 INFO - PROCESS | 17245 | __end_tp_report 09:34:57 INFO - PROCESS | 17245 | __start_cc_report 09:34:57 INFO - PROCESS | 17245 | _x_x_mozilla_cycle_collect,1950 09:34:57 INFO - PROCESS | 17245 | __end_cc_report 09:34:57 INFO - PROCESS | 17245 | __startTimestamp1477672497297__endTimestamp 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | ------- Summary: start ------- 09:34:57 INFO - PROCESS | 17245 | Number of tests: 14 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.67 (2.3%) stddev-sans-first:0.67 09:34:57 INFO - PROCESS | 17245 | Values: 107.0 115.0 115.0 115.0 114.0 116.0 116.0 116.0 115.0 115.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:135.00 stddev:20.67 (15.3%) stddev-sans-first:20.92 09:34:57 INFO - PROCESS | 17245 | Values: 161.0 129.0 136.0 181.0 130.0 130.0 129.0 129.0 175.0 134.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 09:34:57 INFO - PROCESS | 17245 | Values: 162.0 161.0 161.0 161.0 160.0 161.0 163.0 163.0 162.0 159.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.50 stddev:10.90 (14.2%) stddev-sans-first:11.52 09:34:57 INFO - PROCESS | 17245 | Values: 79.0 75.0 76.0 105.0 77.0 76.0 76.0 77.0 99.0 76.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.50 stddev:13.32 (15.9%) stddev-sans-first:13.65 09:34:57 INFO - PROCESS | 17245 | Values: 82.0 83.0 114.0 85.0 83.0 84.0 105.0 84.0 84.0 113.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:34:57 INFO - PROCESS | 17245 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:34:57 INFO - PROCESS | 17245 | Values: 146.0 148.0 147.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:34:57 INFO - PROCESS | 17245 | Values: 86.0 85.0 85.0 85.0 86.0 85.0 86.0 85.0 86.0 85.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:63.50 stddev:2.33 (3.7%) stddev-sans-first:2.45 09:34:57 INFO - PROCESS | 17245 | Values: 63.0 63.0 63.0 63.0 64.0 65.0 70.0 62.0 64.0 62.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 09:34:57 INFO - PROCESS | 17245 | Values: 65.0 66.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 66.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:3.75 (4.4%) stddev-sans-first:3.94 09:34:57 INFO - PROCESS | 17245 | Values: 85.0 84.0 84.0 84.0 94.0 85.0 88.0 85.0 83.0 92.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:144.00 stddev:15.71 (10.9%) stddev-sans-first:15.60 09:34:57 INFO - PROCESS | 17245 | Values: 165.0 140.0 140.0 141.0 140.0 138.0 154.0 147.0 187.0 141.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:178.00 stddev:2.87 (1.6%) stddev-sans-first:2.49 09:34:57 INFO - PROCESS | 17245 | Values: 183.0 177.0 177.0 183.0 179.0 176.0 175.0 177.0 176.0 180.0 09:34:57 INFO - PROCESS | 17245 | 09:34:57 INFO - PROCESS | 17245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:0.79 (1.1%) stddev-sans-first:0.78 09:34:57 INFO - PROCESS | 17245 | Values: 71.0 71.0 70.0 70.0 71.0 71.0 70.0 69.0 69.0 70.0 09:34:57 INFO - PROCESS | 17245 | -------- Summary: end -------- 09:34:57 INFO - PROCESS | 17245 | 09:34:58 INFO - TEST-INFO | 17245: exit 0 09:34:58 INFO - TEST-OK | kraken | took 64280ms 09:34:58 INFO - SUITE-END | took 1187s 09:34:58 INFO - Completed test suite (00:19:47) 09:34:58 INFO - javascript benchmark 09:34:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2528.1151596941068, 2571.2029270926005, 2580.3033181041123, 2606.530824451599, 2621.1481268587704, 4489.102179564092, 4585.082983403316, 4670.416197975253, 4670.836520721776, 4677.602403795677, 4550.044490656957, 4581.106684196583, 4617.030423611046, 4617.722936623796, 4647.419072615923, 4162.1675664867, 4168.458100446953, 4213.810378532973, 4219.367094935754, 4286.678499112563, 3866.7309591054113, 4143.357779544175, 4237.152569486099, 4285.078708077763, 4320.891977700551, 4193.706440549163, 4237.745735255864, 4323.11376167888, 4370.672199585044, 4383.978080109595, 4268.039691069515, 4278.529361770203, 4282.143571285756, 4282.8715138545895, 4293.377460268275, 4261.552536983634, 4261.936070958938, 4264.616184543406, 4270.145970805851, 4272.060146767706, 4576.610988066019, 4594.081183763261, 4596.954030459719, 4597.402337696111, 4598.011427543061, 4842.806287748486, 4859.73271470069, 4878.024395120954, 4890.706557606555, 4894.632902532288, 4914.606831453475, 4922.26166075088, 4925.138100832376, 4935.481774413671, 4935.950640493585, 4561.749103799323, 4609.516000819865, 4610.700304480198, 4612.7462989535225, 4613.907721845578, 4962.33008543842, 4975.179095449211, 4975.253711943165, 5031.748412579356, 5062.898742025139, 4789.664723469394, 4791.47293797682, 4804.567588917014, 4806.158922188603, 4872.756362181947, 4750.928736068961, 4773.188557945157, 4788.11419887322, 4792.640551958617, 4856.562909338106, 4664.533546645308, 4737.573618374363, 4743.95256047442, 4745.620350371962, 4745.83389581363, 4671.789769460383, 4673.112108699336, 4673.392458980311, 4677.64917631179, 4738.715677059387, 3734.1598140418732, 3768.0, 3772.641599048086, 3789.9621003789607, 3798.4682144499793, 3423.4009048416924, 3453.9827300863335, 3455.032590874559, 3465.3242617689307, 3510.8069056201643, 4255.404243405926, 4257.680673949404, 4258.254805409041, 4303.569643035671, 4303.591158839905, 4712.034033023222, 4930.2851086592245, 4934.9753251233515, 4940.827071052496, 4994.650374473752, 4123.8969025773995, 4168.562300958356, 4171.666266698657, 4176.561461046546, 4190.643795277436, 4371.0, 4402.0, 4407.801648925806, 4411.536788637211, 4413.911721765547, 4580.24425969718, 4620.768961551977, 4635.884102897319, 4690.413698287714, 4691.648126390466, 4975.726335051462, 4978.925316120189, 4982.128127577732, 4986.426560945392, 5032.295478632921, 4583.335416364542, 4615.07698460316, 4615.861524154281, 4671.7430541320555, 4672.159011377848, 4686.226772582486, 4767.165745994368, 4840.636952228668, 4848.878778030577, 4849.636277279147, 4946.282788995647, 4947.381577302837, 4980.05378977993, 4988.326575912351, 5007.799688012438, 4802.399700037496, 4816.975915120402, 4825.30033145199, 4846.297286893451, 4877.292792545132, 4576.656750743774, 4616.746078965555, 4619.930701039554, 4808.519148085304, 4861.975690121527, 4528.818847246073, 4568.70303430276, 4585.10590434862, 4585.105904348753, 4641.3502109703995, 4643.883902902455, 4648.395708557866, 4657.767111644472, 4662.603678687349, 4702.318163866289, 4505.256632655575, 4671.696339737906, 4681.087187998444, 4696.201645720304, 4750.833720819893], "value": 4468.586010340958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.2652419234032, 550.0841099569218, 560.6411896386317, 563.1299642053027, 564.723285590061, 28418.14745557634, 31213.375732485365, 37686.43470347947, 39596.60403395965, 39650.0, 39607.60392396075, 39979.60020399795, 40056.79971600145, 40057.0, 40075.0, 7675.6545955432, 7859.764207073797, 7861.0, 7862.095858976234, 7863.37093032556, 7658.234176582353, 7727.845443091135, 7756.0304961879765, 7759.0689117306, 7759.224077592252, 7681.462297639167, 7732.806679833021, 7734.226577342249, 7735.690572377098, 7742.419318551103, 7673.884891726629, 7710.845783084363, 7712.460127791057, 7716.884246736304, 7719.691212351499, 7607.733729319447, 7742.341900938427, 7742.651580678883, 7743.148253692089, 7745.806354841117, 38127.428088578694, 38507.22985540301, 38521.0, 38554.22891542153, 38610.61389386098, 2873.7126287371307, 2909.6508418989647, 2934.207763903734, 3074.6197624382744, 3237.320162765822, 27816.582751258746, 27887.0, 28066.719332806613, 28481.287967800763, 30916.0725178245, 3308.0902751743224, 3380.577427821522, 3402.931941361159, 3443.913902152441, 3454.1537323355938, 263483.0, 264912.9999999981, 266160.0, 266169.0, 267143.0, 30632.69367306343, 31961.840190798895, 53486.7325663377, 53888.0, 53961.730191349576, 33525.32949341, 33630.159246019044, 33731.32537349288, 33813.49279760806, 33835.432216650435, 12623.747525049448, 12705.110642255138, 12705.682357941125, 12709.237445753284, 12709.364531773374, 11132.554697811996, 11209.0, 11223.214374993671, 11230.3261804292, 11231.66305010851, 7733.0, 7751.7674469766, 7799.49303295284, 7838.804029899298, 7902.288794008567, 3122.937541249162, 3138.6704396038544, 3138.9686103139134, 3164.0, 3168.4791300176043, 813.6175997281268, 817.1828171828172, 873.7728190670472, 874.5802015032692, 879.5338470610586, 24859.254222373358, 26342.94628214888, 26584.468310633678, 26766.0, 26889.731102688722, 842.0947481457458, 850.8425941200898, 851.5274022917216, 852.8251708399763, 873.3973558244791, 14157.362918668685, 14194.503192388423, 14369.281535923163, 14692.412303507954, 14694.485693000694, 384253.0, 387009.0, 387505.0, 387823.0, 388611.0, 48514.5148548517, 49004.26493602599, 49027.75486122618, 49040.5095949036, 49164.0, 944.7826999790087, 991.8165139449225, 1004.9799004020025, 1052.8894466081103, 1077.6066735641434, 21168.0, 28026.0, 29281.96915954509, 30989.535156973114, 31007.68992310048, 44636.0, 45305.320420193064, 45376.54623453855, 45382.546174537834, 45406.31890521711, 266889.0, 268371.0, 268900.0, 269166.0, 269216.0, 21299.467513311673, 22157.224497142524, 23453.950986371663, 24994.0, 25496.0, 36959.260814784095, 41189.1762164749, 41300.58699413088, 41636.79181604073, 41836.3724544126, 34033.31933361269, 34588.65411345854, 35019.47470787889, 35051.29897402089, 35709.82145089258, 34201.0, 34355.82822085873, 34876.825615871756, 35235.82382088073, 35355.646443536265, 28655.713442865304, 28807.855960720062, 31183.220419489695, 31277.374452511278, 35854.28291434209, 29771.0, 31222.531662025543, 32483.675163248066, 32804.0, 32820.83589582037, 24653.63019554744, 25180.370490737878, 25194.62208066917, 25423.36441588901, 25593.74406255988], "value": 15906.75634813881, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.651148355059, 357.94809752585877, 363.8999275199321, 366.49972787145555, 385.2737589643521, 12283.692907677301, 13203.2738199399, 14736.631584210387, 16366.181690915466, 17180.0, 16476.176191190454, 16512.17439128045, 16884.324627014903, 17007.659846803057, 17035.659286814258, 4631.930521042187, 5023.447420783729, 5068.898622027557, 5071.239314102877, 5076.796928122871, 3694.11341278094, 3912.882613521599, 4950.455449900508, 5003.274525193863, 5060.949390506103, 3785.5268091488565, 3835.1562656215588, 3887.105965627907, 3945.842166313344, 5851.473367396933, 5894.793682221123, 5906.114082887559, 5907.881842363172, 5913.822585322404, 5915.231019967398, 5042.1428357179, 5105.846824595268, 5136.4606716295, 5168.819091331786, 5172.2241663750365, 16182.757258641012, 16299.918500407422, 16396.75404868928, 20141.697874531892, 20292.391228263175, 1882.802305757903, 1976.1329380403129, 1987.7813440521531, 2318.9072437102495, 2464.396222925395, 12130.211536250115, 12992.870071299356, 13236.86763132366, 13514.391852366667, 13752.587422377344, 1645.5968287769574, 1662.9417970370978, 1677.1614192903548, 1704.1308932444542, 1767.3637490503409, 65339.673301633666, 65497.67251163761, 67156.6642166791, 67483.66258168677, 69092.30907690909, 8926.642934282685, 9124.58939347731, 9373.531323433801, 9390.577424015935, 9545.331826772059, 12935.094543381872, 12972.610821675366, 12972.870271297355, 12977.545785897448, 13006.609801705774, 7025.047341624143, 7132.965719970575, 7253.165885923081, 7279.4540409468445, 7324.780256592311, 6467.805965821033, 6763.289854565298, 6767.240517465494, 6895.827604309932, 6932.653367331714, 5712.714364281769, 5875.441833025856, 5904.881902362014, 5916.49709774674, 6122.66325352101, 1710.5381546982246, 1736.3575477073312, 1766.8144844791111, 1781.8574514038846, 1788.365130378697, 769.8806684963839, 801.2748462641318, 849.2950850793826, 864.2826454043129, 870.9172628600273, 16161.919190403973, 16344.427945021867, 16830.19358321377, 18792.154353054146, 18826.529336766416, 653.1933062667601, 657.3590749019668, 669.7321071571411, 673.1988933169513, 732.3774791427351, 9109.498977556166, 9303.348765586345, 9351.438913665203, 9719.757006074764, 9929.900700993043, 368512.0, 377265.0, 388942.43748312537, 389085.0, 390048.0, 80428.76141147324, 81077.0, 81990.0, 82010.0, 82547.58726206451, 893.946363218209, 907.9273658107203, 928.7817362919709, 929.419113054341, 933.7665583604099, 15346.846531534988, 15359.539213823604, 15708.450204242796, 16284.348626055298, 16302.184890755652, 35471.822640887665, 36783.26433471262, 37536.2492750138, 37550.0, 38446.80776596099, 51165.23252151146, 51533.0, 51875.74062129665, 52023.47976520186, 52335.73832130815, 5080.593552515716, 6855.6005398110265, 6856.314368563104, 7570.507916985378, 7810.492317999312, 8264.710735124241, 10319.432431216355, 10970.616028438966, 11048.392338421463, 11752.58865939688, 9028.548572571213, 9459.365880199777, 9815.36200146988, 10343.069123778896, 10662.413567253876, 9423.952880235554, 9682.9031709682, 9825.164860986895, 9864.309498335047, 9961.40231586107, 9794.314397992071, 9913.702588922344, 10292.948535257276, 10686.786264274515, 10730.0, 7314.670839812327, 7319.926800731924, 7522.285382888617, 7531.0, 7561.659725312485, 9596.23230141573, 9805.656802011896, 9825.803483930424, 9895.703128906145, 9939.950300248453], "value": 8033.884194817726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.9145359824815, 1340.3432318164103, 1366.4397596985234, 1432.369757306785, 1679.3198754504422, 5945.732442040107, 6928.722851085957, 7218.96390518048, 7220.711171553145, 7414.777556673308, 7216.530925489839, 7281.652894214574, 7285.927140728591, 7301.744438944625, 7302.306280903319, 2098.6851972204176, 2120.7243058402387, 2128.5636444528836, 2130.669746189343, 2133.168064454856, 2052.9486762830975, 2097.5490269592033, 2129.361191642509, 2129.659254519277, 2130.0, 2082.5106100066473, 2086.926957556486, 2117.7246957895527, 2125.968110478344, 2126.5321629241544, 2042.6629606114973, 2043.6219299429654, 2053.363457328233, 2060.103854823157, 2068.844836637258, 1989.950251243716, 1993.8305244054272, 2010.5375763574314, 2020.2323117215365, 2025.463252238158, 7183.209846916835, 7231.240719724458, 7231.529950553249, 7246.492745507817, 7356.816079597999, 4168.333066709342, 4306.397104405386, 4309.870703878857, 4353.869383918487, 4363.258246098171, 2589.572720501134, 2804.186785832106, 2836.049923275705, 2849.216465471991, 2863.9713602863912, 888.0897080492482, 891.9955400223022, 901.5807649442975, 910.6175406329357, 918.8805455290769, 9389.10803473669, 9441.716748497556, 9451.243900487945, 9471.526423678857, 9485.905140948571, 3549.3256281306467, 3685.9078523037138, 3790.5451345838674, 3808.7143464240294, 3821.885343439701, 7775.961120194363, 7781.182975787574, 7782.066152061789, 7789.7273595423885, 7791.532508049535, 4294.527601963781, 4376.474823021258, 4382.824687012548, 4399.780010999437, 4401.185780630593, 3471.4272145096284, 3533.8939831805087, 3588.515550400715, 4118.5057793064425, 4119.176164767058, 2779.8610069496444, 3124.5781819454537, 3154.542591324245, 3166.1134882233014, 3169.6513383527795, 984.6258421799813, 987.9259055570861, 988.2143695761887, 1025.041586116983, 1029.7528593137592, 762.3329586611715, 788.3496115704567, 795.2524626850858, 799.2207597592301, 810.5420437452821, 4784.712917224908, 4789.616830653539, 4883.975580122076, 4926.137925863031, 5044.545990860766, 384.21044753032226, 385.51810237203495, 394.9308870947573, 395.8594698881913, 396.10085106807963, 3231.1760501072076, 3344.347852168804, 3377.7804442711636, 3414.385410626111, 3469.2714529948994, 8437.746867593982, 8896.5996530155, 8898.955505222562, 8909.0, 8913.777155571162, 8625.827483450295, 8854.86717699235, 8871.290296776242, 8874.378793484524, 8879.467231966102, 6800.8299792504595, 6986.93013069873, 6988.545744526691, 6990.510664253555, 6992.545484543489, 4872.9512704872495, 4957.677750946321, 5021.041793700387, 5136.845894623168, 5146.562542183956, 7811.609419528887, 8026.1171271158955, 8029.076656184614, 8047.356211503183, 8222.62998165072, 8111.351091912751, 8149.144339844468, 8275.62759675828, 8294.87557686623, 8296.502209867427, 6294.496440284858, 6425.485961123192, 6427.775027874002, 6429.54993150475, 6431.774887878902, 6764.661766911733, 6791.0, 6875.209350924708, 6893.482988775962, 6903.482238832007, 6347.619142851444, 6354.491640668828, 6401.263854656774, 6409.615423074631, 6421.165248517663, 6170.444659980444, 6275.560710750204, 6306.779262725782, 6310.432061114522, 6317.842053948688, 5674.602777805514, 5712.057510510719, 5750.856228594319, 5753.165790960204, 5763.077907534775, 4277.850275240352, 4283.78581070939, 4292.549282325311, 4382.1016691577515, 4434.977825110854, 4356.6950313477755, 4362.323839804835, 4429.778511074369, 4527.932081018853, 4594.402727645384], "value": 3766.197541775236, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.5081228382771, 288.9884404623817, 293.9118264520643, 303.8146730494398, 306.1305891268798, 4508.54914508549, 4552.817887284509, 4621.145088158693, 4714.363560919275, 4737.573618374346, 4695.483496815347, 4702.623790096793, 4706.811727530895, 4708.0, 4719.882002949919, 3519.8592056317716, 3668.944965825515, 3703.4815125882396, 3717.1636381814146, 3721.572019217784, 3610.2418492116685, 3686.1337585667347, 3697.6335145506896, 3722.088088418328, 3754.2866855297543, 3683.963160368389, 3699.8520059197735, 3702.389105797554, 3704.462852886343, 3708.332500149972, 3699.7595156314887, 3715.5541335039698, 3715.5541335039834, 3717.126475278307, 3723.236736469017, 3309.1468777484683, 3310.420676381648, 3311.106001379638, 3320.767546271762, 3321.5183798349344, 4382.233109205877, 4505.36924830524, 4531.43357080365, 4565.748883811389, 4572.690791150481, 4209.3054645983375, 4222.535521092677, 4229.894252643678, 4232.217039847638, 4240.321548552217, 4866.245731911559, 4869.683470574437, 4872.244802055687, 4875.293082503017, 4881.608741508653, 3376.4428869236544, 3577.123604716835, 3614.6566076222716, 3615.204654975901, 3620.818959052037, 5051.3433253676785, 5070.492950704936, 5075.868135383148, 5076.796928122871, 5114.207297868837, 3666.7616604920595, 3671.7796932184156, 3688.1517251032415, 3689.4281386385155, 3695.8152092395812, 3752.962470375316, 3759.642833930772, 3762.6237376262156, 3776.6034566370686, 3782.678472329883, 3999.1603862223124, 4201.537830838605, 4205.474315710536, 4218.502431636724, 4292.957070429318, 4870.488598697086, 4878.487758785347, 4879.950810575743, 4896.0, 4911.993041426499, 1296.4425297122139, 1302.1275745250705, 1312.5537317311969, 1313.6124843171287, 1316.789313709802, 804.6240928013046, 851.7019043334907, 854.5300084953375, 868.3704314372156, 873.2926329672986, 3918.4710064140977, 3920.4119382092344, 3932.3708206686792, 3936.4685767421033, 3937.7440466369594, 4461.665375096881, 4468.285074388147, 4470.798814053375, 4484.663650226246, 4513.277875539898, 3945.5659877413464, 3946.4017073085447, 3957.426173204869, 3961.0, 3987.6442009716834, 2303.9769602303763, 2362.700514716899, 2370.988145059298, 2374.5369652917516, 2408.590974280066, 4172.4784401949755, 4196.873329369578, 4221.345691417835, 4252.447181866338, 4268.91462170761, 4513.689426597592, 4520.638348932143, 4527.596445102029, 4594.5864872161, 4626.352310676508, 4184.937225941613, 4194.937075943863, 4198.467559340879, 4404.471463424474, 4727.456342520654, 5055.898882022412, 5065.620078494201, 5079.187330027178, 5089.872753181052, 5110.361204849394, 4748.833790817304, 4869.513048695102, 4935.815404303014, 4950.1584730596605, 4957.801687932442, 4604.263317869125, 4756.334113224082, 4763.166445872028, 4769.070031343855, 4779.545943135397, 3597.190632107755, 3605.3330133925306, 3608.332458495187, 3613.223157021148, 3615.9638403615627, 4684.648651351231, 4846.781894814671, 5081.8475445736685, 5093.23601459784, 5111.642185047011, 4885.218365061573, 4924.753762311799, 4931.827386041471, 4939.4440751163265, 4940.2342636891335, 4930.8767280818265, 4931.901361972812, 4942.135126352946, 4944.431390390007, 4984.352034235526, 4661.463931647904, 4866.343043689057, 4868.41579010521, 4891.828785992473, 4900.975495122501, 4934.18585933317, 4934.777934992862, 4941.6293777966075, 4945.307656927961, 4963.329950456642, 4874.439439464507, 4879.878003049952, 4882.170031094794, 4891.578668559086, 4907.877303067452], "value": 3648.9517649290137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.8100429369042, 646.113349020859, 660.9570377925437, 681.366329313738, 729.8905164225365, 12317.260964342135, 13087.541936032228, 13190.406431710571, 13192.604221873335, 13214.801777973325, 12547.623571292876, 12668.17656852304, 12671.936640316786, 12704.237745735263, 12714.554990575332, 603.6076550242334, 623.1960770605936, 772.5364781131333, 779.5089093870868, 806.7095845495617, 803.995980020102, 806.995965020174, 807.2855522862279, 807.3339494916688, 807.3984881263467, 843.8692002739585, 847.4830353484369, 847.4999750147412, 847.7414388611471, 848.0374774630777, 650.9023646453046, 664.7341063574561, 818.8280461103176, 843.8101427178866, 844.8974088814095, 616.8026231605888, 617.1082785375135, 617.1699064757894, 617.2284644194757, 617.9536534759866, 12849.229046257255, 12863.421146048357, 12873.163244389085, 12881.871181288161, 12898.419571119228, 11702.122340824388, 11844.526218951232, 11975.940120299343, 12167.2699638022, 12289.446974886152, 10778.245522813406, 10816.405097719622, 11043.337399756041, 11055.613053543088, 11552.884471155265, 3611.2777444511203, 3658.5609726832686, 3684.428913518409, 3740.682042026431, 3799.525059367579, 47362.0, 48157.11057336571, 48671.75664121692, 49661.75169124131, 50259.49740502621, 9315.34792564514, 9327.486988215713, 9346.626134954662, 9365.344425890122, 9374.625014999323, 15857.0, 15980.200989950688, 16064.196790160446, 16150.1117438542, 16244.75632865508, 6426.193063681333, 6556.147700798866, 6568.047633093175, 6579.585389141262, 6661.40047395727, 3562.8931132066077, 3602.819859007039, 3613.7109031277437, 3659.0669379308106, 3687.1703866629796, 2470.197185914549, 2565.1791426743634, 2571.524268010424, 2582.4447743735186, 2586.8706564671693, 449.49880882815427, 455.97264164150255, 458.2141627109457, 464.85821824343225, 465.14877773674095, 464.3846902853732, 484.4549881383444, 527.4040334422078, 538.3982651611503, 598.2730981857064, 7163.0, 7491.288327608869, 7497.7506747975385, 7683.692652293846, 7955.8408831823035, 471.3565982433953, 499.71016810249967, 530.3450238954888, 542.8724249801294, 612.4763327355137, 3561.732870034758, 3744.812759362021, 3745.127436281859, 3789.204267103884, 3832.6742226911024, 63607.0, 63731.36268637347, 64146.679266604304, 66837.66581167062, 66878.66560667165, 58388.41611583915, 58407.70796146077, 58916.0, 59547.404525955055, 59780.402195977484, 54424.18363724547, 54956.72521637366, 55123.448765512636, 55472.16791748127, 55633.72183139058, 7494.495948718691, 7606.22408489015, 7907.644156012878, 7980.720674776588, 8046.436749427484, 37033.0, 37136.0, 37420.251594967405, 37480.81259593685, 38247.6175238244, 41747.16505669809, 42749.0, 44429.0, 50684.0, 52294.47705522896, 9994.650187243411, 10264.897351026395, 10277.486125693536, 10375.896241037795, 10579.89420105789, 11664.6500604982, 11668.066554675435, 11710.590129345432, 11813.586524471602, 12207.45066471993, 10916.836247456136, 10985.61550345734, 11022.614208502984, 11557.364344961108, 11792.29246245228, 10694.304870183412, 10768.246222764332, 10891.836622450512, 11212.887871121511, 11562.248453850472, 10515.0, 10602.098821599942, 10900.672979810619, 11335.376554289593, 11369.090472761995, 8962.283017358726, 9156.084391560791, 9240.815183696423, 9243.861342080008, 9648.421094734338, 9383.249340052917, 9648.13166814962, 9735.799470404285, 9770.951145244228, 9862.457564834003], "value": 6011.2100405281535, "unit": "score"}], "name": "dromaeo_css", "value": 6011.188462381027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 115.0, 114.0, 116.0, 116.0, 116.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 136.0, 181.0, 130.0, 130.0, 129.0, 129.0, 175.0, 134.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 163.0, 163.0, 162.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 105.0, 77.0, 76.0, 76.0, 77.0, 99.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 85.0, 83.0, 84.0, 105.0, 84.0, 84.0, 113.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 65.0, 70.0, 62.0, 64.0, 62.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 94.0, 85.0, 88.0, 85.0, 83.0, 92.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 140.0, 140.0, 141.0, 140.0, 138.0, 154.0, 147.0, 187.0, 141.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 177.0, 177.0, 183.0, 179.0, 176.0, 175.0, 177.0, 176.0, 180.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 70.0, 71.0, 71.0, 70.0, 69.0, 69.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1554.8, "alertThreshold": 2.0}]} 09:34:59 INFO - Return code: 0 09:34:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:59 INFO - # TBPL SUCCESS # 09:34:59 INFO - Running post-action listener: _resource_record_post_action 09:34:59 INFO - [mozharness: 2016-10-28 16:34:59.105044Z] Finished run-tests step (success) 09:34:59 INFO - Running post-run listener: _resource_record_post_run 09:34:59 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390619136; Read time: 12; Write time: 264268 09:34:59 INFO - TinderboxPrint: CPU usage
13.1% 09:34:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:34:59 INFO - TinderboxPrint: I/O write bytes / time
390,619,136 / 264,268 09:34:59 INFO - TinderboxPrint: CPU idle
8,349.7 (86.9%) 09:34:59 INFO - TinderboxPrint: CPU user
1,207.1 (12.6%) 09:34:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:34:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99659776; Read time: 0; Write time: 80636 09:34:59 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290959360; Read time: 0; Write time: 183632 09:34:59 INFO - Running post-run listener: _upload_blobber_files 09:34:59 INFO - Blob upload gear active. 09:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:59 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 09:34:59 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:34:59 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:35:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:00 INFO - (blobuploader) - INFO - Done attempting. 09:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:03 INFO - (blobuploader) - INFO - Done attempting. 09:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:04 INFO - (blobuploader) - INFO - Done attempting. 09:35:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:04 INFO - Return code: 0 09:35:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/bc9d5b58a6940da7e87d3a556da01de3837b4ebda5bc7bc705d75ee5d8b55f578960976ff546e10d44c80a06ddaf7bd98b35756b572704d479ef827ebcbdc654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a314a4a09325bd5602e00bffd04610386214ec1c3d034b4061af1c78dc93019fd2a0bace44670599484017ce2a44cb35f81ab9408e0514ec4216c9324dc50117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/da7aa4e439b2048a00ae90a0513ed2f46a0282de20e7684cdf044f4e6f12d5d6d93dd4579aa1625f18d4bc9efa44028e3f156e95719a5721c3f723bbc167c1d2"} 09:35:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:04 INFO - Contents: 09:35:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/bc9d5b58a6940da7e87d3a556da01de3837b4ebda5bc7bc705d75ee5d8b55f578960976ff546e10d44c80a06ddaf7bd98b35756b572704d479ef827ebcbdc654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a314a4a09325bd5602e00bffd04610386214ec1c3d034b4061af1c78dc93019fd2a0bace44670599484017ce2a44cb35f81ab9408e0514ec4216c9324dc50117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/da7aa4e439b2048a00ae90a0513ed2f46a0282de20e7684cdf044f4e6f12d5d6d93dd4579aa1625f18d4bc9efa44028e3f156e95719a5721c3f723bbc167c1d2"} 09:35:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:04 INFO - Copying logs to upload dir... 09:35:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.637177 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-28 09:35:04.602780) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 09:35:04.605850) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/bc9d5b58a6940da7e87d3a556da01de3837b4ebda5bc7bc705d75ee5d8b55f578960976ff546e10d44c80a06ddaf7bd98b35756b572704d479ef827ebcbdc654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a314a4a09325bd5602e00bffd04610386214ec1c3d034b4061af1c78dc93019fd2a0bace44670599484017ce2a44cb35f81ab9408e0514ec4216c9324dc50117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/da7aa4e439b2048a00ae90a0513ed2f46a0282de20e7684cdf044f4e6f12d5d6d93dd4579aa1625f18d4bc9efa44028e3f156e95719a5721c3f723bbc167c1d2"} build_url:https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/WXw_Fh3wSyyuXS_b4UidNg/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/Cedar/sha512/bc9d5b58a6940da7e87d3a556da01de3837b4ebda5bc7bc705d75ee5d8b55f578960976ff546e10d44c80a06ddaf7bd98b35756b572704d479ef827ebcbdc654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a314a4a09325bd5602e00bffd04610386214ec1c3d034b4061af1c78dc93019fd2a0bace44670599484017ce2a44cb35f81ab9408e0514ec4216c9324dc50117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/da7aa4e439b2048a00ae90a0513ed2f46a0282de20e7684cdf044f4e6f12d5d6d93dd4579aa1625f18d4bc9efa44028e3f156e95719a5721c3f723bbc167c1d2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 09:35:04.631725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:35:04.632203) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1477667297.555308-1045903636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:35:04.715670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 09:35:04.716104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 09:35:04.716423) ========= ========= Total master_lag: 0.21 =========