builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1480563823.15 results: success (0) buildid: 20161130182744 builduid: b0833dd377694f8cb6466424ea87e259 revision: 21aaa1c5e08ac01088ef575b06557e4fc04bcb28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.147068) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.147448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.148097) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.193460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.193778) ========= 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=6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 19:43:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 459K=0.03s 2016-11-30 19:43:43 (459 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.187850 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.417064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.417371) ========= 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=6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019700 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.466983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:43.467360) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 21aaa1c5e08ac01088ef575b06557e4fc04bcb28 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 21aaa1c5e08ac01088ef575b06557e4fc04bcb28 --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=6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 19:43:43,604 truncating revision to first 12 chars 2016-11-30 19:43:43,604 Setting DEBUG logging. 2016-11-30 19:43:43,604 attempt 1/10 2016-11-30 19:43:43,604 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/21aaa1c5e08a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 19:43:43,960 unpacking tar archive at: graphics-21aaa1c5e08a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:44.160138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:44.160538) ========= script_repo_revision: 21aaa1c5e08ac01088ef575b06557e4fc04bcb28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:44.161044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:44.161761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 19:43:44.171224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-30 19:43:44.171547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:43:44 INFO - MultiFileLogger online at 20161130 19:43:44 in /builds/slave/test 19:43:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:43:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:43:44 INFO - {'append_to_log': False, 19:43:44 INFO - 'base_work_dir': '/builds/slave/test', 19:43:44 INFO - 'blob_upload_branch': 'Graphics', 19:43:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:43:44 INFO - 'branch': 'Graphics', 19:43:44 INFO - 'buildbot_json_path': 'buildprops.json', 19:43:44 INFO - 'config_files': ('talos/linux_config.py',), 19:43:44 INFO - 'default_actions': ('clobber', 19:43:44 INFO - 'read-buildbot-config', 19:43:44 INFO - 'download-and-extract', 19:43:44 INFO - 'populate-webroot', 19:43:44 INFO - 'create-virtualenv', 19:43:44 INFO - 'install', 19:43:44 INFO - 'run-tests'), 19:43:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:43:44 INFO - 'download_minidump_stackwalk': True, 19:43:44 INFO - 'download_symbols': 'ondemand', 19:43:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:43:44 INFO - 'tooltool.py': '/tools/tooltool.py', 19:43:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:43:44 INFO - '/tools/misc-python/virtualenv.py')}, 19:43:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:43:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:43:44 INFO - 'installer_path': 'installer.exe', 19:43:44 INFO - 'log_level': 'info', 19:43:44 INFO - 'log_name': 'talos', 19:43:44 INFO - 'log_to_console': True, 19:43:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:43:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:43:44 INFO - 'opt_config_files': (), 19:43:44 INFO - 'pip_index': False, 19:43:44 INFO - 'sps_profile': False, 19:43:44 INFO - 'sps_profile_interval': 0, 19:43:44 INFO - 'suite': 'dromaeojs', 19:43:44 INFO - 'system_bits': '32', 19:43:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:43:44 INFO - 'title': 'talos-linux64-ix-050', 19:43:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:43:44 INFO - 'use_talos_json': True, 19:43:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:43:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:43:44 INFO - 'work_dir': 'build'} 19:43:44 INFO - [mozharness: 2016-12-01 03:43:44.542504Z] Running clobber step. 19:43:44 INFO - Running pre-action listener: _resource_record_pre_action 19:43:44 INFO - Running main action method: clobber 19:43:44 INFO - rmtree: /builds/slave/test/build 19:43:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:43:44 INFO - Running post-action listener: _resource_record_post_action 19:43:44 INFO - [mozharness: 2016-12-01 03:43:44.970767Z] Finished clobber step (success) 19:43:44 INFO - [mozharness: 2016-12-01 03:43:44.970865Z] Running read-buildbot-config step. 19:43:44 INFO - Running pre-action listener: _resource_record_pre_action 19:43:44 INFO - Running main action method: read_buildbot_config 19:43:44 INFO - Using buildbot properties: 19:43:44 INFO - { 19:43:44 INFO - "project": "", 19:43:44 INFO - "product": "firefox", 19:43:44 INFO - "script_repo_revision": "default", 19:43:44 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 19:43:44 INFO - "repository": "", 19:43:44 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 19:43:44 INFO - "buildid": "20161130182744", 19:43:44 INFO - "pgo_build": "False", 19:43:44 INFO - "basedir": "/builds/slave/test", 19:43:44 INFO - "buildnumber": 28, 19:43:44 INFO - "slavename": "talos-linux64-ix-050", 19:43:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:43:44 INFO - "platform": "ubuntu64_hw", 19:43:44 INFO - "scheduler": "tests-graphics-linux64-talos", 19:43:44 INFO - "branch": "graphics", 19:43:44 INFO - "repo_path": "projects/graphics", 19:43:44 INFO - "revision": "21aaa1c5e08ac01088ef575b06557e4fc04bcb28", 19:43:44 INFO - "stage_platform": "linux64", 19:43:44 INFO - "builduid": "b0833dd377694f8cb6466424ea87e259", 19:43:44 INFO - "slavebuilddir": "test" 19:43:44 INFO - } 19:43:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:43:44 INFO - Running post-action listener: _resource_record_post_action 19:43:44 INFO - [mozharness: 2016-12-01 03:43:44.973275Z] Finished read-buildbot-config step (success) 19:43:44 INFO - [mozharness: 2016-12-01 03:43:44.973364Z] Running download-and-extract step. 19:43:44 INFO - Running pre-action listener: _resource_record_pre_action 19:43:44 INFO - Running main action method: download_and_extract 19:43:44 INFO - mkdir: /builds/slave/test/build/tests 19:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:44 INFO - trying https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:43:44 INFO - Downloading https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:43:45 INFO - Downloaded 1361 bytes. 19:43:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:43:45 INFO - Using the following test package requirements: 19:43:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:43:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:43:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:43:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'jsshell-linux-x86_64.zip'], 19:43:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:43:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:43:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:43:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:43:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:43:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:43:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:43:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:43:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:43:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:45 INFO - Fetch https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:43:46 INFO - Http code: 200 19:43:46 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 19:43:46 INFO - x-amz-cf-id: 86i858xqWSZV5HKKd5PH4qdw-EigJI0bXtdV1OehoSRxSfBbz0khTw== 19:43:46 INFO - x-amz-version-id: zX3t0cnYKFw8fNSACvLcaq_NVk4OrTNS 19:43:47 INFO - Expected file size: 20217576 19:43:47 INFO - Obtained file size: 20217576 19:43:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:43:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:43:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:51 INFO - Fetch https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:43:52 INFO - Http code: 200 19:43:52 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 19:43:52 INFO - x-amz-cf-id: 2Y_NHXI4eHo4Dmj20nLGBJZcXW_3Dg84_prU4ZJT8tuk_dDo8VG1vw== 19:43:52 INFO - x-amz-version-id: zX3t0cnYKFw8fNSACvLcaq_NVk4OrTNS 19:43:52 INFO - Expected file size: 20217576 19:43:52 INFO - Obtained file size: 20217576 19:43:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:43:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:43:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:43:57 INFO - Http code: 200 19:43:57 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 19:43:57 INFO - x-amz-cf-id: jkqPpBO_HMDR6i7AP81OH2PiugxtFCur5qqMLGsrnUC1f2W9g70obA== 19:43:57 INFO - x-amz-version-id: XKMhtNrh0EQFj7brq9amN0NaX2BnIb3v 19:43:58 INFO - Expected file size: 14409702 19:43:58 INFO - Obtained file size: 14409702 19:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:58 INFO - trying https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:43:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:44:02 INFO - Downloaded 55687221 bytes. 19:44:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:44:02 INFO - mkdir: /builds/slave/test/properties 19:44:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:44:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:44:02 INFO - Contents: 19:44:02 INFO - build_url:https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:44:03 INFO - Running post-action listener: _resource_record_post_action 19:44:03 INFO - Running post-action listener: set_extra_try_arguments 19:44:03 INFO - [mozharness: 2016-12-01 03:44:03.352508Z] Finished download-and-extract step (success) 19:44:03 INFO - [mozharness: 2016-12-01 03:44:03.352737Z] Running populate-webroot step. 19:44:03 INFO - Running pre-action listener: _resource_record_pre_action 19:44:03 INFO - Running main action method: populate_webroot 19:44:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:03 INFO - '--tppagecycles', 19:44:03 INFO - '7'], 19:44:03 INFO - 'tests': ['tsvgm']}}, 19:44:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:44:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:44:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:44:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['damp', 'tps']}, 19:44:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'tests': ['damp', 'tps']}, 19:44:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['dromaeo_dom']}, 19:44:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:44:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['basic_compositor_video']}, 19:44:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:44:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore', 19:44:03 INFO - 'tabpaint']}, 19:44:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore', 19:44:03 INFO - 'tabpaint']}, 19:44:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore', 19:44:03 INFO - 'tabpaint']}, 19:44:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore', 19:44:03 INFO - 'tabpaint']}, 19:44:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore', 19:44:03 INFO - 'tabpaint']}, 19:44:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore', 19:44:03 INFO - 'tabpaint']}, 19:44:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['tsvgx', 19:44:03 INFO - 'tsvgr_opacity', 19:44:03 INFO - 'tart', 19:44:03 INFO - 'tscrollx', 19:44:03 INFO - 'cart', 19:44:03 INFO - 'tsvg_static']}, 19:44:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:44:03 INFO - 'tsvgr_opacity', 19:44:03 INFO - 'tart', 19:44:03 INFO - 'tscrollx', 19:44:03 INFO - 'cart', 19:44:03 INFO - 'tsvg_static']}, 19:44:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'talos_options': ['--disable-e10s'], 19:44:03 INFO - 'tests': ['tp5o']}, 19:44:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:44:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'talos_options': ['--disable-e10s', 19:44:03 INFO - '--xperf_path', 19:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:03 INFO - 'tests': ['tp5n']}, 19:44:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:44:03 INFO - 'talos_options': ['--xperf_path', 19:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:03 INFO - 'tests': ['tp5n']}}, 19:44:03 INFO - 'talos.zip': {'path': '', 19:44:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:03 INFO - Running post-action listener: _resource_record_post_action 19:44:03 INFO - [mozharness: 2016-12-01 03:44:03.368693Z] Finished populate-webroot step (success) 19:44:03 INFO - [mozharness: 2016-12-01 03:44:03.368781Z] Running create-virtualenv step. 19:44:03 INFO - Running pre-action listener: _resource_record_pre_action 19:44:03 INFO - Running main action method: create_virtualenv 19:44:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:44:03 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 19:44:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:44:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:03 INFO - Using real prefix '/usr' 19:44:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:44:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:44:06 INFO - Installing pip.................done. 19:44:06 INFO - Return code: 0 19:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:44:06 INFO - Reading from file tmpfile_stdout 19:44:06 INFO - Output received: 19:44:06 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) 19:44:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:44:06 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')]} 19:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:06 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')]} 19:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:06 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:06 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 19:44:06 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 19:44:06 INFO - Using env: {'DISPLAY': ':0', 19:44:06 INFO - 'HOME': '/home/cltbld', 19:44:06 INFO - 'LANG': 'en_US.UTF-8', 19:44:06 INFO - 'LANGUAGE': 'en_US:en', 19:44:06 INFO - 'LOGNAME': 'cltbld', 19:44:06 INFO - 'MAIL': '/var/mail/cltbld', 19:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:06 INFO - 'MOZ_NO_REMOTE': '1', 19:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:06 INFO - 'NO_EM_RESTART': '1', 19:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:06 INFO - 'PWD': '/builds/slave/test', 19:44:06 INFO - 'SHELL': '/bin/bash', 19:44:06 INFO - 'SHLVL': '1', 19:44:06 INFO - 'TERM': 'linux', 19:44:06 INFO - 'TMOUT': '86400', 19:44:06 INFO - 'USER': 'cltbld', 19:44:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:06 INFO - '_': '/tools/buildbot/bin/python'} 19:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:06 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 19:44:06 INFO - Cleaning up... 19:44:06 INFO - Return code: 0 19:44:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:44:06 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')]} 19:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:06 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')]} 19:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:06 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:06 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 19:44:06 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 19:44:06 INFO - Using env: {'DISPLAY': ':0', 19:44:06 INFO - 'HOME': '/home/cltbld', 19:44:06 INFO - 'LANG': 'en_US.UTF-8', 19:44:06 INFO - 'LANGUAGE': 'en_US:en', 19:44:06 INFO - 'LOGNAME': 'cltbld', 19:44:06 INFO - 'MAIL': '/var/mail/cltbld', 19:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:06 INFO - 'MOZ_NO_REMOTE': '1', 19:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:06 INFO - 'NO_EM_RESTART': '1', 19:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:06 INFO - 'PWD': '/builds/slave/test', 19:44:06 INFO - 'SHELL': '/bin/bash', 19:44:06 INFO - 'SHLVL': '1', 19:44:06 INFO - 'TERM': 'linux', 19:44:06 INFO - 'TMOUT': '86400', 19:44:06 INFO - 'USER': 'cltbld', 19:44:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:06 INFO - '_': '/tools/buildbot/bin/python'} 19:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:07 INFO - Downloading/unpacking psutil>=3.1.1 19:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:44:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:09 INFO - Installing collected packages: psutil 19:44:09 INFO - Running setup.py install for psutil 19:44:09 INFO - building 'psutil._psutil_linux' extension 19:44:09 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 19:44:10 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 19:44:10 INFO - building 'psutil._psutil_posix' extension 19:44:10 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 19:44:10 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 19:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:10 INFO - Successfully installed psutil 19:44:10 INFO - Cleaning up... 19:44:10 INFO - Return code: 0 19:44:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:10 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:10 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 19:44:10 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 19:44:10 INFO - Using env: {'DISPLAY': ':0', 19:44:10 INFO - 'HOME': '/home/cltbld', 19:44:10 INFO - 'LANG': 'en_US.UTF-8', 19:44:10 INFO - 'LANGUAGE': 'en_US:en', 19:44:10 INFO - 'LOGNAME': 'cltbld', 19:44:10 INFO - 'MAIL': '/var/mail/cltbld', 19:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:10 INFO - 'MOZ_NO_REMOTE': '1', 19:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:10 INFO - 'NO_EM_RESTART': '1', 19:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:10 INFO - 'PWD': '/builds/slave/test', 19:44:10 INFO - 'SHELL': '/bin/bash', 19:44:10 INFO - 'SHLVL': '1', 19:44:10 INFO - 'TERM': 'linux', 19:44:10 INFO - 'TMOUT': '86400', 19:44:10 INFO - 'USER': 'cltbld', 19:44:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:10 INFO - '_': '/tools/buildbot/bin/python'} 19:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:44:13 INFO - Installing collected packages: mozsystemmonitor 19:44:13 INFO - Running setup.py install for mozsystemmonitor 19:44:13 INFO - Successfully installed mozsystemmonitor 19:44:13 INFO - Cleaning up... 19:44:13 INFO - Return code: 0 19:44:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:44: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')]} 19:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:44:13 INFO - Using env: {'DISPLAY': ':0', 19:44:13 INFO - 'HOME': '/home/cltbld', 19:44:13 INFO - 'LANG': 'en_US.UTF-8', 19:44:13 INFO - 'LANGUAGE': 'en_US:en', 19:44:13 INFO - 'LOGNAME': 'cltbld', 19:44:13 INFO - 'MAIL': '/var/mail/cltbld', 19:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:13 INFO - 'MOZ_NO_REMOTE': '1', 19:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:13 INFO - 'NO_EM_RESTART': '1', 19:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:13 INFO - 'PWD': '/builds/slave/test', 19:44:13 INFO - 'SHELL': '/bin/bash', 19:44:13 INFO - 'SHLVL': '1', 19:44:13 INFO - 'TERM': 'linux', 19:44:13 INFO - 'TMOUT': '86400', 19:44:13 INFO - 'USER': 'cltbld', 19:44:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:13 INFO - '_': '/tools/buildbot/bin/python'} 19:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:13 INFO - Downloading/unpacking jsonschema==2.5.1 19:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:44:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:44:15 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 19:44:15 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 19:44:15 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 19:44:15 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 19:44:15 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 19:44:15 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 19:44:15 INFO - Downloading functools32-3.2.3-2.tar.gz 19:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:44:15 INFO - warning: no files found matching '*.txt' 19:44:15 INFO - no previously-included directories found matching 'build' 19:44:15 INFO - no previously-included directories found matching 'dist' 19:44:15 INFO - no previously-included directories found matching '.git*' 19:44:15 INFO - Installing collected packages: jsonschema, functools32 19:44:15 INFO - Running setup.py install for functools32 19:44:15 INFO - warning: no files found matching '*.txt' 19:44:15 INFO - no previously-included directories found matching 'build' 19:44:15 INFO - no previously-included directories found matching 'dist' 19:44:15 INFO - no previously-included directories found matching '.git*' 19:44:15 INFO - Successfully installed jsonschema functools32 19:44:15 INFO - Cleaning up... 19:44:15 INFO - Return code: 0 19:44:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:44:15 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')]} 19:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:15 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')]} 19:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:15 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:15 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 19:44:15 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 19:44:15 INFO - Using env: {'DISPLAY': ':0', 19:44:15 INFO - 'HOME': '/home/cltbld', 19:44:15 INFO - 'LANG': 'en_US.UTF-8', 19:44:15 INFO - 'LANGUAGE': 'en_US:en', 19:44:15 INFO - 'LOGNAME': 'cltbld', 19:44:15 INFO - 'MAIL': '/var/mail/cltbld', 19:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:15 INFO - 'MOZ_NO_REMOTE': '1', 19:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:15 INFO - 'NO_EM_RESTART': '1', 19:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:15 INFO - 'PWD': '/builds/slave/test', 19:44:15 INFO - 'SHELL': '/bin/bash', 19:44:15 INFO - 'SHLVL': '1', 19:44:15 INFO - 'TERM': 'linux', 19:44:15 INFO - 'TMOUT': '86400', 19:44:15 INFO - 'USER': 'cltbld', 19:44:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:15 INFO - '_': '/tools/buildbot/bin/python'} 19:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:44:16 INFO - Cleaning up... 19:44:16 INFO - Return code: 0 19:44:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:44:16 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')]} 19:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:16 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')]} 19:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:16 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:16 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 19:44:16 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 19:44:16 INFO - Using env: {'DISPLAY': ':0', 19:44:16 INFO - 'HOME': '/home/cltbld', 19:44:16 INFO - 'LANG': 'en_US.UTF-8', 19:44:16 INFO - 'LANGUAGE': 'en_US:en', 19:44:16 INFO - 'LOGNAME': 'cltbld', 19:44:16 INFO - 'MAIL': '/var/mail/cltbld', 19:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:16 INFO - 'MOZ_NO_REMOTE': '1', 19:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:16 INFO - 'NO_EM_RESTART': '1', 19:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:16 INFO - 'PWD': '/builds/slave/test', 19:44:16 INFO - 'SHELL': '/bin/bash', 19:44:16 INFO - 'SHLVL': '1', 19:44:16 INFO - 'TERM': 'linux', 19:44:16 INFO - 'TMOUT': '86400', 19:44:16 INFO - 'USER': 'cltbld', 19:44:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:16 INFO - '_': '/tools/buildbot/bin/python'} 19:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:16 INFO - Downloading/unpacking blobuploader==1.2.4 19:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:18 INFO - Downloading blobuploader-1.2.4.tar.gz 19:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:44:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:44:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:19 INFO - Downloading docopt-0.6.1.tar.gz 19:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:44:19 INFO - Installing collected packages: blobuploader, requests, docopt 19:44:19 INFO - Running setup.py install for blobuploader 19:44:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:44:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:44:19 INFO - Running setup.py install for requests 19:44:19 INFO - Running setup.py install for docopt 19:44:19 INFO - Successfully installed blobuploader requests docopt 19:44:19 INFO - Cleaning up... 19:44:19 INFO - Return code: 0 19:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44: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')]} 19:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:19 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:19 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 19:44:19 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 19:44:19 INFO - Using env: {'DISPLAY': ':0', 19:44:19 INFO - 'HOME': '/home/cltbld', 19:44:19 INFO - 'LANG': 'en_US.UTF-8', 19:44:19 INFO - 'LANGUAGE': 'en_US:en', 19:44:19 INFO - 'LOGNAME': 'cltbld', 19:44:19 INFO - 'MAIL': '/var/mail/cltbld', 19:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:19 INFO - 'MOZ_NO_REMOTE': '1', 19:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:19 INFO - 'NO_EM_RESTART': '1', 19:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:19 INFO - 'PWD': '/builds/slave/test', 19:44:19 INFO - 'SHELL': '/bin/bash', 19:44:19 INFO - 'SHLVL': '1', 19:44:19 INFO - 'TERM': 'linux', 19:44:19 INFO - 'TMOUT': '86400', 19:44:19 INFO - 'USER': 'cltbld', 19:44:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:19 INFO - '_': '/tools/buildbot/bin/python'} 19:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:20 INFO - Running setup.py (path:/tmp/pip-bOrutA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:20 INFO - Running setup.py (path:/tmp/pip-co7uX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:20 INFO - Running setup.py (path:/tmp/pip-P1ymia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:20 INFO - Running setup.py (path:/tmp/pip-iDvxUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:20 INFO - Running setup.py (path:/tmp/pip-Bb8Ksx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:20 INFO - Running setup.py (path:/tmp/pip-NcG4yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:20 INFO - Running setup.py (path:/tmp/pip-5TSYYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:20 INFO - Running setup.py (path:/tmp/pip-MpYCu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:20 INFO - Running setup.py (path:/tmp/pip-w3IflU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:20 INFO - Running setup.py (path:/tmp/pip-XBkGDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:20 INFO - Running setup.py (path:/tmp/pip-31OubG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:20 INFO - Running setup.py (path:/tmp/pip-4Bj7eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:20 INFO - Running setup.py (path:/tmp/pip-UPUBvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:21 INFO - Running setup.py (path:/tmp/pip-T0C_0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:21 INFO - Running setup.py (path:/tmp/pip-a_DPIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:21 INFO - Running setup.py (path:/tmp/pip-4AtSh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:21 INFO - Running setup.py (path:/tmp/pip-YNmGLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:44:21 INFO - Running setup.py install for manifestparser 19:44:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:44:21 INFO - Running setup.py install for mozcrash 19:44:21 INFO - Running setup.py install for mozdebug 19:44:21 INFO - Running setup.py install for mozdevice 19:44:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:44:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:44:21 INFO - Running setup.py install for mozfile 19:44:21 INFO - Running setup.py install for mozhttpd 19:44:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:44:21 INFO - Running setup.py install for mozinfo 19:44:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Running setup.py install for mozInstall 19:44:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Running setup.py install for mozleak 19:44:22 INFO - Running setup.py install for mozlog 19:44:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Running setup.py install for moznetwork 19:44:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Running setup.py install for mozprocess 19:44:22 INFO - Running setup.py install for mozprofile 19:44:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Running setup.py install for mozrunner 19:44:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:44:22 INFO - Running setup.py install for mozscreenshot 19:44:22 INFO - Running setup.py install for moztest 19:44:22 INFO - Running setup.py install for mozversion 19:44:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:44:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:44:23 INFO - Cleaning up... 19:44:23 INFO - Return code: 0 19:44:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:23 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')]} 19:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:23 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')]} 19:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:23 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:23 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 19:44:23 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 19:44:23 INFO - Using env: {'DISPLAY': ':0', 19:44:23 INFO - 'HOME': '/home/cltbld', 19:44:23 INFO - 'LANG': 'en_US.UTF-8', 19:44:23 INFO - 'LANGUAGE': 'en_US:en', 19:44:23 INFO - 'LOGNAME': 'cltbld', 19:44:23 INFO - 'MAIL': '/var/mail/cltbld', 19:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:23 INFO - 'MOZ_NO_REMOTE': '1', 19:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:23 INFO - 'NO_EM_RESTART': '1', 19:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:23 INFO - 'PWD': '/builds/slave/test', 19:44:23 INFO - 'SHELL': '/bin/bash', 19:44:23 INFO - 'SHLVL': '1', 19:44:23 INFO - 'TERM': 'linux', 19:44:23 INFO - 'TMOUT': '86400', 19:44:23 INFO - 'USER': 'cltbld', 19:44:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:23 INFO - '_': '/tools/buildbot/bin/python'} 19:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:23 INFO - Running setup.py (path:/tmp/pip-NSuSNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:23 INFO - Running setup.py (path:/tmp/pip-KuC0WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:23 INFO - Running setup.py (path:/tmp/pip-SgtPNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:23 INFO - Running setup.py (path:/tmp/pip-NvW51y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:23 INFO - Running setup.py (path:/tmp/pip-WcaR2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:23 INFO - Running setup.py (path:/tmp/pip-OIqSM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:23 INFO - Running setup.py (path:/tmp/pip-mrg2tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:23 INFO - Running setup.py (path:/tmp/pip-UW5pBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:23 INFO - Running setup.py (path:/tmp/pip-X0dJ32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:23 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)) 19:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:24 INFO - Running setup.py (path:/tmp/pip-Bf9qWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:24 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:24 INFO - Running setup.py (path:/tmp/pip-FmEIRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:24 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:24 INFO - Running setup.py (path:/tmp/pip-arTDL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:24 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:24 INFO - Running setup.py (path:/tmp/pip-heVByc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:24 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:24 INFO - Running setup.py (path:/tmp/pip-mt6FlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:24 INFO - Running setup.py (path:/tmp/pip-vYc9cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:24 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:24 INFO - Running setup.py (path:/tmp/pip-MPCsjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:24 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)) 19:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:24 INFO - Running setup.py (path:/tmp/pip-TnQORK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:24 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)) 19:44:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:44:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:44:24 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)) 19:44:24 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:44:24 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:44:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:26 INFO - Downloading blessings-1.6.tar.gz 19:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:44:26 INFO - Installing collected packages: blessings 19:44:26 INFO - Running setup.py install for blessings 19:44:26 INFO - Successfully installed blessings 19:44:26 INFO - Cleaning up... 19:44:26 INFO - Return code: 0 19:44:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:44:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:44:27 INFO - Reading from file tmpfile_stdout 19:44:27 INFO - Current package versions: 19:44:27 INFO - argparse == 1.2.1 19:44:27 INFO - blessings == 1.6 19:44:27 INFO - blobuploader == 1.2.4 19:44:27 INFO - docopt == 0.6.1 19:44:27 INFO - functools32 == 3.2.3-2 19:44:27 INFO - jsonschema == 2.5.1 19:44:27 INFO - manifestparser == 1.1 19:44:27 INFO - mozInstall == 1.12 19:44:27 INFO - mozcrash == 1.0 19:44:27 INFO - mozdebug == 0.1 19:44:27 INFO - mozdevice == 0.49 19:44:27 INFO - mozfile == 1.2 19:44:27 INFO - mozhttpd == 0.7 19:44:27 INFO - mozinfo == 0.9 19:44:27 INFO - mozleak == 0.1 19:44:27 INFO - mozlog == 3.4 19:44:27 INFO - moznetwork == 0.27 19:44:27 INFO - mozprocess == 0.23 19:44:27 INFO - mozprofile == 0.28 19:44:27 INFO - mozrunner == 6.13 19:44:27 INFO - mozscreenshot == 0.1 19:44:27 INFO - mozsystemmonitor == 0.3 19:44:27 INFO - moztest == 0.7 19:44:27 INFO - mozversion == 1.4 19:44:27 INFO - psutil == 3.1.1 19:44:27 INFO - requests == 1.2.3 19:44:27 INFO - wsgiref == 0.1.2 19:44:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44: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')]} 19:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:27 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 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:27 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 19:44:27 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 19:44:27 INFO - Using env: {'DISPLAY': ':0', 19:44:27 INFO - 'HOME': '/home/cltbld', 19:44:27 INFO - 'LANG': 'en_US.UTF-8', 19:44:27 INFO - 'LANGUAGE': 'en_US:en', 19:44:27 INFO - 'LOGNAME': 'cltbld', 19:44:27 INFO - 'MAIL': '/var/mail/cltbld', 19:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:27 INFO - 'MOZ_NO_REMOTE': '1', 19:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:27 INFO - 'NO_EM_RESTART': '1', 19:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:27 INFO - 'PWD': '/builds/slave/test', 19:44:27 INFO - 'SHELL': '/bin/bash', 19:44:27 INFO - 'SHLVL': '1', 19:44:27 INFO - 'TERM': 'linux', 19:44:27 INFO - 'TMOUT': '86400', 19:44:27 INFO - 'USER': 'cltbld', 19:44:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:27 INFO - '_': '/tools/buildbot/bin/python'} 19:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 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)) 19:44:27 INFO - Cleaning up... 19:44:27 INFO - Return code: 0 19:44:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:44: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')]} 19:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96a582ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be5130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, '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': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', '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 19:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:44:27 INFO - Using env: {'DISPLAY': ':0', 19:44:27 INFO - 'HOME': '/home/cltbld', 19:44:27 INFO - 'LANG': 'en_US.UTF-8', 19:44:27 INFO - 'LANGUAGE': 'en_US:en', 19:44:27 INFO - 'LOGNAME': 'cltbld', 19:44:27 INFO - 'MAIL': '/var/mail/cltbld', 19:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:27 INFO - 'MOZ_NO_REMOTE': '1', 19:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:27 INFO - 'NO_EM_RESTART': '1', 19:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:27 INFO - 'PWD': '/builds/slave/test', 19:44:27 INFO - 'SHELL': '/bin/bash', 19:44:27 INFO - 'SHLVL': '1', 19:44:27 INFO - 'TERM': 'linux', 19:44:27 INFO - 'TMOUT': '86400', 19:44:27 INFO - 'USER': 'cltbld', 19:44:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:27 INFO - '_': '/tools/buildbot/bin/python'} 19:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:44:27 INFO - Cleaning up... 19:44:27 INFO - Return code: 0 19:44:27 INFO - Running post-action listener: _resource_record_post_action 19:44:27 INFO - Running post-action listener: _start_resource_monitoring 19:44:27 INFO - Starting resource monitoring. 19:44:27 INFO - [mozharness: 2016-12-01 03:44:27.543497Z] Finished create-virtualenv step (success) 19:44:27 INFO - [mozharness: 2016-12-01 03:44:27.544441Z] Running install step. 19:44:27 INFO - Running pre-action listener: _resource_record_pre_action 19:44:27 INFO - Running main action method: install 19:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:44:27 INFO - Reading from file tmpfile_stdout 19:44:27 INFO - Detecting whether we're running mozinstall >=1.0... 19:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:44:27 INFO - Reading from file tmpfile_stdout 19:44:27 INFO - Output received: 19:44:27 INFO - Usage: mozinstall [options] installer 19:44:27 INFO - Options: 19:44:27 INFO - -h, --help show this help message and exit 19:44:27 INFO - -d DEST, --destination=DEST 19:44:27 INFO - Directory to install application into. [default: 19:44:27 INFO - "/builds/slave/test"] 19:44:27 INFO - --app=APP Application being installed. [default: firefox] 19:44:27 INFO - mkdir: /builds/slave/test/build/application 19:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:44:43 INFO - Reading from file tmpfile_stdout 19:44:43 INFO - Output received: 19:44:43 INFO - /builds/slave/test/build/application/firefox/firefox 19:44:43 INFO - Running post-action listener: _resource_record_post_action 19:44:43 INFO - [mozharness: 2016-12-01 03:44:43.886026Z] Finished install step (success) 19:44:43 INFO - [mozharness: 2016-12-01 03:44:43.886269Z] Running run-tests step. 19:44:43 INFO - Running pre-action listener: _resource_record_pre_action 19:44:43 INFO - Running main action method: run_tests 19:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:44:43 INFO - Python 2.7.3 19:44:43 INFO - Return code: 0 19:44:43 INFO - grabbing minidump binary from tooltool 19:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:43 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 0x2c73fc0>, '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 0x2c74ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c75350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:44:43 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 19:44:43 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 19:44:43 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 19:44:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:44:44 INFO - Return code: 0 19:44:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:44:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:44:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:44:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:44:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 19:44:44 INFO - Using env: {'DISPLAY': ':0', 19:44:44 INFO - 'HOME': '/home/cltbld', 19:44:44 INFO - 'LANG': 'en_US.UTF-8', 19:44:44 INFO - 'LANGUAGE': 'en_US:en', 19:44:44 INFO - 'LOGNAME': 'cltbld', 19:44:44 INFO - 'MAIL': '/var/mail/cltbld', 19:44:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:44:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:44 INFO - 'MOZ_NO_REMOTE': '1', 19:44:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:44 INFO - 'NO_EM_RESTART': '1', 19:44:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:44 INFO - 'PWD': '/builds/slave/test', 19:44:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:44:44 INFO - 'SHELL': '/bin/bash', 19:44:44 INFO - 'SHLVL': '1', 19:44:44 INFO - 'TERM': 'linux', 19:44:44 INFO - 'TMOUT': '86400', 19:44:44 INFO - 'USER': 'cltbld', 19:44:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890', 19:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:44 INFO - '_': '/tools/buildbot/bin/python'} 19:44:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:44:44 INFO - mozversion application_buildid: 20161130182744 19:44:44 INFO - mozversion application_changeset: 21aaa1c5e08ac01088ef575b06557e4fc04bcb28 19:44:44 INFO - mozversion application_display_name: Nightly 19:44:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:44:44 INFO - mozversion application_name: Firefox 19:44:44 INFO - mozversion application_remotingname: firefox 19:44:44 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:44:44 INFO - mozversion application_vendor: Mozilla 19:44:44 INFO - mozversion application_version: 53.0a1 19:44:44 INFO - mozversion platform_buildid: 20161130182744 19:44:44 INFO - mozversion platform_changeset: 21aaa1c5e08ac01088ef575b06557e4fc04bcb28 19:44:44 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:44:44 INFO - mozversion platform_version: 53.0a1 19:44:44 INFO - using testdate: 1480563884 19:44:44 INFO - actual date: 1480563884 19:44:44 INFO - starting webserver on 'localhost:40330' 19:44:44 INFO - SUITE-START | Running 2 tests 19:44:44 INFO - TEST-START | dromaeo_css 19:44:44 INFO - operating with platform_type : linux_ 19:44:44 INFO - Initialising browser for dromaeo_css test... 19:44:44 INFO - TEST-INFO | started process 3353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp05SxoA/profile http://localhost:40330/getInfo.html) 19:44:49 INFO - PROCESS | 3353 | __metrics Screen width/height:1600/1200 19:44:49 INFO - PROCESS | 3353 | colorDepth:24 19:44:49 INFO - PROCESS | 3353 | Browser inner width/height: 1024/697 19:44:49 INFO - PROCESS | 3353 | __metrics 19:44:51 INFO - PROCESS | 3353 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:44:51 INFO - PROCESS | 3353 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:44:51 INFO - PROCESS | 3353 | console.error: PushService: 19:44:51 INFO - PROCESS | 3353 | stateChangeProcessEnqueue: Error transitioning state 19:44:51 INFO - PROCESS | 3353 | UnknownError 19:44:52 INFO - TEST-INFO | 3353: exit 0 19:44:52 INFO - Browser initialized. 19:44:52 INFO - Running cycle 1/1 for dromaeo_css test... 19:44:52 INFO - TEST-INFO | started process 3437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp05SxoA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:04 INFO - PROCESS | 3437 | RSS: Main: 175673344 19:45:04 INFO - PROCESS | 3437 | 19:45:55 INFO - PROCESS | 3437 | 1480563955646 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] 19:48:09 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:40330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40330/tests/dromaeo/cssquery-ext.html) 19:48:11 INFO - PROCESS | 3437 | RSS: Main: 388628480 19:48:11 INFO - PROCESS | 3437 | 19:51:14 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:40330/tests/dromaeo/cssquery-ext.html (next: http://localhost:40330/tests/dromaeo/cssquery-jquery.html) 19:51:15 INFO - PROCESS | 3437 | RSS: Main: 282443776 19:51:15 INFO - PROCESS | 3437 | 19:54:17 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:40330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40330/tests/dromaeo/cssquery-mootools.html) 19:54:18 INFO - PROCESS | 3437 | RSS: Main: 220807168 19:54:18 INFO - PROCESS | 3437 | 19:57:20 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:40330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40330/tests/dromaeo/cssquery-prototype.html) 19:57:21 INFO - PROCESS | 3437 | RSS: Main: 254746624 19:57:21 INFO - PROCESS | 3437 | 20:00:24 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:40330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40330/tests/dromaeo/cssquery-yui.html) 20:00:24 INFO - PROCESS | 3437 | RSS: Main: 223490048 20:00:24 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | Cycle 1(1): loaded http://localhost:40330/tests/dromaeo/cssquery-yui.html (next: http://localhost:40330/tests/dromaeo/cssquery-dojo.html) 20:03:28 INFO - PROCESS | 3437 | RSS: Main: 311443456 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | __start_tp_report 20:03:28 INFO - PROCESS | 3437 | _x_x_mozilla_page_load 20:03:28 INFO - PROCESS | 3437 | _x_x_mozilla_page_load_details 20:03:28 INFO - PROCESS | 3437 | |i|pagename|runs| 20:03:28 INFO - PROCESS | 3437 | |0;dojo.html;2566.0377358490564;2587.0298638010745;2595.8961641534333;2612.8562929038894;2623.3835048763535;4617.1458280218185;4667.393238878941;4667.69659972102;4705.3177289293035;4705.882352941178;4687.250039993593;4695.319178719093;4715.363425937498;4728.952710472894;4795.208790549564;4333.804978775946;4343.022819865537;4384.539623339551;4428.202923473774;4510.075434535912;4044.939325910114;4448.065906159694;4449.7330160190495;4485.641148708112;4531.071130418273;4265.189613973335;4374.715643483163;4378;4413.955860441387;4483.50681425043;4205.390218418343;4213.199492096492;4231.069164783743;4288.421063156465;4358;4210.242156411845;4212.957870421287;4219.683523735732;4248.723832950848;4282.8715138545895;4600.6319494440695;4604.746738929358;4630.8147674093;4638.397008388888;4661.347411362412;4935.481774413706;4957.479464656195;4986.551210391046;4991.251312303148;5065.670731402447;5057.924131138036;5074.416442109168;5088.389393272794;5088.567471764904;5091.643584949055;4695.5539223773685;4739.810407583727;4743.881402964954;4744.644151688637;4749.596284315872;5159.355080614923;5165.328507294028;5176.81881134166;5197.870053248699;5207.244949482304;4915.582175515121;4957.504249575014;4958.628102892298;4962.305277261186;5020.899582008339;4947.25791131326;4989.276554899519;4991.301217829507;5009.674371165863;5040.697558146523;4903.04390643821;4928.581070609039;4938.4320803107385;4985.077760614298;5037.168867136881;4939.753012349368;4948.134076536592;4959.62802789785;4965.652404331734;5014.674046186986;4170.791460426966;4225.218334608107;4226.218149642326;4235.703500754979;4280.871573852789;3665.9266814663556;3676.6507181817683;3691.8338674759702;3712.7586706863967;3718.7768733875514;4374.365716971021;4376.49670287921;4383.736975781463;4408.625266852289;4412.6690498212765;5111.258867464197;5124.718140502234;5125.359330083739;5125.79496820123;5167;4259.637930775857;4290.227759003409;4302.118065796504;4327.437433133672;4371.715838470489;4540.318952157203;4555.612772914273;4576.954230457653;4577.038821847449;4595.793189306489;4716.056788642285;4755.667103302736;4760;4760.809567617256;4801.5438533339275;4951.059298733229;4986.0277245936695;4987.501249874984;5081.364829396325;5088.185890257541;4753.83361582343;4784.234522476387;4818.927716084191;4879.512048795092;4889.413270407432;5051.318072060371;5051.87370315745;5055.823046193365;5057.089723849595;5106.131957567297;5080.491950805038;5143.61422893277;5144.511271429208;5145.228215767665;5184.533391994739;4794.304825800309;4817.301491283814;4821.9035619288115;4869.123557759637;5000.499950004971;4881.438634557071;4886.340344053508;4887.266909963534;4887.731174785421;4888.902221955612;4784.6889952153;4789.44921334051;4796.688215265996;4817.156997525489;4820.566149046603;4840.927386089141;4879;4880.99939512392;4890.046440943982;4895.7062576245535;4773.498782627774;4776.737279449663;4777.856664300077;4794.616430685467;4876.049170411736 20:03:28 INFO - PROCESS | 3437 | |1;ext.html;568.2782865760485;581.6074149948784;591.243208692873;592.7895597063045;603.1706403694919;27899.16302510923;39029.80485097574;40306.59693403069;40376;43649;39896.60103398965;40258.39612405816;40323.395149072785;40337.59662403375;40396.798016009954;7254.4196464282995;7314.0857392825765;7534.321911028006;7534.585597792119;7545.245475452438;7175.246599107097;9542.427454352726;9804.166645835112;9821.950890245538;10164.491775411238;9865.605375784995;9936.751581210492;9937.701868943943;9937.75155621108;9958.153556947633;9742.561584728704;9789.999999999964;9792.853107203398;9798.069183427562;9804.803903921953;9744.415335079848;9796.755081122958;9803.950980245054;9807.852882206773;9808.558614862348;36602;36826.26347473035;36894.631053689656;36896.63103368985;36923.4461483078;3153.9842300788578;3202.9199270018203;3292.670732926712;3431.365197438482;3657.6342365763476;27286.54269146159;27400.862995685093;27840.72159278422;27967.160985170478;28091.15726528187;3316.2041110133396;3323.252268239651;3372.392969265531;3373.089265898194;3481.3385456763135;248245;248643;249371;249473.58948978534;249500.55493895657;52975.73512132415;53230.46769532333;53292;53532;53578.464215357344;56020.43979560234;56115.71942140263;56116;56152.43847561554;56227.71886140625;13719.314034298246;13893.86106138946;14139.434422623186;14143.50497732595;14152.433902643985;8990.730278091667;9317.90682093184;9798.31411801167;9941.701748947544;10635.734106647396;17134.485965421056;17629.206685699173;17996.910015449837;18044.368447104287;18232.63534729298;6554.836129096715;6812.114425124702;6836.248012718597;6969.303069693092;7092.538984966064;810.4529442626203;883.3551507399634;950.2777888804559;990.0643891522586;1000.6647772996128;26893.731062689123;27132;27346.453070938867;27542.449151016866;27595.172144835688;963.5615794813343;966.7293157915794;971.9465429401309;989.4459102902398;1011.1455819832377;14152.787708184385;14682.779758303634;14752.631184220265;14909.329080191417;14931.776023359658;370190;373525;374123;374292;374508;48895;49204.753976230604;49257.75371123121;49599.256011159865;49601.25598116031;940.501534186882;1046.100353695821;1101.2951710904867;1102.9889701103048;1134.0474001838495;25720.228393148234;28114.578281325386;28145.57781633318;30824.537631935986;31345.216369590944;47453.76273118612;48248.75875620599;48295.75852120717;48301.75849120732;48319.5168048315;265635;266805;267028;267760;268288;23802.40493987595;26332.341691457867;26372.208833735018;36862.8156859214;37443.25113497769;40386.79806600948;40829;40996.38505422361;41241.381379279934;41987.16025679408;34570.65429345674;34710.13224669403;34987.30025399427;35113.648863511036;35190;34187.4871876927;34216.31567368589;34226;34440.82779586086;34538.13654658654;33540.32919341648;34006.82996585001;34093.14767130841;34292;34409;29423.486977142027;31373;32070.83964580162;32088;32192;23839.523209535364;24180.51638967246;24267.665418227218;24392.390190245387;24484.387890302885 20:03:28 INFO - PROCESS | 3437 | |2;jquery.html;331.08290036598606;352.28310388359694;357.68166331964545;366.4484950150024;382.87244066224963;12536.56122035729;13629.25039122848;15785.921070394646;15977.121258330788;16717.749233761504;16513.752293715603;16532.173391330416;16782.83217167828;16828.66342673146;16921.407750728697;4630.37489938859;4684;4817.975910120454;5045.21799121135;5046.924296135561;4834.395700537433;4957.776900039489;4962.851114466572;4965.7020578765205;4966.304717339575;4759.738669252651;4930.852074437755;4934.40787105546;4939.753012349386;4944.950550494485;4777.880552986168;4859.975700121512;4868.415790105175;4868.902621947576;4872.3909511311085;4295.463067116611;4295.634871035965;4298.505671847746;4298.505671847746;4299.849505267332;18456.261749530004;19455.610887782306;19931.402057938285;19992.10035548404;20169.697454538193;1837.0447367369027;1837.200817644329;1887.2168050259127;1890.357298302526;2415.251272105653;12115.454804533729;12591.37043147839;13129.73740525184;13187.340632968313;13347.132436391603;1652.842979916906;1706.436875830973;1712.9828701712947;1734.1329335332334;1807.7921039080543;47069.29396059062;63676.68161659162;64182;64581.99999999953;67834.32165678378;8766.736997890073;8823.735287941372;8926.821463570692;9037.909620903707;9127.315451341043;10568.365898045988;10659.253852230424;11110.111191104692;11801.52793888252;11877.346745929057;6518.674066296761;6853.4174595158975;6854.897176542356;6856.211535673362;6863.416609588241;6508.3491650835485;6570.244421891448;6618.801435956929;7096.822579435556;7176.102987126609;5100.183970564692;5453.945460545344;5659.773609055592;5711.771529138788;5725.599208055396;1457.2711551017017;1550.6588550518868;1560.4382422327953;1582.374961890047;1617.134832864412;857.9099194584603;865.4028720183054;867.9739607811649;923.7644400677918;962.2734835199379;15351.539453816404;16194.919025404797;16367.2634731435;16642;17439.912800435915;890.7283278599959;899.9865002024975;933.9439633622004;939.5443210043123;945.1021529546821;9255.259579233645;9847.064528869745;9893.109620134222;9912;9938.652147174815;255944;258040;259539;372852;374855;56564;66836;80350.59824700956;81963.18036819555;83997.58001209956;905.3752910491739;937.5827756648226;939.1500691873865;942.9245660347156;943.8018016216671;15202.239888005777;15250.618734531725;15500.612484687974;15931.283092261108;16249.106299153187;31744;35422.29155416826;36760.63239367572;36765.81617091897;37726.43410348902;51573.226401604756;51860;52351.476485236184;52448.21327680164;52945.94108117739;7291.817704557428;7355.374793142642;7410.777676669709;7411.814704632212;7627.122880868771;8770.649174032967;8850.95574522149;9838.75403114928;11523.423828808358;11824.822627660764;10025.498725063864;10457.790844182922;10593.417362045162;10772.676819695422;10830.079443247412;9917.008299170026;10213.387196768217;10348.793024139626;10388.584456621953;10586.523606437575;10165.237607179342;10333.638322658671;10442.738931526772;10534.315269507764;10793.784124317626;7119.857602848017;7224.313690199423;7392.593407362647;7477.476576639583;7663.540187588763;10008.549615267184;10171.796564068825;10184.694459166238;10228.181745460197;10354.948225258826 20:03:28 INFO - PROCESS | 3437 | |3;mootools.html;1331.9334033298335;1368.4047439363876;1413.985860141399;1617.1752406272797;1643.1291415549763;6626.469882409402;7049.506534542584;7052.153741551021;7053.365197132257;7053.4709896757695;6137.232845894263;6320.051992201172;6427.325130861251;6636.270010298876;6935;1989.9999999999964;2024.6052019856133;2024.8278896293832;2026.3718247343297;2026.3819535041807;1967.872088314255;1972.753405824272;1976.6837306031039;2029.9951523995642;2033.6746120620703;1791.4536066499713;1855.1744473709205;1959.559099202675;1978.5844972555708;2008.8593798434115;1970.0248377053308;1970.9310174143836;1974.3583335415976;1982.2467462364282;1985.2158397432934;2012.5471768852037;2015.1133501259399;2053.7946205379344;2058.207590077816;2062.3503596367245;6991.510594258404;7067.8586428271665;7166.964165179193;7182.138143422771;7182.209956904736;3913.9021524462114;4043.9191216175805;4055.026793569522;4056.4523789288364;4058.2492238935893;2626.3171575390347;2795.9580606290924;2842.786790990684;2917.620709307798;2935.3688956874375;841.474078700812;881.801594641207;897.622998340692;939.497368907638;942.3121121581285;9454.196393306578;9496.762580935394;9507.857382139273;9517.952410237975;9525.80927384077;3667.156553992597;3750.287445385368;3863.864764733221;3865.130345672201;3887.4644515416253;8134.145914678992;8134.75595732129;8142.267195952392;8152.592370381457;8153.429259951747;4176.707630465899;4184.748915065105;4186.706930514895;4188.015816283171;4188.602082802129;3746.1383881706815;3807.8857634271017;3832.425136229532;3834.616538346199;3834.865779697753;3261.1684020574603;3286.6877646623534;3313.8840140595444;3347.2803347279964;3371.696547310754;1091.6615849086809;1095.7479779650726;1098.1715443786006;1103.2828661370013;1103.7902798468265;767.7850201943464;789.2462698123278;792.3146478296233;805.2390490986079;823.3495538524618;4690.273007683814;4706.458757242961;4713.622910167179;4826.927596086061;4949.034938187091;388.95721470638205;393.2744087159187;393.7657094029048;398.2771270144678;399.97200195986585;3282.7373810095137;3349.05801509969;3355.8322083896196;3375.0549846043145;3423.2639982403903;7912.32745216663;8437.535935523483;8456.323494120456;8487.193716596914;8543.188397102265;8474.152584741476;8489.95755021221;8491.490510569385;8491.61787719554;8492;6426.614403135827;6503.967480162569;6532.902006469907;6600;6601.834954126185;4808.422989241313;4818.229083346648;4863.756812159449;4899.387576552931;4918.8770280743265;7374.373178279691;7495.287947644965;7526.623668816428;7639.197884222077;7782;7483.064616922885;7810.218978102144;8089.959550202211;8164.346852251924;8176.918230817616;6668.299828517936;6728.226253980855;6744.460443164437;6767.763128290486;6825.1127353443735;6702.19573651165;6762.323767623198;6762.830929226809;6765.560238584476;6766.323367663194;5961.403859614177;6028.216331876828;6040.577159598962;6118.785842495669;6119.4798442132915;5862.384449632727;5916.615419997686;5961.433663801932;5978.282606087298;6089.54328425361;5627.409122042127;5728.312602487728;5730.484256416942;5738.426157384228;5741.368449470639;4220.577942205755;4245.172191422766;4273.380359847867;4332.220200363965;4421.336799480104;4212.768297743653;4264.275073237619;4368.366586844953;4378.452693413324;4408.515063343094 20:03:28 INFO - PROCESS | 3437 | |4;prototype.html;257.6354458441306;260.51414112679856;270.3147521034179;278.9135368035909;278.92050765531826;4621.6071633911115;4647.34937108805;4780.832670856521;4824.396950381202;4827.686200396972;4687.765611719409;4778.498257682945;4784.330193772875;4791.233402655575;4794.544518270767;3708.7218458615644;3713.554373475187;3731.9253614927684;3752.4558938953837;3759.4360845873202;3551.236484155906;3674.2651469706034;3694.353488139578;3707.1464267866068;3714.275716235335;3611.1694310308512;3690.298843219793;3692.4645926340663;3714.0900479382453;3718.609545997672;3712.5916149223563;3715.739898207113;3721.4045752679576;3731.3097077040834;3745.606711295329;3270.2641905571295;3279.442494775894;3279.918002049944;3285.950710739341;3288.917777055569;4453.22068637987;4619.699719518254;4680.391549098629;4698.765061746899;4699.365585645928;4139.399787030864;4141.213169497786;4145.233131870614;4160.1471698301775;4163.167366526707;5002.349694539723;5019.247112933052;5024.748762561857;5025.221090730943;5044.419891712463;3326.070878890262;3463.497792820027;3464.7747896386654;3474.6525347465304;3476.1657202271526;5215.713135777531;5252.737363131828;5256.764660304825;5270.973645131749;5288.1538953767595;3547.2373439710586;3549.378858699769;3549.769264997767;3551.7158627309755;3561.216532362876;3599.6400359963795;3600.207954250061;3603.819809009539;3606;3623.9456408153897;3985.980070099689;4065.739620717587;4107.732997355162;4184.225918205142;4192.916141677149;4957.983613359253;4959.181735013683;4966.925496117561;4971.055499455092;4990.126727822689;1204.8674246208536;1215.2344023265287;1216.647172320035;1217.7503611759569;1218.8171774233936;777.8872063550754;822.0258993093204;830.8296799156159;832.862577674689;835.6448509383488;4307.526172121127;4312.417823593837;4312.978435107867;4317.179735850178;4340.742813736839;4972.254161875748;4988;4990.880699562773;5005.224190250517;5021.196608542616;4304.548022457597;4314.503832059353;4318.222719910384;4321;4332.631726303236;2518;2647.9735202647726;2658.787297016234;2668.4656322614574;2677.2771351734923;4644.722701257114;4667.343093201865;4682.391289132391;4696.694714843524;4704.812716682156;5080.983803239293;5105.387353517527;5118.462561430996;5118.722168634922;5146.665466744649;4628.3983082199775;4876.756162191948;4884.7055530285215;4885.316055752198;4894.926576101361;5151.5106064923775;5204.401493828258;5213.504717052026;5219.243209734643;5267;4832.540908613676;5114.539691427641;5148.665336753099;5156.484351564964;5168.043911876315;4567.830280616813;4856.988667026466;4891.26631005352;4892.584130348961;4914.5822605078965;3628.6552777486095;3636.5635024534154;3636.6908812751212;3637.3270944875285;3672.614375490535;5124.64196987806;5195.9740201298755;5235.738213089254;5246.475352464723;5264.578833693372;5017.4731653175895;5032.6980381177245;5034.144195486703;5073.34046573943;5073.619478539051;5032.874178145429;5052.520010598987;5052.69683818972;5056.696598204119;5110.821121260887;4761.381020467317;5000.399952005782;5038.269450929668;5047;5049;5020.949790502048;5026.698398096126;5034.320366750442;5049.57078648319;5069.645124841373;4906.975465122794;4926.852194434173;4930.654854160318;4998.375203099613;5002.624803139852 20:03:28 INFO - PROCESS | 3437 | |5;yui.html;635.7520566978877;638.3381299979087;668.9130413046303;681.1349586025748;739.2792027772922;13496.797548036775;13739.862601373983;13904.235267060307;13997.230152341617;14097.154170749762;15487.380504779823;15497.225138743046;15634.921825390886;15670.608234794106;15673.45142919998;619.6560908695673;746.858096961577;766.4328396986218;768.8577613141558;768.9923100769005;627.7928283666402;748.188215785873;765.5330248548408;771.961401929904;774.094309657699;809.8542262392767;810.9270165685087;812.0823469479479;812.6749300279906;812.8821320908464;642.5502148496072;660.4947215380238;807.1847434091551;807.5962018990505;807.640599933033;568.6332315656379;581.36050344621;587.0138167877964;587.5094296262625;588.5703436491342;13403;13411.731765364639;13416.396262168128;13448.596542103753;13451;12721.745565088646;12807.679808004781;12838.679033024157;12849.550265740747;12991.740165196643;12024.639260822189;12072.27414330218;12164.391780411033;12297.815532767016;12399.814002789966;4099.733517321364;4132.462779838632;4138.193052354792;4195.937060944088;4235.3646952957;54266.45733542654;55150.44849551493;57547.42452575504;64502.677486613204;64564;10370.637027703995;10688.14494840411;10780.78438431227;11006.779864402828;11086.334819910831;19071.90464047671;19097.427077187705;19097.427077187705;19099.713504297448;19100.61798764017;6803.285655006153;6929.133858267716;7051.435885129177;7091.574505529685;7242.96378518104;3712.5173727415804;3775.339315619756;3798.2213646202463;3801.3727734923427;3804.201117765245;2785.9442811143663;2853;2864.0834932821713;2884.5384738442167;2893.4068515954177;486.0400708600556;488.7336401661103;495.95040495950116;499.3383766509317;500.6545483616366;569.2400645138704;582.9681463809035;588.7762650192899;621.7357623010203;635.7171058878755;8475.194856488624;8573.485590864568;8634.136586341316;8648.308135349156;8650.653973841101;586.5219845825638;590.1973316289842;590.8877313310543;593.5459373579215;611.339753066687;3783.281176576442;3862.9570016095495;3966.8809935701975;4054.7567145971334;4055.8986025349013;54940.45059549433;71982;72053.2794672057;72210.63894680493;73882;42920.78539607282;46097.7695111529;47369.28946065812;47452.525474745504;55941.440585594435;45140.77429612897;51805.48194518082;51901;52187;52561.474385257185;8336.958315208385;8740.912590874264;8993.370464067453;9111.9976802553;9214.815703686023;31973;35517.82241088778;36033.11735061241;36389.81805091064;36869;47403;47751.76124119357;49464.50535494599;49878.50121498739;51789;10455.686329409826;10713.517891694737;10804.621838235624;10957.56169753201;11346.886531134583;12542.811857822322;12582.370881455707;12761.872381276069;12867.292298923649;13340.86659133435;11525.366104864313;11806.232594881305;12245;12335.876641233473;12747.377205531742;11810.232334898204;12315.630531084082;12349.629511114681;12646.87353126457;12728.6817829555;11524.539018439169;11573.7106572333;11670.066394688234;11796.174267801172;12054.44263013244;9178.311626628163;9266.166045055978;9804.950975245078;9833.70498885006;10333.638322658671;8547.700830470903;9945.154661853534;10023.949880250551;10105.343152695052;10113.747156321151 20:03:28 INFO - PROCESS | 3437 | __end_tp_report 20:03:28 INFO - PROCESS | 3437 | __start_cc_report 20:03:28 INFO - PROCESS | 3437 | _x_x_mozilla_cycle_collect,2489 20:03:28 INFO - PROCESS | 3437 | __end_cc_report 20:03:28 INFO - PROCESS | 3437 | __startTimestamp1480565008249__endTimestamp 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | ------- Summary: start ------- 20:03:28 INFO - PROCESS | 3437 | Number of tests: 6 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | [#0] dojo.html Cycles:165 Average:4651.86 Median:4784.23 stddev:497.67 (10.4%) stddev-sans-first:471.53 20:03:28 INFO - PROCESS | 3437 | Values: 2566.0 2587.0 2595.9 2612.9 2623.4 4617.1 4667.4 4667.7 4705.3 4705.9 4687.3 4695.3 4715.4 4729.0 4795.2 4333.8 4343.0 4384.5 4428.2 4510.1 4044.9 4448.1 4449.7 4485.6 4531.1 4265.2 4374.7 4378.0 4414.0 4483.5 4205.4 4213.2 4231.1 4288.4 4358.0 4210.2 4213.0 4219.7 4248.7 4282.9 4600.6 4604.7 4630.8 4638.4 4661.3 4935.5 4957.5 4986.6 4991.3 5065.7 5057.9 5074.4 5088.4 5088.6 5091.6 4695.6 4739.8 4743.9 4744.6 4749.6 5159.4 5165.3 5176.8 5197.9 5207.2 4915.6 4957.5 4958.6 4962.3 5020.9 4947.3 4989.3 4991.3 5009.7 5040.7 4903.0 4928.6 4938.4 4985.1 5037.2 4939.8 4948.1 4959.6 4965.7 5014.7 4170.8 4225.2 4226.2 4235.7 4280.9 3665.9 3676.7 3691.8 3712.8 3718.8 4374.4 4376.5 4383.7 4408.6 4412.7 5111.3 5124.7 5125.4 5125.8 5167.0 4259.6 4290.2 4302.1 4327.4 4371.7 4540.3 4555.6 4577.0 4577.0 4595.8 4716.1 4755.7 4760.0 4760.8 4801.5 4951.1 4986.0 4987.5 5081.4 5088.2 4753.8 4784.2 4818.9 4879.5 4889.4 5051.3 5051.9 5055.8 5057.1 5106.1 5080.5 5143.6 5144.5 5145.2 5184.5 4794.3 4817.3 4821.9 4869.1 5000.5 4881.4 4886.3 4887.3 4887.7 4888.9 4784.7 4789.4 4796.7 4817.2 4820.6 4840.9 4879.0 4881.0 4890.0 4895.7 4773.5 4776.7 4777.9 4794.6 4876.0 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | [#1] ext.html Cycles:180 Average:45704.68 Median:36895.63 stddev:79136.29 (214.5%) stddev-sans-first:79285.72 20:03:28 INFO - PROCESS | 3437 | Values: 568.3 581.6 591.2 592.8 603.2 27899.2 39029.8 40306.6 40376.0 43649.0 39896.6 40258.4 40323.4 40337.6 40396.8 7254.4 7314.1 7534.3 7534.6 7545.2 7175.2 9542.4 9804.2 9822.0 10164.5 9865.6 9936.8 9937.7 9937.8 9958.2 9742.6 9790.0 9792.9 9798.1 9804.8 9744.4 9796.8 9804.0 9807.9 9808.6 36602.0 36826.3 36894.6 36896.6 36923.4 3154.0 3202.9 3292.7 3431.4 3657.6 27286.5 27400.9 27840.7 27967.2 28091.2 3316.2 3323.3 3372.4 3373.1 3481.3 248245.0 248643.0 249371.0 249473.6 249500.6 52975.7 53230.5 53292.0 53532.0 53578.5 56020.4 56115.7 56116.0 56152.4 56227.7 13719.3 13893.9 14139.4 14143.5 14152.4 8990.7 9317.9 9798.3 9941.7 10635.7 17134.5 17629.2 17996.9 18044.4 18232.6 6554.8 6812.1 6836.2 6969.3 7092.5 810.5 883.4 950.3 990.1 1000.7 26893.7 27132.0 27346.5 27542.4 27595.2 963.6 966.7 971.9 989.4 1011.1 14152.8 14682.8 14752.6 14909.3 14931.8 370190.0 373525.0 374123.0 374292.0 374508.0 48895.0 49204.8 49257.8 49599.3 49601.3 940.5 1046.1 1101.3 1103.0 1134.0 25720.2 28114.6 28145.6 30824.5 31345.2 47453.8 48248.8 48295.8 48301.8 48319.5 265635.0 266805.0 267028.0 267760.0 268288.0 23802.4 26332.3 26372.2 36862.8 37443.3 40386.8 40829.0 40996.4 41241.4 41987.2 34570.7 34710.1 34987.3 35113.6 35190.0 34187.5 34216.3 34226.0 34440.8 34538.1 33540.3 34006.8 34093.1 34292.0 34409.0 29423.5 31373.0 32070.8 32088.0 32192.0 23839.5 24180.5 24267.7 24392.4 24484.4 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | [#2] jquery.html Cycles:180 Average:21426.75 Median:4465.11 stddev:51635.73 (1156.4%) stddev-sans-first:51756.29 20:03:28 INFO - PROCESS | 3437 | Values: 331.1 352.3 357.7 366.4 382.9 12536.6 13629.3 15785.9 15977.1 16717.7 16513.8 16532.2 16782.8 16828.7 16921.4 4630.4 4684.0 4818.0 5045.2 5046.9 4834.4 4957.8 4962.9 4965.7 4966.3 4759.7 4930.9 4934.4 4939.8 4945.0 4777.9 4860.0 4868.4 4868.9 4872.4 4295.5 4295.6 4298.5 4298.5 4299.8 18456.3 19455.6 19931.4 19992.1 20169.7 1837.0 1837.2 1887.2 1890.4 2415.3 12115.5 12591.4 13129.7 13187.3 13347.1 1652.8 1706.4 1713.0 1734.1 1807.8 47069.3 63676.7 64182.0 64582.0 67834.3 8766.7 8823.7 8926.8 9037.9 9127.3 10568.4 10659.3 11110.1 11801.5 11877.3 6518.7 6853.4 6854.9 6856.2 6863.4 6508.3 6570.2 6618.8 7096.8 7176.1 5100.2 5453.9 5659.8 5711.8 5725.6 1457.3 1550.7 1560.4 1582.4 1617.1 857.9 865.4 868.0 923.8 962.3 15351.5 16194.9 16367.3 16642.0 17439.9 890.7 900.0 933.9 939.5 945.1 9255.3 9847.1 9893.1 9912.0 9938.7 255944.0 258040.0 259539.0 372852.0 374855.0 56564.0 66836.0 80350.6 81963.2 83997.6 905.4 937.6 939.2 942.9 943.8 15202.2 15250.6 15500.6 15931.3 16249.1 31744.0 35422.3 36760.6 36765.8 37726.4 51573.2 51860.0 52351.5 52448.2 52945.9 7291.8 7355.4 7410.8 7411.8 7627.1 8770.6 8851.0 9838.8 11523.4 11824.8 10025.5 10457.8 10593.4 10772.7 10830.1 9917.0 10213.4 10348.8 10388.6 10586.5 10165.2 10333.6 10442.7 10534.3 10793.8 7119.9 7224.3 7392.6 7477.5 7663.5 10008.5 10171.8 10184.7 10228.2 10354.9 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | [#3] mootools.html Cycles:180 Average:4626.34 Median:4845.34 stddev:2535.67 (52.3%) stddev-sans-first:2530.70 20:03:28 INFO - PROCESS | 3437 | Values: 1331.9 1368.4 1414.0 1617.2 1643.1 6626.5 7049.5 7052.2 7053.4 7053.5 6137.2 6320.1 6427.3 6636.3 6935.0 1990.0 2024.6 2024.8 2026.4 2026.4 1967.9 1972.8 1976.7 2030.0 2033.7 1791.5 1855.2 1959.6 1978.6 2008.9 1970.0 1970.9 1974.4 1982.2 1985.2 2012.5 2015.1 2053.8 2058.2 2062.4 6991.5 7067.9 7167.0 7182.1 7182.2 3913.9 4043.9 4055.0 4056.5 4058.2 2626.3 2796.0 2842.8 2917.6 2935.4 841.5 881.8 897.6 939.5 942.3 9454.2 9496.8 9507.9 9518.0 9525.8 3667.2 3750.3 3863.9 3865.1 3887.5 8134.1 8134.8 8142.3 8152.6 8153.4 4176.7 4184.7 4186.7 4188.0 4188.6 3746.1 3807.9 3832.4 3834.6 3834.9 3261.2 3286.7 3313.9 3347.3 3371.7 1091.7 1095.7 1098.2 1103.3 1103.8 767.8 789.2 792.3 805.2 823.3 4690.3 4706.5 4713.6 4826.9 4949.0 389.0 393.3 393.8 398.3 400.0 3282.7 3349.1 3355.8 3375.1 3423.3 7912.3 8437.5 8456.3 8487.2 8543.2 8474.2 8490.0 8491.5 8491.6 8492.0 6426.6 6504.0 6532.9 6600.0 6601.8 4808.4 4818.2 4863.8 4899.4 4918.9 7374.4 7495.3 7526.6 7639.2 7782.0 7483.1 7810.2 8090.0 8164.3 8176.9 6668.3 6728.2 6744.5 6767.8 6825.1 6702.2 6762.3 6762.8 6765.6 6766.3 5961.4 6028.2 6040.6 6118.8 6119.5 5862.4 5916.6 5961.4 5978.3 6089.5 5627.4 5728.3 5730.5 5738.4 5741.4 4220.6 4245.2 4273.4 4332.2 4421.3 4212.8 4264.3 4368.4 4378.5 4408.5 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | [#4] prototype.html Cycles:180 Average:4127.48 Median:4692.23 stddev:1222.82 (26.1%) stddev-sans-first:1191.26 20:03:28 INFO - PROCESS | 3437 | Values: 257.6 260.5 270.3 278.9 278.9 4621.6 4647.3 4780.8 4824.4 4827.7 4687.8 4778.5 4784.3 4791.2 4794.5 3708.7 3713.6 3731.9 3752.5 3759.4 3551.2 3674.3 3694.4 3707.1 3714.3 3611.2 3690.3 3692.5 3714.1 3718.6 3712.6 3715.7 3721.4 3731.3 3745.6 3270.3 3279.4 3279.9 3286.0 3288.9 4453.2 4619.7 4680.4 4698.8 4699.4 4139.4 4141.2 4145.2 4160.1 4163.2 5002.3 5019.2 5024.7 5025.2 5044.4 3326.1 3463.5 3464.8 3474.7 3476.2 5215.7 5252.7 5256.8 5271.0 5288.2 3547.2 3549.4 3549.8 3551.7 3561.2 3599.6 3600.2 3603.8 3606.0 3623.9 3986.0 4065.7 4107.7 4184.2 4192.9 4958.0 4959.2 4966.9 4971.1 4990.1 1204.9 1215.2 1216.6 1217.8 1218.8 777.9 822.0 830.8 832.9 835.6 4307.5 4312.4 4313.0 4317.2 4340.7 4972.3 4988.0 4990.9 5005.2 5021.2 4304.5 4314.5 4318.2 4321.0 4332.6 2518.0 2648.0 2658.8 2668.5 2677.3 4644.7 4667.3 4682.4 4696.7 4704.8 5081.0 5105.4 5118.5 5118.7 5146.7 4628.4 4876.8 4884.7 4885.3 4894.9 5151.5 5204.4 5213.5 5219.2 5267.0 4832.5 5114.5 5148.7 5156.5 5168.0 4567.8 4857.0 4891.3 4892.6 4914.6 3628.7 3636.6 3636.7 3637.3 3672.6 5124.6 5196.0 5235.7 5246.5 5264.6 5017.5 5032.7 5034.1 5073.3 5073.6 5032.9 5052.5 5052.7 5056.7 5110.8 4761.4 5000.4 5038.3 5047.0 5049.0 5020.9 5026.7 5034.3 5049.6 5069.6 4907.0 4926.9 4930.7 4998.4 5002.6 20:03:28 INFO - PROCESS | 3437 | 20:03:28 INFO - PROCESS | 3437 | [#5] yui.html Cycles:180 Average:14828.65 Median:45619.27 stddev:17988.17 (39.4%) stddev-sans-first:18007.06 20:03:28 INFO - PROCESS | 3437 | Values: 635.8 638.3 668.9 681.1 739.3 13496.8 13739.9 13904.2 13997.2 14097.2 15487.4 15497.2 15634.9 15670.6 15673.5 619.7 746.9 766.4 768.9 769.0 627.8 748.2 765.5 772.0 774.1 809.9 810.9 812.1 812.7 812.9 642.6 660.5 807.2 807.6 807.6 568.6 581.4 587.0 587.5 588.6 13403.0 13411.7 13416.4 13448.6 13451.0 12721.7 12807.7 12838.7 12849.6 12991.7 12024.6 12072.3 12164.4 12297.8 12399.8 4099.7 4132.5 4138.2 4195.9 4235.4 54266.5 55150.4 57547.4 64502.7 64564.0 10370.6 10688.1 10780.8 11006.8 11086.3 19071.9 19097.4 19097.4 19099.7 19100.6 6803.3 6929.1 7051.4 7091.6 7243.0 3712.5 3775.3 3798.2 3801.4 3804.2 2785.9 2853.0 2864.1 2884.5 2893.4 486.0 488.7 496.0 499.3 500.7 569.2 583.0 588.8 621.7 635.7 8475.2 8573.5 8634.1 8648.3 8650.7 586.5 590.2 590.9 593.5 611.3 3783.3 3863.0 3966.9 4054.8 4055.9 54940.5 71982.0 72053.3 72210.6 73882.0 42920.8 46097.8 47369.3 47452.5 55941.4 45140.8 51805.5 51901.0 52187.0 52561.5 8337.0 8740.9 8993.4 9112.0 9214.8 31973.0 35517.8 36033.1 36389.8 36869.0 47403.0 47751.8 49464.5 49878.5 51789.0 10455.7 10713.5 10804.6 10957.6 11346.9 12542.8 12582.4 12761.9 12867.3 13340.9 11525.4 11806.2 12245.0 12335.9 12747.4 11810.2 12315.6 12349.6 12646.9 12728.7 11524.5 11573.7 11670.1 11796.2 12054.4 9178.3 9266.2 9805.0 9833.7 10333.6 8547.7 9945.2 10023.9 10105.3 10113.7 20:03:28 INFO - PROCESS | 3437 | -------- Summary: end -------- 20:03:28 INFO - PROCESS | 3437 | 20:03:29 INFO - TEST-INFO | 3437: exit 0 20:03:29 INFO - TEST-OK | dromaeo_css | took 1124728ms 20:03:29 INFO - TEST-START | kraken 20:03:29 INFO - operating with platform_type : linux_ 20:03:29 INFO - Initialising browser for kraken test... 20:03:29 INFO - TEST-INFO | started process 3743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubYfkW/profile http://localhost:40330/getInfo.html) 20:03:33 INFO - PROCESS | 3743 | __metrics Screen width/height:1600/1200 20:03:33 INFO - PROCESS | 3743 | colorDepth:24 20:03:33 INFO - PROCESS | 3743 | Browser inner width/height: 1024/697 20:03:33 INFO - PROCESS | 3743 | __metrics 20:03:33 INFO - PROCESS | 3743 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:03:33 INFO - PROCESS | 3743 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:03:34 INFO - PROCESS | 3743 | console.error: PushService: 20:03:34 INFO - PROCESS | 3743 | stateChangeProcessEnqueue: Error transitioning state 20:03:34 INFO - PROCESS | 3743 | UnknownError 20:03:35 INFO - TEST-INFO | 3743: exit 0 20:03:35 INFO - Browser initialized. 20:03:35 INFO - Running cycle 1/1 for kraken test... 20:03:35 INFO - TEST-INFO | started process 3825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubYfkW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:47 INFO - PROCESS | 3825 | RSS: Main: 175128576 20:03:47 INFO - PROCESS | 3825 | 20:03:50 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40330/tests/kraken/driver.html?testName=audio-beat-detection) 20:03:51 INFO - PROCESS | 3825 | RSS: Main: 240144384 20:03:51 INFO - PROCESS | 3825 | 20:03:54 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40330/tests/kraken/driver.html?testName=audio-dft) 20:03:54 INFO - PROCESS | 3825 | RSS: Main: 219037696 20:03:54 INFO - PROCESS | 3825 | 20:03:57 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40330/tests/kraken/driver.html?testName=audio-fft) 20:03:58 INFO - PROCESS | 3825 | RSS: Main: 301182976 20:03:58 INFO - PROCESS | 3825 | 20:04:00 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40330/tests/kraken/driver.html?testName=audio-oscillator) 20:04:01 INFO - PROCESS | 3825 | RSS: Main: 210718720 20:04:01 INFO - PROCESS | 3825 | 20:04:03 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:04:04 INFO - PROCESS | 3825 | RSS: Main: 214941696 20:04:04 INFO - PROCESS | 3825 | 20:04:07 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40330/tests/kraken/driver.html?testName=imaging-darkroom) 20:04:07 INFO - PROCESS | 3825 | RSS: Main: 253898752 20:04:07 INFO - PROCESS | 3825 | 20:04:11 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40330/tests/kraken/driver.html?testName=imaging-desaturate) 20:04:12 INFO - PROCESS | 3825 | RSS: Main: 248020992 20:04:12 INFO - PROCESS | 3825 | 20:04:14 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40330/tests/kraken/driver.html?testName=json-parse-financial) 20:04:15 INFO - PROCESS | 3825 | RSS: Main: 249925632 20:04:15 INFO - PROCESS | 3825 | 20:04:17 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:04:17 INFO - PROCESS | 3825 | RSS: Main: 213671936 20:04:17 INFO - PROCESS | 3825 | 20:04:19 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:04:20 INFO - PROCESS | 3825 | RSS: Main: 221143040 20:04:20 INFO - PROCESS | 3825 | 20:04:22 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:04:23 INFO - PROCESS | 3825 | RSS: Main: 229609472 20:04:23 INFO - PROCESS | 3825 | 20:04:26 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:04:27 INFO - PROCESS | 3825 | RSS: Main: 238518272 20:04:27 INFO - PROCESS | 3825 | 20:04:30 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:04:30 INFO - PROCESS | 3825 | RSS: Main: 235950080 20:04:30 INFO - PROCESS | 3825 | 20:04:32 INFO - PROCESS | 3825 | Cycle 1(1): loaded http://localhost:40330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40330/tests/kraken/driver.html?testName=ai-astar) 20:04:33 INFO - PROCESS | 3825 | RSS: Main: 288251904 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | __start_tp_report 20:04:33 INFO - PROCESS | 3825 | _x_x_mozilla_page_load 20:04:33 INFO - PROCESS | 3825 | _x_x_mozilla_page_load_details 20:04:33 INFO - PROCESS | 3825 | |i|pagename|runs| 20:04:33 INFO - PROCESS | 3825 | |0;ai-astar;109;116;118;118;118;118;116;118;118;118 20:04:33 INFO - PROCESS | 3825 | |1;audio-beat-detection;150;133;137;182;137;129;128;130;148;133 20:04:33 INFO - PROCESS | 3825 | |2;audio-dft;161;163;163;182;161;161;161;160;161;160 20:04:33 INFO - PROCESS | 3825 | |3;audio-fft;77;76;78;113;77;76;78;78;91;76 20:04:33 INFO - PROCESS | 3825 | |4;audio-oscillator;82;86;115;83;84;84;106;83;84;113 20:04:33 INFO - PROCESS | 3825 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;118 20:04:33 INFO - PROCESS | 3825 | |6;imaging-darkroom;147;146;146;145;147;147;148;148;148;148 20:04:33 INFO - PROCESS | 3825 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;96;96 20:04:33 INFO - PROCESS | 3825 | |8;json-parse-financial;65;64;67;65;66;65;65;65;65;65 20:04:33 INFO - PROCESS | 3825 | |9;json-stringify-tinderbox;67;67;66;65;66;66;66;67;67;65 20:04:33 INFO - PROCESS | 3825 | |10;stanford-crypto-aes;85;85;89;95;86;92;85;86;84;85 20:04:33 INFO - PROCESS | 3825 | |11;stanford-crypto-ccm;147;150;154;147;154;141;154;145;185;148 20:04:33 INFO - PROCESS | 3825 | |12;stanford-crypto-pbkdf2;182;183;178;182;182;180;178;178;185;183 20:04:33 INFO - PROCESS | 3825 | |13;stanford-crypto-sha256-iterative;75;72;71;73;71;71;72;72;70;70 20:04:33 INFO - PROCESS | 3825 | __end_tp_report 20:04:33 INFO - PROCESS | 3825 | __start_cc_report 20:04:33 INFO - PROCESS | 3825 | _x_x_mozilla_cycle_collect,1990 20:04:33 INFO - PROCESS | 3825 | __end_cc_report 20:04:33 INFO - PROCESS | 3825 | __startTimestamp1480565073045__endTimestamp 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | ------- Summary: start ------- 20:04:33 INFO - PROCESS | 3825 | Number of tests: 14 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:2.83 (2.4%) stddev-sans-first:0.88 20:04:33 INFO - PROCESS | 3825 | Values: 109.0 116.0 118.0 118.0 118.0 118.0 116.0 118.0 118.0 118.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:137.00 stddev:16.34 (11.9%) stddev-sans-first:16.99 20:04:33 INFO - PROCESS | 3825 | Values: 150.0 133.0 137.0 182.0 137.0 129.0 128.0 130.0 148.0 133.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#2] audio-dft Cycles:10 Average:163.30 Median:161.00 stddev:6.65 (4.1%) stddev-sans-first:7.00 20:04:33 INFO - PROCESS | 3825 | Values: 161.0 163.0 163.0 182.0 161.0 161.0 161.0 160.0 161.0 160.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.50 stddev:11.78 (15.2%) stddev-sans-first:12.35 20:04:33 INFO - PROCESS | 3825 | Values: 77.0 76.0 78.0 113.0 77.0 76.0 78.0 78.0 91.0 76.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.50 stddev:13.56 (16.2%) stddev-sans-first:13.90 20:04:33 INFO - PROCESS | 3825 | Values: 82.0 86.0 115.0 83.0 84.0 84.0 106.0 83.0 84.0 113.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:04:33 INFO - PROCESS | 3825 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 20:04:33 INFO - PROCESS | 3825 | Values: 147.0 146.0 146.0 145.0 147.0 147.0 148.0 148.0 148.0 148.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:04:33 INFO - PROCESS | 3825 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 20:04:33 INFO - PROCESS | 3825 | Values: 65.0 64.0 67.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 20:04:33 INFO - PROCESS | 3825 | Values: 67.0 67.0 66.0 65.0 66.0 66.0 66.0 67.0 67.0 65.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.00 stddev:3.65 (4.2%) stddev-sans-first:3.78 20:04:33 INFO - PROCESS | 3825 | Values: 85.0 85.0 89.0 95.0 86.0 92.0 85.0 86.0 84.0 85.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:152.00 stddev:12.20 (8.0%) stddev-sans-first:12.77 20:04:33 INFO - PROCESS | 3825 | Values: 147.0 150.0 154.0 147.0 154.0 141.0 154.0 145.0 185.0 148.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:182.00 stddev:2.47 (1.4%) stddev-sans-first:2.60 20:04:33 INFO - PROCESS | 3825 | Values: 182.0 183.0 178.0 182.0 182.0 180.0 178.0 178.0 185.0 183.0 20:04:33 INFO - PROCESS | 3825 | 20:04:33 INFO - PROCESS | 3825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.49 (2.1%) stddev-sans-first:1.00 20:04:33 INFO - PROCESS | 3825 | Values: 75.0 72.0 71.0 73.0 71.0 71.0 72.0 72.0 70.0 70.0 20:04:33 INFO - PROCESS | 3825 | -------- Summary: end -------- 20:04:33 INFO - PROCESS | 3825 | 20:04:34 INFO - TEST-INFO | 3825: exit 0 20:04:34 INFO - TEST-OK | kraken | took 65297ms 20:04:34 INFO - SUITE-END | took 1190s 20:04:34 INFO - Completed test suite (00:19:50) 20:04:34 INFO - javascript benchmark 20:04:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.0377358490564, 2587.0298638010745, 2595.8961641534333, 2612.8562929038894, 2623.3835048763535, 4617.1458280218185, 4667.393238878941, 4667.69659972102, 4705.3177289293035, 4705.882352941178, 4687.250039993593, 4695.319178719093, 4715.363425937498, 4728.952710472894, 4795.208790549564, 4333.804978775946, 4343.022819865537, 4384.539623339551, 4428.202923473774, 4510.075434535912, 4044.939325910114, 4448.065906159694, 4449.7330160190495, 4485.641148708112, 4531.071130418273, 4265.189613973335, 4374.715643483163, 4378.0, 4413.955860441387, 4483.50681425043, 4205.390218418343, 4213.199492096492, 4231.069164783743, 4288.421063156465, 4358.0, 4210.242156411845, 4212.957870421287, 4219.683523735732, 4248.723832950848, 4282.8715138545895, 4600.6319494440695, 4604.746738929358, 4630.8147674093, 4638.397008388888, 4661.347411362412, 4935.481774413706, 4957.479464656195, 4986.551210391046, 4991.251312303148, 5065.670731402447, 5057.924131138036, 5074.416442109168, 5088.389393272794, 5088.567471764904, 5091.643584949055, 4695.5539223773685, 4739.810407583727, 4743.881402964954, 4744.644151688637, 4749.596284315872, 5159.355080614923, 5165.328507294028, 5176.81881134166, 5197.870053248699, 5207.244949482304, 4915.582175515121, 4957.504249575014, 4958.628102892298, 4962.305277261186, 5020.899582008339, 4947.25791131326, 4989.276554899519, 4991.301217829507, 5009.674371165863, 5040.697558146523, 4903.04390643821, 4928.581070609039, 4938.4320803107385, 4985.077760614298, 5037.168867136881, 4939.753012349368, 4948.134076536592, 4959.62802789785, 4965.652404331734, 5014.674046186986, 4170.791460426966, 4225.218334608107, 4226.218149642326, 4235.703500754979, 4280.871573852789, 3665.9266814663556, 3676.6507181817683, 3691.8338674759702, 3712.7586706863967, 3718.7768733875514, 4374.365716971021, 4376.49670287921, 4383.736975781463, 4408.625266852289, 4412.6690498212765, 5111.258867464197, 5124.718140502234, 5125.359330083739, 5125.79496820123, 5167.0, 4259.637930775857, 4290.227759003409, 4302.118065796504, 4327.437433133672, 4371.715838470489, 4540.318952157203, 4555.612772914273, 4576.954230457653, 4577.038821847449, 4595.793189306489, 4716.056788642285, 4755.667103302736, 4760.0, 4760.809567617256, 4801.5438533339275, 4951.059298733229, 4986.0277245936695, 4987.501249874984, 5081.364829396325, 5088.185890257541, 4753.83361582343, 4784.234522476387, 4818.927716084191, 4879.512048795092, 4889.413270407432, 5051.318072060371, 5051.87370315745, 5055.823046193365, 5057.089723849595, 5106.131957567297, 5080.491950805038, 5143.61422893277, 5144.511271429208, 5145.228215767665, 5184.533391994739, 4794.304825800309, 4817.301491283814, 4821.9035619288115, 4869.123557759637, 5000.499950004971, 4881.438634557071, 4886.340344053508, 4887.266909963534, 4887.731174785421, 4888.902221955612, 4784.6889952153, 4789.44921334051, 4796.688215265996, 4817.156997525489, 4820.566149046603, 4840.927386089141, 4879.0, 4880.99939512392, 4890.046440943982, 4895.7062576245535, 4773.498782627774, 4776.737279449663, 4777.856664300077, 4794.616430685467, 4876.049170411736], "value": 4619.3232074066145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2782865760485, 581.6074149948784, 591.243208692873, 592.7895597063045, 603.1706403694919, 27899.16302510923, 39029.80485097574, 40306.59693403069, 40376.0, 43649.0, 39896.60103398965, 40258.39612405816, 40323.395149072785, 40337.59662403375, 40396.798016009954, 7254.4196464282995, 7314.0857392825765, 7534.321911028006, 7534.585597792119, 7545.245475452438, 7175.246599107097, 9542.427454352726, 9804.166645835112, 9821.950890245538, 10164.491775411238, 9865.605375784995, 9936.751581210492, 9937.701868943943, 9937.75155621108, 9958.153556947633, 9742.561584728704, 9789.999999999964, 9792.853107203398, 9798.069183427562, 9804.803903921953, 9744.415335079848, 9796.755081122958, 9803.950980245054, 9807.852882206773, 9808.558614862348, 36602.0, 36826.26347473035, 36894.631053689656, 36896.63103368985, 36923.4461483078, 3153.9842300788578, 3202.9199270018203, 3292.670732926712, 3431.365197438482, 3657.6342365763476, 27286.54269146159, 27400.862995685093, 27840.72159278422, 27967.160985170478, 28091.15726528187, 3316.2041110133396, 3323.252268239651, 3372.392969265531, 3373.089265898194, 3481.3385456763135, 248245.0, 248643.0, 249371.0, 249473.58948978534, 249500.55493895657, 52975.73512132415, 53230.46769532333, 53292.0, 53532.0, 53578.464215357344, 56020.43979560234, 56115.71942140263, 56116.0, 56152.43847561554, 56227.71886140625, 13719.314034298246, 13893.86106138946, 14139.434422623186, 14143.50497732595, 14152.433902643985, 8990.730278091667, 9317.90682093184, 9798.31411801167, 9941.701748947544, 10635.734106647396, 17134.485965421056, 17629.206685699173, 17996.910015449837, 18044.368447104287, 18232.63534729298, 6554.836129096715, 6812.114425124702, 6836.248012718597, 6969.303069693092, 7092.538984966064, 810.4529442626203, 883.3551507399634, 950.2777888804559, 990.0643891522586, 1000.6647772996128, 26893.731062689123, 27132.0, 27346.453070938867, 27542.449151016866, 27595.172144835688, 963.5615794813343, 966.7293157915794, 971.9465429401309, 989.4459102902398, 1011.1455819832377, 14152.787708184385, 14682.779758303634, 14752.631184220265, 14909.329080191417, 14931.776023359658, 370190.0, 373525.0, 374123.0, 374292.0, 374508.0, 48895.0, 49204.753976230604, 49257.75371123121, 49599.256011159865, 49601.25598116031, 940.501534186882, 1046.100353695821, 1101.2951710904867, 1102.9889701103048, 1134.0474001838495, 25720.228393148234, 28114.578281325386, 28145.57781633318, 30824.537631935986, 31345.216369590944, 47453.76273118612, 48248.75875620599, 48295.75852120717, 48301.75849120732, 48319.5168048315, 265635.0, 266805.0, 267028.0, 267760.0, 268288.0, 23802.40493987595, 26332.341691457867, 26372.208833735018, 36862.8156859214, 37443.25113497769, 40386.79806600948, 40829.0, 40996.38505422361, 41241.381379279934, 41987.16025679408, 34570.65429345674, 34710.13224669403, 34987.30025399427, 35113.648863511036, 35190.0, 34187.4871876927, 34216.31567368589, 34226.0, 34440.82779586086, 34538.13654658654, 33540.32919341648, 34006.82996585001, 34093.14767130841, 34292.0, 34409.0, 29423.486977142027, 31373.0, 32070.83964580162, 32088.0, 32192.0, 23839.523209535364, 24180.51638967246, 24267.665418227218, 24392.390190245387, 24484.387890302885], "value": 17715.552231048838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.08290036598606, 352.28310388359694, 357.68166331964545, 366.4484950150024, 382.87244066224963, 12536.56122035729, 13629.25039122848, 15785.921070394646, 15977.121258330788, 16717.749233761504, 16513.752293715603, 16532.173391330416, 16782.83217167828, 16828.66342673146, 16921.407750728697, 4630.37489938859, 4684.0, 4817.975910120454, 5045.21799121135, 5046.924296135561, 4834.395700537433, 4957.776900039489, 4962.851114466572, 4965.7020578765205, 4966.304717339575, 4759.738669252651, 4930.852074437755, 4934.40787105546, 4939.753012349386, 4944.950550494485, 4777.880552986168, 4859.975700121512, 4868.415790105175, 4868.902621947576, 4872.3909511311085, 4295.463067116611, 4295.634871035965, 4298.505671847746, 4298.505671847746, 4299.849505267332, 18456.261749530004, 19455.610887782306, 19931.402057938285, 19992.10035548404, 20169.697454538193, 1837.0447367369027, 1837.200817644329, 1887.2168050259127, 1890.357298302526, 2415.251272105653, 12115.454804533729, 12591.37043147839, 13129.73740525184, 13187.340632968313, 13347.132436391603, 1652.842979916906, 1706.436875830973, 1712.9828701712947, 1734.1329335332334, 1807.7921039080543, 47069.29396059062, 63676.68161659162, 64182.0, 64581.99999999953, 67834.32165678378, 8766.736997890073, 8823.735287941372, 8926.821463570692, 9037.909620903707, 9127.315451341043, 10568.365898045988, 10659.253852230424, 11110.111191104692, 11801.52793888252, 11877.346745929057, 6518.674066296761, 6853.4174595158975, 6854.897176542356, 6856.211535673362, 6863.416609588241, 6508.3491650835485, 6570.244421891448, 6618.801435956929, 7096.822579435556, 7176.102987126609, 5100.183970564692, 5453.945460545344, 5659.773609055592, 5711.771529138788, 5725.599208055396, 1457.2711551017017, 1550.6588550518868, 1560.4382422327953, 1582.374961890047, 1617.134832864412, 857.9099194584603, 865.4028720183054, 867.9739607811649, 923.7644400677918, 962.2734835199379, 15351.539453816404, 16194.919025404797, 16367.2634731435, 16642.0, 17439.912800435915, 890.7283278599959, 899.9865002024975, 933.9439633622004, 939.5443210043123, 945.1021529546821, 9255.259579233645, 9847.064528869745, 9893.109620134222, 9912.0, 9938.652147174815, 255944.0, 258040.0, 259539.0, 372852.0, 374855.0, 56564.0, 66836.0, 80350.59824700956, 81963.18036819555, 83997.58001209956, 905.3752910491739, 937.5827756648226, 939.1500691873865, 942.9245660347156, 943.8018016216671, 15202.239888005777, 15250.618734531725, 15500.612484687974, 15931.283092261108, 16249.106299153187, 31744.0, 35422.29155416826, 36760.63239367572, 36765.81617091897, 37726.43410348902, 51573.226401604756, 51860.0, 52351.476485236184, 52448.21327680164, 52945.94108117739, 7291.817704557428, 7355.374793142642, 7410.777676669709, 7411.814704632212, 7627.122880868771, 8770.649174032967, 8850.95574522149, 9838.75403114928, 11523.423828808358, 11824.822627660764, 10025.498725063864, 10457.790844182922, 10593.417362045162, 10772.676819695422, 10830.079443247412, 9917.008299170026, 10213.387196768217, 10348.793024139626, 10388.584456621953, 10586.523606437575, 10165.237607179342, 10333.638322658671, 10442.738931526772, 10534.315269507764, 10793.784124317626, 7119.857602848017, 7224.313690199423, 7392.593407362647, 7477.476576639583, 7663.540187588763, 10008.549615267184, 10171.796564068825, 10184.694459166238, 10228.181745460197, 10354.948225258826], "value": 7932.297827452437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.9334033298335, 1368.4047439363876, 1413.985860141399, 1617.1752406272797, 1643.1291415549763, 6626.469882409402, 7049.506534542584, 7052.153741551021, 7053.365197132257, 7053.4709896757695, 6137.232845894263, 6320.051992201172, 6427.325130861251, 6636.270010298876, 6935.0, 1989.9999999999964, 2024.6052019856133, 2024.8278896293832, 2026.3718247343297, 2026.3819535041807, 1967.872088314255, 1972.753405824272, 1976.6837306031039, 2029.9951523995642, 2033.6746120620703, 1791.4536066499713, 1855.1744473709205, 1959.559099202675, 1978.5844972555708, 2008.8593798434115, 1970.0248377053308, 1970.9310174143836, 1974.3583335415976, 1982.2467462364282, 1985.2158397432934, 2012.5471768852037, 2015.1133501259399, 2053.7946205379344, 2058.207590077816, 2062.3503596367245, 6991.510594258404, 7067.8586428271665, 7166.964165179193, 7182.138143422771, 7182.209956904736, 3913.9021524462114, 4043.9191216175805, 4055.026793569522, 4056.4523789288364, 4058.2492238935893, 2626.3171575390347, 2795.9580606290924, 2842.786790990684, 2917.620709307798, 2935.3688956874375, 841.474078700812, 881.801594641207, 897.622998340692, 939.497368907638, 942.3121121581285, 9454.196393306578, 9496.762580935394, 9507.857382139273, 9517.952410237975, 9525.80927384077, 3667.156553992597, 3750.287445385368, 3863.864764733221, 3865.130345672201, 3887.4644515416253, 8134.145914678992, 8134.75595732129, 8142.267195952392, 8152.592370381457, 8153.429259951747, 4176.707630465899, 4184.748915065105, 4186.706930514895, 4188.015816283171, 4188.602082802129, 3746.1383881706815, 3807.8857634271017, 3832.425136229532, 3834.616538346199, 3834.865779697753, 3261.1684020574603, 3286.6877646623534, 3313.8840140595444, 3347.2803347279964, 3371.696547310754, 1091.6615849086809, 1095.7479779650726, 1098.1715443786006, 1103.2828661370013, 1103.7902798468265, 767.7850201943464, 789.2462698123278, 792.3146478296233, 805.2390490986079, 823.3495538524618, 4690.273007683814, 4706.458757242961, 4713.622910167179, 4826.927596086061, 4949.034938187091, 388.95721470638205, 393.2744087159187, 393.7657094029048, 398.2771270144678, 399.97200195986585, 3282.7373810095137, 3349.05801509969, 3355.8322083896196, 3375.0549846043145, 3423.2639982403903, 7912.32745216663, 8437.535935523483, 8456.323494120456, 8487.193716596914, 8543.188397102265, 8474.152584741476, 8489.95755021221, 8491.490510569385, 8491.61787719554, 8492.0, 6426.614403135827, 6503.967480162569, 6532.902006469907, 6600.0, 6601.834954126185, 4808.422989241313, 4818.229083346648, 4863.756812159449, 4899.387576552931, 4918.8770280743265, 7374.373178279691, 7495.287947644965, 7526.623668816428, 7639.197884222077, 7782.0, 7483.064616922885, 7810.218978102144, 8089.959550202211, 8164.346852251924, 8176.918230817616, 6668.299828517936, 6728.226253980855, 6744.460443164437, 6767.763128290486, 6825.1127353443735, 6702.19573651165, 6762.323767623198, 6762.830929226809, 6765.560238584476, 6766.323367663194, 5961.403859614177, 6028.216331876828, 6040.577159598962, 6118.785842495669, 6119.4798442132915, 5862.384449632727, 5916.615419997686, 5961.433663801932, 5978.282606087298, 6089.54328425361, 5627.409122042127, 5728.312602487728, 5730.484256416942, 5738.426157384228, 5741.368449470639, 4220.577942205755, 4245.172191422766, 4273.380359847867, 4332.220200363965, 4421.336799480104, 4212.768297743653, 4264.275073237619, 4368.366586844953, 4378.452693413324, 4408.515063343094], "value": 3708.7671906415194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.6354458441306, 260.51414112679856, 270.3147521034179, 278.9135368035909, 278.92050765531826, 4621.6071633911115, 4647.34937108805, 4780.832670856521, 4824.396950381202, 4827.686200396972, 4687.765611719409, 4778.498257682945, 4784.330193772875, 4791.233402655575, 4794.544518270767, 3708.7218458615644, 3713.554373475187, 3731.9253614927684, 3752.4558938953837, 3759.4360845873202, 3551.236484155906, 3674.2651469706034, 3694.353488139578, 3707.1464267866068, 3714.275716235335, 3611.1694310308512, 3690.298843219793, 3692.4645926340663, 3714.0900479382453, 3718.609545997672, 3712.5916149223563, 3715.739898207113, 3721.4045752679576, 3731.3097077040834, 3745.606711295329, 3270.2641905571295, 3279.442494775894, 3279.918002049944, 3285.950710739341, 3288.917777055569, 4453.22068637987, 4619.699719518254, 4680.391549098629, 4698.765061746899, 4699.365585645928, 4139.399787030864, 4141.213169497786, 4145.233131870614, 4160.1471698301775, 4163.167366526707, 5002.349694539723, 5019.247112933052, 5024.748762561857, 5025.221090730943, 5044.419891712463, 3326.070878890262, 3463.497792820027, 3464.7747896386654, 3474.6525347465304, 3476.1657202271526, 5215.713135777531, 5252.737363131828, 5256.764660304825, 5270.973645131749, 5288.1538953767595, 3547.2373439710586, 3549.378858699769, 3549.769264997767, 3551.7158627309755, 3561.216532362876, 3599.6400359963795, 3600.207954250061, 3603.819809009539, 3606.0, 3623.9456408153897, 3985.980070099689, 4065.739620717587, 4107.732997355162, 4184.225918205142, 4192.916141677149, 4957.983613359253, 4959.181735013683, 4966.925496117561, 4971.055499455092, 4990.126727822689, 1204.8674246208536, 1215.2344023265287, 1216.647172320035, 1217.7503611759569, 1218.8171774233936, 777.8872063550754, 822.0258993093204, 830.8296799156159, 832.862577674689, 835.6448509383488, 4307.526172121127, 4312.417823593837, 4312.978435107867, 4317.179735850178, 4340.742813736839, 4972.254161875748, 4988.0, 4990.880699562773, 5005.224190250517, 5021.196608542616, 4304.548022457597, 4314.503832059353, 4318.222719910384, 4321.0, 4332.631726303236, 2518.0, 2647.9735202647726, 2658.787297016234, 2668.4656322614574, 2677.2771351734923, 4644.722701257114, 4667.343093201865, 4682.391289132391, 4696.694714843524, 4704.812716682156, 5080.983803239293, 5105.387353517527, 5118.462561430996, 5118.722168634922, 5146.665466744649, 4628.3983082199775, 4876.756162191948, 4884.7055530285215, 4885.316055752198, 4894.926576101361, 5151.5106064923775, 5204.401493828258, 5213.504717052026, 5219.243209734643, 5267.0, 4832.540908613676, 5114.539691427641, 5148.665336753099, 5156.484351564964, 5168.043911876315, 4567.830280616813, 4856.988667026466, 4891.26631005352, 4892.584130348961, 4914.5822605078965, 3628.6552777486095, 3636.5635024534154, 3636.6908812751212, 3637.3270944875285, 3672.614375490535, 5124.64196987806, 5195.9740201298755, 5235.738213089254, 5246.475352464723, 5264.578833693372, 5017.4731653175895, 5032.6980381177245, 5034.144195486703, 5073.34046573943, 5073.619478539051, 5032.874178145429, 5052.520010598987, 5052.69683818972, 5056.696598204119, 5110.821121260887, 4761.381020467317, 5000.399952005782, 5038.269450929668, 5047.0, 5049.0, 5020.949790502048, 5026.698398096126, 5034.320366750442, 5049.57078648319, 5069.645124841373, 4906.975465122794, 4926.852194434173, 4930.654854160318, 4998.375203099613, 5002.624803139852], "value": 3728.1042459701553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.7520566978877, 638.3381299979087, 668.9130413046303, 681.1349586025748, 739.2792027772922, 13496.797548036775, 13739.862601373983, 13904.235267060307, 13997.230152341617, 14097.154170749762, 15487.380504779823, 15497.225138743046, 15634.921825390886, 15670.608234794106, 15673.45142919998, 619.6560908695673, 746.858096961577, 766.4328396986218, 768.8577613141558, 768.9923100769005, 627.7928283666402, 748.188215785873, 765.5330248548408, 771.961401929904, 774.094309657699, 809.8542262392767, 810.9270165685087, 812.0823469479479, 812.6749300279906, 812.8821320908464, 642.5502148496072, 660.4947215380238, 807.1847434091551, 807.5962018990505, 807.640599933033, 568.6332315656379, 581.36050344621, 587.0138167877964, 587.5094296262625, 588.5703436491342, 13403.0, 13411.731765364639, 13416.396262168128, 13448.596542103753, 13451.0, 12721.745565088646, 12807.679808004781, 12838.679033024157, 12849.550265740747, 12991.740165196643, 12024.639260822189, 12072.27414330218, 12164.391780411033, 12297.815532767016, 12399.814002789966, 4099.733517321364, 4132.462779838632, 4138.193052354792, 4195.937060944088, 4235.3646952957, 54266.45733542654, 55150.44849551493, 57547.42452575504, 64502.677486613204, 64564.0, 10370.637027703995, 10688.14494840411, 10780.78438431227, 11006.779864402828, 11086.334819910831, 19071.90464047671, 19097.427077187705, 19097.427077187705, 19099.713504297448, 19100.61798764017, 6803.285655006153, 6929.133858267716, 7051.435885129177, 7091.574505529685, 7242.96378518104, 3712.5173727415804, 3775.339315619756, 3798.2213646202463, 3801.3727734923427, 3804.201117765245, 2785.9442811143663, 2853.0, 2864.0834932821713, 2884.5384738442167, 2893.4068515954177, 486.0400708600556, 488.7336401661103, 495.95040495950116, 499.3383766509317, 500.6545483616366, 569.2400645138704, 582.9681463809035, 588.7762650192899, 621.7357623010203, 635.7171058878755, 8475.194856488624, 8573.485590864568, 8634.136586341316, 8648.308135349156, 8650.653973841101, 586.5219845825638, 590.1973316289842, 590.8877313310543, 593.5459373579215, 611.339753066687, 3783.281176576442, 3862.9570016095495, 3966.8809935701975, 4054.7567145971334, 4055.8986025349013, 54940.45059549433, 71982.0, 72053.2794672057, 72210.63894680493, 73882.0, 42920.78539607282, 46097.7695111529, 47369.28946065812, 47452.525474745504, 55941.440585594435, 45140.77429612897, 51805.48194518082, 51901.0, 52187.0, 52561.474385257185, 8336.958315208385, 8740.912590874264, 8993.370464067453, 9111.9976802553, 9214.815703686023, 31973.0, 35517.82241088778, 36033.11735061241, 36389.81805091064, 36869.0, 47403.0, 47751.76124119357, 49464.50535494599, 49878.50121498739, 51789.0, 10455.686329409826, 10713.517891694737, 10804.621838235624, 10957.56169753201, 11346.886531134583, 12542.811857822322, 12582.370881455707, 12761.872381276069, 12867.292298923649, 13340.86659133435, 11525.366104864313, 11806.232594881305, 12245.0, 12335.876641233473, 12747.377205531742, 11810.232334898204, 12315.630531084082, 12349.629511114681, 12646.87353126457, 12728.6817829555, 11524.539018439169, 11573.7106572333, 11670.066394688234, 11796.174267801172, 12054.44263013244, 9178.311626628163, 9266.166045055978, 9804.950975245078, 9833.70498885006, 10333.638322658671, 8547.700830470903, 9945.154661853534, 10023.949880250551, 10105.343152695052, 10113.747156321151], "value": 6353.831571643921, "unit": "score"}], "name": "dromaeo_css", "value": 6204.261548819134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 118.0, 118.0, 118.0, 118.0, 116.0, 118.0, 118.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 137.0, 182.0, 137.0, 129.0, 128.0, 130.0, 148.0, 133.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 182.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 113.0, 77.0, 76.0, 78.0, 78.0, 91.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 115.0, 83.0, 84.0, 84.0, 106.0, 83.0, 84.0, 113.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 95.0, 86.0, 92.0, 85.0, 86.0, 84.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 154.0, 147.0, 154.0, 141.0, 154.0, 145.0, 185.0, 148.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 178.0, 182.0, 182.0, 180.0, 178.0, 178.0, 185.0, 183.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 71.0, 73.0, 71.0, 71.0, 72.0, 72.0, 70.0, 70.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1578.3, "alertThreshold": 2.0}]} 20:04:34 INFO - Return code: 0 20:04:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:04:34 INFO - # TBPL SUCCESS # 20:04:34 INFO - Running post-action listener: _resource_record_post_action 20:04:34 INFO - [mozharness: 2016-12-01 04:04:34.836329Z] Finished run-tests step (success) 20:04:34 INFO - Running post-run listener: _resource_record_post_run 20:04:34 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 8028160; Write bytes: 420335616; Read time: 2616; Write time: 353532 20:04:34 INFO - TinderboxPrint: CPU usage
13.1% 20:04:34 INFO - TinderboxPrint: I/O read bytes / time
8,028,160 / 2,616 20:04:34 INFO - TinderboxPrint: I/O write bytes / time
420,335,616 / 353,532 20:04:34 INFO - TinderboxPrint: CPU idle
8,371.7 (86.9%) 20:04:34 INFO - TinderboxPrint: CPU user
1,207.8 (12.5%) 20:04:34 INFO - TinderboxPrint: Swap in / out
0 / 0 20:04:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6246400; Read time: 0; Write time: 2620 20:04:34 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 5861376; Write bytes: 387162112; Read time: 2304; Write time: 331548 20:04:35 INFO - Running post-run listener: _upload_blobber_files 20:04:35 INFO - Blob upload gear active. 20:04:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:04:35 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 20:04:35 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:04:35 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:04:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:04:36 INFO - (blobuploader) - INFO - Done attempting. 20:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:04:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:04:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:04:39 INFO - (blobuploader) - INFO - Done attempting. 20:04:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:04:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:04:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:04:40 INFO - (blobuploader) - INFO - Done attempting. 20:04:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:04:40 INFO - Return code: 0 20:04:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:04:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:04:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/29023f7a6feda2d931e7c8256b1d91aaa7771aef126325624f82f40a5a88a9105822042e6a11e33defe072ded75df2252f27c111137e0ac50749907481bb1226", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bd6f63c0125ea6270549da228fc0ef9c4e34d53fbb0335d8b4c3e1cc478803f6d5b16af9c170a2603a356dec1c2bae34d65133b55592c1a96726bf8dcf42e8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a931154675818ed14674b82de35cfb7e2af7166a32e92f8f243f11a8aec74c268c8f97b27b3da547661219a876539cfa6e6e2611f774c8395a539e3a601cfe3"} 20:04:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:04:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:04:40 INFO - Contents: 20:04:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/29023f7a6feda2d931e7c8256b1d91aaa7771aef126325624f82f40a5a88a9105822042e6a11e33defe072ded75df2252f27c111137e0ac50749907481bb1226", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bd6f63c0125ea6270549da228fc0ef9c4e34d53fbb0335d8b4c3e1cc478803f6d5b16af9c170a2603a356dec1c2bae34d65133b55592c1a96726bf8dcf42e8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a931154675818ed14674b82de35cfb7e2af7166a32e92f8f243f11a8aec74c268c8f97b27b3da547661219a876539cfa6e6e2611f774c8395a539e3a601cfe3"} 20:04:40 INFO - Running post-run listener: copy_logs_to_upload_dir 20:04:40 INFO - Copying logs to upload dir... 20:04:40 INFO - mkdir: /builds/slave/test/build/upload/logs 20:04:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.508316 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-30 20:04:40.688532) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 20:04:40.692100) ========= 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=6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/29023f7a6feda2d931e7c8256b1d91aaa7771aef126325624f82f40a5a88a9105822042e6a11e33defe072ded75df2252f27c111137e0ac50749907481bb1226", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bd6f63c0125ea6270549da228fc0ef9c4e34d53fbb0335d8b4c3e1cc478803f6d5b16af9c170a2603a356dec1c2bae34d65133b55592c1a96726bf8dcf42e8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a931154675818ed14674b82de35cfb7e2af7166a32e92f8f243f11a8aec74c268c8f97b27b3da547661219a876539cfa6e6e2611f774c8395a539e3a601cfe3"} build_url:https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011709 build_url: 'https://queue.taskcluster.net/v1/task/fKg_RzrITPiVQIzuet8XyA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/29023f7a6feda2d931e7c8256b1d91aaa7771aef126325624f82f40a5a88a9105822042e6a11e33defe072ded75df2252f27c111137e0ac50749907481bb1226", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bd6f63c0125ea6270549da228fc0ef9c4e34d53fbb0335d8b4c3e1cc478803f6d5b16af9c170a2603a356dec1c2bae34d65133b55592c1a96726bf8dcf42e8a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a931154675818ed14674b82de35cfb7e2af7166a32e92f8f243f11a8aec74c268c8f97b27b3da547661219a876539cfa6e6e2611f774c8395a539e3a601cfe3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 20:04:40.718925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 20:04:40.719249) ========= 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=6dbc10da6d83fee962c624be000001a8-1480559182.977068-597162890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004375 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 20:04:40.801847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 20:04:40.802150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 20:04:40.802478) ========= ========= Total master_lag: 0.18 =========