builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1477612799.29 results: success (0) buildid: 20161027152921 builduid: 035501053500481ea95a491de1ea112a revision: 6d9707e3343f56e2f5a728c0214de4f724444d08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.288158) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.288641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.288982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.318750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.319050) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 16:59:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 66.9M=0s 2016-10-27 17:00:00 (66.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.448889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.449224) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018976 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.514098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 16:59:59.514467) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d9707e3343f56e2f5a728c0214de4f724444d08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6d9707e3343f56e2f5a728c0214de4f724444d08 --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=bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 17:00:00,131 truncating revision to first 12 chars 2016-10-27 17:00:00,131 Setting DEBUG logging. 2016-10-27 17:00:00,131 attempt 1/10 2016-10-27 17:00:00,131 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d9707e3343f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 17:00:00,461 unpacking tar archive at: mozilla-central-6d9707e3343f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 17:00:00.201007) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 17:00:00.201342) ========= script_repo_revision: 6d9707e3343f56e2f5a728c0214de4f724444d08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 17:00:00.201807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 17:00:00.202122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 17:00:00.214943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-27 17:00:00.215265) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:00:00 INFO - MultiFileLogger online at 20161027 17:00:00 in /builds/slave/test 17:00:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:00:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:00:00 INFO - {'append_to_log': False, 17:00:00 INFO - 'base_work_dir': '/builds/slave/test', 17:00:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:00:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:00:00 INFO - 'branch': 'Firefox-Non-PGO', 17:00:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:00:00 INFO - 'config_files': ('talos/linux_config.py',), 17:00:00 INFO - 'default_actions': ('clobber', 17:00:00 INFO - 'read-buildbot-config', 17:00:00 INFO - 'download-and-extract', 17:00:00 INFO - 'populate-webroot', 17:00:00 INFO - 'create-virtualenv', 17:00:00 INFO - 'install', 17:00:00 INFO - 'run-tests'), 17:00:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:00:00 INFO - 'download_minidump_stackwalk': True, 17:00:00 INFO - 'download_symbols': 'ondemand', 17:00:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:00:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:00:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:00:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:00:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:00:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:00:00 INFO - 'installer_path': 'installer.exe', 17:00:00 INFO - 'log_level': 'info', 17:00:00 INFO - 'log_name': 'talos', 17:00:00 INFO - 'log_to_console': True, 17:00:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:00:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:00:00 INFO - 'opt_config_files': (), 17:00:00 INFO - 'pip_index': False, 17:00:00 INFO - 'sps_profile': False, 17:00:00 INFO - 'sps_profile_interval': 0, 17:00:00 INFO - 'suite': 'dromaeojs', 17:00:00 INFO - 'system_bits': '32', 17:00:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:00:00 INFO - 'title': 'talos-linux64-ix-055', 17:00:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:00:00 INFO - 'use_talos_json': True, 17:00:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:00:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:00:00 INFO - 'work_dir': 'build'} 17:00:00 INFO - [mozharness: 2016-10-28 00:00:00.937617Z] Running clobber step. 17:00:00 INFO - Running pre-action listener: _resource_record_pre_action 17:00:00 INFO - Running main action method: clobber 17:00:00 INFO - rmtree: /builds/slave/test/build 17:00:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:00:01 INFO - Running post-action listener: _resource_record_post_action 17:00:01 INFO - [mozharness: 2016-10-28 00:00:01.921175Z] Finished clobber step (success) 17:00:01 INFO - [mozharness: 2016-10-28 00:00:01.921273Z] Running read-buildbot-config step. 17:00:01 INFO - Running pre-action listener: _resource_record_pre_action 17:00:01 INFO - Running main action method: read_buildbot_config 17:00:01 INFO - Using buildbot properties: 17:00:01 INFO - { 17:00:01 INFO - "project": "", 17:00:01 INFO - "product": "firefox", 17:00:01 INFO - "script_repo_revision": "production", 17:00:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:00:01 INFO - "repository": "", 17:00:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:00:01 INFO - "buildid": "20161027152921", 17:00:01 INFO - "pgo_build": "False", 17:00:01 INFO - "basedir": "/builds/slave/test", 17:00:01 INFO - "buildnumber": 271, 17:00:01 INFO - "slavename": "talos-linux64-ix-055", 17:00:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:00:01 INFO - "platform": "ubuntu64_hw", 17:00:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:00:01 INFO - "branch": "mozilla-central", 17:00:01 INFO - "repo_path": "mozilla-central", 17:00:01 INFO - "revision": "6d9707e3343f56e2f5a728c0214de4f724444d08", 17:00:01 INFO - "stage_platform": "linux64", 17:00:01 INFO - "builduid": "035501053500481ea95a491de1ea112a", 17:00:01 INFO - "slavebuilddir": "test" 17:00:01 INFO - } 17:00:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:00:01 INFO - Running post-action listener: _resource_record_post_action 17:00:01 INFO - [mozharness: 2016-10-28 00:00:01.923690Z] Finished read-buildbot-config step (success) 17:00:01 INFO - [mozharness: 2016-10-28 00:00:01.923778Z] Running download-and-extract step. 17:00:01 INFO - Running pre-action listener: _resource_record_pre_action 17:00:01 INFO - Running main action method: download_and_extract 17:00:01 INFO - mkdir: /builds/slave/test/build/tests 17:00:01 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')]} 17:00:01 INFO - trying https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:00:01 INFO - Downloading https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/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 17:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/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 17:00:02 INFO - Downloaded 1361 bytes. 17:00:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:00:02 INFO - Using the following test package requirements: 17:00:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:00:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:00:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'jsshell-linux-x86_64.zip'], 17:00:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:00:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:00:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:00:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:00:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:00:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:00:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:00:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:02 INFO - Fetch https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:00:03 INFO - Http code: 200 17:00:03 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 17:00:03 INFO - x-amz-cf-id: q1555H24TbX3ovzig6I0Bv9Lp_oqB00NG9-gGd56QvOQBU3Gc9JoHA== 17:00:03 INFO - x-amz-version-id: 1JY.p10rDFvaYWB4JmSiHZLtV8mFqxV7 17:00:03 INFO - Expected file size: 20424325 17:00:03 INFO - Obtained file size: 20424325 17:00:07 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 17:00:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:00:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:07 INFO - Fetch https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:00:08 INFO - Http code: 200 17:00:08 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 17:00:08 INFO - x-amz-cf-id: PmneH3cXr11yhBH7ZW56OOFpGLNgI1qYlcKkIDBFlJypUQokSj9XZA== 17:00:08 INFO - x-amz-version-id: 1JY.p10rDFvaYWB4JmSiHZLtV8mFqxV7 17:00:08 INFO - Expected file size: 20424325 17:00:08 INFO - Obtained file size: 20424325 17:00:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:00:12 INFO - Fetch https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:00:13 INFO - Http code: 200 17:00:13 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 17:00:13 INFO - x-amz-cf-id: 0k5lnP9UBldeXo8SX-h2si3yRMOcTBCksmwz-FCZjm87bCk0HXe3ow== 17:00:13 INFO - x-amz-version-id: UGrr54ZOse.ffq_u_AogrzbIMQhD1vgO 17:00:13 INFO - Expected file size: 14409028 17:00:13 INFO - Obtained file size: 14409028 17:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:13 INFO - trying https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:00:13 INFO - Downloading https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/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 17:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/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 17:00:15 INFO - Downloaded 55456989 bytes. 17:00:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:00:15 INFO - mkdir: /builds/slave/test/properties 17:00:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:00:15 INFO - Writing to file /builds/slave/test/properties/build_url 17:00:15 INFO - Contents: 17:00:15 INFO - build_url:https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:00:16 INFO - Running post-action listener: _resource_record_post_action 17:00:16 INFO - Running post-action listener: set_extra_try_arguments 17:00:16 INFO - [mozharness: 2016-10-28 00:00:16.154985Z] Finished download-and-extract step (success) 17:00:16 INFO - [mozharness: 2016-10-28 00:00:16.155211Z] Running populate-webroot step. 17:00:16 INFO - Running pre-action listener: _resource_record_pre_action 17:00:16 INFO - Running main action method: populate_webroot 17:00:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:16 INFO - '--tppagecycles', 17:00:16 INFO - '7'], 17:00:16 INFO - 'tests': ['tsvgm']}}, 17:00:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:00:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:00:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:00:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['damp', 'tps']}, 17:00:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'tests': ['damp', 'tps']}, 17:00:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['dromaeo_dom']}, 17:00:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['basic_compositor_video']}, 17:00:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:00:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore', 17:00:16 INFO - 'tabpaint']}, 17:00:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore', 17:00:16 INFO - 'tabpaint']}, 17:00:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore', 17:00:16 INFO - 'tabpaint']}, 17:00:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore', 17:00:16 INFO - 'tabpaint']}, 17:00:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore', 17:00:16 INFO - 'tabpaint']}, 17:00:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['a11yr', 17:00:16 INFO - 'ts_paint', 17:00:16 INFO - 'tpaint', 17:00:16 INFO - 'sessionrestore', 17:00:16 INFO - 'sessionrestore_no_auto_restore', 17:00:16 INFO - 'tabpaint']}, 17:00:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['tsvgx', 17:00:16 INFO - 'tsvgr_opacity', 17:00:16 INFO - 'tart', 17:00:16 INFO - 'tscrollx', 17:00:16 INFO - 'cart']}, 17:00:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:00:16 INFO - 'tsvgr_opacity', 17:00:16 INFO - 'tart', 17:00:16 INFO - 'tscrollx', 17:00:16 INFO - 'cart']}, 17:00:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--disable-e10s'], 17:00:16 INFO - 'tests': ['tp5o']}, 17:00:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'tests': ['tp5o']}, 17:00:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--disable-e10s', 17:00:16 INFO - '--xperf_path', 17:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:16 INFO - 'tests': ['tp5n']}, 17:00:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:16 INFO - 'talos_options': ['--xperf_path', 17:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:16 INFO - 'tests': ['tp5n']}}, 17:00:16 INFO - 'talos.zip': {'path': '', 17:00:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:16 INFO - Running post-action listener: _resource_record_post_action 17:00:16 INFO - [mozharness: 2016-10-28 00:00:16.172829Z] Finished populate-webroot step (success) 17:00:16 INFO - [mozharness: 2016-10-28 00:00:16.172917Z] Running create-virtualenv step. 17:00:16 INFO - Running pre-action listener: _resource_record_pre_action 17:00:16 INFO - Running main action method: create_virtualenv 17:00:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:00:16 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 17:00:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:00:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:16 INFO - Using real prefix '/usr' 17:00:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:00:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:18 INFO - Installing pip.................done. 17:00:18 INFO - Return code: 0 17:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:00:18 INFO - Reading from file tmpfile_stdout 17:00:18 INFO - Output received: 17:00:18 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) 17:00:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:18 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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:18 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 17:00:18 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 17:00:18 INFO - Using env: {'DISPLAY': ':0', 17:00:18 INFO - 'HOME': '/home/cltbld', 17:00:18 INFO - 'LANG': 'en_US.UTF-8', 17:00:18 INFO - 'LANGUAGE': 'en_US:en', 17:00:18 INFO - 'LOGNAME': 'cltbld', 17:00:18 INFO - 'MAIL': '/var/mail/cltbld', 17:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:18 INFO - 'MOZ_NO_REMOTE': '1', 17:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:18 INFO - 'NO_EM_RESTART': '1', 17:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:18 INFO - 'PWD': '/builds/slave/test', 17:00:18 INFO - 'SHELL': '/bin/bash', 17:00:18 INFO - 'SHLVL': '1', 17:00:18 INFO - 'TERM': 'linux', 17:00:18 INFO - 'TMOUT': '86400', 17:00:18 INFO - 'USER': 'cltbld', 17:00:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:18 INFO - '_': '/tools/buildbot/bin/python'} 17:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:19 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 17:00:19 INFO - Cleaning up... 17:00:19 INFO - Return code: 0 17:00:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:00:19 INFO - Using env: {'DISPLAY': ':0', 17:00:19 INFO - 'HOME': '/home/cltbld', 17:00:19 INFO - 'LANG': 'en_US.UTF-8', 17:00:19 INFO - 'LANGUAGE': 'en_US:en', 17:00:19 INFO - 'LOGNAME': 'cltbld', 17:00:19 INFO - 'MAIL': '/var/mail/cltbld', 17:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:19 INFO - 'MOZ_NO_REMOTE': '1', 17:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:19 INFO - 'NO_EM_RESTART': '1', 17:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:19 INFO - 'PWD': '/builds/slave/test', 17:00:19 INFO - 'SHELL': '/bin/bash', 17:00:19 INFO - 'SHLVL': '1', 17:00:19 INFO - 'TERM': 'linux', 17:00:19 INFO - 'TMOUT': '86400', 17:00:19 INFO - 'USER': 'cltbld', 17:00:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:19 INFO - '_': '/tools/buildbot/bin/python'} 17:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:19 INFO - Downloading/unpacking psutil>=3.1.1 17:00:19 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 17:00:19 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 17:00:19 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 17:00:19 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 17:00:19 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 17:00:19 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 17:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:21 INFO - Installing collected packages: psutil 17:00:21 INFO - Running setup.py install for psutil 17:00:21 INFO - building 'psutil._psutil_linux' extension 17:00:21 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 17:00:21 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 17:00:21 INFO - building 'psutil._psutil_posix' extension 17:00:21 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 17:00:21 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 17:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:21 INFO - Successfully installed psutil 17:00:21 INFO - Cleaning up... 17:00:22 INFO - Return code: 0 17:00:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:00:22 INFO - Using env: {'DISPLAY': ':0', 17:00:22 INFO - 'HOME': '/home/cltbld', 17:00:22 INFO - 'LANG': 'en_US.UTF-8', 17:00:22 INFO - 'LANGUAGE': 'en_US:en', 17:00:22 INFO - 'LOGNAME': 'cltbld', 17:00:22 INFO - 'MAIL': '/var/mail/cltbld', 17:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:22 INFO - 'MOZ_NO_REMOTE': '1', 17:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:22 INFO - 'NO_EM_RESTART': '1', 17:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:22 INFO - 'PWD': '/builds/slave/test', 17:00:22 INFO - 'SHELL': '/bin/bash', 17:00:22 INFO - 'SHLVL': '1', 17:00:22 INFO - 'TERM': 'linux', 17:00:22 INFO - 'TMOUT': '86400', 17:00:22 INFO - 'USER': 'cltbld', 17:00:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:22 INFO - '_': '/tools/buildbot/bin/python'} 17:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:00:24 INFO - Installing collected packages: mozsystemmonitor 17:00:24 INFO - Running setup.py install for mozsystemmonitor 17:00:24 INFO - Successfully installed mozsystemmonitor 17:00:24 INFO - Cleaning up... 17:00:24 INFO - Return code: 0 17:00:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:00:24 INFO - Using env: {'DISPLAY': ':0', 17:00:24 INFO - 'HOME': '/home/cltbld', 17:00:24 INFO - 'LANG': 'en_US.UTF-8', 17:00:24 INFO - 'LANGUAGE': 'en_US:en', 17:00:24 INFO - 'LOGNAME': 'cltbld', 17:00:24 INFO - 'MAIL': '/var/mail/cltbld', 17:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:24 INFO - 'MOZ_NO_REMOTE': '1', 17:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:24 INFO - 'NO_EM_RESTART': '1', 17:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:24 INFO - 'PWD': '/builds/slave/test', 17:00:24 INFO - 'SHELL': '/bin/bash', 17:00:24 INFO - 'SHLVL': '1', 17:00:24 INFO - 'TERM': 'linux', 17:00:24 INFO - 'TMOUT': '86400', 17:00:24 INFO - 'USER': 'cltbld', 17:00:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:24 INFO - '_': '/tools/buildbot/bin/python'} 17:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:24 INFO - Downloading/unpacking jsonschema==2.5.1 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 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 17:00:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 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 17:00:26 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:26 INFO - warning: no files found matching '*.txt' 17:00:26 INFO - no previously-included directories found matching 'build' 17:00:26 INFO - no previously-included directories found matching 'dist' 17:00:26 INFO - no previously-included directories found matching '.git*' 17:00:26 INFO - Installing collected packages: jsonschema, functools32 17:00:26 INFO - Running setup.py install for functools32 17:00:26 INFO - warning: no files found matching '*.txt' 17:00:26 INFO - no previously-included directories found matching 'build' 17:00:26 INFO - no previously-included directories found matching 'dist' 17:00:26 INFO - no previously-included directories found matching '.git*' 17:00:26 INFO - Successfully installed jsonschema functools32 17:00:26 INFO - Cleaning up... 17:00:27 INFO - Return code: 0 17:00:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:00:27 INFO - Using env: {'DISPLAY': ':0', 17:00:27 INFO - 'HOME': '/home/cltbld', 17:00:27 INFO - 'LANG': 'en_US.UTF-8', 17:00:27 INFO - 'LANGUAGE': 'en_US:en', 17:00:27 INFO - 'LOGNAME': 'cltbld', 17:00:27 INFO - 'MAIL': '/var/mail/cltbld', 17:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:27 INFO - 'MOZ_NO_REMOTE': '1', 17:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:27 INFO - 'NO_EM_RESTART': '1', 17:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:27 INFO - 'PWD': '/builds/slave/test', 17:00:27 INFO - 'SHELL': '/bin/bash', 17:00:27 INFO - 'SHLVL': '1', 17:00:27 INFO - 'TERM': 'linux', 17:00:27 INFO - 'TMOUT': '86400', 17:00:27 INFO - 'USER': 'cltbld', 17:00:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:27 INFO - '_': '/tools/buildbot/bin/python'} 17:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:00:27 INFO - Cleaning up... 17:00:27 INFO - Return code: 0 17:00:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:00:27 INFO - Using env: {'DISPLAY': ':0', 17:00:27 INFO - 'HOME': '/home/cltbld', 17:00:27 INFO - 'LANG': 'en_US.UTF-8', 17:00:27 INFO - 'LANGUAGE': 'en_US:en', 17:00:27 INFO - 'LOGNAME': 'cltbld', 17:00:27 INFO - 'MAIL': '/var/mail/cltbld', 17:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:27 INFO - 'MOZ_NO_REMOTE': '1', 17:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:27 INFO - 'NO_EM_RESTART': '1', 17:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:27 INFO - 'PWD': '/builds/slave/test', 17:00:27 INFO - 'SHELL': '/bin/bash', 17:00:27 INFO - 'SHLVL': '1', 17:00:27 INFO - 'TERM': 'linux', 17:00:27 INFO - 'TMOUT': '86400', 17:00:27 INFO - 'USER': 'cltbld', 17:00:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:27 INFO - '_': '/tools/buildbot/bin/python'} 17:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:27 INFO - Downloading/unpacking blobuploader==1.2.4 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:29 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:30 INFO - Downloading docopt-0.6.1.tar.gz 17:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:30 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:30 INFO - Running setup.py install for blobuploader 17:00:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:30 INFO - Running setup.py install for requests 17:00:30 INFO - Running setup.py install for docopt 17:00:30 INFO - Successfully installed blobuploader requests docopt 17:00:30 INFO - Cleaning up... 17:00:30 INFO - Return code: 0 17:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:30 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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:30 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 17:00:30 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 17:00:30 INFO - Using env: {'DISPLAY': ':0', 17:00:30 INFO - 'HOME': '/home/cltbld', 17:00:30 INFO - 'LANG': 'en_US.UTF-8', 17:00:30 INFO - 'LANGUAGE': 'en_US:en', 17:00:30 INFO - 'LOGNAME': 'cltbld', 17:00:30 INFO - 'MAIL': '/var/mail/cltbld', 17:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:30 INFO - 'MOZ_NO_REMOTE': '1', 17:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:30 INFO - 'NO_EM_RESTART': '1', 17:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:30 INFO - 'PWD': '/builds/slave/test', 17:00:30 INFO - 'SHELL': '/bin/bash', 17:00:30 INFO - 'SHLVL': '1', 17:00:30 INFO - 'TERM': 'linux', 17:00:30 INFO - 'TMOUT': '86400', 17:00:30 INFO - 'USER': 'cltbld', 17:00:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:30 INFO - '_': '/tools/buildbot/bin/python'} 17:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:31 INFO - Running setup.py (path:/tmp/pip-qmV61w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:31 INFO - Running setup.py (path:/tmp/pip-pzqiXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:31 INFO - Running setup.py (path:/tmp/pip-VsIfB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:31 INFO - Running setup.py (path:/tmp/pip-2ATGJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:31 INFO - Running setup.py (path:/tmp/pip-O1ALng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:31 INFO - Running setup.py (path:/tmp/pip-ultvVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:31 INFO - Running setup.py (path:/tmp/pip-NiwEaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:31 INFO - Running setup.py (path:/tmp/pip-aXt6js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:31 INFO - Running setup.py (path:/tmp/pip-OFjfYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:31 INFO - Running setup.py (path:/tmp/pip-tOHMJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:31 INFO - Running setup.py (path:/tmp/pip-5j82GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:31 INFO - Running setup.py (path:/tmp/pip-swDYkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:31 INFO - Running setup.py (path:/tmp/pip-XkkpgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:32 INFO - Running setup.py (path:/tmp/pip-VctHco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:32 INFO - Running setup.py (path:/tmp/pip-haz2gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:32 INFO - Running setup.py (path:/tmp/pip-1Sdujg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:32 INFO - Running setup.py (path:/tmp/pip-lzBO9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:32 INFO - Running setup.py install for manifestparser 17:00:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:32 INFO - Running setup.py install for mozcrash 17:00:32 INFO - Running setup.py install for mozdebug 17:00:32 INFO - Running setup.py install for mozdevice 17:00:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:00:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:32 INFO - Running setup.py install for mozfile 17:00:32 INFO - Running setup.py install for mozhttpd 17:00:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:32 INFO - Running setup.py install for mozinfo 17:00:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Running setup.py install for mozInstall 17:00:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Running setup.py install for mozleak 17:00:33 INFO - Running setup.py install for mozlog 17:00:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Running setup.py install for moznetwork 17:00:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Running setup.py install for mozprocess 17:00:33 INFO - Running setup.py install for mozprofile 17:00:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Running setup.py install for mozrunner 17:00:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:33 INFO - Running setup.py install for mozscreenshot 17:00:33 INFO - Running setup.py install for moztest 17:00:34 INFO - Running setup.py install for mozversion 17:00:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:34 INFO - Cleaning up... 17:00:34 INFO - Return code: 0 17:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:34 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')]} 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 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')]} 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:34 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 17:00:34 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 17:00:34 INFO - Using env: {'DISPLAY': ':0', 17:00:34 INFO - 'HOME': '/home/cltbld', 17:00:34 INFO - 'LANG': 'en_US.UTF-8', 17:00:34 INFO - 'LANGUAGE': 'en_US:en', 17:00:34 INFO - 'LOGNAME': 'cltbld', 17:00:34 INFO - 'MAIL': '/var/mail/cltbld', 17:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:34 INFO - 'MOZ_NO_REMOTE': '1', 17:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:34 INFO - 'NO_EM_RESTART': '1', 17:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:34 INFO - 'PWD': '/builds/slave/test', 17:00:34 INFO - 'SHELL': '/bin/bash', 17:00:34 INFO - 'SHLVL': '1', 17:00:34 INFO - 'TERM': 'linux', 17:00:34 INFO - 'TMOUT': '86400', 17:00:34 INFO - 'USER': 'cltbld', 17:00:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:34 INFO - '_': '/tools/buildbot/bin/python'} 17:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:34 INFO - Running setup.py (path:/tmp/pip-HChCrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:34 INFO - Running setup.py (path:/tmp/pip-sd7wAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:34 INFO - Running setup.py (path:/tmp/pip-6J5nYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:34 INFO - Running setup.py (path:/tmp/pip-Zc1xN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:34 INFO - Running setup.py (path:/tmp/pip-20Ybdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:34 INFO - Running setup.py (path:/tmp/pip-J4aP63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:34 INFO - Running setup.py (path:/tmp/pip-1o8Cab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:34 INFO - Running setup.py (path:/tmp/pip-CvBGA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:34 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)) 17:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:34 INFO - Running setup.py (path:/tmp/pip-je5gsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:35 INFO - Running setup.py (path:/tmp/pip-j177kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:35 INFO - Running setup.py (path:/tmp/pip-HYdO8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:35 INFO - Running setup.py (path:/tmp/pip-GL4xLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:35 INFO - Running setup.py (path:/tmp/pip-GcrXSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:35 INFO - Running setup.py (path:/tmp/pip-qImaNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:35 INFO - Running setup.py (path:/tmp/pip-OswowC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:35 INFO - Running setup.py (path:/tmp/pip-NuoAmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:35 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)) 17:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:35 INFO - Running setup.py (path:/tmp/pip-oO11dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:35 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)) 17:00:35 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)) 17:00:35 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)) 17:00:35 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)) 17:00:35 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)) 17:00:35 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)) 17:00:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:37 INFO - Downloading blessings-1.6.tar.gz 17:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:37 INFO - Installing collected packages: blessings 17:00:37 INFO - Running setup.py install for blessings 17:00:37 INFO - Successfully installed blessings 17:00:37 INFO - Cleaning up... 17:00:37 INFO - Return code: 0 17:00:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:38 INFO - Reading from file tmpfile_stdout 17:00:38 INFO - Current package versions: 17:00:38 INFO - argparse == 1.2.1 17:00:38 INFO - blessings == 1.6 17:00:38 INFO - blobuploader == 1.2.4 17:00:38 INFO - docopt == 0.6.1 17:00:38 INFO - functools32 == 3.2.3-2 17:00:38 INFO - jsonschema == 2.5.1 17:00:38 INFO - manifestparser == 1.1 17:00:38 INFO - mozInstall == 1.12 17:00:38 INFO - mozcrash == 0.17 17:00:38 INFO - mozdebug == 0.1 17:00:38 INFO - mozdevice == 0.48 17:00:38 INFO - mozfile == 1.2 17:00:38 INFO - mozhttpd == 0.7 17:00:38 INFO - mozinfo == 0.9 17:00:38 INFO - mozleak == 0.1 17:00:38 INFO - mozlog == 3.4 17:00:38 INFO - moznetwork == 0.27 17:00:38 INFO - mozprocess == 0.23 17:00:38 INFO - mozprofile == 0.28 17:00:38 INFO - mozrunner == 6.12 17:00:38 INFO - mozscreenshot == 0.1 17:00:38 INFO - mozsystemmonitor == 0.3 17:00:38 INFO - moztest == 0.7 17:00:38 INFO - mozversion == 1.4 17:00:38 INFO - psutil == 3.1.1 17:00:38 INFO - requests == 1.2.3 17:00:38 INFO - wsgiref == 0.1.2 17:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:38 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 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:38 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 17:00:38 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 17:00:38 INFO - Using env: {'DISPLAY': ':0', 17:00:38 INFO - 'HOME': '/home/cltbld', 17:00:38 INFO - 'LANG': 'en_US.UTF-8', 17:00:38 INFO - 'LANGUAGE': 'en_US:en', 17:00:38 INFO - 'LOGNAME': 'cltbld', 17:00:38 INFO - 'MAIL': '/var/mail/cltbld', 17:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:38 INFO - 'MOZ_NO_REMOTE': '1', 17:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:38 INFO - 'NO_EM_RESTART': '1', 17:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:38 INFO - 'PWD': '/builds/slave/test', 17:00:38 INFO - 'SHELL': '/bin/bash', 17:00:38 INFO - 'SHLVL': '1', 17:00:38 INFO - 'TERM': 'linux', 17:00:38 INFO - 'TMOUT': '86400', 17:00:38 INFO - 'USER': 'cltbld', 17:00:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:38 INFO - '_': '/tools/buildbot/bin/python'} 17:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 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)) 17:00:38 INFO - Cleaning up... 17:00:38 INFO - Return code: 0 17:00:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23a829cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18938e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, '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': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', '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 17:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:00:38 INFO - Using env: {'DISPLAY': ':0', 17:00:38 INFO - 'HOME': '/home/cltbld', 17:00:38 INFO - 'LANG': 'en_US.UTF-8', 17:00:38 INFO - 'LANGUAGE': 'en_US:en', 17:00:38 INFO - 'LOGNAME': 'cltbld', 17:00:38 INFO - 'MAIL': '/var/mail/cltbld', 17:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:38 INFO - 'MOZ_NO_REMOTE': '1', 17:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:38 INFO - 'NO_EM_RESTART': '1', 17:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:38 INFO - 'PWD': '/builds/slave/test', 17:00:38 INFO - 'SHELL': '/bin/bash', 17:00:38 INFO - 'SHLVL': '1', 17:00:38 INFO - 'TERM': 'linux', 17:00:38 INFO - 'TMOUT': '86400', 17:00:38 INFO - 'USER': 'cltbld', 17:00:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:38 INFO - '_': '/tools/buildbot/bin/python'} 17:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:00:38 INFO - Cleaning up... 17:00:38 INFO - Return code: 0 17:00:38 INFO - Running post-action listener: _resource_record_post_action 17:00:38 INFO - Running post-action listener: _start_resource_monitoring 17:00:38 INFO - Starting resource monitoring. 17:00:38 INFO - [mozharness: 2016-10-28 00:00:38.508507Z] Finished create-virtualenv step (success) 17:00:38 INFO - [mozharness: 2016-10-28 00:00:38.509013Z] Running install step. 17:00:38 INFO - Running pre-action listener: _resource_record_pre_action 17:00:38 INFO - Running main action method: install 17:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:38 INFO - Reading from file tmpfile_stdout 17:00:38 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:38 INFO - Reading from file tmpfile_stdout 17:00:38 INFO - Output received: 17:00:38 INFO - Usage: mozinstall [options] installer 17:00:38 INFO - Options: 17:00:38 INFO - -h, --help show this help message and exit 17:00:38 INFO - -d DEST, --destination=DEST 17:00:38 INFO - Directory to install application into. [default: 17:00:38 INFO - "/builds/slave/test"] 17:00:38 INFO - --app=APP Application being installed. [default: firefox] 17:00:38 INFO - mkdir: /builds/slave/test/build/application 17:00:38 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'] 17:00:38 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 17:00:54 INFO - Reading from file tmpfile_stdout 17:00:54 INFO - Output received: 17:00:54 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:54 INFO - Running post-action listener: _resource_record_post_action 17:00:54 INFO - [mozharness: 2016-10-28 00:00:54.828756Z] Finished install step (success) 17:00:54 INFO - [mozharness: 2016-10-28 00:00:54.829000Z] Running run-tests step. 17:00:54 INFO - Running pre-action listener: _resource_record_pre_action 17:00:54 INFO - Running main action method: run_tests 17:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:54 INFO - Python 2.7.3 17:00:54 INFO - Return code: 0 17:00:54 INFO - grabbing minidump binary from tooltool 17:00: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')]} 17:00:54 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 0x192c100>, '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 0x19239d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923e60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:54 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 17:00:54 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 17:00:54 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 17:00:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:54 INFO - Return code: 0 17:00:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 17:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 17:00:54 INFO - Using env: {'DISPLAY': ':0', 17:00:54 INFO - 'HOME': '/home/cltbld', 17:00:54 INFO - 'LANG': 'en_US.UTF-8', 17:00:54 INFO - 'LANGUAGE': 'en_US:en', 17:00:54 INFO - 'LOGNAME': 'cltbld', 17:00:54 INFO - 'MAIL': '/var/mail/cltbld', 17:00:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:54 INFO - 'MOZ_NO_REMOTE': '1', 17:00:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:54 INFO - 'NO_EM_RESTART': '1', 17:00:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:54 INFO - 'PWD': '/builds/slave/test', 17:00:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:54 INFO - 'SHELL': '/bin/bash', 17:00:54 INFO - 'SHLVL': '1', 17:00:54 INFO - 'TERM': 'linux', 17:00:54 INFO - 'TMOUT': '86400', 17:00:54 INFO - 'USER': 'cltbld', 17:00:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398', 17:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:54 INFO - '_': '/tools/buildbot/bin/python'} 17:00:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 17:00:55 INFO - mozversion application_buildid: 20161027152921 17:00:55 INFO - mozversion application_changeset: 6d9707e3343f56e2f5a728c0214de4f724444d08 17:00:55 INFO - mozversion application_display_name: Nightly 17:00:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:55 INFO - mozversion application_name: Firefox 17:00:55 INFO - mozversion application_remotingname: firefox 17:00:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:00:55 INFO - mozversion application_vendor: Mozilla 17:00:55 INFO - mozversion application_version: 52.0a1 17:00:55 INFO - mozversion platform_buildid: 20161027152921 17:00:55 INFO - mozversion platform_changeset: 6d9707e3343f56e2f5a728c0214de4f724444d08 17:00:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:00:55 INFO - mozversion platform_version: 52.0a1 17:00:55 INFO - using testdate: 1477612855 17:00:55 INFO - actual date: 1477612855 17:00:55 INFO - starting webserver on 'localhost:37853' 17:00:55 INFO - SUITE-START | Running 2 tests 17:00:55 INFO - TEST-START | dromaeo_css 17:00:55 INFO - operating with platform_type : linux_ 17:00:55 INFO - Initialising browser for dromaeo_css test... 17:00:55 INFO - TEST-INFO | started process 25998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFx5Lj/profile http://localhost:37853/getInfo.html) 17:00:59 INFO - PROCESS | 25998 | __metrics Screen width/height:1600/1200 17:00:59 INFO - PROCESS | 25998 | colorDepth:24 17:00:59 INFO - PROCESS | 25998 | Browser inner width/height: 1024/697 17:00:59 INFO - PROCESS | 25998 | __metrics 17:00:59 INFO - PROCESS | 25998 | 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" 17:00:59 INFO - PROCESS | 25998 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:01:00 INFO - PROCESS | 25998 | console.error: PushService: 17:01:00 INFO - PROCESS | 25998 | stateChangeProcessEnqueue: Error transitioning state 17:01:00 INFO - PROCESS | 25998 | UnknownError 17:01:01 INFO - TEST-INFO | 25998: exit 0 17:01:01 INFO - Browser initialized. 17:01:01 INFO - Running cycle 1/1 for dromaeo_css test... 17:01:01 INFO - TEST-INFO | started process 26079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFx5Lj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:13 INFO - PROCESS | 26079 | RSS: Main: 173608960 17:01:13 INFO - PROCESS | 26079 | 17:02:04 INFO - PROCESS | 26079 | 1477612924702 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] 17:04:19 INFO - PROCESS | 26079 | Cycle 1(1): loaded http://localhost:37853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37853/tests/dromaeo/cssquery-ext.html) 17:04:20 INFO - PROCESS | 26079 | RSS: Main: 296177664 17:04:20 INFO - PROCESS | 26079 | 17:07:23 INFO - PROCESS | 26079 | Cycle 1(1): loaded http://localhost:37853/tests/dromaeo/cssquery-ext.html (next: http://localhost:37853/tests/dromaeo/cssquery-jquery.html) 17:07:23 INFO - PROCESS | 26079 | RSS: Main: 274907136 17:07:23 INFO - PROCESS | 26079 | 17:10:26 INFO - PROCESS | 26079 | Cycle 1(1): loaded http://localhost:37853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37853/tests/dromaeo/cssquery-mootools.html) 17:10:26 INFO - PROCESS | 26079 | RSS: Main: 218091520 17:10:26 INFO - PROCESS | 26079 | 17:13:28 INFO - PROCESS | 26079 | Cycle 1(1): loaded http://localhost:37853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37853/tests/dromaeo/cssquery-prototype.html) 17:13:29 INFO - PROCESS | 26079 | RSS: Main: 246951936 17:13:29 INFO - PROCESS | 26079 | 17:16:32 INFO - PROCESS | 26079 | Cycle 1(1): loaded http://localhost:37853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37853/tests/dromaeo/cssquery-yui.html) 17:16:33 INFO - PROCESS | 26079 | RSS: Main: 218673152 17:16:33 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | Cycle 1(1): loaded http://localhost:37853/tests/dromaeo/cssquery-yui.html (next: http://localhost:37853/tests/dromaeo/cssquery-dojo.html) 17:19:36 INFO - PROCESS | 26079 | RSS: Main: 302919680 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | __start_tp_report 17:19:36 INFO - PROCESS | 26079 | _x_x_mozilla_page_load 17:19:36 INFO - PROCESS | 26079 | _x_x_mozilla_page_load_details 17:19:36 INFO - PROCESS | 26079 | |i|pagename|runs| 17:19:36 INFO - PROCESS | 26079 | |0;dojo.html;2544.7328030556796;2551.4514379408424;2570.1004648373073;2585.457054018656;2603.010855874766;4512.9097418051615;4567.223571992761;4586.610138138258;4591.747453890039;4604.125216208918;4597.034622729222;4633.745144017078;4675.368825208596;4700.788464519096;4790.353302304188;4282.7858607069675;4327.632151267146;4348.152110338485;4354.47746270448;4381.956180438203;4011.65900898424;4306.74159550428;4345.543717909622;4356.499002614708;4359.367891655708;4350.695451318409;4363.040131171138;4367.650587952972;4418.2268103082;4438.4895736990175;4208.663306935468;4260.020195355086;4260.25445547028;4319.67602429819;4355.324924636687;4243.872683819491;4251.702380833343;4263.552327005682;4292.463442069741;4322.50291216511;4580.885477863047;4611.492735799059;4651.674382793206;4652.209124448852;4685.906281874343;4707.458642256116;4970.030843985424;4973.229149481836;4977.104121258172;5029.4216165141115;4777.570018698334;4803.7357945313;4816.795801049738;4854.514548545152;4859.441164266119;4558.8632341029825;4566.109608626352;4610.170169369512;4619;4623.69945953512;4970.030843985461;4971.552560269593;4971.950280497149;4972.179590367549;4972.328735620717;4764.857054288377;4769.165396055676;4812.278158276216;4817.421909370828;4826.58973987208;4816.566509014206;4825.276208568673;4856.4415092264135;4917.041176970528;4920.3111564381015;4811.182099043171;4812.181929072066;4817.807287708522;4866.853994380174;4878;4755.5719985201495;4762.833300834454;4795.256735206049;4812.013537224861;4871.683340582851;4050.432939388488;4072.429859819628;4105.67154627629;4118.382242663624;4119.464469618931;3622.1306886347616;3630.5098811660087;3663.816809159531;3665.7983810890123;3671.8347674354186;4243.490781106287;4252.425922500484;4254;4259.063006138645;4312.986448184674;4741.5258474153;4770.451398089194;4901.436334821541;4905.828296009622;4972.303877457159;4183.581641835853;4200.810963506649;4202.789860506962;4203.726757760735;4205.474315710536;4246.893827654271;4290.37789520524;4294.527601963781;4295.634871035934;4299.892502687458;4580.152671755736;4582.381378513991;4583.2666773316105;4588.311753236974;4589.954100459019;4843.3461482700795;4848.0303939213;4849.466558678472;4853.441854186673;4855.49017353187;4693.859184224479;4705.858824235278;4710.175719249186;4711.646626502958;4714.057188562233;4773.3555969945;4797.040591881568;4810.7113573185725;4871.780769865293;4875.561199492063;4872.6832755870755;4879.780409881493;4887.877803054952;4889.535494128052;4941.530554597308;4744.644151688568;4746.833860814855;4749.572538471554;4750.477447480844;4809.0862736080035;4696.178168820375;4744.691595046311;4748.358971538936;4749.430068391815;4773.164696178224;4708.034852855225;4715.22198837188;4718.504557021463;4753.049390121921;4776.785044672929;4825.95174048255;4826.0830442215865;4826.155422800925;4829.541193586604;4882.487338829372;4535.25168347219;4581.450225972904;4633.83781567657;4646.349511068385;4793.496682848251 17:19:36 INFO - PROCESS | 26079 | |1;ext.html;543.7553101104503;548.5556699073751;559.278530695403;560.7420586530196;563.4253061876885;28122.718772812266;38213.235735285314;39578.60421395785;39631.40552891709;42596.57403425965;39635.40546891799;40054.19485148906;40071.39892901609;40338.7983060085;40351;7624.199459056802;7803.414743894202;7804.102528209243;7808.1801410851895;7811.179826118261;7626.885596716026;7753.689852405897;7757.379409647243;7759.262870027338;7760.844783104363;7807.063152421717;7819.687212511492;7839.804004899866;7841.8823717644;7842.5294482330955;7742.806429839271;7797.142314345418;7797.727079552245;7798.7270445534705;7801.765947021599;7625.084989801204;7721.189275126087;7727.072751269828;7730.497517661334;7732;37123.25753484942;37438.81280593607;37448.81275593632;37485.25029499422;37512.62487375146;3117.0960421477744;3215.2122729931316;3268.280978184819;3357.345317663057;3637.4907512947943;27495.175144745688;28128;28636;28687.426251475063;28780.71219287822;3158.594425480662;3162.4940009598586;3189.1548739583795;3239.7894136881027;3279.1638132276357;244098;244326;244690;245155;245412;32449.35101297961;33792;51087;51280.743596281776;51554.74222628863;31754.523682144787;32023.839880800446;32026.519602205986;32027;32032.199195020312;12591.307478088609;12734.108612397044;12760.6809829755;12770.425330860133;12774.041946854024;9891.851622225673;9958.651447199314;9962.302638815358;9963.202943764481;9968.40189588627;7579.5073320234005;7671.693132274758;7692.192319806451;7715.652795624211;7716.42126840478;2951.3507028454137;2993.1319917224196;2996.8351740654475;3033.9544906826413;3041.832699201521;840.3907167303778;858.4934888415864;906.8866391701038;940.0458534587399;946.4084946908182;25878;26088.478230435663;26771.732282676923;27555.724442755716;29764.85117574398;911.4212475078241;930.4417349590327;931.5528546297815;933.4725879877848;1018.8522664213648;13783.586492405244;14612.496072847909;14778.334974926154;14932.850671493146;15032.398704051715;362439;548961;564891;565097;569134;49385.259221111715;49817.75091124521;49966.500334996184;49985.750071250135;50248;1046.2728403759465;1050.5115121468555;1133.1274918313018;1163.069544364505;1164.2723297938787;24203.878980604983;28132.57801132944;28249.43501130007;30556.236094097825;30896.69103308938;46456.30315545202;47128;47134.29298560456;47156.52843471659;47158.528414716784;311652;320233;320896;323033;323052;22234.332970010277;22978.885105574365;24729.505409891342;25254.368640784127;25708;35915;37816;37984;38193.4270985941;39328;33110.337793244486;33281.83359083189;33516.832415837765;33603.83198083994;33789.83105084459;32176;32344.67655323511;32786.67213327836;33093.17267068342;33303.33393332168;29452.852735736185;30061.398772024;30131.849340753157;33629.15927101842;33744.3251134971;22795.658065128704;34537;35033.474497883064;35087.64912350946;35265.47101793424;24874.258801884418;25063.49873002566;25165.87417062903;25543.616845746958;25693 17:19:36 INFO - PROCESS | 26079 | |2;jquery.html;338.5784698050927;350.15088410604295;359.2402069622748;362.17785626627546;384.87876318959525;12351.135420520555;15503;15542.611434714137;16270.75593866093;17225.74161387577;15017.098974061564;15327;15911.761323580156;15973;16181.91909040456;4613.123506533756;4781.8087276508895;4782.426108866941;5058.291839142523;5384.623076384654;5242.213667949819;5356.491133342326;5385.380681221651;5389.11381016643;5391.002664507059;5501.14732216507;5572;5590.888182236353;5595.860103497404;5599.888002239953;5600.243967064455;5601.747921343549;5605.523530499932;5863.325717542494;6053.697315134225;5331.866703332409;5345.1714984177515;5345.625806193568;5346.599005074635;5346.8395948121615;12232.327222002787;12553.372331383485;12601.684957876034;12665.240085594802;19331.613367732567;1659.5768079139864;1755.5084576318652;1783.28668532588;1788.284686125547;1836.540864783804;9201.171894529458;9695.70912872615;9839;10238.795224095551;12746.553870614483;1621.4000819696787;1726.413019573351;1733.7486064520574;1758.577941294093;1770.9468715938413;63132.68433657848;63316.68341658262;63613.68193159004;63975.36024639787;67441;9584.616615335308;9713.90286097144;9722.465264410524;10069.748256293506;10098.798024039477;13529.59411217665;13552;13555.186688798703;13566.050376473551;13645.658858528417;6550.0829883816305;6585.5719378240265;6761.425278851353;6794.388505034571;6883.242843287235;6365.363463653597;6397.136386587751;6439.162908821823;6619.536632435779;6636.270010298863;4253.638440732572;4269.850555230552;4289.592488713567;4290.163418133434;4407.867763967086;1769.6195318006432;1806.945791626227;1823.8267364600342;1825.379371013835;1846.2153584726707;774.3688893551737;835.9801042727862;865.68835219321;886.2466903132415;893.2987604730386;15968.281427335798;16354.345826167058;16859.325626975027;17426.912865435846;17512.12439378026;808.9838203235902;817.1379194949267;826.0839237491664;871.1419252036738;882.849915514364;9264.305177111744;9435.150836424755;9543.188828949616;9550.564606025418;9616.75958101053;330175;331153;332028;335820;340336;70642.2935770646;70867.64566177239;71181.6440917792;71608.64195679092;72535.27464725285;865.6623916672503;891.7458524320538;893.1871996483299;897.1566727276339;898.2409863665192;14815.92592037033;14913.850861491246;14974.47589334368;15426.537203883901;15487.457938972082;31004.68995310018;31857.681423185473;33045.83477082599;33802.830985844914;35307.52733326339;44682;44686.77656611696;44945.55054449545;45032.324515132954;46764.29853552132;7154.678039488132;7384.556926584207;7391.889121663072;7678.155402905788;7929.246721561442;11312.94343528277;11532.192746507664;11661.76676466449;12006.75986480283;12186.878131218575;9822.607095716377;10141.29010969225;10171.288009839536;10378.169746420117;10654.14766818668;9778.364406313567;10000.699979000641;10094.848577271494;10433.739156520844;10635.627753028606;9064.365494415328;9791.951040244754;9802.264830137625;9932.275396726227;10829.891701082888;6594.901076483952;6911.51402448476;6941.722331106901;7210.2789721027475;7426.888596670946;8390.538520381439;10369.688909332732;10397.32417392867;10490.108340791117;10920.126389888632 17:19:36 INFO - PROCESS | 26079 | |3;mootools.html;1211.6849619099032;1327.5419980106865;1370.4929176204805;1388.4793202549045;1623.39934224337;6075.756969721211;6694.330566943303;7007.334303241197;7036.648167591626;7205.099362579677;7008.053912721781;7054.082969213995;7070.080889484373;7071.469639777025;7072.787816365504;2054.5274586845;2095.4028101990934;2095.9266425675105;2099.464636517686;2101.600695867788;2062.0720675695998;2090.7282053333047;2099.359695292935;2126.5959467701164;2133.1040962795664;2052.5792212596384;2075.937721868346;2091.1530830013867;2093.1836583732356;2094.256538928681;2010.2461576908659;2024.170090262985;2027.5843452092358;2029.0564887327464;2032.8576999610034;2014.405750303664;2026.2604149485478;2065.10168076887;2066.4833791552114;2070.099506714569;6774.729010839561;6902.5858448492745;6904.585724856474;6910.170779506441;6930.861382772317;4207.600277973587;4361.912761744779;4364.519902810688;4411.382406463098;4414;2578.9613155802676;2788.0520622988283;2837.120492647265;2837.67366752824;2845.630068091135;875.5228400521731;876.5704804645742;885.2784980241083;901.7610333261691;902.8058967321991;8918.197362237364;9062.229710474552;9067.954660226656;9080.909190908073;9099.226565741987;3508.4737289406285;3624.655657712513;3657.579378371521;3718.4236443351324;3719.8512059517857;7524.360429363565;7526.924730752732;7533.096028476618;7534;7534.246575342422;4167.062410957571;4168.0205151789305;4175.394567787654;4195.748255104703;4197.139586384784;3261.8858339957987;3369.1408690784183;3715.9256814864093;3739.457778622139;3763.4919285896053;3064.2033071401597;3106.5865031410654;3205.5672484214797;3209.935801283961;3218.11501836992;950.3964982236191;960.9279304052224;972.1590823937385;982.1406269514175;985.280745056113;805.685782544808;811.8863359129726;816.1960468938091;821.6261600971544;830.9542975136304;4670.5329467053025;4671.48613652498;4710.105080034782;4744.810207591727;4891.095147397672;403.3344980781675;403.5298876808544;406.08427994871965;407.5557642170049;847.6948298612494;3172.4924012158403;3184.3153721949893;3256.397566450214;3262.5921759780026;3346.481295399217;8267.751967440987;8484.15158484159;8574.356923230782;8585.65657373698;8593.914060859312;8536.359773017048;8545.829083418297;8546;8548.957255213683;8555;6494.4479719223455;6630;6635.767748128889;6645.136132302867;6649.4015538602725;4407.6473882089995;4600.976995115137;4606.470255920612;4644.8374306899095;4658.114958157939;7687.077550693953;7716.614169291625;7795.298423141944;7818.022747156606;7863.05643322782;7891.092524359772;7925.960370198342;7990.640421181177;8067.83864322722;8129.4715843469985;5832.650040997553;5855.38518455556;5865.266841644794;5934.821955341346;5980.700964951822;6667.53327267106;6752.662366881735;6753.628550429774;6757.121574195323;6763.560368576027;5936.732847021981;6051.788187413419;6208.9689551551955;6234;6304.05439184126;6047.0627052806885;6197.442230199304;6197.938020619736;6202.069689546604;6203.689815509116;5535.3357597087;5648.181013753065;5649.71751412436;5652.152177173457;5673.943260567342;4268.0823622921225;4269.701120921506;4278.978605106954;4293.677974152014;4454.554544545649;4222.978885105677;4237.851675191477;4300.419443375229;4303.07483890965;4432.778361081998 17:19:36 INFO - PROCESS | 26079 | |4;prototype.html;288.75311608574657;291.7068346311956;298.44787143784;302.4827544898224;302.833441607116;4656.674032817704;4814.662973591846;4834.395700537433;4881.389826271711;4905.558499735028;4653.69750966187;4696.295555666652;4726.149293127236;4730.249807571204;4783.9714461390795;3795.905102372449;3807.657310842024;3814.6566808987186;3815.2369526094753;3822.655960963513;3528.817846021573;3801.756963391598;3804.6005169457226;3816.4466152407886;3831.808409579524;3524.207053412987;3789.431585262219;3809.7237425462504;3813.2564149990762;3821.445890345898;3777.5844657087837;3783.356829339019;3783.3946568549177;3784.299904517673;3793.3930571108626;3364.5121457388786;3364.713999310062;3367.7810942288675;3369.006143187741;3371.5954085509898;4467.709598876063;4646.212272636425;4696.694714843524;4708.246680531099;4712.75112095295;4250.362445633149;4252.574742525753;4253.21315556623;4263;4263.381809637616;5025.899482010339;5028.4411832331725;5029.647924645276;5040.823571174991;5104.285400043997;3423.3495635829113;3564.32277867207;3567.839447224881;3570.8571657133684;3571.2143328467696;5247.501487358733;5258.605604579672;5258.6318957672975;5260.1583746600745;5265.578753699695;3657.780533167965;3662.6703596676425;3667.064898450878;3671.706263498967;3677.5770786359913;3497.300539892032;3717.8141092945243;3726.9937116978263;3757.830897609614;3759.4548790425233;4197.160567886435;4200.411942328076;4201.537830838605;4207.263728847501;4245.724027938174;4998.1503144464805;5005.599552035828;5012.598992080625;5052.646314758005;5052.898942021213;1204.1992075270023;1225.350564200975;1267.258653687603;1275.4770544076885;1280.9807852882213;837.7570504553734;864.5374724522351;878.9692360767342;879.3624622148891;884.6107712606432;4413.404190434315;4416.271315232951;4420.160169567772;4454.10917816438;4461.263891457873;5143.665661731976;5146.919146979101;5163.793448262028;5169.276301317818;5175.783690832726;4297.871063868089;4461.130079634505;4464.419625448736;4471.485779135376;4515.300128480091;2736.8494732789886;2751.7660998814927;2752.545829938078;2775.1674497650624;2776.2642899631614;4844.2007068833245;4895.632827537949;4900.289458028566;4924.901501969941;4944.060628480577;5163.199704045879;5296.682199068068;5320.228566857784;5343.946560534345;5345.7594408251725;4923.359963204761;4926.3842019747535;4939.3084968104495;4945.282933974553;4947.579455746302;5026.421961474477;5237.816676416307;5240.318758561362;5247.8192406708185;5252.9737351313;5068.619853510928;5078.527227104246;5085.364329458817;5087.08432482142;5096.694198348111;4863.927041094457;4874.488178741323;4879.365682461257;4883.316335712932;4890.828820991248;3701.0932321581386;3731.6641502264924;3744.831482583345;3747.1381582235695;3769.6230376962085;4903.896623259738;5078.4667609900425;5136.460671629425;5145.536901678717;5149;4994.650374473752;4996.575291100152;4999;5003.874128321098;5015.899682006267;4788.3313769074875;4957.553820156203;4965.1311020571975;4976.154053810933;4981.975090124526;4679.368285281444;4784.114938736345;4825.662203645711;4850.1997170466475;4888.804447822189;4909.459959404391;5017.147084995487;5045.571126454292;5054;5066.923996139987;4926.802927882844;4939.382577177853;4946.851594452172;4953.2663567751;4955.900881982268 17:19:36 INFO - PROCESS | 26079 | |5;yui.html;622.2936966542974;654.5352799512349;671.8421171024805;680.2313385873963;680.5644387591942;12296.5696200633;13053.216806991588;13055.477780888777;13079.934600326997;13153.73692526149;12645.988320934302;12756.553520626756;12776;12777.488900443994;12788.168769030006;611.68803910006;632.7500637248285;765.2538774694684;775.4920527054788;793.9325157361632;784.8861915022318;794.1105961323298;795.2842441802367;795.5982228974389;795.761271618515;837.5728378526965;838.2246422059601;839.1776059461731;840.7057529864529;841.6717480182703;645.9677016149174;661.4344735251387;804.8470790549835;820.6512232301249;837.3803385494751;612.3111499562991;612.6905912514152;612.9448349648509;613.1630324606924;613.2028363127961;12014.759704805854;12040.81938770919;12057.819132713017;12091.334976576285;12145.635630931087;11640.476178571984;11732.94133529327;12171.391430428443;12193.085518586142;12374.319412432313;11066.28069175501;11190.776184476264;11253;11377;11551.480183391768;3957.960420395788;3966.940495892564;3982.4424580558743;4070.1249231415386;4077.6330130288416;47772;47898.76050619724;49705.00589988216;50591;51406.48593514092;9692.563834627459;9695.254854126326;9705.660301889542;9760.170385517311;9858.112769850604;17396.304147833944;17559.20983555743;17663.11684415774;17728.379506717203;18032.188551515213;6370.77702280418;6373.203349581302;6411.903821442682;6560.278369379364;6572.244191917895;3463.203463203427;3466;3491.6682915123024;3551.7158627309755;3560.2523470071574;2615.2677250369925;2681.9731802682113;2689.1529168311918;2700.6084117803202;2706.878190481433;427.9764612946318;438.95829896159813;440.8324836562086;443.65173338928787;452.26958462084156;476.2237552788932;534.9063913815066;558.1664232994593;571.6370104983282;587.49475451112;6877.277885821916;7106.857862842818;7112.57324560528;7350.52221605594;7373.520721153108;483.24131114150447;486.6325923927483;502.8717676992417;562.521856422038;586.4956137721556;3348.748843836722;3397.8131202784084;3486.5293185419646;3509.596396414445;3557.519734835764;65714.67142664352;68308;70220.64889675518;73031;73110;62108.68945655243;62138.0679289802;62670.68664656739;62677;64253.357466425674;55031.391915030734;58872;59219.70390148108;59570;60089;6566.737330506726;6997.965010174917;7096.396806271525;7107.538010029331;7345.245532925153;31891.36217275595;32408.35183296368;33986;34971.30057398888;35975.92072237837;31809.840950795096;32102.839485802422;43077.35383969306;43750.78124609357;44750;9575;9581.281403894875;9849.556769945226;9929.156021737945;9939.254555908481;11886.702832428913;11995.40022998864;12126.090543209119;12330.136890417585;12756.61730148097;7422.66598003102;9993.550290236812;11454.541818327507;11700.765984680089;11803;10819.350838949687;11361.042301116873;11793.29240245588;11850.940745296219;12044;11298.322100673986;11321.773564528829;11533.769324613293;11705.239159454608;11710.1217408693;9182.219511341611;9328.347015709107;9341.20599749029;9488.620455181992;9886.555105020147;9103.271738260792;9181.495017774087;9519.904800951901;9536;10234.33476824004 17:19:36 INFO - PROCESS | 26079 | __end_tp_report 17:19:36 INFO - PROCESS | 26079 | __start_cc_report 17:19:36 INFO - PROCESS | 26079 | _x_x_mozilla_cycle_collect,1175 17:19:36 INFO - PROCESS | 26079 | __end_cc_report 17:19:36 INFO - PROCESS | 26079 | __startTimestamp1477613976612__endTimestamp 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | ------- Summary: start ------- 17:19:36 INFO - PROCESS | 26079 | Number of tests: 6 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | [#0] dojo.html Cycles:165 Average:4532.33 Median:4693.86 stddev:458.91 (9.8%) stddev-sans-first:433.02 17:19:36 INFO - PROCESS | 26079 | Values: 2544.7 2551.5 2570.1 2585.5 2603.0 4512.9 4567.2 4586.6 4591.7 4604.1 4597.0 4633.7 4675.4 4700.8 4790.4 4282.8 4327.6 4348.2 4354.5 4382.0 4011.7 4306.7 4345.5 4356.5 4359.4 4350.7 4363.0 4367.7 4418.2 4438.5 4208.7 4260.0 4260.3 4319.7 4355.3 4243.9 4251.7 4263.6 4292.5 4322.5 4580.9 4611.5 4651.7 4652.2 4685.9 4707.5 4970.0 4973.2 4977.1 5029.4 4777.6 4803.7 4816.8 4854.5 4859.4 4558.9 4566.1 4610.2 4619.0 4623.7 4970.0 4971.6 4972.0 4972.2 4972.3 4764.9 4769.2 4812.3 4817.4 4826.6 4816.6 4825.3 4856.4 4917.0 4920.3 4811.2 4812.2 4817.8 4866.9 4878.0 4755.6 4762.8 4795.3 4812.0 4871.7 4050.4 4072.4 4105.7 4118.4 4119.5 3622.1 3630.5 3663.8 3665.8 3671.8 4243.5 4252.4 4254.0 4259.1 4313.0 4741.5 4770.5 4901.4 4905.8 4972.3 4183.6 4200.8 4202.8 4203.7 4205.5 4246.9 4290.4 4294.5 4295.6 4299.9 4580.2 4582.4 4583.3 4588.3 4590.0 4843.3 4848.0 4849.5 4853.4 4855.5 4693.9 4705.9 4710.2 4711.6 4714.1 4773.4 4797.0 4810.7 4871.8 4875.6 4872.7 4879.8 4887.9 4889.5 4941.5 4744.6 4746.8 4749.6 4750.5 4809.1 4696.2 4744.7 4748.4 4749.4 4773.2 4708.0 4715.2 4718.5 4753.0 4776.8 4826.0 4826.1 4826.2 4829.5 4882.5 4535.3 4581.5 4633.8 4646.3 4793.5 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | [#1] ext.html Cycles:180 Average:49246.69 Median:35060.56 stddev:102511.86 (292.4%) stddev-sans-first:102734.21 17:19:36 INFO - PROCESS | 26079 | Values: 543.8 548.6 559.3 560.7 563.4 28122.7 38213.2 39578.6 39631.4 42596.6 39635.4 40054.2 40071.4 40338.8 40351.0 7624.2 7803.4 7804.1 7808.2 7811.2 7626.9 7753.7 7757.4 7759.3 7760.8 7807.1 7819.7 7839.8 7841.9 7842.5 7742.8 7797.1 7797.7 7798.7 7801.8 7625.1 7721.2 7727.1 7730.5 7732.0 37123.3 37438.8 37448.8 37485.3 37512.6 3117.1 3215.2 3268.3 3357.3 3637.5 27495.2 28128.0 28636.0 28687.4 28780.7 3158.6 3162.5 3189.2 3239.8 3279.2 244098.0 244326.0 244690.0 245155.0 245412.0 32449.4 33792.0 51087.0 51280.7 51554.7 31754.5 32023.8 32026.5 32027.0 32032.2 12591.3 12734.1 12760.7 12770.4 12774.0 9891.9 9958.7 9962.3 9963.2 9968.4 7579.5 7671.7 7692.2 7715.7 7716.4 2951.4 2993.1 2996.8 3034.0 3041.8 840.4 858.5 906.9 940.0 946.4 25878.0 26088.5 26771.7 27555.7 29764.9 911.4 930.4 931.6 933.5 1018.9 13783.6 14612.5 14778.3 14932.9 15032.4 362439.0 548961.0 564891.0 565097.0 569134.0 49385.3 49817.8 49966.5 49985.8 50248.0 1046.3 1050.5 1133.1 1163.1 1164.3 24203.9 28132.6 28249.4 30556.2 30896.7 46456.3 47128.0 47134.3 47156.5 47158.5 311652.0 320233.0 320896.0 323033.0 323052.0 22234.3 22978.9 24729.5 25254.4 25708.0 35915.0 37816.0 37984.0 38193.4 39328.0 33110.3 33281.8 33516.8 33603.8 33789.8 32176.0 32344.7 32786.7 33093.2 33303.3 29452.9 30061.4 30131.8 33629.2 33744.3 22795.7 34537.0 35033.5 35087.6 35265.5 24874.3 25063.5 25165.9 25543.6 25693.0 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | [#2] jquery.html Cycles:180 Average:21868.97 Median:24822.72 stddev:55241.65 (222.5%) stddev-sans-first:55372.97 17:19:36 INFO - PROCESS | 26079 | Values: 338.6 350.2 359.2 362.2 384.9 12351.1 15503.0 15542.6 16270.8 17225.7 15017.1 15327.0 15911.8 15973.0 16181.9 4613.1 4781.8 4782.4 5058.3 5384.6 5242.2 5356.5 5385.4 5389.1 5391.0 5501.1 5572.0 5590.9 5595.9 5599.9 5600.2 5601.7 5605.5 5863.3 6053.7 5331.9 5345.2 5345.6 5346.6 5346.8 12232.3 12553.4 12601.7 12665.2 19331.6 1659.6 1755.5 1783.3 1788.3 1836.5 9201.2 9695.7 9839.0 10238.8 12746.6 1621.4 1726.4 1733.7 1758.6 1770.9 63132.7 63316.7 63613.7 63975.4 67441.0 9584.6 9713.9 9722.5 10069.7 10098.8 13529.6 13552.0 13555.2 13566.1 13645.7 6550.1 6585.6 6761.4 6794.4 6883.2 6365.4 6397.1 6439.2 6619.5 6636.3 4253.6 4269.9 4289.6 4290.2 4407.9 1769.6 1806.9 1823.8 1825.4 1846.2 774.4 836.0 865.7 886.2 893.3 15968.3 16354.3 16859.3 17426.9 17512.1 809.0 817.1 826.1 871.1 882.8 9264.3 9435.2 9543.2 9550.6 9616.8 330175.0 331153.0 332028.0 335820.0 340336.0 70642.3 70867.6 71181.6 71608.6 72535.3 865.7 891.7 893.2 897.2 898.2 14815.9 14913.9 14974.5 15426.5 15487.5 31004.7 31857.7 33045.8 33802.8 35307.5 44682.0 44686.8 44945.6 45032.3 46764.3 7154.7 7384.6 7391.9 7678.2 7929.2 11312.9 11532.2 11661.8 12006.8 12186.9 9822.6 10141.3 10171.3 10378.2 10654.1 9778.4 10000.7 10094.8 10433.7 10635.6 9064.4 9792.0 9802.3 9932.3 10829.9 6594.9 6911.5 6941.7 7210.3 7426.9 8390.5 10369.7 10397.3 10490.1 10920.1 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | [#3] mootools.html Cycles:180 Average:4586.16 Median:5648.95 stddev:2499.23 (44.2%) stddev-sans-first:2493.37 17:19:36 INFO - PROCESS | 26079 | Values: 1211.7 1327.5 1370.5 1388.5 1623.4 6075.8 6694.3 7007.3 7036.6 7205.1 7008.1 7054.1 7070.1 7071.5 7072.8 2054.5 2095.4 2095.9 2099.5 2101.6 2062.1 2090.7 2099.4 2126.6 2133.1 2052.6 2075.9 2091.2 2093.2 2094.3 2010.2 2024.2 2027.6 2029.1 2032.9 2014.4 2026.3 2065.1 2066.5 2070.1 6774.7 6902.6 6904.6 6910.2 6930.9 4207.6 4361.9 4364.5 4411.4 4414.0 2579.0 2788.1 2837.1 2837.7 2845.6 875.5 876.6 885.3 901.8 902.8 8918.2 9062.2 9068.0 9080.9 9099.2 3508.5 3624.7 3657.6 3718.4 3719.9 7524.4 7526.9 7533.1 7534.0 7534.2 4167.1 4168.0 4175.4 4195.7 4197.1 3261.9 3369.1 3715.9 3739.5 3763.5 3064.2 3106.6 3205.6 3209.9 3218.1 950.4 960.9 972.2 982.1 985.3 805.7 811.9 816.2 821.6 831.0 4670.5 4671.5 4710.1 4744.8 4891.1 403.3 403.5 406.1 407.6 847.7 3172.5 3184.3 3256.4 3262.6 3346.5 8267.8 8484.2 8574.4 8585.7 8593.9 8536.4 8545.8 8546.0 8549.0 8555.0 6494.4 6630.0 6635.8 6645.1 6649.4 4407.6 4601.0 4606.5 4644.8 4658.1 7687.1 7716.6 7795.3 7818.0 7863.1 7891.1 7926.0 7990.6 8067.8 8129.5 5832.7 5855.4 5865.3 5934.8 5980.7 6667.5 6752.7 6753.6 6757.1 6763.6 5936.7 6051.8 6209.0 6234.0 6304.1 6047.1 6197.4 6197.9 6202.1 6203.7 5535.3 5648.2 5649.7 5652.2 5673.9 4268.1 4269.7 4279.0 4293.7 4454.6 4223.0 4237.9 4300.4 4303.1 4432.8 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | [#4] prototype.html Cycles:180 Average:4177.20 Median:4757.11 stddev:1207.81 (25.4%) stddev-sans-first:1175.40 17:19:36 INFO - PROCESS | 26079 | Values: 288.8 291.7 298.4 302.5 302.8 4656.7 4814.7 4834.4 4881.4 4905.6 4653.7 4696.3 4726.1 4730.2 4784.0 3795.9 3807.7 3814.7 3815.2 3822.7 3528.8 3801.8 3804.6 3816.4 3831.8 3524.2 3789.4 3809.7 3813.3 3821.4 3777.6 3783.4 3783.4 3784.3 3793.4 3364.5 3364.7 3367.8 3369.0 3371.6 4467.7 4646.2 4696.7 4708.2 4712.8 4250.4 4252.6 4253.2 4263.0 4263.4 5025.9 5028.4 5029.6 5040.8 5104.3 3423.3 3564.3 3567.8 3570.9 3571.2 5247.5 5258.6 5258.6 5260.2 5265.6 3657.8 3662.7 3667.1 3671.7 3677.6 3497.3 3717.8 3727.0 3757.8 3759.5 4197.2 4200.4 4201.5 4207.3 4245.7 4998.2 5005.6 5012.6 5052.6 5052.9 1204.2 1225.4 1267.3 1275.5 1281.0 837.8 864.5 879.0 879.4 884.6 4413.4 4416.3 4420.2 4454.1 4461.3 5143.7 5146.9 5163.8 5169.3 5175.8 4297.9 4461.1 4464.4 4471.5 4515.3 2736.8 2751.8 2752.5 2775.2 2776.3 4844.2 4895.6 4900.3 4924.9 4944.1 5163.2 5296.7 5320.2 5343.9 5345.8 4923.4 4926.4 4939.3 4945.3 4947.6 5026.4 5237.8 5240.3 5247.8 5253.0 5068.6 5078.5 5085.4 5087.1 5096.7 4863.9 4874.5 4879.4 4883.3 4890.8 3701.1 3731.7 3744.8 3747.1 3769.6 4903.9 5078.5 5136.5 5145.5 5149.0 4994.7 4996.6 4999.0 5003.9 5015.9 4788.3 4957.6 4965.1 4976.2 4982.0 4679.4 4784.1 4825.7 4850.2 4888.8 4909.5 5017.1 5045.6 5054.0 5066.9 4926.8 4939.4 4946.9 4953.3 4955.9 17:19:36 INFO - PROCESS | 26079 | 17:19:36 INFO - PROCESS | 26079 | [#5] yui.html Cycles:180 Average:14361.19 Median:25546.94 stddev:18445.57 (72.2%) stddev-sans-first:18468.46 17:19:36 INFO - PROCESS | 26079 | Values: 622.3 654.5 671.8 680.2 680.6 12296.6 13053.2 13055.5 13079.9 13153.7 12646.0 12756.6 12776.0 12777.5 12788.2 611.7 632.8 765.3 775.5 793.9 784.9 794.1 795.3 795.6 795.8 837.6 838.2 839.2 840.7 841.7 646.0 661.4 804.8 820.7 837.4 612.3 612.7 612.9 613.2 613.2 12014.8 12040.8 12057.8 12091.3 12145.6 11640.5 11732.9 12171.4 12193.1 12374.3 11066.3 11190.8 11253.0 11377.0 11551.5 3958.0 3966.9 3982.4 4070.1 4077.6 47772.0 47898.8 49705.0 50591.0 51406.5 9692.6 9695.3 9705.7 9760.2 9858.1 17396.3 17559.2 17663.1 17728.4 18032.2 6370.8 6373.2 6411.9 6560.3 6572.2 3463.2 3466.0 3491.7 3551.7 3560.3 2615.3 2682.0 2689.2 2700.6 2706.9 428.0 439.0 440.8 443.7 452.3 476.2 534.9 558.2 571.6 587.5 6877.3 7106.9 7112.6 7350.5 7373.5 483.2 486.6 502.9 562.5 586.5 3348.7 3397.8 3486.5 3509.6 3557.5 65714.7 68308.0 70220.6 73031.0 73110.0 62108.7 62138.1 62670.7 62677.0 64253.4 55031.4 58872.0 59219.7 59570.0 60089.0 6566.7 6998.0 7096.4 7107.5 7345.2 31891.4 32408.4 33986.0 34971.3 35975.9 31809.8 32102.8 43077.4 43750.8 44750.0 9575.0 9581.3 9849.6 9929.2 9939.3 11886.7 11995.4 12126.1 12330.1 12756.6 7422.7 9993.6 11454.5 11700.8 11803.0 10819.4 11361.0 11793.3 11850.9 12044.0 11298.3 11321.8 11533.8 11705.2 11710.1 9182.2 9328.3 9341.2 9488.6 9886.6 9103.3 9181.5 9519.9 9536.0 10234.3 17:19:36 INFO - PROCESS | 26079 | -------- Summary: end -------- 17:19:36 INFO - PROCESS | 26079 | 17:19:37 INFO - TEST-INFO | 26079: exit 0 17:19:37 INFO - TEST-OK | dromaeo_css | took 1122515ms 17:19:37 INFO - TEST-START | kraken 17:19:37 INFO - operating with platform_type : linux_ 17:19:37 INFO - Initialising browser for kraken test... 17:19:37 INFO - TEST-INFO | started process 26386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcuCLi/profile http://localhost:37853/getInfo.html) 17:19:41 INFO - PROCESS | 26386 | __metrics Screen width/height:1600/1200 17:19:41 INFO - PROCESS | 26386 | colorDepth:24 17:19:41 INFO - PROCESS | 26386 | Browser inner width/height: 1024/697 17:19:41 INFO - PROCESS | 26386 | __metrics 17:19:42 INFO - PROCESS | 26386 | 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" 17:19:42 INFO - PROCESS | 26386 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:19:42 INFO - PROCESS | 26386 | console.error: PushService: 17:19:42 INFO - PROCESS | 26386 | stateChangeProcessEnqueue: Error transitioning state 17:19:42 INFO - PROCESS | 26386 | UnknownError 17:19:43 INFO - TEST-INFO | 26386: exit 0 17:19:43 INFO - Browser initialized. 17:19:43 INFO - Running cycle 1/1 for kraken test... 17:19:43 INFO - TEST-INFO | started process 26469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcuCLi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:55 INFO - PROCESS | 26469 | RSS: Main: 173404160 17:19:55 INFO - PROCESS | 26469 | 17:19:58 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37853/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:59 INFO - PROCESS | 26469 | RSS: Main: 230674432 17:19:59 INFO - PROCESS | 26469 | 17:20:02 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37853/tests/kraken/driver.html?testName=audio-dft) 17:20:03 INFO - PROCESS | 26469 | RSS: Main: 216653824 17:20:03 INFO - PROCESS | 26469 | 17:20:06 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37853/tests/kraken/driver.html?testName=audio-fft) 17:20:06 INFO - PROCESS | 26469 | RSS: Main: 299216896 17:20:06 INFO - PROCESS | 26469 | 17:20:09 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37853/tests/kraken/driver.html?testName=audio-oscillator) 17:20:09 INFO - PROCESS | 26469 | RSS: Main: 210436096 17:20:09 INFO - PROCESS | 26469 | 17:20:11 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:12 INFO - PROCESS | 26469 | RSS: Main: 212541440 17:20:12 INFO - PROCESS | 26469 | 17:20:15 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37853/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:16 INFO - PROCESS | 26469 | RSS: Main: 248721408 17:20:16 INFO - PROCESS | 26469 | 17:20:19 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37853/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:20 INFO - PROCESS | 26469 | RSS: Main: 247984128 17:20:20 INFO - PROCESS | 26469 | 17:20:23 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37853/tests/kraken/driver.html?testName=json-parse-financial) 17:20:23 INFO - PROCESS | 26469 | RSS: Main: 248123392 17:20:23 INFO - PROCESS | 26469 | 17:20:25 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:25 INFO - PROCESS | 26469 | RSS: Main: 210034688 17:20:25 INFO - PROCESS | 26469 | 17:20:27 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:28 INFO - PROCESS | 26469 | RSS: Main: 216952832 17:20:28 INFO - PROCESS | 26469 | 17:20:30 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:31 INFO - PROCESS | 26469 | RSS: Main: 226541568 17:20:31 INFO - PROCESS | 26469 | 17:20:34 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:34 INFO - PROCESS | 26469 | RSS: Main: 235753472 17:20:34 INFO - PROCESS | 26469 | 17:20:37 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:38 INFO - PROCESS | 26469 | RSS: Main: 232136704 17:20:38 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | Cycle 1(1): loaded http://localhost:37853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37853/tests/kraken/driver.html?testName=ai-astar) 17:20:40 INFO - PROCESS | 26469 | RSS: Main: 282144768 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | __start_tp_report 17:20:40 INFO - PROCESS | 26469 | _x_x_mozilla_page_load 17:20:40 INFO - PROCESS | 26469 | _x_x_mozilla_page_load_details 17:20:40 INFO - PROCESS | 26469 | |i|pagename|runs| 17:20:40 INFO - PROCESS | 26469 | |0;ai-astar;109;116;116;116;115;117;115;114;117;115 17:20:40 INFO - PROCESS | 26469 | |1;audio-beat-detection;163;132;133;169;129;128;128;130;166;130 17:20:40 INFO - PROCESS | 26469 | |2;audio-dft;162;160;163;163;162;161;162;161;161;161 17:20:40 INFO - PROCESS | 26469 | |3;audio-fft;76;75;76;103;76;77;75;77;102;79 17:20:40 INFO - PROCESS | 26469 | |4;audio-oscillator;84;83;118;83;84;84;113;84;84;117 17:20:40 INFO - PROCESS | 26469 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 17:20:40 INFO - PROCESS | 26469 | |6;imaging-darkroom;147;146;146;147;147;146;146;148;147;145 17:20:40 INFO - PROCESS | 26469 | |7;imaging-desaturate;85;86;85;86;85;85;85;85;85;85 17:20:40 INFO - PROCESS | 26469 | |8;json-parse-financial;62;62;60;60;62;62;61;63;63;62 17:20:40 INFO - PROCESS | 26469 | |9;json-stringify-tinderbox;65;66;66;66;66;65;65;66;66;66 17:20:40 INFO - PROCESS | 26469 | |10;stanford-crypto-aes;84;83;84;83;84;83;84;83;83;84 17:20:40 INFO - PROCESS | 26469 | |11;stanford-crypto-ccm;144;151;140;149;148;150;140;142;186;151 17:20:40 INFO - PROCESS | 26469 | |12;stanford-crypto-pbkdf2;176;179;181;182;179;180;184;183;178;181 17:20:40 INFO - PROCESS | 26469 | |13;stanford-crypto-sha256-iterative;73;70;71;70;70;71;72;71;70;71 17:20:40 INFO - PROCESS | 26469 | __end_tp_report 17:20:40 INFO - PROCESS | 26469 | __start_cc_report 17:20:40 INFO - PROCESS | 26469 | _x_x_mozilla_cycle_collect,2016 17:20:40 INFO - PROCESS | 26469 | __end_cc_report 17:20:40 INFO - PROCESS | 26469 | __startTimestamp1477614040622__endTimestamp 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | ------- Summary: start ------- 17:20:40 INFO - PROCESS | 26469 | Number of tests: 14 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:2.31 (2.0%) stddev-sans-first:1.00 17:20:40 INFO - PROCESS | 26469 | Values: 109.0 116.0 116.0 116.0 115.0 117.0 115.0 114.0 117.0 115.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:132.50 stddev:17.52 (13.2%) stddev-sans-first:16.64 17:20:40 INFO - PROCESS | 26469 | Values: 163.0 132.0 133.0 169.0 129.0 128.0 128.0 130.0 166.0 130.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:20:40 INFO - PROCESS | 26469 | Values: 162.0 160.0 163.0 163.0 162.0 161.0 162.0 161.0 161.0 161.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:11.08 (14.6%) stddev-sans-first:11.56 17:20:40 INFO - PROCESS | 26469 | Values: 76.0 75.0 76.0 103.0 76.0 77.0 75.0 77.0 102.0 79.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.00 stddev:15.65 (18.6%) stddev-sans-first:16.23 17:20:40 INFO - PROCESS | 26469 | Values: 84.0 83.0 118.0 83.0 84.0 84.0 113.0 84.0 84.0 117.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:20:40 INFO - PROCESS | 26469 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 17:20:40 INFO - PROCESS | 26469 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 148.0 147.0 145.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 17:20:40 INFO - PROCESS | 26469 | Values: 85.0 86.0 85.0 86.0 85.0 85.0 85.0 85.0 85.0 85.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 17:20:40 INFO - PROCESS | 26469 | Values: 62.0 62.0 60.0 60.0 62.0 62.0 61.0 63.0 63.0 62.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 17:20:40 INFO - PROCESS | 26469 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 17:20:40 INFO - PROCESS | 26469 | Values: 84.0 83.0 84.0 83.0 84.0 83.0 84.0 83.0 83.0 84.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:149.50 stddev:13.35 (8.9%) stddev-sans-first:13.97 17:20:40 INFO - PROCESS | 26469 | Values: 144.0 151.0 140.0 149.0 148.0 150.0 140.0 142.0 186.0 151.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:181.00 stddev:2.41 (1.3%) stddev-sans-first:1.99 17:20:40 INFO - PROCESS | 26469 | Values: 176.0 179.0 181.0 182.0 179.0 180.0 184.0 183.0 178.0 181.0 17:20:40 INFO - PROCESS | 26469 | 17:20:40 INFO - PROCESS | 26469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:0.99 (1.4%) stddev-sans-first:0.71 17:20:40 INFO - PROCESS | 26469 | Values: 73.0 70.0 71.0 70.0 70.0 71.0 72.0 71.0 70.0 71.0 17:20:40 INFO - PROCESS | 26469 | -------- Summary: end -------- 17:20:40 INFO - PROCESS | 26469 | 17:20:41 INFO - TEST-INFO | 26469: exit 0 17:20:41 INFO - TEST-OK | kraken | took 64327ms 17:20:41 INFO - SUITE-END | took 1186s 17:20:42 INFO - Completed test suite (00:19:47) 17:20:42 INFO - javascript benchmark 17:20:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2544.7328030556796, 2551.4514379408424, 2570.1004648373073, 2585.457054018656, 2603.010855874766, 4512.9097418051615, 4567.223571992761, 4586.610138138258, 4591.747453890039, 4604.125216208918, 4597.034622729222, 4633.745144017078, 4675.368825208596, 4700.788464519096, 4790.353302304188, 4282.7858607069675, 4327.632151267146, 4348.152110338485, 4354.47746270448, 4381.956180438203, 4011.65900898424, 4306.74159550428, 4345.543717909622, 4356.499002614708, 4359.367891655708, 4350.695451318409, 4363.040131171138, 4367.650587952972, 4418.2268103082, 4438.4895736990175, 4208.663306935468, 4260.020195355086, 4260.25445547028, 4319.67602429819, 4355.324924636687, 4243.872683819491, 4251.702380833343, 4263.552327005682, 4292.463442069741, 4322.50291216511, 4580.885477863047, 4611.492735799059, 4651.674382793206, 4652.209124448852, 4685.906281874343, 4707.458642256116, 4970.030843985424, 4973.229149481836, 4977.104121258172, 5029.4216165141115, 4777.570018698334, 4803.7357945313, 4816.795801049738, 4854.514548545152, 4859.441164266119, 4558.8632341029825, 4566.109608626352, 4610.170169369512, 4619.0, 4623.69945953512, 4970.030843985461, 4971.552560269593, 4971.950280497149, 4972.179590367549, 4972.328735620717, 4764.857054288377, 4769.165396055676, 4812.278158276216, 4817.421909370828, 4826.58973987208, 4816.566509014206, 4825.276208568673, 4856.4415092264135, 4917.041176970528, 4920.3111564381015, 4811.182099043171, 4812.181929072066, 4817.807287708522, 4866.853994380174, 4878.0, 4755.5719985201495, 4762.833300834454, 4795.256735206049, 4812.013537224861, 4871.683340582851, 4050.432939388488, 4072.429859819628, 4105.67154627629, 4118.382242663624, 4119.464469618931, 3622.1306886347616, 3630.5098811660087, 3663.816809159531, 3665.7983810890123, 3671.8347674354186, 4243.490781106287, 4252.425922500484, 4254.0, 4259.063006138645, 4312.986448184674, 4741.5258474153, 4770.451398089194, 4901.436334821541, 4905.828296009622, 4972.303877457159, 4183.581641835853, 4200.810963506649, 4202.789860506962, 4203.726757760735, 4205.474315710536, 4246.893827654271, 4290.37789520524, 4294.527601963781, 4295.634871035934, 4299.892502687458, 4580.152671755736, 4582.381378513991, 4583.2666773316105, 4588.311753236974, 4589.954100459019, 4843.3461482700795, 4848.0303939213, 4849.466558678472, 4853.441854186673, 4855.49017353187, 4693.859184224479, 4705.858824235278, 4710.175719249186, 4711.646626502958, 4714.057188562233, 4773.3555969945, 4797.040591881568, 4810.7113573185725, 4871.780769865293, 4875.561199492063, 4872.6832755870755, 4879.780409881493, 4887.877803054952, 4889.535494128052, 4941.530554597308, 4744.644151688568, 4746.833860814855, 4749.572538471554, 4750.477447480844, 4809.0862736080035, 4696.178168820375, 4744.691595046311, 4748.358971538936, 4749.430068391815, 4773.164696178224, 4708.034852855225, 4715.22198837188, 4718.504557021463, 4753.049390121921, 4776.785044672929, 4825.95174048255, 4826.0830442215865, 4826.155422800925, 4829.541193586604, 4882.487338829372, 4535.25168347219, 4581.450225972904, 4633.83781567657, 4646.349511068385, 4793.496682848251], "value": 4503.72401599871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.7553101104503, 548.5556699073751, 559.278530695403, 560.7420586530196, 563.4253061876885, 28122.718772812266, 38213.235735285314, 39578.60421395785, 39631.40552891709, 42596.57403425965, 39635.40546891799, 40054.19485148906, 40071.39892901609, 40338.7983060085, 40351.0, 7624.199459056802, 7803.414743894202, 7804.102528209243, 7808.1801410851895, 7811.179826118261, 7626.885596716026, 7753.689852405897, 7757.379409647243, 7759.262870027338, 7760.844783104363, 7807.063152421717, 7819.687212511492, 7839.804004899866, 7841.8823717644, 7842.5294482330955, 7742.806429839271, 7797.142314345418, 7797.727079552245, 7798.7270445534705, 7801.765947021599, 7625.084989801204, 7721.189275126087, 7727.072751269828, 7730.497517661334, 7732.0, 37123.25753484942, 37438.81280593607, 37448.81275593632, 37485.25029499422, 37512.62487375146, 3117.0960421477744, 3215.2122729931316, 3268.280978184819, 3357.345317663057, 3637.4907512947943, 27495.175144745688, 28128.0, 28636.0, 28687.426251475063, 28780.71219287822, 3158.594425480662, 3162.4940009598586, 3189.1548739583795, 3239.7894136881027, 3279.1638132276357, 244098.0, 244326.0, 244690.0, 245155.0, 245412.0, 32449.35101297961, 33792.0, 51087.0, 51280.743596281776, 51554.74222628863, 31754.523682144787, 32023.839880800446, 32026.519602205986, 32027.0, 32032.199195020312, 12591.307478088609, 12734.108612397044, 12760.6809829755, 12770.425330860133, 12774.041946854024, 9891.851622225673, 9958.651447199314, 9962.302638815358, 9963.202943764481, 9968.40189588627, 7579.5073320234005, 7671.693132274758, 7692.192319806451, 7715.652795624211, 7716.42126840478, 2951.3507028454137, 2993.1319917224196, 2996.8351740654475, 3033.9544906826413, 3041.832699201521, 840.3907167303778, 858.4934888415864, 906.8866391701038, 940.0458534587399, 946.4084946908182, 25878.0, 26088.478230435663, 26771.732282676923, 27555.724442755716, 29764.85117574398, 911.4212475078241, 930.4417349590327, 931.5528546297815, 933.4725879877848, 1018.8522664213648, 13783.586492405244, 14612.496072847909, 14778.334974926154, 14932.850671493146, 15032.398704051715, 362439.0, 548961.0, 564891.0, 565097.0, 569134.0, 49385.259221111715, 49817.75091124521, 49966.500334996184, 49985.750071250135, 50248.0, 1046.2728403759465, 1050.5115121468555, 1133.1274918313018, 1163.069544364505, 1164.2723297938787, 24203.878980604983, 28132.57801132944, 28249.43501130007, 30556.236094097825, 30896.69103308938, 46456.30315545202, 47128.0, 47134.29298560456, 47156.52843471659, 47158.528414716784, 311652.0, 320233.0, 320896.0, 323033.0, 323052.0, 22234.332970010277, 22978.885105574365, 24729.505409891342, 25254.368640784127, 25708.0, 35915.0, 37816.0, 37984.0, 38193.4270985941, 39328.0, 33110.337793244486, 33281.83359083189, 33516.832415837765, 33603.83198083994, 33789.83105084459, 32176.0, 32344.67655323511, 32786.67213327836, 33093.17267068342, 33303.33393332168, 29452.852735736185, 30061.398772024, 30131.849340753157, 33629.15927101842, 33744.3251134971, 22795.658065128704, 34537.0, 35033.474497883064, 35087.64912350946, 35265.47101793424, 24874.258801884418, 25063.49873002566, 25165.87417062903, 25543.616845746958, 25693.0], "value": 16119.682467074044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.5784698050927, 350.15088410604295, 359.2402069622748, 362.17785626627546, 384.87876318959525, 12351.135420520555, 15503.0, 15542.611434714137, 16270.75593866093, 17225.74161387577, 15017.098974061564, 15327.0, 15911.761323580156, 15973.0, 16181.91909040456, 4613.123506533756, 4781.8087276508895, 4782.426108866941, 5058.291839142523, 5384.623076384654, 5242.213667949819, 5356.491133342326, 5385.380681221651, 5389.11381016643, 5391.002664507059, 5501.14732216507, 5572.0, 5590.888182236353, 5595.860103497404, 5599.888002239953, 5600.243967064455, 5601.747921343549, 5605.523530499932, 5863.325717542494, 6053.697315134225, 5331.866703332409, 5345.1714984177515, 5345.625806193568, 5346.599005074635, 5346.8395948121615, 12232.327222002787, 12553.372331383485, 12601.684957876034, 12665.240085594802, 19331.613367732567, 1659.5768079139864, 1755.5084576318652, 1783.28668532588, 1788.284686125547, 1836.540864783804, 9201.171894529458, 9695.70912872615, 9839.0, 10238.795224095551, 12746.553870614483, 1621.4000819696787, 1726.413019573351, 1733.7486064520574, 1758.577941294093, 1770.9468715938413, 63132.68433657848, 63316.68341658262, 63613.68193159004, 63975.36024639787, 67441.0, 9584.616615335308, 9713.90286097144, 9722.465264410524, 10069.748256293506, 10098.798024039477, 13529.59411217665, 13552.0, 13555.186688798703, 13566.050376473551, 13645.658858528417, 6550.0829883816305, 6585.5719378240265, 6761.425278851353, 6794.388505034571, 6883.242843287235, 6365.363463653597, 6397.136386587751, 6439.162908821823, 6619.536632435779, 6636.270010298863, 4253.638440732572, 4269.850555230552, 4289.592488713567, 4290.163418133434, 4407.867763967086, 1769.6195318006432, 1806.945791626227, 1823.8267364600342, 1825.379371013835, 1846.2153584726707, 774.3688893551737, 835.9801042727862, 865.68835219321, 886.2466903132415, 893.2987604730386, 15968.281427335798, 16354.345826167058, 16859.325626975027, 17426.912865435846, 17512.12439378026, 808.9838203235902, 817.1379194949267, 826.0839237491664, 871.1419252036738, 882.849915514364, 9264.305177111744, 9435.150836424755, 9543.188828949616, 9550.564606025418, 9616.75958101053, 330175.0, 331153.0, 332028.0, 335820.0, 340336.0, 70642.2935770646, 70867.64566177239, 71181.6440917792, 71608.64195679092, 72535.27464725285, 865.6623916672503, 891.7458524320538, 893.1871996483299, 897.1566727276339, 898.2409863665192, 14815.92592037033, 14913.850861491246, 14974.47589334368, 15426.537203883901, 15487.457938972082, 31004.68995310018, 31857.681423185473, 33045.83477082599, 33802.830985844914, 35307.52733326339, 44682.0, 44686.77656611696, 44945.55054449545, 45032.324515132954, 46764.29853552132, 7154.678039488132, 7384.556926584207, 7391.889121663072, 7678.155402905788, 7929.246721561442, 11312.94343528277, 11532.192746507664, 11661.76676466449, 12006.75986480283, 12186.878131218575, 9822.607095716377, 10141.29010969225, 10171.288009839536, 10378.169746420117, 10654.14766818668, 9778.364406313567, 10000.699979000641, 10094.848577271494, 10433.739156520844, 10635.627753028606, 9064.365494415328, 9791.951040244754, 9802.264830137625, 9932.275396726227, 10829.891701082888, 6594.901076483952, 6911.51402448476, 6941.722331106901, 7210.2789721027475, 7426.888596670946, 8390.538520381439, 10369.688909332732, 10397.32417392867, 10490.108340791117, 10920.126389888632], "value": 7865.504191628535, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.6849619099032, 1327.5419980106865, 1370.4929176204805, 1388.4793202549045, 1623.39934224337, 6075.756969721211, 6694.330566943303, 7007.334303241197, 7036.648167591626, 7205.099362579677, 7008.053912721781, 7054.082969213995, 7070.080889484373, 7071.469639777025, 7072.787816365504, 2054.5274586845, 2095.4028101990934, 2095.9266425675105, 2099.464636517686, 2101.600695867788, 2062.0720675695998, 2090.7282053333047, 2099.359695292935, 2126.5959467701164, 2133.1040962795664, 2052.5792212596384, 2075.937721868346, 2091.1530830013867, 2093.1836583732356, 2094.256538928681, 2010.2461576908659, 2024.170090262985, 2027.5843452092358, 2029.0564887327464, 2032.8576999610034, 2014.405750303664, 2026.2604149485478, 2065.10168076887, 2066.4833791552114, 2070.099506714569, 6774.729010839561, 6902.5858448492745, 6904.585724856474, 6910.170779506441, 6930.861382772317, 4207.600277973587, 4361.912761744779, 4364.519902810688, 4411.382406463098, 4414.0, 2578.9613155802676, 2788.0520622988283, 2837.120492647265, 2837.67366752824, 2845.630068091135, 875.5228400521731, 876.5704804645742, 885.2784980241083, 901.7610333261691, 902.8058967321991, 8918.197362237364, 9062.229710474552, 9067.954660226656, 9080.909190908073, 9099.226565741987, 3508.4737289406285, 3624.655657712513, 3657.579378371521, 3718.4236443351324, 3719.8512059517857, 7524.360429363565, 7526.924730752732, 7533.096028476618, 7534.0, 7534.246575342422, 4167.062410957571, 4168.0205151789305, 4175.394567787654, 4195.748255104703, 4197.139586384784, 3261.8858339957987, 3369.1408690784183, 3715.9256814864093, 3739.457778622139, 3763.4919285896053, 3064.2033071401597, 3106.5865031410654, 3205.5672484214797, 3209.935801283961, 3218.11501836992, 950.3964982236191, 960.9279304052224, 972.1590823937385, 982.1406269514175, 985.280745056113, 805.685782544808, 811.8863359129726, 816.1960468938091, 821.6261600971544, 830.9542975136304, 4670.5329467053025, 4671.48613652498, 4710.105080034782, 4744.810207591727, 4891.095147397672, 403.3344980781675, 403.5298876808544, 406.08427994871965, 407.5557642170049, 847.6948298612494, 3172.4924012158403, 3184.3153721949893, 3256.397566450214, 3262.5921759780026, 3346.481295399217, 8267.751967440987, 8484.15158484159, 8574.356923230782, 8585.65657373698, 8593.914060859312, 8536.359773017048, 8545.829083418297, 8546.0, 8548.957255213683, 8555.0, 6494.4479719223455, 6630.0, 6635.767748128889, 6645.136132302867, 6649.4015538602725, 4407.6473882089995, 4600.976995115137, 4606.470255920612, 4644.8374306899095, 4658.114958157939, 7687.077550693953, 7716.614169291625, 7795.298423141944, 7818.022747156606, 7863.05643322782, 7891.092524359772, 7925.960370198342, 7990.640421181177, 8067.83864322722, 8129.4715843469985, 5832.650040997553, 5855.38518455556, 5865.266841644794, 5934.821955341346, 5980.700964951822, 6667.53327267106, 6752.662366881735, 6753.628550429774, 6757.121574195323, 6763.560368576027, 5936.732847021981, 6051.788187413419, 6208.9689551551955, 6234.0, 6304.05439184126, 6047.0627052806885, 6197.442230199304, 6197.938020619736, 6202.069689546604, 6203.689815509116, 5535.3357597087, 5648.181013753065, 5649.71751412436, 5652.152177173457, 5673.943260567342, 4268.0823622921225, 4269.701120921506, 4278.978605106954, 4293.677974152014, 4454.554544545649, 4222.978885105677, 4237.851675191477, 4300.419443375229, 4303.07483890965, 4432.778361081998], "value": 3699.5552393172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.75311608574657, 291.7068346311956, 298.44787143784, 302.4827544898224, 302.833441607116, 4656.674032817704, 4814.662973591846, 4834.395700537433, 4881.389826271711, 4905.558499735028, 4653.69750966187, 4696.295555666652, 4726.149293127236, 4730.249807571204, 4783.9714461390795, 3795.905102372449, 3807.657310842024, 3814.6566808987186, 3815.2369526094753, 3822.655960963513, 3528.817846021573, 3801.756963391598, 3804.6005169457226, 3816.4466152407886, 3831.808409579524, 3524.207053412987, 3789.431585262219, 3809.7237425462504, 3813.2564149990762, 3821.445890345898, 3777.5844657087837, 3783.356829339019, 3783.3946568549177, 3784.299904517673, 3793.3930571108626, 3364.5121457388786, 3364.713999310062, 3367.7810942288675, 3369.006143187741, 3371.5954085509898, 4467.709598876063, 4646.212272636425, 4696.694714843524, 4708.246680531099, 4712.75112095295, 4250.362445633149, 4252.574742525753, 4253.21315556623, 4263.0, 4263.381809637616, 5025.899482010339, 5028.4411832331725, 5029.647924645276, 5040.823571174991, 5104.285400043997, 3423.3495635829113, 3564.32277867207, 3567.839447224881, 3570.8571657133684, 3571.2143328467696, 5247.501487358733, 5258.605604579672, 5258.6318957672975, 5260.1583746600745, 5265.578753699695, 3657.780533167965, 3662.6703596676425, 3667.064898450878, 3671.706263498967, 3677.5770786359913, 3497.300539892032, 3717.8141092945243, 3726.9937116978263, 3757.830897609614, 3759.4548790425233, 4197.160567886435, 4200.411942328076, 4201.537830838605, 4207.263728847501, 4245.724027938174, 4998.1503144464805, 5005.599552035828, 5012.598992080625, 5052.646314758005, 5052.898942021213, 1204.1992075270023, 1225.350564200975, 1267.258653687603, 1275.4770544076885, 1280.9807852882213, 837.7570504553734, 864.5374724522351, 878.9692360767342, 879.3624622148891, 884.6107712606432, 4413.404190434315, 4416.271315232951, 4420.160169567772, 4454.10917816438, 4461.263891457873, 5143.665661731976, 5146.919146979101, 5163.793448262028, 5169.276301317818, 5175.783690832726, 4297.871063868089, 4461.130079634505, 4464.419625448736, 4471.485779135376, 4515.300128480091, 2736.8494732789886, 2751.7660998814927, 2752.545829938078, 2775.1674497650624, 2776.2642899631614, 4844.2007068833245, 4895.632827537949, 4900.289458028566, 4924.901501969941, 4944.060628480577, 5163.199704045879, 5296.682199068068, 5320.228566857784, 5343.946560534345, 5345.7594408251725, 4923.359963204761, 4926.3842019747535, 4939.3084968104495, 4945.282933974553, 4947.579455746302, 5026.421961474477, 5237.816676416307, 5240.318758561362, 5247.8192406708185, 5252.9737351313, 5068.619853510928, 5078.527227104246, 5085.364329458817, 5087.08432482142, 5096.694198348111, 4863.927041094457, 4874.488178741323, 4879.365682461257, 4883.316335712932, 4890.828820991248, 3701.0932321581386, 3731.6641502264924, 3744.831482583345, 3747.1381582235695, 3769.6230376962085, 4903.896623259738, 5078.4667609900425, 5136.460671629425, 5145.536901678717, 5149.0, 4994.650374473752, 4996.575291100152, 4999.0, 5003.874128321098, 5015.899682006267, 4788.3313769074875, 4957.553820156203, 4965.1311020571975, 4976.154053810933, 4981.975090124526, 4679.368285281444, 4784.114938736345, 4825.662203645711, 4850.1997170466475, 4888.804447822189, 4909.459959404391, 5017.147084995487, 5045.571126454292, 5054.0, 5066.923996139987, 4926.802927882844, 4939.382577177853, 4946.851594452172, 4953.2663567751, 4955.900881982268], "value": 3792.5177993188154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.2936966542974, 654.5352799512349, 671.8421171024805, 680.2313385873963, 680.5644387591942, 12296.5696200633, 13053.216806991588, 13055.477780888777, 13079.934600326997, 13153.73692526149, 12645.988320934302, 12756.553520626756, 12776.0, 12777.488900443994, 12788.168769030006, 611.68803910006, 632.7500637248285, 765.2538774694684, 775.4920527054788, 793.9325157361632, 784.8861915022318, 794.1105961323298, 795.2842441802367, 795.5982228974389, 795.761271618515, 837.5728378526965, 838.2246422059601, 839.1776059461731, 840.7057529864529, 841.6717480182703, 645.9677016149174, 661.4344735251387, 804.8470790549835, 820.6512232301249, 837.3803385494751, 612.3111499562991, 612.6905912514152, 612.9448349648509, 613.1630324606924, 613.2028363127961, 12014.759704805854, 12040.81938770919, 12057.819132713017, 12091.334976576285, 12145.635630931087, 11640.476178571984, 11732.94133529327, 12171.391430428443, 12193.085518586142, 12374.319412432313, 11066.28069175501, 11190.776184476264, 11253.0, 11377.0, 11551.480183391768, 3957.960420395788, 3966.940495892564, 3982.4424580558743, 4070.1249231415386, 4077.6330130288416, 47772.0, 47898.76050619724, 49705.00589988216, 50591.0, 51406.48593514092, 9692.563834627459, 9695.254854126326, 9705.660301889542, 9760.170385517311, 9858.112769850604, 17396.304147833944, 17559.20983555743, 17663.11684415774, 17728.379506717203, 18032.188551515213, 6370.77702280418, 6373.203349581302, 6411.903821442682, 6560.278369379364, 6572.244191917895, 3463.203463203427, 3466.0, 3491.6682915123024, 3551.7158627309755, 3560.2523470071574, 2615.2677250369925, 2681.9731802682113, 2689.1529168311918, 2700.6084117803202, 2706.878190481433, 427.9764612946318, 438.95829896159813, 440.8324836562086, 443.65173338928787, 452.26958462084156, 476.2237552788932, 534.9063913815066, 558.1664232994593, 571.6370104983282, 587.49475451112, 6877.277885821916, 7106.857862842818, 7112.57324560528, 7350.52221605594, 7373.520721153108, 483.24131114150447, 486.6325923927483, 502.8717676992417, 562.521856422038, 586.4956137721556, 3348.748843836722, 3397.8131202784084, 3486.5293185419646, 3509.596396414445, 3557.519734835764, 65714.67142664352, 68308.0, 70220.64889675518, 73031.0, 73110.0, 62108.68945655243, 62138.0679289802, 62670.68664656739, 62677.0, 64253.357466425674, 55031.391915030734, 58872.0, 59219.70390148108, 59570.0, 60089.0, 6566.737330506726, 6997.965010174917, 7096.396806271525, 7107.538010029331, 7345.245532925153, 31891.36217275595, 32408.35183296368, 33986.0, 34971.30057398888, 35975.92072237837, 31809.840950795096, 32102.839485802422, 43077.35383969306, 43750.78124609357, 44750.0, 9575.0, 9581.281403894875, 9849.556769945226, 9929.156021737945, 9939.254555908481, 11886.702832428913, 11995.40022998864, 12126.090543209119, 12330.136890417585, 12756.61730148097, 7422.66598003102, 9993.550290236812, 11454.541818327507, 11700.765984680089, 11803.0, 10819.350838949687, 11361.042301116873, 11793.29240245588, 11850.940745296219, 12044.0, 11298.322100673986, 11321.773564528829, 11533.769324613293, 11705.239159454608, 11710.1217408693, 9182.219511341611, 9328.347015709107, 9341.20599749029, 9488.620455181992, 9886.555105020147, 9103.271738260792, 9181.495017774087, 9519.904800951901, 9536.0, 10234.33476824004], "value": 5981.888483087325, "unit": "score"}], "name": "dromaeo_css", "value": 6027.0320504262545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 116.0, 115.0, 117.0, 115.0, 114.0, 117.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 133.0, 169.0, 129.0, 128.0, 128.0, 130.0, 166.0, 130.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 103.0, 76.0, 77.0, 75.0, 77.0, 102.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 83.0, 84.0, 84.0, 113.0, 84.0, 84.0, 117.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 60.0, 62.0, 62.0, 61.0, 63.0, 63.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 83.0, 84.0, 83.0, 84.0, 83.0, 83.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 151.0, 140.0, 149.0, 148.0, 150.0, 140.0, 142.0, 186.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 181.0, 182.0, 179.0, 180.0, 184.0, 183.0, 178.0, 181.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 71.0, 70.0, 70.0, 71.0, 72.0, 71.0, 70.0, 71.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1553.1, "alertThreshold": 2.0}]} 17:20:42 INFO - Return code: 0 17:20:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:20:42 INFO - # TBPL SUCCESS # 17:20:42 INFO - Running post-action listener: _resource_record_post_action 17:20:42 INFO - [mozharness: 2016-10-28 00:20:42.421980Z] Finished run-tests step (success) 17:20:42 INFO - Running post-run listener: _resource_record_post_run 17:20:42 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407543808; Read time: 100; Write time: 217484 17:20:42 INFO - TinderboxPrint: CPU usage
13.0% 17:20:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 100 17:20:42 INFO - TinderboxPrint: I/O write bytes / time
407,543,808 / 217,484 17:20:42 INFO - TinderboxPrint: CPU idle
8,347.5 (87.0%) 17:20:42 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 17:20:42 INFO - TinderboxPrint: Swap in / out
0 / 0 17:20:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115617792; Read time: 0; Write time: 58200 17:20:42 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290983936; Read time: 88; Write time: 159260 17:20:43 INFO - Running post-run listener: _upload_blobber_files 17:20:43 INFO - Blob upload gear active. 17:20:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:43 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 17:20:43 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20:43 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:20:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:44 INFO - (blobuploader) - INFO - Done attempting. 17:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:45 INFO - (blobuploader) - INFO - Done attempting. 17:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:48 INFO - (blobuploader) - INFO - Done attempting. 17:20:48 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:48 INFO - Return code: 0 17:20:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3f4a46b36f2fb3cd168512edb55a355d8c1599b66603accfaea590ee4141a631f0b92a1808836d6799a1dc180cbec6918af461351f364bb2202a0c546f5dce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d46ee52950e644126769ce2c3bd497c8657bba7a20009ce378e7313a01c44b2b53b7e679fac7deab982e886d80c5feae319bb2ca6f74b0731c5cb15f4b2e9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91329768f3385cbb117c90710d3b452906455274a28c876916491a7e5e25710785148e3c47a1b92794c8b872cc1daba2268fcfeac13d1306b0fc92c39ebd9252"} 17:20:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:48 INFO - Contents: 17:20:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3f4a46b36f2fb3cd168512edb55a355d8c1599b66603accfaea590ee4141a631f0b92a1808836d6799a1dc180cbec6918af461351f364bb2202a0c546f5dce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d46ee52950e644126769ce2c3bd497c8657bba7a20009ce378e7313a01c44b2b53b7e679fac7deab982e886d80c5feae319bb2ca6f74b0731c5cb15f4b2e9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91329768f3385cbb117c90710d3b452906455274a28c876916491a7e5e25710785148e3c47a1b92794c8b872cc1daba2268fcfeac13d1306b0fc92c39ebd9252"} 17:20:48 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:48 INFO - Copying logs to upload dir... 17:20:48 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.202994 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-27 17:20:48.426503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 17:20:48.429681) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca3f4a46b36f2fb3cd168512edb55a355d8c1599b66603accfaea590ee4141a631f0b92a1808836d6799a1dc180cbec6918af461351f364bb2202a0c546f5dce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d46ee52950e644126769ce2c3bd497c8657bba7a20009ce378e7313a01c44b2b53b7e679fac7deab982e886d80c5feae319bb2ca6f74b0731c5cb15f4b2e9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91329768f3385cbb117c90710d3b452906455274a28c876916491a7e5e25710785148e3c47a1b92794c8b872cc1daba2268fcfeac13d1306b0fc92c39ebd9252"} build_url:https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/H256VKIDTai_vQMLShM9nQ/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/Firefox-Non-PGO/sha512/ca3f4a46b36f2fb3cd168512edb55a355d8c1599b66603accfaea590ee4141a631f0b92a1808836d6799a1dc180cbec6918af461351f364bb2202a0c546f5dce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d46ee52950e644126769ce2c3bd497c8657bba7a20009ce378e7313a01c44b2b53b7e679fac7deab982e886d80c5feae319bb2ca6f74b0731c5cb15f4b2e9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91329768f3385cbb117c90710d3b452906455274a28c876916491a7e5e25710785148e3c47a1b92794c8b872cc1daba2268fcfeac13d1306b0fc92c39ebd9252"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 17:20:48.454876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 17:20:48.455197) ========= 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=bb9b54edd4a927dc735d112f000001d9-1477612574.809032-844819398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 17:20:48.539084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 17:20:48.539415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 17:20:48.539695) ========= ========= Total master_lag: 0.18 =========