builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1476745470.29 results: success (0) buildid: 20161017142049 builduid: 3658f20c32d04e0d82112331e655564f revision: 8c8266b3c23446275dc503366fd739ba3bc4834a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.286391) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.286868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.287213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.302234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.302542) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 16:04:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-10-17 16:04:30 (43.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.440647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.441003) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019383 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.491212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:30.491597) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 8c8266b3c23446275dc503366fd739ba3bc4834a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 8c8266b3c23446275dc503366fd739ba3bc4834a --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=9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 16:04:30,928 truncating revision to first 12 chars 2016-10-17 16:04:30,928 Setting DEBUG logging. 2016-10-17 16:04:30,928 attempt 1/10 2016-10-17 16:04:30,928 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/8c8266b3c234?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 16:04:31,229 unpacking tar archive at: larch-8c8266b3c234/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:31.185184) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:31.185557) ========= script_repo_revision: 8c8266b3c23446275dc503366fd739ba3bc4834a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:31.186016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:31.186343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 16:04:31.195511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-17 16:04:31.195822) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:04:31 INFO - MultiFileLogger online at 20161017 16:04:31 in /builds/slave/test 16:04:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 16:04:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:04:31 INFO - {'append_to_log': False, 16:04:31 INFO - 'base_work_dir': '/builds/slave/test', 16:04:31 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 16:04:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:04:31 INFO - 'branch': 'Larch-Non-PGO', 16:04:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:04:31 INFO - 'config_files': ('talos/linux_config.py',), 16:04:31 INFO - 'default_actions': ('clobber', 16:04:31 INFO - 'read-buildbot-config', 16:04:31 INFO - 'download-and-extract', 16:04:31 INFO - 'populate-webroot', 16:04:31 INFO - 'create-virtualenv', 16:04:31 INFO - 'install', 16:04:31 INFO - 'run-tests'), 16:04:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:04:31 INFO - 'download_minidump_stackwalk': True, 16:04:31 INFO - 'download_symbols': 'ondemand', 16:04:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:04:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:04:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:04:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:04:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:04:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:04:31 INFO - 'installer_path': 'installer.exe', 16:04:31 INFO - 'log_level': 'info', 16:04:31 INFO - 'log_name': 'talos', 16:04:31 INFO - 'log_to_console': True, 16:04:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:04:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:04:31 INFO - 'opt_config_files': (), 16:04:31 INFO - 'pip_index': False, 16:04:31 INFO - 'sps_profile': False, 16:04:31 INFO - 'sps_profile_interval': 0, 16:04:31 INFO - 'suite': 'dromaeojs', 16:04:31 INFO - 'system_bits': '32', 16:04:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:04:31 INFO - 'title': 'talos-linux64-ix-040', 16:04:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:04:31 INFO - 'use_talos_json': True, 16:04:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:04:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:04:31 INFO - 'work_dir': 'build'} 16:04:31 INFO - [mozharness: 2016-10-17 23:04:31.740562Z] Running clobber step. 16:04:31 INFO - Running pre-action listener: _resource_record_pre_action 16:04:31 INFO - Running main action method: clobber 16:04:31 INFO - rmtree: /builds/slave/test/build 16:04:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:04:32 INFO - Running post-action listener: _resource_record_post_action 16:04:32 INFO - [mozharness: 2016-10-17 23:04:32.735510Z] Finished clobber step (success) 16:04:32 INFO - [mozharness: 2016-10-17 23:04:32.735611Z] Running read-buildbot-config step. 16:04:32 INFO - Running pre-action listener: _resource_record_pre_action 16:04:32 INFO - Running main action method: read_buildbot_config 16:04:32 INFO - Using buildbot properties: 16:04:32 INFO - { 16:04:32 INFO - "project": "", 16:04:32 INFO - "product": "firefox", 16:04:32 INFO - "script_repo_revision": "production", 16:04:32 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 16:04:32 INFO - "repository": "", 16:04:32 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 16:04:32 INFO - "buildid": "20161017142049", 16:04:32 INFO - "pgo_build": "False", 16:04:32 INFO - "basedir": "/builds/slave/test", 16:04:32 INFO - "buildnumber": 4, 16:04:32 INFO - "slavename": "talos-linux64-ix-040", 16:04:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:04:32 INFO - "platform": "ubuntu64_hw", 16:04:32 INFO - "scheduler": "tests-larch-linux64-talos", 16:04:32 INFO - "branch": "larch", 16:04:32 INFO - "repo_path": "projects/larch", 16:04:32 INFO - "revision": "8c8266b3c23446275dc503366fd739ba3bc4834a", 16:04:32 INFO - "stage_platform": "linux64", 16:04:32 INFO - "builduid": "3658f20c32d04e0d82112331e655564f", 16:04:32 INFO - "slavebuilddir": "test" 16:04:32 INFO - } 16:04:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:04:32 INFO - Running post-action listener: _resource_record_post_action 16:04:32 INFO - [mozharness: 2016-10-17 23:04:32.738050Z] Finished read-buildbot-config step (success) 16:04:32 INFO - [mozharness: 2016-10-17 23:04:32.738138Z] Running download-and-extract step. 16:04:32 INFO - Running pre-action listener: _resource_record_pre_action 16:04:32 INFO - Running main action method: download_and_extract 16:04:32 INFO - mkdir: /builds/slave/test/build/tests 16:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:32 INFO - trying https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:04:32 INFO - Downloading https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:04:33 INFO - Downloaded 1361 bytes. 16:04:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:04:33 INFO - Using the following test package requirements: 16:04:33 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:04:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:04:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:04:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'jsshell-linux-x86_64.zip'], 16:04:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:04:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:04:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:04:33 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:04:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:04:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:04:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:04:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:04:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:04:33 INFO - Fetch https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:04:33 INFO - Http code: 200 16:04:33 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 16:04:33 INFO - x-amz-cf-id: dNPbBB9U7byNH_Ig4FTppvdiyuAhV2dGR5T4GGHO9x6-DqLEw6v_Ww== 16:04:33 INFO - x-amz-version-id: .20Rxx0tZ6HYMiz6G8fXE2RWWvoJdaOz 16:04:34 INFO - Expected file size: 20528584 16:04:34 INFO - Obtained file size: 20528584 16:04:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:04:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:04:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:04:38 INFO - Fetch https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:04:38 INFO - Http code: 200 16:04:38 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 16:04:38 INFO - x-amz-cf-id: ARFy7e0R295QqPP_rKqrgj-cLA6lp2dQ8nXAoyhgBSz2ndTgoAWuRg== 16:04:38 INFO - x-amz-version-id: .20Rxx0tZ6HYMiz6G8fXE2RWWvoJdaOz 16:04:39 INFO - Expected file size: 20528584 16:04:39 INFO - Obtained file size: 20528584 16:04:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:04:43 INFO - Fetch https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:04:44 INFO - Http code: 200 16:04:44 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 16:04:44 INFO - x-amz-cf-id: u-w-Y1EjchQk1pU2_0TyF3DTmJ9zc-c1YaEDoxunBBccVcvyoDiOUA== 16:04:44 INFO - x-amz-version-id: SMIUKCHLoOCQ3_ijGJKTAxOdy43doHfv 16:04:44 INFO - Expected file size: 14409006 16:04:44 INFO - Obtained file size: 14409006 16:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:44 INFO - trying https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:04:44 INFO - Downloading https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:04:45 INFO - Downloaded 56016220 bytes. 16:04:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:04:45 INFO - mkdir: /builds/slave/test/properties 16:04:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:04:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:04:45 INFO - Contents: 16:04:45 INFO - build_url:https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:04:46 INFO - Running post-action listener: _resource_record_post_action 16:04:46 INFO - Running post-action listener: set_extra_try_arguments 16:04:46 INFO - [mozharness: 2016-10-17 23:04:46.433631Z] Finished download-and-extract step (success) 16:04:46 INFO - [mozharness: 2016-10-17 23:04:46.433929Z] Running populate-webroot step. 16:04:46 INFO - Running pre-action listener: _resource_record_pre_action 16:04:46 INFO - Running main action method: populate_webroot 16:04:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:04:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:04:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:04:46 INFO - '--tppagecycles', 16:04:46 INFO - '7'], 16:04:46 INFO - 'tests': ['tsvgm']}}, 16:04:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:04:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:04:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:04:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:04:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['damp', 'tps']}, 16:04:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'tests': ['damp', 'tps']}, 16:04:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['dromaeo_dom']}, 16:04:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:04:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['basic_compositor_video']}, 16:04:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:04:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['a11yr', 16:04:46 INFO - 'ts_paint', 16:04:46 INFO - 'tpaint', 16:04:46 INFO - 'sessionrestore', 16:04:46 INFO - 'sessionrestore_no_auto_restore', 16:04:46 INFO - 'tabpaint']}, 16:04:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:04:46 INFO - 'ts_paint', 16:04:46 INFO - 'tpaint', 16:04:46 INFO - 'sessionrestore', 16:04:46 INFO - 'sessionrestore_no_auto_restore', 16:04:46 INFO - 'tabpaint']}, 16:04:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:04:46 INFO - 'ts_paint', 16:04:46 INFO - 'tpaint', 16:04:46 INFO - 'sessionrestore', 16:04:46 INFO - 'sessionrestore_no_auto_restore', 16:04:46 INFO - 'tabpaint']}, 16:04:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:04:46 INFO - 'ts_paint', 16:04:46 INFO - 'tpaint', 16:04:46 INFO - 'sessionrestore', 16:04:46 INFO - 'sessionrestore_no_auto_restore', 16:04:46 INFO - 'tabpaint']}, 16:04:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['a11yr', 16:04:46 INFO - 'ts_paint', 16:04:46 INFO - 'tpaint', 16:04:46 INFO - 'sessionrestore', 16:04:46 INFO - 'sessionrestore_no_auto_restore', 16:04:46 INFO - 'tabpaint']}, 16:04:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['a11yr', 16:04:46 INFO - 'ts_paint', 16:04:46 INFO - 'tpaint', 16:04:46 INFO - 'sessionrestore', 16:04:46 INFO - 'sessionrestore_no_auto_restore', 16:04:46 INFO - 'tabpaint']}, 16:04:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['tsvgx', 16:04:46 INFO - 'tsvgr_opacity', 16:04:46 INFO - 'tart', 16:04:46 INFO - 'tscrollx', 16:04:46 INFO - 'cart']}, 16:04:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:04:46 INFO - 'tsvgr_opacity', 16:04:46 INFO - 'tart', 16:04:46 INFO - 'tscrollx', 16:04:46 INFO - 'cart']}, 16:04:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'talos_options': ['--disable-e10s'], 16:04:46 INFO - 'tests': ['tp5o']}, 16:04:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'tests': ['tp5o']}, 16:04:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'talos_options': ['--disable-e10s', 16:04:46 INFO - '--xperf_path', 16:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:46 INFO - 'tests': ['tp5n']}, 16:04:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:46 INFO - 'talos_options': ['--xperf_path', 16:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:46 INFO - 'tests': ['tp5n']}}, 16:04:46 INFO - 'talos.zip': {'path': '', 16:04:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:46 INFO - Running post-action listener: _resource_record_post_action 16:04:46 INFO - [mozharness: 2016-10-17 23:04:46.455632Z] Finished populate-webroot step (success) 16:04:46 INFO - [mozharness: 2016-10-17 23:04:46.455724Z] Running create-virtualenv step. 16:04:46 INFO - Running pre-action listener: _resource_record_pre_action 16:04:46 INFO - Running main action method: create_virtualenv 16:04:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:04:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:04:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:04:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:04:46 INFO - Using real prefix '/usr' 16:04:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:04:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:04:49 INFO - Installing pip.................done. 16:04:49 INFO - Return code: 0 16:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:04:49 INFO - Reading from file tmpfile_stdout 16:04:49 INFO - Output received: 16:04:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:04:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:49 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:04:49 INFO - Using env: {'DISPLAY': ':0', 16:04:49 INFO - 'HOME': '/home/cltbld', 16:04:49 INFO - 'LANG': 'en_US.UTF-8', 16:04:49 INFO - 'LANGUAGE': 'en_US:en', 16:04:49 INFO - 'LOGNAME': 'cltbld', 16:04:49 INFO - 'MAIL': '/var/mail/cltbld', 16:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:49 INFO - 'MOZ_NO_REMOTE': '1', 16:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:49 INFO - 'NO_EM_RESTART': '1', 16:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:49 INFO - 'PWD': '/builds/slave/test', 16:04:49 INFO - 'SHELL': '/bin/bash', 16:04:49 INFO - 'SHLVL': '1', 16:04:49 INFO - 'TERM': 'linux', 16:04:49 INFO - 'TMOUT': '86400', 16:04:49 INFO - 'USER': 'cltbld', 16:04:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:49 INFO - '_': '/tools/buildbot/bin/python'} 16:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:04:49 INFO - Cleaning up... 16:04:49 INFO - Return code: 0 16:04:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:49 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:04:49 INFO - Using env: {'DISPLAY': ':0', 16:04:49 INFO - 'HOME': '/home/cltbld', 16:04:49 INFO - 'LANG': 'en_US.UTF-8', 16:04:49 INFO - 'LANGUAGE': 'en_US:en', 16:04:49 INFO - 'LOGNAME': 'cltbld', 16:04:49 INFO - 'MAIL': '/var/mail/cltbld', 16:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:49 INFO - 'MOZ_NO_REMOTE': '1', 16:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:49 INFO - 'NO_EM_RESTART': '1', 16:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:49 INFO - 'PWD': '/builds/slave/test', 16:04:49 INFO - 'SHELL': '/bin/bash', 16:04:49 INFO - 'SHLVL': '1', 16:04:49 INFO - 'TERM': 'linux', 16:04:49 INFO - 'TMOUT': '86400', 16:04:49 INFO - 'USER': 'cltbld', 16:04:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:49 INFO - '_': '/tools/buildbot/bin/python'} 16:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:49 INFO - Downloading/unpacking psutil>=3.1.1 16:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:51 INFO - Installing collected packages: psutil 16:04:51 INFO - Running setup.py install for psutil 16:04:51 INFO - building 'psutil._psutil_linux' extension 16:04:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:04:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:04:51 INFO - building 'psutil._psutil_posix' extension 16:04:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:04:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:04:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:52 INFO - Successfully installed psutil 16:04:52 INFO - Cleaning up... 16:04:52 INFO - Return code: 0 16:04:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:52 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:04:52 INFO - Using env: {'DISPLAY': ':0', 16:04:52 INFO - 'HOME': '/home/cltbld', 16:04:52 INFO - 'LANG': 'en_US.UTF-8', 16:04:52 INFO - 'LANGUAGE': 'en_US:en', 16:04:52 INFO - 'LOGNAME': 'cltbld', 16:04:52 INFO - 'MAIL': '/var/mail/cltbld', 16:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:52 INFO - 'MOZ_NO_REMOTE': '1', 16:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:52 INFO - 'NO_EM_RESTART': '1', 16:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:52 INFO - 'PWD': '/builds/slave/test', 16:04:52 INFO - 'SHELL': '/bin/bash', 16:04:52 INFO - 'SHLVL': '1', 16:04:52 INFO - 'TERM': 'linux', 16:04:52 INFO - 'TMOUT': '86400', 16:04:52 INFO - 'USER': 'cltbld', 16:04:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:52 INFO - '_': '/tools/buildbot/bin/python'} 16:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:04:54 INFO - Installing collected packages: mozsystemmonitor 16:04:54 INFO - Running setup.py install for mozsystemmonitor 16:04:54 INFO - Successfully installed mozsystemmonitor 16:04:54 INFO - Cleaning up... 16:04:54 INFO - Return code: 0 16:04:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:04:54 INFO - Using env: {'DISPLAY': ':0', 16:04:54 INFO - 'HOME': '/home/cltbld', 16:04:54 INFO - 'LANG': 'en_US.UTF-8', 16:04:54 INFO - 'LANGUAGE': 'en_US:en', 16:04:54 INFO - 'LOGNAME': 'cltbld', 16:04:54 INFO - 'MAIL': '/var/mail/cltbld', 16:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:54 INFO - 'MOZ_NO_REMOTE': '1', 16:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:54 INFO - 'NO_EM_RESTART': '1', 16:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:54 INFO - 'PWD': '/builds/slave/test', 16:04:54 INFO - 'SHELL': '/bin/bash', 16:04:54 INFO - 'SHLVL': '1', 16:04:54 INFO - 'TERM': 'linux', 16:04:54 INFO - 'TMOUT': '86400', 16:04:54 INFO - 'USER': 'cltbld', 16:04:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:54 INFO - '_': '/tools/buildbot/bin/python'} 16:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:04:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:04:58 INFO - warning: no files found matching '*.txt' 16:04:58 INFO - no previously-included directories found matching 'build' 16:04:58 INFO - no previously-included directories found matching 'dist' 16:04:58 INFO - no previously-included directories found matching '.git*' 16:04:58 INFO - Installing collected packages: jsonschema, functools32 16:04:58 INFO - Running setup.py install for functools32 16:04:58 INFO - warning: no files found matching '*.txt' 16:04:58 INFO - no previously-included directories found matching 'build' 16:04:58 INFO - no previously-included directories found matching 'dist' 16:04:58 INFO - no previously-included directories found matching '.git*' 16:04:58 INFO - Successfully installed jsonschema functools32 16:04:58 INFO - Cleaning up... 16:04:58 INFO - Return code: 0 16:04:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:58 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:04:58 INFO - Using env: {'DISPLAY': ':0', 16:04:58 INFO - 'HOME': '/home/cltbld', 16:04:58 INFO - 'LANG': 'en_US.UTF-8', 16:04:58 INFO - 'LANGUAGE': 'en_US:en', 16:04:58 INFO - 'LOGNAME': 'cltbld', 16:04:58 INFO - 'MAIL': '/var/mail/cltbld', 16:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:58 INFO - 'MOZ_NO_REMOTE': '1', 16:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:58 INFO - 'NO_EM_RESTART': '1', 16:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:58 INFO - 'PWD': '/builds/slave/test', 16:04:58 INFO - 'SHELL': '/bin/bash', 16:04:58 INFO - 'SHLVL': '1', 16:04:58 INFO - 'TERM': 'linux', 16:04:58 INFO - 'TMOUT': '86400', 16:04:58 INFO - 'USER': 'cltbld', 16:04:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:58 INFO - '_': '/tools/buildbot/bin/python'} 16:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:04:58 INFO - Cleaning up... 16:04:58 INFO - Return code: 0 16:04:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:58 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:04:58 INFO - Using env: {'DISPLAY': ':0', 16:04:58 INFO - 'HOME': '/home/cltbld', 16:04:58 INFO - 'LANG': 'en_US.UTF-8', 16:04:58 INFO - 'LANGUAGE': 'en_US:en', 16:04:58 INFO - 'LOGNAME': 'cltbld', 16:04:58 INFO - 'MAIL': '/var/mail/cltbld', 16:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:58 INFO - 'MOZ_NO_REMOTE': '1', 16:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:58 INFO - 'NO_EM_RESTART': '1', 16:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:58 INFO - 'PWD': '/builds/slave/test', 16:04:58 INFO - 'SHELL': '/bin/bash', 16:04:58 INFO - 'SHLVL': '1', 16:04:58 INFO - 'TERM': 'linux', 16:04:58 INFO - 'TMOUT': '86400', 16:04:58 INFO - 'USER': 'cltbld', 16:04:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:58 INFO - '_': '/tools/buildbot/bin/python'} 16:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:01 INFO - Downloading docopt-0.6.1.tar.gz 16:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:01 INFO - Running setup.py install for blobuploader 16:05:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:01 INFO - Running setup.py install for requests 16:05:02 INFO - Running setup.py install for docopt 16:05:02 INFO - Successfully installed blobuploader requests docopt 16:05:02 INFO - Cleaning up... 16:05:02 INFO - Return code: 0 16:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:02 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:05:02 INFO - Using env: {'DISPLAY': ':0', 16:05:02 INFO - 'HOME': '/home/cltbld', 16:05:02 INFO - 'LANG': 'en_US.UTF-8', 16:05:02 INFO - 'LANGUAGE': 'en_US:en', 16:05:02 INFO - 'LOGNAME': 'cltbld', 16:05:02 INFO - 'MAIL': '/var/mail/cltbld', 16:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:02 INFO - 'MOZ_NO_REMOTE': '1', 16:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:02 INFO - 'NO_EM_RESTART': '1', 16:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:02 INFO - 'PWD': '/builds/slave/test', 16:05:02 INFO - 'SHELL': '/bin/bash', 16:05:02 INFO - 'SHLVL': '1', 16:05:02 INFO - 'TERM': 'linux', 16:05:02 INFO - 'TMOUT': '86400', 16:05:02 INFO - 'USER': 'cltbld', 16:05:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:02 INFO - '_': '/tools/buildbot/bin/python'} 16:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:02 INFO - Running setup.py (path:/tmp/pip-VoBJOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:02 INFO - Running setup.py (path:/tmp/pip-IZ_uEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:02 INFO - Running setup.py (path:/tmp/pip-GISvzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:02 INFO - Running setup.py (path:/tmp/pip-V_coYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:02 INFO - Running setup.py (path:/tmp/pip-x_vMB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:02 INFO - Running setup.py (path:/tmp/pip-kzCFsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:02 INFO - Running setup.py (path:/tmp/pip-O8OQcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:02 INFO - Running setup.py (path:/tmp/pip-v7Z4sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:03 INFO - Running setup.py (path:/tmp/pip-j1wLm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:03 INFO - Running setup.py (path:/tmp/pip-e8H4FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:03 INFO - Running setup.py (path:/tmp/pip-F8poXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:03 INFO - Running setup.py (path:/tmp/pip-jim7Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:03 INFO - Running setup.py (path:/tmp/pip-bLCFL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:03 INFO - Running setup.py (path:/tmp/pip-uWz74E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:03 INFO - Running setup.py (path:/tmp/pip-2RTJND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:03 INFO - Running setup.py (path:/tmp/pip-6ivxT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:03 INFO - Running setup.py (path:/tmp/pip-CUewGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:03 INFO - Running setup.py install for manifestparser 16:05:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:03 INFO - Running setup.py install for mozcrash 16:05:03 INFO - Running setup.py install for mozdebug 16:05:04 INFO - Running setup.py install for mozdevice 16:05:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Running setup.py install for mozfile 16:05:04 INFO - Running setup.py install for mozhttpd 16:05:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Running setup.py install for mozinfo 16:05:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Running setup.py install for mozInstall 16:05:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Running setup.py install for mozleak 16:05:04 INFO - Running setup.py install for mozlog 16:05:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Running setup.py install for moznetwork 16:05:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:04 INFO - Running setup.py install for mozprocess 16:05:04 INFO - Running setup.py install for mozprofile 16:05:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:05:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:05:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:05:05 INFO - Running setup.py install for mozrunner 16:05:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:05:05 INFO - Running setup.py install for mozscreenshot 16:05:05 INFO - Running setup.py install for moztest 16:05:05 INFO - Running setup.py install for mozversion 16:05:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:05:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:05 INFO - Cleaning up... 16:05:05 INFO - Return code: 0 16:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:05 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:05:05 INFO - Using env: {'DISPLAY': ':0', 16:05:05 INFO - 'HOME': '/home/cltbld', 16:05:05 INFO - 'LANG': 'en_US.UTF-8', 16:05:05 INFO - 'LANGUAGE': 'en_US:en', 16:05:05 INFO - 'LOGNAME': 'cltbld', 16:05:05 INFO - 'MAIL': '/var/mail/cltbld', 16:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:05 INFO - 'MOZ_NO_REMOTE': '1', 16:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:05 INFO - 'NO_EM_RESTART': '1', 16:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:05 INFO - 'PWD': '/builds/slave/test', 16:05:05 INFO - 'SHELL': '/bin/bash', 16:05:05 INFO - 'SHLVL': '1', 16:05:05 INFO - 'TERM': 'linux', 16:05:05 INFO - 'TMOUT': '86400', 16:05:05 INFO - 'USER': 'cltbld', 16:05:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:05 INFO - '_': '/tools/buildbot/bin/python'} 16:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:05 INFO - Running setup.py (path:/tmp/pip-TE_UDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:05 INFO - Running setup.py (path:/tmp/pip-iCQiMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:05 INFO - Running setup.py (path:/tmp/pip-4YOrn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:05 INFO - Running setup.py (path:/tmp/pip-92RpGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:06 INFO - Running setup.py (path:/tmp/pip-EhOOAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:06 INFO - Running setup.py (path:/tmp/pip-ZpX_fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:06 INFO - Running setup.py (path:/tmp/pip-EPgP7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:06 INFO - Running setup.py (path:/tmp/pip-DJ1X5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:06 INFO - Running setup.py (path:/tmp/pip-LWjZGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:06 INFO - Running setup.py (path:/tmp/pip-Vm8QPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:06 INFO - Running setup.py (path:/tmp/pip-ubdNt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:06 INFO - Running setup.py (path:/tmp/pip-qwlAeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:06 INFO - Running setup.py (path:/tmp/pip-lU90HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:06 INFO - Running setup.py (path:/tmp/pip-dhYD9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:06 INFO - Running setup.py (path:/tmp/pip-OX3e9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:06 INFO - Running setup.py (path:/tmp/pip-VIOJiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:06 INFO - Running setup.py (path:/tmp/pip-D96eW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:08 INFO - Downloading blessings-1.6.tar.gz 16:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:05:09 INFO - Installing collected packages: blessings 16:05:09 INFO - Running setup.py install for blessings 16:05:09 INFO - Successfully installed blessings 16:05:09 INFO - Cleaning up... 16:05:09 INFO - Return code: 0 16:05:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:09 INFO - Reading from file tmpfile_stdout 16:05:09 INFO - Current package versions: 16:05:09 INFO - argparse == 1.2.1 16:05:09 INFO - blessings == 1.6 16:05:09 INFO - blobuploader == 1.2.4 16:05:09 INFO - docopt == 0.6.1 16:05:09 INFO - functools32 == 3.2.3-2 16:05:09 INFO - jsonschema == 2.5.1 16:05:09 INFO - manifestparser == 1.1 16:05:09 INFO - mozInstall == 1.12 16:05:09 INFO - mozcrash == 0.17 16:05:09 INFO - mozdebug == 0.1 16:05:09 INFO - mozdevice == 0.48 16:05:09 INFO - mozfile == 1.2 16:05:09 INFO - mozhttpd == 0.7 16:05:09 INFO - mozinfo == 0.9 16:05:09 INFO - mozleak == 0.1 16:05:09 INFO - mozlog == 3.4 16:05:09 INFO - moznetwork == 0.27 16:05:09 INFO - mozprocess == 0.23 16:05:09 INFO - mozprofile == 0.28 16:05:09 INFO - mozrunner == 6.12 16:05:09 INFO - mozscreenshot == 0.1 16:05:09 INFO - mozsystemmonitor == 0.3 16:05:09 INFO - moztest == 0.7 16:05:09 INFO - mozversion == 1.4 16:05:09 INFO - psutil == 3.1.1 16:05:09 INFO - requests == 1.2.3 16:05:09 INFO - wsgiref == 0.1.2 16:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:09 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:05:09 INFO - Using env: {'DISPLAY': ':0', 16:05:09 INFO - 'HOME': '/home/cltbld', 16:05:09 INFO - 'LANG': 'en_US.UTF-8', 16:05:09 INFO - 'LANGUAGE': 'en_US:en', 16:05:09 INFO - 'LOGNAME': 'cltbld', 16:05:09 INFO - 'MAIL': '/var/mail/cltbld', 16:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:09 INFO - 'MOZ_NO_REMOTE': '1', 16:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:09 INFO - 'NO_EM_RESTART': '1', 16:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:09 INFO - 'PWD': '/builds/slave/test', 16:05:09 INFO - 'SHELL': '/bin/bash', 16:05:09 INFO - 'SHLVL': '1', 16:05:09 INFO - 'TERM': 'linux', 16:05:09 INFO - 'TMOUT': '86400', 16:05:09 INFO - 'USER': 'cltbld', 16:05:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:09 INFO - '_': '/tools/buildbot/bin/python'} 16:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:05:09 INFO - Cleaning up... 16:05:09 INFO - Return code: 0 16:05:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:09 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 0x7fbab16b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1125ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:05:09 INFO - Using env: {'DISPLAY': ':0', 16:05:09 INFO - 'HOME': '/home/cltbld', 16:05:09 INFO - 'LANG': 'en_US.UTF-8', 16:05:09 INFO - 'LANGUAGE': 'en_US:en', 16:05:09 INFO - 'LOGNAME': 'cltbld', 16:05:09 INFO - 'MAIL': '/var/mail/cltbld', 16:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:09 INFO - 'MOZ_NO_REMOTE': '1', 16:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:09 INFO - 'NO_EM_RESTART': '1', 16:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:09 INFO - 'PWD': '/builds/slave/test', 16:05:09 INFO - 'SHELL': '/bin/bash', 16:05:09 INFO - 'SHLVL': '1', 16:05:09 INFO - 'TERM': 'linux', 16:05:09 INFO - 'TMOUT': '86400', 16:05:09 INFO - 'USER': 'cltbld', 16:05:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:09 INFO - '_': '/tools/buildbot/bin/python'} 16:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:05:09 INFO - Cleaning up... 16:05:09 INFO - Return code: 0 16:05:09 INFO - Running post-action listener: _resource_record_post_action 16:05:09 INFO - Running post-action listener: _start_resource_monitoring 16:05:09 INFO - Starting resource monitoring. 16:05:09 INFO - [mozharness: 2016-10-17 23:05:09.886243Z] Finished create-virtualenv step (success) 16:05:09 INFO - [mozharness: 2016-10-17 23:05:09.886700Z] Running install step. 16:05:09 INFO - Running pre-action listener: _resource_record_pre_action 16:05:09 INFO - Running main action method: install 16:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:10 INFO - Reading from file tmpfile_stdout 16:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:05:10 INFO - Reading from file tmpfile_stdout 16:05:10 INFO - Output received: 16:05:10 INFO - Usage: mozinstall [options] installer 16:05:10 INFO - Options: 16:05:10 INFO - -h, --help show this help message and exit 16:05:10 INFO - -d DEST, --destination=DEST 16:05:10 INFO - Directory to install application into. [default: 16:05:10 INFO - "/builds/slave/test"] 16:05:10 INFO - --app=APP Application being installed. [default: firefox] 16:05:10 INFO - mkdir: /builds/slave/test/build/application 16:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:05:26 INFO - Reading from file tmpfile_stdout 16:05:26 INFO - Output received: 16:05:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:05:26 INFO - Running post-action listener: _resource_record_post_action 16:05:26 INFO - [mozharness: 2016-10-17 23:05:26.349543Z] Finished install step (success) 16:05:26 INFO - [mozharness: 2016-10-17 23:05:26.349788Z] Running run-tests step. 16:05:26 INFO - Running pre-action listener: _resource_record_pre_action 16:05:26 INFO - Running main action method: run_tests 16:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:05:26 INFO - Python 2.7.3 16:05:26 INFO - Return code: 0 16:05:26 INFO - grabbing minidump binary from tooltool 16:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:26 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 0x1122f60>, '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 0x1123d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11241d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:05:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:05:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:05:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:05:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:05:26 INFO - Return code: 0 16:05:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:05:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:05:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:05:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:05:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:05:26 INFO - Using env: {'DISPLAY': ':0', 16:05:26 INFO - 'HOME': '/home/cltbld', 16:05:26 INFO - 'LANG': 'en_US.UTF-8', 16:05:26 INFO - 'LANGUAGE': 'en_US:en', 16:05:26 INFO - 'LOGNAME': 'cltbld', 16:05:26 INFO - 'MAIL': '/var/mail/cltbld', 16:05:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:05:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:26 INFO - 'MOZ_NO_REMOTE': '1', 16:05:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:26 INFO - 'NO_EM_RESTART': '1', 16:05:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:26 INFO - 'PWD': '/builds/slave/test', 16:05:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:05:26 INFO - 'SHELL': '/bin/bash', 16:05:26 INFO - 'SHLVL': '1', 16:05:26 INFO - 'TERM': 'linux', 16:05:26 INFO - 'TMOUT': '86400', 16:05:26 INFO - 'USER': 'cltbld', 16:05:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701', 16:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:26 INFO - '_': '/tools/buildbot/bin/python'} 16:05:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:05:26 INFO - mozversion application_buildid: 20161017142049 16:05:26 INFO - mozversion application_changeset: 8c8266b3c23446275dc503366fd739ba3bc4834a 16:05:26 INFO - mozversion application_display_name: Nightly 16:05:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:05:26 INFO - mozversion application_name: Firefox 16:05:26 INFO - mozversion application_remotingname: firefox 16:05:26 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:05:26 INFO - mozversion application_vendor: Mozilla 16:05:26 INFO - mozversion application_version: 52.0a1 16:05:26 INFO - mozversion platform_buildid: 20161017142049 16:05:26 INFO - mozversion platform_changeset: 8c8266b3c23446275dc503366fd739ba3bc4834a 16:05:26 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:05:26 INFO - mozversion platform_version: 52.0a1 16:05:26 INFO - using testdate: 1476745526 16:05:26 INFO - actual date: 1476745526 16:05:26 INFO - starting webserver on 'localhost:48668' 16:05:26 INFO - SUITE-START | Running 2 tests 16:05:26 INFO - TEST-START | dromaeo_css 16:05:26 INFO - operating with platform_type : linux_ 16:05:26 INFO - Initialising browser for dromaeo_css test... 16:05:26 INFO - TEST-INFO | started process 13160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDWYww/profile http://localhost:48668/getInfo.html) 16:05:31 INFO - PROCESS | 13160 | __metrics Screen width/height:1600/1200 16:05:31 INFO - PROCESS | 13160 | colorDepth:24 16:05:31 INFO - PROCESS | 13160 | Browser inner width/height: 1024/697 16:05:31 INFO - PROCESS | 13160 | __metrics 16:05:31 INFO - PROCESS | 13160 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:05:31 INFO - PROCESS | 13160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:05:32 INFO - PROCESS | 13160 | console.error: PushService: 16:05:32 INFO - PROCESS | 13160 | stateChangeProcessEnqueue: Error transitioning state 16:05:32 INFO - PROCESS | 13160 | UnknownError 16:05:33 INFO - TEST-INFO | 13160: exit 0 16:05:33 INFO - Browser initialized. 16:05:33 INFO - Running cycle 1/1 for dromaeo_css test... 16:05:33 INFO - TEST-INFO | started process 13242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDWYww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:45 INFO - PROCESS | 13242 | RSS: Main: 176398336 16:05:45 INFO - PROCESS | 13242 | 16:06:36 INFO - PROCESS | 13242 | 1476745596861 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:08:50 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:48668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48668/tests/dromaeo/cssquery-ext.html) 16:08:51 INFO - PROCESS | 13242 | RSS: Main: 272912384 16:08:51 INFO - PROCESS | 13242 | 16:11:54 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:48668/tests/dromaeo/cssquery-ext.html (next: http://localhost:48668/tests/dromaeo/cssquery-jquery.html) 16:11:55 INFO - PROCESS | 13242 | RSS: Main: 287977472 16:11:55 INFO - PROCESS | 13242 | 16:14:57 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:48668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48668/tests/dromaeo/cssquery-mootools.html) 16:14:57 INFO - PROCESS | 13242 | RSS: Main: 222830592 16:14:57 INFO - PROCESS | 13242 | 16:18:00 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:48668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48668/tests/dromaeo/cssquery-prototype.html) 16:18:00 INFO - PROCESS | 13242 | RSS: Main: 237760512 16:18:00 INFO - PROCESS | 13242 | 16:21:03 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:48668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48668/tests/dromaeo/cssquery-yui.html) 16:21:04 INFO - PROCESS | 13242 | RSS: Main: 223391744 16:21:04 INFO - PROCESS | 13242 | 16:24:07 INFO - PROCESS | 13242 | Cycle 1(1): loaded http://localhost:48668/tests/dromaeo/cssquery-yui.html (next: http://localhost:48668/tests/dromaeo/cssquery-dojo.html) 16:24:08 INFO - PROCESS | 13242 | RSS: Main: 299089920 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | __start_tp_report 16:24:08 INFO - PROCESS | 13242 | _x_x_mozilla_page_load 16:24:08 INFO - PROCESS | 13242 | _x_x_mozilla_page_load_details 16:24:08 INFO - PROCESS | 13242 | |i|pagename|runs| 16:24:08 INFO - PROCESS | 13242 | |0;dojo.html;2539.9746002539973;2567.1528395629443;2582.22533240028;2591.6889973203206;2603.4402603440267;4524.411826462563;4587.655925805561;4662.953370466298;4665.04366604846;4680.555347242015;4614.169449499089;4616.630669546436;4622.191116554598;4624.653151013679;4625.768711564425;4174.269502837006;4192.496900371944;4212.662986961036;4237.555056719047;4271.914561708764;4185.602367775056;4201.68487363449;4209.095044565418;4220.704550681454;4223.134257477225;4209.536950935395;4215.894602634943;4236.9152616947795;4262.65898728101;4280.657547396217;4259.297215959363;4267.018585725301;4305.956940430587;4328.394024836525;4357.455318085239;4097.938530922039;4137.944824069873;4209;4221.957780422187;4237.8304867805255;4612.446506419217;4616.307553866914;4622.676412651116;4677.111348843743;4686.9765651171865;4917.655764096515;4928.778457651038;4934.432540257881;4943.1102401567705;5011.173156429185;4794.35276237707;4855.5387238212315;4909.558139767438;4968.726720030433;4972.03045406146;4582.908341833145;4587.564181402761;4587.842020552185;4625.560571745679;4634.142683603578;5010.198368261061;5014.473480284591;5015.699058056528;5017.648764586444;5069.03688299222;4743.573078422958;4790.928136077961;4793;4799.904001920012;4841.1285968526;4889.926651100236;4915.827946021872;4920.901581968341;4967.677100988424;4979.651424400257;4853.174960256765;4865.70805751656;4871.329471145521;4928.950710492921;4930.33440485537;4755.857324280277;4808.182608956486;4861.80552777892;4871.878203044881;4924.8276310328965;3830.0807806126327;3862.092408284051;3864.7101467390057;3865.265599536079;3872;3430.9313813723584;3488.930221395558;3491.8428670709877;3523.700485458765;3536.7524273300623;4385.912281754347;4387.934180987288;4388.407564978751;4397.428334316518;4427.269500532376;5043.117454445457;5044.772985215674;5051.87370315745;5056.494350564988;5118.360204974379;4251.022264879095;4289.892752681208;4290.89272768177;4348.543402942709;4372.256716358227;4418.9337159942625;4464.129494748558;4469.150861336336;4473.46318441789;4476.955230447719;4720.811167553259;4733.621310295237;4735.408073990751;4735.715857048451;4740.857774266778;4937.77779999908;4965.0318187953;4967.652264341606;5034.244863270539;5038.546530812245;4660.347551342883;4697.154512187839;4701.459332176843;4742.312364707167;4758.785854636619;4881.048195601824;4884.267359896044;4884.535969082932;4887.706737595756;4947.678400903929;4718.528147185254;4764.499727528698;4765.11845308619;4812.06164797861;4938.111139994836;4717.929231061606;4733.952660473489;4736.8578942631775;4787.162246606899;4794.760261986957;4726.432828060655;4727.763611819327;4735.550122738335;4737.407824021997;4796.3285140079715;4542.227821270458;4596.172688916027;4687.742174180453;4700.858974230779;4746.5490778376;4727.763611819464;4802.991371811819;4816.084943860796;4844.975775121102;4907.165781817171;4737.360456338488;4783.593394561502;4784.521547845187;4788.832390866303;4836.202026665702 16:24:08 INFO - PROCESS | 13242 | |1;ext.html;558.4917724870367;562.2072877243083;567.7587025514156;576.5358886096692;580.834462178279;26401.07596234132;27079.864600676992;38966.80516597417;39531.20937581247;39568.20863582734;38824.80587597058;39306.60693393065;39393.40909886347;39397.60602393975;39472.210555788864;7397.852042959151;7554.471187016911;7554.660040298199;7556.50882692626;7559.281868222538;7470.58911759853;7563.810904727371;7583.431242656795;7587.734429294948;7588.772336829904;7607.353374963135;7636.809079772995;7636.923630763677;7648.541087534738;7660.348870346027;7590.051243594551;7622.2758837910305;7624.390048796083;7629.732959346452;7637.121731000951;7561.281678240558;7619.695212191506;7624.656890439944;7628.389728821681;7632.656530456143;37220.44169337462;37588.43617345714;37604;37640.43539346912;37651.43522847159;2842.4457230839994;3106.642736085334;3170.889018884328;3451.9482207766905;3516.4901089342156;27515.58726619102;27573;27592.448151037068;27664.723352766418;27958.580621290697;3288.934221315584;3324.7173990210863;3380.6619338066;3408.880689175892;3468.549088618489;178380;178461;178689;179144;179581;30955.380892382025;31781.841090794398;31897.65074667173;50393;50546.74726626417;32974.83512582422;33160.668393315755;33161.66838331586;33162.8341858294;33163.3367332652;13414.597562073153;13526.32368381577;13546;13550.186988780704;13553.52562660322;11116.055135313589;11208.55165793359;11221.551137954553;11222.775544489228;11225.158113141548;7589.924100759032;7647.502912310682;7692.92307076922;7701.460897737216;7731.110922243902;2973.435047340998;3004.2639553309577;3025.198322444554;3063.693630636963;3112.719855212996;853.5518852602434;881.2553392383426;885.4642941020719;889.1597440418742;948.1798244518442;26438.339041524116;26845;27329.45341093167;27349.45301093967;27413.45173096527;760.866848301545;928.4986107501874;939.2016785732073;949.8480243161199;953.1993125774244;13318.533851315158;14006.299685015709;14270.3578338975;14403.207823569805;14462;352399;357845;358354;358549;359260;47761.52238477571;48281;48288.27567586489;48308;48330.27504587434;1043.2488608202082;1062.8671416072991;1148.534843388429;1161.19877284675;1178.5956648437264;26689.866550667124;27557.31106722348;27903.16290511288;28742.281442963256;28853.97033311472;40068.7996560027;40561;40641.796791015855;40664.1867162661;40669.79665101656;234084;234896;234963;235065;235553;24353.269401917973;25401.618975715748;25446.872765636053;25896.352591185372;26177.73822261753;36658.8167059163;36738.26523469462;37026;37547.436788448744;38095.428568572046;31641.20896977594;32098.518522222654;32104.197395065312;32458.83770581132;33169;31241.218969525944;32081.197970050936;33364.33271334511;33615.327693445506;35085.122871928404;32590.34819303648;34295.828520857234;35093.649063510056;35241;35249.82375088108;28786.7121328784;30950;31356.372872541964;31653.525197121602;31865.522017170224;24689.259322219645;24898.377540561632;24955.875220624508;25356.873215633805;25401.110961116272 16:24:08 INFO - PROCESS | 13242 | |2;jquery.html;323.9595050618673;343.6443281203956;358.6216541548666;361.26302343219834;383.81576843115306;12258.632241032772;12808.167469114513;15122.773158402633;15383.461578844757;15874.84125158748;15723.292451839667;16503.422380216696;16589.91705041473;16673.24970376333;16837.494875153734;3970.7617542947514;4842.491538388463;5064.873378165538;5072.771725272353;5074.3657042869645;4939.456659767423;5012.198048312271;5013.874653133683;5017.899642007176;5023.623228257877;4846.515348465143;4918.286848406997;4929.630277729167;4932.136876046696;4947.752612369385;4733.668643194977;4916.901661966741;4917.188663870457;4921.089598424267;4923.286123512089;4381.014271788854;4381.452318460192;4382.715123516993;4382.846600369004;4385.035292235703;19842.404727858186;20197.49506262355;20272.087756051013;20431;20469.692954605693;1760.2255007796527;1775.6263100109766;1930.1893204853995;1930.8744931579402;1933.806619338069;8849.557522123869;9074;9228.123328283802;9313.254939604816;9614.0385961404;1648.604334959613;1666.1169580122555;1672.8578070863869;1712.0925909268108;1715.579682977666;70404.6479767603;70448;71700.6414967927;73274.63362683206;74712.25287747162;9134.497602631785;9180.632774689071;9203.539823008823;9229.723108306762;9293;11942.582009629796;12108.515659373526;12153.635390938285;12210.816837747441;12409.689757756129;6472.708728107246;6814.795556133324;6886.621235832077;6901.861962760817;7023.92976070243;6792.694328755218;6843.8973415398805;6987.441004719712;6997.615131167733;7091.609961452066;3581.803000834927;3723.739338246351;3778.074371778932;3950.585188555218;4282.764447955392;1572.716910956016;1615.8061032675919;1699.9320027198773;1731.2469075952001;1778.7331900214813;803.269025187077;803.5379656697305;819.1153554161491;865.4331412924545;913.5021413329752;16215;16458.506244812674;16577.668446631;17154.39959601408;17205.311787528357;759.3204082346269;836.9790755231168;845.2815107158866;847.7160151349244;863.6588547523693;9097.681581144629;9419.199368053793;9564.13922746956;9647.951760241294;9789.853152202722;388359;400360;404300;405262;406461;67626.32373676299;67782.66108669425;70530.64734676396;73044.63477682683;79302.60348698335;867.1631875240423;905.8595917632778;912.6258234123977;917.8898532176181;921.5714692667808;15208.923955380153;15314.846851531342;15318.234088295318;15584.298706558458;16183.271752770917;34559.481607776404;35544.46683299701;35835.64164358323;36206.637933620324;36675.44986825146;47509.52490475051;50923.745381272856;51370;52331.73834130805;52764.736176318875;7145.17830449505;7384.9261507384235;7556.206598307099;7561.962190189014;7562.508436951581;9119.407238529475;10489.685309440729;10605.932854882725;10666.306690065121;10850.978110031732;9061.456312621263;9245.630174792934;9344.34589578723;9362.672306469241;9649.324547281623;9258.259339252709;9447.291453140904;9498.762530936781;9626.326157169211;9805;9223.58493867764;9543.952280238555;9687;9698.563564639468;10025.298229124182;7300.488965772345;7358.816029599303;7393.44549158826;7462.888056679046;7508.699652013858;9067.183953444222;9118.863217051883;9233.58448869816;9438.716838494856;9510.239180865652 16:24:08 INFO - PROCESS | 13242 | |3;mootools.html;1309.6660351610337;1348.73025394921;1364.8976326775487;1565.835587263338;1590.411547727341;6878.346557077082;7409.962950185255;7411.88882166768;7413.2957369049855;7415.962920185399;6109.541784366168;6390.808275751723;6885.7245710171655;7074.68163932623;7151.4993950423495;2089.937301880946;2091.3307741522717;2100.0339843671927;2110.883901385423;2121.3635909227246;2085.3838275336584;2100.348891843526;2100.653392190294;2102.6530622447276;2104.116271166114;1719.3638353809047;1784.5538615346163;1786.5622922384034;1990.5919286546296;2072.4715197624587;2056.1878058167017;2102.5899949509853;2104.7789982051895;2106.0733277357913;2110.0399318310133;2038.2152871144567;2049.4876280929766;2072.1504183284783;2105.368389483149;2110.229766135365;7151.106111736033;7215;7227.494075414723;7257.310555497219;7257.600831954241;4085.5914408558906;4224.746515209097;4229.111886503807;4230.513490948519;4239.088595951855;2664.733526647339;2753.9724602753918;2765.6819465761496;2789.734975177355;2833.5891295762203;855.4439614250724;876.7106854737921;886.6054605700466;901.3825529512305;905.7418635688863;9688.564014619358;9746.122848943629;9766.609335626637;9769.609215631366;9771;3791.696664266907;3951.5258169019903;3993.1614360983936;4031.677465802729;4051.372037334218;7152.213256541776;7392.519486233377;8375.539345335943;8396.622152003174;8398.958005210057;4235.0682849773;4370.584794444522;4375.912481750411;4378.562143785596;4379.299312110111;4025.577314382006;4028.576999415078;4032.8991775205855;4035.5964403559997;4036.1322315702264;3004.309008927959;3134.3731253749343;3147.213196700825;3214.5981752280964;3247.285597168619;959.2949182350967;990.3859607043679;993.215359865698;994.796066806303;999.7600575861886;751.9210482899326;752.4055995763395;770.9284095107805;778.1518145221736;779.7855589712874;4592.288195329729;4639.976800115978;4800.159972004885;4824.93616553491;4933.629977751683;783.7139444102861;809.2069771623842;816.4978538198965;821.219841150909;840.0087896282323;3137.498000319938;3168.255459966906;3168.7623428242514;3223.5164725291393;3262.7389808815237;8280.089190189074;8620.78448038804;8621.008584012794;8622.784430389165;8632.395732298804;8554.743357699155;8577.656893724181;8593.484390936565;8599.312055035582;8599.39804213699;6619.536632435779;6775.62734049632;6781.830454238683;6786.423154031962;6790.626515541594;4497.730136191839;4639.327297541905;4667.719936803803;4741.881452963566;4755.714657120584;8125.187481251827;8194.180581941759;8204.753857384288;8212.384071194803;8251;8117.066537348281;8273.917260827315;8364.53995030255;8407.915920840713;8410.915890841014;5875.118732190205;5949.434803693643;5963.016102343065;6011.819645410645;6012.9098063529955;6808.829779255559;6870.31296870309;6873.1064961554675;6874.4844136690945;6899.310068993262;6238.469730072995;6319.210098737658;6342.8731425370315;6368.968155159195;6471.288158302489;6169.96915015422;6175.4750846176785;6220.346863579259;6266.655333956676;6288.717007734572;5553.444655534414;5645.830625081254;5652.0674088774895;5652.208690783212;5652.632578882524;4012.277789997828;4033.4756481657196;4036.7174297800047;4136.193442278847;4228.89427764296;4065.3698676705158;4069.8372065117064;4090.938635920404;4168.708190426641;4206.997403579237 16:24:08 INFO - PROCESS | 13242 | |4;prototype.html;284.2694275711423;287.2330876559586;295.1985359748283;297.3948015787872;302.0711312713407;4624.878207210132;4722.834700785474;4830.647418722754;4869.3426387437685;4924.359833221685;4659.277811939146;4831.347768051312;4839.370881785372;4851.320815085891;4856.951430485694;3738.981305093471;3766.4162054881467;3789.7536660117144;3792.2036372361836;3796.6013568575318;3592.784432934019;3643.143861192618;3709.6475834795788;3760.2667479841443;3766.491523644314;3717.3122972250085;3750.681192098661;3758.5113935188388;3775.6402248594627;3776.66010059096;3751.7748935063846;3757.755745876509;3760.2479504099288;3777.3578491656485;3791.317562838688;3250.7886987345746;3270.2641905571295;3325.88359407422;3343.147497388175;3343.431616625155;4618.683675152565;4640.489546149921;4646.326282689025;4664;4694.906101877978;4246.978765106154;4254.574542545752;4255.063885945118;4260.637845783112;4267.871963841089;4952.62855285855;4967.130752118364;4972.950270497321;4975.925361119586;4981.9750901245625;3347.364000839857;3542.982285088584;3564.3940530109685;3565.5721313442295;3590.6588874056924;5120.974395128001;5209.19257515082;5218.452062533417;5224.529792318672;5259.447757985433;3581.5881173664843;3588.3899737044767;3596.9820150899077;3598.694111000542;3622.402303619926;3546.1489242581592;3666.8899933002053;3669.449582562637;3673.522442082512;3713.33160031197;3977.482927219443;4044.7168698190844;4084.4690190275073;4200.6219440250525;4247.49030116388;4973.8010479581135;4975.203967365276;4985.825496107619;4993.925091123636;5001.89996200074;1241.7206128620987;1250.893674037717;1253.4484826676232;1263.1726219326356;1263.286243272548;778.6924164954811;822.4078663362369;824.1675907333636;833.8415701016787;840.2018082821344;4018.1160144768105;4018.9799051004557;4035.596440355941;4043.6765058795227;4053.8783836484954;4551.340055691906;4559.726416415026;4566.862994110182;4582.450105987303;4598.172328980749;4053.7569944044644;4086.366613174963;4095.344744840811;4107.424960505532;4107.835686572504;2306.6770652108717;2439.5730747119183;2455.5757660556833;2456.4104614892653;2473.9257822265363;4369.80335884886;4384.210842048462;4390.868273951786;4400.09797991411;4405.537418571004;4686.625069994392;4697.412823397075;4701.811927522929;4710.929336059962;4724.6456515760765;4422.778861056999;4435.445569303837;4644.976775116171;4961.7519124044375;4986.252062190701;5214;5233.869153271199;5239.607029472729;5244.37067551881;5245.554127899171;5113.181890897587;5117.641765076409;5132.717700526507;5134.974325128351;5147.404304665566;4675.358422491281;4941.135301322182;4963.602911766978;4977.959036795041;4983.177775666974;3605.729570282187;3614.620464851258;3616.222512159793;3626.601073881818;3635.7636753611987;4949.480304567968;5122.8975420492125;5248.8425347239645;5276;5294.788208471772;4689.390379250675;4917.409910810726;4988.176950803077;5074.467180945948;5077.77150028257;5023.191651005562;5035.155137347387;5037.848864534069;5048;5050.696958182521;4868.2940973557925;4945.604351651931;4967.205247160437;4968.850934471827;4989.326440930428;5039.647224694236;5045.2432135180015;5045.62157838171;5063.291139240583;5083.669561478492;4939.259111133359;4946.727929963887;4952.4057113146655;4954.157793175097;4954.355933728592 16:24:08 INFO - PROCESS | 13242 | |5;yui.html;609.6159419565679;617.5090802811765;685.1812084558951;685.3934268172667;689.9275576064513;12542.498300067999;12950.935245323772;13163.078584499077;13172.670683232924;13831;14235.28823558823;14280.928595357034;14370.640733981629;14386.424543018293;14448.566543003726;541.3044238153973;725.9999999999986;740.9777706668808;741.2032065529551;741.6106544064355;549.362739222502;728.4718579030214;744.430510659346;753.2317036622669;755.6410704915177;793.9007624046994;794.5034353529045;797.3342259213564;799.7360870912585;801.7113839017949;552.9115341545373;784.1100351101541;785.1167436633787;785.1794874356283;785.7289235213842;418.97695626740517;553.7452771725011;574.0499473371576;576.0466428061522;580.7967211475992;12775.425105870258;12796.296203708793;12803.679908002281;12810.679733006657;12836.16564923277;11516.42417879111;11940.283582984961;11980.903341915217;12065.155439119266;12380.45244344457;11576.47905844239;11724.237924534878;11734.295942243492;11820.408979551074;11846.98601237783;4063.451434056394;4074.2666320062376;4077.734947228421;4148.045949431647;4154.5222299435645;61092.38907610956;61802;62482;64015.35984640141;64095.35904640941;8896.466212027299;9010.536754679559;9070.501122438329;9659.806803864023;9713.22294216461;15853.920730396505;16579.585510362336;16820.15899205035;16851.241694123793;16883.32466701343;6478.2873883872735;6558.508111891627;6585.769498067641;6641.203055633355;6713.12729345182;3410.4202285611505;3451.6720911513366;3461.6550168661233;3520.8591656333974;3648.3068217038676;2827.953657146869;2921.868515916746;2926.9268268293035;2933.457310397583;2934.9706502934696;480.1884814663278;480.3899048208825;486.4527406667499;492.50011238592856;499.3358832752503;432.8052376430556;437.24356862627195;499.75511999120897;532.3372401360331;542.156945949053;7384.667689953965;7927.8810817837775;8117.512949223065;8179.386546008954;8209.38429617781;531.415443012683;559.5188138201144;561.3348182403864;571.8856228754266;589.1192666962918;3871.922561548753;3884.436756670267;3957.6438120569287;4027.1341661542324;4070.063885306396;100534;101130.4943475278;103643;103787.48106259572;104678;83238;84926.57536712401;84981.57509212538;85072.57463712642;85136.57431712802;59989.40010599838;60366.39633603695;61399.38600614026;66876.6656166716;71997;7439.293267139613;7532.246775322424;8001;8002.51984880909;8197.508149511048;29834.850825745732;32265.51601726023;39390.606093938695;39885;40310.39534406928;54482.45517544932;58411;60111;60223.39776602178;60946.39053609407;11163;11198.44007799623;11427.257228280136;11575.652730418102;11751.177417580688;11829.526818927146;12134.271943683407;12163.148579599698;12863.421146048637;12960.287184204582;10293.897061029294;11074.5570177192;11266.211365204357;11637.243579167327;11638.70903227426;10512.474376281003;11235.606753763579;11624.302541847177;11630.825537616773;11638.76722465529;10263.435511046964;11068.335899846035;11469.08247340194;11473.483693233658;11485.483153257956;9327.626894924128;9347.766305842408;9364.204042656178;9502.382345147544;9523.380980236263;8901.109889011048;8966.193042626195;9016.143466370684;9123.589438475152;9151.542422878963 16:24:08 INFO - PROCESS | 13242 | __end_tp_report 16:24:08 INFO - PROCESS | 13242 | __start_cc_report 16:24:08 INFO - PROCESS | 13242 | _x_x_mozilla_cycle_collect,1413 16:24:08 INFO - PROCESS | 13242 | __end_cc_report 16:24:08 INFO - PROCESS | 13242 | __startTimestamp1476746648110__endTimestamp 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | ------- Summary: start ------- 16:24:08 INFO - PROCESS | 13242 | Number of tests: 6 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | [#0] dojo.html Cycles:165 Average:4546.36 Median:4717.93 stddev:493.81 (10.5%) stddev-sans-first:469.58 16:24:08 INFO - PROCESS | 13242 | Values: 2540.0 2567.2 2582.2 2591.7 2603.4 4524.4 4587.7 4663.0 4665.0 4680.6 4614.2 4616.6 4622.2 4624.7 4625.8 4174.3 4192.5 4212.7 4237.6 4271.9 4185.6 4201.7 4209.1 4220.7 4223.1 4209.5 4215.9 4236.9 4262.7 4280.7 4259.3 4267.0 4306.0 4328.4 4357.5 4097.9 4137.9 4209.0 4222.0 4237.8 4612.4 4616.3 4622.7 4677.1 4687.0 4917.7 4928.8 4934.4 4943.1 5011.2 4794.4 4855.5 4909.6 4968.7 4972.0 4582.9 4587.6 4587.8 4625.6 4634.1 5010.2 5014.5 5015.7 5017.6 5069.0 4743.6 4790.9 4793.0 4799.9 4841.1 4889.9 4915.8 4920.9 4967.7 4979.7 4853.2 4865.7 4871.3 4929.0 4930.3 4755.9 4808.2 4861.8 4871.9 4924.8 3830.1 3862.1 3864.7 3865.3 3872.0 3430.9 3488.9 3491.8 3523.7 3536.8 4385.9 4387.9 4388.4 4397.4 4427.3 5043.1 5044.8 5051.9 5056.5 5118.4 4251.0 4289.9 4290.9 4348.5 4372.3 4418.9 4464.1 4469.2 4473.5 4477.0 4720.8 4733.6 4735.4 4735.7 4740.9 4937.8 4965.0 4967.7 5034.2 5038.5 4660.3 4697.2 4701.5 4742.3 4758.8 4881.0 4884.3 4884.5 4887.7 4947.7 4718.5 4764.5 4765.1 4812.1 4938.1 4717.9 4734.0 4736.9 4787.2 4794.8 4726.4 4727.8 4735.6 4737.4 4796.3 4542.2 4596.2 4687.7 4700.9 4746.5 4727.8 4803.0 4816.1 4845.0 4907.2 4737.4 4783.6 4784.5 4788.8 4836.2 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | [#1] ext.html Cycles:180 Average:40052.27 Median:3394.77 stddev:70520.86 (2077.3%) stddev-sans-first:70656.35 16:24:08 INFO - PROCESS | 13242 | Values: 558.5 562.2 567.8 576.5 580.8 26401.1 27079.9 38966.8 39531.2 39568.2 38824.8 39306.6 39393.4 39397.6 39472.2 7397.9 7554.5 7554.7 7556.5 7559.3 7470.6 7563.8 7583.4 7587.7 7588.8 7607.4 7636.8 7636.9 7648.5 7660.3 7590.1 7622.3 7624.4 7629.7 7637.1 7561.3 7619.7 7624.7 7628.4 7632.7 37220.4 37588.4 37604.0 37640.4 37651.4 2842.4 3106.6 3170.9 3451.9 3516.5 27515.6 27573.0 27592.4 27664.7 27958.6 3288.9 3324.7 3380.7 3408.9 3468.5 178380.0 178461.0 178689.0 179144.0 179581.0 30955.4 31781.8 31897.7 50393.0 50546.7 32974.8 33160.7 33161.7 33162.8 33163.3 13414.6 13526.3 13546.0 13550.2 13553.5 11116.1 11208.6 11221.6 11222.8 11225.2 7589.9 7647.5 7692.9 7701.5 7731.1 2973.4 3004.3 3025.2 3063.7 3112.7 853.6 881.3 885.5 889.2 948.2 26438.3 26845.0 27329.5 27349.5 27413.5 760.9 928.5 939.2 949.8 953.2 13318.5 14006.3 14270.4 14403.2 14462.0 352399.0 357845.0 358354.0 358549.0 359260.0 47761.5 48281.0 48288.3 48308.0 48330.3 1043.2 1062.9 1148.5 1161.2 1178.6 26689.9 27557.3 27903.2 28742.3 28854.0 40068.8 40561.0 40641.8 40664.2 40669.8 234084.0 234896.0 234963.0 235065.0 235553.0 24353.3 25401.6 25446.9 25896.4 26177.7 36658.8 36738.3 37026.0 37547.4 38095.4 31641.2 32098.5 32104.2 32458.8 33169.0 31241.2 32081.2 33364.3 33615.3 35085.1 32590.3 34295.8 35093.6 35241.0 35249.8 28786.7 30950.0 31356.4 31653.5 31865.5 24689.3 24898.4 24955.9 25356.9 25401.1 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | [#2] jquery.html Cycles:180 Average:24097.99 Median:5015.89 stddev:66172.96 (1319.3%) stddev-sans-first:66334.52 16:24:08 INFO - PROCESS | 13242 | Values: 324.0 343.6 358.6 361.3 383.8 12258.6 12808.2 15122.8 15383.5 15874.8 15723.3 16503.4 16589.9 16673.2 16837.5 3970.8 4842.5 5064.9 5072.8 5074.4 4939.5 5012.2 5013.9 5017.9 5023.6 4846.5 4918.3 4929.6 4932.1 4947.8 4733.7 4916.9 4917.2 4921.1 4923.3 4381.0 4381.5 4382.7 4382.8 4385.0 19842.4 20197.5 20272.1 20431.0 20469.7 1760.2 1775.6 1930.2 1930.9 1933.8 8849.6 9074.0 9228.1 9313.3 9614.0 1648.6 1666.1 1672.9 1712.1 1715.6 70404.6 70448.0 71700.6 73274.6 74712.3 9134.5 9180.6 9203.5 9229.7 9293.0 11942.6 12108.5 12153.6 12210.8 12409.7 6472.7 6814.8 6886.6 6901.9 7023.9 6792.7 6843.9 6987.4 6997.6 7091.6 3581.8 3723.7 3778.1 3950.6 4282.8 1572.7 1615.8 1699.9 1731.2 1778.7 803.3 803.5 819.1 865.4 913.5 16215.0 16458.5 16577.7 17154.4 17205.3 759.3 837.0 845.3 847.7 863.7 9097.7 9419.2 9564.1 9648.0 9789.9 388359.0 400360.0 404300.0 405262.0 406461.0 67626.3 67782.7 70530.6 73044.6 79302.6 867.2 905.9 912.6 917.9 921.6 15208.9 15314.8 15318.2 15584.3 16183.3 34559.5 35544.5 35835.6 36206.6 36675.4 47509.5 50923.7 51370.0 52331.7 52764.7 7145.2 7384.9 7556.2 7562.0 7562.5 9119.4 10489.7 10605.9 10666.3 10851.0 9061.5 9245.6 9344.3 9362.7 9649.3 9258.3 9447.3 9498.8 9626.3 9805.0 9223.6 9544.0 9687.0 9698.6 10025.3 7300.5 7358.8 7393.4 7462.9 7508.7 9067.2 9118.9 9233.6 9438.7 9510.2 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | [#3] mootools.html Cycles:180 Average:4688.50 Median:5912.28 stddev:2593.59 (43.9%) stddev-sans-first:2588.43 16:24:08 INFO - PROCESS | 13242 | Values: 1309.7 1348.7 1364.9 1565.8 1590.4 6878.3 7410.0 7411.9 7413.3 7416.0 6109.5 6390.8 6885.7 7074.7 7151.5 2089.9 2091.3 2100.0 2110.9 2121.4 2085.4 2100.3 2100.7 2102.7 2104.1 1719.4 1784.6 1786.6 1990.6 2072.5 2056.2 2102.6 2104.8 2106.1 2110.0 2038.2 2049.5 2072.2 2105.4 2110.2 7151.1 7215.0 7227.5 7257.3 7257.6 4085.6 4224.7 4229.1 4230.5 4239.1 2664.7 2754.0 2765.7 2789.7 2833.6 855.4 876.7 886.6 901.4 905.7 9688.6 9746.1 9766.6 9769.6 9771.0 3791.7 3951.5 3993.2 4031.7 4051.4 7152.2 7392.5 8375.5 8396.6 8399.0 4235.1 4370.6 4375.9 4378.6 4379.3 4025.6 4028.6 4032.9 4035.6 4036.1 3004.3 3134.4 3147.2 3214.6 3247.3 959.3 990.4 993.2 994.8 999.8 751.9 752.4 770.9 778.2 779.8 4592.3 4640.0 4800.2 4824.9 4933.6 783.7 809.2 816.5 821.2 840.0 3137.5 3168.3 3168.8 3223.5 3262.7 8280.1 8620.8 8621.0 8622.8 8632.4 8554.7 8577.7 8593.5 8599.3 8599.4 6619.5 6775.6 6781.8 6786.4 6790.6 4497.7 4639.3 4667.7 4741.9 4755.7 8125.2 8194.2 8204.8 8212.4 8251.0 8117.1 8273.9 8364.5 8407.9 8410.9 5875.1 5949.4 5963.0 6011.8 6012.9 6808.8 6870.3 6873.1 6874.5 6899.3 6238.5 6319.2 6342.9 6369.0 6471.3 6170.0 6175.5 6220.3 6266.7 6288.7 5553.4 5645.8 5652.1 5652.2 5652.6 4012.3 4033.5 4036.7 4136.2 4228.9 4065.4 4069.8 4090.9 4168.7 4207.0 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | [#4] prototype.html Cycles:180 Average:4087.43 Median:4590.31 stddev:1201.48 (26.2%) stddev-sans-first:1170.45 16:24:08 INFO - PROCESS | 13242 | Values: 284.3 287.2 295.2 297.4 302.1 4624.9 4722.8 4830.6 4869.3 4924.4 4659.3 4831.3 4839.4 4851.3 4857.0 3739.0 3766.4 3789.8 3792.2 3796.6 3592.8 3643.1 3709.6 3760.3 3766.5 3717.3 3750.7 3758.5 3775.6 3776.7 3751.8 3757.8 3760.2 3777.4 3791.3 3250.8 3270.3 3325.9 3343.1 3343.4 4618.7 4640.5 4646.3 4664.0 4694.9 4247.0 4254.6 4255.1 4260.6 4267.9 4952.6 4967.1 4973.0 4975.9 4982.0 3347.4 3543.0 3564.4 3565.6 3590.7 5121.0 5209.2 5218.5 5224.5 5259.4 3581.6 3588.4 3597.0 3598.7 3622.4 3546.1 3666.9 3669.4 3673.5 3713.3 3977.5 4044.7 4084.5 4200.6 4247.5 4973.8 4975.2 4985.8 4993.9 5001.9 1241.7 1250.9 1253.4 1263.2 1263.3 778.7 822.4 824.2 833.8 840.2 4018.1 4019.0 4035.6 4043.7 4053.9 4551.3 4559.7 4566.9 4582.5 4598.2 4053.8 4086.4 4095.3 4107.4 4107.8 2306.7 2439.6 2455.6 2456.4 2473.9 4369.8 4384.2 4390.9 4400.1 4405.5 4686.6 4697.4 4701.8 4710.9 4724.6 4422.8 4435.4 4645.0 4961.8 4986.3 5214.0 5233.9 5239.6 5244.4 5245.6 5113.2 5117.6 5132.7 5135.0 5147.4 4675.4 4941.1 4963.6 4978.0 4983.2 3605.7 3614.6 3616.2 3626.6 3635.8 4949.5 5122.9 5248.8 5276.0 5294.8 4689.4 4917.4 4988.2 5074.5 5077.8 5023.2 5035.2 5037.8 5048.0 5050.7 4868.3 4945.6 4967.2 4968.9 4989.3 5039.6 5045.2 5045.6 5063.3 5083.7 4939.3 4946.7 4952.4 4954.2 4954.4 16:24:08 INFO - PROCESS | 13242 | 16:24:08 INFO - PROCESS | 13242 | [#5] yui.html Cycles:180 Average:17159.79 Median:489.48 stddev:24928.31 (5092.9%) stddev-sans-first:24967.26 16:24:08 INFO - PROCESS | 13242 | Values: 609.6 617.5 685.2 685.4 689.9 12542.5 12950.9 13163.1 13172.7 13831.0 14235.3 14280.9 14370.6 14386.4 14448.6 541.3 726.0 741.0 741.2 741.6 549.4 728.5 744.4 753.2 755.6 793.9 794.5 797.3 799.7 801.7 552.9 784.1 785.1 785.2 785.7 419.0 553.7 574.0 576.0 580.8 12775.4 12796.3 12803.7 12810.7 12836.2 11516.4 11940.3 11980.9 12065.2 12380.5 11576.5 11724.2 11734.3 11820.4 11847.0 4063.5 4074.3 4077.7 4148.0 4154.5 61092.4 61802.0 62482.0 64015.4 64095.4 8896.5 9010.5 9070.5 9659.8 9713.2 15853.9 16579.6 16820.2 16851.2 16883.3 6478.3 6558.5 6585.8 6641.2 6713.1 3410.4 3451.7 3461.7 3520.9 3648.3 2828.0 2921.9 2926.9 2933.5 2935.0 480.2 480.4 486.5 492.5 499.3 432.8 437.2 499.8 532.3 542.2 7384.7 7927.9 8117.5 8179.4 8209.4 531.4 559.5 561.3 571.9 589.1 3871.9 3884.4 3957.6 4027.1 4070.1 100534.0 101130.5 103643.0 103787.5 104678.0 83238.0 84926.6 84981.6 85072.6 85136.6 59989.4 60366.4 61399.4 66876.7 71997.0 7439.3 7532.2 8001.0 8002.5 8197.5 29834.9 32265.5 39390.6 39885.0 40310.4 54482.5 58411.0 60111.0 60223.4 60946.4 11163.0 11198.4 11427.3 11575.7 11751.2 11829.5 12134.3 12163.1 12863.4 12960.3 10293.9 11074.6 11266.2 11637.2 11638.7 10512.5 11235.6 11624.3 11630.8 11638.8 10263.4 11068.3 11469.1 11473.5 11485.5 9327.6 9347.8 9364.2 9502.4 9523.4 8901.1 8966.2 9016.1 9123.6 9151.5 16:24:08 INFO - PROCESS | 13242 | -------- Summary: end -------- 16:24:08 INFO - PROCESS | 13242 | 16:24:09 INFO - TEST-INFO | 13242: exit 0 16:24:09 INFO - TEST-OK | dromaeo_css | took 1122388ms 16:24:09 INFO - TEST-START | kraken 16:24:09 INFO - operating with platform_type : linux_ 16:24:09 INFO - Initialising browser for kraken test... 16:24:09 INFO - TEST-INFO | started process 13547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSIE6A8/profile http://localhost:48668/getInfo.html) 16:24:13 INFO - PROCESS | 13547 | __metrics Screen width/height:1600/1200 16:24:13 INFO - PROCESS | 13547 | colorDepth:24 16:24:13 INFO - PROCESS | 13547 | Browser inner width/height: 1024/697 16:24:13 INFO - PROCESS | 13547 | __metrics 16:24:14 INFO - PROCESS | 13547 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:24:14 INFO - PROCESS | 13547 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:14 INFO - PROCESS | 13547 | console.error: PushService: 16:24:14 INFO - PROCESS | 13547 | stateChangeProcessEnqueue: Error transitioning state 16:24:14 INFO - PROCESS | 13547 | UnknownError 16:24:15 INFO - TEST-INFO | 13547: exit 0 16:24:15 INFO - Browser initialized. 16:24:15 INFO - Running cycle 1/1 for kraken test... 16:24:15 INFO - TEST-INFO | started process 13628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSIE6A8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:27 INFO - PROCESS | 13628 | RSS: Main: 176492544 16:24:27 INFO - PROCESS | 13628 | 16:24:30 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48668/tests/kraken/driver.html?testName=audio-beat-detection) 16:24:31 INFO - PROCESS | 13628 | RSS: Main: 235261952 16:24:31 INFO - PROCESS | 13628 | 16:24:34 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48668/tests/kraken/driver.html?testName=audio-dft) 16:24:34 INFO - PROCESS | 13628 | RSS: Main: 220561408 16:24:34 INFO - PROCESS | 13628 | 16:24:38 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48668/tests/kraken/driver.html?testName=audio-fft) 16:24:38 INFO - PROCESS | 13628 | RSS: Main: 301989888 16:24:38 INFO - PROCESS | 13628 | 16:24:40 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48668/tests/kraken/driver.html?testName=audio-oscillator) 16:24:41 INFO - PROCESS | 13628 | RSS: Main: 213225472 16:24:41 INFO - PROCESS | 13628 | 16:24:43 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:24:44 INFO - PROCESS | 13628 | RSS: Main: 215703552 16:24:44 INFO - PROCESS | 13628 | 16:24:47 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48668/tests/kraken/driver.html?testName=imaging-darkroom) 16:24:48 INFO - PROCESS | 13628 | RSS: Main: 251830272 16:24:48 INFO - PROCESS | 13628 | 16:24:51 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48668/tests/kraken/driver.html?testName=imaging-desaturate) 16:24:52 INFO - PROCESS | 13628 | RSS: Main: 245714944 16:24:52 INFO - PROCESS | 13628 | 16:24:55 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48668/tests/kraken/driver.html?testName=json-parse-financial) 16:24:55 INFO - PROCESS | 13628 | RSS: Main: 248582144 16:24:55 INFO - PROCESS | 13628 | 16:24:57 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:24:58 INFO - PROCESS | 13628 | RSS: Main: 212529152 16:24:58 INFO - PROCESS | 13628 | 16:25:00 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:00 INFO - PROCESS | 13628 | RSS: Main: 219996160 16:25:00 INFO - PROCESS | 13628 | 16:25:02 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:03 INFO - PROCESS | 13628 | RSS: Main: 228335616 16:25:03 INFO - PROCESS | 13628 | 16:25:06 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:07 INFO - PROCESS | 13628 | RSS: Main: 237072384 16:25:07 INFO - PROCESS | 13628 | 16:25:10 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:10 INFO - PROCESS | 13628 | RSS: Main: 234307584 16:25:10 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | Cycle 1(1): loaded http://localhost:48668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48668/tests/kraken/driver.html?testName=ai-astar) 16:25:12 INFO - PROCESS | 13628 | RSS: Main: 285073408 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | __start_tp_report 16:25:12 INFO - PROCESS | 13628 | _x_x_mozilla_page_load 16:25:12 INFO - PROCESS | 13628 | _x_x_mozilla_page_load_details 16:25:12 INFO - PROCESS | 13628 | |i|pagename|runs| 16:25:12 INFO - PROCESS | 13628 | |0;ai-astar;112;116;113;115;115;115;114;114;115;113 16:25:12 INFO - PROCESS | 13628 | |1;audio-beat-detection;159;131;125;174;128;127;128;138;162;128 16:25:12 INFO - PROCESS | 13628 | |2;audio-dft;163;161;164;162;161;160;160;161;161;161 16:25:12 INFO - PROCESS | 13628 | |3;audio-fft;75;77;77;113;76;77;77;77;101;76 16:25:12 INFO - PROCESS | 13628 | |4;audio-oscillator;83;83;115;84;85;83;105;83;83;128 16:25:12 INFO - PROCESS | 13628 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;118 16:25:12 INFO - PROCESS | 13628 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;147;147 16:25:12 INFO - PROCESS | 13628 | |7;imaging-desaturate;94;95;95;95;95;95;96;95;95;95 16:25:12 INFO - PROCESS | 13628 | |8;json-parse-financial;64;64;66;64;64;65;66;65;65;65 16:25:12 INFO - PROCESS | 13628 | |9;json-stringify-tinderbox;64;66;65;66;67;66;67;67;67;67 16:25:12 INFO - PROCESS | 13628 | |10;stanford-crypto-aes;83;84;83;94;90;85;82;82;83;85 16:25:12 INFO - PROCESS | 13628 | |11;stanford-crypto-ccm;141;142;146;136;137;139;137;134;179;139 16:25:12 INFO - PROCESS | 13628 | |12;stanford-crypto-pbkdf2;175;182;179;179;175;176;174;178;176;176 16:25:12 INFO - PROCESS | 13628 | |13;stanford-crypto-sha256-iterative;70;71;70;70;70;70;70;70;68;70 16:25:12 INFO - PROCESS | 13628 | __end_tp_report 16:25:12 INFO - PROCESS | 13628 | __start_cc_report 16:25:12 INFO - PROCESS | 13628 | _x_x_mozilla_cycle_collect,2000 16:25:12 INFO - PROCESS | 13628 | __end_cc_report 16:25:12 INFO - PROCESS | 13628 | __startTimestamp1476746712754__endTimestamp 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | ------- Summary: start ------- 16:25:12 INFO - PROCESS | 13628 | Number of tests: 14 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:1.23 (1.1%) stddev-sans-first:1.01 16:25:12 INFO - PROCESS | 13628 | Values: 112.0 116.0 113.0 115.0 115.0 115.0 114.0 114.0 115.0 113.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:134.50 stddev:17.99 (13.4%) stddev-sans-first:17.72 16:25:12 INFO - PROCESS | 13628 | Values: 159.0 131.0 125.0 174.0 128.0 127.0 128.0 138.0 162.0 128.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 16:25:12 INFO - PROCESS | 13628 | Values: 163.0 161.0 164.0 162.0 161.0 160.0 160.0 161.0 161.0 161.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:13.18 (17.1%) stddev-sans-first:13.69 16:25:12 INFO - PROCESS | 13628 | Values: 75.0 77.0 77.0 113.0 76.0 77.0 77.0 77.0 101.0 76.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:83.00 stddev:16.66 (20.1%) stddev-sans-first:17.26 16:25:12 INFO - PROCESS | 13628 | Values: 83.0 83.0 115.0 84.0 85.0 83.0 105.0 83.0 83.0 128.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:25:12 INFO - PROCESS | 13628 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:25:12 INFO - PROCESS | 13628 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 16:25:12 INFO - PROCESS | 13628 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 16:25:12 INFO - PROCESS | 13628 | Values: 64.0 64.0 66.0 64.0 64.0 65.0 66.0 65.0 65.0 65.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:0.73 16:25:12 INFO - PROCESS | 13628 | Values: 64.0 66.0 65.0 66.0 67.0 66.0 67.0 67.0 67.0 67.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:3.90 (4.6%) stddev-sans-first:4.06 16:25:12 INFO - PROCESS | 13628 | Values: 83.0 84.0 83.0 94.0 90.0 85.0 82.0 82.0 83.0 85.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:140.00 stddev:13.10 (9.4%) stddev-sans-first:13.87 16:25:12 INFO - PROCESS | 13628 | Values: 141.0 142.0 146.0 136.0 137.0 139.0 137.0 134.0 179.0 139.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.00 stddev:2.45 (1.4%) stddev-sans-first:2.49 16:25:12 INFO - PROCESS | 13628 | Values: 175.0 182.0 179.0 179.0 175.0 176.0 174.0 178.0 176.0 176.0 16:25:12 INFO - PROCESS | 13628 | 16:25:12 INFO - PROCESS | 13628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 16:25:12 INFO - PROCESS | 13628 | Values: 70.0 71.0 70.0 70.0 70.0 70.0 70.0 70.0 68.0 70.0 16:25:12 INFO - PROCESS | 13628 | -------- Summary: end -------- 16:25:12 INFO - PROCESS | 13628 | 16:25:14 INFO - TEST-INFO | 13628: exit 0 16:25:14 INFO - TEST-OK | kraken | took 65076ms 16:25:14 INFO - SUITE-END | took 1187s 16:25:14 INFO - Completed test suite (00:19:47) 16:25:14 INFO - javascript benchmark 16:25:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2539.9746002539973, 2567.1528395629443, 2582.22533240028, 2591.6889973203206, 2603.4402603440267, 4524.411826462563, 4587.655925805561, 4662.953370466298, 4665.04366604846, 4680.555347242015, 4614.169449499089, 4616.630669546436, 4622.191116554598, 4624.653151013679, 4625.768711564425, 4174.269502837006, 4192.496900371944, 4212.662986961036, 4237.555056719047, 4271.914561708764, 4185.602367775056, 4201.68487363449, 4209.095044565418, 4220.704550681454, 4223.134257477225, 4209.536950935395, 4215.894602634943, 4236.9152616947795, 4262.65898728101, 4280.657547396217, 4259.297215959363, 4267.018585725301, 4305.956940430587, 4328.394024836525, 4357.455318085239, 4097.938530922039, 4137.944824069873, 4209.0, 4221.957780422187, 4237.8304867805255, 4612.446506419217, 4616.307553866914, 4622.676412651116, 4677.111348843743, 4686.9765651171865, 4917.655764096515, 4928.778457651038, 4934.432540257881, 4943.1102401567705, 5011.173156429185, 4794.35276237707, 4855.5387238212315, 4909.558139767438, 4968.726720030433, 4972.03045406146, 4582.908341833145, 4587.564181402761, 4587.842020552185, 4625.560571745679, 4634.142683603578, 5010.198368261061, 5014.473480284591, 5015.699058056528, 5017.648764586444, 5069.03688299222, 4743.573078422958, 4790.928136077961, 4793.0, 4799.904001920012, 4841.1285968526, 4889.926651100236, 4915.827946021872, 4920.901581968341, 4967.677100988424, 4979.651424400257, 4853.174960256765, 4865.70805751656, 4871.329471145521, 4928.950710492921, 4930.33440485537, 4755.857324280277, 4808.182608956486, 4861.80552777892, 4871.878203044881, 4924.8276310328965, 3830.0807806126327, 3862.092408284051, 3864.7101467390057, 3865.265599536079, 3872.0, 3430.9313813723584, 3488.930221395558, 3491.8428670709877, 3523.700485458765, 3536.7524273300623, 4385.912281754347, 4387.934180987288, 4388.407564978751, 4397.428334316518, 4427.269500532376, 5043.117454445457, 5044.772985215674, 5051.87370315745, 5056.494350564988, 5118.360204974379, 4251.022264879095, 4289.892752681208, 4290.89272768177, 4348.543402942709, 4372.256716358227, 4418.9337159942625, 4464.129494748558, 4469.150861336336, 4473.46318441789, 4476.955230447719, 4720.811167553259, 4733.621310295237, 4735.408073990751, 4735.715857048451, 4740.857774266778, 4937.77779999908, 4965.0318187953, 4967.652264341606, 5034.244863270539, 5038.546530812245, 4660.347551342883, 4697.154512187839, 4701.459332176843, 4742.312364707167, 4758.785854636619, 4881.048195601824, 4884.267359896044, 4884.535969082932, 4887.706737595756, 4947.678400903929, 4718.528147185254, 4764.499727528698, 4765.11845308619, 4812.06164797861, 4938.111139994836, 4717.929231061606, 4733.952660473489, 4736.8578942631775, 4787.162246606899, 4794.760261986957, 4726.432828060655, 4727.763611819327, 4735.550122738335, 4737.407824021997, 4796.3285140079715, 4542.227821270458, 4596.172688916027, 4687.742174180453, 4700.858974230779, 4746.5490778376, 4727.763611819464, 4802.991371811819, 4816.084943860796, 4844.975775121102, 4907.165781817171, 4737.360456338488, 4783.593394561502, 4784.521547845187, 4788.832390866303, 4836.202026665702], "value": 4513.754793996789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.4917724870367, 562.2072877243083, 567.7587025514156, 576.5358886096692, 580.834462178279, 26401.07596234132, 27079.864600676992, 38966.80516597417, 39531.20937581247, 39568.20863582734, 38824.80587597058, 39306.60693393065, 39393.40909886347, 39397.60602393975, 39472.210555788864, 7397.852042959151, 7554.471187016911, 7554.660040298199, 7556.50882692626, 7559.281868222538, 7470.58911759853, 7563.810904727371, 7583.431242656795, 7587.734429294948, 7588.772336829904, 7607.353374963135, 7636.809079772995, 7636.923630763677, 7648.541087534738, 7660.348870346027, 7590.051243594551, 7622.2758837910305, 7624.390048796083, 7629.732959346452, 7637.121731000951, 7561.281678240558, 7619.695212191506, 7624.656890439944, 7628.389728821681, 7632.656530456143, 37220.44169337462, 37588.43617345714, 37604.0, 37640.43539346912, 37651.43522847159, 2842.4457230839994, 3106.642736085334, 3170.889018884328, 3451.9482207766905, 3516.4901089342156, 27515.58726619102, 27573.0, 27592.448151037068, 27664.723352766418, 27958.580621290697, 3288.934221315584, 3324.7173990210863, 3380.6619338066, 3408.880689175892, 3468.549088618489, 178380.0, 178461.0, 178689.0, 179144.0, 179581.0, 30955.380892382025, 31781.841090794398, 31897.65074667173, 50393.0, 50546.74726626417, 32974.83512582422, 33160.668393315755, 33161.66838331586, 33162.8341858294, 33163.3367332652, 13414.597562073153, 13526.32368381577, 13546.0, 13550.186988780704, 13553.52562660322, 11116.055135313589, 11208.55165793359, 11221.551137954553, 11222.775544489228, 11225.158113141548, 7589.924100759032, 7647.502912310682, 7692.92307076922, 7701.460897737216, 7731.110922243902, 2973.435047340998, 3004.2639553309577, 3025.198322444554, 3063.693630636963, 3112.719855212996, 853.5518852602434, 881.2553392383426, 885.4642941020719, 889.1597440418742, 948.1798244518442, 26438.339041524116, 26845.0, 27329.45341093167, 27349.45301093967, 27413.45173096527, 760.866848301545, 928.4986107501874, 939.2016785732073, 949.8480243161199, 953.1993125774244, 13318.533851315158, 14006.299685015709, 14270.3578338975, 14403.207823569805, 14462.0, 352399.0, 357845.0, 358354.0, 358549.0, 359260.0, 47761.52238477571, 48281.0, 48288.27567586489, 48308.0, 48330.27504587434, 1043.2488608202082, 1062.8671416072991, 1148.534843388429, 1161.19877284675, 1178.5956648437264, 26689.866550667124, 27557.31106722348, 27903.16290511288, 28742.281442963256, 28853.97033311472, 40068.7996560027, 40561.0, 40641.796791015855, 40664.1867162661, 40669.79665101656, 234084.0, 234896.0, 234963.0, 235065.0, 235553.0, 24353.269401917973, 25401.618975715748, 25446.872765636053, 25896.352591185372, 26177.73822261753, 36658.8167059163, 36738.26523469462, 37026.0, 37547.436788448744, 38095.428568572046, 31641.20896977594, 32098.518522222654, 32104.197395065312, 32458.83770581132, 33169.0, 31241.218969525944, 32081.197970050936, 33364.33271334511, 33615.327693445506, 35085.122871928404, 32590.34819303648, 34295.828520857234, 35093.649063510056, 35241.0, 35249.82375088108, 28786.7121328784, 30950.0, 31356.372872541964, 31653.525197121602, 31865.522017170224, 24689.259322219645, 24898.377540561632, 24955.875220624508, 25356.873215633805, 25401.110961116272], "value": 15531.554826455556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.9595050618673, 343.6443281203956, 358.6216541548666, 361.26302343219834, 383.81576843115306, 12258.632241032772, 12808.167469114513, 15122.773158402633, 15383.461578844757, 15874.84125158748, 15723.292451839667, 16503.422380216696, 16589.91705041473, 16673.24970376333, 16837.494875153734, 3970.7617542947514, 4842.491538388463, 5064.873378165538, 5072.771725272353, 5074.3657042869645, 4939.456659767423, 5012.198048312271, 5013.874653133683, 5017.899642007176, 5023.623228257877, 4846.515348465143, 4918.286848406997, 4929.630277729167, 4932.136876046696, 4947.752612369385, 4733.668643194977, 4916.901661966741, 4917.188663870457, 4921.089598424267, 4923.286123512089, 4381.014271788854, 4381.452318460192, 4382.715123516993, 4382.846600369004, 4385.035292235703, 19842.404727858186, 20197.49506262355, 20272.087756051013, 20431.0, 20469.692954605693, 1760.2255007796527, 1775.6263100109766, 1930.1893204853995, 1930.8744931579402, 1933.806619338069, 8849.557522123869, 9074.0, 9228.123328283802, 9313.254939604816, 9614.0385961404, 1648.604334959613, 1666.1169580122555, 1672.8578070863869, 1712.0925909268108, 1715.579682977666, 70404.6479767603, 70448.0, 71700.6414967927, 73274.63362683206, 74712.25287747162, 9134.497602631785, 9180.632774689071, 9203.539823008823, 9229.723108306762, 9293.0, 11942.582009629796, 12108.515659373526, 12153.635390938285, 12210.816837747441, 12409.689757756129, 6472.708728107246, 6814.795556133324, 6886.621235832077, 6901.861962760817, 7023.92976070243, 6792.694328755218, 6843.8973415398805, 6987.441004719712, 6997.615131167733, 7091.609961452066, 3581.803000834927, 3723.739338246351, 3778.074371778932, 3950.585188555218, 4282.764447955392, 1572.716910956016, 1615.8061032675919, 1699.9320027198773, 1731.2469075952001, 1778.7331900214813, 803.269025187077, 803.5379656697305, 819.1153554161491, 865.4331412924545, 913.5021413329752, 16215.0, 16458.506244812674, 16577.668446631, 17154.39959601408, 17205.311787528357, 759.3204082346269, 836.9790755231168, 845.2815107158866, 847.7160151349244, 863.6588547523693, 9097.681581144629, 9419.199368053793, 9564.13922746956, 9647.951760241294, 9789.853152202722, 388359.0, 400360.0, 404300.0, 405262.0, 406461.0, 67626.32373676299, 67782.66108669425, 70530.64734676396, 73044.63477682683, 79302.60348698335, 867.1631875240423, 905.8595917632778, 912.6258234123977, 917.8898532176181, 921.5714692667808, 15208.923955380153, 15314.846851531342, 15318.234088295318, 15584.298706558458, 16183.271752770917, 34559.481607776404, 35544.46683299701, 35835.64164358323, 36206.637933620324, 36675.44986825146, 47509.52490475051, 50923.745381272856, 51370.0, 52331.73834130805, 52764.736176318875, 7145.17830449505, 7384.9261507384235, 7556.206598307099, 7561.962190189014, 7562.508436951581, 9119.407238529475, 10489.685309440729, 10605.932854882725, 10666.306690065121, 10850.978110031732, 9061.456312621263, 9245.630174792934, 9344.34589578723, 9362.672306469241, 9649.324547281623, 9258.259339252709, 9447.291453140904, 9498.762530936781, 9626.326157169211, 9805.0, 9223.58493867764, 9543.952280238555, 9687.0, 9698.563564639468, 10025.298229124182, 7300.488965772345, 7358.816029599303, 7393.44549158826, 7462.888056679046, 7508.699652013858, 9067.183953444222, 9118.863217051883, 9233.58448869816, 9438.716838494856, 9510.239180865652], "value": 7771.085012818996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6660351610337, 1348.73025394921, 1364.8976326775487, 1565.835587263338, 1590.411547727341, 6878.346557077082, 7409.962950185255, 7411.88882166768, 7413.2957369049855, 7415.962920185399, 6109.541784366168, 6390.808275751723, 6885.7245710171655, 7074.68163932623, 7151.4993950423495, 2089.937301880946, 2091.3307741522717, 2100.0339843671927, 2110.883901385423, 2121.3635909227246, 2085.3838275336584, 2100.348891843526, 2100.653392190294, 2102.6530622447276, 2104.116271166114, 1719.3638353809047, 1784.5538615346163, 1786.5622922384034, 1990.5919286546296, 2072.4715197624587, 2056.1878058167017, 2102.5899949509853, 2104.7789982051895, 2106.0733277357913, 2110.0399318310133, 2038.2152871144567, 2049.4876280929766, 2072.1504183284783, 2105.368389483149, 2110.229766135365, 7151.106111736033, 7215.0, 7227.494075414723, 7257.310555497219, 7257.600831954241, 4085.5914408558906, 4224.746515209097, 4229.111886503807, 4230.513490948519, 4239.088595951855, 2664.733526647339, 2753.9724602753918, 2765.6819465761496, 2789.734975177355, 2833.5891295762203, 855.4439614250724, 876.7106854737921, 886.6054605700466, 901.3825529512305, 905.7418635688863, 9688.564014619358, 9746.122848943629, 9766.609335626637, 9769.609215631366, 9771.0, 3791.696664266907, 3951.5258169019903, 3993.1614360983936, 4031.677465802729, 4051.372037334218, 7152.213256541776, 7392.519486233377, 8375.539345335943, 8396.622152003174, 8398.958005210057, 4235.0682849773, 4370.584794444522, 4375.912481750411, 4378.562143785596, 4379.299312110111, 4025.577314382006, 4028.576999415078, 4032.8991775205855, 4035.5964403559997, 4036.1322315702264, 3004.309008927959, 3134.3731253749343, 3147.213196700825, 3214.5981752280964, 3247.285597168619, 959.2949182350967, 990.3859607043679, 993.215359865698, 994.796066806303, 999.7600575861886, 751.9210482899326, 752.4055995763395, 770.9284095107805, 778.1518145221736, 779.7855589712874, 4592.288195329729, 4639.976800115978, 4800.159972004885, 4824.93616553491, 4933.629977751683, 783.7139444102861, 809.2069771623842, 816.4978538198965, 821.219841150909, 840.0087896282323, 3137.498000319938, 3168.255459966906, 3168.7623428242514, 3223.5164725291393, 3262.7389808815237, 8280.089190189074, 8620.78448038804, 8621.008584012794, 8622.784430389165, 8632.395732298804, 8554.743357699155, 8577.656893724181, 8593.484390936565, 8599.312055035582, 8599.39804213699, 6619.536632435779, 6775.62734049632, 6781.830454238683, 6786.423154031962, 6790.626515541594, 4497.730136191839, 4639.327297541905, 4667.719936803803, 4741.881452963566, 4755.714657120584, 8125.187481251827, 8194.180581941759, 8204.753857384288, 8212.384071194803, 8251.0, 8117.066537348281, 8273.917260827315, 8364.53995030255, 8407.915920840713, 8410.915890841014, 5875.118732190205, 5949.434803693643, 5963.016102343065, 6011.819645410645, 6012.9098063529955, 6808.829779255559, 6870.31296870309, 6873.1064961554675, 6874.4844136690945, 6899.310068993262, 6238.469730072995, 6319.210098737658, 6342.8731425370315, 6368.968155159195, 6471.288158302489, 6169.96915015422, 6175.4750846176785, 6220.346863579259, 6266.655333956676, 6288.717007734572, 5553.444655534414, 5645.830625081254, 5652.0674088774895, 5652.208690783212, 5652.632578882524, 4012.277789997828, 4033.4756481657196, 4036.7174297800047, 4136.193442278847, 4228.89427764296, 4065.3698676705158, 4069.8372065117064, 4090.938635920404, 4168.708190426641, 4206.997403579237], "value": 3796.7636530384652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2694275711423, 287.2330876559586, 295.1985359748283, 297.3948015787872, 302.0711312713407, 4624.878207210132, 4722.834700785474, 4830.647418722754, 4869.3426387437685, 4924.359833221685, 4659.277811939146, 4831.347768051312, 4839.370881785372, 4851.320815085891, 4856.951430485694, 3738.981305093471, 3766.4162054881467, 3789.7536660117144, 3792.2036372361836, 3796.6013568575318, 3592.784432934019, 3643.143861192618, 3709.6475834795788, 3760.2667479841443, 3766.491523644314, 3717.3122972250085, 3750.681192098661, 3758.5113935188388, 3775.6402248594627, 3776.66010059096, 3751.7748935063846, 3757.755745876509, 3760.2479504099288, 3777.3578491656485, 3791.317562838688, 3250.7886987345746, 3270.2641905571295, 3325.88359407422, 3343.147497388175, 3343.431616625155, 4618.683675152565, 4640.489546149921, 4646.326282689025, 4664.0, 4694.906101877978, 4246.978765106154, 4254.574542545752, 4255.063885945118, 4260.637845783112, 4267.871963841089, 4952.62855285855, 4967.130752118364, 4972.950270497321, 4975.925361119586, 4981.9750901245625, 3347.364000839857, 3542.982285088584, 3564.3940530109685, 3565.5721313442295, 3590.6588874056924, 5120.974395128001, 5209.19257515082, 5218.452062533417, 5224.529792318672, 5259.447757985433, 3581.5881173664843, 3588.3899737044767, 3596.9820150899077, 3598.694111000542, 3622.402303619926, 3546.1489242581592, 3666.8899933002053, 3669.449582562637, 3673.522442082512, 3713.33160031197, 3977.482927219443, 4044.7168698190844, 4084.4690190275073, 4200.6219440250525, 4247.49030116388, 4973.8010479581135, 4975.203967365276, 4985.825496107619, 4993.925091123636, 5001.89996200074, 1241.7206128620987, 1250.893674037717, 1253.4484826676232, 1263.1726219326356, 1263.286243272548, 778.6924164954811, 822.4078663362369, 824.1675907333636, 833.8415701016787, 840.2018082821344, 4018.1160144768105, 4018.9799051004557, 4035.596440355941, 4043.6765058795227, 4053.8783836484954, 4551.340055691906, 4559.726416415026, 4566.862994110182, 4582.450105987303, 4598.172328980749, 4053.7569944044644, 4086.366613174963, 4095.344744840811, 4107.424960505532, 4107.835686572504, 2306.6770652108717, 2439.5730747119183, 2455.5757660556833, 2456.4104614892653, 2473.9257822265363, 4369.80335884886, 4384.210842048462, 4390.868273951786, 4400.09797991411, 4405.537418571004, 4686.625069994392, 4697.412823397075, 4701.811927522929, 4710.929336059962, 4724.6456515760765, 4422.778861056999, 4435.445569303837, 4644.976775116171, 4961.7519124044375, 4986.252062190701, 5214.0, 5233.869153271199, 5239.607029472729, 5244.37067551881, 5245.554127899171, 5113.181890897587, 5117.641765076409, 5132.717700526507, 5134.974325128351, 5147.404304665566, 4675.358422491281, 4941.135301322182, 4963.602911766978, 4977.959036795041, 4983.177775666974, 3605.729570282187, 3614.620464851258, 3616.222512159793, 3626.601073881818, 3635.7636753611987, 4949.480304567968, 5122.8975420492125, 5248.8425347239645, 5276.0, 5294.788208471772, 4689.390379250675, 4917.409910810726, 4988.176950803077, 5074.467180945948, 5077.77150028257, 5023.191651005562, 5035.155137347387, 5037.848864534069, 5048.0, 5050.696958182521, 4868.2940973557925, 4945.604351651931, 4967.205247160437, 4968.850934471827, 4989.326440930428, 5039.647224694236, 5045.2432135180015, 5045.62157838171, 5063.291139240583, 5083.669561478492, 4939.259111133359, 4946.727929963887, 4952.4057113146655, 4954.157793175097, 4954.355933728592], "value": 3705.052618652442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.6159419565679, 617.5090802811765, 685.1812084558951, 685.3934268172667, 689.9275576064513, 12542.498300067999, 12950.935245323772, 13163.078584499077, 13172.670683232924, 13831.0, 14235.28823558823, 14280.928595357034, 14370.640733981629, 14386.424543018293, 14448.566543003726, 541.3044238153973, 725.9999999999986, 740.9777706668808, 741.2032065529551, 741.6106544064355, 549.362739222502, 728.4718579030214, 744.430510659346, 753.2317036622669, 755.6410704915177, 793.9007624046994, 794.5034353529045, 797.3342259213564, 799.7360870912585, 801.7113839017949, 552.9115341545373, 784.1100351101541, 785.1167436633787, 785.1794874356283, 785.7289235213842, 418.97695626740517, 553.7452771725011, 574.0499473371576, 576.0466428061522, 580.7967211475992, 12775.425105870258, 12796.296203708793, 12803.679908002281, 12810.679733006657, 12836.16564923277, 11516.42417879111, 11940.283582984961, 11980.903341915217, 12065.155439119266, 12380.45244344457, 11576.47905844239, 11724.237924534878, 11734.295942243492, 11820.408979551074, 11846.98601237783, 4063.451434056394, 4074.2666320062376, 4077.734947228421, 4148.045949431647, 4154.5222299435645, 61092.38907610956, 61802.0, 62482.0, 64015.35984640141, 64095.35904640941, 8896.466212027299, 9010.536754679559, 9070.501122438329, 9659.806803864023, 9713.22294216461, 15853.920730396505, 16579.585510362336, 16820.15899205035, 16851.241694123793, 16883.32466701343, 6478.2873883872735, 6558.508111891627, 6585.769498067641, 6641.203055633355, 6713.12729345182, 3410.4202285611505, 3451.6720911513366, 3461.6550168661233, 3520.8591656333974, 3648.3068217038676, 2827.953657146869, 2921.868515916746, 2926.9268268293035, 2933.457310397583, 2934.9706502934696, 480.1884814663278, 480.3899048208825, 486.4527406667499, 492.50011238592856, 499.3358832752503, 432.8052376430556, 437.24356862627195, 499.75511999120897, 532.3372401360331, 542.156945949053, 7384.667689953965, 7927.8810817837775, 8117.512949223065, 8179.386546008954, 8209.38429617781, 531.415443012683, 559.5188138201144, 561.3348182403864, 571.8856228754266, 589.1192666962918, 3871.922561548753, 3884.436756670267, 3957.6438120569287, 4027.1341661542324, 4070.063885306396, 100534.0, 101130.4943475278, 103643.0, 103787.48106259572, 104678.0, 83238.0, 84926.57536712401, 84981.57509212538, 85072.57463712642, 85136.57431712802, 59989.40010599838, 60366.39633603695, 61399.38600614026, 66876.6656166716, 71997.0, 7439.293267139613, 7532.246775322424, 8001.0, 8002.51984880909, 8197.508149511048, 29834.850825745732, 32265.51601726023, 39390.606093938695, 39885.0, 40310.39534406928, 54482.45517544932, 58411.0, 60111.0, 60223.39776602178, 60946.39053609407, 11163.0, 11198.44007799623, 11427.257228280136, 11575.652730418102, 11751.177417580688, 11829.526818927146, 12134.271943683407, 12163.148579599698, 12863.421146048637, 12960.287184204582, 10293.897061029294, 11074.5570177192, 11266.211365204357, 11637.243579167327, 11638.70903227426, 10512.474376281003, 11235.606753763579, 11624.302541847177, 11630.825537616773, 11638.76722465529, 10263.435511046964, 11068.335899846035, 11469.08247340194, 11473.483693233658, 11485.483153257956, 9327.626894924128, 9347.766305842408, 9364.204042656178, 9502.382345147544, 9523.380980236263, 8901.109889011048, 8966.193042626195, 9016.143466370684, 9123.589438475152, 9151.542422878963], "value": 6310.207168471074, "unit": "score"}], "name": "dromaeo_css", "value": 6036.091517202011, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 113.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 125.0, 174.0, 128.0, 127.0, 128.0, 138.0, 162.0, 128.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 113.0, 76.0, 77.0, 77.0, 77.0, 101.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 84.0, 85.0, 83.0, 105.0, 83.0, 83.0, 128.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 94.0, 90.0, 85.0, 82.0, 82.0, 83.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 146.0, 136.0, 137.0, 139.0, 137.0, 134.0, 179.0, 139.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 182.0, 179.0, 179.0, 175.0, 176.0, 174.0, 178.0, 176.0, 176.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 68.0, 70.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1556.1000000000001, "alertThreshold": 2.0}]} 16:25:14 INFO - Return code: 0 16:25:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:25:14 INFO - # TBPL SUCCESS # 16:25:14 INFO - Running post-action listener: _resource_record_post_action 16:25:14 INFO - [mozharness: 2016-10-17 23:25:14.557336Z] Finished run-tests step (success) 16:25:14 INFO - Running post-run listener: _resource_record_post_run 16:25:14 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392294400; Read time: 8; Write time: 252132 16:25:14 INFO - TinderboxPrint: CPU usage
13.0% 16:25:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:25:14 INFO - TinderboxPrint: I/O write bytes / time
392,294,400 / 252,132 16:25:14 INFO - TinderboxPrint: CPU idle
8,352.8 (86.9%) 16:25:14 INFO - TinderboxPrint: CPU user
1,205.3 (12.5%) 16:25:14 INFO - TinderboxPrint: Swap in / out
0 / 0 16:25:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100249600; Read time: 0; Write time: 110236 16:25:14 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292044800; Read time: 0; Write time: 141896 16:25:15 INFO - Running post-run listener: _upload_blobber_files 16:25:15 INFO - Blob upload gear active. 16:25:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:25:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:25:15 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:25:15 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:25:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:18 INFO - (blobuploader) - INFO - Done attempting. 16:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:19 INFO - (blobuploader) - INFO - Done attempting. 16:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:20 INFO - (blobuploader) - INFO - Done attempting. 16:25:20 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:20 INFO - Return code: 0 16:25:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:25:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1540f128b61a82ec4f5a32d29c6c969c3e6a5376a5482112f08ed861ad05501f51062df5e9399655d937563d04200a1b7a68501e6b23d9a949c14589028b05dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/736f733962483682f7c6d4d55f289d2c531e02339f6d5629cb7f0201a0bc2e3b7af097f67da4199fc5699a2f694f7437bc5cb3dcc77d5edd406ce3e74536cc0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/633d2d626dcdf974b5c62c3f30831097a1b382f0feacf94998bdba0014ab3063e075507ea2497775d337399ff7fef2bab93b46e7152484652d84f8942ef92b36"} 16:25:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:25:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:25:20 INFO - Contents: 16:25:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1540f128b61a82ec4f5a32d29c6c969c3e6a5376a5482112f08ed861ad05501f51062df5e9399655d937563d04200a1b7a68501e6b23d9a949c14589028b05dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/736f733962483682f7c6d4d55f289d2c531e02339f6d5629cb7f0201a0bc2e3b7af097f67da4199fc5699a2f694f7437bc5cb3dcc77d5edd406ce3e74536cc0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/633d2d626dcdf974b5c62c3f30831097a1b382f0feacf94998bdba0014ab3063e075507ea2497775d337399ff7fef2bab93b46e7152484652d84f8942ef92b36"} 16:25:20 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:20 INFO - Copying logs to upload dir... 16:25:20 INFO - mkdir: /builds/slave/test/build/upload/logs 16:25:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.875077 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-17 16:25:20.083670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 16:25:20.087598) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1540f128b61a82ec4f5a32d29c6c969c3e6a5376a5482112f08ed861ad05501f51062df5e9399655d937563d04200a1b7a68501e6b23d9a949c14589028b05dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/736f733962483682f7c6d4d55f289d2c531e02339f6d5629cb7f0201a0bc2e3b7af097f67da4199fc5699a2f694f7437bc5cb3dcc77d5edd406ce3e74536cc0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/633d2d626dcdf974b5c62c3f30831097a1b382f0feacf94998bdba0014ab3063e075507ea2497775d337399ff7fef2bab93b46e7152484652d84f8942ef92b36"} build_url:https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/TqLjNrr9SF28sR6wz7Fmqg/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/Larch-Non-PGO/sha512/1540f128b61a82ec4f5a32d29c6c969c3e6a5376a5482112f08ed861ad05501f51062df5e9399655d937563d04200a1b7a68501e6b23d9a949c14589028b05dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/736f733962483682f7c6d4d55f289d2c531e02339f6d5629cb7f0201a0bc2e3b7af097f67da4199fc5699a2f694f7437bc5cb3dcc77d5edd406ce3e74536cc0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/633d2d626dcdf974b5c62c3f30831097a1b382f0feacf94998bdba0014ab3063e075507ea2497775d337399ff7fef2bab93b46e7152484652d84f8942ef92b36"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 16:25:20.113162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:25:20.113500) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1476745470.1617-1124434701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 16:25:20.195230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 16:25:20.195544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 16:25:20.195844) ========= ========= Total master_lag: 0.16 =========