builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1478152066.31 results: success (0) buildid: 20161102143123 builduid: d5bdbdd1399a43f28f50fb6619c15691 revision: ee7c1fd6966586f0ffab187d164b3e282f771cab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.307417) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.307922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.308206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.322903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.323662) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 22:47:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-11-02 22:47:46 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.271811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.609589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.609943) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013917 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:46.659638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 22:47:46.659997) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev ee7c1fd6966586f0ffab187d164b3e282f771cab --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 ee7c1fd6966586f0ffab187d164b3e282f771cab --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=82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 22:47:46,862 truncating revision to first 12 chars 2016-11-02 22:47:46,862 Setting DEBUG logging. 2016-11-02 22:47:46,862 attempt 1/10 2016-11-02 22:47:46,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/ee7c1fd69665?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 22:47:48,237 unpacking tar archive at: cedar-ee7c1fd69665/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 22:47:48.424276) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:48.424594) ========= script_repo_revision: ee7c1fd6966586f0ffab187d164b3e282f771cab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:48.424992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:48.425253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 22:47:48.434390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-02 22:47:48.434965) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:48 INFO - MultiFileLogger online at 20161102 22:47:48 in /builds/slave/test 22:47:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 22:47:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:47:48 INFO - {'append_to_log': False, 22:47:48 INFO - 'base_work_dir': '/builds/slave/test', 22:47:48 INFO - 'blob_upload_branch': 'Cedar', 22:47:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:47:48 INFO - 'branch': 'Cedar', 22:47:48 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:48 INFO - 'config_files': ('talos/linux_config.py',), 22:47:48 INFO - 'default_actions': ('clobber', 22:47:48 INFO - 'read-buildbot-config', 22:47:48 INFO - 'download-and-extract', 22:47:48 INFO - 'populate-webroot', 22:47:48 INFO - 'create-virtualenv', 22:47:48 INFO - 'install', 22:47:48 INFO - 'run-tests'), 22:47:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:48 INFO - 'download_minidump_stackwalk': True, 22:47:48 INFO - 'download_symbols': 'ondemand', 22:47:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:48 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:48 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:48 INFO - 'installer_path': 'installer.exe', 22:47:48 INFO - 'log_level': 'info', 22:47:48 INFO - 'log_name': 'talos', 22:47:48 INFO - 'log_to_console': True, 22:47:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:48 INFO - 'opt_config_files': (), 22:47:48 INFO - 'pip_index': False, 22:47:48 INFO - 'sps_profile': False, 22:47:48 INFO - 'sps_profile_interval': 0, 22:47:48 INFO - 'suite': 'dromaeojs-e10s', 22:47:48 INFO - 'system_bits': '32', 22:47:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:48 INFO - 'title': 'talos-linux64-ix-066', 22:47:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:48 INFO - 'use_talos_json': True, 22:47:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:47:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:48 INFO - 'work_dir': 'build'} 22:47:48 INFO - [mozharness: 2016-11-03 05:47:48.745266Z] Running clobber step. 22:47:48 INFO - Running pre-action listener: _resource_record_pre_action 22:47:48 INFO - Running main action method: clobber 22:47:48 INFO - rmtree: /builds/slave/test/build 22:47:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:47:49 INFO - Running post-action listener: _resource_record_post_action 22:47:49 INFO - [mozharness: 2016-11-03 05:47:49.208302Z] Finished clobber step (success) 22:47:49 INFO - [mozharness: 2016-11-03 05:47:49.208404Z] Running read-buildbot-config step. 22:47:49 INFO - Running pre-action listener: _resource_record_pre_action 22:47:49 INFO - Running main action method: read_buildbot_config 22:47:49 INFO - Using buildbot properties: 22:47:49 INFO - { 22:47:49 INFO - "project": "", 22:47:49 INFO - "product": "firefox", 22:47:49 INFO - "script_repo_revision": "default", 22:47:49 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 22:47:49 INFO - "repository": "", 22:47:49 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 22:47:49 INFO - "buildid": "20161102143123", 22:47:49 INFO - "pgo_build": "False", 22:47:49 INFO - "basedir": "/builds/slave/test", 22:47:49 INFO - "buildnumber": 1, 22:47:49 INFO - "slavename": "talos-linux64-ix-066", 22:47:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:47:49 INFO - "platform": "ubuntu64_hw", 22:47:49 INFO - "scheduler": "tests-cedar-linux64-talos", 22:47:49 INFO - "branch": "cedar", 22:47:49 INFO - "repo_path": "projects/cedar", 22:47:49 INFO - "revision": "ee7c1fd6966586f0ffab187d164b3e282f771cab", 22:47:49 INFO - "stage_platform": "linux64", 22:47:49 INFO - "builduid": "d5bdbdd1399a43f28f50fb6619c15691", 22:47:49 INFO - "slavebuilddir": "test" 22:47:49 INFO - } 22:47:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:47:49 INFO - Running post-action listener: _resource_record_post_action 22:47:49 INFO - [mozharness: 2016-11-03 05:47:49.210862Z] Finished read-buildbot-config step (success) 22:47:49 INFO - [mozharness: 2016-11-03 05:47:49.210950Z] Running download-and-extract step. 22:47:49 INFO - Running pre-action listener: _resource_record_pre_action 22:47:49 INFO - Running main action method: download_and_extract 22:47:49 INFO - mkdir: /builds/slave/test/build/tests 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:49 INFO - trying https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:47:49 INFO - Downloading https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/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 22:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/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 22:47:49 INFO - Downloaded 1361 bytes. 22:47:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:47:49 INFO - Using the following test package requirements: 22:47:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:47:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'jsshell-linux-x86_64.zip'], 22:47:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:47:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:47:49 INFO - Fetch https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:47:50 INFO - Http code: 200 22:47:50 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 22:47:50 INFO - x-amz-cf-id: Nn6UgKMSD28nc0qIHkzbtoKBvCOb3Bax6710cFo9O2LbDY-wUEC9KA== 22:47:50 INFO - x-amz-version-id: dhuoPmHYBmDZ7rPaFzzdDF7rpJsq3L3w 22:47:50 INFO - Expected file size: 20452285 22:47:50 INFO - Obtained file size: 20452285 22:47:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:47:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:47:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:47:54 INFO - Fetch https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:47:55 INFO - Http code: 200 22:47:55 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 22:47:55 INFO - x-amz-cf-id: lwZ_oOLpINX6wI2BbKl35MUTeTHwstshEnu5hBXMC9gBZJxcqwLztQ== 22:47:55 INFO - x-amz-version-id: dhuoPmHYBmDZ7rPaFzzdDF7rpJsq3L3w 22:47:55 INFO - Expected file size: 20452285 22:47:55 INFO - Obtained file size: 20452285 22:47:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:47:59 INFO - Fetch https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:48:00 INFO - Http code: 200 22:48:00 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 22:48:00 INFO - x-amz-cf-id: 9PeucG0MyXk4Xtwma4ik8Fwp_0WxwuGAkwobwXxMquOgSXNooRBL8g== 22:48:00 INFO - x-amz-version-id: FCPuCz5_.j0e_3Vo2nCj.rLvNJbRfN5o 22:48:00 INFO - Expected file size: 14409038 22:48:00 INFO - Obtained file size: 14409038 22:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:00 INFO - trying https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:48:00 INFO - Downloading https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/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 22:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/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 22:48:02 INFO - Downloaded 55801566 bytes. 22:48:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:48:02 INFO - mkdir: /builds/slave/test/properties 22:48:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:48:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:48:02 INFO - Contents: 22:48:02 INFO - build_url:https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:48:02 INFO - Running post-action listener: _resource_record_post_action 22:48:02 INFO - Running post-action listener: set_extra_try_arguments 22:48:02 INFO - [mozharness: 2016-11-03 05:48:02.797120Z] Finished download-and-extract step (success) 22:48:02 INFO - [mozharness: 2016-11-03 05:48:02.797346Z] Running populate-webroot step. 22:48:02 INFO - Running pre-action listener: _resource_record_pre_action 22:48:02 INFO - Running main action method: populate_webroot 22:48:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:48:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:48:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:48:02 INFO - '--tppagecycles', 22:48:02 INFO - '7'], 22:48:02 INFO - 'tests': ['tsvgm']}}, 22:48:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:48:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:48:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:48:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:48:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:48:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:48:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['damp', 'tps']}, 22:48:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'tests': ['damp', 'tps']}, 22:48:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['dromaeo_dom']}, 22:48:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:48:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['basic_compositor_video']}, 22:48:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:48:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['a11yr', 22:48:02 INFO - 'ts_paint', 22:48:02 INFO - 'tpaint', 22:48:02 INFO - 'sessionrestore', 22:48:02 INFO - 'sessionrestore_no_auto_restore', 22:48:02 INFO - 'tabpaint']}, 22:48:02 INFO - 'other-e10s': {'tests': ['a11yr', 22:48:02 INFO - 'ts_paint', 22:48:02 INFO - 'tpaint', 22:48:02 INFO - 'sessionrestore', 22:48:02 INFO - 'sessionrestore_no_auto_restore', 22:48:02 INFO - 'tabpaint']}, 22:48:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:48:02 INFO - 'ts_paint', 22:48:02 INFO - 'tpaint', 22:48:02 INFO - 'sessionrestore', 22:48:02 INFO - 'sessionrestore_no_auto_restore', 22:48:02 INFO - 'tabpaint']}, 22:48:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:48:02 INFO - 'ts_paint', 22:48:02 INFO - 'tpaint', 22:48:02 INFO - 'sessionrestore', 22:48:02 INFO - 'sessionrestore_no_auto_restore', 22:48:02 INFO - 'tabpaint']}, 22:48:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['a11yr', 22:48:02 INFO - 'ts_paint', 22:48:02 INFO - 'tpaint', 22:48:02 INFO - 'sessionrestore', 22:48:02 INFO - 'sessionrestore_no_auto_restore', 22:48:02 INFO - 'tabpaint']}, 22:48:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['a11yr', 22:48:02 INFO - 'ts_paint', 22:48:02 INFO - 'tpaint', 22:48:02 INFO - 'sessionrestore', 22:48:02 INFO - 'sessionrestore_no_auto_restore', 22:48:02 INFO - 'tabpaint']}, 22:48:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['tsvgx', 22:48:02 INFO - 'tsvgr_opacity', 22:48:02 INFO - 'tart', 22:48:02 INFO - 'tscrollx', 22:48:02 INFO - 'cart']}, 22:48:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:48:02 INFO - 'tsvgr_opacity', 22:48:02 INFO - 'tart', 22:48:02 INFO - 'tscrollx', 22:48:02 INFO - 'cart']}, 22:48:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'talos_options': ['--disable-e10s'], 22:48:02 INFO - 'tests': ['tp5o']}, 22:48:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'tests': ['tp5o']}, 22:48:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'talos_options': ['--disable-e10s', 22:48:02 INFO - '--xperf_path', 22:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:48:02 INFO - 'tests': ['tp5n']}, 22:48:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:48:02 INFO - 'talos_options': ['--xperf_path', 22:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:48:02 INFO - 'tests': ['tp5n']}}, 22:48:02 INFO - 'talos.zip': {'path': '', 22:48:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:48:02 INFO - Running post-action listener: _resource_record_post_action 22:48:02 INFO - [mozharness: 2016-11-03 05:48:02.819490Z] Finished populate-webroot step (success) 22:48:02 INFO - [mozharness: 2016-11-03 05:48:02.819588Z] Running create-virtualenv step. 22:48:02 INFO - Running pre-action listener: _resource_record_pre_action 22:48:02 INFO - Running main action method: create_virtualenv 22:48:02 INFO - Creating virtualenv /builds/slave/test/build/venv 22:48:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:48:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:48:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:48:02 INFO - Using real prefix '/usr' 22:48:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:48:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:48:05 INFO - Installing pip.................done. 22:48:05 INFO - Return code: 0 22:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:48:05 INFO - Reading from file tmpfile_stdout 22:48:05 INFO - Output received: 22:48:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:48:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:48:05 INFO - Using env: {'DISPLAY': ':0', 22:48:05 INFO - 'HOME': '/home/cltbld', 22:48:05 INFO - 'LANG': 'en_US.UTF-8', 22:48:05 INFO - 'LANGUAGE': 'en_US:en', 22:48:05 INFO - 'LOGNAME': 'cltbld', 22:48:05 INFO - 'MAIL': '/var/mail/cltbld', 22:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:05 INFO - 'MOZ_NO_REMOTE': '1', 22:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:05 INFO - 'NO_EM_RESTART': '1', 22:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:05 INFO - 'PWD': '/builds/slave/test', 22:48:05 INFO - 'SHELL': '/bin/bash', 22:48:05 INFO - 'SHLVL': '1', 22:48:05 INFO - 'TERM': 'linux', 22:48:05 INFO - 'TMOUT': '86400', 22:48:05 INFO - 'USER': 'cltbld', 22:48:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:05 INFO - '_': '/tools/buildbot/bin/python'} 22:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:48:05 INFO - Cleaning up... 22:48:05 INFO - Return code: 0 22:48:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:48:05 INFO - Using env: {'DISPLAY': ':0', 22:48:05 INFO - 'HOME': '/home/cltbld', 22:48:05 INFO - 'LANG': 'en_US.UTF-8', 22:48:05 INFO - 'LANGUAGE': 'en_US:en', 22:48:05 INFO - 'LOGNAME': 'cltbld', 22:48:05 INFO - 'MAIL': '/var/mail/cltbld', 22:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:05 INFO - 'MOZ_NO_REMOTE': '1', 22:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:05 INFO - 'NO_EM_RESTART': '1', 22:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:05 INFO - 'PWD': '/builds/slave/test', 22:48:05 INFO - 'SHELL': '/bin/bash', 22:48:05 INFO - 'SHLVL': '1', 22:48:05 INFO - 'TERM': 'linux', 22:48:05 INFO - 'TMOUT': '86400', 22:48:05 INFO - 'USER': 'cltbld', 22:48:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:05 INFO - '_': '/tools/buildbot/bin/python'} 22:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:06 INFO - Downloading/unpacking psutil>=3.1.1 22:48:06 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 22:48:06 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 22:48:06 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 22:48:06 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 22:48:06 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 22:48:06 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 22:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:48:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:48:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:48:08 INFO - Installing collected packages: psutil 22:48:08 INFO - Running setup.py install for psutil 22:48:08 INFO - building 'psutil._psutil_linux' extension 22:48:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:48:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:48:08 INFO - building 'psutil._psutil_posix' extension 22:48:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:48:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:48:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:48:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:48:08 INFO - Successfully installed psutil 22:48:08 INFO - Cleaning up... 22:48:08 INFO - Return code: 0 22:48:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:48:08 INFO - Using env: {'DISPLAY': ':0', 22:48:08 INFO - 'HOME': '/home/cltbld', 22:48:08 INFO - 'LANG': 'en_US.UTF-8', 22:48:08 INFO - 'LANGUAGE': 'en_US:en', 22:48:08 INFO - 'LOGNAME': 'cltbld', 22:48:08 INFO - 'MAIL': '/var/mail/cltbld', 22:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:08 INFO - 'MOZ_NO_REMOTE': '1', 22:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:08 INFO - 'NO_EM_RESTART': '1', 22:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:08 INFO - 'PWD': '/builds/slave/test', 22:48:08 INFO - 'SHELL': '/bin/bash', 22:48:08 INFO - 'SHLVL': '1', 22:48:08 INFO - 'TERM': 'linux', 22:48:08 INFO - 'TMOUT': '86400', 22:48:08 INFO - 'USER': 'cltbld', 22:48:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:08 INFO - '_': '/tools/buildbot/bin/python'} 22:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:48:10 INFO - Installing collected packages: mozsystemmonitor 22:48:10 INFO - Running setup.py install for mozsystemmonitor 22:48:10 INFO - Successfully installed mozsystemmonitor 22:48:10 INFO - Cleaning up... 22:48:10 INFO - Return code: 0 22:48:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:48: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')]} 22:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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')]} 22:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:11 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 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:11 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 22:48:11 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 22:48:11 INFO - Using env: {'DISPLAY': ':0', 22:48:11 INFO - 'HOME': '/home/cltbld', 22:48:11 INFO - 'LANG': 'en_US.UTF-8', 22:48:11 INFO - 'LANGUAGE': 'en_US:en', 22:48:11 INFO - 'LOGNAME': 'cltbld', 22:48:11 INFO - 'MAIL': '/var/mail/cltbld', 22:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:11 INFO - 'MOZ_NO_REMOTE': '1', 22:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:11 INFO - 'NO_EM_RESTART': '1', 22:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:11 INFO - 'PWD': '/builds/slave/test', 22:48:11 INFO - 'SHELL': '/bin/bash', 22:48:11 INFO - 'SHLVL': '1', 22:48:11 INFO - 'TERM': 'linux', 22:48:11 INFO - 'TMOUT': '86400', 22:48:11 INFO - 'USER': 'cltbld', 22:48:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:11 INFO - '_': '/tools/buildbot/bin/python'} 22:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:11 INFO - Downloading/unpacking jsonschema==2.5.1 22:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:48:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:13 INFO - Downloading functools32-3.2.3-2.tar.gz 22:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:48:13 INFO - warning: no files found matching '*.txt' 22:48:13 INFO - no previously-included directories found matching 'build' 22:48:13 INFO - no previously-included directories found matching 'dist' 22:48:13 INFO - no previously-included directories found matching '.git*' 22:48:13 INFO - Installing collected packages: jsonschema, functools32 22:48:13 INFO - Running setup.py install for functools32 22:48:13 INFO - warning: no files found matching '*.txt' 22:48:13 INFO - no previously-included directories found matching 'build' 22:48:13 INFO - no previously-included directories found matching 'dist' 22:48:13 INFO - no previously-included directories found matching '.git*' 22:48:13 INFO - Successfully installed jsonschema functools32 22:48:13 INFO - Cleaning up... 22:48:13 INFO - Return code: 0 22:48:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:48:13 INFO - Using env: {'DISPLAY': ':0', 22:48:13 INFO - 'HOME': '/home/cltbld', 22:48:13 INFO - 'LANG': 'en_US.UTF-8', 22:48:13 INFO - 'LANGUAGE': 'en_US:en', 22:48:13 INFO - 'LOGNAME': 'cltbld', 22:48:13 INFO - 'MAIL': '/var/mail/cltbld', 22:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:13 INFO - 'MOZ_NO_REMOTE': '1', 22:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:13 INFO - 'NO_EM_RESTART': '1', 22:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:13 INFO - 'PWD': '/builds/slave/test', 22:48:13 INFO - 'SHELL': '/bin/bash', 22:48:13 INFO - 'SHLVL': '1', 22:48:13 INFO - 'TERM': 'linux', 22:48:13 INFO - 'TMOUT': '86400', 22:48:13 INFO - 'USER': 'cltbld', 22:48:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:13 INFO - '_': '/tools/buildbot/bin/python'} 22:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:48:13 INFO - Cleaning up... 22:48:13 INFO - Return code: 0 22:48:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:48:13 INFO - Using env: {'DISPLAY': ':0', 22:48:13 INFO - 'HOME': '/home/cltbld', 22:48:13 INFO - 'LANG': 'en_US.UTF-8', 22:48:13 INFO - 'LANGUAGE': 'en_US:en', 22:48:13 INFO - 'LOGNAME': 'cltbld', 22:48:13 INFO - 'MAIL': '/var/mail/cltbld', 22:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:13 INFO - 'MOZ_NO_REMOTE': '1', 22:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:13 INFO - 'NO_EM_RESTART': '1', 22:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:13 INFO - 'PWD': '/builds/slave/test', 22:48:13 INFO - 'SHELL': '/bin/bash', 22:48:13 INFO - 'SHLVL': '1', 22:48:13 INFO - 'TERM': 'linux', 22:48:13 INFO - 'TMOUT': '86400', 22:48:13 INFO - 'USER': 'cltbld', 22:48:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:13 INFO - '_': '/tools/buildbot/bin/python'} 22:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:48:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:48:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:16 INFO - Downloading docopt-0.6.1.tar.gz 22:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:48:16 INFO - Installing collected packages: blobuploader, requests, docopt 22:48:16 INFO - Running setup.py install for blobuploader 22:48:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:48:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:48:16 INFO - Running setup.py install for requests 22:48:17 INFO - Running setup.py install for docopt 22:48:17 INFO - Successfully installed blobuploader requests docopt 22:48:17 INFO - Cleaning up... 22:48:17 INFO - Return code: 0 22:48:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:17 INFO - Using env: {'DISPLAY': ':0', 22:48:17 INFO - 'HOME': '/home/cltbld', 22:48:17 INFO - 'LANG': 'en_US.UTF-8', 22:48:17 INFO - 'LANGUAGE': 'en_US:en', 22:48:17 INFO - 'LOGNAME': 'cltbld', 22:48:17 INFO - 'MAIL': '/var/mail/cltbld', 22:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:17 INFO - 'MOZ_NO_REMOTE': '1', 22:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:17 INFO - 'NO_EM_RESTART': '1', 22:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:17 INFO - 'PWD': '/builds/slave/test', 22:48:17 INFO - 'SHELL': '/bin/bash', 22:48:17 INFO - 'SHLVL': '1', 22:48:17 INFO - 'TERM': 'linux', 22:48:17 INFO - 'TMOUT': '86400', 22:48:17 INFO - 'USER': 'cltbld', 22:48:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:17 INFO - '_': '/tools/buildbot/bin/python'} 22:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:48:17 INFO - Running setup.py (path:/tmp/pip-B3n2D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:48:17 INFO - Running setup.py (path:/tmp/pip-388lJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:48:17 INFO - Running setup.py (path:/tmp/pip-6X9sO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:48:17 INFO - Running setup.py (path:/tmp/pip-8tadPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:48:17 INFO - Running setup.py (path:/tmp/pip-sGj65U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:48:17 INFO - Running setup.py (path:/tmp/pip-sdT_jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:48:18 INFO - Running setup.py (path:/tmp/pip-RImGtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:48:18 INFO - Running setup.py (path:/tmp/pip-6T91t7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:48:18 INFO - Running setup.py (path:/tmp/pip-YcgWoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:48:18 INFO - Running setup.py (path:/tmp/pip-ULPcCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:48:18 INFO - Running setup.py (path:/tmp/pip-DeQQSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:48:18 INFO - Running setup.py (path:/tmp/pip-hjpVAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:48:18 INFO - Running setup.py (path:/tmp/pip-e5Z7t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:48:18 INFO - Running setup.py (path:/tmp/pip-QyeRTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:18 INFO - Running setup.py (path:/tmp/pip-7AIMto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:48:18 INFO - Running setup.py (path:/tmp/pip-YNkJ9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:48:18 INFO - Running setup.py (path:/tmp/pip-xENQ7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:48:18 INFO - Running setup.py install for manifestparser 22:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:48:18 INFO - Running setup.py install for mozcrash 22:48:19 INFO - Running setup.py install for mozdebug 22:48:19 INFO - Running setup.py install for mozdevice 22:48:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Running setup.py install for mozfile 22:48:19 INFO - Running setup.py install for mozhttpd 22:48:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Running setup.py install for mozinfo 22:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Running setup.py install for mozInstall 22:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Running setup.py install for mozleak 22:48:19 INFO - Running setup.py install for mozlog 22:48:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Running setup.py install for moznetwork 22:48:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:48:19 INFO - Running setup.py install for mozprocess 22:48:20 INFO - Running setup.py install for mozprofile 22:48:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:48:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:48:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:48:20 INFO - Running setup.py install for mozrunner 22:48:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:48:20 INFO - Running setup.py install for mozscreenshot 22:48:20 INFO - Running setup.py install for moztest 22:48:20 INFO - Running setup.py install for mozversion 22:48:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:48:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:48:20 INFO - Cleaning up... 22:48:20 INFO - Return code: 0 22:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:20 INFO - Using env: {'DISPLAY': ':0', 22:48:20 INFO - 'HOME': '/home/cltbld', 22:48:20 INFO - 'LANG': 'en_US.UTF-8', 22:48:20 INFO - 'LANGUAGE': 'en_US:en', 22:48:20 INFO - 'LOGNAME': 'cltbld', 22:48:20 INFO - 'MAIL': '/var/mail/cltbld', 22:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:20 INFO - 'MOZ_NO_REMOTE': '1', 22:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:20 INFO - 'NO_EM_RESTART': '1', 22:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:20 INFO - 'PWD': '/builds/slave/test', 22:48:20 INFO - 'SHELL': '/bin/bash', 22:48:20 INFO - 'SHLVL': '1', 22:48:20 INFO - 'TERM': 'linux', 22:48:20 INFO - 'TMOUT': '86400', 22:48:20 INFO - 'USER': 'cltbld', 22:48:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:20 INFO - '_': '/tools/buildbot/bin/python'} 22:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:48:20 INFO - Running setup.py (path:/tmp/pip-UT54az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:48:20 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)) 22:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:48:20 INFO - Running setup.py (path:/tmp/pip-LgUvy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:48:21 INFO - Running setup.py (path:/tmp/pip-WbbH80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:48:21 INFO - Running setup.py (path:/tmp/pip-Oe7NCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:48:21 INFO - Running setup.py (path:/tmp/pip-JdXg1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:48:21 INFO - Running setup.py (path:/tmp/pip-F81OBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:48:21 INFO - Running setup.py (path:/tmp/pip-dc7d6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:48:21 INFO - Running setup.py (path:/tmp/pip-h8StuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:48:21 INFO - Running setup.py (path:/tmp/pip-dskgTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:48:21 INFO - Running setup.py (path:/tmp/pip-Myd19z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:48:21 INFO - Running setup.py (path:/tmp/pip-sO6TyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:48:21 INFO - Running setup.py (path:/tmp/pip-LJ1SuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:48:21 INFO - Running setup.py (path:/tmp/pip-M69a_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:48:21 INFO - Running setup.py (path:/tmp/pip-4iYOEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:48:21 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)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:21 INFO - Running setup.py (path:/tmp/pip-hnlBwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:48:21 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)) 22:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:48:21 INFO - Running setup.py (path:/tmp/pip-yoaiZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:48:22 INFO - Running setup.py (path:/tmp/pip-llf6ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:48:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:24 INFO - Downloading blessings-1.6.tar.gz 22:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:48:24 INFO - Installing collected packages: blessings 22:48:24 INFO - Running setup.py install for blessings 22:48:24 INFO - Successfully installed blessings 22:48:24 INFO - Cleaning up... 22:48:24 INFO - Return code: 0 22:48:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:24 INFO - Reading from file tmpfile_stdout 22:48:24 INFO - Current package versions: 22:48:24 INFO - argparse == 1.2.1 22:48:24 INFO - blessings == 1.6 22:48:24 INFO - blobuploader == 1.2.4 22:48:24 INFO - docopt == 0.6.1 22:48:24 INFO - functools32 == 3.2.3-2 22:48:24 INFO - jsonschema == 2.5.1 22:48:24 INFO - manifestparser == 1.1 22:48:24 INFO - mozInstall == 1.12 22:48:24 INFO - mozcrash == 0.17 22:48:24 INFO - mozdebug == 0.1 22:48:24 INFO - mozdevice == 0.48 22:48:24 INFO - mozfile == 1.2 22:48:24 INFO - mozhttpd == 0.7 22:48:24 INFO - mozinfo == 0.9 22:48:24 INFO - mozleak == 0.1 22:48:24 INFO - mozlog == 3.4 22:48:24 INFO - moznetwork == 0.27 22:48:24 INFO - mozprocess == 0.23 22:48:24 INFO - mozprofile == 0.28 22:48:24 INFO - mozrunner == 6.12 22:48:24 INFO - mozscreenshot == 0.1 22:48:24 INFO - mozsystemmonitor == 0.3 22:48:24 INFO - moztest == 0.7 22:48:24 INFO - mozversion == 1.4 22:48:24 INFO - psutil == 3.1.1 22:48:24 INFO - requests == 1.2.3 22:48:24 INFO - wsgiref == 0.1.2 22:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:24 INFO - Using env: {'DISPLAY': ':0', 22:48:24 INFO - 'HOME': '/home/cltbld', 22:48:24 INFO - 'LANG': 'en_US.UTF-8', 22:48:24 INFO - 'LANGUAGE': 'en_US:en', 22:48:24 INFO - 'LOGNAME': 'cltbld', 22:48:24 INFO - 'MAIL': '/var/mail/cltbld', 22:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:24 INFO - 'MOZ_NO_REMOTE': '1', 22:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:24 INFO - 'NO_EM_RESTART': '1', 22:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:24 INFO - 'PWD': '/builds/slave/test', 22:48:24 INFO - 'SHELL': '/bin/bash', 22:48:24 INFO - 'SHLVL': '1', 22:48:24 INFO - 'TERM': 'linux', 22:48:24 INFO - 'TMOUT': '86400', 22:48:24 INFO - 'USER': 'cltbld', 22:48:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:24 INFO - '_': '/tools/buildbot/bin/python'} 22:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 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)) 22:48:24 INFO - Cleaning up... 22:48:24 INFO - Return code: 0 22:48:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:24 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 0x7fd0181bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', '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 22:48:24 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 22:48:24 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 22:48:24 INFO - Using env: {'DISPLAY': ':0', 22:48:24 INFO - 'HOME': '/home/cltbld', 22:48:24 INFO - 'LANG': 'en_US.UTF-8', 22:48:24 INFO - 'LANGUAGE': 'en_US:en', 22:48:24 INFO - 'LOGNAME': 'cltbld', 22:48:24 INFO - 'MAIL': '/var/mail/cltbld', 22:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:24 INFO - 'MOZ_NO_REMOTE': '1', 22:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:24 INFO - 'NO_EM_RESTART': '1', 22:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:24 INFO - 'PWD': '/builds/slave/test', 22:48:24 INFO - 'SHELL': '/bin/bash', 22:48:24 INFO - 'SHLVL': '1', 22:48:24 INFO - 'TERM': 'linux', 22:48:24 INFO - 'TMOUT': '86400', 22:48:24 INFO - 'USER': 'cltbld', 22:48:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:24 INFO - '_': '/tools/buildbot/bin/python'} 22:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:48:24 INFO - Cleaning up... 22:48:24 INFO - Return code: 0 22:48:24 INFO - Running post-action listener: _resource_record_post_action 22:48:24 INFO - Running post-action listener: _start_resource_monitoring 22:48:25 INFO - Starting resource monitoring. 22:48:25 INFO - [mozharness: 2016-11-03 05:48:25.004363Z] Finished create-virtualenv step (success) 22:48:25 INFO - [mozharness: 2016-11-03 05:48:25.004828Z] Running install step. 22:48:25 INFO - Running pre-action listener: _resource_record_pre_action 22:48:25 INFO - Running main action method: install 22:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:25 INFO - Reading from file tmpfile_stdout 22:48:25 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:48:25 INFO - Reading from file tmpfile_stdout 22:48:25 INFO - Output received: 22:48:25 INFO - Usage: mozinstall [options] installer 22:48:25 INFO - Options: 22:48:25 INFO - -h, --help show this help message and exit 22:48:25 INFO - -d DEST, --destination=DEST 22:48:25 INFO - Directory to install application into. [default: 22:48:25 INFO - "/builds/slave/test"] 22:48:25 INFO - --app=APP Application being installed. [default: firefox] 22:48:25 INFO - mkdir: /builds/slave/test/build/application 22:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:48:41 INFO - Reading from file tmpfile_stdout 22:48:41 INFO - Output received: 22:48:41 INFO - /builds/slave/test/build/application/firefox/firefox 22:48:41 INFO - Running post-action listener: _resource_record_post_action 22:48:41 INFO - [mozharness: 2016-11-03 05:48:41.406166Z] Finished install step (success) 22:48:41 INFO - [mozharness: 2016-11-03 05:48:41.406412Z] Running run-tests step. 22:48:41 INFO - Running pre-action listener: _resource_record_pre_action 22:48:41 INFO - Running main action method: run_tests 22:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:48:41 INFO - Python 2.7.3 22:48:41 INFO - Return code: 0 22:48:41 INFO - grabbing minidump binary from tooltool 22:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc930>, '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 0x16bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bdcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:48:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:48:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:48:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:48:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:41 INFO - Return code: 0 22:48:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:48:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:48:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:48:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:48:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:48:41 INFO - Using env: {'DISPLAY': ':0', 22:48:41 INFO - 'HOME': '/home/cltbld', 22:48:41 INFO - 'LANG': 'en_US.UTF-8', 22:48:41 INFO - 'LANGUAGE': 'en_US:en', 22:48:41 INFO - 'LOGNAME': 'cltbld', 22:48:41 INFO - 'MAIL': '/var/mail/cltbld', 22:48:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:48:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:41 INFO - 'MOZ_NO_REMOTE': '1', 22:48:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:41 INFO - 'NO_EM_RESTART': '1', 22:48:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:41 INFO - 'PWD': '/builds/slave/test', 22:48:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:48:41 INFO - 'SHELL': '/bin/bash', 22:48:41 INFO - 'SHLVL': '1', 22:48:41 INFO - 'TERM': 'linux', 22:48:41 INFO - 'TMOUT': '86400', 22:48:41 INFO - 'USER': 'cltbld', 22:48:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908', 22:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:41 INFO - '_': '/tools/buildbot/bin/python'} 22:48:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:48:41 INFO - mozversion application_buildid: 20161102143123 22:48:41 INFO - mozversion application_changeset: ee7c1fd6966586f0ffab187d164b3e282f771cab 22:48:41 INFO - mozversion application_display_name: Nightly 22:48:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:41 INFO - mozversion application_name: Firefox 22:48:41 INFO - mozversion application_remotingname: firefox 22:48:41 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 22:48:41 INFO - mozversion application_vendor: Mozilla 22:48:41 INFO - mozversion application_version: 52.0a1 22:48:41 INFO - mozversion platform_buildid: 20161102143123 22:48:41 INFO - mozversion platform_changeset: ee7c1fd6966586f0ffab187d164b3e282f771cab 22:48:41 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 22:48:41 INFO - mozversion platform_version: 52.0a1 22:48:41 INFO - using testdate: 1478152121 22:48:41 INFO - actual date: 1478152121 22:48:41 INFO - starting webserver on 'localhost:54449' 22:48:41 INFO - SUITE-START | Running 2 tests 22:48:41 INFO - TEST-START | dromaeo_css 22:48:41 INFO - operating with platform_type : linux_ 22:48:41 INFO - Initialising browser for dromaeo_css test... 22:48:41 INFO - TEST-INFO | started process 24660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptRVGtT/profile http://localhost:54449/getInfo.html) 22:48:46 INFO - PROCESS | 24660 | __metrics Screen width/height:1600/1200 22:48:46 INFO - PROCESS | 24660 | colorDepth:24 22:48:46 INFO - PROCESS | 24660 | Browser inner width/height: 1024/697 22:48:46 INFO - PROCESS | 24660 | __metrics 22:48:47 ERROR - PROCESS | 24660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 22:48:48 INFO - TEST-INFO | 24660: exit 0 22:48:48 INFO - Browser initialized. 22:48:48 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:48 INFO - TEST-INFO | started process 24780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptRVGtT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:00 INFO - PROCESS | 24780 | RSS: Main: 186634240 22:49:00 INFO - PROCESS | 24780 | 22:49:50 INFO - PROCESS | 24780 | 1478152190421 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] 22:52:05 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54449/tests/dromaeo/cssquery-ext.html) 22:52:06 INFO - PROCESS | 24780 | RSS: Main: 196612096 22:52:06 INFO - PROCESS | 24780 | 22:55:08 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-ext.html (next: http://localhost:54449/tests/dromaeo/cssquery-jquery.html) 22:55:09 INFO - PROCESS | 24780 | RSS: Main: 196440064 22:55:09 INFO - PROCESS | 24780 | 22:58:11 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54449/tests/dromaeo/cssquery-mootools.html) 22:58:12 INFO - PROCESS | 24780 | RSS: Main: 198365184 22:58:12 INFO - PROCESS | 24780 | 23:01:14 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54449/tests/dromaeo/cssquery-prototype.html) 23:01:14 INFO - PROCESS | 24780 | RSS: Main: 195362816 23:01:14 INFO - PROCESS | 24780 | 23:04:17 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54449/tests/dromaeo/cssquery-yui.html) 23:04:18 INFO - PROCESS | 24780 | RSS: Main: 198373376 23:04:18 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-yui.html (next: http://localhost:54449/tests/dromaeo/cssquery-dojo.html) 23:07:21 INFO - PROCESS | 24780 | RSS: Main: 198795264 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | __start_tp_report 23:07:21 INFO - PROCESS | 24780 | _x_x_mozilla_page_load 23:07:21 INFO - PROCESS | 24780 | _x_x_mozilla_page_load_details 23:07:21 INFO - PROCESS | 24780 | |i|pagename|runs| 23:07:21 INFO - PROCESS | 24780 | |0;dojo.html;2658.415148667293;2662.960055599165;2666.0935282004116;2682.1953413975816;2700.4329090890924;4766.094442056007;4792.616590672742;4816.807327706892;4846.0307938412325;4848.563629273364;4807.351007613971;4811.374521312233;4830.9275360869615;4871.488493708154;4872.70763754175;4430.202563538562;4449.510553839075;4484.618807401374;4535.387722657432;4594.885127871797;4402.273624851911;4453.309736990772;4495.910081798362;4504.369388285642;4529.5470452954605;4321.200577893069;4334.913301733947;4399.230134726442;4423.292273236299;4464.397306363632;4357.150355680644;4372.322290045016;4393.582609652078;4446;4456.754878481682;4292.978535107336;4348.869533913988;4376.474823021226;4382.517923028464;4418.29307310832;4589.1968905441745;4661.510541393172;4678.906421871544;4698.859034228979;4718.339432479455;5091.770870310845;5143.537081662668;5145.202493613496;5190.32525771651;5203.03743807393;5154.226865970097;5159.380874295071;5164.406093299281;5172.896542069175;5227.26818245446;4707;4758.690685105457;4805.3512775775525;4807.855764327076;4845.394325709286;5222.060029194706;5222.477752224747;5227.764750586157;5287.4448182941005;5340.439253878365;5006.224035274538;5022.949770502249;5033.307180658403;5034.748262586856;5088.185890257541;4974.303597496353;5093.821716239914;5127.179651255781;5134.691918484903;5149.304843846107;5025.070361983045;5074.23886417033;5088.72012039334;5109.897802043938;5132.307138536325;5002.349694539759;5019.498050195024;5044.4198917125;5056.014077254974;5105.15764898795;4064.5732198119363;4126.979365103155;4138.937915931264;4158.313878210122;4195.811188496525;3610.151614370621;3698.2418604186078;3703.185299234164;3750.3436898542645;3767.3972164453558;4488.169688607618;4507.661925355612;4508.301213311942;4522.8643140705835;4556.3621093047;5133.383993920754;5133.640645154878;5173.094708426011;5189.584833213334;5202.401723801736;4410.713303635253;4448;4448.266036104072;4494.393256910341;4520.299353600197;4557.612602928788;4580.221362368406;4589.472210695746;4628.3983082199775;4638.350630911675;4887.047025829929;4896;4896.853094407174;4898.681585696918;4952.133376658998;5018.422881368543;5046.3439752833365;5157.871053223699;5185.766640501111;5225.973870130777;4957.380327459067;4960.429550601582;4965.031818795444;4974.801007959786;4988.600911927109;5137.152369858932;5158.819441319536;5175.715335656575;5178.093833579184;5178.766955487087;5025.723585202849;5085.46602606721;5159.329287192641;5180.093483640272;5248.501392367719;5061.620378471555;5074.720890351066;5078.898422031612;5128.692278463304;5140.948590514047;5046.116929537243;5057.949420505748;5065.721385323843;5066.06277838601;5124.871878203075;4792.185328494234;4869.31829543857;4894.853154405374;4931.9753401232765;4948.727819969936;5057.721825299496;5059.443461219336;5064.037832811754;5065.949340506695;5117.257997590403;4883.145449546244;4929.285253638131;4941.036497882878;4942.75286235694;4943.604511639132 23:07:21 INFO - PROCESS | 24780 | |1;ext.html;539.0270561636247;545.4845171313108;551.2475470982109;562.4712769996203;573.9311282646083;38002;39710;39766;43036.78481607595;43049;40039.19921601566;40495;40513.797431012805;40530.18939621206;40531.594684053154;7633.694652213905;7777.18339574345;7783.961080194591;7785.1436342002335;7785.260400261966;7689.769306920802;7703.576303303316;7751.302382785549;7773.261540153676;7778.183290754474;7753.185915478878;7781;7799.766007019798;7803.29770320671;7812.101608315032;7629.313361797437;7739.071311442606;7743.264389882952;7751.379889608817;7752.961235193788;7570.16728159902;7627.80930476737;7640.465167438281;7644.885326720048;7646.464747467679;37496.62503374959;37792.62207377919;37796.81101594502;37829.432558511646;37929.62070379288;3013.5329024001317;3183.4428974929297;3201.135693362779;3206.599175103112;3245.7890237134748;27433.177004689893;28053.547684032786;28275;28533.429331413463;30905.845470772503;3264.8530816113093;3402.387570237356;3444.7588668793196;3466.9826650866835;3590.9640903591153;246790;248463;248923;249032.75483622646;249600;53542;54056;54063.45936540663;54079.72960135174;54087;55314.17028744572;55601;55644.721776390856;55885;56296.718516407156;14604.853951460349;14821.925890370694;14822.777658335133;14860.03409778361;14895.851041489663;11386.601468948547;11464.4840982156;11493.942530287295;11497.712557186138;11577.247478913843;16368.508944731677;17290.135493225287;17369.56576085583;17371.65256694859;17373.65252694939;6738.888083466173;6882.5870447773295;7020.859582808417;7139.214686384494;7172.46206534512;797.9162187970179;841.6170642357713;883.1874675298741;935.8481559017565;1001.5092604623682;26403.47193056128;26981.325466863487;27946.72053279441;28006;28054.298642533693;922.3812209572158;929.6606738540519;997.7006897930592;1001.5843424978552;1001.9298649094493;13646.727065458635;14372.209528476034;14589.781153282709;14791.852081479263;14819.407223711147;380489;383230;383656;384828;386607;48217;48274.27588586174;48557.75721121372;48693.5130648689;48761;1187.2223693480785;1192.3918801411169;1193.1945936493007;1193.2005556277315;1229.735606844515;25687.743122568536;26442.206733798015;26796.774628947947;27210.45579088447;27375.17874463769;39913.40129897996;40188.59811401849;40292.59707402888;40321.395179072926;40342.57944523338;314864;316176;316476;316797;319658;24589.508209835345;24667.753322466546;25024.49951001006;25092.62361064622;25098.498030038932;39903;40312.39531406973;40747.38878916878;40893.59106408898;41193.58806411897;35136.47295290521;35521.64478355287;35535.11162220965;35780;36443.63556364403;32800.671993279764;33069;33075.83462082674;33132;34091;29700.40599187961;30444;33538.329233414705;34388.14029649279;34900.825495872356;29605.407891841613;31849.522257166624;32232;32247.516287256178;32408.67591324151;24755.25734227976;24796.876015619808;25229.495410092062;25282.115125970504;25515.10697125592 23:07:21 INFO - PROCESS | 24780 | |2;jquery.html;360.48450715476855;367.5167155190924;378.198219774079;378.5476355754872;396.2135161704019;15695.45065922693;16887.746683799753;17427.56431089222;17527.386541471053;17566.473005809847;16155.43455979041;16964.236609352578;17188.484345469624;17213.483595492125;17381.82618173821;4840.104580652573;5108.259302401149;5130.56390206831;5132.589392848582;5141.511556402154;4720.315554244632;5030.748462576875;5043.243513472972;5054.974725126388;5062.291279220912;4991.900161996758;5034.647574669756;5061.164907790228;5083.974580127094;5148;5086.160783470741;5314.309139811839;5888.087346461284;5966.343702192756;5974.163617093611;5300.390455097675;5302.390225124122;5306.442823503515;5307.150855863082;5324.334458192726;11977.341246231454;12123.515059397701;12165.087618428654;12171.044410566601;12208.816867746991;1805.4583624912605;1882.1436246507806;1889.8204670556274;1906.9713954290696;2071.1197740960033;8885.289176865836;8941.50821704806;8990.865137022884;9126.361154719172;9445.386049906734;1696.4062578097692;1748.9737653935074;1867.6638205123072;1871.9625607487774;1883.2184643372984;68994;69023.65488172577;69938;70266.64866675634;71087;10046.19630429564;10101.343412678152;10126.594936202617;10200.132988695896;10245.7438564035;13163.407646655924;13193.20840749539;13222.537211197561;13290.3354832258;13316.600501984956;7145.249748776304;7167.569945803164;7212.963935180291;7516.173220945691;7558.773236802905;6969.128858892638;7045.295470453017;7135.108111486064;7217.206107328295;7227.16887557927;4036.515618125785;4264.296391095435;4374.409454723572;4436.401085853433;4503.7522936238165;1674.355373181334;1758.6570618729224;1816.4278252350732;1826.2329821475012;1852.9258829646933;800.1998001998002;813.507827764206;835.8328334333157;879.1384443245655;879.7272845417941;16081.517554473385;16893.577660558338;16917.323307067578;17319.4804155873;17469.301227950993;835.7283882738135;868.8740132680726;869.5956380283199;884.425123669607;888.5823662878566;9114.40756350835;9460.290478214161;9592.83671185176;9710.271729620306;9744;358156;362703;382321;389246;391314;73752;74454;74765.62617186879;74886;76411.92027156032;883.8541640629353;907.5371560504191;922.262190247799;962.7737481691797;968.8885778135464;15918.96526725759;15933.840661593236;16081.517554473385;16527.83472165263;16560.254788534785;36223.81888090648;36722.26555468929;37463.81268093642;37569.81215093907;38438.23123537458;45975.31037034514;46957.2956405661;47287;53255.73372133115;54711.17933231084;6076.453119219292;6591.176102987127;6817.454603631797;7194.964025179841;7520.511166774361;9313;10298.3820970742;10938.945305273422;10953.616623418142;11615.419229038684;9098.863517047383;9452.196563292197;9543.856842147512;9977.45124018186;10196.745081373025;4884.462709102067;9216.723498295061;9441.433513989183;9553.570089345858;9886.378347158543;9708.951455242679;9823.803523929339;10027.298089133983;10039.949800250952;10280;6084.3915608440575;7182.712691492282;7352.558846469229;7369.152547457111;7370.410367170721;7871.370290376871;9238.168564829197;9349.39228950116;9483.973494048165;9563.09150630689 23:07:21 INFO - PROCESS | 24780 | |3;mootools.html;1379.579228335358;1405.248192217164;1505.668752874368;1677.8154403015658;1682.2598056854983;6110.755569777203;6325.2409710834645;6735.292794256606;7057.364837164654;7084.043654106694;6505.902411463831;6797.354251346126;6804.183497980237;6950.7914762557075;6952.582845029302;2084.9895750521264;2117.8093971542557;2118.4280244334022;2119.21589012065;2138.6364318065966;2058.2281644383356;2128.0423809285808;2139.0267428320153;2142.0574947023338;2156.5147841735643;2087.1025459052603;2095.9266425675105;2106.536561956367;2109.6519074352714;2125.2455378340696;2041.8876961767096;2068.2967790951147;2069.2343832781817;2074.0563043815105;2084.8853313067775;2033.9084741186682;2070.4202823209525;2077.0237988145545;2080.240712140073;2090.1430413530534;6699.966500167517;6800.625965571891;6827.146606674166;6876.140482439695;6906;4154.958450415517;4251.298535741599;4260.510041345254;4262.296721041024;4266.893327666802;2653.517988213107;2692.367293685982;2767.9446411071867;2870.6842247352774;2898.7536059434974;883.5935469683953;915.8946721127089;940.9858852117223;947.0434860790582;954.7040417470606;9018.549072546411;9081.59132839024;9098.545072746336;9119.361644684876;9141.040190779939;3700.703943684499;3816.904577385588;3918.0988372673874;3934.1344904121047;3941.3299739044432;7863.410244231705;7871.724489642835;7910;7915.327197188303;7949.7217597383815;4280.208161490072;4301.978490107529;4311.202427550913;4313.8490152845125;4340.544242854518;3412.7269818414466;3551.2897420516;3713.201661642706;3915.158240978203;3927.5876033016693;3313.370459612666;3328.6671332866517;3436.914077148091;3459.1697992482127;3461.376952148587;1124.1119515582598;1130.3218069158438;1132.5073592987078;1133.6372360844616;1143.5540139345662;848.1772680499905;855.5893171277821;858.1761508951352;862.7325529086004;883.7569668341257;4785.449673287547;4796.136695394793;4888.364512613338;4927.975360123177;4959.752012399365;387.75571390024106;400.40739705236416;401.56430273153956;401.6284936433787;401.9577944315863;3384.340053689556;3408.7784294020807;3414.8463319150696;3444.328355970612;3465.428204346305;7828.491148075357;8254.8349033019;8257.710980115668;8265.95867020661;8333.125021872738;8283.25450709427;8302.003759548892;8305.37709671777;8307.584620768937;8312.83374332522;6113.908291375633;6298.653574053379;6478.805635830932;6541.6075035498025;6616.636085015371;5009.474005229544;5026.924596130988;5099.133147365031;5165.819196328261;5192.662476938987;7518.962405187939;7578.924210758042;7590.658420371207;7670.309672129535;7705.267999540035;7710.190430004769;7789.221077892165;7818.491798033109;7877.803054923444;7878.448508604342;5974.074018527135;6016.09758536223;6046.697665116639;6106.175666285172;6109.84725381869;6536.281009089092;6598.736050557924;6609.173853268341;6616.040674102324;6625.469962403093;5797.826065218051;5945.137954996588;5954.612950158225;6026.578139530191;6128.877422451436;5871.500922421642;5930.881382372415;5934.2878854536;5958.880822383615;5971.552133589911;5627.324721033502;5714.457126572969;5741.942580574308;5745.626534275259;5746.798862039976;4101.097758493127;4120.443740095168;4137.8965525862095;4192.329227323614;4237.152569486177;4173.6661067115165;4214.409982602499;4239.59723826236;4246.171996460661;4249.065205654751 23:07:21 INFO - PROCESS | 24780 | |4;prototype.html;282.31256889474133;294.5772816009027;295.37970262448846;297.73799056829984;304.3441383817873;4783.545563171493;4925.630577706677;4998.675086119404;5054.469280725526;5057.822976195829;4792.472827988927;4900.975495122529;4944.728039957801;4946.431160416544;4955.306257123996;3882.941755873664;3923.7449565778275;3924.3909996901275;3929.2730844793805;3930.528336599612;3650.1969566695284;3908.0103720653724;3912.865269071966;3919.58844321345;3935;3776.565694945089;3828.105087981453;3828.923421531568;3836.9040773980596;3841.385378339466;3816.484774555427;3816.5992570780086;3817.351050321438;3821.2739579479808;3844.6539811417106;3292.2592416706048;3342.7464700737223;3343.6489168637186;3403;3421.26442814796;4811.542903424169;4823.348847905523;4837.7339246341435;4854.441739200002;4878.731669758162;4427.778611069466;4441.511433742286;4465.933011004838;4471.195184866723;4479.3281007848755;4920.852374428773;5165.328507294028;5232.633715639907;5233.345831771028;5265.236540701615;3732.346839303111;3753.1180172659674;3758.1919887224103;3758.3798673218885;3772.5284339457567;5437.429069947638;5492.423295553949;5495.2856128703415;5516.310461192391;5521.089020311684;3768.5854555998817;3846.3076646203954;3854.383298672199;3867.9226415471535;3880.417937309426;3898.629630185128;3905.87130014143;3905.941410878839;3916.8433262669173;3927;4414.146058655372;4426.203283408953;4427.180971520279;4436.82252709888;4458.840701417655;5168.664036837594;5215.8614967862995;5217.321748172713;5233.037610895914;5281.653178439474;1323.7286356296936;1353.7766268565576;1359.3543067043076;1360.7414591227634;1371.6296599917966;840.8654615261529;861.6251930410292;874.33113668044;878.4246318661287;880.9735707928772;4084;4102.323116685713;4102.722988741218;4112.3420252759415;4122.855700050483;4630.976845115821;4655.2784318430695;4667.206574882278;4667.8599642010795;4685.680588108908;4049.9797501012895;4053.5338436079637;4068.2270368629866;4086.5504794473177;4147.274227010322;2339.5788758023377;2488.9751102488744;2490.7956458534327;2495;2495.75042495749;4406.537313582092;4409.3606427068535;4437.42313499243;4447.355133505624;4473.396091527602;4678.760128565933;4766.475687674353;4779.904401912012;4822.3591188653045;4843.951560484421;4300.634446072057;4445.822167113344;4486.775661216926;4521.7286962783;4527.479339875957;4740.5733483986605;4761.381020467317;4761.4762376137905;4764.475907650087;4804.471508134172;4681.836135735233;4694.098889949576;4696.671233013656;4707.741074240949;4716.103940251342;4211.873643790691;4497.415336006298;4517.480489743722;4520.773961301988;4530.365748795237;3428.2800611871785;3466.3240668069484;3485.634008429078;3584.6415358463946;3704.7962362070343;5362.490563396471;5391.676499410048;5394.541463975606;5409.242706021081;5428.56571474289;5169.172932330809;5194.298769666198;5198.922016169836;5210.1764382465835;5211.60912931524;5051.267566202953;5193.792248310026;5203.074862300973;5212.843614691566;5233.325335892478;5101.479978814606;5122.694787345635;5124.718140502308;5125.2568377585785;5139.948600513947;5206.349206349207;5229.869253268699;5245.872137490458;5248.76380562868;5269.1832765921345;4899.681520701143;5068.2904393384215;5092.490750924878;5095.286659867696;5108.974455127701 23:07:21 INFO - PROCESS | 24780 | |5;yui.html;650.4698670583474;666.9733210671571;712.5048091576357;743.6802175064723;751.2787723785162;12454.501819927204;12667.23996560207;12834.229946203212;12948.352582370891;13193.274369909652;12185.207961482498;12198.573049943254;12305.261684298948;12328.260304381722;12335.321557314366;766.3294617209941;784.090455072115;801.5150833745587;802.5305196460049;804.0150815251329;786.9960650196741;801.7995501124719;802.4864086984305;803.0243254445847;804.2239239134234;840.3781201910573;843.3506200225822;846.7840700621364;847.1909326593088;849.2314455417826;837.5644664774313;838.9370797190174;841.4236248169962;845.3617518773286;848.0332421040019;606.7118118893534;607.6809674920657;610.1092405088576;612.3631423319742;613.524518498163;12613.621591352274;13119.86880131196;13152.145110567879;13173.34133293341;13304.534341298106;12330.260184388966;12473.501059957682;12511.061670374667;12646;12659.936700316532;9891.703248902544;9895.172331091524;9970.40177589347;9984.101430871257;10149.89850101497;3180.3003339265324;3192.9361412771846;3203.599550056243;3267.493538501536;3287.852046657906;52556.47443525554;52970;53077.73461132708;54300.72849635727;54688;9693.757656058513;9796.26528010402;9933;10014.0980486906;10091.798164036678;18185.272589096552;18193.181306841223;18207.544811379823;18215.63568728618;18218.36235731743;6418.1656384669695;6504.837379065561;6523.380278873499;6581.177352830896;6677.365650263315;3602.3335682898746;3657.524521812147;3658.5061016762397;3699.3341198584512;3779.4708740776314;2725.986370068137;2799.90200342987;2809.606655068292;2810.4800611886867;2814.32456210508;474.5254745254745;486.96591238612956;487.93412889259497;495.35109007199964;498.2725221177122;603.8611119442465;621.9378062193745;632.5824955529329;640.1581919775481;654.9246836613851;8171.142030086874;8179.263866252066;8225.629846656915;8323.916760832435;8457.40798144124;529.8410476856927;623.1462895832739;629.8866204083217;634.4543692424511;650.1710319342876;3773.3208022555655;3840.711946604016;3931.6658084063174;3959.703022273341;3966.127451960564;40147.197056059296;40273;69574.3042569578;71803.28196718071;71860.28139718536;39197.21605567873;41648.37527437091;60938.390616094155;63167;63928;33548.66451335455;33922.15194620105;33927.830360848035;46960.765196174485;51782.22326665178;7984.520928744294;8310.085890551914;8322.24362921324;8504.829903402022;8530.14698530142;36680.449793253654;36752;36877.26245475129;36949.44575831311;37921.81039094787;38622;49370.50629493803;49967.50032499628;51283;52191.73904130455;10489.370637761758;10854.34873907568;10969.122470202205;11006.394648294101;11140.498677559368;12302.630921072383;12532.561360352343;12546.749065018466;13221;13330.800037999632;11073;11242.381669008282;11321.886781132083;11838.526458941546;12239.510419583117;11310.095192384424;11513.366764828015;11595.768084638092;11624.5350185995;12110.273383597012;11408.54365825391;11594;11680.591179308683;11730.589429369931;11731.35477548743;9256.861147082935;9654.806903861743;9830.311878168459;9861.753456163653;9874.555644996137;9778.511074446391;9990.350627209207;10105;10165.644202453175;10336.844947325646 23:07:21 INFO - PROCESS | 24780 | __end_tp_report 23:07:21 INFO - PROCESS | 24780 | __start_cc_report 23:07:21 INFO - PROCESS | 24780 | _x_x_mozilla_cycle_collect,349 23:07:21 INFO - PROCESS | 24780 | __end_cc_report 23:07:21 INFO - PROCESS | 24780 | __startTimestamp1478153241405__endTimestamp 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | ------- Summary: start ------- 23:07:21 INFO - PROCESS | 24780 | Number of tests: 6 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | [#0] dojo.html Cycles:165 Average:4749.20 Median:4898.68 stddev:513.46 (10.5%) stddev-sans-first:488.13 23:07:21 INFO - PROCESS | 24780 | Values: 2658.4 2663.0 2666.1 2682.2 2700.4 4766.1 4792.6 4816.8 4846.0 4848.6 4807.4 4811.4 4830.9 4871.5 4872.7 4430.2 4449.5 4484.6 4535.4 4594.9 4402.3 4453.3 4495.9 4504.4 4529.5 4321.2 4334.9 4399.2 4423.3 4464.4 4357.2 4372.3 4393.6 4446.0 4456.8 4293.0 4348.9 4376.5 4382.5 4418.3 4589.2 4661.5 4678.9 4698.9 4718.3 5091.8 5143.5 5145.2 5190.3 5203.0 5154.2 5159.4 5164.4 5172.9 5227.3 4707.0 4758.7 4805.4 4807.9 4845.4 5222.1 5222.5 5227.8 5287.4 5340.4 5006.2 5022.9 5033.3 5034.7 5088.2 4974.3 5093.8 5127.2 5134.7 5149.3 5025.1 5074.2 5088.7 5109.9 5132.3 5002.3 5019.5 5044.4 5056.0 5105.2 4064.6 4127.0 4138.9 4158.3 4195.8 3610.2 3698.2 3703.2 3750.3 3767.4 4488.2 4507.7 4508.3 4522.9 4556.4 5133.4 5133.6 5173.1 5189.6 5202.4 4410.7 4448.0 4448.3 4494.4 4520.3 4557.6 4580.2 4589.5 4628.4 4638.4 4887.0 4896.0 4896.9 4898.7 4952.1 5018.4 5046.3 5157.9 5185.8 5226.0 4957.4 4960.4 4965.0 4974.8 4988.6 5137.2 5158.8 5175.7 5178.1 5178.8 5025.7 5085.5 5159.3 5180.1 5248.5 5061.6 5074.7 5078.9 5128.7 5140.9 5046.1 5057.9 5065.7 5066.1 5124.9 4792.2 4869.3 4894.9 4932.0 4948.7 5057.7 5059.4 5064.0 5065.9 5117.3 4883.1 4929.3 4941.0 4942.8 4943.6 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | [#1] ext.html Cycles:180 Average:46855.44 Median:19685.48 stddev:84556.85 (429.5%) stddev-sans-first:84722.55 23:07:21 INFO - PROCESS | 24780 | Values: 539.0 545.5 551.2 562.5 573.9 38002.0 39710.0 39766.0 43036.8 43049.0 40039.2 40495.0 40513.8 40530.2 40531.6 7633.7 7777.2 7784.0 7785.1 7785.3 7689.8 7703.6 7751.3 7773.3 7778.2 7753.2 7781.0 7799.8 7803.3 7812.1 7629.3 7739.1 7743.3 7751.4 7753.0 7570.2 7627.8 7640.5 7644.9 7646.5 37496.6 37792.6 37796.8 37829.4 37929.6 3013.5 3183.4 3201.1 3206.6 3245.8 27433.2 28053.5 28275.0 28533.4 30905.8 3264.9 3402.4 3444.8 3467.0 3591.0 246790.0 248463.0 248923.0 249032.8 249600.0 53542.0 54056.0 54063.5 54079.7 54087.0 55314.2 55601.0 55644.7 55885.0 56296.7 14604.9 14821.9 14822.8 14860.0 14895.9 11386.6 11464.5 11493.9 11497.7 11577.2 16368.5 17290.1 17369.6 17371.7 17373.7 6738.9 6882.6 7020.9 7139.2 7172.5 797.9 841.6 883.2 935.8 1001.5 26403.5 26981.3 27946.7 28006.0 28054.3 922.4 929.7 997.7 1001.6 1001.9 13646.7 14372.2 14589.8 14791.9 14819.4 380489.0 383230.0 383656.0 384828.0 386607.0 48217.0 48274.3 48557.8 48693.5 48761.0 1187.2 1192.4 1193.2 1193.2 1229.7 25687.7 26442.2 26796.8 27210.5 27375.2 39913.4 40188.6 40292.6 40321.4 40342.6 314864.0 316176.0 316476.0 316797.0 319658.0 24589.5 24667.8 25024.5 25092.6 25098.5 39903.0 40312.4 40747.4 40893.6 41193.6 35136.5 35521.6 35535.1 35780.0 36443.6 32800.7 33069.0 33075.8 33132.0 34091.0 29700.4 30444.0 33538.3 34388.1 34900.8 29605.4 31849.5 32232.0 32247.5 32408.7 24755.3 24796.9 25229.5 25282.1 25515.1 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | [#2] jquery.html Cycles:180 Average:23468.41 Median:5073.13 stddev:62359.54 (1229.2%) stddev-sans-first:62510.34 23:07:21 INFO - PROCESS | 24780 | Values: 360.5 367.5 378.2 378.5 396.2 15695.5 16887.7 17427.6 17527.4 17566.5 16155.4 16964.2 17188.5 17213.5 17381.8 4840.1 5108.3 5130.6 5132.6 5141.5 4720.3 5030.7 5043.2 5055.0 5062.3 4991.9 5034.6 5061.2 5084.0 5148.0 5086.2 5314.3 5888.1 5966.3 5974.2 5300.4 5302.4 5306.4 5307.2 5324.3 11977.3 12123.5 12165.1 12171.0 12208.8 1805.5 1882.1 1889.8 1907.0 2071.1 8885.3 8941.5 8990.9 9126.4 9445.4 1696.4 1749.0 1867.7 1872.0 1883.2 68994.0 69023.7 69938.0 70266.6 71087.0 10046.2 10101.3 10126.6 10200.1 10245.7 13163.4 13193.2 13222.5 13290.3 13316.6 7145.2 7167.6 7213.0 7516.2 7558.8 6969.1 7045.3 7135.1 7217.2 7227.2 4036.5 4264.3 4374.4 4436.4 4503.8 1674.4 1758.7 1816.4 1826.2 1852.9 800.2 813.5 835.8 879.1 879.7 16081.5 16893.6 16917.3 17319.5 17469.3 835.7 868.9 869.6 884.4 888.6 9114.4 9460.3 9592.8 9710.3 9744.0 358156.0 362703.0 382321.0 389246.0 391314.0 73752.0 74454.0 74765.6 74886.0 76411.9 883.9 907.5 922.3 962.8 968.9 15919.0 15933.8 16081.5 16527.8 16560.3 36223.8 36722.3 37463.8 37569.8 38438.2 45975.3 46957.3 47287.0 53255.7 54711.2 6076.5 6591.2 6817.5 7195.0 7520.5 9313.0 10298.4 10938.9 10953.6 11615.4 9098.9 9452.2 9543.9 9977.5 10196.7 4884.5 9216.7 9441.4 9553.6 9886.4 9709.0 9823.8 10027.3 10039.9 10280.0 6084.4 7182.7 7352.6 7369.2 7370.4 7871.4 9238.2 9349.4 9484.0 9563.1 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | [#3] mootools.html Cycles:180 Average:4591.06 Median:5018.20 stddev:2433.55 (48.5%) stddev-sans-first:2428.41 23:07:21 INFO - PROCESS | 24780 | Values: 1379.6 1405.2 1505.7 1677.8 1682.3 6110.8 6325.2 6735.3 7057.4 7084.0 6505.9 6797.4 6804.2 6950.8 6952.6 2085.0 2117.8 2118.4 2119.2 2138.6 2058.2 2128.0 2139.0 2142.1 2156.5 2087.1 2095.9 2106.5 2109.7 2125.2 2041.9 2068.3 2069.2 2074.1 2084.9 2033.9 2070.4 2077.0 2080.2 2090.1 6700.0 6800.6 6827.1 6876.1 6906.0 4155.0 4251.3 4260.5 4262.3 4266.9 2653.5 2692.4 2767.9 2870.7 2898.8 883.6 915.9 941.0 947.0 954.7 9018.5 9081.6 9098.5 9119.4 9141.0 3700.7 3816.9 3918.1 3934.1 3941.3 7863.4 7871.7 7910.0 7915.3 7949.7 4280.2 4302.0 4311.2 4313.8 4340.5 3412.7 3551.3 3713.2 3915.2 3927.6 3313.4 3328.7 3436.9 3459.2 3461.4 1124.1 1130.3 1132.5 1133.6 1143.6 848.2 855.6 858.2 862.7 883.8 4785.4 4796.1 4888.4 4928.0 4959.8 387.8 400.4 401.6 401.6 402.0 3384.3 3408.8 3414.8 3444.3 3465.4 7828.5 8254.8 8257.7 8266.0 8333.1 8283.3 8302.0 8305.4 8307.6 8312.8 6113.9 6298.7 6478.8 6541.6 6616.6 5009.5 5026.9 5099.1 5165.8 5192.7 7519.0 7578.9 7590.7 7670.3 7705.3 7710.2 7789.2 7818.5 7877.8 7878.4 5974.1 6016.1 6046.7 6106.2 6109.8 6536.3 6598.7 6609.2 6616.0 6625.5 5797.8 5945.1 5954.6 6026.6 6128.9 5871.5 5930.9 5934.3 5958.9 5971.6 5627.3 5714.5 5741.9 5745.6 5746.8 4101.1 4120.4 4137.9 4192.3 4237.2 4173.7 4214.4 4239.6 4246.2 4249.1 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | [#4] prototype.html Cycles:180 Average:4164.45 Median:4519.13 stddev:1207.58 (26.7%) stddev-sans-first:1175.29 23:07:21 INFO - PROCESS | 24780 | Values: 282.3 294.6 295.4 297.7 304.3 4783.5 4925.6 4998.7 5054.5 5057.8 4792.5 4901.0 4944.7 4946.4 4955.3 3882.9 3923.7 3924.4 3929.3 3930.5 3650.2 3908.0 3912.9 3919.6 3935.0 3776.6 3828.1 3828.9 3836.9 3841.4 3816.5 3816.6 3817.4 3821.3 3844.7 3292.3 3342.7 3343.6 3403.0 3421.3 4811.5 4823.3 4837.7 4854.4 4878.7 4427.8 4441.5 4465.9 4471.2 4479.3 4920.9 5165.3 5232.6 5233.3 5265.2 3732.3 3753.1 3758.2 3758.4 3772.5 5437.4 5492.4 5495.3 5516.3 5521.1 3768.6 3846.3 3854.4 3867.9 3880.4 3898.6 3905.9 3905.9 3916.8 3927.0 4414.1 4426.2 4427.2 4436.8 4458.8 5168.7 5215.9 5217.3 5233.0 5281.7 1323.7 1353.8 1359.4 1360.7 1371.6 840.9 861.6 874.3 878.4 881.0 4084.0 4102.3 4102.7 4112.3 4122.9 4631.0 4655.3 4667.2 4667.9 4685.7 4050.0 4053.5 4068.2 4086.6 4147.3 2339.6 2489.0 2490.8 2495.0 2495.8 4406.5 4409.4 4437.4 4447.4 4473.4 4678.8 4766.5 4779.9 4822.4 4844.0 4300.6 4445.8 4486.8 4521.7 4527.5 4740.6 4761.4 4761.5 4764.5 4804.5 4681.8 4694.1 4696.7 4707.7 4716.1 4211.9 4497.4 4517.5 4520.8 4530.4 3428.3 3466.3 3485.6 3584.6 3704.8 5362.5 5391.7 5394.5 5409.2 5428.6 5169.2 5194.3 5198.9 5210.2 5211.6 5051.3 5193.8 5203.1 5212.8 5233.3 5101.5 5122.7 5124.7 5125.3 5139.9 5206.3 5229.9 5245.9 5248.8 5269.2 4899.7 5068.3 5092.5 5095.3 5109.0 23:07:21 INFO - PROCESS | 24780 | 23:07:21 INFO - PROCESS | 24780 | [#5] yui.html Cycles:180 Average:13929.64 Median:480.75 stddev:16918.64 (3519.2%) stddev-sans-first:16936.71 23:07:21 INFO - PROCESS | 24780 | Values: 650.5 667.0 712.5 743.7 751.3 12454.5 12667.2 12834.2 12948.4 13193.3 12185.2 12198.6 12305.3 12328.3 12335.3 766.3 784.1 801.5 802.5 804.0 787.0 801.8 802.5 803.0 804.2 840.4 843.4 846.8 847.2 849.2 837.6 838.9 841.4 845.4 848.0 606.7 607.7 610.1 612.4 613.5 12613.6 13119.9 13152.1 13173.3 13304.5 12330.3 12473.5 12511.1 12646.0 12659.9 9891.7 9895.2 9970.4 9984.1 10149.9 3180.3 3192.9 3203.6 3267.5 3287.9 52556.5 52970.0 53077.7 54300.7 54688.0 9693.8 9796.3 9933.0 10014.1 10091.8 18185.3 18193.2 18207.5 18215.6 18218.4 6418.2 6504.8 6523.4 6581.2 6677.4 3602.3 3657.5 3658.5 3699.3 3779.5 2726.0 2799.9 2809.6 2810.5 2814.3 474.5 487.0 487.9 495.4 498.3 603.9 621.9 632.6 640.2 654.9 8171.1 8179.3 8225.6 8323.9 8457.4 529.8 623.1 629.9 634.5 650.2 3773.3 3840.7 3931.7 3959.7 3966.1 40147.2 40273.0 69574.3 71803.3 71860.3 39197.2 41648.4 60938.4 63167.0 63928.0 33548.7 33922.2 33927.8 46960.8 51782.2 7984.5 8310.1 8322.2 8504.8 8530.1 36680.4 36752.0 36877.3 36949.4 37921.8 38622.0 49370.5 49967.5 51283.0 52191.7 10489.4 10854.3 10969.1 11006.4 11140.5 12302.6 12532.6 12546.7 13221.0 13330.8 11073.0 11242.4 11321.9 11838.5 12239.5 11310.1 11513.4 11595.8 11624.5 12110.3 11408.5 11594.0 11680.6 11730.6 11731.4 9256.9 9654.8 9830.3 9861.8 9874.6 9778.5 9990.4 10105.0 10165.6 10336.8 23:07:21 INFO - PROCESS | 24780 | -------- Summary: end -------- 23:07:21 INFO - PROCESS | 24780 | 23:07:22 INFO - TEST-INFO | 24780: exit 0 23:07:22 INFO - TEST-OK | dromaeo_css | took 1120770ms 23:07:22 INFO - TEST-START | kraken 23:07:22 INFO - operating with platform_type : linux_ 23:07:22 INFO - Initialising browser for kraken test... 23:07:22 INFO - TEST-INFO | started process 25139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKQlGfQ/profile http://localhost:54449/getInfo.html) 23:07:27 INFO - PROCESS | 25139 | __metrics Screen width/height:1600/1200 23:07:27 INFO - PROCESS | 25139 | colorDepth:24 23:07:27 INFO - PROCESS | 25139 | Browser inner width/height: 1024/697 23:07:27 INFO - PROCESS | 25139 | __metrics 23:07:27 ERROR - PROCESS | 25139 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 23:07:28 INFO - TEST-INFO | 25139: exit 0 23:07:28 INFO - Browser initialized. 23:07:28 INFO - Running cycle 1/1 for kraken test... 23:07:28 INFO - TEST-INFO | started process 25261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKQlGfQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:41 INFO - PROCESS | 25261 | RSS: Main: 187334656 23:07:41 INFO - PROCESS | 25261 | 23:07:44 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:45 INFO - PROCESS | 25261 | RSS: Main: 199647232 23:07:45 INFO - PROCESS | 25261 | 23:07:47 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-dft) 23:07:48 INFO - PROCESS | 25261 | RSS: Main: 197709824 23:07:48 INFO - PROCESS | 25261 | 23:07:51 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-fft) 23:07:52 INFO - PROCESS | 25261 | RSS: Main: 194445312 23:07:52 INFO - PROCESS | 25261 | 23:07:54 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-oscillator) 23:07:54 INFO - PROCESS | 25261 | RSS: Main: 194596864 23:07:54 INFO - PROCESS | 25261 | 23:07:57 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:57 INFO - PROCESS | 25261 | RSS: Main: 195239936 23:07:57 INFO - PROCESS | 25261 | 23:08:01 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54449/tests/kraken/driver.html?testName=imaging-darkroom) 23:08:01 INFO - PROCESS | 25261 | RSS: Main: 195239936 23:08:01 INFO - PROCESS | 25261 | 23:08:05 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54449/tests/kraken/driver.html?testName=imaging-desaturate) 23:08:05 INFO - PROCESS | 25261 | RSS: Main: 193466368 23:08:05 INFO - PROCESS | 25261 | 23:08:08 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54449/tests/kraken/driver.html?testName=json-parse-financial) 23:08:09 INFO - PROCESS | 25261 | RSS: Main: 194383872 23:08:09 INFO - PROCESS | 25261 | 23:08:11 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:08:11 INFO - PROCESS | 25261 | RSS: Main: 194990080 23:08:11 INFO - PROCESS | 25261 | 23:08:13 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:08:14 INFO - PROCESS | 25261 | RSS: Main: 195145728 23:08:14 INFO - PROCESS | 25261 | 23:08:16 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:08:17 INFO - PROCESS | 25261 | RSS: Main: 195448832 23:08:17 INFO - PROCESS | 25261 | 23:08:19 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:08:20 INFO - PROCESS | 25261 | RSS: Main: 195653632 23:08:20 INFO - PROCESS | 25261 | 23:08:23 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:08:24 INFO - PROCESS | 25261 | RSS: Main: 195928064 23:08:24 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54449/tests/kraken/driver.html?testName=ai-astar) 23:08:26 INFO - PROCESS | 25261 | RSS: Main: 197767168 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | __start_tp_report 23:08:26 INFO - PROCESS | 25261 | _x_x_mozilla_page_load 23:08:26 INFO - PROCESS | 25261 | _x_x_mozilla_page_load_details 23:08:26 INFO - PROCESS | 25261 | |i|pagename|runs| 23:08:26 INFO - PROCESS | 25261 | |0;ai-astar;113;118;116;118;116;118;116;116;116;117 23:08:26 INFO - PROCESS | 25261 | |1;audio-beat-detection;158;132;130;185;133;138;131;134;165;131 23:08:26 INFO - PROCESS | 25261 | |2;audio-dft;166;170;164;164;164;161;165;164;164;165 23:08:26 INFO - PROCESS | 25261 | |3;audio-fft;79;76;78;116;78;78;78;78;110;77 23:08:26 INFO - PROCESS | 25261 | |4;audio-oscillator;84;85;111;85;86;83;114;84;83;119 23:08:26 INFO - PROCESS | 25261 | |5;imaging-gaussian-blur;119;120;119;118;120;117;119;117;119;117 23:08:26 INFO - PROCESS | 25261 | |6;imaging-darkroom;149;150;147;149;147;148;148;148;150;148 23:08:26 INFO - PROCESS | 25261 | |7;imaging-desaturate;85;86;85;85;85;85;86;85;85;85 23:08:26 INFO - PROCESS | 25261 | |8;json-parse-financial;62;63;63;64;64;65;66;64;64;64 23:08:26 INFO - PROCESS | 25261 | |9;json-stringify-tinderbox;66;67;66;66;68;67;66;66;69;67 23:08:26 INFO - PROCESS | 25261 | |10;stanford-crypto-aes;85;85;94;86;85;85;88;90;86;87 23:08:26 INFO - PROCESS | 25261 | |11;stanford-crypto-ccm;155;143;152;144;146;151;146;146;191;149 23:08:26 INFO - PROCESS | 25261 | |12;stanford-crypto-pbkdf2;180;184;182;175;175;182;177;183;184;185 23:08:26 INFO - PROCESS | 25261 | |13;stanford-crypto-sha256-iterative;70;70;70;70;71;74;68;69;71;70 23:08:26 INFO - PROCESS | 25261 | __end_tp_report 23:08:26 INFO - PROCESS | 25261 | __start_cc_report 23:08:26 INFO - PROCESS | 25261 | _x_x_mozilla_cycle_collect,848 23:08:26 INFO - PROCESS | 25261 | __end_cc_report 23:08:26 INFO - PROCESS | 25261 | __startTimestamp1478153306472__endTimestamp 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | ------- Summary: start ------- 23:08:26 INFO - PROCESS | 25261 | Number of tests: 14 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.50 stddev:1.51 (1.3%) stddev-sans-first:0.97 23:08:26 INFO - PROCESS | 25261 | Values: 113.0 118.0 116.0 118.0 116.0 118.0 116.0 116.0 116.0 117.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:136.00 stddev:19.01 (14.0%) stddev-sans-first:19.45 23:08:26 INFO - PROCESS | 25261 | Values: 158.0 132.0 130.0 185.0 133.0 138.0 131.0 134.0 165.0 131.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.26 (1.4%) stddev-sans-first:2.35 23:08:26 INFO - PROCESS | 25261 | Values: 166.0 170.0 164.0 164.0 164.0 161.0 165.0 164.0 164.0 165.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#3] audio-fft Cycles:10 Average:84.80 Median:78.00 stddev:14.95 (19.2%) stddev-sans-first:15.71 23:08:26 INFO - PROCESS | 25261 | Values: 79.0 76.0 78.0 116.0 78.0 78.0 78.0 78.0 110.0 77.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.00 stddev:14.83 (17.7%) stddev-sans-first:15.33 23:08:26 INFO - PROCESS | 25261 | Values: 84.0 85.0 111.0 85.0 86.0 83.0 114.0 84.0 83.0 119.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 23:08:26 INFO - PROCESS | 25261 | Values: 119.0 120.0 119.0 118.0 120.0 117.0 119.0 117.0 119.0 117.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 23:08:26 INFO - PROCESS | 25261 | Values: 149.0 150.0 147.0 149.0 147.0 148.0 148.0 148.0 150.0 148.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 23:08:26 INFO - PROCESS | 25261 | Values: 85.0 86.0 85.0 85.0 85.0 85.0 86.0 85.0 85.0 85.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.10 (1.7%) stddev-sans-first:0.93 23:08:26 INFO - PROCESS | 25261 | Values: 62.0 63.0 63.0 64.0 64.0 65.0 66.0 64.0 64.0 64.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 23:08:26 INFO - PROCESS | 25261 | Values: 66.0 67.0 66.0 66.0 68.0 67.0 66.0 66.0 69.0 67.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.92 (3.4%) stddev-sans-first:3.00 23:08:26 INFO - PROCESS | 25261 | Values: 85.0 85.0 94.0 86.0 85.0 85.0 88.0 90.0 86.0 87.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:150.00 stddev:14.11 (9.4%) stddev-sans-first:14.93 23:08:26 INFO - PROCESS | 25261 | Values: 155.0 143.0 152.0 144.0 146.0 151.0 146.0 146.0 191.0 149.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:182.50 stddev:3.77 (2.1%) stddev-sans-first:3.99 23:08:26 INFO - PROCESS | 25261 | Values: 180.0 184.0 182.0 175.0 175.0 182.0 177.0 183.0 184.0 185.0 23:08:26 INFO - PROCESS | 25261 | 23:08:26 INFO - PROCESS | 25261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.57 (2.2%) stddev-sans-first:1.66 23:08:26 INFO - PROCESS | 25261 | Values: 70.0 70.0 70.0 70.0 71.0 74.0 68.0 69.0 71.0 70.0 23:08:26 INFO - PROCESS | 25261 | -------- Summary: end -------- 23:08:26 INFO - PROCESS | 25261 | 23:08:27 INFO - TEST-INFO | 25261: exit 0 23:08:27 INFO - TEST-OK | kraken | took 65312ms 23:08:27 INFO - SUITE-END | took 1186s 23:08:28 INFO - Completed test suite (00:19:46) 23:08:28 INFO - javascript benchmark 23:08:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6186.252503985076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2658.415148667293, 2662.960055599165, 2666.0935282004116, 2682.1953413975816, 2700.4329090890924, 4766.094442056007, 4792.616590672742, 4816.807327706892, 4846.0307938412325, 4848.563629273364, 4807.351007613971, 4811.374521312233, 4830.9275360869615, 4871.488493708154, 4872.70763754175, 4430.202563538562, 4449.510553839075, 4484.618807401374, 4535.387722657432, 4594.885127871797, 4402.273624851911, 4453.309736990772, 4495.910081798362, 4504.369388285642, 4529.5470452954605, 4321.200577893069, 4334.913301733947, 4399.230134726442, 4423.292273236299, 4464.397306363632, 4357.150355680644, 4372.322290045016, 4393.582609652078, 4446.0, 4456.754878481682, 4292.978535107336, 4348.869533913988, 4376.474823021226, 4382.517923028464, 4418.29307310832, 4589.1968905441745, 4661.510541393172, 4678.906421871544, 4698.859034228979, 4718.339432479455, 5091.770870310845, 5143.537081662668, 5145.202493613496, 5190.32525771651, 5203.03743807393, 5154.226865970097, 5159.380874295071, 5164.406093299281, 5172.896542069175, 5227.26818245446, 4707.0, 4758.690685105457, 4805.3512775775525, 4807.855764327076, 4845.394325709286, 5222.060029194706, 5222.477752224747, 5227.764750586157, 5287.4448182941005, 5340.439253878365, 5006.224035274538, 5022.949770502249, 5033.307180658403, 5034.748262586856, 5088.185890257541, 4974.303597496353, 5093.821716239914, 5127.179651255781, 5134.691918484903, 5149.304843846107, 5025.070361983045, 5074.23886417033, 5088.72012039334, 5109.897802043938, 5132.307138536325, 5002.349694539759, 5019.498050195024, 5044.4198917125, 5056.014077254974, 5105.15764898795, 4064.5732198119363, 4126.979365103155, 4138.937915931264, 4158.313878210122, 4195.811188496525, 3610.151614370621, 3698.2418604186078, 3703.185299234164, 3750.3436898542645, 3767.3972164453558, 4488.169688607618, 4507.661925355612, 4508.301213311942, 4522.8643140705835, 4556.3621093047, 5133.383993920754, 5133.640645154878, 5173.094708426011, 5189.584833213334, 5202.401723801736, 4410.713303635253, 4448.0, 4448.266036104072, 4494.393256910341, 4520.299353600197, 4557.612602928788, 4580.221362368406, 4589.472210695746, 4628.3983082199775, 4638.350630911675, 4887.047025829929, 4896.0, 4896.853094407174, 4898.681585696918, 4952.133376658998, 5018.422881368543, 5046.3439752833365, 5157.871053223699, 5185.766640501111, 5225.973870130777, 4957.380327459067, 4960.429550601582, 4965.031818795444, 4974.801007959786, 4988.600911927109, 5137.152369858932, 5158.819441319536, 5175.715335656575, 5178.093833579184, 5178.766955487087, 5025.723585202849, 5085.46602606721, 5159.329287192641, 5180.093483640272, 5248.501392367719, 5061.620378471555, 5074.720890351066, 5078.898422031612, 5128.692278463304, 5140.948590514047, 5046.116929537243, 5057.949420505748, 5065.721385323843, 5066.06277838601, 5124.871878203075, 4792.185328494234, 4869.31829543857, 4894.853154405374, 4931.9753401232765, 4948.727819969936, 5057.721825299496, 5059.443461219336, 5064.037832811754, 5065.949340506695, 5117.257997590403, 4883.145449546244, 4929.285253638131, 4941.036497882878, 4942.75286235694, 4943.604511639132], "value": 4715.3990308766315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.0270561636247, 545.4845171313108, 551.2475470982109, 562.4712769996203, 573.9311282646083, 38002.0, 39710.0, 39766.0, 43036.78481607595, 43049.0, 40039.19921601566, 40495.0, 40513.797431012805, 40530.18939621206, 40531.594684053154, 7633.694652213905, 7777.18339574345, 7783.961080194591, 7785.1436342002335, 7785.260400261966, 7689.769306920802, 7703.576303303316, 7751.302382785549, 7773.261540153676, 7778.183290754474, 7753.185915478878, 7781.0, 7799.766007019798, 7803.29770320671, 7812.101608315032, 7629.313361797437, 7739.071311442606, 7743.264389882952, 7751.379889608817, 7752.961235193788, 7570.16728159902, 7627.80930476737, 7640.465167438281, 7644.885326720048, 7646.464747467679, 37496.62503374959, 37792.62207377919, 37796.81101594502, 37829.432558511646, 37929.62070379288, 3013.5329024001317, 3183.4428974929297, 3201.135693362779, 3206.599175103112, 3245.7890237134748, 27433.177004689893, 28053.547684032786, 28275.0, 28533.429331413463, 30905.845470772503, 3264.8530816113093, 3402.387570237356, 3444.7588668793196, 3466.9826650866835, 3590.9640903591153, 246790.0, 248463.0, 248923.0, 249032.75483622646, 249600.0, 53542.0, 54056.0, 54063.45936540663, 54079.72960135174, 54087.0, 55314.17028744572, 55601.0, 55644.721776390856, 55885.0, 56296.718516407156, 14604.853951460349, 14821.925890370694, 14822.777658335133, 14860.03409778361, 14895.851041489663, 11386.601468948547, 11464.4840982156, 11493.942530287295, 11497.712557186138, 11577.247478913843, 16368.508944731677, 17290.135493225287, 17369.56576085583, 17371.65256694859, 17373.65252694939, 6738.888083466173, 6882.5870447773295, 7020.859582808417, 7139.214686384494, 7172.46206534512, 797.9162187970179, 841.6170642357713, 883.1874675298741, 935.8481559017565, 1001.5092604623682, 26403.47193056128, 26981.325466863487, 27946.72053279441, 28006.0, 28054.298642533693, 922.3812209572158, 929.6606738540519, 997.7006897930592, 1001.5843424978552, 1001.9298649094493, 13646.727065458635, 14372.209528476034, 14589.781153282709, 14791.852081479263, 14819.407223711147, 380489.0, 383230.0, 383656.0, 384828.0, 386607.0, 48217.0, 48274.27588586174, 48557.75721121372, 48693.5130648689, 48761.0, 1187.2223693480785, 1192.3918801411169, 1193.1945936493007, 1193.2005556277315, 1229.735606844515, 25687.743122568536, 26442.206733798015, 26796.774628947947, 27210.45579088447, 27375.17874463769, 39913.40129897996, 40188.59811401849, 40292.59707402888, 40321.395179072926, 40342.57944523338, 314864.0, 316176.0, 316476.0, 316797.0, 319658.0, 24589.508209835345, 24667.753322466546, 25024.49951001006, 25092.62361064622, 25098.498030038932, 39903.0, 40312.39531406973, 40747.38878916878, 40893.59106408898, 41193.58806411897, 35136.47295290521, 35521.64478355287, 35535.11162220965, 35780.0, 36443.63556364403, 32800.671993279764, 33069.0, 33075.83462082674, 33132.0, 34091.0, 29700.40599187961, 30444.0, 33538.329233414705, 34388.14029649279, 34900.825495872356, 29605.407891841613, 31849.522257166624, 32232.0, 32247.516287256178, 32408.67591324151, 24755.25734227976, 24796.876015619808, 25229.495410092062, 25282.115125970504, 25515.10697125592], "value": 17295.012538755964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.48450715476855, 367.5167155190924, 378.198219774079, 378.5476355754872, 396.2135161704019, 15695.45065922693, 16887.746683799753, 17427.56431089222, 17527.386541471053, 17566.473005809847, 16155.43455979041, 16964.236609352578, 17188.484345469624, 17213.483595492125, 17381.82618173821, 4840.104580652573, 5108.259302401149, 5130.56390206831, 5132.589392848582, 5141.511556402154, 4720.315554244632, 5030.748462576875, 5043.243513472972, 5054.974725126388, 5062.291279220912, 4991.900161996758, 5034.647574669756, 5061.164907790228, 5083.974580127094, 5148.0, 5086.160783470741, 5314.309139811839, 5888.087346461284, 5966.343702192756, 5974.163617093611, 5300.390455097675, 5302.390225124122, 5306.442823503515, 5307.150855863082, 5324.334458192726, 11977.341246231454, 12123.515059397701, 12165.087618428654, 12171.044410566601, 12208.816867746991, 1805.4583624912605, 1882.1436246507806, 1889.8204670556274, 1906.9713954290696, 2071.1197740960033, 8885.289176865836, 8941.50821704806, 8990.865137022884, 9126.361154719172, 9445.386049906734, 1696.4062578097692, 1748.9737653935074, 1867.6638205123072, 1871.9625607487774, 1883.2184643372984, 68994.0, 69023.65488172577, 69938.0, 70266.64866675634, 71087.0, 10046.19630429564, 10101.343412678152, 10126.594936202617, 10200.132988695896, 10245.7438564035, 13163.407646655924, 13193.20840749539, 13222.537211197561, 13290.3354832258, 13316.600501984956, 7145.249748776304, 7167.569945803164, 7212.963935180291, 7516.173220945691, 7558.773236802905, 6969.128858892638, 7045.295470453017, 7135.108111486064, 7217.206107328295, 7227.16887557927, 4036.515618125785, 4264.296391095435, 4374.409454723572, 4436.401085853433, 4503.7522936238165, 1674.355373181334, 1758.6570618729224, 1816.4278252350732, 1826.2329821475012, 1852.9258829646933, 800.1998001998002, 813.507827764206, 835.8328334333157, 879.1384443245655, 879.7272845417941, 16081.517554473385, 16893.577660558338, 16917.323307067578, 17319.4804155873, 17469.301227950993, 835.7283882738135, 868.8740132680726, 869.5956380283199, 884.425123669607, 888.5823662878566, 9114.40756350835, 9460.290478214161, 9592.83671185176, 9710.271729620306, 9744.0, 358156.0, 362703.0, 382321.0, 389246.0, 391314.0, 73752.0, 74454.0, 74765.62617186879, 74886.0, 76411.92027156032, 883.8541640629353, 907.5371560504191, 922.262190247799, 962.7737481691797, 968.8885778135464, 15918.96526725759, 15933.840661593236, 16081.517554473385, 16527.83472165263, 16560.254788534785, 36223.81888090648, 36722.26555468929, 37463.81268093642, 37569.81215093907, 38438.23123537458, 45975.31037034514, 46957.2956405661, 47287.0, 53255.73372133115, 54711.17933231084, 6076.453119219292, 6591.176102987127, 6817.454603631797, 7194.964025179841, 7520.511166774361, 9313.0, 10298.3820970742, 10938.945305273422, 10953.616623418142, 11615.419229038684, 9098.863517047383, 9452.196563292197, 9543.856842147512, 9977.45124018186, 10196.745081373025, 4884.462709102067, 9216.723498295061, 9441.433513989183, 9553.570089345858, 9886.378347158543, 9708.951455242679, 9823.803523929339, 10027.298089133983, 10039.949800250952, 10280.0, 6084.3915608440575, 7182.712691492282, 7352.558846469229, 7369.152547457111, 7370.410367170721, 7871.370290376871, 9238.168564829197, 9349.39228950116, 9483.973494048165, 9563.09150630689], "value": 7911.032939284729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.579228335358, 1405.248192217164, 1505.668752874368, 1677.8154403015658, 1682.2598056854983, 6110.755569777203, 6325.2409710834645, 6735.292794256606, 7057.364837164654, 7084.043654106694, 6505.902411463831, 6797.354251346126, 6804.183497980237, 6950.7914762557075, 6952.582845029302, 2084.9895750521264, 2117.8093971542557, 2118.4280244334022, 2119.21589012065, 2138.6364318065966, 2058.2281644383356, 2128.0423809285808, 2139.0267428320153, 2142.0574947023338, 2156.5147841735643, 2087.1025459052603, 2095.9266425675105, 2106.536561956367, 2109.6519074352714, 2125.2455378340696, 2041.8876961767096, 2068.2967790951147, 2069.2343832781817, 2074.0563043815105, 2084.8853313067775, 2033.9084741186682, 2070.4202823209525, 2077.0237988145545, 2080.240712140073, 2090.1430413530534, 6699.966500167517, 6800.625965571891, 6827.146606674166, 6876.140482439695, 6906.0, 4154.958450415517, 4251.298535741599, 4260.510041345254, 4262.296721041024, 4266.893327666802, 2653.517988213107, 2692.367293685982, 2767.9446411071867, 2870.6842247352774, 2898.7536059434974, 883.5935469683953, 915.8946721127089, 940.9858852117223, 947.0434860790582, 954.7040417470606, 9018.549072546411, 9081.59132839024, 9098.545072746336, 9119.361644684876, 9141.040190779939, 3700.703943684499, 3816.904577385588, 3918.0988372673874, 3934.1344904121047, 3941.3299739044432, 7863.410244231705, 7871.724489642835, 7910.0, 7915.327197188303, 7949.7217597383815, 4280.208161490072, 4301.978490107529, 4311.202427550913, 4313.8490152845125, 4340.544242854518, 3412.7269818414466, 3551.2897420516, 3713.201661642706, 3915.158240978203, 3927.5876033016693, 3313.370459612666, 3328.6671332866517, 3436.914077148091, 3459.1697992482127, 3461.376952148587, 1124.1119515582598, 1130.3218069158438, 1132.5073592987078, 1133.6372360844616, 1143.5540139345662, 848.1772680499905, 855.5893171277821, 858.1761508951352, 862.7325529086004, 883.7569668341257, 4785.449673287547, 4796.136695394793, 4888.364512613338, 4927.975360123177, 4959.752012399365, 387.75571390024106, 400.40739705236416, 401.56430273153956, 401.6284936433787, 401.9577944315863, 3384.340053689556, 3408.7784294020807, 3414.8463319150696, 3444.328355970612, 3465.428204346305, 7828.491148075357, 8254.8349033019, 8257.710980115668, 8265.95867020661, 8333.125021872738, 8283.25450709427, 8302.003759548892, 8305.37709671777, 8307.584620768937, 8312.83374332522, 6113.908291375633, 6298.653574053379, 6478.805635830932, 6541.6075035498025, 6616.636085015371, 5009.474005229544, 5026.924596130988, 5099.133147365031, 5165.819196328261, 5192.662476938987, 7518.962405187939, 7578.924210758042, 7590.658420371207, 7670.309672129535, 7705.267999540035, 7710.190430004769, 7789.221077892165, 7818.491798033109, 7877.803054923444, 7878.448508604342, 5974.074018527135, 6016.09758536223, 6046.697665116639, 6106.175666285172, 6109.84725381869, 6536.281009089092, 6598.736050557924, 6609.173853268341, 6616.040674102324, 6625.469962403093, 5797.826065218051, 5945.137954996588, 5954.612950158225, 6026.578139530191, 6128.877422451436, 5871.500922421642, 5930.881382372415, 5934.2878854536, 5958.880822383615, 5971.552133589911, 5627.324721033502, 5714.457126572969, 5741.942580574308, 5745.626534275259, 5746.798862039976, 4101.097758493127, 4120.443740095168, 4137.8965525862095, 4192.329227323614, 4237.152569486177, 4173.6661067115165, 4214.409982602499, 4239.59723826236, 4246.171996460661, 4249.065205654751], "value": 3731.102129597634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.31256889474133, 294.5772816009027, 295.37970262448846, 297.73799056829984, 304.3441383817873, 4783.545563171493, 4925.630577706677, 4998.675086119404, 5054.469280725526, 5057.822976195829, 4792.472827988927, 4900.975495122529, 4944.728039957801, 4946.431160416544, 4955.306257123996, 3882.941755873664, 3923.7449565778275, 3924.3909996901275, 3929.2730844793805, 3930.528336599612, 3650.1969566695284, 3908.0103720653724, 3912.865269071966, 3919.58844321345, 3935.0, 3776.565694945089, 3828.105087981453, 3828.923421531568, 3836.9040773980596, 3841.385378339466, 3816.484774555427, 3816.5992570780086, 3817.351050321438, 3821.2739579479808, 3844.6539811417106, 3292.2592416706048, 3342.7464700737223, 3343.6489168637186, 3403.0, 3421.26442814796, 4811.542903424169, 4823.348847905523, 4837.7339246341435, 4854.441739200002, 4878.731669758162, 4427.778611069466, 4441.511433742286, 4465.933011004838, 4471.195184866723, 4479.3281007848755, 4920.852374428773, 5165.328507294028, 5232.633715639907, 5233.345831771028, 5265.236540701615, 3732.346839303111, 3753.1180172659674, 3758.1919887224103, 3758.3798673218885, 3772.5284339457567, 5437.429069947638, 5492.423295553949, 5495.2856128703415, 5516.310461192391, 5521.089020311684, 3768.5854555998817, 3846.3076646203954, 3854.383298672199, 3867.9226415471535, 3880.417937309426, 3898.629630185128, 3905.87130014143, 3905.941410878839, 3916.8433262669173, 3927.0, 4414.146058655372, 4426.203283408953, 4427.180971520279, 4436.82252709888, 4458.840701417655, 5168.664036837594, 5215.8614967862995, 5217.321748172713, 5233.037610895914, 5281.653178439474, 1323.7286356296936, 1353.7766268565576, 1359.3543067043076, 1360.7414591227634, 1371.6296599917966, 840.8654615261529, 861.6251930410292, 874.33113668044, 878.4246318661287, 880.9735707928772, 4084.0, 4102.323116685713, 4102.722988741218, 4112.3420252759415, 4122.855700050483, 4630.976845115821, 4655.2784318430695, 4667.206574882278, 4667.8599642010795, 4685.680588108908, 4049.9797501012895, 4053.5338436079637, 4068.2270368629866, 4086.5504794473177, 4147.274227010322, 2339.5788758023377, 2488.9751102488744, 2490.7956458534327, 2495.0, 2495.75042495749, 4406.537313582092, 4409.3606427068535, 4437.42313499243, 4447.355133505624, 4473.396091527602, 4678.760128565933, 4766.475687674353, 4779.904401912012, 4822.3591188653045, 4843.951560484421, 4300.634446072057, 4445.822167113344, 4486.775661216926, 4521.7286962783, 4527.479339875957, 4740.5733483986605, 4761.381020467317, 4761.4762376137905, 4764.475907650087, 4804.471508134172, 4681.836135735233, 4694.098889949576, 4696.671233013656, 4707.741074240949, 4716.103940251342, 4211.873643790691, 4497.415336006298, 4517.480489743722, 4520.773961301988, 4530.365748795237, 3428.2800611871785, 3466.3240668069484, 3485.634008429078, 3584.6415358463946, 3704.7962362070343, 5362.490563396471, 5391.676499410048, 5394.541463975606, 5409.242706021081, 5428.56571474289, 5169.172932330809, 5194.298769666198, 5198.922016169836, 5210.1764382465835, 5211.60912931524, 5051.267566202953, 5193.792248310026, 5203.074862300973, 5212.843614691566, 5233.325335892478, 5101.479978814606, 5122.694787345635, 5124.718140502308, 5125.2568377585785, 5139.948600513947, 5206.349206349207, 5229.869253268699, 5245.872137490458, 5248.76380562868, 5269.1832765921345, 4899.681520701143, 5068.2904393384215, 5092.490750924878, 5095.286659867696, 5108.974455127701], "value": 3783.179890098621, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.4698670583474, 666.9733210671571, 712.5048091576357, 743.6802175064723, 751.2787723785162, 12454.501819927204, 12667.23996560207, 12834.229946203212, 12948.352582370891, 13193.274369909652, 12185.207961482498, 12198.573049943254, 12305.261684298948, 12328.260304381722, 12335.321557314366, 766.3294617209941, 784.090455072115, 801.5150833745587, 802.5305196460049, 804.0150815251329, 786.9960650196741, 801.7995501124719, 802.4864086984305, 803.0243254445847, 804.2239239134234, 840.3781201910573, 843.3506200225822, 846.7840700621364, 847.1909326593088, 849.2314455417826, 837.5644664774313, 838.9370797190174, 841.4236248169962, 845.3617518773286, 848.0332421040019, 606.7118118893534, 607.6809674920657, 610.1092405088576, 612.3631423319742, 613.524518498163, 12613.621591352274, 13119.86880131196, 13152.145110567879, 13173.34133293341, 13304.534341298106, 12330.260184388966, 12473.501059957682, 12511.061670374667, 12646.0, 12659.936700316532, 9891.703248902544, 9895.172331091524, 9970.40177589347, 9984.101430871257, 10149.89850101497, 3180.3003339265324, 3192.9361412771846, 3203.599550056243, 3267.493538501536, 3287.852046657906, 52556.47443525554, 52970.0, 53077.73461132708, 54300.72849635727, 54688.0, 9693.757656058513, 9796.26528010402, 9933.0, 10014.0980486906, 10091.798164036678, 18185.272589096552, 18193.181306841223, 18207.544811379823, 18215.63568728618, 18218.36235731743, 6418.1656384669695, 6504.837379065561, 6523.380278873499, 6581.177352830896, 6677.365650263315, 3602.3335682898746, 3657.524521812147, 3658.5061016762397, 3699.3341198584512, 3779.4708740776314, 2725.986370068137, 2799.90200342987, 2809.606655068292, 2810.4800611886867, 2814.32456210508, 474.5254745254745, 486.96591238612956, 487.93412889259497, 495.35109007199964, 498.2725221177122, 603.8611119442465, 621.9378062193745, 632.5824955529329, 640.1581919775481, 654.9246836613851, 8171.142030086874, 8179.263866252066, 8225.629846656915, 8323.916760832435, 8457.40798144124, 529.8410476856927, 623.1462895832739, 629.8866204083217, 634.4543692424511, 650.1710319342876, 3773.3208022555655, 3840.711946604016, 3931.6658084063174, 3959.703022273341, 3966.127451960564, 40147.197056059296, 40273.0, 69574.3042569578, 71803.28196718071, 71860.28139718536, 39197.21605567873, 41648.37527437091, 60938.390616094155, 63167.0, 63928.0, 33548.66451335455, 33922.15194620105, 33927.830360848035, 46960.765196174485, 51782.22326665178, 7984.520928744294, 8310.085890551914, 8322.24362921324, 8504.829903402022, 8530.14698530142, 36680.449793253654, 36752.0, 36877.26245475129, 36949.44575831311, 37921.81039094787, 38622.0, 49370.50629493803, 49967.50032499628, 51283.0, 52191.73904130455, 10489.370637761758, 10854.34873907568, 10969.122470202205, 11006.394648294101, 11140.498677559368, 12302.630921072383, 12532.561360352343, 12546.749065018466, 13221.0, 13330.800037999632, 11073.0, 11242.381669008282, 11321.886781132083, 11838.526458941546, 12239.510419583117, 11310.095192384424, 11513.366764828015, 11595.768084638092, 11624.5350185995, 12110.273383597012, 11408.54365825391, 11594.0, 11680.591179308683, 11730.589429369931, 11731.35477548743, 9256.861147082935, 9654.806903861743, 9830.311878168459, 9861.753456163653, 9874.555644996137, 9778.511074446391, 9990.350627209207, 10105.0, 10165.644202453175, 10336.844947325646], "value": 6153.845104836016, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 116.0, 118.0, 116.0, 118.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 130.0, 185.0, 133.0, 138.0, 131.0, 134.0, 165.0, 131.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 164.0, 164.0, 164.0, 161.0, 165.0, 164.0, 164.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 78.0, 116.0, 78.0, 78.0, 78.0, 78.0, 110.0, 77.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 111.0, 85.0, 86.0, 83.0, 114.0, 84.0, 83.0, 119.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 119.0, 118.0, 120.0, 117.0, 119.0, 117.0, 119.0, 117.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0, 150.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 66.0, 66.0, 69.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 94.0, 86.0, 85.0, 85.0, 88.0, 90.0, 86.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 143.0, 152.0, 144.0, 146.0, 151.0, 146.0, 146.0, 191.0, 149.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 182.0, 175.0, 175.0, 182.0, 177.0, 183.0, 184.0, 185.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 71.0, 74.0, 68.0, 69.0, 71.0, 70.0], "value": 70.3, "unit": "score"}]}]} 23:08:28 INFO - Return code: 0 23:08:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:08:28 ERROR - # TBPL SUCCESS # 23:08:28 INFO - Running post-action listener: _resource_record_post_action 23:08:28 INFO - [mozharness: 2016-11-03 06:08:28.257013Z] Finished run-tests step (success) 23:08:28 INFO - Running post-run listener: _resource_record_post_run 23:08:28 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 16384; Write bytes: 391856128; Read time: 176; Write time: 244844 23:08:28 INFO - TinderboxPrint: CPU usage
13.5% 23:08:28 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 176 23:08:28 INFO - TinderboxPrint: I/O write bytes / time
391,856,128 / 244,844 23:08:28 INFO - TinderboxPrint: CPU idle
8,298.4 (86.5%) 23:08:28 INFO - TinderboxPrint: CPU user
1,230.1 (12.8%) 23:08:28 INFO - TinderboxPrint: Swap in / out
0 / 0 23:08:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99794944; Read time: 0; Write time: 88912 23:08:28 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292061184; Read time: 168; Write time: 155932 23:08:28 INFO - Running post-run listener: _upload_blobber_files 23:08:28 INFO - Blob upload gear active. 23:08:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:08:28 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 23:08:28 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'] 23:08:28 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 23:08:29 INFO - (blobuploader) - INFO - Open directory for files ... 23:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:30 INFO - (blobuploader) - INFO - Done attempting. 23:08:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:08:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:08:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:33 INFO - (blobuploader) - INFO - Done attempting. 23:08:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:08:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:08:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:34 INFO - (blobuploader) - INFO - Done attempting. 23:08:34 INFO - (blobuploader) - INFO - Iteration through files over. 23:08:34 INFO - Return code: 0 23:08:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:08:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:08:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/03399453a02f7c81319886b766d1070e3dafbb4fce3da165448aef3fc4e383df9a5331a5a93448f72a6fcf231e93920d679b3eb76c6b2cc2601aa1d7c50860b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49a5fda80cb90aa8e129925f5fec5055218c61f511cfc2ffa8f1561d830a9dc8326a823824d07ff3973491c8bd046d71e6c71f433673a1a60ab96c5c049b2700", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/30f80d5352ec9f4693a31396e4caeeecc0906aa38277171e47e7c6af2ef7080012aaf5219afd2f49f7d83151264b4f6cdb3eb98735da8a178dc7ed8ffa29ee52"} 23:08:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:08:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:08:34 INFO - Contents: 23:08:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/03399453a02f7c81319886b766d1070e3dafbb4fce3da165448aef3fc4e383df9a5331a5a93448f72a6fcf231e93920d679b3eb76c6b2cc2601aa1d7c50860b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49a5fda80cb90aa8e129925f5fec5055218c61f511cfc2ffa8f1561d830a9dc8326a823824d07ff3973491c8bd046d71e6c71f433673a1a60ab96c5c049b2700", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/30f80d5352ec9f4693a31396e4caeeecc0906aa38277171e47e7c6af2ef7080012aaf5219afd2f49f7d83151264b4f6cdb3eb98735da8a178dc7ed8ffa29ee52"} 23:08:34 INFO - Running post-run listener: copy_logs_to_upload_dir 23:08:34 INFO - Copying logs to upload dir... 23:08:34 INFO - mkdir: /builds/slave/test/build/upload/logs 23:08:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.041447 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-02 23:08:34.565043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 23:08:34.568146) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/03399453a02f7c81319886b766d1070e3dafbb4fce3da165448aef3fc4e383df9a5331a5a93448f72a6fcf231e93920d679b3eb76c6b2cc2601aa1d7c50860b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49a5fda80cb90aa8e129925f5fec5055218c61f511cfc2ffa8f1561d830a9dc8326a823824d07ff3973491c8bd046d71e6c71f433673a1a60ab96c5c049b2700", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/30f80d5352ec9f4693a31396e4caeeecc0906aa38277171e47e7c6af2ef7080012aaf5219afd2f49f7d83151264b4f6cdb3eb98735da8a178dc7ed8ffa29ee52"} build_url:https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/a6GGtFeKTbiyWPdo4JVz4g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/03399453a02f7c81319886b766d1070e3dafbb4fce3da165448aef3fc4e383df9a5331a5a93448f72a6fcf231e93920d679b3eb76c6b2cc2601aa1d7c50860b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49a5fda80cb90aa8e129925f5fec5055218c61f511cfc2ffa8f1561d830a9dc8326a823824d07ff3973491c8bd046d71e6c71f433673a1a60ab96c5c049b2700", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/30f80d5352ec9f4693a31396e4caeeecc0906aa38277171e47e7c6af2ef7080012aaf5219afd2f49f7d83151264b4f6cdb3eb98735da8a178dc7ed8ffa29ee52"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 23:08:34.659541) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 23:08:34.659888) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1478152065.819072-889661908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 23:08:34.677656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 23:08:34.678200) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 23:08:34.678539) ========= ========= Total master_lag: 0.24 =========