builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1475673418.84 results: success (0) buildid: 20161005033001 builduid: 4aea672fe9d841d9a0478930a9e29ce4 revision: c4a811b0531e3bf4279a1e19a3e4451f2e416719 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.839317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.842041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.842436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.866614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.866922) ========= 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=af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 06:16:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-05 06:16:59 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.951794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:58.952085) ========= 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=af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017155 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.005010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.005581) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a811b0531e3bf4279a1e19a3e4451f2e416719 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c4a811b0531e3bf4279a1e19a3e4451f2e416719 --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=af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 06:16:59,620 truncating revision to first 12 chars 2016-10-05 06:16:59,621 Setting DEBUG logging. 2016-10-05 06:16:59,621 attempt 1/10 2016-10-05 06:16:59,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a811b0531e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 06:16:59,938 unpacking tar archive at: fx-team-c4a811b0531e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.747103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.747397) ========= script_repo_revision: c4a811b0531e3bf4279a1e19a3e4451f2e416719 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.747792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.748060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 06:16:59.758816) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-05 06:16:59.759125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:17:00 INFO - MultiFileLogger online at 20161005 06:17:00 in /builds/slave/test 06:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:00 INFO - {'append_to_log': False, 06:17:00 INFO - 'base_work_dir': '/builds/slave/test', 06:17:00 INFO - 'blob_upload_branch': 'Fx-Team', 06:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:00 INFO - 'branch': 'Fx-Team', 06:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:00 INFO - 'config_files': ('talos/linux_config.py',), 06:17:00 INFO - 'default_actions': ('clobber', 06:17:00 INFO - 'read-buildbot-config', 06:17:00 INFO - 'download-and-extract', 06:17:00 INFO - 'populate-webroot', 06:17:00 INFO - 'create-virtualenv', 06:17:00 INFO - 'install', 06:17:00 INFO - 'run-tests'), 06:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:00 INFO - 'download_minidump_stackwalk': True, 06:17:00 INFO - 'download_symbols': 'ondemand', 06:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:00 INFO - 'installer_path': 'installer.exe', 06:17:00 INFO - 'log_level': 'info', 06:17:00 INFO - 'log_name': 'talos', 06:17:00 INFO - 'log_to_console': True, 06:17:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:17:00 INFO - 'opt_config_files': (), 06:17:00 INFO - 'pip_index': False, 06:17:00 INFO - 'sps_profile': False, 06:17:00 INFO - 'sps_profile_interval': 0, 06:17:00 INFO - 'suite': 'dromaeojs', 06:17:00 INFO - 'system_bits': '32', 06:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:00 INFO - 'title': 'talos-linux64-ix-020', 06:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:00 INFO - 'use_talos_json': True, 06:17:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:00 INFO - 'work_dir': 'build'} 06:17:00 INFO - [mozharness: 2016-10-05 13:17:00.468879Z] Running clobber step. 06:17:00 INFO - Running pre-action listener: _resource_record_pre_action 06:17:00 INFO - Running main action method: clobber 06:17:00 INFO - rmtree: /builds/slave/test/build 06:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:17:00 INFO - Running post-action listener: _resource_record_post_action 06:17:00 INFO - [mozharness: 2016-10-05 13:17:00.929669Z] Finished clobber step (success) 06:17:00 INFO - [mozharness: 2016-10-05 13:17:00.929771Z] Running read-buildbot-config step. 06:17:00 INFO - Running pre-action listener: _resource_record_pre_action 06:17:00 INFO - Running main action method: read_buildbot_config 06:17:00 INFO - Using buildbot properties: 06:17:00 INFO - { 06:17:00 INFO - "project": "", 06:17:00 INFO - "product": "firefox", 06:17:00 INFO - "script_repo_revision": "production", 06:17:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:17:00 INFO - "repository": "", 06:17:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:17:00 INFO - "buildid": "20161005033001", 06:17:00 INFO - "pgo_build": "True", 06:17:00 INFO - "basedir": "/builds/slave/test", 06:17:00 INFO - "buildnumber": 506, 06:17:00 INFO - "slavename": "talos-linux64-ix-020", 06:17:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:17:00 INFO - "platform": "ubuntu64_hw", 06:17:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:17:00 INFO - "branch": "fx-team", 06:17:00 INFO - "repo_path": "integration/fx-team", 06:17:00 INFO - "revision": "c4a811b0531e3bf4279a1e19a3e4451f2e416719", 06:17:00 INFO - "stage_platform": "linux64-pgo", 06:17:00 INFO - "builduid": "4aea672fe9d841d9a0478930a9e29ce4", 06:17:00 INFO - "slavebuilddir": "test" 06:17:00 INFO - } 06:17:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:17:00 INFO - Running post-action listener: _resource_record_post_action 06:17:00 INFO - [mozharness: 2016-10-05 13:17:00.932192Z] Finished read-buildbot-config step (success) 06:17:00 INFO - [mozharness: 2016-10-05 13:17:00.932280Z] Running download-and-extract step. 06:17:00 INFO - Running pre-action listener: _resource_record_pre_action 06:17:00 INFO - Running main action method: download_and_extract 06:17:00 INFO - mkdir: /builds/slave/test/build/tests 06:17: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')]} 06:17:00 INFO - trying https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:17:00 INFO - Downloading https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/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 06:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/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 06:17:01 INFO - Downloaded 1361 bytes. 06:17:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:17:01 INFO - Using the following test package requirements: 06:17:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:17:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:17:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'jsshell-linux-x86_64.zip'], 06:17:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:17:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:17:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:17:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:17:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:17:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:17:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:17:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:17:07 INFO - Http code: 200 06:17:07 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 06:17:07 INFO - x-amz-cf-id: t64V8aTp9vL2M5zJBScWa15M0RORDUvvSm5L90nNBMykhNfJafdqPg== 06:17:07 INFO - x-amz-version-id: 4q9sVvhjJz4ieXydt4SVCDfL0Pgf5wD6 06:17:07 INFO - Expected file size: 21992733 06:17:07 INFO - Obtained file size: 21992733 06:17:11 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 06:17:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:17:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:11 INFO - Fetch https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:17:11 INFO - Http code: 200 06:17:11 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 06:17:11 INFO - x-amz-cf-id: Oaoo5hoNpgPcL0vFlXViWj0ha_hcX7mB80NqTAQoyhfPifU0DSu2tg== 06:17:11 INFO - x-amz-version-id: 4q9sVvhjJz4ieXydt4SVCDfL0Pgf5wD6 06:17:12 INFO - Expected file size: 21992733 06:17:12 INFO - Obtained file size: 21992733 06:17:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:17:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:17:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:17:17 INFO - Http code: 200 06:17:17 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 06:17:17 INFO - x-amz-cf-id: M8ukRqGghfZgIe1qJQum2Lf9-yHirZo5thEN5cTd3HhiVvlaIopNPw== 06:17:17 INFO - x-amz-version-id: Tsyc.moTbDtPa8AVr4uGFjFehRPIJKxm 06:17:17 INFO - Expected file size: 14409006 06:17:17 INFO - Obtained file size: 14409006 06:17: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')]} 06:17:17 INFO - trying https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:17:17 INFO - Downloading https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/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 06:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/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 06:17:18 INFO - Downloaded 59709533 bytes. 06:17:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:17:18 INFO - mkdir: /builds/slave/test/properties 06:17:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:17:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:17:18 INFO - Contents: 06:17:18 INFO - build_url:https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:17:19 INFO - Running post-action listener: _resource_record_post_action 06:17:19 INFO - Running post-action listener: set_extra_try_arguments 06:17:19 INFO - [mozharness: 2016-10-05 13:17:19.458917Z] Finished download-and-extract step (success) 06:17:19 INFO - [mozharness: 2016-10-05 13:17:19.459143Z] Running populate-webroot step. 06:17:19 INFO - Running pre-action listener: _resource_record_pre_action 06:17:19 INFO - Running main action method: populate_webroot 06:17:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:17:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:17:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:17:19 INFO - '--tppagecycles', 06:17:19 INFO - '7'], 06:17:19 INFO - 'tests': ['tsvgm']}}, 06:17:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:17:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:17:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:17:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:17:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:17:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['damp', 'tps']}, 06:17:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'tests': ['damp', 'tps']}, 06:17:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['dromaeo_dom']}, 06:17:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:17:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['basic_compositor_video']}, 06:17:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:17:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['a11yr', 06:17:19 INFO - 'ts_paint', 06:17:19 INFO - 'tpaint', 06:17:19 INFO - 'sessionrestore', 06:17:19 INFO - 'sessionrestore_no_auto_restore', 06:17:19 INFO - 'tabpaint']}, 06:17:19 INFO - 'other-e10s': {'tests': ['a11yr', 06:17:19 INFO - 'ts_paint', 06:17:19 INFO - 'tpaint', 06:17:19 INFO - 'sessionrestore', 06:17:19 INFO - 'sessionrestore_no_auto_restore', 06:17:19 INFO - 'tabpaint']}, 06:17:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:17:19 INFO - 'ts_paint', 06:17:19 INFO - 'tpaint', 06:17:19 INFO - 'sessionrestore', 06:17:19 INFO - 'sessionrestore_no_auto_restore', 06:17:19 INFO - 'tabpaint']}, 06:17:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:17:19 INFO - 'ts_paint', 06:17:19 INFO - 'tpaint', 06:17:19 INFO - 'sessionrestore', 06:17:19 INFO - 'sessionrestore_no_auto_restore', 06:17:19 INFO - 'tabpaint']}, 06:17:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['a11yr', 06:17:19 INFO - 'ts_paint', 06:17:19 INFO - 'tpaint', 06:17:19 INFO - 'sessionrestore', 06:17:19 INFO - 'sessionrestore_no_auto_restore', 06:17:19 INFO - 'tabpaint']}, 06:17:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['a11yr', 06:17:19 INFO - 'ts_paint', 06:17:19 INFO - 'tpaint', 06:17:19 INFO - 'sessionrestore', 06:17:19 INFO - 'sessionrestore_no_auto_restore', 06:17:19 INFO - 'tabpaint']}, 06:17:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['tsvgx', 06:17:19 INFO - 'tsvgr_opacity', 06:17:19 INFO - 'tart', 06:17:19 INFO - 'tscrollx', 06:17:19 INFO - 'cart']}, 06:17:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:17:19 INFO - 'tsvgr_opacity', 06:17:19 INFO - 'tart', 06:17:19 INFO - 'tscrollx', 06:17:19 INFO - 'cart']}, 06:17:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'talos_options': ['--disable-e10s'], 06:17:19 INFO - 'tests': ['tp5o']}, 06:17:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'tests': ['tp5o']}, 06:17:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'talos_options': ['--disable-e10s', 06:17:19 INFO - '--xperf_path', 06:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:19 INFO - 'tests': ['tp5n']}, 06:17:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:17:19 INFO - 'talos_options': ['--xperf_path', 06:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:17:19 INFO - 'tests': ['tp5n']}}, 06:17:19 INFO - 'talos.zip': {'path': '', 06:17:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:17:19 INFO - Running post-action listener: _resource_record_post_action 06:17:19 INFO - [mozharness: 2016-10-05 13:17:19.476444Z] Finished populate-webroot step (success) 06:17:19 INFO - [mozharness: 2016-10-05 13:17:19.476532Z] Running create-virtualenv step. 06:17:19 INFO - Running pre-action listener: _resource_record_pre_action 06:17:19 INFO - Running main action method: create_virtualenv 06:17:19 INFO - Creating virtualenv /builds/slave/test/build/venv 06:17:19 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 06:17:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:17:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:17:19 INFO - Using real prefix '/usr' 06:17:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:17:20 INFO - Installing distribute.............................................................................................................................................................................................done. 06:17:22 INFO - Installing pip.................done. 06:17:22 INFO - Return code: 0 06:17:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:17:22 INFO - Reading from file tmpfile_stdout 06:17:22 INFO - Output received: 06:17:22 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) 06:17:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:22 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:22 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 06:17:22 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 06:17:22 INFO - Using env: {'DISPLAY': ':0', 06:17:22 INFO - 'HOME': '/home/cltbld', 06:17:22 INFO - 'LANG': 'en_US.UTF-8', 06:17:22 INFO - 'LANGUAGE': 'en_US:en', 06:17:22 INFO - 'LOGNAME': 'cltbld', 06:17:22 INFO - 'MAIL': '/var/mail/cltbld', 06:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:22 INFO - 'MOZ_NO_REMOTE': '1', 06:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:22 INFO - 'NO_EM_RESTART': '1', 06:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:22 INFO - 'PWD': '/builds/slave/test', 06:17:22 INFO - 'SHELL': '/bin/bash', 06:17:22 INFO - 'SHLVL': '1', 06:17:22 INFO - 'TERM': 'linux', 06:17:22 INFO - 'TMOUT': '86400', 06:17:22 INFO - 'USER': 'cltbld', 06:17:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:22 INFO - '_': '/tools/buildbot/bin/python'} 06:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:22 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 06:17:22 INFO - Cleaning up... 06:17:22 INFO - Return code: 0 06:17:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:22 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:22 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 06:17:22 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 06:17:22 INFO - Using env: {'DISPLAY': ':0', 06:17:22 INFO - 'HOME': '/home/cltbld', 06:17:22 INFO - 'LANG': 'en_US.UTF-8', 06:17:22 INFO - 'LANGUAGE': 'en_US:en', 06:17:22 INFO - 'LOGNAME': 'cltbld', 06:17:22 INFO - 'MAIL': '/var/mail/cltbld', 06:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:22 INFO - 'MOZ_NO_REMOTE': '1', 06:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:22 INFO - 'NO_EM_RESTART': '1', 06:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:22 INFO - 'PWD': '/builds/slave/test', 06:17:22 INFO - 'SHELL': '/bin/bash', 06:17:22 INFO - 'SHLVL': '1', 06:17:22 INFO - 'TERM': 'linux', 06:17:22 INFO - 'TMOUT': '86400', 06:17:22 INFO - 'USER': 'cltbld', 06:17:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:22 INFO - '_': '/tools/buildbot/bin/python'} 06:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:22 INFO - Downloading/unpacking psutil>=3.1.1 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:24 INFO - Installing collected packages: psutil 06:17:24 INFO - Running setup.py install for psutil 06:17:24 INFO - building 'psutil._psutil_linux' extension 06:17:24 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 06:17:24 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 06:17:24 INFO - building 'psutil._psutil_posix' extension 06:17:24 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 06:17:25 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 06:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:17:25 INFO - Successfully installed psutil 06:17:25 INFO - Cleaning up... 06:17:25 INFO - Return code: 0 06:17:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:17:25 INFO - Using env: {'DISPLAY': ':0', 06:17:25 INFO - 'HOME': '/home/cltbld', 06:17:25 INFO - 'LANG': 'en_US.UTF-8', 06:17:25 INFO - 'LANGUAGE': 'en_US:en', 06:17:25 INFO - 'LOGNAME': 'cltbld', 06:17:25 INFO - 'MAIL': '/var/mail/cltbld', 06:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:25 INFO - 'MOZ_NO_REMOTE': '1', 06:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:25 INFO - 'NO_EM_RESTART': '1', 06:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:25 INFO - 'PWD': '/builds/slave/test', 06:17:25 INFO - 'SHELL': '/bin/bash', 06:17:25 INFO - 'SHLVL': '1', 06:17:25 INFO - 'TERM': 'linux', 06:17:25 INFO - 'TMOUT': '86400', 06:17:25 INFO - 'USER': 'cltbld', 06:17:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:25 INFO - '_': '/tools/buildbot/bin/python'} 06:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:17:25 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 06:17:25 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 06:17:25 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 06:17:25 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 06:17:25 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 06:17:25 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 06:17:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:17:27 INFO - Installing collected packages: mozsystemmonitor 06:17:27 INFO - Running setup.py install for mozsystemmonitor 06:17:27 INFO - Successfully installed mozsystemmonitor 06:17:27 INFO - Cleaning up... 06:17:27 INFO - Return code: 0 06:17:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:17:27 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')]} 06:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:27 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')]} 06:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:27 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:27 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 06:17:27 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 06:17:27 INFO - Using env: {'DISPLAY': ':0', 06:17:27 INFO - 'HOME': '/home/cltbld', 06:17:27 INFO - 'LANG': 'en_US.UTF-8', 06:17:27 INFO - 'LANGUAGE': 'en_US:en', 06:17:27 INFO - 'LOGNAME': 'cltbld', 06:17:27 INFO - 'MAIL': '/var/mail/cltbld', 06:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:27 INFO - 'MOZ_NO_REMOTE': '1', 06:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:27 INFO - 'NO_EM_RESTART': '1', 06:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:27 INFO - 'PWD': '/builds/slave/test', 06:17:27 INFO - 'SHELL': '/bin/bash', 06:17:27 INFO - 'SHLVL': '1', 06:17:27 INFO - 'TERM': 'linux', 06:17:27 INFO - 'TMOUT': '86400', 06:17:27 INFO - 'USER': 'cltbld', 06:17:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:27 INFO - '_': '/tools/buildbot/bin/python'} 06:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:27 INFO - Downloading/unpacking jsonschema==2.5.1 06:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:17:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:17:29 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 06:17:29 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 06:17:29 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 06:17:29 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 06:17:29 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 06:17:29 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 06:17:29 INFO - Downloading functools32-3.2.3-2.tar.gz 06:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:17:29 INFO - warning: no files found matching '*.txt' 06:17:29 INFO - no previously-included directories found matching 'build' 06:17:29 INFO - no previously-included directories found matching 'dist' 06:17:29 INFO - no previously-included directories found matching '.git*' 06:17:29 INFO - Installing collected packages: jsonschema, functools32 06:17:29 INFO - Running setup.py install for functools32 06:17:30 INFO - warning: no files found matching '*.txt' 06:17:30 INFO - no previously-included directories found matching 'build' 06:17:30 INFO - no previously-included directories found matching 'dist' 06:17:30 INFO - no previously-included directories found matching '.git*' 06:17:30 INFO - Successfully installed jsonschema functools32 06:17:30 INFO - Cleaning up... 06:17:30 INFO - Return code: 0 06:17:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:30 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:30 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 06:17:30 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 06:17:30 INFO - Using env: {'DISPLAY': ':0', 06:17:30 INFO - 'HOME': '/home/cltbld', 06:17:30 INFO - 'LANG': 'en_US.UTF-8', 06:17:30 INFO - 'LANGUAGE': 'en_US:en', 06:17:30 INFO - 'LOGNAME': 'cltbld', 06:17:30 INFO - 'MAIL': '/var/mail/cltbld', 06:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:30 INFO - 'MOZ_NO_REMOTE': '1', 06:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:30 INFO - 'NO_EM_RESTART': '1', 06:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:30 INFO - 'PWD': '/builds/slave/test', 06:17:30 INFO - 'SHELL': '/bin/bash', 06:17:30 INFO - 'SHLVL': '1', 06:17:30 INFO - 'TERM': 'linux', 06:17:30 INFO - 'TMOUT': '86400', 06:17:30 INFO - 'USER': 'cltbld', 06:17:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:30 INFO - '_': '/tools/buildbot/bin/python'} 06:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:17:30 INFO - Cleaning up... 06:17:30 INFO - Return code: 0 06:17:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:30 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:30 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 06:17:30 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 06:17:30 INFO - Using env: {'DISPLAY': ':0', 06:17:30 INFO - 'HOME': '/home/cltbld', 06:17:30 INFO - 'LANG': 'en_US.UTF-8', 06:17:30 INFO - 'LANGUAGE': 'en_US:en', 06:17:30 INFO - 'LOGNAME': 'cltbld', 06:17:30 INFO - 'MAIL': '/var/mail/cltbld', 06:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:30 INFO - 'MOZ_NO_REMOTE': '1', 06:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:30 INFO - 'NO_EM_RESTART': '1', 06:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:30 INFO - 'PWD': '/builds/slave/test', 06:17:30 INFO - 'SHELL': '/bin/bash', 06:17:30 INFO - 'SHLVL': '1', 06:17:30 INFO - 'TERM': 'linux', 06:17:30 INFO - 'TMOUT': '86400', 06:17:30 INFO - 'USER': 'cltbld', 06:17:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:30 INFO - '_': '/tools/buildbot/bin/python'} 06:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:17:30 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 06:17:30 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 06:17:30 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 06:17:30 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 06:17:30 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 06:17:30 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 06:17:32 INFO - Downloading blobuploader-1.2.4.tar.gz 06:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:17:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:17:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 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 06:17:32 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 06:17:33 INFO - Downloading docopt-0.6.1.tar.gz 06:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:17:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:17:33 INFO - Running setup.py install for blobuploader 06:17:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:17:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:17:33 INFO - Running setup.py install for requests 06:17:33 INFO - Running setup.py install for docopt 06:17:33 INFO - Successfully installed blobuploader requests docopt 06:17:33 INFO - Cleaning up... 06:17:33 INFO - Return code: 0 06:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:33 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')]} 06:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:33 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')]} 06:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:33 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:33 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 06:17:33 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 06:17:33 INFO - Using env: {'DISPLAY': ':0', 06:17:33 INFO - 'HOME': '/home/cltbld', 06:17:33 INFO - 'LANG': 'en_US.UTF-8', 06:17:33 INFO - 'LANGUAGE': 'en_US:en', 06:17:33 INFO - 'LOGNAME': 'cltbld', 06:17:33 INFO - 'MAIL': '/var/mail/cltbld', 06:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:33 INFO - 'MOZ_NO_REMOTE': '1', 06:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:33 INFO - 'NO_EM_RESTART': '1', 06:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:33 INFO - 'PWD': '/builds/slave/test', 06:17:33 INFO - 'SHELL': '/bin/bash', 06:17:33 INFO - 'SHLVL': '1', 06:17:33 INFO - 'TERM': 'linux', 06:17:33 INFO - 'TMOUT': '86400', 06:17:33 INFO - 'USER': 'cltbld', 06:17:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:33 INFO - '_': '/tools/buildbot/bin/python'} 06:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:34 INFO - Running setup.py (path:/tmp/pip-GkPiNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:34 INFO - Running setup.py (path:/tmp/pip-v6w2CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:34 INFO - Running setup.py (path:/tmp/pip-Ef30sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:34 INFO - Running setup.py (path:/tmp/pip-EcaCDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:34 INFO - Running setup.py (path:/tmp/pip-jvCGLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:34 INFO - Running setup.py (path:/tmp/pip-gzJQiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:34 INFO - Running setup.py (path:/tmp/pip-Y7nBXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:34 INFO - Running setup.py (path:/tmp/pip-TLNj6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:34 INFO - Running setup.py (path:/tmp/pip-v4wnV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:34 INFO - Running setup.py (path:/tmp/pip-NPEroK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:34 INFO - Running setup.py (path:/tmp/pip-3kEFVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:34 INFO - Running setup.py (path:/tmp/pip-NLZ3cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:34 INFO - Running setup.py (path:/tmp/pip-2kelGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:35 INFO - Running setup.py (path:/tmp/pip-nE9LDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:35 INFO - Running setup.py (path:/tmp/pip-lLvM4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:35 INFO - Running setup.py (path:/tmp/pip-sntRD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:35 INFO - Running setup.py (path:/tmp/pip-8In8R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:17:35 INFO - Running setup.py install for manifestparser 06:17:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:17:35 INFO - Running setup.py install for mozcrash 06:17:35 INFO - Running setup.py install for mozdebug 06:17:35 INFO - Running setup.py install for mozdevice 06:17:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:17:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:17:35 INFO - Running setup.py install for mozfile 06:17:35 INFO - Running setup.py install for mozhttpd 06:17:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:17:35 INFO - Running setup.py install for mozinfo 06:17:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Running setup.py install for mozInstall 06:17:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Running setup.py install for mozleak 06:17:36 INFO - Running setup.py install for mozlog 06:17:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Running setup.py install for moznetwork 06:17:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Running setup.py install for mozprocess 06:17:36 INFO - Running setup.py install for mozprofile 06:17:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Running setup.py install for mozrunner 06:17:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:17:36 INFO - Running setup.py install for mozscreenshot 06:17:36 INFO - Running setup.py install for moztest 06:17:36 INFO - Running setup.py install for mozversion 06:17:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:17:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:17:37 INFO - Cleaning up... 06:17:37 INFO - Return code: 0 06:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:37 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')]} 06:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:37 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')]} 06:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:37 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:37 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 06:17:37 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 06:17:37 INFO - Using env: {'DISPLAY': ':0', 06:17:37 INFO - 'HOME': '/home/cltbld', 06:17:37 INFO - 'LANG': 'en_US.UTF-8', 06:17:37 INFO - 'LANGUAGE': 'en_US:en', 06:17:37 INFO - 'LOGNAME': 'cltbld', 06:17:37 INFO - 'MAIL': '/var/mail/cltbld', 06:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:37 INFO - 'MOZ_NO_REMOTE': '1', 06:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:37 INFO - 'NO_EM_RESTART': '1', 06:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:37 INFO - 'PWD': '/builds/slave/test', 06:17:37 INFO - 'SHELL': '/bin/bash', 06:17:37 INFO - 'SHLVL': '1', 06:17:37 INFO - 'TERM': 'linux', 06:17:37 INFO - 'TMOUT': '86400', 06:17:37 INFO - 'USER': 'cltbld', 06:17:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:37 INFO - '_': '/tools/buildbot/bin/python'} 06:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:37 INFO - Running setup.py (path:/tmp/pip-0Y1473-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:37 INFO - Running setup.py (path:/tmp/pip-j_MkjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:37 INFO - Running setup.py (path:/tmp/pip-Iu4V9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:37 INFO - Running setup.py (path:/tmp/pip-goVMrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:37 INFO - Running setup.py (path:/tmp/pip-qNG1nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:37 INFO - Running setup.py (path:/tmp/pip-ynS2tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:37 INFO - Running setup.py (path:/tmp/pip-gjGJtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:37 INFO - Running setup.py (path:/tmp/pip-Xi2333-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:37 INFO - Running setup.py (path:/tmp/pip-s_ijsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:37 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)) 06:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:38 INFO - Running setup.py (path:/tmp/pip-1zEg4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:38 INFO - Running setup.py (path:/tmp/pip-uikUp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:38 INFO - Running setup.py (path:/tmp/pip-barlPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:38 INFO - Running setup.py (path:/tmp/pip-R1TTRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:38 INFO - Running setup.py (path:/tmp/pip-DCmiHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:38 INFO - Running setup.py (path:/tmp/pip-t0nH4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:38 INFO - Running setup.py (path:/tmp/pip-VQ12DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:38 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)) 06:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:38 INFO - Running setup.py (path:/tmp/pip-pYMmr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:38 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)) 06:17:38 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)) 06:17:38 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)) 06:17:38 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)) 06:17:38 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)) 06:17:38 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)) 06:17:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:40 INFO - Downloading blessings-1.6.tar.gz 06:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:17:40 INFO - Installing collected packages: blessings 06:17:40 INFO - Running setup.py install for blessings 06:17:40 INFO - Successfully installed blessings 06:17:40 INFO - Cleaning up... 06:17:40 INFO - Return code: 0 06:17:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:40 INFO - Reading from file tmpfile_stdout 06:17:40 INFO - Current package versions: 06:17:40 INFO - argparse == 1.2.1 06:17:40 INFO - blessings == 1.6 06:17:40 INFO - blobuploader == 1.2.4 06:17:40 INFO - docopt == 0.6.1 06:17:40 INFO - functools32 == 3.2.3-2 06:17:40 INFO - jsonschema == 2.5.1 06:17:40 INFO - manifestparser == 1.1 06:17:40 INFO - mozInstall == 1.12 06:17:40 INFO - mozcrash == 0.17 06:17:40 INFO - mozdebug == 0.1 06:17:40 INFO - mozdevice == 0.48 06:17:40 INFO - mozfile == 1.2 06:17:40 INFO - mozhttpd == 0.7 06:17:40 INFO - mozinfo == 0.9 06:17:40 INFO - mozleak == 0.1 06:17:40 INFO - mozlog == 3.4 06:17:40 INFO - moznetwork == 0.27 06:17:40 INFO - mozprocess == 0.23 06:17:40 INFO - mozprofile == 0.28 06:17:40 INFO - mozrunner == 6.12 06:17:40 INFO - mozscreenshot == 0.1 06:17:40 INFO - mozsystemmonitor == 0.3 06:17:40 INFO - moztest == 0.7 06:17:40 INFO - mozversion == 1.4 06:17:40 INFO - psutil == 3.1.1 06:17:40 INFO - requests == 1.2.3 06:17:40 INFO - wsgiref == 0.1.2 06:17:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:40 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:40 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 06:17:40 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 06:17:40 INFO - Using env: {'DISPLAY': ':0', 06:17:40 INFO - 'HOME': '/home/cltbld', 06:17:40 INFO - 'LANG': 'en_US.UTF-8', 06:17:40 INFO - 'LANGUAGE': 'en_US:en', 06:17:40 INFO - 'LOGNAME': 'cltbld', 06:17:40 INFO - 'MAIL': '/var/mail/cltbld', 06:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:40 INFO - 'MOZ_NO_REMOTE': '1', 06:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:40 INFO - 'NO_EM_RESTART': '1', 06:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:40 INFO - 'PWD': '/builds/slave/test', 06:17:40 INFO - 'SHELL': '/bin/bash', 06:17:40 INFO - 'SHLVL': '1', 06:17:40 INFO - 'TERM': 'linux', 06:17:40 INFO - 'TMOUT': '86400', 06:17:40 INFO - 'USER': 'cltbld', 06:17:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:40 INFO - '_': '/tools/buildbot/bin/python'} 06:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 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)) 06:17:41 INFO - Cleaning up... 06:17:41 INFO - Return code: 0 06:17:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:17: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')]} 06:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17: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')]} 06:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:41 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 0x7ffa609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d27790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', '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 06:17:41 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 06:17:41 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 06:17:41 INFO - Using env: {'DISPLAY': ':0', 06:17:41 INFO - 'HOME': '/home/cltbld', 06:17:41 INFO - 'LANG': 'en_US.UTF-8', 06:17:41 INFO - 'LANGUAGE': 'en_US:en', 06:17:41 INFO - 'LOGNAME': 'cltbld', 06:17:41 INFO - 'MAIL': '/var/mail/cltbld', 06:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:41 INFO - 'MOZ_NO_REMOTE': '1', 06:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:41 INFO - 'NO_EM_RESTART': '1', 06:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:41 INFO - 'PWD': '/builds/slave/test', 06:17:41 INFO - 'SHELL': '/bin/bash', 06:17:41 INFO - 'SHLVL': '1', 06:17:41 INFO - 'TERM': 'linux', 06:17:41 INFO - 'TMOUT': '86400', 06:17:41 INFO - 'USER': 'cltbld', 06:17:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:41 INFO - '_': '/tools/buildbot/bin/python'} 06:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:17:41 INFO - Cleaning up... 06:17:41 INFO - Return code: 0 06:17:41 INFO - Running post-action listener: _resource_record_post_action 06:17:41 INFO - Running post-action listener: _start_resource_monitoring 06:17:41 INFO - Starting resource monitoring. 06:17:41 INFO - [mozharness: 2016-10-05 13:17:41.432492Z] Finished create-virtualenv step (success) 06:17:41 INFO - [mozharness: 2016-10-05 13:17:41.433005Z] Running install step. 06:17:41 INFO - Running pre-action listener: _resource_record_pre_action 06:17:41 INFO - Running main action method: install 06:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:41 INFO - Reading from file tmpfile_stdout 06:17:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:17:41 INFO - Reading from file tmpfile_stdout 06:17:41 INFO - Output received: 06:17:41 INFO - Usage: mozinstall [options] installer 06:17:41 INFO - Options: 06:17:41 INFO - -h, --help show this help message and exit 06:17:41 INFO - -d DEST, --destination=DEST 06:17:41 INFO - Directory to install application into. [default: 06:17:41 INFO - "/builds/slave/test"] 06:17:41 INFO - --app=APP Application being installed. [default: firefox] 06:17:41 INFO - mkdir: /builds/slave/test/build/application 06:17:41 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'] 06:17:41 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 06:17:58 INFO - Reading from file tmpfile_stdout 06:17:58 INFO - Output received: 06:17:58 INFO - /builds/slave/test/build/application/firefox/firefox 06:17:58 INFO - Running post-action listener: _resource_record_post_action 06:17:58 INFO - [mozharness: 2016-10-05 13:17:58.744746Z] Finished install step (success) 06:17:58 INFO - [mozharness: 2016-10-05 13:17:58.744992Z] Running run-tests step. 06:17:58 INFO - Running pre-action listener: _resource_record_pre_action 06:17:58 INFO - Running main action method: run_tests 06:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:17:58 INFO - Python 2.7.3 06:17:58 INFO - Return code: 0 06:17:58 INFO - grabbing minidump binary from tooltool 06:17:58 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')]} 06:17:58 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 0x1d24930>, '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 0x1d25830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:17:58 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 06:17:58 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 06:17:58 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 06:17:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:17:58 INFO - Return code: 0 06:17:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:17:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:17:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:17:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:17:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:17:58 INFO - Using env: {'DISPLAY': ':0', 06:17:58 INFO - 'HOME': '/home/cltbld', 06:17:58 INFO - 'LANG': 'en_US.UTF-8', 06:17:58 INFO - 'LANGUAGE': 'en_US:en', 06:17:58 INFO - 'LOGNAME': 'cltbld', 06:17:58 INFO - 'MAIL': '/var/mail/cltbld', 06:17:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:17:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:58 INFO - 'MOZ_NO_REMOTE': '1', 06:17:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:58 INFO - 'NO_EM_RESTART': '1', 06:17:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:58 INFO - 'PWD': '/builds/slave/test', 06:17:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:17:58 INFO - 'SHELL': '/bin/bash', 06:17:58 INFO - 'SHLVL': '1', 06:17:58 INFO - 'TERM': 'linux', 06:17:58 INFO - 'TMOUT': '86400', 06:17:58 INFO - 'USER': 'cltbld', 06:17:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666', 06:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:58 INFO - '_': '/tools/buildbot/bin/python'} 06:17:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:17:59 INFO - mozversion application_buildid: 20161005033001 06:17:59 INFO - mozversion application_changeset: c4a811b0531e3bf4279a1e19a3e4451f2e416719 06:17:59 INFO - mozversion application_display_name: Nightly 06:17:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:17:59 INFO - mozversion application_name: Firefox 06:17:59 INFO - mozversion application_remotingname: firefox 06:17:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:17:59 INFO - mozversion application_vendor: Mozilla 06:17:59 INFO - mozversion application_version: 52.0a1 06:17:59 INFO - mozversion platform_buildid: 20161005033001 06:17:59 INFO - mozversion platform_changeset: c4a811b0531e3bf4279a1e19a3e4451f2e416719 06:17:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:17:59 INFO - mozversion platform_version: 52.0a1 06:17:59 INFO - using testdate: 1475673479 06:17:59 INFO - actual date: 1475673479 06:17:59 INFO - starting webserver on 'localhost:33246' 06:17:59 INFO - SUITE-START | Running 2 tests 06:17:59 INFO - TEST-START | dromaeo_css 06:17:59 INFO - operating with platform_type : linux_ 06:17:59 INFO - Initialising browser for dromaeo_css test... 06:17:59 INFO - TEST-INFO | started process 22768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxtUPbc/profile http://localhost:33246/getInfo.html) 06:18:03 INFO - PROCESS | 22768 | __metrics Screen width/height:1600/1200 06:18:03 INFO - PROCESS | 22768 | colorDepth:24 06:18:03 INFO - PROCESS | 22768 | Browser inner width/height: 1024/697 06:18:03 INFO - PROCESS | 22768 | __metrics 06:18:04 INFO - PROCESS | 22768 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:04 INFO - PROCESS | 22768 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:05 INFO - PROCESS | 22768 | console.error: PushService: 06:18:05 INFO - PROCESS | 22768 | stateChangeProcessEnqueue: Error transitioning state 06:18:05 INFO - PROCESS | 22768 | UnknownError 06:18:05 INFO - TEST-INFO | 22768: exit 0 06:18:05 INFO - Browser initialized. 06:18:05 INFO - Running cycle 1/1 for dromaeo_css test... 06:18:05 INFO - TEST-INFO | started process 22854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxtUPbc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:17 INFO - PROCESS | 22854 | RSS: Main: 173920256 06:18:17 INFO - PROCESS | 22854 | 06:19:08 INFO - PROCESS | 22854 | 1475673548976 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] 06:21:20 INFO - PROCESS | 22854 | Cycle 1(1): loaded http://localhost:33246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33246/tests/dromaeo/cssquery-ext.html) 06:21:21 INFO - PROCESS | 22854 | RSS: Main: 278908928 06:21:21 INFO - PROCESS | 22854 | 06:24:24 INFO - PROCESS | 22854 | Cycle 1(1): loaded http://localhost:33246/tests/dromaeo/cssquery-ext.html (next: http://localhost:33246/tests/dromaeo/cssquery-jquery.html) 06:24:24 INFO - PROCESS | 22854 | RSS: Main: 285003776 06:24:24 INFO - PROCESS | 22854 | 06:27:26 INFO - PROCESS | 22854 | Cycle 1(1): loaded http://localhost:33246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33246/tests/dromaeo/cssquery-mootools.html) 06:27:27 INFO - PROCESS | 22854 | RSS: Main: 253898752 06:27:27 INFO - PROCESS | 22854 | 06:30:29 INFO - PROCESS | 22854 | Cycle 1(1): loaded http://localhost:33246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33246/tests/dromaeo/cssquery-prototype.html) 06:30:29 INFO - PROCESS | 22854 | RSS: Main: 240369664 06:30:29 INFO - PROCESS | 22854 | 06:33:32 INFO - PROCESS | 22854 | Cycle 1(1): loaded http://localhost:33246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33246/tests/dromaeo/cssquery-yui.html) 06:33:33 INFO - PROCESS | 22854 | RSS: Main: 219734016 06:33:33 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | Cycle 1(1): loaded http://localhost:33246/tests/dromaeo/cssquery-yui.html (next: http://localhost:33246/tests/dromaeo/cssquery-dojo.html) 06:36:36 INFO - PROCESS | 22854 | RSS: Main: 305823744 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | __start_tp_report 06:36:36 INFO - PROCESS | 22854 | _x_x_mozilla_page_load 06:36:36 INFO - PROCESS | 22854 | _x_x_mozilla_page_load_details 06:36:36 INFO - PROCESS | 22854 | |i|pagename|runs| 06:36:36 INFO - PROCESS | 22854 | |0;dojo.html;2946.9410611787766;3022.350194708137;3026.71246231608;3048.542718592212;3072.754179665627;5147.22791581263;5229.058769421507;5255.290535777669;5275.182346736257;5334.599905007125;5213.687178769267;5254.054270231357;5276.419593844674;5329.573634109272;5366.087765079936;4787.928181077286;4795.472498025214;4805.087033463648;4814.1334559779225;4912.263160525914;4906.509349065101;4931.630127740415;4951.603871690256;4955.207166853304;4970.552650261476;4733.644976626767;4786.593139583105;4798.376211092553;4844.055409195208;4907.852764417074;4823.20417131173;4837.564619184291;4838.927416088762;4839.588634966032;4841;4792.065547218293;4801.663883528155;4811.158047341736;4813.807447702087;4819.614430845524;5194.532492075694;5234.659747116425;5241.318628578299;5248.081585722483;5259.526642602146;5552.333719953632;5560.138178582326;5562.916556251659;5564.4713752193475;5566.165075238706;5624.29696287964;5642.915356269659;5646;5647.887042259173;5651.40660230674;5198.194279886624;5219.739013049409;5238.161894096965;5265.631405801595;5266.315379000705;5700.144978253295;5717.22817419643;5728.541716662657;5796.072628379439;5798.101294299306;5541.722913854291;5542.8337149885565;5548.0845660466375;5552.139418390156;5559.499645031886;5430.185472179205;5452.536534394541;5510.448955104538;5561.277033985556;5583.469570390806;5522.447755224526;5541.251930989265;5542.972285138549;5543.833684989457;5552.666839989613;5550.972245138829;5560.499555040065;5562.3047119110115;5566.332040155207;5621.550275977912;4240.427542281815;4277.529471758104;4286.207051695446;4297.140571885635;4307.095509942885;3830.3296923038356;3860.4595356650093;3871.5160604924386;3885.203533275672;3892.3188442022533;5256.737163141827;5263.973680131575;5274.129768588216;5278.630495865253;5334.1732031535175;5445.618806683494;5539.5014448699;5540.196671482693;5544.279243698374;5546.389897111395;5162.406323272797;5218.669239343943;5221.060209162311;5222.634415590948;5303.098473259555;4782.282657601388;4789.3294938708605;4791.760411979457;4795.808167673324;4801.4718380978065;5625.634333768292;5672.12082127271;5692.032354499662;5699.686517241508;5700.543956483389;5483.862903427286;5558.91661625084;5560.2493663356545;5646.520045796154;5647.237622920853;5824.592278540462;5849.590528663123;5861.296644402699;5863.648181109147;5917.704114794329;5513.145462453326;5527.723613819373;5538.778448862;5540.69526176048;5543.057680194457;5461.9180712290145;5515.834524964257;5566.693831839288;5567.526760225426;5609.27079479665;5269.130593452038;5312.123499622519;5320.255164276927;5329.813456529158;5382.811601593926;5321.255024296524;5324.6006549508165;5327.360716714019;5335.67985920846;5397.595180361567;5193.792248310026;5270.367555893317;5344.572434205332;5391.730413479232;5392.595555333444;5451.863703407446;5487.368952570346;5492.725363731877;5542.334919809648;5558.527525160245;5316.867078323073;5334;5335.919961200508;5338.279332290246;5346.545543628835 06:36:36 INFO - PROCESS | 22854 | |1;ext.html;554.7365001624231;561.6573889927145;565.5362602665813;569.0780934885486;575.252172176171;28173.154805355847;28786.280342991435;31077.66917481187;31109.377812443738;31119.844400777965;36627.084322891875;37773;37813.62186378135;40681.796591017;40869.79565102178;8460.280876125522;8597.226249637532;8597.269232115246;8597.61310741015;8600;8445.788855278606;8516.74449766508;8533.061363250037;8534.530600816952;8535.402521823475;8487.44831585948;8556.914430855673;8584.05575386707;8620.956895215515;8621.094785047573;8476.66093356265;8516.659333626647;8525.658973641079;8528.317734581218;8540.70107546233;8422.399744048673;8492.320614350838;8495.235428811375;8497;8498.065212826585;35554.64445355565;36041;36050.45924311138;36176.63823361759;36220.63779362199;2975.1074677596853;3000.4599172149005;3034.9696503034907;3177.53925680775;3480.3735327641016;26928.59607105895;27058.729412706016;27178.184654460398;27578.724212757817;27784.86107569449;4218.831246750126;4231.87304380869;4279.679024073176;4305.138972205571;4373.300271956472;306776;308193;308360;308392;309076;45982.080358392646;46477.7676111624;46556.53443465522;46577.534224658;46586.30120548195;43463.565364346585;44430.33354499685;48277.275840862414;48348.75825620849;48459.18489781249;12423.75152496945;12689;14322;14706.33821478036;14712.19082950448;11431;11438.542458301741;11485.449464322377;11532.135089868294;11539.826902596467;13028.739425211443;13169.53906613264;13245.337733113305;13337.866621333662;13462.461501539829;4816.866879137044;5478.698671573102;5487.122060470386;5546.944530554723;5593.664380137205;809.9554524501209;899.4288626721948;903.5482258870434;935.6818681648273;952.1573407534382;26202;26970.32574185661;27925.16224513268;28076.43847123046;28291.575626365622;983.8819341679044;984;1023.6775415744016;1041.463646222196;1072.0780129088978;14008.369623366973;14355.78466323006;14396.043256934006;14877.107373557405;15012.849871501363;504012;505349;511198;512645;512789;46710;46803.765981169876;46850.76574617173;46855;46883.5311646886;1072.420892717939;1109.4730003248392;1121.1871393239999;1148.942552872353;1174.395186478964;23969.28092157238;28087;28732.281692957844;29108.563371549866;31297.217569560944;44919;45109.09781804411;45449;45528.317075243234;45584.54415455936;341823;344229;344433;344595;344700;24072.638910416706;24634.13780517673;24702.25893223206;24792.504149916538;26130.86934565315;38092.017583990615;38802.61197388103;39220;39283.08961379828;39688.60311396964;32059;33803.83098084494;34069.48895766615;34330;35043.12392190216;32996.67003329936;33955.83022084874;34298.657013430544;34650.48024279587;35353;33848.15379615431;34224;34327.65672343344;34714.13214669654;34793.47809782805;26636.60045099364;28190.85904570464;28560.42879142447;28657.856710716314;28724.856375717987;24167.879160604083;24442.63336049925;24502.63246051275;24650.26049218526;24852.50294994054 06:36:36 INFO - PROCESS | 22854 | |2;jquery.html;361.3080949980787;369.8723940240619;386.31814846795413;386.5651142464727;409.41044895350694;13462;16771.329146834127;17498.125093745308;17787.377441789507;18631.53421164468;15719.9782014169;16518.504444866645;16558.83441165588;16619.83380166198;16623.168841557905;5386.326709161355;5918.763249470037;6214.694914068028;6233.252009758835;6342.207224096988;3831.252905683393;4040.4949381327333;6292.18201633787;6334.683265836713;6335.651539165344;3921.1177485065773;6193.102000209967;6226.533010024244;6306.1171435998995;6306.36936306368;6303.968480157593;6310.4320611144985;6310.558260921737;6726.562773419712;7055.25919778421;6813.591184528944;6919.031335613018;6928.16861976561;6947.305269473063;6953.965230173867;22687.773122268733;23081.769182308297;23177.652335214985;23473.647895281585;23709.644355334683;2564.4614630927526;2627.710951795301;2697.652633624481;2751.917442476729;2854.771618270554;13938.442462301497;14202.360893759806;14322.856771432256;14421.495247666386;15188.924055379652;1906.6643361881722;1921;1943.3295513047976;1965.9017049147485;2009.5277609761695;91201;91829.54085229531;91912.54043729739;91988.54005729995;92048;8822.558872056372;9498.905010949802;9582;9681.903180968242;9704.369216000938;12899.742005160031;12942.223466592035;12946.96424286055;12978.66384050861;12980;7047.788566343018;7214;7247.601381924045;7368.300011498899;7426.774582193985;6848.623325717133;6946.9579563064935;7156.284371562906;7170.856582868418;7174.964125179341;3879.573246942834;3994.107218657122;3999.320115580358;4083;4084.875864550417;1905.1902941249914;1911.5603411215498;1913.9712904306446;1932.700431433102;1960.2649006622516;792.1523969352737;800.1798156889118;849.2017503546647;852.6163226548078;888.138505649519;16786.91606541984;17423.12884355777;17866.846478789586;17931.103444827706;17936.91031544834;862.4868203419081;876.588003638289;877.7147427086222;899.0874262623443;910;9087.454752714859;9755.365901216399;9797.265205109503;9838;9890.653827116017;435444;436672;438638;454230;454831;88297.55851220703;88363;88388;89168;89753.55123224342;871.6121326009865;885.2342723544217;887.933404994628;888.311558542135;891.5497673674882;15469.226538672796;15693.293801779175;15746.212689365715;15893.602659933595;16075.598110047342;40347.394789078775;40573;40668.79665601653;41588.79205604074;41790.79104604458;53915.730421347645;54839.72580137233;54858.93572552616;56692.433075670364;57529;7885.566293853663;7932.206779322252;7958.562279074707;8148.633311501115;8268.958655206685;10990.780184396428;11633.6509904703;11652.494713636608;11869.169158158846;11992.520299187934;10060.49697515136;10556.841647375142;10904.454777261264;10915.617953371593;11221.831672525082;9928.453935033642;10270.794584108426;10296;10694.572217111228;10793.514291856729;9920.652777153055;9926.553305101143;10537;10599.629012984817;10910.399928004035;8072.233137851895;10772.353658780497;10967.725806854893;11037;11421.31472111676;10626.309289896131;10902.127829773757;10913.957820404541;11224;11814.881851181379 06:36:36 INFO - PROCESS | 22854 | |3;mootools.html;1125.9211855170142;1186.9791978898147;1198.7063169523467;1251.3180316727385;1407.4299908537039;7430.962845185773;8172.101068882425;8381.87427188592;8449.23956843884;8692;8484.321254299657;8495;8517.701880434186;8553.743387698363;8563.657453701844;2258.8644681319133;2284.017872314904;2286.8970896309625;2288.553732022256;2293.6330187170056;2221.466847956487;2275.8862056897174;2288.21056735426;2288.329519450802;2290.1183044527893;2255.379770563092;2272.761360057195;2282.6233671444193;2288.519410923708;2298.5173113646156;2193.0350645715835;2204.7574766775642;2205.6250437425674;2217.922372716955;2217.9889100554474;2211.259228158569;2219.212179676208;2219.633760429543;2223.977760222393;2230.4535388829677;8594.742157735278;8778.912210877874;8797.956010219972;8798.340124490689;8804.559772011438;5017.774200161001;5185.325907632021;5191.740412979374;5252.3171987641745;5259.947400525984;3321.9003429897143;3548.4854696068924;3594.9281014379826;3616.8372423241017;3627.0569651890432;1199.3044034459992;1235.839340885688;1242.2111958906069;1259.1941157659105;1282.3331867428885;12826.486940522367;12861.742765144738;12916;12918.870811291861;12922.54771083017;4111.8972025699595;4332.285172946492;4411.20598292304;4497.977510112429;4502.257127573914;9481.857772133424;9485.478298693639;9495.335326527076;9500.42997420157;9502.192313653279;5050;5055.443901170868;5060.5698515625845;5060.645754797202;5063.3417655704525;4247.086876321606;4390.604845563851;4620.0990806793025;4718.905621887543;4750.358701575312;3580.9820950895078;3614.945775813365;3646.2707458508403;3681.37416639172;3736.831842567091;1118.2060736876908;1121.3664279682116;1129.3849794793525;1142.3203194099497;1142.8971392574708;829.5976451421056;830.6511265268481;850.4557083466586;854.8290341931638;854.9529775862263;5377.085895397791;5592.412796656293;5712;5781.768729250867;5804.332501762351;782.8864814601851;789.1989630525022;791.3748138970265;793.5556088590292;873.5501216873315;3591.7844929304324;3650.7079433645245;3661.359262129117;3723.236736469017;3814.389697648363;10880.78238435227;11348.829767553329;11556.133290003283;11597.072234221241;11632.651020469399;11415.086793056536;11604.535818567332;11624.767504649859;11626.53493860253;11628.372027916099;8108.635111420001;8120.878186827203;8173.060098088677;8239.752807415787;8262.628181731836;5416.350037995308;5453.7818487260065;5476.205950137288;5608.495235428831;5711.714414279352;10296.279260451696;10330.328528645614;10353.63762268317;10459.947700261755;10553.73615659584;10594.364338139736;10671.432472013119;10733.516991735547;10769.515371808131;10795.136389089012;6506.772262970773;6663.933360666331;6737.3599508046655;7197.352238298578;7340.669669864762;7810.140884502586;8292.668293268202;8395.454295470774;8576.228139467477;8604.268637165911;7468.3278504934815;7497.10034795828;7688.115866675404;7692.730754423568;7866.331361834308;7363.963180184065;7488.700451981859;7567.31894129531;7643.541387516767;7669;6717.966410167918;6819.795406137824;6825.488088393291;6829.590224586541;6830.624315662686;4999.900002000012;5055.845977941172;5166.535011848951;5211.6872987619345;5269.525742683177;4926.556609905126;5025.673331233458;5050.949490505048;5157.742112894265;5195.870103247449 06:36:36 INFO - PROCESS | 22854 | |4;prototype.html;301.07569760834247;307.18442535069386;314.4606998996723;315.9589253397058;319.4569232305082;4975.7857753299795;5025.748712564371;5115.590752739781;5119.616028797841;5132.2814805927155;4947.901041979158;5036.899262014757;5066.378758797177;5087.364079490064;5107.361579802525;4029.798510074499;4035;4040.0303927057444;4044.292248856438;4067.3695577185586;3944.7435916665327;4030.415589739486;4058.147788964306;4073.6537394321517;4099.913522916429;3968.6229808168177;3990.8626041578154;3999.580044095357;4005.299072662287;4005.479287692596;3973.165635216579;3989.4414781930554;3999.2401443725744;4000.4799376080923;4003.2794097062515;3556.590992035923;3557.484164796116;3560.43033114703;3565.6969157621634;3578.8031658258788;4777.4267087949665;4965.6592719965765;4980.950190498085;4983.875403114951;5024.572911302544;4521.480029796583;4564.726116433025;4573.588377046049;4578.885527861797;4587.518310577375;5226.346706661668;5289.04305406998;5305.522502974751;5320.76056577455;5330.546903513206;3753.5871054184017;3837.9232415351535;3847.3074846527616;3854.5952674969285;3865.1254141741233;5475.780968761205;5497.230387745719;5511.807086751945;5518.641288316287;5522.806701765419;3944.2505923874373;3952.2490726761825;3954.2008386184216;3958.7426817256787;3975.7018223632763;3907.785071821077;4029.6097846243;4033.798310084484;4036.0918793271867;4041.333180025322;4542.682012259176;4546.931796023062;4549.749763763025;4551.3173024046655;4559.817607295671;5316.73416329182;5323.148296272578;5333.706646134422;5344.8663783404945;5361.329833770778;1315.8420989481324;1330.3547779327212;1345.2533843716635;1350.1763924006348;1377.882879955215;920.2270093121676;935.3312381647155;946.6450081219542;955.1308309438377;960.5293406230896;5134.204198349262;5136.948630513722;5143.76549628094;5149.485051494896;5152.3044389007755;5414.242006119146;5414.29614150158;5421.620486565903;5426.945730542644;5428.185772134211;4889.486603906538;5135.178371460548;5135.35808023997;5140.357455318085;5159.974200129051;2528;2538.5684433646325;2542.6694529711017;2555.258974897259;2572.9356766080996;4913.361263035782;4927.408710954636;4935.777889994959;4953.72754498506;4953.876153096201;4897.918384686565;4898.2652602109965;4922.926156107661;5263.3947096083675;5571.247881536022;5671.6597004179885;5690.829275121753;5692.31692196939;5696.743646535916;5704.543636509069;5481.3970463248215;5500.944990550043;5515.58633102527;5527.917081243865;5555.972220138873;5224.791008359775;5463.754131064032;5468.207109968953;5482.259894914295;5484.287042684426;5685.71571421419;5691.96261308753;5695.772169113189;5714.342850572071;5742;3851.5185601799776;3883.9417408738327;3886.3587508060855;3888.125171836314;3893.357595996629;5261.342332208474;5327.706976116351;5482.945170548243;5503.587230957774;5527.281453411031;5133.589312855037;5160.380754309507;5255.868603284948;5281.339832520935;5281.656692314988;5237.947620523899;5270.235815806764;5282.102042652681;5296.523312901857;5301.840944771663;5088.618353623567;5270.78916843322;5290.9735451322495;5314.309139811954;5366.168243922199;5302.70835104073;5306.336707911511;5312.920306195488;5316.30887984575;5327.493888080626;5140.254663073759;5164.690118592896;5179.637425380187;5203.791848326025;5219.347581552306 06:36:36 INFO - PROCESS | 22854 | |5;yui.html;614.0635530815507;625.6652690810417;627.3224917089544;667.0894229376902;668.7425341243622;12463;13068.281244531547;13567;13579.185248885075;13704.109232899855;12964.675883102927;13287;13304.866951330483;13314.800277995837;13320.467181312735;502.7561632608182;568.6985897474335;580.4253788749129;583.2563481561001;583.8978178818711;515.5720751776036;570.37543889441;579.7912751409489;584.52653350786;589.178096555305;613.6348872420903;615.9507239420858;617.9011358182692;618.4742968476804;621.0590954703628;524.6248932013591;615.0159744408954;615.6613862375675;616.4575173847009;616.7101462312728;393.3156308024046;434.036439105186;439.55165730954565;440.3812643236258;442.8826361014334;12195.39023048844;12252.632421027383;12260.26438413698;12637.178583392142;12653.936730316289;12856.22862628236;13060.412281447358;13863.37614807326;13958.860411395959;14074.929625351808;11066.39134847583;11167.609133680364;11575.247608905394;12070.69823254417;12305.26168429897;4296.205202037601;4312.137572485515;4371.475422949235;4399.780010999437;4566.06395688883;81470.59264703697;81999.18000819975;82221;82412;84591.57704211501;9642.146621658647;9654.903450965541;9724.70825875225;9807;10242.897571024343;16857.494275171764;17075.658486830194;17082.658346832995;17107;17109.657806843792;7573.924260757432;7649.235076492418;7778;7941.483803552751;7964.800879977931;4569.634429245719;4614.123316569908;4620.722756634613;4673;4767.594754445841;3157.17913342528;3272.5254838048827;3280.3767284215924;3292.8353582320788;3299.3896129216173;564.0467609739609;572.193207577314;586.2408181405091;591.9585629005928;598.8950386536833;445.11644385893976;461.3541042540403;525.853639066838;536.5921899356517;574.7902015764216;7383.852322953511;7769.3784497240085;7870.134285228621;8037.678492860337;8353.958230208931;475.9690620109682;506.3695698854876;564.1396869773628;579.1515429895223;594.215635361319;3897.2595206910596;3906.121122747416;4004.139110091286;4104.733192342488;4189.2459357315365;120384;120496.3975180136;122619;123503.38248308701;128073.35963320124;104961;105188;106577.46711266549;110686;111740;57963.4203657958;83504.05687118506;90228.54885725661;92033;94014.5299273513;7747.92252077472;7804.687812487664;7963.84072318562;7984.760457186294;8049.51702897828;54387;54678;55163.44836551743;55631;56904.43095569157;51702;82042;82200;84373.15626843653;84401.57799210964;10377.636782712569;10476.63331783384;10782.299150555189;10999.61501347449;11001;12306.692332691397;12526.686832829253;12576.119671623264;12994.285314307805;13407.530736424178;11657.300561966309;11806;11911.40442977865;12159.148859579744;12576.622701318975;12007.099467539794;12037.939810300892;12431.440585173508;12821.935890320488;12860.292683902475;12019.879801201876;12159.574414895436;12987.870121299044;12988.610341689764;12995.480180792661;9144;9461.146338430934;9516.19112375456;9622.326437149612;9838.097761160618;9361.625534978797;9821.116099551075;10122.898771012196;10221.540030698488;10228 06:36:36 INFO - PROCESS | 22854 | __end_tp_report 06:36:36 INFO - PROCESS | 22854 | __start_cc_report 06:36:36 INFO - PROCESS | 22854 | _x_x_mozilla_cycle_collect,952 06:36:36 INFO - PROCESS | 22854 | __end_cc_report 06:36:36 INFO - PROCESS | 22854 | __startTimestamp1475674596580__endTimestamp 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | ------- Summary: start ------- 06:36:36 INFO - PROCESS | 22854 | Number of tests: 6 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | [#0] dojo.html Cycles:165 Average:5193.07 Median:5334.00 stddev:569.37 (10.7%) stddev-sans-first:543.16 06:36:36 INFO - PROCESS | 22854 | Values: 2946.9 3022.4 3026.7 3048.5 3072.8 5147.2 5229.1 5255.3 5275.2 5334.6 5213.7 5254.1 5276.4 5329.6 5366.1 4787.9 4795.5 4805.1 4814.1 4912.3 4906.5 4931.6 4951.6 4955.2 4970.6 4733.6 4786.6 4798.4 4844.1 4907.9 4823.2 4837.6 4838.9 4839.6 4841.0 4792.1 4801.7 4811.2 4813.8 4819.6 5194.5 5234.7 5241.3 5248.1 5259.5 5552.3 5560.1 5562.9 5564.5 5566.2 5624.3 5642.9 5646.0 5647.9 5651.4 5198.2 5219.7 5238.2 5265.6 5266.3 5700.1 5717.2 5728.5 5796.1 5798.1 5541.7 5542.8 5548.1 5552.1 5559.5 5430.2 5452.5 5510.4 5561.3 5583.5 5522.4 5541.3 5543.0 5543.8 5552.7 5551.0 5560.5 5562.3 5566.3 5621.6 4240.4 4277.5 4286.2 4297.1 4307.1 3830.3 3860.5 3871.5 3885.2 3892.3 5256.7 5264.0 5274.1 5278.6 5334.2 5445.6 5539.5 5540.2 5544.3 5546.4 5162.4 5218.7 5221.1 5222.6 5303.1 4782.3 4789.3 4791.8 4795.8 4801.5 5625.6 5672.1 5692.0 5699.7 5700.5 5483.9 5558.9 5560.2 5646.5 5647.2 5824.6 5849.6 5861.3 5863.6 5917.7 5513.1 5527.7 5538.8 5540.7 5543.1 5461.9 5515.8 5566.7 5567.5 5609.3 5269.1 5312.1 5320.3 5329.8 5382.8 5321.3 5324.6 5327.4 5335.7 5397.6 5193.8 5270.4 5344.6 5391.7 5392.6 5451.9 5487.4 5492.7 5542.3 5558.5 5316.9 5334.0 5335.9 5338.3 5346.5 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | [#1] ext.html Cycles:180 Average:51819.30 Median:19261.75 stddev:105526.34 (547.9%) stddev-sans-first:105752.17 06:36:36 INFO - PROCESS | 22854 | Values: 554.7 561.7 565.5 569.1 575.3 28173.2 28786.3 31077.7 31109.4 31119.8 36627.1 37773.0 37813.6 40681.8 40869.8 8460.3 8597.2 8597.3 8597.6 8600.0 8445.8 8516.7 8533.1 8534.5 8535.4 8487.4 8556.9 8584.1 8621.0 8621.1 8476.7 8516.7 8525.7 8528.3 8540.7 8422.4 8492.3 8495.2 8497.0 8498.1 35554.6 36041.0 36050.5 36176.6 36220.6 2975.1 3000.5 3035.0 3177.5 3480.4 26928.6 27058.7 27178.2 27578.7 27784.9 4218.8 4231.9 4279.7 4305.1 4373.3 306776.0 308193.0 308360.0 308392.0 309076.0 45982.1 46477.8 46556.5 46577.5 46586.3 43463.6 44430.3 48277.3 48348.8 48459.2 12423.8 12689.0 14322.0 14706.3 14712.2 11431.0 11438.5 11485.4 11532.1 11539.8 13028.7 13169.5 13245.3 13337.9 13462.5 4816.9 5478.7 5487.1 5546.9 5593.7 810.0 899.4 903.5 935.7 952.2 26202.0 26970.3 27925.2 28076.4 28291.6 983.9 984.0 1023.7 1041.5 1072.1 14008.4 14355.8 14396.0 14877.1 15012.8 504012.0 505349.0 511198.0 512645.0 512789.0 46710.0 46803.8 46850.8 46855.0 46883.5 1072.4 1109.5 1121.2 1148.9 1174.4 23969.3 28087.0 28732.3 29108.6 31297.2 44919.0 45109.1 45449.0 45528.3 45584.5 341823.0 344229.0 344433.0 344595.0 344700.0 24072.6 24634.1 24702.3 24792.5 26130.9 38092.0 38802.6 39220.0 39283.1 39688.6 32059.0 33803.8 34069.5 34330.0 35043.1 32996.7 33955.8 34298.7 34650.5 35353.0 33848.2 34224.0 34327.7 34714.1 34793.5 26636.6 28190.9 28560.4 28657.9 28724.9 24167.9 24442.6 24502.6 24650.3 24852.5 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | [#2] jquery.html Cycles:180 Average:27463.46 Median:2247.14 stddev:73692.17 (3279.4%) stddev-sans-first:73870.80 06:36:36 INFO - PROCESS | 22854 | Values: 361.3 369.9 386.3 386.6 409.4 13462.0 16771.3 17498.1 17787.4 18631.5 15720.0 16518.5 16558.8 16619.8 16623.2 5386.3 5918.8 6214.7 6233.3 6342.2 3831.3 4040.5 6292.2 6334.7 6335.7 3921.1 6193.1 6226.5 6306.1 6306.4 6304.0 6310.4 6310.6 6726.6 7055.3 6813.6 6919.0 6928.2 6947.3 6954.0 22687.8 23081.8 23177.7 23473.6 23709.6 2564.5 2627.7 2697.7 2751.9 2854.8 13938.4 14202.4 14322.9 14421.5 15188.9 1906.7 1921.0 1943.3 1965.9 2009.5 91201.0 91829.5 91912.5 91988.5 92048.0 8822.6 9498.9 9582.0 9681.9 9704.4 12899.7 12942.2 12947.0 12978.7 12980.0 7047.8 7214.0 7247.6 7368.3 7426.8 6848.6 6947.0 7156.3 7170.9 7175.0 3879.6 3994.1 3999.3 4083.0 4084.9 1905.2 1911.6 1914.0 1932.7 1960.3 792.2 800.2 849.2 852.6 888.1 16786.9 17423.1 17866.8 17931.1 17936.9 862.5 876.6 877.7 899.1 910.0 9087.5 9755.4 9797.3 9838.0 9890.7 435444.0 436672.0 438638.0 454230.0 454831.0 88297.6 88363.0 88388.0 89168.0 89753.6 871.6 885.2 887.9 888.3 891.5 15469.2 15693.3 15746.2 15893.6 16075.6 40347.4 40573.0 40668.8 41588.8 41790.8 53915.7 54839.7 54858.9 56692.4 57529.0 7885.6 7932.2 7958.6 8148.6 8269.0 10990.8 11633.7 11652.5 11869.2 11992.5 10060.5 10556.8 10904.5 10915.6 11221.8 9928.5 10270.8 10296.0 10694.6 10793.5 9920.7 9926.6 10537.0 10599.6 10910.4 8072.2 10772.4 10967.7 11037.0 11421.3 10626.3 10902.1 10914.0 11224.0 11814.9 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | [#3] mootools.html Cycles:180 Average:5703.86 Median:4963.23 stddev:3395.27 (68.4%) stddev-sans-first:3387.37 06:36:36 INFO - PROCESS | 22854 | Values: 1125.9 1187.0 1198.7 1251.3 1407.4 7431.0 8172.1 8381.9 8449.2 8692.0 8484.3 8495.0 8517.7 8553.7 8563.7 2258.9 2284.0 2286.9 2288.6 2293.6 2221.5 2275.9 2288.2 2288.3 2290.1 2255.4 2272.8 2282.6 2288.5 2298.5 2193.0 2204.8 2205.6 2217.9 2218.0 2211.3 2219.2 2219.6 2224.0 2230.5 8594.7 8778.9 8798.0 8798.3 8804.6 5017.8 5185.3 5191.7 5252.3 5259.9 3321.9 3548.5 3594.9 3616.8 3627.1 1199.3 1235.8 1242.2 1259.2 1282.3 12826.5 12861.7 12916.0 12918.9 12922.5 4111.9 4332.3 4411.2 4498.0 4502.3 9481.9 9485.5 9495.3 9500.4 9502.2 5050.0 5055.4 5060.6 5060.6 5063.3 4247.1 4390.6 4620.1 4718.9 4750.4 3581.0 3614.9 3646.3 3681.4 3736.8 1118.2 1121.4 1129.4 1142.3 1142.9 829.6 830.7 850.5 854.8 855.0 5377.1 5592.4 5712.0 5781.8 5804.3 782.9 789.2 791.4 793.6 873.6 3591.8 3650.7 3661.4 3723.2 3814.4 10880.8 11348.8 11556.1 11597.1 11632.7 11415.1 11604.5 11624.8 11626.5 11628.4 8108.6 8120.9 8173.1 8239.8 8262.6 5416.4 5453.8 5476.2 5608.5 5711.7 10296.3 10330.3 10353.6 10459.9 10553.7 10594.4 10671.4 10733.5 10769.5 10795.1 6506.8 6663.9 6737.4 7197.4 7340.7 7810.1 8292.7 8395.5 8576.2 8604.3 7468.3 7497.1 7688.1 7692.7 7866.3 7364.0 7488.7 7567.3 7643.5 7669.0 6718.0 6819.8 6825.5 6829.6 6830.6 4999.9 5055.8 5166.5 5211.7 5269.5 4926.6 5025.7 5050.9 5157.7 5195.9 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | [#4] prototype.html Cycles:180 Average:4458.49 Median:5097.99 stddev:1305.59 (25.6%) stddev-sans-first:1271.42 06:36:36 INFO - PROCESS | 22854 | Values: 301.1 307.2 314.5 316.0 319.5 4975.8 5025.7 5115.6 5119.6 5132.3 4947.9 5036.9 5066.4 5087.4 5107.4 4029.8 4035.0 4040.0 4044.3 4067.4 3944.7 4030.4 4058.1 4073.7 4099.9 3968.6 3990.9 3999.6 4005.3 4005.5 3973.2 3989.4 3999.2 4000.5 4003.3 3556.6 3557.5 3560.4 3565.7 3578.8 4777.4 4965.7 4981.0 4983.9 5024.6 4521.5 4564.7 4573.6 4578.9 4587.5 5226.3 5289.0 5305.5 5320.8 5330.5 3753.6 3837.9 3847.3 3854.6 3865.1 5475.8 5497.2 5511.8 5518.6 5522.8 3944.3 3952.2 3954.2 3958.7 3975.7 3907.8 4029.6 4033.8 4036.1 4041.3 4542.7 4546.9 4549.7 4551.3 4559.8 5316.7 5323.1 5333.7 5344.9 5361.3 1315.8 1330.4 1345.3 1350.2 1377.9 920.2 935.3 946.6 955.1 960.5 5134.2 5136.9 5143.8 5149.5 5152.3 5414.2 5414.3 5421.6 5426.9 5428.2 4889.5 5135.2 5135.4 5140.4 5160.0 2528.0 2538.6 2542.7 2555.3 2572.9 4913.4 4927.4 4935.8 4953.7 4953.9 4897.9 4898.3 4922.9 5263.4 5571.2 5671.7 5690.8 5692.3 5696.7 5704.5 5481.4 5500.9 5515.6 5527.9 5556.0 5224.8 5463.8 5468.2 5482.3 5484.3 5685.7 5692.0 5695.8 5714.3 5742.0 3851.5 3883.9 3886.4 3888.1 3893.4 5261.3 5327.7 5482.9 5503.6 5527.3 5133.6 5160.4 5255.9 5281.3 5281.7 5237.9 5270.2 5282.1 5296.5 5301.8 5088.6 5270.8 5291.0 5314.3 5366.2 5302.7 5306.3 5312.9 5316.3 5327.5 5140.3 5164.7 5179.6 5203.8 5219.3 06:36:36 INFO - PROCESS | 22854 | 06:36:36 INFO - PROCESS | 22854 | [#5] yui.html Cycles:180 Average:20699.79 Median:2515.49 stddev:32088.28 (1275.6%) stddev-sans-first:32142.86 06:36:36 INFO - PROCESS | 22854 | Values: 614.1 625.7 627.3 667.1 668.7 12463.0 13068.3 13567.0 13579.2 13704.1 12964.7 13287.0 13304.9 13314.8 13320.5 502.8 568.7 580.4 583.3 583.9 515.6 570.4 579.8 584.5 589.2 613.6 616.0 617.9 618.5 621.1 524.6 615.0 615.7 616.5 616.7 393.3 434.0 439.6 440.4 442.9 12195.4 12252.6 12260.3 12637.2 12653.9 12856.2 13060.4 13863.4 13958.9 14074.9 11066.4 11167.6 11575.2 12070.7 12305.3 4296.2 4312.1 4371.5 4399.8 4566.1 81470.6 81999.2 82221.0 82412.0 84591.6 9642.1 9654.9 9724.7 9807.0 10242.9 16857.5 17075.7 17082.7 17107.0 17109.7 7573.9 7649.2 7778.0 7941.5 7964.8 4569.6 4614.1 4620.7 4673.0 4767.6 3157.2 3272.5 3280.4 3292.8 3299.4 564.0 572.2 586.2 592.0 598.9 445.1 461.4 525.9 536.6 574.8 7383.9 7769.4 7870.1 8037.7 8354.0 476.0 506.4 564.1 579.2 594.2 3897.3 3906.1 4004.1 4104.7 4189.2 120384.0 120496.4 122619.0 123503.4 128073.4 104961.0 105188.0 106577.5 110686.0 111740.0 57963.4 83504.1 90228.5 92033.0 94014.5 7747.9 7804.7 7963.8 7984.8 8049.5 54387.0 54678.0 55163.4 55631.0 56904.4 51702.0 82042.0 82200.0 84373.2 84401.6 10377.6 10476.6 10782.3 10999.6 11001.0 12306.7 12526.7 12576.1 12994.3 13407.5 11657.3 11806.0 11911.4 12159.1 12576.6 12007.1 12037.9 12431.4 12821.9 12860.3 12019.9 12159.6 12987.9 12988.6 12995.5 9144.0 9461.1 9516.2 9622.3 9838.1 9361.6 9821.1 10122.9 10221.5 10228.0 06:36:36 INFO - PROCESS | 22854 | -------- Summary: end -------- 06:36:36 INFO - PROCESS | 22854 | 06:36:37 INFO - TEST-INFO | 22854: exit 0 06:36:37 INFO - TEST-OK | dromaeo_css | took 1118558ms 06:36:37 INFO - TEST-START | kraken 06:36:37 INFO - operating with platform_type : linux_ 06:36:37 INFO - Initialising browser for kraken test... 06:36:37 INFO - TEST-INFO | started process 23160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphzos9S/profile http://localhost:33246/getInfo.html) 06:36:42 INFO - PROCESS | 23160 | __metrics Screen width/height:1600/1200 06:36:42 INFO - PROCESS | 23160 | colorDepth:24 06:36:42 INFO - PROCESS | 23160 | Browser inner width/height: 1024/697 06:36:42 INFO - PROCESS | 23160 | __metrics 06:36:42 INFO - PROCESS | 23160 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:36:42 INFO - PROCESS | 23160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:43 INFO - PROCESS | 23160 | console.error: PushService: 06:36:43 INFO - PROCESS | 23160 | stateChangeProcessEnqueue: Error transitioning state 06:36:43 INFO - PROCESS | 23160 | UnknownError 06:36:44 INFO - TEST-INFO | 23160: exit 0 06:36:44 INFO - Browser initialized. 06:36:44 INFO - Running cycle 1/1 for kraken test... 06:36:44 INFO - TEST-INFO | started process 23247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphzos9S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:56 INFO - PROCESS | 23247 | RSS: Main: 173740032 06:36:56 INFO - PROCESS | 23247 | 06:36:58 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33246/tests/kraken/driver.html?testName=audio-beat-detection) 06:36:59 INFO - PROCESS | 23247 | RSS: Main: 233234432 06:36:59 INFO - PROCESS | 23247 | 06:37:02 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33246/tests/kraken/driver.html?testName=audio-dft) 06:37:02 INFO - PROCESS | 23247 | RSS: Main: 218038272 06:37:02 INFO - PROCESS | 23247 | 06:37:06 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33246/tests/kraken/driver.html?testName=audio-fft) 06:37:06 INFO - PROCESS | 23247 | RSS: Main: 299524096 06:37:06 INFO - PROCESS | 23247 | 06:37:08 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33246/tests/kraken/driver.html?testName=audio-oscillator) 06:37:09 INFO - PROCESS | 23247 | RSS: Main: 208244736 06:37:09 INFO - PROCESS | 23247 | 06:37:11 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:37:12 INFO - PROCESS | 23247 | RSS: Main: 213450752 06:37:12 INFO - PROCESS | 23247 | 06:37:15 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33246/tests/kraken/driver.html?testName=imaging-darkroom) 06:37:15 INFO - PROCESS | 23247 | RSS: Main: 249978880 06:37:15 INFO - PROCESS | 23247 | 06:37:19 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33246/tests/kraken/driver.html?testName=imaging-desaturate) 06:37:19 INFO - PROCESS | 23247 | RSS: Main: 248942592 06:37:19 INFO - PROCESS | 23247 | 06:37:22 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33246/tests/kraken/driver.html?testName=json-parse-financial) 06:37:23 INFO - PROCESS | 23247 | RSS: Main: 248180736 06:37:23 INFO - PROCESS | 23247 | 06:37:24 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:37:25 INFO - PROCESS | 23247 | RSS: Main: 210083840 06:37:25 INFO - PROCESS | 23247 | 06:37:27 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:37:27 INFO - PROCESS | 23247 | RSS: Main: 217591808 06:37:27 INFO - PROCESS | 23247 | 06:37:29 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:37:30 INFO - PROCESS | 23247 | RSS: Main: 227106816 06:37:30 INFO - PROCESS | 23247 | 06:37:32 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:37:33 INFO - PROCESS | 23247 | RSS: Main: 236158976 06:37:33 INFO - PROCESS | 23247 | 06:37:36 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:37:37 INFO - PROCESS | 23247 | RSS: Main: 233316352 06:37:37 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | Cycle 1(1): loaded http://localhost:33246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33246/tests/kraken/driver.html?testName=ai-astar) 06:37:38 INFO - PROCESS | 23247 | RSS: Main: 283475968 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | __start_tp_report 06:37:38 INFO - PROCESS | 23247 | _x_x_mozilla_page_load 06:37:38 INFO - PROCESS | 23247 | _x_x_mozilla_page_load_details 06:37:38 INFO - PROCESS | 23247 | |i|pagename|runs| 06:37:38 INFO - PROCESS | 23247 | |0;ai-astar;109;110;111;110;111;111;111;112;110;111 06:37:38 INFO - PROCESS | 23247 | |1;audio-beat-detection;152;129;123;167;123;128;127;128;156;124 06:37:38 INFO - PROCESS | 23247 | |2;audio-dft;162;163;161;162;166;161;161;162;162;160 06:37:38 INFO - PROCESS | 23247 | |3;audio-fft;77;76;76;117;76;76;77;77;106;77 06:37:38 INFO - PROCESS | 23247 | |4;audio-oscillator;83;83;106;82;83;83;103;82;82;106 06:37:38 INFO - PROCESS | 23247 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;117 06:37:38 INFO - PROCESS | 23247 | |6;imaging-darkroom;145;145;148;148;147;145;145;146;146;146 06:37:38 INFO - PROCESS | 23247 | |7;imaging-desaturate;95;95;95;94;95;96;95;96;96;96 06:37:38 INFO - PROCESS | 23247 | |8;json-parse-financial;54;50;50;51;50;53;52;51;52;52 06:37:38 INFO - PROCESS | 23247 | |9;json-stringify-tinderbox;61;61;61;61;62;62;61;62;63;66 06:37:38 INFO - PROCESS | 23247 | |10;stanford-crypto-aes;80;81;79;79;80;80;80;80;80;80 06:37:38 INFO - PROCESS | 23247 | |11;stanford-crypto-ccm;136;133;131;129;128;129;146;139;164;140 06:37:38 INFO - PROCESS | 23247 | |12;stanford-crypto-pbkdf2;167;167;165;166;167;166;166;166;163;164 06:37:38 INFO - PROCESS | 23247 | |13;stanford-crypto-sha256-iterative;66;66;66;65;65;69;66;63;66;74 06:37:38 INFO - PROCESS | 23247 | __end_tp_report 06:37:38 INFO - PROCESS | 23247 | __start_cc_report 06:37:38 INFO - PROCESS | 23247 | _x_x_mozilla_cycle_collect,1650 06:37:38 INFO - PROCESS | 23247 | __end_cc_report 06:37:38 INFO - PROCESS | 23247 | __startTimestamp1475674658944__endTimestamp 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | ------- Summary: start ------- 06:37:38 INFO - PROCESS | 23247 | Number of tests: 14 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:0.84 (0.8%) stddev-sans-first:0.67 06:37:38 INFO - PROCESS | 23247 | Values: 109.0 110.0 111.0 110.0 111.0 111.0 111.0 112.0 110.0 111.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:128.50 stddev:16.18 (12.6%) stddev-sans-first:16.05 06:37:38 INFO - PROCESS | 23247 | Values: 152.0 129.0 123.0 167.0 123.0 128.0 127.0 128.0 156.0 124.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 06:37:38 INFO - PROCESS | 23247 | Values: 162.0 163.0 161.0 162.0 166.0 161.0 161.0 162.0 162.0 160.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:14.99 (19.6%) stddev-sans-first:15.71 06:37:38 INFO - PROCESS | 23247 | Values: 77.0 76.0 76.0 117.0 76.0 76.0 77.0 77.0 106.0 77.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.50 stddev:10.87 (13.2%) stddev-sans-first:11.29 06:37:38 INFO - PROCESS | 23247 | Values: 83.0 83.0 106.0 82.0 83.0 83.0 103.0 82.0 82.0 106.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:37:38 INFO - PROCESS | 23247 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 06:37:38 INFO - PROCESS | 23247 | Values: 145.0 145.0 148.0 148.0 147.0 145.0 145.0 146.0 146.0 146.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:37:38 INFO - PROCESS | 23247 | Values: 95.0 95.0 95.0 94.0 95.0 96.0 95.0 96.0 96.0 96.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.35 (2.6%) stddev-sans-first:1.09 06:37:38 INFO - PROCESS | 23247 | Values: 54.0 50.0 50.0 51.0 50.0 53.0 52.0 51.0 52.0 52.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.56 (2.5%) stddev-sans-first:1.62 06:37:38 INFO - PROCESS | 23247 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 63.0 66.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 06:37:38 INFO - PROCESS | 23247 | Values: 80.0 81.0 79.0 79.0 80.0 80.0 80.0 80.0 80.0 80.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:137.50 stddev:10.97 (8.0%) stddev-sans-first:11.62 06:37:38 INFO - PROCESS | 23247 | Values: 136.0 133.0 131.0 129.0 128.0 129.0 146.0 139.0 164.0 140.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 06:37:38 INFO - PROCESS | 23247 | Values: 167.0 167.0 165.0 166.0 167.0 166.0 166.0 166.0 163.0 164.0 06:37:38 INFO - PROCESS | 23247 | 06:37:38 INFO - PROCESS | 23247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:2.99 (4.5%) stddev-sans-first:3.16 06:37:38 INFO - PROCESS | 23247 | Values: 66.0 66.0 66.0 65.0 65.0 69.0 66.0 63.0 66.0 74.0 06:37:38 INFO - PROCESS | 23247 | -------- Summary: end -------- 06:37:38 INFO - PROCESS | 23247 | 06:37:40 INFO - TEST-INFO | 23247: exit 0 06:37:40 INFO - TEST-OK | kraken | took 62579ms 06:37:40 INFO - SUITE-END | took 1181s 06:37:40 INFO - Completed test suite (00:19:41) 06:37:40 INFO - javascript benchmark 06:37:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2946.9410611787766, 3022.350194708137, 3026.71246231608, 3048.542718592212, 3072.754179665627, 5147.22791581263, 5229.058769421507, 5255.290535777669, 5275.182346736257, 5334.599905007125, 5213.687178769267, 5254.054270231357, 5276.419593844674, 5329.573634109272, 5366.087765079936, 4787.928181077286, 4795.472498025214, 4805.087033463648, 4814.1334559779225, 4912.263160525914, 4906.509349065101, 4931.630127740415, 4951.603871690256, 4955.207166853304, 4970.552650261476, 4733.644976626767, 4786.593139583105, 4798.376211092553, 4844.055409195208, 4907.852764417074, 4823.20417131173, 4837.564619184291, 4838.927416088762, 4839.588634966032, 4841.0, 4792.065547218293, 4801.663883528155, 4811.158047341736, 4813.807447702087, 4819.614430845524, 5194.532492075694, 5234.659747116425, 5241.318628578299, 5248.081585722483, 5259.526642602146, 5552.333719953632, 5560.138178582326, 5562.916556251659, 5564.4713752193475, 5566.165075238706, 5624.29696287964, 5642.915356269659, 5646.0, 5647.887042259173, 5651.40660230674, 5198.194279886624, 5219.739013049409, 5238.161894096965, 5265.631405801595, 5266.315379000705, 5700.144978253295, 5717.22817419643, 5728.541716662657, 5796.072628379439, 5798.101294299306, 5541.722913854291, 5542.8337149885565, 5548.0845660466375, 5552.139418390156, 5559.499645031886, 5430.185472179205, 5452.536534394541, 5510.448955104538, 5561.277033985556, 5583.469570390806, 5522.447755224526, 5541.251930989265, 5542.972285138549, 5543.833684989457, 5552.666839989613, 5550.972245138829, 5560.499555040065, 5562.3047119110115, 5566.332040155207, 5621.550275977912, 4240.427542281815, 4277.529471758104, 4286.207051695446, 4297.140571885635, 4307.095509942885, 3830.3296923038356, 3860.4595356650093, 3871.5160604924386, 3885.203533275672, 3892.3188442022533, 5256.737163141827, 5263.973680131575, 5274.129768588216, 5278.630495865253, 5334.1732031535175, 5445.618806683494, 5539.5014448699, 5540.196671482693, 5544.279243698374, 5546.389897111395, 5162.406323272797, 5218.669239343943, 5221.060209162311, 5222.634415590948, 5303.098473259555, 4782.282657601388, 4789.3294938708605, 4791.760411979457, 4795.808167673324, 4801.4718380978065, 5625.634333768292, 5672.12082127271, 5692.032354499662, 5699.686517241508, 5700.543956483389, 5483.862903427286, 5558.91661625084, 5560.2493663356545, 5646.520045796154, 5647.237622920853, 5824.592278540462, 5849.590528663123, 5861.296644402699, 5863.648181109147, 5917.704114794329, 5513.145462453326, 5527.723613819373, 5538.778448862, 5540.69526176048, 5543.057680194457, 5461.9180712290145, 5515.834524964257, 5566.693831839288, 5567.526760225426, 5609.27079479665, 5269.130593452038, 5312.123499622519, 5320.255164276927, 5329.813456529158, 5382.811601593926, 5321.255024296524, 5324.6006549508165, 5327.360716714019, 5335.67985920846, 5397.595180361567, 5193.792248310026, 5270.367555893317, 5344.572434205332, 5391.730413479232, 5392.595555333444, 5451.863703407446, 5487.368952570346, 5492.725363731877, 5542.334919809648, 5558.527525160245, 5316.867078323073, 5334.0, 5335.919961200508, 5338.279332290246, 5346.545543628835], "value": 5155.5492753515655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7365001624231, 561.6573889927145, 565.5362602665813, 569.0780934885486, 575.252172176171, 28173.154805355847, 28786.280342991435, 31077.66917481187, 31109.377812443738, 31119.844400777965, 36627.084322891875, 37773.0, 37813.62186378135, 40681.796591017, 40869.79565102178, 8460.280876125522, 8597.226249637532, 8597.269232115246, 8597.61310741015, 8600.0, 8445.788855278606, 8516.74449766508, 8533.061363250037, 8534.530600816952, 8535.402521823475, 8487.44831585948, 8556.914430855673, 8584.05575386707, 8620.956895215515, 8621.094785047573, 8476.66093356265, 8516.659333626647, 8525.658973641079, 8528.317734581218, 8540.70107546233, 8422.399744048673, 8492.320614350838, 8495.235428811375, 8497.0, 8498.065212826585, 35554.64445355565, 36041.0, 36050.45924311138, 36176.63823361759, 36220.63779362199, 2975.1074677596853, 3000.4599172149005, 3034.9696503034907, 3177.53925680775, 3480.3735327641016, 26928.59607105895, 27058.729412706016, 27178.184654460398, 27578.724212757817, 27784.86107569449, 4218.831246750126, 4231.87304380869, 4279.679024073176, 4305.138972205571, 4373.300271956472, 306776.0, 308193.0, 308360.0, 308392.0, 309076.0, 45982.080358392646, 46477.7676111624, 46556.53443465522, 46577.534224658, 46586.30120548195, 43463.565364346585, 44430.33354499685, 48277.275840862414, 48348.75825620849, 48459.18489781249, 12423.75152496945, 12689.0, 14322.0, 14706.33821478036, 14712.19082950448, 11431.0, 11438.542458301741, 11485.449464322377, 11532.135089868294, 11539.826902596467, 13028.739425211443, 13169.53906613264, 13245.337733113305, 13337.866621333662, 13462.461501539829, 4816.866879137044, 5478.698671573102, 5487.122060470386, 5546.944530554723, 5593.664380137205, 809.9554524501209, 899.4288626721948, 903.5482258870434, 935.6818681648273, 952.1573407534382, 26202.0, 26970.32574185661, 27925.16224513268, 28076.43847123046, 28291.575626365622, 983.8819341679044, 984.0, 1023.6775415744016, 1041.463646222196, 1072.0780129088978, 14008.369623366973, 14355.78466323006, 14396.043256934006, 14877.107373557405, 15012.849871501363, 504012.0, 505349.0, 511198.0, 512645.0, 512789.0, 46710.0, 46803.765981169876, 46850.76574617173, 46855.0, 46883.5311646886, 1072.420892717939, 1109.4730003248392, 1121.1871393239999, 1148.942552872353, 1174.395186478964, 23969.28092157238, 28087.0, 28732.281692957844, 29108.563371549866, 31297.217569560944, 44919.0, 45109.09781804411, 45449.0, 45528.317075243234, 45584.54415455936, 341823.0, 344229.0, 344433.0, 344595.0, 344700.0, 24072.638910416706, 24634.13780517673, 24702.25893223206, 24792.504149916538, 26130.86934565315, 38092.017583990615, 38802.61197388103, 39220.0, 39283.08961379828, 39688.60311396964, 32059.0, 33803.83098084494, 34069.48895766615, 34330.0, 35043.12392190216, 32996.67003329936, 33955.83022084874, 34298.657013430544, 34650.48024279587, 35353.0, 33848.15379615431, 34224.0, 34327.65672343344, 34714.13214669654, 34793.47809782805, 26636.60045099364, 28190.85904570464, 28560.42879142447, 28657.856710716314, 28724.856375717987, 24167.879160604083, 24442.63336049925, 24502.63246051275, 24650.26049218526, 24852.50294994054], "value": 17262.865378279745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.3080949980787, 369.8723940240619, 386.31814846795413, 386.5651142464727, 409.41044895350694, 13462.0, 16771.329146834127, 17498.125093745308, 17787.377441789507, 18631.53421164468, 15719.9782014169, 16518.504444866645, 16558.83441165588, 16619.83380166198, 16623.168841557905, 5386.326709161355, 5918.763249470037, 6214.694914068028, 6233.252009758835, 6342.207224096988, 3831.252905683393, 4040.4949381327333, 6292.18201633787, 6334.683265836713, 6335.651539165344, 3921.1177485065773, 6193.102000209967, 6226.533010024244, 6306.1171435998995, 6306.36936306368, 6303.968480157593, 6310.4320611144985, 6310.558260921737, 6726.562773419712, 7055.25919778421, 6813.591184528944, 6919.031335613018, 6928.16861976561, 6947.305269473063, 6953.965230173867, 22687.773122268733, 23081.769182308297, 23177.652335214985, 23473.647895281585, 23709.644355334683, 2564.4614630927526, 2627.710951795301, 2697.652633624481, 2751.917442476729, 2854.771618270554, 13938.442462301497, 14202.360893759806, 14322.856771432256, 14421.495247666386, 15188.924055379652, 1906.6643361881722, 1921.0, 1943.3295513047976, 1965.9017049147485, 2009.5277609761695, 91201.0, 91829.54085229531, 91912.54043729739, 91988.54005729995, 92048.0, 8822.558872056372, 9498.905010949802, 9582.0, 9681.903180968242, 9704.369216000938, 12899.742005160031, 12942.223466592035, 12946.96424286055, 12978.66384050861, 12980.0, 7047.788566343018, 7214.0, 7247.601381924045, 7368.300011498899, 7426.774582193985, 6848.623325717133, 6946.9579563064935, 7156.284371562906, 7170.856582868418, 7174.964125179341, 3879.573246942834, 3994.107218657122, 3999.320115580358, 4083.0, 4084.875864550417, 1905.1902941249914, 1911.5603411215498, 1913.9712904306446, 1932.700431433102, 1960.2649006622516, 792.1523969352737, 800.1798156889118, 849.2017503546647, 852.6163226548078, 888.138505649519, 16786.91606541984, 17423.12884355777, 17866.846478789586, 17931.103444827706, 17936.91031544834, 862.4868203419081, 876.588003638289, 877.7147427086222, 899.0874262623443, 910.0, 9087.454752714859, 9755.365901216399, 9797.265205109503, 9838.0, 9890.653827116017, 435444.0, 436672.0, 438638.0, 454230.0, 454831.0, 88297.55851220703, 88363.0, 88388.0, 89168.0, 89753.55123224342, 871.6121326009865, 885.2342723544217, 887.933404994628, 888.311558542135, 891.5497673674882, 15469.226538672796, 15693.293801779175, 15746.212689365715, 15893.602659933595, 16075.598110047342, 40347.394789078775, 40573.0, 40668.79665601653, 41588.79205604074, 41790.79104604458, 53915.730421347645, 54839.72580137233, 54858.93572552616, 56692.433075670364, 57529.0, 7885.566293853663, 7932.206779322252, 7958.562279074707, 8148.633311501115, 8268.958655206685, 10990.780184396428, 11633.6509904703, 11652.494713636608, 11869.169158158846, 11992.520299187934, 10060.49697515136, 10556.841647375142, 10904.454777261264, 10915.617953371593, 11221.831672525082, 9928.453935033642, 10270.794584108426, 10296.0, 10694.572217111228, 10793.514291856729, 9920.652777153055, 9926.553305101143, 10537.0, 10599.629012984817, 10910.399928004035, 8072.233137851895, 10772.353658780497, 10967.725806854893, 11037.0, 11421.31472111676, 10626.309289896131, 10902.127829773757, 10913.957820404541, 11224.0, 11814.881851181379], "value": 8881.29478172717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1125.9211855170142, 1186.9791978898147, 1198.7063169523467, 1251.3180316727385, 1407.4299908537039, 7430.962845185773, 8172.101068882425, 8381.87427188592, 8449.23956843884, 8692.0, 8484.321254299657, 8495.0, 8517.701880434186, 8553.743387698363, 8563.657453701844, 2258.8644681319133, 2284.017872314904, 2286.8970896309625, 2288.553732022256, 2293.6330187170056, 2221.466847956487, 2275.8862056897174, 2288.21056735426, 2288.329519450802, 2290.1183044527893, 2255.379770563092, 2272.761360057195, 2282.6233671444193, 2288.519410923708, 2298.5173113646156, 2193.0350645715835, 2204.7574766775642, 2205.6250437425674, 2217.922372716955, 2217.9889100554474, 2211.259228158569, 2219.212179676208, 2219.633760429543, 2223.977760222393, 2230.4535388829677, 8594.742157735278, 8778.912210877874, 8797.956010219972, 8798.340124490689, 8804.559772011438, 5017.774200161001, 5185.325907632021, 5191.740412979374, 5252.3171987641745, 5259.947400525984, 3321.9003429897143, 3548.4854696068924, 3594.9281014379826, 3616.8372423241017, 3627.0569651890432, 1199.3044034459992, 1235.839340885688, 1242.2111958906069, 1259.1941157659105, 1282.3331867428885, 12826.486940522367, 12861.742765144738, 12916.0, 12918.870811291861, 12922.54771083017, 4111.8972025699595, 4332.285172946492, 4411.20598292304, 4497.977510112429, 4502.257127573914, 9481.857772133424, 9485.478298693639, 9495.335326527076, 9500.42997420157, 9502.192313653279, 5050.0, 5055.443901170868, 5060.5698515625845, 5060.645754797202, 5063.3417655704525, 4247.086876321606, 4390.604845563851, 4620.0990806793025, 4718.905621887543, 4750.358701575312, 3580.9820950895078, 3614.945775813365, 3646.2707458508403, 3681.37416639172, 3736.831842567091, 1118.2060736876908, 1121.3664279682116, 1129.3849794793525, 1142.3203194099497, 1142.8971392574708, 829.5976451421056, 830.6511265268481, 850.4557083466586, 854.8290341931638, 854.9529775862263, 5377.085895397791, 5592.412796656293, 5712.0, 5781.768729250867, 5804.332501762351, 782.8864814601851, 789.1989630525022, 791.3748138970265, 793.5556088590292, 873.5501216873315, 3591.7844929304324, 3650.7079433645245, 3661.359262129117, 3723.236736469017, 3814.389697648363, 10880.78238435227, 11348.829767553329, 11556.133290003283, 11597.072234221241, 11632.651020469399, 11415.086793056536, 11604.535818567332, 11624.767504649859, 11626.53493860253, 11628.372027916099, 8108.635111420001, 8120.878186827203, 8173.060098088677, 8239.752807415787, 8262.628181731836, 5416.350037995308, 5453.7818487260065, 5476.205950137288, 5608.495235428831, 5711.714414279352, 10296.279260451696, 10330.328528645614, 10353.63762268317, 10459.947700261755, 10553.73615659584, 10594.364338139736, 10671.432472013119, 10733.516991735547, 10769.515371808131, 10795.136389089012, 6506.772262970773, 6663.933360666331, 6737.3599508046655, 7197.352238298578, 7340.669669864762, 7810.140884502586, 8292.668293268202, 8395.454295470774, 8576.228139467477, 8604.268637165911, 7468.3278504934815, 7497.10034795828, 7688.115866675404, 7692.730754423568, 7866.331361834308, 7363.963180184065, 7488.700451981859, 7567.31894129531, 7643.541387516767, 7669.0, 6717.966410167918, 6819.795406137824, 6825.488088393291, 6829.590224586541, 6830.624315662686, 4999.900002000012, 5055.845977941172, 5166.535011848951, 5211.6872987619345, 5269.525742683177, 4926.556609905126, 5025.673331233458, 5050.949490505048, 5157.742112894265, 5195.870103247449], "value": 4481.876153100732, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.07569760834247, 307.18442535069386, 314.4606998996723, 315.9589253397058, 319.4569232305082, 4975.7857753299795, 5025.748712564371, 5115.590752739781, 5119.616028797841, 5132.2814805927155, 4947.901041979158, 5036.899262014757, 5066.378758797177, 5087.364079490064, 5107.361579802525, 4029.798510074499, 4035.0, 4040.0303927057444, 4044.292248856438, 4067.3695577185586, 3944.7435916665327, 4030.415589739486, 4058.147788964306, 4073.6537394321517, 4099.913522916429, 3968.6229808168177, 3990.8626041578154, 3999.580044095357, 4005.299072662287, 4005.479287692596, 3973.165635216579, 3989.4414781930554, 3999.2401443725744, 4000.4799376080923, 4003.2794097062515, 3556.590992035923, 3557.484164796116, 3560.43033114703, 3565.6969157621634, 3578.8031658258788, 4777.4267087949665, 4965.6592719965765, 4980.950190498085, 4983.875403114951, 5024.572911302544, 4521.480029796583, 4564.726116433025, 4573.588377046049, 4578.885527861797, 4587.518310577375, 5226.346706661668, 5289.04305406998, 5305.522502974751, 5320.76056577455, 5330.546903513206, 3753.5871054184017, 3837.9232415351535, 3847.3074846527616, 3854.5952674969285, 3865.1254141741233, 5475.780968761205, 5497.230387745719, 5511.807086751945, 5518.641288316287, 5522.806701765419, 3944.2505923874373, 3952.2490726761825, 3954.2008386184216, 3958.7426817256787, 3975.7018223632763, 3907.785071821077, 4029.6097846243, 4033.798310084484, 4036.0918793271867, 4041.333180025322, 4542.682012259176, 4546.931796023062, 4549.749763763025, 4551.3173024046655, 4559.817607295671, 5316.73416329182, 5323.148296272578, 5333.706646134422, 5344.8663783404945, 5361.329833770778, 1315.8420989481324, 1330.3547779327212, 1345.2533843716635, 1350.1763924006348, 1377.882879955215, 920.2270093121676, 935.3312381647155, 946.6450081219542, 955.1308309438377, 960.5293406230896, 5134.204198349262, 5136.948630513722, 5143.76549628094, 5149.485051494896, 5152.3044389007755, 5414.242006119146, 5414.29614150158, 5421.620486565903, 5426.945730542644, 5428.185772134211, 4889.486603906538, 5135.178371460548, 5135.35808023997, 5140.357455318085, 5159.974200129051, 2528.0, 2538.5684433646325, 2542.6694529711017, 2555.258974897259, 2572.9356766080996, 4913.361263035782, 4927.408710954636, 4935.777889994959, 4953.72754498506, 4953.876153096201, 4897.918384686565, 4898.2652602109965, 4922.926156107661, 5263.3947096083675, 5571.247881536022, 5671.6597004179885, 5690.829275121753, 5692.31692196939, 5696.743646535916, 5704.543636509069, 5481.3970463248215, 5500.944990550043, 5515.58633102527, 5527.917081243865, 5555.972220138873, 5224.791008359775, 5463.754131064032, 5468.207109968953, 5482.259894914295, 5484.287042684426, 5685.71571421419, 5691.96261308753, 5695.772169113189, 5714.342850572071, 5742.0, 3851.5185601799776, 3883.9417408738327, 3886.3587508060855, 3888.125171836314, 3893.357595996629, 5261.342332208474, 5327.706976116351, 5482.945170548243, 5503.587230957774, 5527.281453411031, 5133.589312855037, 5160.380754309507, 5255.868603284948, 5281.339832520935, 5281.656692314988, 5237.947620523899, 5270.235815806764, 5282.102042652681, 5296.523312901857, 5301.840944771663, 5088.618353623567, 5270.78916843322, 5290.9735451322495, 5314.309139811954, 5366.168243922199, 5302.70835104073, 5306.336707911511, 5312.920306195488, 5316.30887984575, 5327.493888080626, 5140.254663073759, 5164.690118592896, 5179.637425380187, 5203.791848326025, 5219.347581552306], "value": 4041.2348429479325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.0635530815507, 625.6652690810417, 627.3224917089544, 667.0894229376902, 668.7425341243622, 12463.0, 13068.281244531547, 13567.0, 13579.185248885075, 13704.109232899855, 12964.675883102927, 13287.0, 13304.866951330483, 13314.800277995837, 13320.467181312735, 502.7561632608182, 568.6985897474335, 580.4253788749129, 583.2563481561001, 583.8978178818711, 515.5720751776036, 570.37543889441, 579.7912751409489, 584.52653350786, 589.178096555305, 613.6348872420903, 615.9507239420858, 617.9011358182692, 618.4742968476804, 621.0590954703628, 524.6248932013591, 615.0159744408954, 615.6613862375675, 616.4575173847009, 616.7101462312728, 393.3156308024046, 434.036439105186, 439.55165730954565, 440.3812643236258, 442.8826361014334, 12195.39023048844, 12252.632421027383, 12260.26438413698, 12637.178583392142, 12653.936730316289, 12856.22862628236, 13060.412281447358, 13863.37614807326, 13958.860411395959, 14074.929625351808, 11066.39134847583, 11167.609133680364, 11575.247608905394, 12070.69823254417, 12305.26168429897, 4296.205202037601, 4312.137572485515, 4371.475422949235, 4399.780010999437, 4566.06395688883, 81470.59264703697, 81999.18000819975, 82221.0, 82412.0, 84591.57704211501, 9642.146621658647, 9654.903450965541, 9724.70825875225, 9807.0, 10242.897571024343, 16857.494275171764, 17075.658486830194, 17082.658346832995, 17107.0, 17109.657806843792, 7573.924260757432, 7649.235076492418, 7778.0, 7941.483803552751, 7964.800879977931, 4569.634429245719, 4614.123316569908, 4620.722756634613, 4673.0, 4767.594754445841, 3157.17913342528, 3272.5254838048827, 3280.3767284215924, 3292.8353582320788, 3299.3896129216173, 564.0467609739609, 572.193207577314, 586.2408181405091, 591.9585629005928, 598.8950386536833, 445.11644385893976, 461.3541042540403, 525.853639066838, 536.5921899356517, 574.7902015764216, 7383.852322953511, 7769.3784497240085, 7870.134285228621, 8037.678492860337, 8353.958230208931, 475.9690620109682, 506.3695698854876, 564.1396869773628, 579.1515429895223, 594.215635361319, 3897.2595206910596, 3906.121122747416, 4004.139110091286, 4104.733192342488, 4189.2459357315365, 120384.0, 120496.3975180136, 122619.0, 123503.38248308701, 128073.35963320124, 104961.0, 105188.0, 106577.46711266549, 110686.0, 111740.0, 57963.4203657958, 83504.05687118506, 90228.54885725661, 92033.0, 94014.5299273513, 7747.92252077472, 7804.687812487664, 7963.84072318562, 7984.760457186294, 8049.51702897828, 54387.0, 54678.0, 55163.44836551743, 55631.0, 56904.43095569157, 51702.0, 82042.0, 82200.0, 84373.15626843653, 84401.57799210964, 10377.636782712569, 10476.63331783384, 10782.299150555189, 10999.61501347449, 11001.0, 12306.692332691397, 12526.686832829253, 12576.119671623264, 12994.285314307805, 13407.530736424178, 11657.300561966309, 11806.0, 11911.40442977865, 12159.148859579744, 12576.622701318975, 12007.099467539794, 12037.939810300892, 12431.440585173508, 12821.935890320488, 12860.292683902475, 12019.879801201876, 12159.574414895436, 12987.870121299044, 12988.610341689764, 12995.480180792661, 9144.0, 9461.146338430934, 9516.19112375456, 9622.326437149612, 9838.097761160618, 9361.625534978797, 9821.116099551075, 10122.898771012196, 10221.540030698488, 10228.0], "value": 6631.6442313113, "unit": "score"}], "name": "dromaeo_css", "value": 6754.35064727069, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 123.0, 167.0, 123.0, 128.0, 127.0, 128.0, 156.0, 124.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 166.0, 161.0, 161.0, 162.0, 162.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 117.0, 76.0, 76.0, 77.0, 77.0, 106.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 82.0, 83.0, 83.0, 103.0, 82.0, 82.0, 106.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 148.0, 148.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 50.0, 51.0, 50.0, 53.0, 52.0, 51.0, 52.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 63.0, 66.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 79.0, 80.0, 80.0, 80.0, 80.0, 80.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 131.0, 129.0, 128.0, 129.0, 146.0, 139.0, 164.0, 140.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 165.0, 166.0, 167.0, 166.0, 166.0, 166.0, 163.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 69.0, 66.0, 63.0, 66.0, 74.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1502.8999999999999, "alertThreshold": 2.0}]} 06:37:40 INFO - Return code: 0 06:37:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:37:40 INFO - # TBPL SUCCESS # 06:37:40 INFO - Running post-action listener: _resource_record_post_action 06:37:40 INFO - [mozharness: 2016-10-05 13:37:40.737196Z] Finished run-tests step (success) 06:37:40 INFO - Running post-run listener: _resource_record_post_run 06:37:40 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 393244672; Read time: 0; Write time: 418452 06:37:40 INFO - TinderboxPrint: CPU usage
13.0% 06:37:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:37:40 INFO - TinderboxPrint: I/O write bytes / time
393,244,672 / 418,452 06:37:40 INFO - TinderboxPrint: CPU idle
8,317.4 (86.9%) 06:37:40 INFO - TinderboxPrint: CPU user
1,197.1 (12.5%) 06:37:40 INFO - TinderboxPrint: Swap in / out
0 / 0 06:37:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103219200; Read time: 0; Write time: 88732 06:37:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289480704; Read time: 0; Write time: 329712 06:37:41 INFO - Running post-run listener: _upload_blobber_files 06:37:41 INFO - Blob upload gear active. 06:37:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:37:41 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 06:37:41 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:37:41 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:37:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:45 INFO - (blobuploader) - INFO - Done attempting. 06:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:46 INFO - (blobuploader) - INFO - Done attempting. 06:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:46 INFO - (blobuploader) - INFO - Done attempting. 06:37:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:37:46 INFO - Return code: 0 06:37:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:37:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:37:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bab86f3b31a8b3821ca1877f46945c29193781f7c197aa4621ef10fb912155d72ac045828687e62224535a3eb851abc3cd2d6c174559c8924f979a3cbd828cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932b84a04508055e4b83aa00587b894e6c68f4d22d5f4098e52a170fc5c6b31e711d5edfa4bec47b7621f39ffb77f07bafe34023b79db755357e32af995fca58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cdd7bc34ea6fc5ba5070f3f1377b2c715854c30f4d077eb33c2ec36b3784c36974146176c0ff4aee5638d79553cbf588768e7304a1a549988557620da6b26eb"} 06:37:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:37:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:37:46 INFO - Contents: 06:37:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bab86f3b31a8b3821ca1877f46945c29193781f7c197aa4621ef10fb912155d72ac045828687e62224535a3eb851abc3cd2d6c174559c8924f979a3cbd828cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932b84a04508055e4b83aa00587b894e6c68f4d22d5f4098e52a170fc5c6b31e711d5edfa4bec47b7621f39ffb77f07bafe34023b79db755357e32af995fca58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cdd7bc34ea6fc5ba5070f3f1377b2c715854c30f4d077eb33c2ec36b3784c36974146176c0ff4aee5638d79553cbf588768e7304a1a549988557620da6b26eb"} 06:37:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:37:46 INFO - Copying logs to upload dir... 06:37:46 INFO - mkdir: /builds/slave/test/build/upload/logs 06:37:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.705063 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-05 06:37:46.477567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:46.483806) ========= 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=af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bab86f3b31a8b3821ca1877f46945c29193781f7c197aa4621ef10fb912155d72ac045828687e62224535a3eb851abc3cd2d6c174559c8924f979a3cbd828cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932b84a04508055e4b83aa00587b894e6c68f4d22d5f4098e52a170fc5c6b31e711d5edfa4bec47b7621f39ffb77f07bafe34023b79db755357e32af995fca58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cdd7bc34ea6fc5ba5070f3f1377b2c715854c30f4d077eb33c2ec36b3784c36974146176c0ff4aee5638d79553cbf588768e7304a1a549988557620da6b26eb"} build_url:https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/bFMnJ9htTB2qdGE5H64RGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bab86f3b31a8b3821ca1877f46945c29193781f7c197aa4621ef10fb912155d72ac045828687e62224535a3eb851abc3cd2d6c174559c8924f979a3cbd828cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932b84a04508055e4b83aa00587b894e6c68f4d22d5f4098e52a170fc5c6b31e711d5edfa4bec47b7621f39ffb77f07bafe34023b79db755357e32af995fca58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cdd7bc34ea6fc5ba5070f3f1377b2c715854c30f4d077eb33c2ec36b3784c36974146176c0ff4aee5638d79553cbf588768e7304a1a549988557620da6b26eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:46.509581) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:46.509893) ========= 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=af724c981e2a0f424dbabf99000001e7-1475672560.919452-1061116666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 06:37:46.592444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 06:37:46.592753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 06:37:46.593057) ========= ========= Total master_lag: 0.17 =========