builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1479327710.85 results: success (0) buildid: 20161116105708 builduid: 95ba28a1f38149bd8352cfdd3edb1c19 revision: cc3d0823289f64804fce57ac51a03b0b17d0189e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:50.850588) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:50.850966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:50.851233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:50.881042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:50.881330) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 12:21:51-- 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% 223M=0s 2016-11-16 12:21:51 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142929 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.038997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.039326) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015162 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.089699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.090125) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev cc3d0823289f64804fce57ac51a03b0b17d0189e --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 cc3d0823289f64804fce57ac51a03b0b17d0189e --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=934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 12:21:51,925 truncating revision to first 12 chars 2016-11-16 12:21:51,925 Setting DEBUG logging. 2016-11-16 12:21:51,925 attempt 1/10 2016-11-16 12:21:51,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/cc3d0823289f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 12:21:52,290 unpacking tar archive at: graphics-cc3d0823289f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.784277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.784646) ========= script_repo_revision: cc3d0823289f64804fce57ac51a03b0b17d0189e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.785025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.785319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 12:21:51.802013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-16 12:21:51.802368) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:21:52 INFO - MultiFileLogger online at 20161116 12:21:52 in /builds/slave/test 12:21:52 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 12:21:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:21:52 INFO - {'append_to_log': False, 12:21:52 INFO - 'base_work_dir': '/builds/slave/test', 12:21:52 INFO - 'blob_upload_branch': 'Graphics', 12:21:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:21:52 INFO - 'branch': 'Graphics', 12:21:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:21:52 INFO - 'config_files': ('talos/linux_config.py',), 12:21:52 INFO - 'default_actions': ('clobber', 12:21:52 INFO - 'read-buildbot-config', 12:21:52 INFO - 'download-and-extract', 12:21:52 INFO - 'populate-webroot', 12:21:52 INFO - 'create-virtualenv', 12:21:52 INFO - 'install', 12:21:52 INFO - 'run-tests'), 12:21:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:21:52 INFO - 'download_minidump_stackwalk': True, 12:21:52 INFO - 'download_symbols': 'ondemand', 12:21:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:21:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:21:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:21:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:21:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:21:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:21:52 INFO - 'installer_path': 'installer.exe', 12:21:52 INFO - 'log_level': 'info', 12:21:52 INFO - 'log_name': 'talos', 12:21:52 INFO - 'log_to_console': True, 12:21:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:21:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:21:52 INFO - 'opt_config_files': (), 12:21:52 INFO - 'pip_index': False, 12:21:52 INFO - 'sps_profile': False, 12:21:52 INFO - 'sps_profile_interval': 0, 12:21:52 INFO - 'suite': 'dromaeojs', 12:21:52 INFO - 'system_bits': '32', 12:21:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:21:52 INFO - 'title': 'talos-linux64-ix-057', 12:21:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:21:52 INFO - 'use_talos_json': True, 12:21:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:21:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:21:52 INFO - 'work_dir': 'build'} 12:21:52 INFO - [mozharness: 2016-11-16 20:21:52.735149Z] Running clobber step. 12:21:52 INFO - Running pre-action listener: _resource_record_pre_action 12:21:52 INFO - Running main action method: clobber 12:21:52 INFO - rmtree: /builds/slave/test/build 12:21:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:21:53 INFO - Running post-action listener: _resource_record_post_action 12:21:53 INFO - [mozharness: 2016-11-16 20:21:53.210331Z] Finished clobber step (success) 12:21:53 INFO - [mozharness: 2016-11-16 20:21:53.210429Z] Running read-buildbot-config step. 12:21:53 INFO - Running pre-action listener: _resource_record_pre_action 12:21:53 INFO - Running main action method: read_buildbot_config 12:21:53 INFO - Using buildbot properties: 12:21:53 INFO - { 12:21:53 INFO - "project": "", 12:21:53 INFO - "product": "firefox", 12:21:53 INFO - "script_repo_revision": "default", 12:21:53 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 12:21:53 INFO - "repository": "", 12:21:53 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 12:21:53 INFO - "buildid": "20161116105708", 12:21:53 INFO - "pgo_build": "False", 12:21:53 INFO - "basedir": "/builds/slave/test", 12:21:53 INFO - "buildnumber": 2, 12:21:53 INFO - "slavename": "talos-linux64-ix-057", 12:21:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:21:53 INFO - "platform": "ubuntu64_hw", 12:21:53 INFO - "scheduler": "tests-graphics-linux64-talos", 12:21:53 INFO - "branch": "graphics", 12:21:53 INFO - "repo_path": "projects/graphics", 12:21:53 INFO - "revision": "cc3d0823289f64804fce57ac51a03b0b17d0189e", 12:21:53 INFO - "stage_platform": "linux64", 12:21:53 INFO - "builduid": "95ba28a1f38149bd8352cfdd3edb1c19", 12:21:53 INFO - "slavebuilddir": "test" 12:21:53 INFO - } 12:21:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:21:53 INFO - Running post-action listener: _resource_record_post_action 12:21:53 INFO - [mozharness: 2016-11-16 20:21:53.212840Z] Finished read-buildbot-config step (success) 12:21:53 INFO - [mozharness: 2016-11-16 20:21:53.212925Z] Running download-and-extract step. 12:21:53 INFO - Running pre-action listener: _resource_record_pre_action 12:21:53 INFO - Running main action method: download_and_extract 12:21:53 INFO - mkdir: /builds/slave/test/build/tests 12:21:53 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')]} 12:21:53 INFO - trying https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:21:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/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 12:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/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 12:21:53 INFO - Downloaded 1361 bytes. 12:21:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:21:53 INFO - Using the following test package requirements: 12:21:53 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:21:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:21:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:21:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'jsshell-linux-x86_64.zip'], 12:21:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:21:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:21:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:21:53 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:21:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:21:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:21:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:21:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:21:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:21:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:21:53 INFO - Fetch https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:21:54 INFO - Http code: 200 12:21:54 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 12:21:54 INFO - x-amz-cf-id: Ic5F4w8y6AAbepJYseeA_wd4CAHVZzb5Uh8WvPFgI63GHrc_zExMJA== 12:21:54 INFO - x-amz-version-id: i4ZtwkBPMEb33ONr9rBZHNnHEe5_y8vF 12:21:54 INFO - Expected file size: 20353917 12:21:54 INFO - Obtained file size: 20353917 12:21:58 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 12:21:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:21:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:21:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:21:59 INFO - Http code: 200 12:21:59 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 12:21:59 INFO - x-amz-cf-id: 4-GbIbFvwtL1f0OTW_rFFFYdlDV0XAMuKQkzLiJTTGp3Tx0oRkl9mg== 12:21:59 INFO - x-amz-version-id: i4ZtwkBPMEb33ONr9rBZHNnHEe5_y8vF 12:21:59 INFO - Expected file size: 20353917 12:21:59 INFO - Obtained file size: 20353917 12:22:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:22:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:22:04 INFO - Fetch https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:22:04 INFO - Http code: 200 12:22:04 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 12:22:04 INFO - x-amz-cf-id: OPxLab_gcNtsfKZ9xyXKyOQXnoAAfO8vTSdWieAEznpYN5wK0qoTvQ== 12:22:04 INFO - x-amz-version-id: 1UB.58.IC_tN7Pbwk7qY.o8ku3IZXvNV 12:22:04 INFO - Expected file size: 14409366 12:22:04 INFO - Obtained file size: 14409366 12:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:05 INFO - trying https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/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 12:22:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/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 12:22:06 INFO - Downloaded 55753858 bytes. 12:22:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:06 INFO - mkdir: /builds/slave/test/properties 12:22:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:22:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:22:06 INFO - Contents: 12:22:06 INFO - build_url:https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:22:06 INFO - Running post-action listener: _resource_record_post_action 12:22:06 INFO - Running post-action listener: set_extra_try_arguments 12:22:06 INFO - [mozharness: 2016-11-16 20:22:06.882182Z] Finished download-and-extract step (success) 12:22:06 INFO - [mozharness: 2016-11-16 20:22:06.882481Z] Running populate-webroot step. 12:22:06 INFO - Running pre-action listener: _resource_record_pre_action 12:22:06 INFO - Running main action method: populate_webroot 12:22:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:22:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:22:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:22:06 INFO - '--tppagecycles', 12:22:06 INFO - '7'], 12:22:06 INFO - 'tests': ['tsvgm']}}, 12:22:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:22:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:22:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:22:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:22:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['damp', 'tps']}, 12:22:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'tests': ['damp', 'tps']}, 12:22:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['dromaeo_dom']}, 12:22:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:22:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['basic_compositor_video']}, 12:22:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:22:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['a11yr', 12:22:06 INFO - 'ts_paint', 12:22:06 INFO - 'tpaint', 12:22:06 INFO - 'sessionrestore', 12:22:06 INFO - 'sessionrestore_no_auto_restore', 12:22:06 INFO - 'tabpaint']}, 12:22:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:22:06 INFO - 'ts_paint', 12:22:06 INFO - 'tpaint', 12:22:06 INFO - 'sessionrestore', 12:22:06 INFO - 'sessionrestore_no_auto_restore', 12:22:06 INFO - 'tabpaint']}, 12:22:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:22:06 INFO - 'ts_paint', 12:22:06 INFO - 'tpaint', 12:22:06 INFO - 'sessionrestore', 12:22:06 INFO - 'sessionrestore_no_auto_restore', 12:22:06 INFO - 'tabpaint']}, 12:22:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:22:06 INFO - 'ts_paint', 12:22:06 INFO - 'tpaint', 12:22:06 INFO - 'sessionrestore', 12:22:06 INFO - 'sessionrestore_no_auto_restore', 12:22:06 INFO - 'tabpaint']}, 12:22:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['a11yr', 12:22:06 INFO - 'ts_paint', 12:22:06 INFO - 'tpaint', 12:22:06 INFO - 'sessionrestore', 12:22:06 INFO - 'sessionrestore_no_auto_restore', 12:22:06 INFO - 'tabpaint']}, 12:22:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['a11yr', 12:22:06 INFO - 'ts_paint', 12:22:06 INFO - 'tpaint', 12:22:06 INFO - 'sessionrestore', 12:22:06 INFO - 'sessionrestore_no_auto_restore', 12:22:06 INFO - 'tabpaint']}, 12:22:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['tsvgx', 12:22:06 INFO - 'tsvgr_opacity', 12:22:06 INFO - 'tart', 12:22:06 INFO - 'tscrollx', 12:22:06 INFO - 'cart']}, 12:22:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:22:06 INFO - 'tsvgr_opacity', 12:22:06 INFO - 'tart', 12:22:06 INFO - 'tscrollx', 12:22:06 INFO - 'cart']}, 12:22:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'talos_options': ['--disable-e10s'], 12:22:06 INFO - 'tests': ['tp5o']}, 12:22:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:22:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'talos_options': ['--disable-e10s', 12:22:06 INFO - '--xperf_path', 12:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:06 INFO - 'tests': ['tp5n']}, 12:22:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:22:06 INFO - 'talos_options': ['--xperf_path', 12:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:06 INFO - 'tests': ['tp5n']}}, 12:22:06 INFO - 'talos.zip': {'path': '', 12:22:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:22:06 INFO - Running post-action listener: _resource_record_post_action 12:22:06 INFO - [mozharness: 2016-11-16 20:22:06.902865Z] Finished populate-webroot step (success) 12:22:06 INFO - [mozharness: 2016-11-16 20:22:06.902958Z] Running create-virtualenv step. 12:22:06 INFO - Running pre-action listener: _resource_record_pre_action 12:22:06 INFO - Running main action method: create_virtualenv 12:22:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:22:06 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 12:22:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:22:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:22:07 INFO - Using real prefix '/usr' 12:22:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:22:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:22:09 INFO - Installing pip.................done. 12:22:09 INFO - Return code: 0 12:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:22:09 INFO - Reading from file tmpfile_stdout 12:22:09 INFO - Output received: 12:22:09 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) 12:22:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:22:09 INFO - Using env: {'DISPLAY': ':0', 12:22:09 INFO - 'HOME': '/home/cltbld', 12:22:09 INFO - 'LANG': 'en_US.UTF-8', 12:22:09 INFO - 'LANGUAGE': 'en_US:en', 12:22:09 INFO - 'LOGNAME': 'cltbld', 12:22:09 INFO - 'MAIL': '/var/mail/cltbld', 12:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:09 INFO - 'MOZ_NO_REMOTE': '1', 12:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:09 INFO - 'NO_EM_RESTART': '1', 12:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:09 INFO - 'PWD': '/builds/slave/test', 12:22:09 INFO - 'SHELL': '/bin/bash', 12:22:09 INFO - 'SHLVL': '1', 12:22:09 INFO - 'TERM': 'linux', 12:22:09 INFO - 'TMOUT': '86400', 12:22:09 INFO - 'USER': 'cltbld', 12:22:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:09 INFO - '_': '/tools/buildbot/bin/python'} 12:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:09 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 12:22:09 INFO - Cleaning up... 12:22:09 INFO - Return code: 0 12:22:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:22:09 INFO - Using env: {'DISPLAY': ':0', 12:22:09 INFO - 'HOME': '/home/cltbld', 12:22:09 INFO - 'LANG': 'en_US.UTF-8', 12:22:09 INFO - 'LANGUAGE': 'en_US:en', 12:22:09 INFO - 'LOGNAME': 'cltbld', 12:22:09 INFO - 'MAIL': '/var/mail/cltbld', 12:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:09 INFO - 'MOZ_NO_REMOTE': '1', 12:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:09 INFO - 'NO_EM_RESTART': '1', 12:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:09 INFO - 'PWD': '/builds/slave/test', 12:22:09 INFO - 'SHELL': '/bin/bash', 12:22:09 INFO - 'SHLVL': '1', 12:22:09 INFO - 'TERM': 'linux', 12:22:09 INFO - 'TMOUT': '86400', 12:22:09 INFO - 'USER': 'cltbld', 12:22:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:09 INFO - '_': '/tools/buildbot/bin/python'} 12:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:10 INFO - Downloading/unpacking psutil>=3.1.1 12:22:10 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 12:22:10 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 12:22:10 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 12:22:10 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 12:22:10 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 12:22:10 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 12:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:12 INFO - Installing collected packages: psutil 12:22:12 INFO - Running setup.py install for psutil 12:22:12 INFO - building 'psutil._psutil_linux' extension 12:22:12 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 12:22:12 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 12:22:12 INFO - building 'psutil._psutil_posix' extension 12:22:12 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 12:22:12 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 12:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:12 INFO - Successfully installed psutil 12:22:12 INFO - Cleaning up... 12:22:12 INFO - Return code: 0 12:22:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:22:12 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')]} 12:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:12 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')]} 12:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:12 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:12 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 12:22:12 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 12:22:12 INFO - Using env: {'DISPLAY': ':0', 12:22:12 INFO - 'HOME': '/home/cltbld', 12:22:12 INFO - 'LANG': 'en_US.UTF-8', 12:22:12 INFO - 'LANGUAGE': 'en_US:en', 12:22:12 INFO - 'LOGNAME': 'cltbld', 12:22:12 INFO - 'MAIL': '/var/mail/cltbld', 12:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:12 INFO - 'MOZ_NO_REMOTE': '1', 12:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:12 INFO - 'NO_EM_RESTART': '1', 12:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:12 INFO - 'PWD': '/builds/slave/test', 12:22:12 INFO - 'SHELL': '/bin/bash', 12:22:12 INFO - 'SHLVL': '1', 12:22:12 INFO - 'TERM': 'linux', 12:22:12 INFO - 'TMOUT': '86400', 12:22:12 INFO - 'USER': 'cltbld', 12:22:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:12 INFO - '_': '/tools/buildbot/bin/python'} 12:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:22:12 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 12:22:12 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 12:22:12 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 12:22:12 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 12:22:12 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 12:22:12 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 12:22:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:22:14 INFO - Installing collected packages: mozsystemmonitor 12:22:14 INFO - Running setup.py install for mozsystemmonitor 12:22:14 INFO - Successfully installed mozsystemmonitor 12:22:14 INFO - Cleaning up... 12:22:15 INFO - Return code: 0 12:22:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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', '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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:22: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 jsonschema==2.5.1 12:22:15 INFO - Using env: {'DISPLAY': ':0', 12:22:15 INFO - 'HOME': '/home/cltbld', 12:22:15 INFO - 'LANG': 'en_US.UTF-8', 12:22:15 INFO - 'LANGUAGE': 'en_US:en', 12:22:15 INFO - 'LOGNAME': 'cltbld', 12:22:15 INFO - 'MAIL': '/var/mail/cltbld', 12:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:15 INFO - 'MOZ_NO_REMOTE': '1', 12:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:15 INFO - 'NO_EM_RESTART': '1', 12:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:15 INFO - 'PWD': '/builds/slave/test', 12:22:15 INFO - 'SHELL': '/bin/bash', 12:22:15 INFO - 'SHLVL': '1', 12:22:15 INFO - 'TERM': 'linux', 12:22:15 INFO - 'TMOUT': '86400', 12:22:15 INFO - 'USER': 'cltbld', 12:22:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:15 INFO - '_': '/tools/buildbot/bin/python'} 12:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:22:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:22:17 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 12:22:17 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 12:22:17 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 12:22:17 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 12:22:17 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 12:22:17 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 12:22:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:22:17 INFO - warning: no files found matching '*.txt' 12:22:17 INFO - no previously-included directories found matching 'build' 12:22:17 INFO - no previously-included directories found matching 'dist' 12:22:17 INFO - no previously-included directories found matching '.git*' 12:22:17 INFO - Installing collected packages: jsonschema, functools32 12:22:17 INFO - Running setup.py install for functools32 12:22:17 INFO - warning: no files found matching '*.txt' 12:22:17 INFO - no previously-included directories found matching 'build' 12:22:17 INFO - no previously-included directories found matching 'dist' 12:22:17 INFO - no previously-included directories found matching '.git*' 12:22:17 INFO - Successfully installed jsonschema functools32 12:22:17 INFO - Cleaning up... 12:22:17 INFO - Return code: 0 12:22:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:17 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:17 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 12:22:17 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 12:22:17 INFO - Using env: {'DISPLAY': ':0', 12:22:17 INFO - 'HOME': '/home/cltbld', 12:22:17 INFO - 'LANG': 'en_US.UTF-8', 12:22:17 INFO - 'LANGUAGE': 'en_US:en', 12:22:17 INFO - 'LOGNAME': 'cltbld', 12:22:17 INFO - 'MAIL': '/var/mail/cltbld', 12:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:17 INFO - 'MOZ_NO_REMOTE': '1', 12:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:17 INFO - 'NO_EM_RESTART': '1', 12:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:17 INFO - 'PWD': '/builds/slave/test', 12:22:17 INFO - 'SHELL': '/bin/bash', 12:22:17 INFO - 'SHLVL': '1', 12:22:17 INFO - 'TERM': 'linux', 12:22:17 INFO - 'TMOUT': '86400', 12:22:17 INFO - 'USER': 'cltbld', 12:22:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:17 INFO - '_': '/tools/buildbot/bin/python'} 12:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:22:17 INFO - Cleaning up... 12:22:17 INFO - Return code: 0 12:22:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:17 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:17 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 12:22:17 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 12:22:17 INFO - Using env: {'DISPLAY': ':0', 12:22:17 INFO - 'HOME': '/home/cltbld', 12:22:17 INFO - 'LANG': 'en_US.UTF-8', 12:22:17 INFO - 'LANGUAGE': 'en_US:en', 12:22:17 INFO - 'LOGNAME': 'cltbld', 12:22:17 INFO - 'MAIL': '/var/mail/cltbld', 12:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:17 INFO - 'MOZ_NO_REMOTE': '1', 12:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:17 INFO - 'NO_EM_RESTART': '1', 12:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:17 INFO - 'PWD': '/builds/slave/test', 12:22:17 INFO - 'SHELL': '/bin/bash', 12:22:17 INFO - 'SHLVL': '1', 12:22:17 INFO - 'TERM': 'linux', 12:22:17 INFO - 'TMOUT': '86400', 12:22:17 INFO - 'USER': 'cltbld', 12:22:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:17 INFO - '_': '/tools/buildbot/bin/python'} 12:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22: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 12:22:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:22:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:22:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 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 12:22:20 INFO - Downloading docopt-0.6.1.tar.gz 12:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:22:20 INFO - Installing collected packages: blobuploader, requests, docopt 12:22:20 INFO - Running setup.py install for blobuploader 12:22:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:22:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:22:20 INFO - Running setup.py install for requests 12:22:21 INFO - Running setup.py install for docopt 12:22:21 INFO - Successfully installed blobuploader requests docopt 12:22:21 INFO - Cleaning up... 12:22:21 INFO - Return code: 0 12:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:21 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')]} 12:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:21 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')]} 12:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:21 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:21 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 12:22:21 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 12:22:21 INFO - Using env: {'DISPLAY': ':0', 12:22:21 INFO - 'HOME': '/home/cltbld', 12:22:21 INFO - 'LANG': 'en_US.UTF-8', 12:22:21 INFO - 'LANGUAGE': 'en_US:en', 12:22:21 INFO - 'LOGNAME': 'cltbld', 12:22:21 INFO - 'MAIL': '/var/mail/cltbld', 12:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:21 INFO - 'MOZ_NO_REMOTE': '1', 12:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:21 INFO - 'NO_EM_RESTART': '1', 12:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:21 INFO - 'PWD': '/builds/slave/test', 12:22:21 INFO - 'SHELL': '/bin/bash', 12:22:21 INFO - 'SHLVL': '1', 12:22:21 INFO - 'TERM': 'linux', 12:22:21 INFO - 'TMOUT': '86400', 12:22:21 INFO - 'USER': 'cltbld', 12:22:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:21 INFO - '_': '/tools/buildbot/bin/python'} 12:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:21 INFO - Running setup.py (path:/tmp/pip-zFi1Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:21 INFO - Running setup.py (path:/tmp/pip-u2W_De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:21 INFO - Running setup.py (path:/tmp/pip-MbPv2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:21 INFO - Running setup.py (path:/tmp/pip-CHY9nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:21 INFO - Running setup.py (path:/tmp/pip-f8rQwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:21 INFO - Running setup.py (path:/tmp/pip-nGV0R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:22 INFO - Running setup.py (path:/tmp/pip-U7o8lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:22 INFO - Running setup.py (path:/tmp/pip-VfnLfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:22 INFO - Running setup.py (path:/tmp/pip-tUmGIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:22 INFO - Running setup.py (path:/tmp/pip-o9Ss3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:22 INFO - Running setup.py (path:/tmp/pip-KVNB1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:22 INFO - Running setup.py (path:/tmp/pip-TC0hYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:22 INFO - Running setup.py (path:/tmp/pip-TBKlgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:22 INFO - Running setup.py (path:/tmp/pip-hP7w6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:22 INFO - Running setup.py (path:/tmp/pip-3Oi3is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:22 INFO - Running setup.py (path:/tmp/pip-kcBrsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:22 INFO - Running setup.py (path:/tmp/pip-nkxjS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:22:22 INFO - Running setup.py install for manifestparser 12:22:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:22:22 INFO - Running setup.py install for mozcrash 12:22:23 INFO - Running setup.py install for mozdebug 12:22:23 INFO - Running setup.py install for mozdevice 12:22:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Running setup.py install for mozfile 12:22:23 INFO - Running setup.py install for mozhttpd 12:22:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Running setup.py install for mozinfo 12:22:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Running setup.py install for mozInstall 12:22:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Running setup.py install for mozleak 12:22:23 INFO - Running setup.py install for mozlog 12:22:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Running setup.py install for moznetwork 12:22:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:22:23 INFO - Running setup.py install for mozprocess 12:22:24 INFO - Running setup.py install for mozprofile 12:22:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:22:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:22:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:22:24 INFO - Running setup.py install for mozrunner 12:22:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:22:24 INFO - Running setup.py install for mozscreenshot 12:22:24 INFO - Running setup.py install for moztest 12:22:24 INFO - Running setup.py install for mozversion 12:22:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:22:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:22:24 INFO - Cleaning up... 12:22:24 INFO - Return code: 0 12:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:24 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:24 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 12:22:24 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 12:22:24 INFO - Using env: {'DISPLAY': ':0', 12:22:24 INFO - 'HOME': '/home/cltbld', 12:22:24 INFO - 'LANG': 'en_US.UTF-8', 12:22:24 INFO - 'LANGUAGE': 'en_US:en', 12:22:24 INFO - 'LOGNAME': 'cltbld', 12:22:24 INFO - 'MAIL': '/var/mail/cltbld', 12:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:24 INFO - 'MOZ_NO_REMOTE': '1', 12:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:24 INFO - 'NO_EM_RESTART': '1', 12:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:24 INFO - 'PWD': '/builds/slave/test', 12:22:24 INFO - 'SHELL': '/bin/bash', 12:22:24 INFO - 'SHLVL': '1', 12:22:24 INFO - 'TERM': 'linux', 12:22:24 INFO - 'TMOUT': '86400', 12:22:24 INFO - 'USER': 'cltbld', 12:22:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:24 INFO - '_': '/tools/buildbot/bin/python'} 12:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:22:24 INFO - Running setup.py (path:/tmp/pip-ckmxgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:22:24 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)) 12:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:22:24 INFO - Running setup.py (path:/tmp/pip-0a5Fc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:22:25 INFO - Running setup.py (path:/tmp/pip-8ojzfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:22:25 INFO - Running setup.py (path:/tmp/pip-9oaYQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:22:25 INFO - Running setup.py (path:/tmp/pip-jvDnfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:22:25 INFO - Running setup.py (path:/tmp/pip-L3Ntle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:22:25 INFO - Running setup.py (path:/tmp/pip-ZeViQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:22:25 INFO - Running setup.py (path:/tmp/pip-JR7yeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:22:25 INFO - Running setup.py (path:/tmp/pip-XZlKDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:22:25 INFO - Running setup.py (path:/tmp/pip-dlHIxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:22:25 INFO - Running setup.py (path:/tmp/pip-LXf4R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:22:25 INFO - Running setup.py (path:/tmp/pip-41HWiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:22:25 INFO - Running setup.py (path:/tmp/pip-sPw4Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:22:25 INFO - Running setup.py (path:/tmp/pip-4ncJjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:25 INFO - Running setup.py (path:/tmp/pip-Qhei9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:22:25 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)) 12:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:22:25 INFO - Running setup.py (path:/tmp/pip-JysNCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:22:26 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)) 12:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:22:26 INFO - Running setup.py (path:/tmp/pip-7V4qoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:22:26 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)) 12:22:26 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)) 12:22:26 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)) 12:22:26 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)) 12:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:22:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:28 INFO - Downloading blessings-1.6.tar.gz 12:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:22:28 INFO - Installing collected packages: blessings 12:22:28 INFO - Running setup.py install for blessings 12:22:28 INFO - Successfully installed blessings 12:22:28 INFO - Cleaning up... 12:22:28 INFO - Return code: 0 12:22:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:28 INFO - Reading from file tmpfile_stdout 12:22:28 INFO - Current package versions: 12:22:28 INFO - argparse == 1.2.1 12:22:28 INFO - blessings == 1.6 12:22:28 INFO - blobuploader == 1.2.4 12:22:28 INFO - docopt == 0.6.1 12:22:28 INFO - functools32 == 3.2.3-2 12:22:28 INFO - jsonschema == 2.5.1 12:22:28 INFO - manifestparser == 1.1 12:22:28 INFO - mozInstall == 1.12 12:22:28 INFO - mozcrash == 1.0 12:22:28 INFO - mozdebug == 0.1 12:22:28 INFO - mozdevice == 0.48 12:22:28 INFO - mozfile == 1.2 12:22:28 INFO - mozhttpd == 0.7 12:22:28 INFO - mozinfo == 0.9 12:22:28 INFO - mozleak == 0.1 12:22:28 INFO - mozlog == 3.4 12:22:28 INFO - moznetwork == 0.27 12:22:28 INFO - mozprocess == 0.23 12:22:28 INFO - mozprofile == 0.28 12:22:28 INFO - mozrunner == 6.13 12:22:28 INFO - mozscreenshot == 0.1 12:22:28 INFO - mozsystemmonitor == 0.3 12:22:28 INFO - moztest == 0.7 12:22:28 INFO - mozversion == 1.4 12:22:28 INFO - psutil == 3.1.1 12:22:28 INFO - requests == 1.2.3 12:22:28 INFO - wsgiref == 0.1.2 12:22:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:22:28 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')]} 12:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:28 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')]} 12:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:28 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:28 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 12:22:28 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 12:22:28 INFO - Using env: {'DISPLAY': ':0', 12:22:28 INFO - 'HOME': '/home/cltbld', 12:22:28 INFO - 'LANG': 'en_US.UTF-8', 12:22:28 INFO - 'LANGUAGE': 'en_US:en', 12:22:28 INFO - 'LOGNAME': 'cltbld', 12:22:28 INFO - 'MAIL': '/var/mail/cltbld', 12:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:28 INFO - 'MOZ_NO_REMOTE': '1', 12:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:28 INFO - 'NO_EM_RESTART': '1', 12:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:28 INFO - 'PWD': '/builds/slave/test', 12:22:28 INFO - 'SHELL': '/bin/bash', 12:22:28 INFO - 'SHLVL': '1', 12:22:28 INFO - 'TERM': 'linux', 12:22:28 INFO - 'TMOUT': '86400', 12:22:28 INFO - 'USER': 'cltbld', 12:22:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:28 INFO - '_': '/tools/buildbot/bin/python'} 12:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 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)) 12:22:28 INFO - Cleaning up... 12:22:28 INFO - Return code: 0 12:22:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:22:28 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')]} 12:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:28 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')]} 12:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:28 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 0x7f970fc63e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf19130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', '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 12:22:28 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 12:22:28 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 12:22:28 INFO - Using env: {'DISPLAY': ':0', 12:22:28 INFO - 'HOME': '/home/cltbld', 12:22:28 INFO - 'LANG': 'en_US.UTF-8', 12:22:28 INFO - 'LANGUAGE': 'en_US:en', 12:22:28 INFO - 'LOGNAME': 'cltbld', 12:22:28 INFO - 'MAIL': '/var/mail/cltbld', 12:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:28 INFO - 'MOZ_NO_REMOTE': '1', 12:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:28 INFO - 'NO_EM_RESTART': '1', 12:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:28 INFO - 'PWD': '/builds/slave/test', 12:22:28 INFO - 'SHELL': '/bin/bash', 12:22:28 INFO - 'SHLVL': '1', 12:22:28 INFO - 'TERM': 'linux', 12:22:28 INFO - 'TMOUT': '86400', 12:22:28 INFO - 'USER': 'cltbld', 12:22:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:28 INFO - '_': '/tools/buildbot/bin/python'} 12:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:22:28 INFO - Cleaning up... 12:22:28 INFO - Return code: 0 12:22:28 INFO - Running post-action listener: _resource_record_post_action 12:22:28 INFO - Running post-action listener: _start_resource_monitoring 12:22:29 INFO - Starting resource monitoring. 12:22:29 INFO - [mozharness: 2016-11-16 20:22:29.024677Z] Finished create-virtualenv step (success) 12:22:29 INFO - [mozharness: 2016-11-16 20:22:29.025196Z] Running install step. 12:22:29 INFO - Running pre-action listener: _resource_record_pre_action 12:22:29 INFO - Running main action method: install 12:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:22:29 INFO - Reading from file tmpfile_stdout 12:22:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:22:29 INFO - Reading from file tmpfile_stdout 12:22:29 INFO - Output received: 12:22:29 INFO - Usage: mozinstall [options] installer 12:22:29 INFO - Options: 12:22:29 INFO - -h, --help show this help message and exit 12:22:29 INFO - -d DEST, --destination=DEST 12:22:29 INFO - Directory to install application into. [default: 12:22:29 INFO - "/builds/slave/test"] 12:22:29 INFO - --app=APP Application being installed. [default: firefox] 12:22:29 INFO - mkdir: /builds/slave/test/build/application 12:22:29 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'] 12:22:29 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 12:22:45 INFO - Reading from file tmpfile_stdout 12:22:45 INFO - Output received: 12:22:45 INFO - /builds/slave/test/build/application/firefox/firefox 12:22:45 INFO - Running post-action listener: _resource_record_post_action 12:22:45 INFO - [mozharness: 2016-11-16 20:22:45.457722Z] Finished install step (success) 12:22:45 INFO - [mozharness: 2016-11-16 20:22:45.457964Z] Running run-tests step. 12:22:45 INFO - Running pre-action listener: _resource_record_pre_action 12:22:45 INFO - Running main action method: run_tests 12:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:22:45 INFO - Python 2.7.3 12:22:45 INFO - Return code: 0 12:22:45 INFO - grabbing minidump binary from tooltool 12:22:45 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')]} 12:22:45 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 0xfa7fc0>, '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 0xfa8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa9350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:22:45 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 12:22:45 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 12:22:45 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 12:22:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:22:45 INFO - Return code: 0 12:22:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:22:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:22:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:22:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:22:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:22:45 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/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 12:22:45 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/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 12:22:45 INFO - Using env: {'DISPLAY': ':0', 12:22:45 INFO - 'HOME': '/home/cltbld', 12:22:45 INFO - 'LANG': 'en_US.UTF-8', 12:22:45 INFO - 'LANGUAGE': 'en_US:en', 12:22:45 INFO - 'LOGNAME': 'cltbld', 12:22:45 INFO - 'MAIL': '/var/mail/cltbld', 12:22:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:22:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:45 INFO - 'MOZ_NO_REMOTE': '1', 12:22:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:45 INFO - 'NO_EM_RESTART': '1', 12:22:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:45 INFO - 'PWD': '/builds/slave/test', 12:22:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:22:45 INFO - 'SHELL': '/bin/bash', 12:22:45 INFO - 'SHLVL': '1', 12:22:45 INFO - 'TERM': 'linux', 12:22:45 INFO - 'TMOUT': '86400', 12:22:45 INFO - 'USER': 'cltbld', 12:22:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842', 12:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:45 INFO - '_': '/tools/buildbot/bin/python'} 12:22:45 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/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 12:22:45 INFO - mozversion application_buildid: 20161116105708 12:22:45 INFO - mozversion application_changeset: cc3d0823289f64804fce57ac51a03b0b17d0189e 12:22:45 INFO - mozversion application_display_name: Nightly 12:22:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:22:45 INFO - mozversion application_name: Firefox 12:22:45 INFO - mozversion application_remotingname: firefox 12:22:45 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:22:45 INFO - mozversion application_vendor: Mozilla 12:22:45 INFO - mozversion application_version: 53.0a1 12:22:45 INFO - mozversion platform_buildid: 20161116105708 12:22:45 INFO - mozversion platform_changeset: cc3d0823289f64804fce57ac51a03b0b17d0189e 12:22:45 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:22:45 INFO - mozversion platform_version: 53.0a1 12:22:45 INFO - using testdate: 1479327765 12:22:45 INFO - actual date: 1479327765 12:22:45 INFO - starting webserver on 'localhost:41509' 12:22:45 INFO - SUITE-START | Running 2 tests 12:22:45 INFO - TEST-START | dromaeo_css 12:22:45 INFO - operating with platform_type : linux_ 12:22:45 INFO - Initialising browser for dromaeo_css test... 12:22:45 INFO - TEST-INFO | started process 6105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCvpwQT/profile http://localhost:41509/getInfo.html) 12:22:50 INFO - PROCESS | 6105 | __metrics Screen width/height:1600/1200 12:22:50 INFO - PROCESS | 6105 | colorDepth:24 12:22:50 INFO - PROCESS | 6105 | Browser inner width/height: 1024/697 12:22:50 INFO - PROCESS | 6105 | __metrics 12:22:50 INFO - PROCESS | 6105 | 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" 12:22:50 INFO - PROCESS | 6105 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:22:51 INFO - PROCESS | 6105 | console.error: PushService: 12:22:51 INFO - PROCESS | 6105 | stateChangeProcessEnqueue: Error transitioning state 12:22:51 INFO - PROCESS | 6105 | UnknownError 12:22:52 INFO - TEST-INFO | 6105: exit 0 12:22:52 INFO - Browser initialized. 12:22:52 INFO - Running cycle 1/1 for dromaeo_css test... 12:22:52 INFO - TEST-INFO | started process 6186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCvpwQT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:04 INFO - PROCESS | 6186 | RSS: Main: 175599616 12:23:04 INFO - PROCESS | 6186 | 12:23:55 INFO - PROCESS | 6186 | 1479327835709 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] 12:26:10 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:41509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41509/tests/dromaeo/cssquery-ext.html) 12:26:11 INFO - PROCESS | 6186 | RSS: Main: 303693824 12:26:11 INFO - PROCESS | 6186 | 12:29:14 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:41509/tests/dromaeo/cssquery-ext.html (next: http://localhost:41509/tests/dromaeo/cssquery-jquery.html) 12:29:15 INFO - PROCESS | 6186 | RSS: Main: 278310912 12:29:15 INFO - PROCESS | 6186 | 12:32:17 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:41509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41509/tests/dromaeo/cssquery-mootools.html) 12:32:17 INFO - PROCESS | 6186 | RSS: Main: 223096832 12:32:17 INFO - PROCESS | 6186 | 12:35:20 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:41509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41509/tests/dromaeo/cssquery-prototype.html) 12:35:20 INFO - PROCESS | 6186 | RSS: Main: 230559744 12:35:20 INFO - PROCESS | 6186 | 12:38:24 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:41509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41509/tests/dromaeo/cssquery-yui.html) 12:38:24 INFO - PROCESS | 6186 | RSS: Main: 221491200 12:38:24 INFO - PROCESS | 6186 | 12:41:27 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:41509/tests/dromaeo/cssquery-yui.html (next: http://localhost:41509/tests/dromaeo/cssquery-dojo.html) 12:41:28 INFO - PROCESS | 6186 | RSS: Main: 309288960 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | __start_tp_report 12:41:28 INFO - PROCESS | 6186 | _x_x_mozilla_page_load 12:41:28 INFO - PROCESS | 6186 | _x_x_mozilla_page_load_details 12:41:28 INFO - PROCESS | 6186 | |i|pagename|runs| 12:41:28 INFO - PROCESS | 6186 | |0;dojo.html;2576.8196226264163;2606.8696565171736;2622.868856557173;2623.9344016399596;2632.9078482253126;4569.977150114253;4643.280291554806;4703.788329525171;4726.810927562898;4731.692439991402;4629.699069560476;4655.301704744282;4696.225122854725;4724;4803.039392121572;4273.166732487166;4290.957090429087;4329.047609525915;4354.3468479728135;4366.388705581221;4389.670774691895;4394.824207031715;4417.668674849383;4443.266860967937;4473.105378924212;4204.033072393336;4417.403650507173;4424.823007079713;4444.688871778977;4526.660500462479;4246.681498887596;4313.266744653416;4322.740635561876;4328.675349348811;4331.155424692186;4249.213895429355;4267.594578515036;4306.35404689296;4308.3968244445805;4312.762798046107;4683.437987441494;4722.220833562458;4730.739809310487;4733.526647335273;4751.049790042005;5007.2489126630935;5012.498750124995;5015.949840501585;5018.548330650259;5059.468755780626;4889.413270407574;5043.041822053798;5047.621428392885;5052.368453943257;5105.923411148836;4633;4692.929606055912;4708.199606066977;4758.619310455155;4828.106800241896;5212.374515058217;5245.659032162897;5249.921251181236;5257.474252574789;5292.311999440049;4991.201407774739;5010.774515146754;5031.195008798648;5041.193409054534;5080.390353157644;4847.903041939141;4879.2925025871045;4879.853604391874;5044.117279476077;5121.103806833789;5020.2720605511995;5095.337606111182;5095.566876815438;5116.258142569307;5135.075686376488;5094.923576146361;5099.69401835891;5106.923396149061;5113.488651134857;5145.3568303962;4090.5909409058854;4282.764447955392;4292.248856450109;4294.377315289265;4344.044310251739;3654.561452625702;3710.8144592770254;3712.2575484903127;3727.6645101940953;3761.097336639242;4392.516823149451;4393.450818647669;4398.054418300081;4422.425084738963;4427.512973572904;5130.666506677054;5133.332666753373;5141.2288156776785;5142.04872098663;5149.253358263031;4161.500619925568;4246.363045543131;4319.67602429819;4378.8029538670835;4380.62764665007;4555.681102322872;4596.080783843177;4597.126545956257;4627.1439783640135;4633.467151277646;4824.469308376006;4827.758612069452;4830;4834.540718631724;4869.951300487091;4839.41926968766;4917.9016419672125;5107.795688172431;5111.79552817898;5163.8192663258105;4657.86026419208;4671.15919134559;4675.696079754805;4680.4149481314835;4683.859484215479;4957.305977163128;5022.472640372708;5040.117979353672;5078.97460512695;5127.333446651912;5122.1804511278015;5136.563392111563;5143.202803565453;5148.9227661584355;5191.169412893919;4731.290306453921;4940.802367905244;4974.726390048438;4977.377827771528;4988.6757360771435;4761.285807128958;4846.80612775485;4900;4911.803527858846;4959.181735013683;4748.264019077049;4750.667453278375;4754.215554433618;4756.262779269219;4794.568488836021;4923.409190897115;4934.5312195341385;4940.6788558743565;4942.678725882806;5006.4743201963265;4688.249880019181;4754.595859351994;4861.4895435980125;4919.803207871788;4951.603871690329 12:41:28 INFO - PROCESS | 6186 | |1;ext.html;548.3474665148474;558.3941423555441;559.0440347006619;570.7574280930603;574.7126436781609;28677.283067923287;38896.61103388969;40459;40535;43730.78134609322;40499;40817.387739183934;40861;40899;41010;7635.618219089038;7793.805154871116;7804.063512378494;7806.921930780704;7807.4144439167;7576.128745194291;7635.160132385433;7653.010217343475;7667;7675.884861727079;7660.387169026492;7712.6529306181355;7714.961425192866;7718;7730;7643.885341719851;7685.308322250969;7688.5386876787015;7688.5771282579435;7703.037120359955;7581.12817026038;7651.770446886602;7658.578778167199;7680.731174408925;7683.30850223477;38512.61487385146;39085.21829563393;39086.218275634616;39132.60867391346;39143.21713565713;2893.23329317731;2893.6382952130984;2894.6381702287213;2949.911502654924;3043.3152540678393;27759.583606245924;28608.856955715295;28633.28416789576;28895.56656650152;29535.409291814045;3405.0205920781295;3447.5862896452586;3448.6034106077873;3450.6204317525053;3549.6095429502734;249005;249105;249875;252397;254911;53123;53787.73106134444;53800;53805.46194538083;53867.73066134644;32406.189845253586;33196.66803331984;33238.66761332356;56303;56378.71810640921;14583.197924114063;14963.775543366859;14970.550883473514;14977.176255306063;14979.303725329328;10664.573417063231;10709.089727373104;10726.892731072745;10732.195085368628;10742.516586753614;18093.54766130831;18101.094945252684;18181.81818181828;18254.726179107325;18275.908620456812;6574.704138313692;6617.735290588323;6854.828629284208;6864.656767161622;7000.684969176399;707.8088915992756;790.3795520516367;829.5396055189307;888.7022847346211;919.4023884475012;27270.001499175374;27545.586816197774;27617.309567260978;27763.86118069437;27769.166924991878;716.3839098375392;774.7133560582507;872.1757938747822;883.6067949762422;895.3732387328896;11354.716132096599;13866.168029918237;14002.159870407808;14119.576412707635;14226.502072427415;373124;403911;415976;605310;605417;49130.50869491331;49816.25275620868;49837.25244121341;49850.750746246034;49893;1093.5188517052472;1118.6867677050277;1139.9202055856176;1201.7836789377996;1208.9637310880864;27550.173494795188;29072.709272907847;29512.704872950995;30089.097327080224;30158.69841301559;40789.38815917704;41467.1706565873;41492.170156597305;41605.79197103995;41734.791326043174;323244;325404;327958;328452;374631;35346.823265883504;37310.813445932596;37774.811125944194;37817;38729.806350968065;41370.1725965485;41600.79199603983;41915.16169676528;42547.787261063495;42570.57429425666;35704;36168.09579760527;36347.63652363443;36662.08344791402;36814.44778328274;36385.63614363928;36522.06781987654;36540.81729591335;37430;37900.2419951605;35055.29889402249;35443;35941.28117437689;36008;36321.81839090788;28394.574081388382;32485.18787030343;32727.836360818044;33121.668783311856;33126;25336.873315633304;25411.745882540938;25477.872610636827;25495.745042549337;25896.22311330663 12:41:28 INFO - PROCESS | 6186 | |2;jquery.html;333.8664534186324;340.475667472093;346.6014083803626;351.99824000879994;375.2289046010449;12526.436310366043;13126.47494100236;15490.535283941486;15795;16543.91728041358;16999.150042497888;17067.231974561142;17082.402115925946;17176.570585735364;17368.82631173691;4583.564561366665;4674.088552732219;4834.637402194832;5064.746762661871;5066.822661206858;4946.431160416562;5019.749012549358;5057.291979122907;5082.974585127069;5082.974585127069;4777.498362671921;5030.6730062546;5044.092063428581;5052.823151189709;5053.898922021557;4870.951290487103;4933.654644174909;4937.21004639256;4938.555530002317;4938.777755001033;4389.868303950887;4393.20922234001;4393.36296237047;4394.428724265825;4394.8242070317465;11276.267042642203;16915.407960721437;18427.72358414625;19172.71240931387;19237.61524769497;1741.7735694359778;1829.195154132191;1856.8700190986635;1940.088158565472;2116.1746918701565;8420;9079.863802042975;9199.632014719404;10562.471876406149;13483.460661573525;1616.5958510372407;1699.2523289752469;1710.042376269293;1792.3816283382212;1802.5913495533348;61301;66115;67570.3242967569;69650.30349696489;70617.64691176562;9357.672481463253;9548.464479372242;9733.756656083655;9772.755681108029;9860.704178874645;13152.934235328763;13163.802542961863;13165.53920612793;13168.078234523682;13172.47310107604;7146.142462904485;7386.2613738625705;7407.296306850948;7531.924680753123;7554.735584254525;7161.67772450241;7266.7093316266755;7403.074615673041;7414;7434.442416818761;4002.4996875390575;4126;4135.793210339471;4229.2598795210715;4230.85192018284;1695.8304169582943;1720.6644704282794;1754.3684273661472;1755.7893052833485;1772.7961284452194;812.2486699802658;814.3892080939296;830.2652152844655;881.9206271435602;906.4606559097458;16448;16984.74522882158;17017.574560636083;17244.827551724575;17426.302947882195;842.9926238145357;870.208110619346;871.7166920750782;873.2271939333735;880.6917578847352;8592.398532102818;9342.159205671522;9387.34288599805;9610.95194524037;9624.51877406127;361046;362997;363841;369213;382082;70255;73910.6304468485;76310;79257.60371198106;82490.58754706309;896.3814967672286;897.8069715011435;937.095702646949;949.093615597103;951.8381875081253;15462.226888655747;15467.84532154709;15800.525984220492;16416.343346266494;16468.341266349693;36532.63467365292;37593.436098458;37711.81144094262;37915.43126853044;38264.2347153061;47913.5208647923;48395.27407088967;49419.258711118644;52117.21824172565;52246;4445.977770111129;4644.3265726470145;6677.532572719863;6768.695408706719;7322.121345438582;10085.495725213563;11572.363520006144;11723.941380293043;12071.155019148926;12131.332776697367;10064.949675251577;10102.646407375707;10117;10161.593536258762;10219.591216351262;9525;9940.602375904882;10019.849702254618;10162.441065741456;10255.538500767632;10171.288009839536;10436.478176091014;10461.581536738446;10506.842397363893;10700.357978521313;6990.965045174741;7070.4343652508705;7137.072180616487;7514.47398682087;7617;9465.195458385839;10216.335938163995;10319.432431216355;10394.740131496774;10650.786984260116 12:41:28 INFO - PROCESS | 6186 | |3;mootools.html;1177.3936422742283;1272.5482453728926;1315.546136582879;1318.242010843765;1592.3789722008419;5715.685637289947;6189.814305570834;6362.713677884489;6366.808995730124;6554.475641948645;6404.583702059363;6460;6460.257070436901;6466.321036291192;6469.74121035158;1993.8404927605793;2013.929512467064;2019.0207749241679;2019.7475315585552;2019.9293024744136;1973.6743437332823;2011.5071807407205;2021.3834780391974;2025.1291944463874;2027.2803154880025;1974.802519748028;1984.7122167285736;2001.1195074167392;2004.4888553418857;2007.2372498450568;1959.5003274165067;1980.2673010985955;1980.5939782344585;1980.8910509921948;1985.3944546913185;1930.3822776711459;1968.3110911181116;1973.6743437332823;1978.9010549472468;1981.4947188466992;6318.368163183691;6331.2719037310835;6434.839129021765;6444.709988050502;6461.773837915651;4006.7395619284653;4152;4156.584341565849;4160.209560183585;4163.458750362463;2566.525192839331;2768.9169324920285;2818.394045280254;2829.589709492112;2829.7453229209264;875.7153924974409;881.8544940084878;894.1014280647908;895.4000819450919;896.1710417863516;8199.262066414052;8272.17278272174;8278.958605206995;8279.958600207021;8338.207870252316;3259.7392208623255;3500.7199424046016;3553.857845686195;3559.199180184438;3570.696490798259;6905.1713794344;6906.309369063154;6907.205671347759;6908.585484870924;6926.619035953071;4004.5795191505053;4004.739691920016;4006.719529632956;4008.378701301303;4009.959900401017;3373.8313084345687;3473.513708080871;3626.1841085756023;3690.2435000824767;3754.962450375516;2855.3718181999925;2870.5263631500984;2949.83775892328;2959.9704002959693;2992.745616622568;901.1124042817819;912;935.5649622925372;937.0863408176973;942.6370847223731;694.944404447643;695.2387136085978;716.7455553278616;724.478375569589;766.5937053361728;4472.552744725566;4523.502414734442;4566.086782643484;4566.771661416916;4626.074785043005;387.40533281412894;388.42707007164205;401.63852532720784;404.3106503411676;405.1956865621739;3216.4210442120175;3219.3239419721654;3250.5124231365485;3287.819169945628;3329.7003269705842;7321.670524826395;7669.7315593953945;7695.92304076952;7697.923020769833;7729.536227826348;7658.425618078666;7666.271704188093;7669.654865531064;7671.424643151786;7680.615969201517;6071.635701857903;6132.172156758869;6133.172021777093;6135.355787642323;6135.815925522242;4616.492185859485;4659.860204193744;4695.835645752382;4792.520747925179;4860.295257187759;6848.1097457330225;6951.548149370275;7074.50478466523;7083.929160708327;7084.220735718964;7096.148462184571;7109.680064397218;7121.4302855770375;7121.572705637678;7131.0729605151;5180.352455943007;5628.577856660849;5754.798582049608;5807.070868660994;5814.127880817911;5812.099124635688;5893.2044174035955;6067.757289708362;6075.969620151871;6214.067889816563;5553.16702494629;5606.103023516218;5623.831285061455;5649.887002260014;5734.397888221677;5367.543758780547;5419.891602167856;5467.972660136674;5484.972575137099;5517.36550296721;5339.065663508948;5353.036453438419;5395.055865223491;5414.269073675004;5419.918701219563;3882.1071153634257;3930.76415415076;4055.7160998729805;4057.107436363995;4095.1400205955892;4036.2129384769687;4061.309577371913;4114.526829414655;4136.937945930874;4166.500019997619 12:41:28 INFO - PROCESS | 6186 | |4;prototype.html;277.0787132783494;284.4978612748499;286.0888071492296;290.25694222789656;292.4925254683125;4617.376654151689;4763.35694681218;4780.402449693788;4844.854654360371;4872.926906096412;4663.883402914928;4676.942145455997;4745.952540474595;4771.761411929407;4789.688670236432;3758.379867321902;3759.7404869368793;3760.247950409922;3763.322601931651;3764.8705388383514;3681.6193927277272;3762.3980163173896;3762.774233545996;3766.717496187783;3771.905702357449;3697.7781333119965;3708;3718.8326525306425;3719.163188282642;3721.7208709346774;3695.5011073505;3696.9445458318146;3708.3510385682534;3718.8140592970244;3719.619443556126;3248.772585918987;3260.2827377976805;3261.3693153423287;3269.280758233209;3276.4921437177036;4552.294394368878;4632.72203667781;4660.6970546914345;4675.509071547506;4704.1767690654;4187.623113919762;4223;4223.107171587472;4225.619694227504;4232.76719780412;4966.683828785374;4971.105201063807;4976.576990955773;4979.551840334388;4989.950100498985;3557.1107223194203;3558;3558.5195998540125;3566.964330356689;3568.839402226906;4998.500149985009;5210.244514545369;5230.424653288173;5254.395744489356;5277.313949186581;3541.3979623464074;3545.663161999606;3549.580167932796;3552.342816578941;3560.9821950890077;3598.712103031751;3604.98197509016;3611.133328001261;3618.656227658368;3621.764585301947;3938.8030598469963;4185;4186.769727664947;4190.497140343178;4195.15413218183;4983.875403114951;5029.748512574357;5051.898962020812;5052.292679024939;5060.645754797129;1155.5377848860523;1173.5951096871565;1186.851643544557;1200.3038237822043;1210.7881120804;805.4804651000072;816.420341557489;825.1500954017372;825.9710910118117;826.3265438667466;4223.704340696183;4229.450171477688;4249.235137675187;4266.786660666954;4268.445102136764;4959.776810043557;4960.313493412257;4987.9525299687475;4989.800407983713;4994.550490455877;4235.37406807775;4240.660747140221;4306.2894622387585;4314.870553883388;4317.222899877989;2537.9492410151693;2619.2535127488954;2674.7532073058337;2696.8786404611837;2697.473992571469;4739.431268247763;4773.902002539436;4781.258904869751;4793.736344501086;4796.25658023007;5123.666961647481;5158.220413957179;5158.226266060046;5181.4559471255725;5200.869978250574;4501.212287849678;4734.130018642617;4747.810087596457;4777.1878780606685;4788.688735232199;5061.367329083864;5072.873178170576;5080.665301433554;5085.694858308513;5093.312402825572;4936.506349365035;5000.174866227267;5012;5028.723420211923;5029.371328583927;4606.746628935441;4864.829730959399;4900.705957642553;4911.312416261655;4926.137925863031;3548.8225588720975;3555.7155427565217;3609.278144371189;3609.4224924012033;3612.620674829105;5237.711925844115;5240.659357141773;5243.659162154448;5248.6588371755715;5253.816116435906;4694.413198350207;4768.737719425465;5029.27075574047;5047.9747601263225;5089.6691715038405;5093.796248150181;5101.081805274937;5104.1067813133295;5110.4123025852505;5114.488551144856;4803.5916947058495;4952.360015388758;4955.40535135786;4955.454899961073;4958.6281028923695;5093.592512599057;5117.692938423706;5119.953627591577;5128.871778205575;5131.409263128442;5010.173321401928;5012.7693176536095;5020.146575082318;5020.268007537394;5032.723200223876 12:41:28 INFO - PROCESS | 6186 | |5;yui.html;618.5279035894571;664.80055983205;669.7843414203221;712.9287071292874;731.7146312937955;11637.650870473888;12506.249625022494;12578.622641320764;12646.557370492035;12662.43019064142;12101.576444824434;12240.265584064962;12241;12252.754944901097;12260.325682087503;621.773052835714;637.2098597738817;751.4176513202258;753.0737193252276;774.3302043732187;772.9613519324039;776.4681193382551;776.4836383804763;776.7475570439601;776.7786180938434;821.6343727041469;822.5517093184229;823.1110400767187;823.5347028928636;823.7734622978669;652.8106849013805;669.0165456778528;787.6258777080898;798.1419973528422;820.0323618130603;589.8142085243135;589.9439553242435;590.038237672591;590.9852253693649;591.3583761618648;12067.758644827141;12226.449809758582;12251.816222756666;12274.140810143293;12283.877161228364;11745.177837551375;11806;12059.6382108536;12126.75986269345;12323.322217278046;10051.231037055459;10196.3372380795;10372.844407333821;10391.948040259751;10722.731931701692;3867.864624738149;3882.262370149691;3886.630770076838;3925.2738243425056;3954.584768599313;45240.773796131136;48003.75998120022;48164.27753583664;48183.518164818255;48213.51786482125;9339.392939458914;9355.4386736796;9394.859077113848;9421.340506164639;9428.528573571293;16994.745078823827;17105.401310954057;17147.056911869717;17275;17446.127693615268;6136.754529818846;6253.812385628438;6322.9051564226575;6516.576422532615;6583.07836902834;3281.9343613127603;3303.587051618548;3353.463445848701;3388.9322213556084;3482.1294676330917;2576.510463012022;2635.0777227970057;2654.632864075003;2655.4290827472187;2658.016533882437;446.2035267048368;449.7369039112156;462.36424915740855;462.54208333749347;469.50701763148555;527.1024312475136;542.9782808687609;547.5838362844268;549.4395716369281;553.9335279766453;6765.594064356154;6783.491238157158;6791.796246112624;6861.245263021064;6874.415674667609;501.4308759557855;517.5730022731186;521.5097808060411;527.5304978569077;532.0210812105744;3890.727649064595;4017.4375587417785;4083.1629515949753;4299.634531064832;4411.073674528385;38846.22307553833;39903.600963989986;40150.397744033864;40352.39471407931;70155.64922175357;35003.82498087493;49159.50840491621;53339.46660533422;56423.43576564182;57270.42729572734;44807.999999999345;45423;50989.745051274505;52069.739651301505;52532.737336313076;7597.727465445612;7942.068910448551;7988.360931125612;8307.127751585997;8346.749597512084;26651.20046398611;33328.333433330714;35201.29597407986;36106.63893361138;38469.41310937755;32126.83936580302;32838.34323313473;45402.77298613618;47245.527544724115;48108;10109.949450252701;10514.421706806199;10577.36535807854;10633.840492392466;10706.464676766287;11557.711057223636;11835;11841.467133979164;12598.055145863913;12707.110502264753;10529.736756581147;10606.734831629272;10739.624113156002;10850.131989440984;11199.21605487608;11079.889201107886;11320.547178112784;11352.716182095184;11755.529778809094;11831.112666550216;10301.536430860779;10449.9477502612;10472.633457828939;10635.415052172204;10694.60141698495;8601.913980860112;8878.37851350425;9067.455952642862;9132.908670913472;9157.175854173156;8049.476784009021;8375;8566.143385661384;8751.212390884852;8753.387262891536 12:41:28 INFO - PROCESS | 6186 | __end_tp_report 12:41:28 INFO - PROCESS | 6186 | __start_cc_report 12:41:28 INFO - PROCESS | 6186 | _x_x_mozilla_cycle_collect,1309 12:41:28 INFO - PROCESS | 6186 | __end_cc_report 12:41:28 INFO - PROCESS | 6186 | __startTimestamp1479328888026__endTimestamp 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | ------- Summary: start ------- 12:41:28 INFO - PROCESS | 6186 | Number of tests: 6 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | [#0] dojo.html Cycles:165 Average:4671.92 Median:4754.60 stddev:503.51 (10.6%) stddev-sans-first:477.47 12:41:28 INFO - PROCESS | 6186 | Values: 2576.8 2606.9 2622.9 2623.9 2632.9 4570.0 4643.3 4703.8 4726.8 4731.7 4629.7 4655.3 4696.2 4724.0 4803.0 4273.2 4291.0 4329.0 4354.3 4366.4 4389.7 4394.8 4417.7 4443.3 4473.1 4204.0 4417.4 4424.8 4444.7 4526.7 4246.7 4313.3 4322.7 4328.7 4331.2 4249.2 4267.6 4306.4 4308.4 4312.8 4683.4 4722.2 4730.7 4733.5 4751.0 5007.2 5012.5 5015.9 5018.5 5059.5 4889.4 5043.0 5047.6 5052.4 5105.9 4633.0 4692.9 4708.2 4758.6 4828.1 5212.4 5245.7 5249.9 5257.5 5292.3 4991.2 5010.8 5031.2 5041.2 5080.4 4847.9 4879.3 4879.9 5044.1 5121.1 5020.3 5095.3 5095.6 5116.3 5135.1 5094.9 5099.7 5106.9 5113.5 5145.4 4090.6 4282.8 4292.2 4294.4 4344.0 3654.6 3710.8 3712.3 3727.7 3761.1 4392.5 4393.5 4398.1 4422.4 4427.5 5130.7 5133.3 5141.2 5142.0 5149.3 4161.5 4246.4 4319.7 4378.8 4380.6 4555.7 4596.1 4597.1 4627.1 4633.5 4824.5 4827.8 4830.0 4834.5 4870.0 4839.4 4917.9 5107.8 5111.8 5163.8 4657.9 4671.2 4675.7 4680.4 4683.9 4957.3 5022.5 5040.1 5079.0 5127.3 5122.2 5136.6 5143.2 5148.9 5191.2 4731.3 4940.8 4974.7 4977.4 4988.7 4761.3 4846.8 4900.0 4911.8 4959.2 4748.3 4750.7 4754.2 4756.3 4794.6 4923.4 4934.5 4940.7 4942.7 5006.5 4688.2 4754.6 4861.5 4919.8 4951.6 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | [#1] ext.html Cycles:180 Average:50469.97 Median:206202.91 stddev:99212.00 (48.1%) stddev-sans-first:99419.52 12:41:28 INFO - PROCESS | 6186 | Values: 548.3 558.4 559.0 570.8 574.7 28677.3 38896.6 40459.0 40535.0 43730.8 40499.0 40817.4 40861.0 40899.0 41010.0 7635.6 7793.8 7804.1 7806.9 7807.4 7576.1 7635.2 7653.0 7667.0 7675.9 7660.4 7712.7 7715.0 7718.0 7730.0 7643.9 7685.3 7688.5 7688.6 7703.0 7581.1 7651.8 7658.6 7680.7 7683.3 38512.6 39085.2 39086.2 39132.6 39143.2 2893.2 2893.6 2894.6 2949.9 3043.3 27759.6 28608.9 28633.3 28895.6 29535.4 3405.0 3447.6 3448.6 3450.6 3549.6 249005.0 249105.0 249875.0 252397.0 254911.0 53123.0 53787.7 53800.0 53805.5 53867.7 32406.2 33196.7 33238.7 56303.0 56378.7 14583.2 14963.8 14970.6 14977.2 14979.3 10664.6 10709.1 10726.9 10732.2 10742.5 18093.5 18101.1 18181.8 18254.7 18275.9 6574.7 6617.7 6854.8 6864.7 7000.7 707.8 790.4 829.5 888.7 919.4 27270.0 27545.6 27617.3 27763.9 27769.2 716.4 774.7 872.2 883.6 895.4 11354.7 13866.2 14002.2 14119.6 14226.5 373124.0 403911.0 415976.0 605310.0 605417.0 49130.5 49816.3 49837.3 49850.8 49893.0 1093.5 1118.7 1139.9 1201.8 1209.0 27550.2 29072.7 29512.7 30089.1 30158.7 40789.4 41467.2 41492.2 41605.8 41734.8 323244.0 325404.0 327958.0 328452.0 374631.0 35346.8 37310.8 37774.8 37817.0 38729.8 41370.2 41600.8 41915.2 42547.8 42570.6 35704.0 36168.1 36347.6 36662.1 36814.4 36385.6 36522.1 36540.8 37430.0 37900.2 35055.3 35443.0 35941.3 36008.0 36321.8 28394.6 32485.2 32727.8 33121.7 33126.0 25336.9 25411.7 25477.9 25495.7 25896.2 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | [#2] jquery.html Cycles:180 Average:23332.94 Median:4393.29 stddev:60895.98 (1386.1%) stddev-sans-first:61042.32 12:41:28 INFO - PROCESS | 6186 | Values: 333.9 340.5 346.6 352.0 375.2 12526.4 13126.5 15490.5 15795.0 16543.9 16999.2 17067.2 17082.4 17176.6 17368.8 4583.6 4674.1 4834.6 5064.7 5066.8 4946.4 5019.7 5057.3 5083.0 5083.0 4777.5 5030.7 5044.1 5052.8 5053.9 4871.0 4933.7 4937.2 4938.6 4938.8 4389.9 4393.2 4393.4 4394.4 4394.8 11276.3 16915.4 18427.7 19172.7 19237.6 1741.8 1829.2 1856.9 1940.1 2116.2 8420.0 9079.9 9199.6 10562.5 13483.5 1616.6 1699.3 1710.0 1792.4 1802.6 61301.0 66115.0 67570.3 69650.3 70617.6 9357.7 9548.5 9733.8 9772.8 9860.7 13152.9 13163.8 13165.5 13168.1 13172.5 7146.1 7386.3 7407.3 7531.9 7554.7 7161.7 7266.7 7403.1 7414.0 7434.4 4002.5 4126.0 4135.8 4229.3 4230.9 1695.8 1720.7 1754.4 1755.8 1772.8 812.2 814.4 830.3 881.9 906.5 16448.0 16984.7 17017.6 17244.8 17426.3 843.0 870.2 871.7 873.2 880.7 8592.4 9342.2 9387.3 9611.0 9624.5 361046.0 362997.0 363841.0 369213.0 382082.0 70255.0 73910.6 76310.0 79257.6 82490.6 896.4 897.8 937.1 949.1 951.8 15462.2 15467.8 15800.5 16416.3 16468.3 36532.6 37593.4 37711.8 37915.4 38264.2 47913.5 48395.3 49419.3 52117.2 52246.0 4446.0 4644.3 6677.5 6768.7 7322.1 10085.5 11572.4 11723.9 12071.2 12131.3 10064.9 10102.6 10117.0 10161.6 10219.6 9525.0 9940.6 10019.8 10162.4 10255.5 10171.3 10436.5 10461.6 10506.8 10700.4 6991.0 7070.4 7137.1 7514.5 7617.0 9465.2 10216.3 10319.4 10394.7 10650.8 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | [#3] mootools.html Cycles:180 Average:4269.43 Median:5259.71 stddev:2236.76 (42.5%) stddev-sans-first:2230.96 12:41:28 INFO - PROCESS | 6186 | Values: 1177.4 1272.5 1315.5 1318.2 1592.4 5715.7 6189.8 6362.7 6366.8 6554.5 6404.6 6460.0 6460.3 6466.3 6469.7 1993.8 2013.9 2019.0 2019.7 2019.9 1973.7 2011.5 2021.4 2025.1 2027.3 1974.8 1984.7 2001.1 2004.5 2007.2 1959.5 1980.3 1980.6 1980.9 1985.4 1930.4 1968.3 1973.7 1978.9 1981.5 6318.4 6331.3 6434.8 6444.7 6461.8 4006.7 4152.0 4156.6 4160.2 4163.5 2566.5 2768.9 2818.4 2829.6 2829.7 875.7 881.9 894.1 895.4 896.2 8199.3 8272.2 8279.0 8280.0 8338.2 3259.7 3500.7 3553.9 3559.2 3570.7 6905.2 6906.3 6907.2 6908.6 6926.6 4004.6 4004.7 4006.7 4008.4 4010.0 3373.8 3473.5 3626.2 3690.2 3755.0 2855.4 2870.5 2949.8 2960.0 2992.7 901.1 912.0 935.6 937.1 942.6 694.9 695.2 716.7 724.5 766.6 4472.6 4523.5 4566.1 4566.8 4626.1 387.4 388.4 401.6 404.3 405.2 3216.4 3219.3 3250.5 3287.8 3329.7 7321.7 7669.7 7695.9 7697.9 7729.5 7658.4 7666.3 7669.7 7671.4 7680.6 6071.6 6132.2 6133.2 6135.4 6135.8 4616.5 4659.9 4695.8 4792.5 4860.3 6848.1 6951.5 7074.5 7083.9 7084.2 7096.1 7109.7 7121.4 7121.6 7131.1 5180.4 5628.6 5754.8 5807.1 5814.1 5812.1 5893.2 6067.8 6076.0 6214.1 5553.2 5606.1 5623.8 5649.9 5734.4 5367.5 5419.9 5468.0 5485.0 5517.4 5339.1 5353.0 5395.1 5414.3 5419.9 3882.1 3930.8 4055.7 4057.1 4095.1 4036.2 4061.3 4114.5 4136.9 4166.5 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | [#4] prototype.html Cycles:180 Average:4127.13 Median:4719.15 stddev:1216.85 (25.8%) stddev-sans-first:1185.46 12:41:28 INFO - PROCESS | 6186 | Values: 277.1 284.5 286.1 290.3 292.5 4617.4 4763.4 4780.4 4844.9 4872.9 4663.9 4676.9 4746.0 4771.8 4789.7 3758.4 3759.7 3760.2 3763.3 3764.9 3681.6 3762.4 3762.8 3766.7 3771.9 3697.8 3708.0 3718.8 3719.2 3721.7 3695.5 3696.9 3708.4 3718.8 3719.6 3248.8 3260.3 3261.4 3269.3 3276.5 4552.3 4632.7 4660.7 4675.5 4704.2 4187.6 4223.0 4223.1 4225.6 4232.8 4966.7 4971.1 4976.6 4979.6 4990.0 3557.1 3558.0 3558.5 3567.0 3568.8 4998.5 5210.2 5230.4 5254.4 5277.3 3541.4 3545.7 3549.6 3552.3 3561.0 3598.7 3605.0 3611.1 3618.7 3621.8 3938.8 4185.0 4186.8 4190.5 4195.2 4983.9 5029.7 5051.9 5052.3 5060.6 1155.5 1173.6 1186.9 1200.3 1210.8 805.5 816.4 825.2 826.0 826.3 4223.7 4229.5 4249.2 4266.8 4268.4 4959.8 4960.3 4988.0 4989.8 4994.6 4235.4 4240.7 4306.3 4314.9 4317.2 2537.9 2619.3 2674.8 2696.9 2697.5 4739.4 4773.9 4781.3 4793.7 4796.3 5123.7 5158.2 5158.2 5181.5 5200.9 4501.2 4734.1 4747.8 4777.2 4788.7 5061.4 5072.9 5080.7 5085.7 5093.3 4936.5 5000.2 5012.0 5028.7 5029.4 4606.7 4864.8 4900.7 4911.3 4926.1 3548.8 3555.7 3609.3 3609.4 3612.6 5237.7 5240.7 5243.7 5248.7 5253.8 4694.4 4768.7 5029.3 5048.0 5089.7 5093.8 5101.1 5104.1 5110.4 5114.5 4803.6 4952.4 4955.4 4955.5 4958.6 5093.6 5117.7 5120.0 5128.9 5131.4 5010.2 5012.8 5020.1 5020.3 5032.7 12:41:28 INFO - PROCESS | 6186 | 12:41:28 INFO - PROCESS | 6186 | [#5] yui.html Cycles:180 Average:12991.01 Median:45321.77 stddev:15348.97 (33.9%) stddev-sans-first:15363.91 12:41:28 INFO - PROCESS | 6186 | Values: 618.5 664.8 669.8 712.9 731.7 11637.7 12506.2 12578.6 12646.6 12662.4 12101.6 12240.3 12241.0 12252.8 12260.3 621.8 637.2 751.4 753.1 774.3 773.0 776.5 776.5 776.7 776.8 821.6 822.6 823.1 823.5 823.8 652.8 669.0 787.6 798.1 820.0 589.8 589.9 590.0 591.0 591.4 12067.8 12226.4 12251.8 12274.1 12283.9 11745.2 11806.0 12059.6 12126.8 12323.3 10051.2 10196.3 10372.8 10391.9 10722.7 3867.9 3882.3 3886.6 3925.3 3954.6 45240.8 48003.8 48164.3 48183.5 48213.5 9339.4 9355.4 9394.9 9421.3 9428.5 16994.7 17105.4 17147.1 17275.0 17446.1 6136.8 6253.8 6322.9 6516.6 6583.1 3281.9 3303.6 3353.5 3388.9 3482.1 2576.5 2635.1 2654.6 2655.4 2658.0 446.2 449.7 462.4 462.5 469.5 527.1 543.0 547.6 549.4 553.9 6765.6 6783.5 6791.8 6861.2 6874.4 501.4 517.6 521.5 527.5 532.0 3890.7 4017.4 4083.2 4299.6 4411.1 38846.2 39903.6 40150.4 40352.4 70155.6 35003.8 49159.5 53339.5 56423.4 57270.4 44808.0 45423.0 50989.7 52069.7 52532.7 7597.7 7942.1 7988.4 8307.1 8346.7 26651.2 33328.3 35201.3 36106.6 38469.4 32126.8 32838.3 45402.8 47245.5 48108.0 10109.9 10514.4 10577.4 10633.8 10706.5 11557.7 11835.0 11841.5 12598.1 12707.1 10529.7 10606.7 10739.6 10850.1 11199.2 11079.9 11320.5 11352.7 11755.5 11831.1 10301.5 10449.9 10472.6 10635.4 10694.6 8601.9 8878.4 9067.5 9132.9 9157.2 8049.5 8375.0 8566.1 8751.2 8753.4 12:41:28 INFO - PROCESS | 6186 | -------- Summary: end -------- 12:41:28 INFO - PROCESS | 6186 | 12:41:29 INFO - TEST-INFO | 6186: exit 0 12:41:29 INFO - TEST-OK | dromaeo_css | took 1123365ms 12:41:29 INFO - TEST-START | kraken 12:41:29 INFO - operating with platform_type : linux_ 12:41:29 INFO - Initialising browser for kraken test... 12:41:29 INFO - TEST-INFO | started process 6488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWn5D6/profile http://localhost:41509/getInfo.html) 12:41:33 INFO - PROCESS | 6488 | __metrics Screen width/height:1600/1200 12:41:33 INFO - PROCESS | 6488 | colorDepth:24 12:41:33 INFO - PROCESS | 6488 | Browser inner width/height: 1024/697 12:41:33 INFO - PROCESS | 6488 | __metrics 12:41:34 INFO - PROCESS | 6488 | 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" 12:41:34 INFO - PROCESS | 6488 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:41:34 INFO - PROCESS | 6488 | console.error: PushService: 12:41:34 INFO - PROCESS | 6488 | stateChangeProcessEnqueue: Error transitioning state 12:41:34 INFO - PROCESS | 6488 | UnknownError 12:41:35 INFO - TEST-INFO | 6488: exit 0 12:41:35 INFO - Browser initialized. 12:41:35 INFO - Running cycle 1/1 for kraken test... 12:41:35 INFO - TEST-INFO | started process 6572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQWn5D6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:47 INFO - PROCESS | 6572 | RSS: Main: 174866432 12:41:47 INFO - PROCESS | 6572 | 12:41:50 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41509/tests/kraken/driver.html?testName=audio-beat-detection) 12:41:51 INFO - PROCESS | 6572 | RSS: Main: 231378944 12:41:51 INFO - PROCESS | 6572 | 12:41:54 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41509/tests/kraken/driver.html?testName=audio-dft) 12:41:54 INFO - PROCESS | 6572 | RSS: Main: 218017792 12:41:54 INFO - PROCESS | 6572 | 12:41:58 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41509/tests/kraken/driver.html?testName=audio-fft) 12:41:58 INFO - PROCESS | 6572 | RSS: Main: 299847680 12:41:58 INFO - PROCESS | 6572 | 12:42:00 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41509/tests/kraken/driver.html?testName=audio-oscillator) 12:42:01 INFO - PROCESS | 6572 | RSS: Main: 211247104 12:42:01 INFO - PROCESS | 6572 | 12:42:03 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:42:04 INFO - PROCESS | 6572 | RSS: Main: 214192128 12:42:04 INFO - PROCESS | 6572 | 12:42:07 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41509/tests/kraken/driver.html?testName=imaging-darkroom) 12:42:08 INFO - PROCESS | 6572 | RSS: Main: 254164992 12:42:08 INFO - PROCESS | 6572 | 12:42:11 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41509/tests/kraken/driver.html?testName=imaging-desaturate) 12:42:12 INFO - PROCESS | 6572 | RSS: Main: 253333504 12:42:12 INFO - PROCESS | 6572 | 12:42:15 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41509/tests/kraken/driver.html?testName=json-parse-financial) 12:42:15 INFO - PROCESS | 6572 | RSS: Main: 252473344 12:42:15 INFO - PROCESS | 6572 | 12:42:17 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:42:18 INFO - PROCESS | 6572 | RSS: Main: 214798336 12:42:18 INFO - PROCESS | 6572 | 12:42:19 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:42:20 INFO - PROCESS | 6572 | RSS: Main: 221982720 12:42:20 INFO - PROCESS | 6572 | 12:42:22 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:42:23 INFO - PROCESS | 6572 | RSS: Main: 230600704 12:42:23 INFO - PROCESS | 6572 | 12:42:26 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:42:27 INFO - PROCESS | 6572 | RSS: Main: 239235072 12:42:27 INFO - PROCESS | 6572 | 12:42:30 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:42:30 INFO - PROCESS | 6572 | RSS: Main: 235163648 12:42:30 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | Cycle 1(1): loaded http://localhost:41509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41509/tests/kraken/driver.html?testName=ai-astar) 12:42:32 INFO - PROCESS | 6572 | RSS: Main: 286187520 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | __start_tp_report 12:42:32 INFO - PROCESS | 6572 | _x_x_mozilla_page_load 12:42:32 INFO - PROCESS | 6572 | _x_x_mozilla_page_load_details 12:42:32 INFO - PROCESS | 6572 | |i|pagename|runs| 12:42:32 INFO - PROCESS | 6572 | |0;ai-astar;109;115;116;119;116;116;117;117;116;117 12:42:32 INFO - PROCESS | 6572 | |1;audio-beat-detection;150;126;128;174;130;139;131;127;157;130 12:42:32 INFO - PROCESS | 6572 | |2;audio-dft;162;162;161;161;161;161;161;162;163;163 12:42:32 INFO - PROCESS | 6572 | |3;audio-fft;77;77;75;103;78;77;78;76;100;78 12:42:32 INFO - PROCESS | 6572 | |4;audio-oscillator;83;83;114;84;84;83;114;83;83;119 12:42:32 INFO - PROCESS | 6572 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;116;117;117 12:42:32 INFO - PROCESS | 6572 | |6;imaging-darkroom;147;147;147;148;147;146;147;147;147;146 12:42:32 INFO - PROCESS | 6572 | |7;imaging-desaturate;95;94;96;94;95;96;95;95;95;96 12:42:32 INFO - PROCESS | 6572 | |8;json-parse-financial;66;65;66;64;64;64;65;64;64;64 12:42:32 INFO - PROCESS | 6572 | |9;json-stringify-tinderbox;66;67;67;66;66;66;66;68;67;67 12:42:32 INFO - PROCESS | 6572 | |10;stanford-crypto-aes;84;84;85;84;85;84;83;83;85;85 12:42:32 INFO - PROCESS | 6572 | |11;stanford-crypto-ccm;145;140;142;141;143;146;145;141;183;149 12:42:32 INFO - PROCESS | 6572 | |12;stanford-crypto-pbkdf2;181;177;176;183;174;177;179;175;176;180 12:42:32 INFO - PROCESS | 6572 | |13;stanford-crypto-sha256-iterative;69;69;72;69;70;68;70;69;68;67 12:42:32 INFO - PROCESS | 6572 | __end_tp_report 12:42:32 INFO - PROCESS | 6572 | __start_cc_report 12:42:32 INFO - PROCESS | 6572 | _x_x_mozilla_cycle_collect,1998 12:42:32 INFO - PROCESS | 6572 | __end_cc_report 12:42:32 INFO - PROCESS | 6572 | __startTimestamp1479328952689__endTimestamp 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | ------- Summary: start ------- 12:42:32 INFO - PROCESS | 6572 | Number of tests: 14 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.50 stddev:2.62 (2.2%) stddev-sans-first:1.13 12:42:32 INFO - PROCESS | 6572 | Values: 109.0 115.0 116.0 119.0 116.0 116.0 117.0 117.0 116.0 117.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:135.00 stddev:16.09 (11.9%) stddev-sans-first:16.58 12:42:32 INFO - PROCESS | 6572 | Values: 150.0 126.0 128.0 174.0 130.0 139.0 131.0 127.0 157.0 130.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:42:32 INFO - PROCESS | 6572 | Values: 162.0 162.0 161.0 161.0 161.0 161.0 161.0 162.0 163.0 163.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:10.40 (13.5%) stddev-sans-first:10.88 12:42:32 INFO - PROCESS | 6572 | Values: 77.0 77.0 75.0 103.0 78.0 77.0 78.0 76.0 100.0 78.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:15.71 (18.9%) stddev-sans-first:16.24 12:42:32 INFO - PROCESS | 6572 | Values: 83.0 83.0 114.0 84.0 84.0 83.0 114.0 83.0 83.0 119.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 12:42:32 INFO - PROCESS | 6572 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:42:32 INFO - PROCESS | 6572 | Values: 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 146.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 12:42:32 INFO - PROCESS | 6572 | Values: 95.0 94.0 96.0 94.0 95.0 96.0 95.0 95.0 95.0 96.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 12:42:32 INFO - PROCESS | 6572 | Values: 66.0 65.0 66.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 12:42:32 INFO - PROCESS | 6572 | Values: 66.0 67.0 67.0 66.0 66.0 66.0 66.0 68.0 67.0 67.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 12:42:32 INFO - PROCESS | 6572 | Values: 84.0 84.0 85.0 84.0 85.0 84.0 83.0 83.0 85.0 85.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:145.00 stddev:12.77 (8.8%) stddev-sans-first:13.52 12:42:32 INFO - PROCESS | 6572 | Values: 145.0 140.0 142.0 141.0 143.0 146.0 145.0 141.0 183.0 149.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:178.00 stddev:2.86 (1.6%) stddev-sans-first:2.79 12:42:32 INFO - PROCESS | 6572 | Values: 181.0 177.0 176.0 183.0 174.0 177.0 179.0 175.0 176.0 180.0 12:42:32 INFO - PROCESS | 6572 | 12:42:32 INFO - PROCESS | 6572 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 12:42:32 INFO - PROCESS | 6572 | Values: 69.0 69.0 72.0 69.0 70.0 68.0 70.0 69.0 68.0 67.0 12:42:32 INFO - PROCESS | 6572 | -------- Summary: end -------- 12:42:32 INFO - PROCESS | 6572 | 12:42:34 INFO - TEST-INFO | 6572: exit 0 12:42:34 INFO - TEST-OK | kraken | took 64951ms 12:42:34 INFO - SUITE-END | took 1188s 12:42:34 INFO - Completed test suite (00:19:48) 12:42:34 INFO - javascript benchmark 12:42:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.8196226264163, 2606.8696565171736, 2622.868856557173, 2623.9344016399596, 2632.9078482253126, 4569.977150114253, 4643.280291554806, 4703.788329525171, 4726.810927562898, 4731.692439991402, 4629.699069560476, 4655.301704744282, 4696.225122854725, 4724.0, 4803.039392121572, 4273.166732487166, 4290.957090429087, 4329.047609525915, 4354.3468479728135, 4366.388705581221, 4389.670774691895, 4394.824207031715, 4417.668674849383, 4443.266860967937, 4473.105378924212, 4204.033072393336, 4417.403650507173, 4424.823007079713, 4444.688871778977, 4526.660500462479, 4246.681498887596, 4313.266744653416, 4322.740635561876, 4328.675349348811, 4331.155424692186, 4249.213895429355, 4267.594578515036, 4306.35404689296, 4308.3968244445805, 4312.762798046107, 4683.437987441494, 4722.220833562458, 4730.739809310487, 4733.526647335273, 4751.049790042005, 5007.2489126630935, 5012.498750124995, 5015.949840501585, 5018.548330650259, 5059.468755780626, 4889.413270407574, 5043.041822053798, 5047.621428392885, 5052.368453943257, 5105.923411148836, 4633.0, 4692.929606055912, 4708.199606066977, 4758.619310455155, 4828.106800241896, 5212.374515058217, 5245.659032162897, 5249.921251181236, 5257.474252574789, 5292.311999440049, 4991.201407774739, 5010.774515146754, 5031.195008798648, 5041.193409054534, 5080.390353157644, 4847.903041939141, 4879.2925025871045, 4879.853604391874, 5044.117279476077, 5121.103806833789, 5020.2720605511995, 5095.337606111182, 5095.566876815438, 5116.258142569307, 5135.075686376488, 5094.923576146361, 5099.69401835891, 5106.923396149061, 5113.488651134857, 5145.3568303962, 4090.5909409058854, 4282.764447955392, 4292.248856450109, 4294.377315289265, 4344.044310251739, 3654.561452625702, 3710.8144592770254, 3712.2575484903127, 3727.6645101940953, 3761.097336639242, 4392.516823149451, 4393.450818647669, 4398.054418300081, 4422.425084738963, 4427.512973572904, 5130.666506677054, 5133.332666753373, 5141.2288156776785, 5142.04872098663, 5149.253358263031, 4161.500619925568, 4246.363045543131, 4319.67602429819, 4378.8029538670835, 4380.62764665007, 4555.681102322872, 4596.080783843177, 4597.126545956257, 4627.1439783640135, 4633.467151277646, 4824.469308376006, 4827.758612069452, 4830.0, 4834.540718631724, 4869.951300487091, 4839.41926968766, 4917.9016419672125, 5107.795688172431, 5111.79552817898, 5163.8192663258105, 4657.86026419208, 4671.15919134559, 4675.696079754805, 4680.4149481314835, 4683.859484215479, 4957.305977163128, 5022.472640372708, 5040.117979353672, 5078.97460512695, 5127.333446651912, 5122.1804511278015, 5136.563392111563, 5143.202803565453, 5148.9227661584355, 5191.169412893919, 4731.290306453921, 4940.802367905244, 4974.726390048438, 4977.377827771528, 4988.6757360771435, 4761.285807128958, 4846.80612775485, 4900.0, 4911.803527858846, 4959.181735013683, 4748.264019077049, 4750.667453278375, 4754.215554433618, 4756.262779269219, 4794.568488836021, 4923.409190897115, 4934.5312195341385, 4940.6788558743565, 4942.678725882806, 5006.4743201963265, 4688.249880019181, 4754.595859351994, 4861.4895435980125, 4919.803207871788, 4951.603871690329], "value": 4639.04778706871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3474665148474, 558.3941423555441, 559.0440347006619, 570.7574280930603, 574.7126436781609, 28677.283067923287, 38896.61103388969, 40459.0, 40535.0, 43730.78134609322, 40499.0, 40817.387739183934, 40861.0, 40899.0, 41010.0, 7635.618219089038, 7793.805154871116, 7804.063512378494, 7806.921930780704, 7807.4144439167, 7576.128745194291, 7635.160132385433, 7653.010217343475, 7667.0, 7675.884861727079, 7660.387169026492, 7712.6529306181355, 7714.961425192866, 7718.0, 7730.0, 7643.885341719851, 7685.308322250969, 7688.5386876787015, 7688.5771282579435, 7703.037120359955, 7581.12817026038, 7651.770446886602, 7658.578778167199, 7680.731174408925, 7683.30850223477, 38512.61487385146, 39085.21829563393, 39086.218275634616, 39132.60867391346, 39143.21713565713, 2893.23329317731, 2893.6382952130984, 2894.6381702287213, 2949.911502654924, 3043.3152540678393, 27759.583606245924, 28608.856955715295, 28633.28416789576, 28895.56656650152, 29535.409291814045, 3405.0205920781295, 3447.5862896452586, 3448.6034106077873, 3450.6204317525053, 3549.6095429502734, 249005.0, 249105.0, 249875.0, 252397.0, 254911.0, 53123.0, 53787.73106134444, 53800.0, 53805.46194538083, 53867.73066134644, 32406.189845253586, 33196.66803331984, 33238.66761332356, 56303.0, 56378.71810640921, 14583.197924114063, 14963.775543366859, 14970.550883473514, 14977.176255306063, 14979.303725329328, 10664.573417063231, 10709.089727373104, 10726.892731072745, 10732.195085368628, 10742.516586753614, 18093.54766130831, 18101.094945252684, 18181.81818181828, 18254.726179107325, 18275.908620456812, 6574.704138313692, 6617.735290588323, 6854.828629284208, 6864.656767161622, 7000.684969176399, 707.8088915992756, 790.3795520516367, 829.5396055189307, 888.7022847346211, 919.4023884475012, 27270.001499175374, 27545.586816197774, 27617.309567260978, 27763.86118069437, 27769.166924991878, 716.3839098375392, 774.7133560582507, 872.1757938747822, 883.6067949762422, 895.3732387328896, 11354.716132096599, 13866.168029918237, 14002.159870407808, 14119.576412707635, 14226.502072427415, 373124.0, 403911.0, 415976.0, 605310.0, 605417.0, 49130.50869491331, 49816.25275620868, 49837.25244121341, 49850.750746246034, 49893.0, 1093.5188517052472, 1118.6867677050277, 1139.9202055856176, 1201.7836789377996, 1208.9637310880864, 27550.173494795188, 29072.709272907847, 29512.704872950995, 30089.097327080224, 30158.69841301559, 40789.38815917704, 41467.1706565873, 41492.170156597305, 41605.79197103995, 41734.791326043174, 323244.0, 325404.0, 327958.0, 328452.0, 374631.0, 35346.823265883504, 37310.813445932596, 37774.811125944194, 37817.0, 38729.806350968065, 41370.1725965485, 41600.79199603983, 41915.16169676528, 42547.787261063495, 42570.57429425666, 35704.0, 36168.09579760527, 36347.63652363443, 36662.08344791402, 36814.44778328274, 36385.63614363928, 36522.06781987654, 36540.81729591335, 37430.0, 37900.2419951605, 35055.29889402249, 35443.0, 35941.28117437689, 36008.0, 36321.81839090788, 28394.574081388382, 32485.18787030343, 32727.836360818044, 33121.668783311856, 33126.0, 25336.873315633304, 25411.745882540938, 25477.872610636827, 25495.745042549337, 25896.22311330663], "value": 17477.91139232776, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8664534186324, 340.475667472093, 346.6014083803626, 351.99824000879994, 375.2289046010449, 12526.436310366043, 13126.47494100236, 15490.535283941486, 15795.0, 16543.91728041358, 16999.150042497888, 17067.231974561142, 17082.402115925946, 17176.570585735364, 17368.82631173691, 4583.564561366665, 4674.088552732219, 4834.637402194832, 5064.746762661871, 5066.822661206858, 4946.431160416562, 5019.749012549358, 5057.291979122907, 5082.974585127069, 5082.974585127069, 4777.498362671921, 5030.6730062546, 5044.092063428581, 5052.823151189709, 5053.898922021557, 4870.951290487103, 4933.654644174909, 4937.21004639256, 4938.555530002317, 4938.777755001033, 4389.868303950887, 4393.20922234001, 4393.36296237047, 4394.428724265825, 4394.8242070317465, 11276.267042642203, 16915.407960721437, 18427.72358414625, 19172.71240931387, 19237.61524769497, 1741.7735694359778, 1829.195154132191, 1856.8700190986635, 1940.088158565472, 2116.1746918701565, 8420.0, 9079.863802042975, 9199.632014719404, 10562.471876406149, 13483.460661573525, 1616.5958510372407, 1699.2523289752469, 1710.042376269293, 1792.3816283382212, 1802.5913495533348, 61301.0, 66115.0, 67570.3242967569, 69650.30349696489, 70617.64691176562, 9357.672481463253, 9548.464479372242, 9733.756656083655, 9772.755681108029, 9860.704178874645, 13152.934235328763, 13163.802542961863, 13165.53920612793, 13168.078234523682, 13172.47310107604, 7146.142462904485, 7386.2613738625705, 7407.296306850948, 7531.924680753123, 7554.735584254525, 7161.67772450241, 7266.7093316266755, 7403.074615673041, 7414.0, 7434.442416818761, 4002.4996875390575, 4126.0, 4135.793210339471, 4229.2598795210715, 4230.85192018284, 1695.8304169582943, 1720.6644704282794, 1754.3684273661472, 1755.7893052833485, 1772.7961284452194, 812.2486699802658, 814.3892080939296, 830.2652152844655, 881.9206271435602, 906.4606559097458, 16448.0, 16984.74522882158, 17017.574560636083, 17244.827551724575, 17426.302947882195, 842.9926238145357, 870.208110619346, 871.7166920750782, 873.2271939333735, 880.6917578847352, 8592.398532102818, 9342.159205671522, 9387.34288599805, 9610.95194524037, 9624.51877406127, 361046.0, 362997.0, 363841.0, 369213.0, 382082.0, 70255.0, 73910.6304468485, 76310.0, 79257.60371198106, 82490.58754706309, 896.3814967672286, 897.8069715011435, 937.095702646949, 949.093615597103, 951.8381875081253, 15462.226888655747, 15467.84532154709, 15800.525984220492, 16416.343346266494, 16468.341266349693, 36532.63467365292, 37593.436098458, 37711.81144094262, 37915.43126853044, 38264.2347153061, 47913.5208647923, 48395.27407088967, 49419.258711118644, 52117.21824172565, 52246.0, 4445.977770111129, 4644.3265726470145, 6677.532572719863, 6768.695408706719, 7322.121345438582, 10085.495725213563, 11572.363520006144, 11723.941380293043, 12071.155019148926, 12131.332776697367, 10064.949675251577, 10102.646407375707, 10117.0, 10161.593536258762, 10219.591216351262, 9525.0, 9940.602375904882, 10019.849702254618, 10162.441065741456, 10255.538500767632, 10171.288009839536, 10436.478176091014, 10461.581536738446, 10506.842397363893, 10700.357978521313, 6990.965045174741, 7070.4343652508705, 7137.072180616487, 7514.47398682087, 7617.0, 9465.195458385839, 10216.335938163995, 10319.432431216355, 10394.740131496774, 10650.786984260116], "value": 7910.479131975169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1177.3936422742283, 1272.5482453728926, 1315.546136582879, 1318.242010843765, 1592.3789722008419, 5715.685637289947, 6189.814305570834, 6362.713677884489, 6366.808995730124, 6554.475641948645, 6404.583702059363, 6460.0, 6460.257070436901, 6466.321036291192, 6469.74121035158, 1993.8404927605793, 2013.929512467064, 2019.0207749241679, 2019.7475315585552, 2019.9293024744136, 1973.6743437332823, 2011.5071807407205, 2021.3834780391974, 2025.1291944463874, 2027.2803154880025, 1974.802519748028, 1984.7122167285736, 2001.1195074167392, 2004.4888553418857, 2007.2372498450568, 1959.5003274165067, 1980.2673010985955, 1980.5939782344585, 1980.8910509921948, 1985.3944546913185, 1930.3822776711459, 1968.3110911181116, 1973.6743437332823, 1978.9010549472468, 1981.4947188466992, 6318.368163183691, 6331.2719037310835, 6434.839129021765, 6444.709988050502, 6461.773837915651, 4006.7395619284653, 4152.0, 4156.584341565849, 4160.209560183585, 4163.458750362463, 2566.525192839331, 2768.9169324920285, 2818.394045280254, 2829.589709492112, 2829.7453229209264, 875.7153924974409, 881.8544940084878, 894.1014280647908, 895.4000819450919, 896.1710417863516, 8199.262066414052, 8272.17278272174, 8278.958605206995, 8279.958600207021, 8338.207870252316, 3259.7392208623255, 3500.7199424046016, 3553.857845686195, 3559.199180184438, 3570.696490798259, 6905.1713794344, 6906.309369063154, 6907.205671347759, 6908.585484870924, 6926.619035953071, 4004.5795191505053, 4004.739691920016, 4006.719529632956, 4008.378701301303, 4009.959900401017, 3373.8313084345687, 3473.513708080871, 3626.1841085756023, 3690.2435000824767, 3754.962450375516, 2855.3718181999925, 2870.5263631500984, 2949.83775892328, 2959.9704002959693, 2992.745616622568, 901.1124042817819, 912.0, 935.5649622925372, 937.0863408176973, 942.6370847223731, 694.944404447643, 695.2387136085978, 716.7455553278616, 724.478375569589, 766.5937053361728, 4472.552744725566, 4523.502414734442, 4566.086782643484, 4566.771661416916, 4626.074785043005, 387.40533281412894, 388.42707007164205, 401.63852532720784, 404.3106503411676, 405.1956865621739, 3216.4210442120175, 3219.3239419721654, 3250.5124231365485, 3287.819169945628, 3329.7003269705842, 7321.670524826395, 7669.7315593953945, 7695.92304076952, 7697.923020769833, 7729.536227826348, 7658.425618078666, 7666.271704188093, 7669.654865531064, 7671.424643151786, 7680.615969201517, 6071.635701857903, 6132.172156758869, 6133.172021777093, 6135.355787642323, 6135.815925522242, 4616.492185859485, 4659.860204193744, 4695.835645752382, 4792.520747925179, 4860.295257187759, 6848.1097457330225, 6951.548149370275, 7074.50478466523, 7083.929160708327, 7084.220735718964, 7096.148462184571, 7109.680064397218, 7121.4302855770375, 7121.572705637678, 7131.0729605151, 5180.352455943007, 5628.577856660849, 5754.798582049608, 5807.070868660994, 5814.127880817911, 5812.099124635688, 5893.2044174035955, 6067.757289708362, 6075.969620151871, 6214.067889816563, 5553.16702494629, 5606.103023516218, 5623.831285061455, 5649.887002260014, 5734.397888221677, 5367.543758780547, 5419.891602167856, 5467.972660136674, 5484.972575137099, 5517.36550296721, 5339.065663508948, 5353.036453438419, 5395.055865223491, 5414.269073675004, 5419.918701219563, 3882.1071153634257, 3930.76415415076, 4055.7160998729805, 4057.107436363995, 4095.1400205955892, 4036.2129384769687, 4061.309577371913, 4114.526829414655, 4136.937945930874, 4166.500019997619], "value": 3469.3091495622643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.0787132783494, 284.4978612748499, 286.0888071492296, 290.25694222789656, 292.4925254683125, 4617.376654151689, 4763.35694681218, 4780.402449693788, 4844.854654360371, 4872.926906096412, 4663.883402914928, 4676.942145455997, 4745.952540474595, 4771.761411929407, 4789.688670236432, 3758.379867321902, 3759.7404869368793, 3760.247950409922, 3763.322601931651, 3764.8705388383514, 3681.6193927277272, 3762.3980163173896, 3762.774233545996, 3766.717496187783, 3771.905702357449, 3697.7781333119965, 3708.0, 3718.8326525306425, 3719.163188282642, 3721.7208709346774, 3695.5011073505, 3696.9445458318146, 3708.3510385682534, 3718.8140592970244, 3719.619443556126, 3248.772585918987, 3260.2827377976805, 3261.3693153423287, 3269.280758233209, 3276.4921437177036, 4552.294394368878, 4632.72203667781, 4660.6970546914345, 4675.509071547506, 4704.1767690654, 4187.623113919762, 4223.0, 4223.107171587472, 4225.619694227504, 4232.76719780412, 4966.683828785374, 4971.105201063807, 4976.576990955773, 4979.551840334388, 4989.950100498985, 3557.1107223194203, 3558.0, 3558.5195998540125, 3566.964330356689, 3568.839402226906, 4998.500149985009, 5210.244514545369, 5230.424653288173, 5254.395744489356, 5277.313949186581, 3541.3979623464074, 3545.663161999606, 3549.580167932796, 3552.342816578941, 3560.9821950890077, 3598.712103031751, 3604.98197509016, 3611.133328001261, 3618.656227658368, 3621.764585301947, 3938.8030598469963, 4185.0, 4186.769727664947, 4190.497140343178, 4195.15413218183, 4983.875403114951, 5029.748512574357, 5051.898962020812, 5052.292679024939, 5060.645754797129, 1155.5377848860523, 1173.5951096871565, 1186.851643544557, 1200.3038237822043, 1210.7881120804, 805.4804651000072, 816.420341557489, 825.1500954017372, 825.9710910118117, 826.3265438667466, 4223.704340696183, 4229.450171477688, 4249.235137675187, 4266.786660666954, 4268.445102136764, 4959.776810043557, 4960.313493412257, 4987.9525299687475, 4989.800407983713, 4994.550490455877, 4235.37406807775, 4240.660747140221, 4306.2894622387585, 4314.870553883388, 4317.222899877989, 2537.9492410151693, 2619.2535127488954, 2674.7532073058337, 2696.8786404611837, 2697.473992571469, 4739.431268247763, 4773.902002539436, 4781.258904869751, 4793.736344501086, 4796.25658023007, 5123.666961647481, 5158.220413957179, 5158.226266060046, 5181.4559471255725, 5200.869978250574, 4501.212287849678, 4734.130018642617, 4747.810087596457, 4777.1878780606685, 4788.688735232199, 5061.367329083864, 5072.873178170576, 5080.665301433554, 5085.694858308513, 5093.312402825572, 4936.506349365035, 5000.174866227267, 5012.0, 5028.723420211923, 5029.371328583927, 4606.746628935441, 4864.829730959399, 4900.705957642553, 4911.312416261655, 4926.137925863031, 3548.8225588720975, 3555.7155427565217, 3609.278144371189, 3609.4224924012033, 3612.620674829105, 5237.711925844115, 5240.659357141773, 5243.659162154448, 5248.6588371755715, 5253.816116435906, 4694.413198350207, 4768.737719425465, 5029.27075574047, 5047.9747601263225, 5089.6691715038405, 5093.796248150181, 5101.081805274937, 5104.1067813133295, 5110.4123025852505, 5114.488551144856, 4803.5916947058495, 4952.360015388758, 4955.40535135786, 4955.454899961073, 4958.6281028923695, 5093.592512599057, 5117.692938423706, 5119.953627591577, 5128.871778205575, 5131.409263128442, 5010.173321401928, 5012.7693176536095, 5020.146575082318, 5020.268007537394, 5032.723200223876], "value": 3733.4687593663825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.5279035894571, 664.80055983205, 669.7843414203221, 712.9287071292874, 731.7146312937955, 11637.650870473888, 12506.249625022494, 12578.622641320764, 12646.557370492035, 12662.43019064142, 12101.576444824434, 12240.265584064962, 12241.0, 12252.754944901097, 12260.325682087503, 621.773052835714, 637.2098597738817, 751.4176513202258, 753.0737193252276, 774.3302043732187, 772.9613519324039, 776.4681193382551, 776.4836383804763, 776.7475570439601, 776.7786180938434, 821.6343727041469, 822.5517093184229, 823.1110400767187, 823.5347028928636, 823.7734622978669, 652.8106849013805, 669.0165456778528, 787.6258777080898, 798.1419973528422, 820.0323618130603, 589.8142085243135, 589.9439553242435, 590.038237672591, 590.9852253693649, 591.3583761618648, 12067.758644827141, 12226.449809758582, 12251.816222756666, 12274.140810143293, 12283.877161228364, 11745.177837551375, 11806.0, 12059.6382108536, 12126.75986269345, 12323.322217278046, 10051.231037055459, 10196.3372380795, 10372.844407333821, 10391.948040259751, 10722.731931701692, 3867.864624738149, 3882.262370149691, 3886.630770076838, 3925.2738243425056, 3954.584768599313, 45240.773796131136, 48003.75998120022, 48164.27753583664, 48183.518164818255, 48213.51786482125, 9339.392939458914, 9355.4386736796, 9394.859077113848, 9421.340506164639, 9428.528573571293, 16994.745078823827, 17105.401310954057, 17147.056911869717, 17275.0, 17446.127693615268, 6136.754529818846, 6253.812385628438, 6322.9051564226575, 6516.576422532615, 6583.07836902834, 3281.9343613127603, 3303.587051618548, 3353.463445848701, 3388.9322213556084, 3482.1294676330917, 2576.510463012022, 2635.0777227970057, 2654.632864075003, 2655.4290827472187, 2658.016533882437, 446.2035267048368, 449.7369039112156, 462.36424915740855, 462.54208333749347, 469.50701763148555, 527.1024312475136, 542.9782808687609, 547.5838362844268, 549.4395716369281, 553.9335279766453, 6765.594064356154, 6783.491238157158, 6791.796246112624, 6861.245263021064, 6874.415674667609, 501.4308759557855, 517.5730022731186, 521.5097808060411, 527.5304978569077, 532.0210812105744, 3890.727649064595, 4017.4375587417785, 4083.1629515949753, 4299.634531064832, 4411.073674528385, 38846.22307553833, 39903.600963989986, 40150.397744033864, 40352.39471407931, 70155.64922175357, 35003.82498087493, 49159.50840491621, 53339.46660533422, 56423.43576564182, 57270.42729572734, 44807.999999999345, 45423.0, 50989.745051274505, 52069.739651301505, 52532.737336313076, 7597.727465445612, 7942.068910448551, 7988.360931125612, 8307.127751585997, 8346.749597512084, 26651.20046398611, 33328.333433330714, 35201.29597407986, 36106.63893361138, 38469.41310937755, 32126.83936580302, 32838.34323313473, 45402.77298613618, 47245.527544724115, 48108.0, 10109.949450252701, 10514.421706806199, 10577.36535807854, 10633.840492392466, 10706.464676766287, 11557.711057223636, 11835.0, 11841.467133979164, 12598.055145863913, 12707.110502264753, 10529.736756581147, 10606.734831629272, 10739.624113156002, 10850.131989440984, 11199.21605487608, 11079.889201107886, 11320.547178112784, 11352.716182095184, 11755.529778809094, 11831.112666550216, 10301.536430860779, 10449.9477502612, 10472.633457828939, 10635.415052172204, 10694.60141698495, 8601.913980860112, 8878.37851350425, 9067.455952642862, 9132.908670913472, 9157.175854173156, 8049.476784009021, 8375.0, 8566.143385661384, 8751.212390884852, 8753.387262891536], "value": 5803.944682999106, "unit": "score"}], "name": "dromaeo_css", "value": 6033.133769740871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 116.0, 119.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 128.0, 174.0, 130.0, 139.0, 131.0, 127.0, 157.0, 130.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 163.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 103.0, 78.0, 77.0, 78.0, 76.0, 100.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 84.0, 84.0, 83.0, 114.0, 83.0, 83.0, 119.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 68.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 83.0, 83.0, 85.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 140.0, 142.0, 141.0, 143.0, 146.0, 145.0, 141.0, 183.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 177.0, 176.0, 183.0, 174.0, 177.0, 179.0, 175.0, 176.0, 180.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 69.0, 70.0, 68.0, 70.0, 69.0, 68.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1560.3999999999999, "alertThreshold": 2.0}]} 12:42:34 INFO - Return code: 0 12:42:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:42:34 INFO - # TBPL SUCCESS # 12:42:34 INFO - Running post-action listener: _resource_record_post_action 12:42:34 INFO - [mozharness: 2016-11-16 20:42:34.509465Z] Finished run-tests step (success) 12:42:34 INFO - Running post-run listener: _resource_record_post_run 12:42:34 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401727488; Read time: 12; Write time: 238488 12:42:34 INFO - TinderboxPrint: CPU usage
13.1% 12:42:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:42:34 INFO - TinderboxPrint: I/O write bytes / time
401,727,488 / 238,488 12:42:34 INFO - TinderboxPrint: CPU idle
8,354.7 (86.9%) 12:42:34 INFO - TinderboxPrint: CPU user
1,209.5 (12.6%) 12:42:34 INFO - TinderboxPrint: Swap in / out
0 / 0 12:42:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110403584; Read time: 0; Write time: 56464 12:42:34 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291323904; Read time: 0; Write time: 182024 12:42:35 INFO - Running post-run listener: _upload_blobber_files 12:42:35 INFO - Blob upload gear active. 12:42:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:42: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 12:42: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'] 12:42: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 12:42:35 INFO - (blobuploader) - INFO - Open directory for files ... 12:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:42:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:36 INFO - (blobuploader) - INFO - Done attempting. 12:42:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:42:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:40 INFO - (blobuploader) - INFO - Done attempting. 12:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:42:41 INFO - (blobuploader) - INFO - Done attempting. 12:42:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:42:41 INFO - Return code: 0 12:42:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:42:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:42:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c03763c24ec5f1bd8eb46424ab6977f8f2755293f9b1f56598670f1a5f6b96abb16f2040649617de8e7b29cbe0e295955eec9245e758d1e3d6e088262170abd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eee4ff840a7ac1cdbba6e2e9d2e84210217bae48f4fb77ae5bb2eb9766164ea9d69a5398ab8875e79fa9a2e2a32ffcfec86af524921697b4e2d88e6b5bb31815", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f0a526c038c060d3f72e3cf4771427b8992b580ab056e848ba9f55154f6da100b9bd05b18c2d9db66a7f48559bec863c1bd2a5c8241002ce3f633acf4a51358"} 12:42:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:42:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:42:41 INFO - Contents: 12:42:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c03763c24ec5f1bd8eb46424ab6977f8f2755293f9b1f56598670f1a5f6b96abb16f2040649617de8e7b29cbe0e295955eec9245e758d1e3d6e088262170abd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eee4ff840a7ac1cdbba6e2e9d2e84210217bae48f4fb77ae5bb2eb9766164ea9d69a5398ab8875e79fa9a2e2a32ffcfec86af524921697b4e2d88e6b5bb31815", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f0a526c038c060d3f72e3cf4771427b8992b580ab056e848ba9f55154f6da100b9bd05b18c2d9db66a7f48559bec863c1bd2a5c8241002ce3f633acf4a51358"} 12:42:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:42:41 INFO - Copying logs to upload dir... 12:42:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:42:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.511394 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-16 12:42:40.355833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 12:42:40.360847) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842 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/c03763c24ec5f1bd8eb46424ab6977f8f2755293f9b1f56598670f1a5f6b96abb16f2040649617de8e7b29cbe0e295955eec9245e758d1e3d6e088262170abd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eee4ff840a7ac1cdbba6e2e9d2e84210217bae48f4fb77ae5bb2eb9766164ea9d69a5398ab8875e79fa9a2e2a32ffcfec86af524921697b4e2d88e6b5bb31815", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f0a526c038c060d3f72e3cf4771427b8992b580ab056e848ba9f55154f6da100b9bd05b18c2d9db66a7f48559bec863c1bd2a5c8241002ce3f633acf4a51358"} build_url:https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/QCNAB_7_TVm5_NqxpEmwTA/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/c03763c24ec5f1bd8eb46424ab6977f8f2755293f9b1f56598670f1a5f6b96abb16f2040649617de8e7b29cbe0e295955eec9245e758d1e3d6e088262170abd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eee4ff840a7ac1cdbba6e2e9d2e84210217bae48f4fb77ae5bb2eb9766164ea9d69a5398ab8875e79fa9a2e2a32ffcfec86af524921697b4e2d88e6b5bb31815", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8f0a526c038c060d3f72e3cf4771427b8992b580ab056e848ba9f55154f6da100b9bd05b18c2d9db66a7f48559bec863c1bd2a5c8241002ce3f633acf4a51358"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 12:42:40.393300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:42:40.393637) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479324388.264055-1713758842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 12:42:40.476543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 12:42:40.476907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 12:42:40.477242) ========= ========= Total master_lag: 0.21 =========