builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1475063562.35 results: success (0) buildid: 20160928041920 builduid: f99144e20a9c49509718a383b33bce30 revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.348102) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.348833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.349177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.765051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.765397) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 04:52:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.9M=0s 2016-09-28 04:52:43 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.894645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.894942) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014484 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:42.946824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 04:52:42.950211) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --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=74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 04:52:43,503 truncating revision to first 12 chars 2016-09-28 04:52:43,503 Setting DEBUG logging. 2016-09-28 04:52:43,503 attempt 1/10 2016-09-28 04:52:43,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc513f0359eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 04:52:44,788 unpacking tar archive at: fx-team-fc513f0359eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.637003 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 04:52:44.600430) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:44.600762) ========= script_repo_revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:44.601232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:44.601554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 04:52:44.611328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-28 04:52:44.611688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:45 INFO - MultiFileLogger online at 20160928 04:52:45 in /builds/slave/test 04:52:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:52:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:45 INFO - {'append_to_log': False, 04:52:45 INFO - 'base_work_dir': '/builds/slave/test', 04:52:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:52:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:45 INFO - 'branch': 'Fx-Team-Non-PGO', 04:52:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:45 INFO - 'config_files': ('talos/linux_config.py',), 04:52:45 INFO - 'default_actions': ('clobber', 04:52:45 INFO - 'read-buildbot-config', 04:52:45 INFO - 'download-and-extract', 04:52:45 INFO - 'populate-webroot', 04:52:45 INFO - 'create-virtualenv', 04:52:45 INFO - 'install', 04:52:45 INFO - 'run-tests'), 04:52:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:45 INFO - 'download_minidump_stackwalk': True, 04:52:45 INFO - 'download_symbols': 'ondemand', 04:52:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:45 INFO - 'installer_path': 'installer.exe', 04:52:45 INFO - 'log_level': 'info', 04:52:45 INFO - 'log_name': 'talos', 04:52:45 INFO - 'log_to_console': True, 04:52:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:45 INFO - 'opt_config_files': (), 04:52:45 INFO - 'pip_index': False, 04:52:45 INFO - 'sps_profile': False, 04:52:45 INFO - 'sps_profile_interval': 0, 04:52:45 INFO - 'suite': 'dromaeojs', 04:52:45 INFO - 'system_bits': '32', 04:52:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:45 INFO - 'title': 'talos-linux64-ix-042', 04:52:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:45 INFO - 'use_talos_json': True, 04:52:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:45 INFO - 'work_dir': 'build'} 04:52:45 INFO - [mozharness: 2016-09-28 11:52:45.260794Z] Running clobber step. 04:52:45 INFO - Running pre-action listener: _resource_record_pre_action 04:52:45 INFO - Running main action method: clobber 04:52:45 INFO - rmtree: /builds/slave/test/build 04:52:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - [mozharness: 2016-09-28 11:52:46.231782Z] Finished clobber step (success) 04:52:46 INFO - [mozharness: 2016-09-28 11:52:46.231885Z] Running read-buildbot-config step. 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: read_buildbot_config 04:52:46 INFO - Using buildbot properties: 04:52:46 INFO - { 04:52:46 INFO - "project": "", 04:52:46 INFO - "product": "firefox", 04:52:46 INFO - "script_repo_revision": "production", 04:52:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:52:46 INFO - "repository": "", 04:52:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:52:46 INFO - "buildid": "20160928041920", 04:52:46 INFO - "pgo_build": "False", 04:52:46 INFO - "basedir": "/builds/slave/test", 04:52:46 INFO - "buildnumber": 2176, 04:52:46 INFO - "slavename": "talos-linux64-ix-042", 04:52:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:52:46 INFO - "platform": "ubuntu64_hw", 04:52:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:52:46 INFO - "branch": "fx-team", 04:52:46 INFO - "repo_path": "integration/fx-team", 04:52:46 INFO - "revision": "fc513f0359ebca43d8b791a458583aeb3bb37f42", 04:52:46 INFO - "stage_platform": "linux64", 04:52:46 INFO - "builduid": "f99144e20a9c49509718a383b33bce30", 04:52:46 INFO - "slavebuilddir": "test" 04:52:46 INFO - } 04:52:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - [mozharness: 2016-09-28 11:52:46.234352Z] Finished read-buildbot-config step (success) 04:52:46 INFO - [mozharness: 2016-09-28 11:52:46.234441Z] Running download-and-extract step. 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: download_and_extract 04:52:46 INFO - mkdir: /builds/slave/test/build/tests 04:52:46 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')]} 04:52:46 INFO - trying https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:52:46 INFO - Downloading https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:52:46 INFO - Downloaded 1361 bytes. 04:52:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:52:46 INFO - Using the following test package requirements: 04:52:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:52:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:52:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'jsshell-linux-x86_64.zip'], 04:52:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:52:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:52:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:52:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:52:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:52:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:52:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:52:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:46 INFO - Fetch https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:52:47 INFO - Expected file size: 20413434 04:52:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:52:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:52:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:52:52 INFO - Expected file size: 20413434 04:52:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:52:58 INFO - Fetch https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:52:58 INFO - Expected file size: 14414062 04:52:59 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')]} 04:52:59 INFO - trying https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:52:59 INFO - Downloading https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:53:02 INFO - Downloaded 55729801 bytes. 04:53:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:53:02 INFO - mkdir: /builds/slave/test/properties 04:53:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:02 INFO - Contents: 04:53:02 INFO - build_url:https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:53:03 INFO - Running post-action listener: _resource_record_post_action 04:53:03 INFO - Running post-action listener: set_extra_try_arguments 04:53:03 INFO - [mozharness: 2016-09-28 11:53:03.346216Z] Finished download-and-extract step (success) 04:53:03 INFO - [mozharness: 2016-09-28 11:53:03.346443Z] Running populate-webroot step. 04:53:03 INFO - Running pre-action listener: _resource_record_pre_action 04:53:03 INFO - Running main action method: populate_webroot 04:53:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:03 INFO - '--tppagecycles', 04:53:03 INFO - '7'], 04:53:03 INFO - 'tests': ['tsvgm']}}, 04:53:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['damp', 'tps']}, 04:53:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'tests': ['damp', 'tps']}, 04:53:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['dromaeo_dom']}, 04:53:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['basic_compositor_video']}, 04:53:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:53:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['a11yr', 04:53:03 INFO - 'ts_paint', 04:53:03 INFO - 'tpaint', 04:53:03 INFO - 'sessionrestore', 04:53:03 INFO - 'sessionrestore_no_auto_restore', 04:53:03 INFO - 'tabpaint']}, 04:53:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:03 INFO - 'ts_paint', 04:53:03 INFO - 'tpaint', 04:53:03 INFO - 'sessionrestore', 04:53:03 INFO - 'sessionrestore_no_auto_restore', 04:53:03 INFO - 'tabpaint']}, 04:53:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:03 INFO - 'ts_paint', 04:53:03 INFO - 'tpaint', 04:53:03 INFO - 'sessionrestore', 04:53:03 INFO - 'sessionrestore_no_auto_restore', 04:53:03 INFO - 'tabpaint']}, 04:53:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:03 INFO - 'ts_paint', 04:53:03 INFO - 'tpaint', 04:53:03 INFO - 'sessionrestore', 04:53:03 INFO - 'sessionrestore_no_auto_restore', 04:53:03 INFO - 'tabpaint']}, 04:53:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['a11yr', 04:53:03 INFO - 'ts_paint', 04:53:03 INFO - 'tpaint', 04:53:03 INFO - 'sessionrestore', 04:53:03 INFO - 'sessionrestore_no_auto_restore', 04:53:03 INFO - 'tabpaint']}, 04:53:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['a11yr', 04:53:03 INFO - 'ts_paint', 04:53:03 INFO - 'tpaint', 04:53:03 INFO - 'sessionrestore', 04:53:03 INFO - 'sessionrestore_no_auto_restore', 04:53:03 INFO - 'tabpaint']}, 04:53:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['tsvgx', 04:53:03 INFO - 'tsvgr_opacity', 04:53:03 INFO - 'tart', 04:53:03 INFO - 'tscrollx', 04:53:03 INFO - 'cart']}, 04:53:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:03 INFO - 'tsvgr_opacity', 04:53:03 INFO - 'tart', 04:53:03 INFO - 'tscrollx', 04:53:03 INFO - 'cart']}, 04:53:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'talos_options': ['--disable-e10s'], 04:53:03 INFO - 'tests': ['tp5o']}, 04:53:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'tests': ['tp5o']}, 04:53:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'talos_options': ['--disable-e10s', 04:53:03 INFO - '--xperf_path', 04:53:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:03 INFO - 'tests': ['tp5n']}, 04:53:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:03 INFO - 'talos_options': ['--xperf_path', 04:53:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:03 INFO - 'tests': ['tp5n']}}, 04:53:03 INFO - 'talos.zip': {'path': '', 04:53:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:03 INFO - Running post-action listener: _resource_record_post_action 04:53:03 INFO - [mozharness: 2016-09-28 11:53:03.363690Z] Finished populate-webroot step (success) 04:53:03 INFO - [mozharness: 2016-09-28 11:53:03.363780Z] Running create-virtualenv step. 04:53:03 INFO - Running pre-action listener: _resource_record_pre_action 04:53:03 INFO - Running main action method: create_virtualenv 04:53:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:53:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:03 INFO - Using real prefix '/usr' 04:53:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:05 INFO - Installing pip.................done. 04:53:05 INFO - Return code: 0 04:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:06 INFO - Reading from file tmpfile_stdout 04:53:06 INFO - Output received: 04:53:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:53:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:06 INFO - Using env: {'DISPLAY': ':0', 04:53:06 INFO - 'HOME': '/home/cltbld', 04:53:06 INFO - 'LANG': 'en_US.UTF-8', 04:53:06 INFO - 'LANGUAGE': 'en_US:en', 04:53:06 INFO - 'LOGNAME': 'cltbld', 04:53:06 INFO - 'MAIL': '/var/mail/cltbld', 04:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:06 INFO - 'MOZ_NO_REMOTE': '1', 04:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:06 INFO - 'NO_EM_RESTART': '1', 04:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:06 INFO - 'PWD': '/builds/slave/test', 04:53:06 INFO - 'SHELL': '/bin/bash', 04:53:06 INFO - 'SHLVL': '1', 04:53:06 INFO - 'TERM': 'linux', 04:53:06 INFO - 'TMOUT': '86400', 04:53:06 INFO - 'USER': 'cltbld', 04:53:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:06 INFO - '_': '/tools/buildbot/bin/python'} 04:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:06 INFO - Cleaning up... 04:53:06 INFO - Return code: 0 04:53:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:53:06 INFO - Using env: {'DISPLAY': ':0', 04:53:06 INFO - 'HOME': '/home/cltbld', 04:53:06 INFO - 'LANG': 'en_US.UTF-8', 04:53:06 INFO - 'LANGUAGE': 'en_US:en', 04:53:06 INFO - 'LOGNAME': 'cltbld', 04:53:06 INFO - 'MAIL': '/var/mail/cltbld', 04:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:06 INFO - 'MOZ_NO_REMOTE': '1', 04:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:06 INFO - 'NO_EM_RESTART': '1', 04:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:06 INFO - 'PWD': '/builds/slave/test', 04:53:06 INFO - 'SHELL': '/bin/bash', 04:53:06 INFO - 'SHLVL': '1', 04:53:06 INFO - 'TERM': 'linux', 04:53:06 INFO - 'TMOUT': '86400', 04:53:06 INFO - 'USER': 'cltbld', 04:53:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:06 INFO - '_': '/tools/buildbot/bin/python'} 04:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:06 INFO - Downloading/unpacking psutil>=3.1.1 04:53:06 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 04:53:06 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 04:53:06 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 04:53:06 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 04:53:06 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 04:53:06 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 04:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:08 INFO - Installing collected packages: psutil 04:53:08 INFO - Running setup.py install for psutil 04:53:08 INFO - building 'psutil._psutil_linux' extension 04:53:08 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 04:53:08 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 04:53:08 INFO - building 'psutil._psutil_posix' extension 04:53:08 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 04:53:08 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 04:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:09 INFO - Successfully installed psutil 04:53:09 INFO - Cleaning up... 04:53:09 INFO - Return code: 0 04:53:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:53: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 mozsystemmonitor==0.3 04:53:09 INFO - Using env: {'DISPLAY': ':0', 04:53:09 INFO - 'HOME': '/home/cltbld', 04:53:09 INFO - 'LANG': 'en_US.UTF-8', 04:53:09 INFO - 'LANGUAGE': 'en_US:en', 04:53:09 INFO - 'LOGNAME': 'cltbld', 04:53:09 INFO - 'MAIL': '/var/mail/cltbld', 04:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:09 INFO - 'MOZ_NO_REMOTE': '1', 04:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:09 INFO - 'NO_EM_RESTART': '1', 04:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:09 INFO - 'PWD': '/builds/slave/test', 04:53:09 INFO - 'SHELL': '/bin/bash', 04:53:09 INFO - 'SHLVL': '1', 04:53:09 INFO - 'TERM': 'linux', 04:53:09 INFO - 'TMOUT': '86400', 04:53:09 INFO - 'USER': 'cltbld', 04:53:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:09 INFO - '_': '/tools/buildbot/bin/python'} 04:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:09 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 04:53:09 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 04:53:09 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 04:53:09 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 04:53:09 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 04:53:09 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 04:53:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:11 INFO - Installing collected packages: mozsystemmonitor 04:53:11 INFO - Running setup.py install for mozsystemmonitor 04:53:11 INFO - Successfully installed mozsystemmonitor 04:53:11 INFO - Cleaning up... 04:53:11 INFO - Return code: 0 04:53:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:11 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')]} 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:11 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')]} 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:11 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 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:11 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 04:53:11 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 04:53:11 INFO - Using env: {'DISPLAY': ':0', 04:53:11 INFO - 'HOME': '/home/cltbld', 04:53:11 INFO - 'LANG': 'en_US.UTF-8', 04:53:11 INFO - 'LANGUAGE': 'en_US:en', 04:53:11 INFO - 'LOGNAME': 'cltbld', 04:53:11 INFO - 'MAIL': '/var/mail/cltbld', 04:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:11 INFO - 'MOZ_NO_REMOTE': '1', 04:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:11 INFO - 'NO_EM_RESTART': '1', 04:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:11 INFO - 'PWD': '/builds/slave/test', 04:53:11 INFO - 'SHELL': '/bin/bash', 04:53:11 INFO - 'SHLVL': '1', 04:53:11 INFO - 'TERM': 'linux', 04:53:11 INFO - 'TMOUT': '86400', 04:53:11 INFO - 'USER': 'cltbld', 04:53:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:11 INFO - '_': '/tools/buildbot/bin/python'} 04:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:11 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:13 INFO - warning: no files found matching '*.txt' 04:53:13 INFO - no previously-included directories found matching 'build' 04:53:13 INFO - no previously-included directories found matching 'dist' 04:53:13 INFO - no previously-included directories found matching '.git*' 04:53:13 INFO - Installing collected packages: jsonschema, functools32 04:53:13 INFO - Running setup.py install for functools32 04:53:13 INFO - warning: no files found matching '*.txt' 04:53:13 INFO - no previously-included directories found matching 'build' 04:53:13 INFO - no previously-included directories found matching 'dist' 04:53:13 INFO - no previously-included directories found matching '.git*' 04:53:13 INFO - Successfully installed jsonschema functools32 04:53:13 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:14 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')]} 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 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')]} 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 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 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:14 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 04:53:14 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 04:53:14 INFO - Using env: {'DISPLAY': ':0', 04:53:14 INFO - 'HOME': '/home/cltbld', 04:53:14 INFO - 'LANG': 'en_US.UTF-8', 04:53:14 INFO - 'LANGUAGE': 'en_US:en', 04:53:14 INFO - 'LOGNAME': 'cltbld', 04:53:14 INFO - 'MAIL': '/var/mail/cltbld', 04:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:14 INFO - 'MOZ_NO_REMOTE': '1', 04:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:14 INFO - 'NO_EM_RESTART': '1', 04:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:14 INFO - 'PWD': '/builds/slave/test', 04:53:14 INFO - 'SHELL': '/bin/bash', 04:53:14 INFO - 'SHLVL': '1', 04:53:14 INFO - 'TERM': 'linux', 04:53:14 INFO - 'TMOUT': '86400', 04:53:14 INFO - 'USER': 'cltbld', 04:53:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:14 INFO - '_': '/tools/buildbot/bin/python'} 04:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:14 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:14 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')]} 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 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')]} 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 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 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:14 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 04:53:14 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 04:53:14 INFO - Using env: {'DISPLAY': ':0', 04:53:14 INFO - 'HOME': '/home/cltbld', 04:53:14 INFO - 'LANG': 'en_US.UTF-8', 04:53:14 INFO - 'LANGUAGE': 'en_US:en', 04:53:14 INFO - 'LOGNAME': 'cltbld', 04:53:14 INFO - 'MAIL': '/var/mail/cltbld', 04:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:14 INFO - 'MOZ_NO_REMOTE': '1', 04:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:14 INFO - 'NO_EM_RESTART': '1', 04:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:14 INFO - 'PWD': '/builds/slave/test', 04:53:14 INFO - 'SHELL': '/bin/bash', 04:53:14 INFO - 'SHLVL': '1', 04:53:14 INFO - 'TERM': 'linux', 04:53:14 INFO - 'TMOUT': '86400', 04:53:14 INFO - 'USER': 'cltbld', 04:53:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:14 INFO - '_': '/tools/buildbot/bin/python'} 04:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 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 04:53:14 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 04:53:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:17 INFO - Downloading docopt-0.6.1.tar.gz 04:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:17 INFO - Running setup.py install for blobuploader 04:53:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:17 INFO - Running setup.py install for requests 04:53:17 INFO - Running setup.py install for docopt 04:53:17 INFO - Successfully installed blobuploader requests docopt 04:53:17 INFO - Cleaning up... 04:53:17 INFO - Return code: 0 04:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:17 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 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:17 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 04:53:17 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 04:53:17 INFO - Using env: {'DISPLAY': ':0', 04:53:17 INFO - 'HOME': '/home/cltbld', 04:53:17 INFO - 'LANG': 'en_US.UTF-8', 04:53:17 INFO - 'LANGUAGE': 'en_US:en', 04:53:17 INFO - 'LOGNAME': 'cltbld', 04:53:17 INFO - 'MAIL': '/var/mail/cltbld', 04:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:17 INFO - 'MOZ_NO_REMOTE': '1', 04:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:17 INFO - 'NO_EM_RESTART': '1', 04:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:17 INFO - 'PWD': '/builds/slave/test', 04:53:17 INFO - 'SHELL': '/bin/bash', 04:53:17 INFO - 'SHLVL': '1', 04:53:17 INFO - 'TERM': 'linux', 04:53:17 INFO - 'TMOUT': '86400', 04:53:17 INFO - 'USER': 'cltbld', 04:53:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:17 INFO - '_': '/tools/buildbot/bin/python'} 04:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:18 INFO - Running setup.py (path:/tmp/pip-tn0qOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:18 INFO - Running setup.py (path:/tmp/pip-IFk9sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:18 INFO - Running setup.py (path:/tmp/pip-5JSH7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:18 INFO - Running setup.py (path:/tmp/pip-RhZQuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:18 INFO - Running setup.py (path:/tmp/pip-ErzwlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:18 INFO - Running setup.py (path:/tmp/pip-LQfcCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:18 INFO - Running setup.py (path:/tmp/pip-5ABcxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:18 INFO - Running setup.py (path:/tmp/pip-iNbsVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:18 INFO - Running setup.py (path:/tmp/pip-f94dQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:18 INFO - Running setup.py (path:/tmp/pip-GAf3g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:18 INFO - Running setup.py (path:/tmp/pip-_yMrne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:18 INFO - Running setup.py (path:/tmp/pip-uZ8x5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:18 INFO - Running setup.py (path:/tmp/pip-9_iZZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:18 INFO - Running setup.py (path:/tmp/pip-skqA_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:19 INFO - Running setup.py (path:/tmp/pip-eBU_JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:19 INFO - Running setup.py (path:/tmp/pip-RBYUMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:19 INFO - Running setup.py (path:/tmp/pip-FyKweL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:19 INFO - Running setup.py install for manifestparser 04:53:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:19 INFO - Running setup.py install for mozcrash 04:53:19 INFO - Running setup.py install for mozdebug 04:53:19 INFO - Running setup.py install for mozdevice 04:53:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:19 INFO - Running setup.py install for mozfile 04:53:19 INFO - Running setup.py install for mozhttpd 04:53:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:19 INFO - Running setup.py install for mozinfo 04:53:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:19 INFO - Running setup.py install for mozInstall 04:53:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozleak 04:53:20 INFO - Running setup.py install for mozlog 04:53:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for moznetwork 04:53:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozprocess 04:53:20 INFO - Running setup.py install for mozprofile 04:53:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozrunner 04:53:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:20 INFO - Running setup.py install for mozscreenshot 04:53:20 INFO - Running setup.py install for moztest 04:53:20 INFO - Running setup.py install for mozversion 04:53:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:21 INFO - Cleaning up... 04:53:21 INFO - Return code: 0 04:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:21 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 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:21 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 04:53:21 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 04:53:21 INFO - Using env: {'DISPLAY': ':0', 04:53:21 INFO - 'HOME': '/home/cltbld', 04:53:21 INFO - 'LANG': 'en_US.UTF-8', 04:53:21 INFO - 'LANGUAGE': 'en_US:en', 04:53:21 INFO - 'LOGNAME': 'cltbld', 04:53:21 INFO - 'MAIL': '/var/mail/cltbld', 04:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:21 INFO - 'MOZ_NO_REMOTE': '1', 04:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:21 INFO - 'NO_EM_RESTART': '1', 04:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:21 INFO - 'PWD': '/builds/slave/test', 04:53:21 INFO - 'SHELL': '/bin/bash', 04:53:21 INFO - 'SHLVL': '1', 04:53:21 INFO - 'TERM': 'linux', 04:53:21 INFO - 'TMOUT': '86400', 04:53:21 INFO - 'USER': 'cltbld', 04:53:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:21 INFO - '_': '/tools/buildbot/bin/python'} 04:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:21 INFO - Running setup.py (path:/tmp/pip-dKKn8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:21 INFO - Running setup.py (path:/tmp/pip-hYqeu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:21 INFO - Running setup.py (path:/tmp/pip-s5bhjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:21 INFO - Running setup.py (path:/tmp/pip-YYKJSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:21 INFO - Running setup.py (path:/tmp/pip-AmH1MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:21 INFO - Running setup.py (path:/tmp/pip-xxISHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:21 INFO - Running setup.py (path:/tmp/pip-_m7wPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:21 INFO - Running setup.py (path:/tmp/pip-1wLXnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:21 INFO - Running setup.py (path:/tmp/pip-G5Cfux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:21 INFO - Running setup.py (path:/tmp/pip-ce7SWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:21 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)) 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:21 INFO - Running setup.py (path:/tmp/pip-KZrN_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:22 INFO - Running setup.py (path:/tmp/pip-1tnVKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:22 INFO - Running setup.py (path:/tmp/pip-x26MIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:22 INFO - Running setup.py (path:/tmp/pip-lTPly6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:22 INFO - Running setup.py (path:/tmp/pip-du6IPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:22 INFO - Running setup.py (path:/tmp/pip-3g6k3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:22 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)) 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:22 INFO - Running setup.py (path:/tmp/pip-SpPNbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:22 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)) 04:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:22 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)) 04:53:22 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)) 04:53:22 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)) 04:53:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:24 INFO - Downloading blessings-1.6.tar.gz 04:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:24 INFO - Installing collected packages: blessings 04:53:24 INFO - Running setup.py install for blessings 04:53:24 INFO - Successfully installed blessings 04:53:24 INFO - Cleaning up... 04:53:24 INFO - Return code: 0 04:53:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:24 INFO - Reading from file tmpfile_stdout 04:53:24 INFO - Current package versions: 04:53:24 INFO - argparse == 1.2.1 04:53:24 INFO - blessings == 1.6 04:53:24 INFO - blobuploader == 1.2.4 04:53:24 INFO - docopt == 0.6.1 04:53:24 INFO - functools32 == 3.2.3-2 04:53:24 INFO - jsonschema == 2.5.1 04:53:24 INFO - manifestparser == 1.1 04:53:24 INFO - mozInstall == 1.12 04:53:24 INFO - mozcrash == 0.17 04:53:24 INFO - mozdebug == 0.1 04:53:24 INFO - mozdevice == 0.48 04:53:24 INFO - mozfile == 1.2 04:53:24 INFO - mozhttpd == 0.7 04:53:24 INFO - mozinfo == 0.9 04:53:24 INFO - mozleak == 0.1 04:53:24 INFO - mozlog == 3.4 04:53:24 INFO - moznetwork == 0.27 04:53:24 INFO - mozprocess == 0.23 04:53:24 INFO - mozprofile == 0.28 04:53:24 INFO - mozrunner == 6.12 04:53:24 INFO - mozscreenshot == 0.1 04:53:24 INFO - mozsystemmonitor == 0.3 04:53:24 INFO - moztest == 0.7 04:53:24 INFO - mozversion == 1.4 04:53:24 INFO - psutil == 3.1.1 04:53:24 INFO - requests == 1.2.3 04:53:24 INFO - wsgiref == 0.1.2 04:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:24 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 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:24 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 04:53:24 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 04:53:24 INFO - Using env: {'DISPLAY': ':0', 04:53:24 INFO - 'HOME': '/home/cltbld', 04:53:24 INFO - 'LANG': 'en_US.UTF-8', 04:53:24 INFO - 'LANGUAGE': 'en_US:en', 04:53:24 INFO - 'LOGNAME': 'cltbld', 04:53:24 INFO - 'MAIL': '/var/mail/cltbld', 04:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:24 INFO - 'MOZ_NO_REMOTE': '1', 04:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:24 INFO - 'NO_EM_RESTART': '1', 04:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:24 INFO - 'PWD': '/builds/slave/test', 04:53:24 INFO - 'SHELL': '/bin/bash', 04:53:24 INFO - 'SHLVL': '1', 04:53:24 INFO - 'TERM': 'linux', 04:53:24 INFO - 'TMOUT': '86400', 04:53:24 INFO - 'USER': 'cltbld', 04:53:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:24 INFO - '_': '/tools/buildbot/bin/python'} 04:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 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)) 04:53:25 INFO - Cleaning up... 04:53:25 INFO - Return code: 0 04:53:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58d4505f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', '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 04:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:25 INFO - Using env: {'DISPLAY': ':0', 04:53:25 INFO - 'HOME': '/home/cltbld', 04:53:25 INFO - 'LANG': 'en_US.UTF-8', 04:53:25 INFO - 'LANGUAGE': 'en_US:en', 04:53:25 INFO - 'LOGNAME': 'cltbld', 04:53:25 INFO - 'MAIL': '/var/mail/cltbld', 04:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:25 INFO - 'MOZ_NO_REMOTE': '1', 04:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:25 INFO - 'NO_EM_RESTART': '1', 04:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:25 INFO - 'PWD': '/builds/slave/test', 04:53:25 INFO - 'SHELL': '/bin/bash', 04:53:25 INFO - 'SHLVL': '1', 04:53:25 INFO - 'TERM': 'linux', 04:53:25 INFO - 'TMOUT': '86400', 04:53:25 INFO - 'USER': 'cltbld', 04:53:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:25 INFO - '_': '/tools/buildbot/bin/python'} 04:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:25 INFO - Cleaning up... 04:53:25 INFO - Return code: 0 04:53:25 INFO - Running post-action listener: _resource_record_post_action 04:53:25 INFO - Running post-action listener: _start_resource_monitoring 04:53:25 INFO - Starting resource monitoring. 04:53:25 INFO - [mozharness: 2016-09-28 11:53:25.362310Z] Finished create-virtualenv step (success) 04:53:25 INFO - [mozharness: 2016-09-28 11:53:25.362812Z] Running install step. 04:53:25 INFO - Running pre-action listener: _resource_record_pre_action 04:53:25 INFO - Running main action method: install 04:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:25 INFO - Reading from file tmpfile_stdout 04:53:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:25 INFO - Reading from file tmpfile_stdout 04:53:25 INFO - Output received: 04:53:25 INFO - Usage: mozinstall [options] installer 04:53:25 INFO - Options: 04:53:25 INFO - -h, --help show this help message and exit 04:53:25 INFO - -d DEST, --destination=DEST 04:53:25 INFO - Directory to install application into. [default: 04:53:25 INFO - "/builds/slave/test"] 04:53:25 INFO - --app=APP Application being installed. [default: firefox] 04:53:25 INFO - mkdir: /builds/slave/test/build/application 04:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:53:41 INFO - Reading from file tmpfile_stdout 04:53:41 INFO - Output received: 04:53:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:53:41 INFO - Running post-action listener: _resource_record_post_action 04:53:41 INFO - [mozharness: 2016-09-28 11:53:41.855865Z] Finished install step (success) 04:53:41 INFO - [mozharness: 2016-09-28 11:53:41.856110Z] Running run-tests step. 04:53:41 INFO - Running pre-action listener: _resource_record_pre_action 04:53:41 INFO - Running main action method: run_tests 04:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:41 INFO - Python 2.7.3 04:53:41 INFO - Return code: 0 04:53:41 INFO - grabbing minidump binary from tooltool 04:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:41 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 0x192bf60>, '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 0x192cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:41 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 04:53:41 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 04:53:41 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 04:53:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:41 INFO - Return code: 0 04:53:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:53:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:53:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 04:53:41 INFO - Using env: {'DISPLAY': ':0', 04:53:41 INFO - 'HOME': '/home/cltbld', 04:53:41 INFO - 'LANG': 'en_US.UTF-8', 04:53:41 INFO - 'LANGUAGE': 'en_US:en', 04:53:41 INFO - 'LOGNAME': 'cltbld', 04:53:41 INFO - 'MAIL': '/var/mail/cltbld', 04:53:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:41 INFO - 'MOZ_NO_REMOTE': '1', 04:53:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:41 INFO - 'NO_EM_RESTART': '1', 04:53:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:41 INFO - 'PWD': '/builds/slave/test', 04:53:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:41 INFO - 'SHELL': '/bin/bash', 04:53:41 INFO - 'SHLVL': '1', 04:53:41 INFO - 'TERM': 'linux', 04:53:41 INFO - 'TMOUT': '86400', 04:53:41 INFO - 'USER': 'cltbld', 04:53:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381', 04:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:41 INFO - '_': '/tools/buildbot/bin/python'} 04:53:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:53:42 INFO - mozversion application_buildid: 20160928041920 04:53:42 INFO - mozversion application_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 04:53:42 INFO - mozversion application_display_name: Nightly 04:53:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:42 INFO - mozversion application_name: Firefox 04:53:42 INFO - mozversion application_remotingname: firefox 04:53:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:53:42 INFO - mozversion application_vendor: Mozilla 04:53:42 INFO - mozversion application_version: 52.0a1 04:53:42 INFO - mozversion platform_buildid: 20160928041920 04:53:42 INFO - mozversion platform_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 04:53:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:53:42 INFO - mozversion platform_version: 52.0a1 04:53:42 INFO - using testdate: 1475063622 04:53:42 INFO - actual date: 1475063622 04:53:42 INFO - starting webserver on 'localhost:42110' 04:53:42 INFO - SUITE-START | Running 2 tests 04:53:42 INFO - TEST-START | dromaeo_css 04:53:42 INFO - operating with platform_type : linux_ 04:53:42 INFO - Initialising browser for dromaeo_css test... 04:53:42 INFO - TEST-INFO | started process 18725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDqesP/profile http://localhost:42110/getInfo.html) 04:53:46 INFO - PROCESS | 18725 | __metrics Screen width/height:1600/1200 04:53:46 INFO - PROCESS | 18725 | colorDepth:24 04:53:46 INFO - PROCESS | 18725 | Browser inner width/height: 1024/697 04:53:46 INFO - PROCESS | 18725 | __metrics 04:53:47 INFO - PROCESS | 18725 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:47 INFO - PROCESS | 18725 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:47 INFO - PROCESS | 18725 | console.error: PushService: 04:53:47 INFO - PROCESS | 18725 | stateChangeProcessEnqueue: Error transitioning state 04:53:47 INFO - PROCESS | 18725 | UnknownError 04:53:48 INFO - TEST-INFO | 18725: exit 0 04:53:48 INFO - Browser initialized. 04:53:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:48 INFO - TEST-INFO | started process 18809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDqesP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:00 INFO - PROCESS | 18809 | RSS: Main: 175394816 04:54:00 INFO - PROCESS | 18809 | 04:54:51 INFO - PROCESS | 18809 | 1475063691634 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] 04:57:05 INFO - PROCESS | 18809 | Cycle 1(1): loaded http://localhost:42110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42110/tests/dromaeo/cssquery-ext.html) 04:57:06 INFO - PROCESS | 18809 | RSS: Main: 313942016 04:57:06 INFO - PROCESS | 18809 | 05:00:09 INFO - PROCESS | 18809 | Cycle 1(1): loaded http://localhost:42110/tests/dromaeo/cssquery-ext.html (next: http://localhost:42110/tests/dromaeo/cssquery-jquery.html) 05:00:09 INFO - PROCESS | 18809 | RSS: Main: 282365952 05:00:09 INFO - PROCESS | 18809 | 05:03:11 INFO - PROCESS | 18809 | Cycle 1(1): loaded http://localhost:42110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42110/tests/dromaeo/cssquery-mootools.html) 05:03:12 INFO - PROCESS | 18809 | RSS: Main: 220110848 05:03:12 INFO - PROCESS | 18809 | 05:06:14 INFO - PROCESS | 18809 | Cycle 1(1): loaded http://localhost:42110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42110/tests/dromaeo/cssquery-prototype.html) 05:06:15 INFO - PROCESS | 18809 | RSS: Main: 226385920 05:06:15 INFO - PROCESS | 18809 | 05:09:18 INFO - PROCESS | 18809 | Cycle 1(1): loaded http://localhost:42110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42110/tests/dromaeo/cssquery-yui.html) 05:09:19 INFO - PROCESS | 18809 | RSS: Main: 218112000 05:09:19 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | Cycle 1(1): loaded http://localhost:42110/tests/dromaeo/cssquery-yui.html (next: http://localhost:42110/tests/dromaeo/cssquery-dojo.html) 05:12:22 INFO - PROCESS | 18809 | RSS: Main: 311832576 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | __start_tp_report 05:12:22 INFO - PROCESS | 18809 | _x_x_mozilla_page_load 05:12:22 INFO - PROCESS | 18809 | _x_x_mozilla_page_load_details 05:12:22 INFO - PROCESS | 18809 | |i|pagename|runs| 05:12:22 INFO - PROCESS | 18809 | |0;dojo.html;2578.8710564471776;2611.438540713746;2622.291981165086;2636.0510216322123;2647.907323243686;4557.453105627321;4629;4730.550597693218;4739.14695354836;4746.169420351438;4692.671512994092;4699.788509517071;4706.764661766906;4708.458527269365;4725.503822098682;4295.119500502397;4359.149965756663;4384.18892504886;4441.467023957113;4442.022754993896;4346.695731298811;4400.097979914126;4421.491528474218;4454.844080457185;4463.4420697412825;4408.426904502427;4447.155040542287;4509.571590698878;4515.729056256619;4526.569975852305;4447.5552444755585;4474.261746811772;4513.300438432048;4527.411436513232;4529.320601909707;4240.851570195059;4294.398784170218;4296.5273819879785;4342.088161486092;4361.280388735887;4722.126406614787;4749.358836557055;4750.192467280536;4755.595774359183;4761.785719642589;4991.850244492671;5022.070916880352;5030.195168773015;5059.924101138486;5093.465186155438;5053.646244762868;5058.645894787366;5064.265681476165;5151.742412879341;5214.556762675177;4786.210275304606;4794.7362895040405;4795.376601041842;4800.207965685623;4854.126257273654;5103.10695628271;5153.458886816905;5158.92261616076;5203.375594928557;5220.1647736362;4970.428400733889;5001.42483614389;5003.574696150795;5012.624053196025;5076.771545280398;5090.847274581768;5104.9744751276;5106.106431374495;5108.642395032386;5111.080005598954;4879.804807807648;4973.52751488608;4976.377952755905;5041.092603331363;5047.141985862412;4995.325631039763;5018.799248030038;5026.2460630904925;5029.823956161516;5033.0437216929395;4290.313549832012;4319.568043195718;4331.696781225347;4333.479982402132;4334.1981733379425;3757.962420375761;3773.1699026214187;3790.450384694204;3790.962090379116;3819.7708137511836;4301.935470967938;4341.804618792162;4390.05613793036;4396.670249731283;4398.8020539075815;5130.666506677054;5135.306733590992;5135.512126347991;5136.871578210575;5189.169732842727;4256.723312984646;4309.439772829574;4324.827006919751;4333.566643335705;4386.166628340605;4531.77341132942;4578.633709303248;4584.977075114603;4622.95377046232;4674.205385084544;4779.784909679072;4786.473487916396;4788;4789.137955168103;4841.298011788342;5139.460356662496;5152.6650767699975;5155.2782610435315;5155.561777248976;5216.686998780086;4645.953540464688;4703.012367402884;4730.385049943486;4730.739809310521;4790.7844147012775;5071.568916642127;5071.721055341992;5071.949280507148;5075.2387141929;5126.53861152498;5111.3355263815465;5140.485951404829;5140.56305214061;5141.691498510101;5192.662476938987;4785.569298763128;4839.032193561231;4930.802767889244;4941.110600092018;4999.700017998932;4981.975090124526;4989.875253118701;4990.975045124751;5039.143345631325;5055.87360315995;4879.902401952012;4890.510948905081;4909.042736666316;4912.410510738734;4984.127777638826;4837.7581120944515;4895.265710143364;4944.75276236194;4997.125503036881;5073.7716802743225;4873.780679869344;4894.779734912009;4898.632602554894;4939.851804445872;4940.604751619933 05:12:22 INFO - PROCESS | 18809 | |1;ext.html;531.9627626066177;543.9972800135998;569.7265312649929;583.1981026089128;583.8336074218847;28303.29241768957;38405.239214117864;39709.602903970954;39802.60197398025;43799.78100109495;40163.598364016354;40501.59498405015;40572;40595;40644.39033414501;7638.12161601416;7793.454458187901;7794.415418843581;7794.922050779504;7797;7684.38524918008;7772.572508512029;7775.377969762406;7777.18339574345;7777.455578109534;7794.259545343183;7836.686532538692;7847;7847.96076019622;7849;7740.109887362941;7793.259640334216;7796.80507987302;7797.649105790253;7800.687972481094;7729.265719756614;7802.33680137189;7803.375729941591;7805.492642978188;7810.882836757453;36624.81687591545;36943;37001.814990924875;37025.25949480995;37044.629553704384;2924.2543151496234;3204.8878289259997;3587.210813620999;3603;3616.9095772605897;29122.271943201376;29613.70386296131;29673.554896676567;30127.246818829484;30546.694533054608;3516.472529120627;3550.8934731958084;3743.681787048104;3747.831347589365;3759;250481;250669;250904;252481;252805;51785.48214517882;52107.04983026606;52156.73921630368;52204;52251;55525.444745552835;55719;55829.7208513963;55855.44144558503;55899;14190.574282771533;14437.639059023608;14446;14449.205293708737;14452;10952.069074128789;11002.559897604006;11013.889861101447;11025.393603351733;11031.117510599133;13878;15721.764173537405;15944.521664350088;16007.199640017952;16021.359145634044;4360.193364227628;4577.885552861138;5183.2743415921805;5255.369355677343;5461.563074953994;856.7986523167051;894.7092195036639;913.8257339318943;915.190056799737;916.7891384981492;26468.470630587664;27867.442651146863;28274.71725282721;28302.433951320858;28463.71536284652;921.8478950973148;943.857931902392;965.4738167698621;968.8926584678296;997.7954519323521;14069.648258793408;14958;15057.085157859035;15062.698746025018;15073.924630376778;352178;356441;357103;357413;357459;49735.502644973814;49783.751081244365;49883;49954;49974;1161.372858656333;1174.1839421602076;1178.187050934852;1183.7336599265097;1191.6901605582439;26201.344966375993;26940.191794246202;27532.862335688194;27579.862100689366;27811.08174155935;37113;37851;37872.242555148194;37873;37946.810265948494;318496;320292;321014;321029;322071;24493.877530612233;25629.3592660185;36757;37086.072848179014;37186.6281337194;41363.586364137176;41465.79267103645;41889.16221675611;42106.789466052476;42494;35293.117672058404;35401.468977965866;35459.64540354563;35582;35615.465768014015;35143.297134056666;35707;35742.4638630426;36038.099047524025;36288.09279768027;35161.29677406489;35420.645793541735;35757.82121089378;36053.81973090118;36505;30520.694793052673;31635;31728.543792209275;32002.19994500156;32025.67974320227;24986.625200621642;25140.714821294678;25375.873120634278;25733.099341522957;25782.742172578033 05:12:22 INFO - PROCESS | 18809 | |2;jquery.html;340.33804250732334;351.9313733821906;361.26843142636164;367.9540057492814;380.72968192583267;12181.147319687625;15442.073475591458;15856.286467108965;16416.17919104043;17225.22486488108;16262;16641.667166656658;16691.248893799777;16827.074510901897;16833.074180920044;4019;4952.083864485064;5088.23676448532;5104.438511763703;5144.4598317176715;4978.900421991558;5051.419086805009;5056.924146137811;5057.772400241998;5058.696478211319;4843.225083986563;5017.122003649365;5022.271770593262;5072.873178170538;5103.770330335144;5079.2635067915135;5094.617903657222;5113.948860511385;5122.641415100926;5122.974385128051;4411.073674528353;4526.8868278292975;4578.313253012042;4578.633709303248;4583;19771.80228197714;19774.80225197744;19976.10107545164;19986.10062547189;20070.698939515918;1845.3910209630924;1863.4595967169505;1879.20133943075;1880.0787614069145;2002.3792624286518;12675.873241267562;12717.109802313842;12931.612051638465;13438.12652177615;13622.114562553501;1618.174730887244;1624.2609612626227;1663.4344322930262;1703.9403620873334;1719.346648273648;43415.565844341465;64850.351496485375;66339.66830165818;66514.66742666304;67435;9229.953850230706;9416.246700263962;9673.274504412197;9682;9687.225021998223;13086.934565327112;13088.411021504055;13088.869111308955;13096.738065238642;13100.21398716061;6907.925972941993;7025.578465292099;7063.364297213276;7266.564006159648;7284.562926224337;6873.20958089816;6899.448044156456;6941.409980151642;7180.461465390116;7207.315305046012;5980.611260268069;6046.093086037042;6071.726772295257;6085.5435842312;6236.376362363727;1613.2256516871732;1644.7203975323985;1714.768506251665;1715.3653148334947;1738.6696527659703;802.8996375453069;838.4172999765104;849.392684230778;975.2880397310004;980.9313348065567;16092;16387.508374748777;17380.13099345053;17483.86354886928;17948.641027179383;855.170484629908;862.943908645936;867.9739607811775;868.4702331577732;895.0199531512983;9054.456732596065;9317.534123293808;9804.607815687436;10169.796604067877;10215.897841021644;362599;365169;367065;367364;370049;75221.24778752252;75788.24211757923;77280.22719772843;77556;78704.60647696839;900.8513595256841;904.4934836491586;914.4467597103657;916.9174774270215;917.7659696777413;15279.847201527842;15282;15664.686706266039;15984.680306393575;16051.678966420373;34076.488852666735;36798.8160059198;36966;40443.59556404516;41456.79271603622;48385;52131.73934130305;52419;52656.736716316176;52723.736381317845;4735.195016847076;5874.882502349844;6071.876702809995;7354.6690398931105;7604.657790399335;9083.772905677146;11750.23623464472;11891.702707432383;12055.457504412498;12065.81901271464;10417.270791044553;10503.264771465923;10662.89337106619;10741.409222492837;10881.782364352826;9474.668386606436;10273.280870339004;10549.314294571135;10618.09746171584;10647.733806654585;10250.692479225338;10483.370997739856;10799.514021868878;10835.67492975212;10894.836577451186;7542.170361260147;7639.885401718868;7679.846403071795;7775.650095745592;7855.960720196363;8905.975812781355;10396.544483772126;10476.00477954593;10618.946905265424;10732.624358147428 05:12:22 INFO - PROCESS | 18809 | |3;mootools.html;1161.5992482593501;1318.3210646517039;1377.9311034448276;1392.269058744159;1695.4150817967804;6771.424428923541;7757.379409647228;8004.559749213791;8025.839483210332;8259.752207433787;8110.95944520278;8190.754277371673;8197.672093116269;8202.056763472203;8204.507729536232;2197.395716178056;2216.8891555422247;2217.5010622609943;2219.4562332228547;2226.1763147635397;2133.232036466871;2168.1544197762805;2189.4745261137373;2191.233068426054;2194.6378847490146;2149.215536329244;2154.472154322193;2164.0478189596606;2179.139240000199;2206.6910632511463;2129.4569884679386;2132.115172203534;2132.2110818996916;2134.2210093315907;2135.722356093713;2107.062357251024;2130.9680354794536;2153.493928926701;2155.385715071213;2156.0728886578763;7954.3636509079715;8051.557164355958;8054.23484768946;8059.838803223961;8116.797080072986;4447.577480139382;4617.561331673485;4618.1687296286655;4663.067386522675;4687.6249900007915;2786.317352248692;2921.524630061805;2933.0467598030514;2953.3354995126138;2953.5569664550276;852.3394369363731;873.2228316798055;882.4749274181852;893.0622846011727;898.23201163006;10896.945515272451;11023.393713345762;11052.944735276273;11057.889421105847;11061.944690276498;3824.254270417242;3939.6454319110844;4106.835726570964;4122.134351786099;4123.773192474383;8567.143285671507;8570.700025499078;8572.099929507436;8572.228499435081;8574.78563035929;4440.622547083534;4455.353973673799;4460.77696115193;4462.6876118672035;4464.598186163261;3699.2231631357718;3842.634949679776;4035.596440355941;4180.226658068267;4185.727927684691;3354.3626710924846;3388.542546756206;3506.2461570762407;3534.540509733718;3536.4695295705337;1001.7746007148479;1014.4116412480744;1018.3126389686931;1020.0360659177006;1035.166690813887;668.488606216245;795.431266644352;807.6809660184311;826.6404114210337;848.4485084694998;4825.4933232010835;5000.774965126578;5060.797568097309;5156.1492353761205;5312;358.6503159419597;368.7418806835226;376.8793985924478;380.46544604830257;905.2531661379388;3511.648835116519;3610.4403817408343;3615.6926661233565;3655.8903232903053;3658.762180458262;9370.718878433658;9707.514624268759;9743.464109473905;9778.41329520231;9893.45585992763;9686.564104615309;9888.555015024342;9892;9917.752056198653;9974.850377244202;7429.5542267464125;7595.810104747315;7596.886046709304;7608.733694320562;7609.733659321897;5191.22131680251;5213.582913366998;5220.504052115043;5428;5578.219049333015;8638.524881131598;8731.956340218258;8983.730488085368;9160.679376222068;9283.814323713623;9236.769080772765;9250.167484926389;9410.623575056921;9444.905550944402;9453.291003174927;6729.831754206184;7010.053642758162;7606.163322034682;7775.961120194363;7788.727394541163;7308.415326773952;7696.615169241628;7729.265719756614;7878;7893.802654933443;6712.39588437043;6752;6864.38220560152;6936.618485983319;7070.36366726997;6703.731850725916;6761.52669313163;6766.511367499143;6900.516963812485;6986.441084713312;6426.196725409324;6452.645104519109;6459.063435801876;6499.610023398611;6503.51223658237;4522.502524722212;4548.681592288508;4549.112922979987;4564.475085365226;4603.907921841477;4540.591346778806;4543.840965566189;4550.863474095782;4669.322948172564;4695.765211739467 05:12:22 INFO - PROCESS | 18809 | |4;prototype.html;290.91563446600475;292.1862612623842;297.6101307287453;303.89819410497483;305.1151660185462;4503.211937910861;4649.395578574789;4678.274867395555;4718.480967093621;4736.810527578897;4537.752118167506;4610.5850473457385;4686.625069994401;4687.8359257426;4708.882277943053;3766.2279232757355;3766.8304926278247;3769.18962423079;3769.905752356199;3772.302124107035;3551.875684351048;3677.5403074615674;3768.868089616864;3771.18919432322;3778.508793856795;3637.5271214742047;3718.8326525306425;3735.2529494101154;3736.514253147087;3751.1934933989187;3720.720945929066;3726.4037753959237;3729.1236559408517;3730.477733117366;3732.552093748754;3308.123347312964;3308.586426696663;3317.402867483876;3319.40250754864;3321.2029113012945;4499.842505512324;4595.678302518825;4598.862034138948;4608.654350923661;4617.953820461786;4237.406763053175;4240.38514415408;4243.299855523835;4252.617264446215;4259.1268789897995;4920.409550853885;4928.778204980785;4938.38270216223;4940.184869496528;4940.604751619861;3454.671806178409;3599.3521166190076;3620.3664358737115;3626.673599376069;3630.8547658093644;5099.87250318745;5107.719075450848;5115;5129.948700512984;5155.226715992631;3648.689861361761;3665.120371110914;3667.339878821838;3667.9266414671556;3678.2643471305846;3715.1826598148364;3717.423799311111;3719.683826874692;3727.8508859645854;3728.520533845017;3892.026993251687;4134.834606615702;4149.688773342012;4158.251514727378;4208.22147902639;4877.414710234723;4883.34074899891;4892.143874821963;4893.266010098514;4896.2410826321975;1188.3226560860226;1214.8967337776387;1217.9756404871853;1243.9440225189887;1257.6478585995935;852.4331319672473;852.8635418333037;866.6923242249037;868.7437206024238;868.8045189832363;4312.374705667723;4347.782610869507;4349.238883195429;4363.211083455832;4375.321825117112;5066.721330326794;5074.391073071181;5082.74586270685;5088.1350170471105;5095.388553373619;4370.431843860341;4373.759443230653;4374.321980093091;4376.978115109404;4378.846740364135;2313.8611683299055;2415.7463466336135;2415.8188135889877;2420.2739178246457;2421.2736179146186;4269.765162916069;4273.722208056466;4278.358246263023;4285.700000999963;4291.463567054118;4584.7936842842155;4598.425196850394;4625.283081122431;4631.652626053059;4634.490206077328;4253.107886637116;4279.507856596531;4469.865904022885;4819.566239038503;4847.854564363075;5161.535461808456;5171.9482805171465;5178.559822415137;5184.274201611853;5186.585073194211;5088.160453525127;5089.211172268304;5090.821821236239;5093.159628661229;5098;4633.675642704979;4766.523347665206;4795.592374648055;4811.398575178103;4840.951590484191;3620.31214069326;3636.8181590919817;3647.161152934787;3655.670989610948;3655.6892664123848;5118.027574760784;5129.563987061141;5134.281200631989;5134.922976155286;5146.459621739813;4714.316424118552;4842.7578621068105;4886.144924638245;4988.376452943382;5018.297438358706;5003.724795136157;5004.174311238605;5004.9489607182895;5005.274235235797;5022.3219865317715;4899.877503062452;4910.386201724785;4911.666958194972;4913.557779799835;4933.506649335038;4793.32893394918;4986.376702912136;5016.792611251038;5023.271625614192;5026.974865125651;4920.065187614342;4923.163062279349;4927.704337739747;4928.285398617252;4937.679050861682 05:12:22 INFO - PROCESS | 18809 | |5;yui.html;554.5369616370331;559.7117484495483;622.1410781794187;721.7473884140552;759.7834617134115;11636.360000199986;12612.369381530922;12613.558525451612;12613.810792838114;12700.555480558194;11953.163278570504;12210.93894530526;12567.308798016105;12716;12735.808962865542;491.7442929676566;759.0360242492046;779.6569509415867;781.9061712594497;782.6165179062275;648.6951132967498;660.3825423229272;660.6531570925279;660.8215781738928;735.4153448008846;815.1440986963664;823.7693445835175;824.9793755156139;825.2861274997115;825.9008918929707;819.8524265632154;820.0159808230118;821.0475848016273;822.5475988206463;822.7284995951321;477.5463309855616;490.75952783136364;599.8260504453704;599.9100134979744;600.7236671131285;11898.46456909441;12399.13206075575;12436.626901192889;12646.936765316206;12884.291363974977;12618.17981831178;12644.68388290291;13648.590542283748;13821.51624693141;13891.930540347335;10191.745206369826;10195.643152489627;10369.585216591327;10598.31110977784;10783.245172837904;3337.4493208620547;3337.8664853405835;3353.3796247694254;3355.8489867955755;3356.127406874206;60351.69824150895;60446.09330860041;60466.39533604652;61639.69180154115;61847.38152618506;10122.88794158945;10216.131628811485;10439.321444106108;10763.78472430547;10853.45732713377;18434;18476;18575.81424185768;18595.721064184047;18598.25606975706;6759.5606285591275;6832.795016149524;6851.417629501449;6865.897011544831;7113;3576.2668652926086;3691.630836916287;3735.477033215352;3794.487744154559;3823.0824602095295;2925.473414785359;3061.974238630084;3067.9539806902912;3071.7081877221626;3075.815451072943;498.9675671081368;509.1802198460476;516.4241870314572;545.9344878614512;564.3030856891735;492.8743170491502;504.41487874065905;530.4695304695305;533.6184627991005;552.3592632546307;6828.385445309946;7266.346028857322;7321.194668586451;7368.59472729005;7911.327537159291;469.3522938345062;519.8440467859627;532.3186321508475;583.8481994681329;585.5813093638069;3552.8223588820456;3780.5085338905765;3878.2825177342283;3936.5866584008268;4071.75569465833;87000.5649971746;96650;103775.4811225939;107425;107599.46200268948;65661;66710.33289667139;66912;76498.61750691323;86676.5666171665;43174;60415.39584604186;75791.24208757952;77293;78663.21336786673;7512.248775122444;7843.960780196063;7893.723719669784;8100.87848682282;8191.672333106609;29912.80348786024;38168.427473588476;38500.42249366318;38630.14242075619;43331.35002975021;59480.40519594749;59690.70154649199;59712.70143649254;59763.40236597752;63866.68066659637;10933.83599246028;10947.50736216888;10999.560017599206;11146.554137834395;11398.772024559628;11835.46740396667;11885.811418858046;12056.397180140782;12309.892109710168;12928.224306541637;11136;11223.551057957917;11497.195196336175;11582.247153934968;11722.355270459866;11170.441477925908;11174.720631984266;11489.368084755419;11608.767824643292;12004.879951200726;10660.413677247825;10698.411587362458;10755.569777208824;11397.259178153394;11477.655670329903;9587.760305992406;9718.173955213886;9783.36408133469;9969.35199212049;10179.389236645826;10405.47972601382;10662.306950048222;10798.244122911321;10868.456577171268;11049.28179668319 05:12:22 INFO - PROCESS | 18809 | __end_tp_report 05:12:22 INFO - PROCESS | 18809 | __start_cc_report 05:12:22 INFO - PROCESS | 18809 | _x_x_mozilla_cycle_collect,1182 05:12:22 INFO - PROCESS | 18809 | __end_cc_report 05:12:22 INFO - PROCESS | 18809 | __startTimestamp1475064742449__endTimestamp 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | ------- Summary: start ------- 05:12:22 INFO - PROCESS | 18809 | Number of tests: 6 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | [#0] dojo.html Cycles:165 Average:4703.69 Median:4795.38 stddev:495.93 (10.3%) stddev-sans-first:468.60 05:12:22 INFO - PROCESS | 18809 | Values: 2578.9 2611.4 2622.3 2636.1 2647.9 4557.5 4629.0 4730.6 4739.1 4746.2 4692.7 4699.8 4706.8 4708.5 4725.5 4295.1 4359.1 4384.2 4441.5 4442.0 4346.7 4400.1 4421.5 4454.8 4463.4 4408.4 4447.2 4509.6 4515.7 4526.6 4447.6 4474.3 4513.3 4527.4 4529.3 4240.9 4294.4 4296.5 4342.1 4361.3 4722.1 4749.4 4750.2 4755.6 4761.8 4991.9 5022.1 5030.2 5059.9 5093.5 5053.6 5058.6 5064.3 5151.7 5214.6 4786.2 4794.7 4795.4 4800.2 4854.1 5103.1 5153.5 5158.9 5203.4 5220.2 4970.4 5001.4 5003.6 5012.6 5076.8 5090.8 5105.0 5106.1 5108.6 5111.1 4879.8 4973.5 4976.4 5041.1 5047.1 4995.3 5018.8 5026.2 5029.8 5033.0 4290.3 4319.6 4331.7 4333.5 4334.2 3758.0 3773.2 3790.5 3791.0 3819.8 4301.9 4341.8 4390.1 4396.7 4398.8 5130.7 5135.3 5135.5 5136.9 5189.2 4256.7 4309.4 4324.8 4333.6 4386.2 4531.8 4578.6 4585.0 4623.0 4674.2 4779.8 4786.5 4788.0 4789.1 4841.3 5139.5 5152.7 5155.3 5155.6 5216.7 4646.0 4703.0 4730.4 4730.7 4790.8 5071.6 5071.7 5071.9 5075.2 5126.5 5111.3 5140.5 5140.6 5141.7 5192.7 4785.6 4839.0 4930.8 4941.1 4999.7 4982.0 4989.9 4991.0 5039.1 5055.9 4879.9 4890.5 4909.0 4912.4 4984.1 4837.8 4895.3 4944.8 4997.1 5073.8 4873.8 4894.8 4898.6 4939.9 4940.6 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | [#1] ext.html Cycles:180 Average:46455.19 Median:36690.91 stddev:82081.18 (223.7%) stddev-sans-first:82239.02 05:12:22 INFO - PROCESS | 18809 | Values: 532.0 544.0 569.7 583.2 583.8 28303.3 38405.2 39709.6 39802.6 43799.8 40163.6 40501.6 40572.0 40595.0 40644.4 7638.1 7793.5 7794.4 7794.9 7797.0 7684.4 7772.6 7775.4 7777.2 7777.5 7794.3 7836.7 7847.0 7848.0 7849.0 7740.1 7793.3 7796.8 7797.6 7800.7 7729.3 7802.3 7803.4 7805.5 7810.9 36624.8 36943.0 37001.8 37025.3 37044.6 2924.3 3204.9 3587.2 3603.0 3616.9 29122.3 29613.7 29673.6 30127.2 30546.7 3516.5 3550.9 3743.7 3747.8 3759.0 250481.0 250669.0 250904.0 252481.0 252805.0 51785.5 52107.0 52156.7 52204.0 52251.0 55525.4 55719.0 55829.7 55855.4 55899.0 14190.6 14437.6 14446.0 14449.2 14452.0 10952.1 11002.6 11013.9 11025.4 11031.1 13878.0 15721.8 15944.5 16007.2 16021.4 4360.2 4577.9 5183.3 5255.4 5461.6 856.8 894.7 913.8 915.2 916.8 26468.5 27867.4 28274.7 28302.4 28463.7 921.8 943.9 965.5 968.9 997.8 14069.6 14958.0 15057.1 15062.7 15073.9 352178.0 356441.0 357103.0 357413.0 357459.0 49735.5 49783.8 49883.0 49954.0 49974.0 1161.4 1174.2 1178.2 1183.7 1191.7 26201.3 26940.2 27532.9 27579.9 27811.1 37113.0 37851.0 37872.2 37873.0 37946.8 318496.0 320292.0 321014.0 321029.0 322071.0 24493.9 25629.4 36757.0 37086.1 37186.6 41363.6 41465.8 41889.2 42106.8 42494.0 35293.1 35401.5 35459.6 35582.0 35615.5 35143.3 35707.0 35742.5 36038.1 36288.1 35161.3 35420.6 35757.8 36053.8 36505.0 30520.7 31635.0 31728.5 32002.2 32025.7 24986.6 25140.7 25375.9 25733.1 25782.7 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | [#2] jquery.html Cycles:180 Average:23474.42 Median:23913.32 stddev:60560.78 (253.3%) stddev-sans-first:60705.76 05:12:22 INFO - PROCESS | 18809 | Values: 340.3 351.9 361.3 368.0 380.7 12181.1 15442.1 15856.3 16416.2 17225.2 16262.0 16641.7 16691.2 16827.1 16833.1 4019.0 4952.1 5088.2 5104.4 5144.5 4978.9 5051.4 5056.9 5057.8 5058.7 4843.2 5017.1 5022.3 5072.9 5103.8 5079.3 5094.6 5113.9 5122.6 5123.0 4411.1 4526.9 4578.3 4578.6 4583.0 19771.8 19774.8 19976.1 19986.1 20070.7 1845.4 1863.5 1879.2 1880.1 2002.4 12675.9 12717.1 12931.6 13438.1 13622.1 1618.2 1624.3 1663.4 1703.9 1719.3 43415.6 64850.4 66339.7 66514.7 67435.0 9230.0 9416.2 9673.3 9682.0 9687.2 13086.9 13088.4 13088.9 13096.7 13100.2 6907.9 7025.6 7063.4 7266.6 7284.6 6873.2 6899.4 6941.4 7180.5 7207.3 5980.6 6046.1 6071.7 6085.5 6236.4 1613.2 1644.7 1714.8 1715.4 1738.7 802.9 838.4 849.4 975.3 980.9 16092.0 16387.5 17380.1 17483.9 17948.6 855.2 862.9 868.0 868.5 895.0 9054.5 9317.5 9804.6 10169.8 10215.9 362599.0 365169.0 367065.0 367364.0 370049.0 75221.2 75788.2 77280.2 77556.0 78704.6 900.9 904.5 914.4 916.9 917.8 15279.8 15282.0 15664.7 15984.7 16051.7 34076.5 36798.8 36966.0 40443.6 41456.8 48385.0 52131.7 52419.0 52656.7 52723.7 4735.2 5874.9 6071.9 7354.7 7604.7 9083.8 11750.2 11891.7 12055.5 12065.8 10417.3 10503.3 10662.9 10741.4 10881.8 9474.7 10273.3 10549.3 10618.1 10647.7 10250.7 10483.4 10799.5 10835.7 10894.8 7542.2 7639.9 7679.8 7775.7 7856.0 8906.0 10396.5 10476.0 10618.9 10732.6 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | [#3] mootools.html Cycles:180 Average:5174.63 Median:5030.79 stddev:2992.33 (59.5%) stddev-sans-first:2985.52 05:12:22 INFO - PROCESS | 18809 | Values: 1161.6 1318.3 1377.9 1392.3 1695.4 6771.4 7757.4 8004.6 8025.8 8259.8 8111.0 8190.8 8197.7 8202.1 8204.5 2197.4 2216.9 2217.5 2219.5 2226.2 2133.2 2168.2 2189.5 2191.2 2194.6 2149.2 2154.5 2164.0 2179.1 2206.7 2129.5 2132.1 2132.2 2134.2 2135.7 2107.1 2131.0 2153.5 2155.4 2156.1 7954.4 8051.6 8054.2 8059.8 8116.8 4447.6 4617.6 4618.2 4663.1 4687.6 2786.3 2921.5 2933.0 2953.3 2953.6 852.3 873.2 882.5 893.1 898.2 10896.9 11023.4 11052.9 11057.9 11061.9 3824.3 3939.6 4106.8 4122.1 4123.8 8567.1 8570.7 8572.1 8572.2 8574.8 4440.6 4455.4 4460.8 4462.7 4464.6 3699.2 3842.6 4035.6 4180.2 4185.7 3354.4 3388.5 3506.2 3534.5 3536.5 1001.8 1014.4 1018.3 1020.0 1035.2 668.5 795.4 807.7 826.6 848.4 4825.5 5000.8 5060.8 5156.1 5312.0 358.7 368.7 376.9 380.5 905.3 3511.6 3610.4 3615.7 3655.9 3658.8 9370.7 9707.5 9743.5 9778.4 9893.5 9686.6 9888.6 9892.0 9917.8 9974.9 7429.6 7595.8 7596.9 7608.7 7609.7 5191.2 5213.6 5220.5 5428.0 5578.2 8638.5 8732.0 8983.7 9160.7 9283.8 9236.8 9250.2 9410.6 9444.9 9453.3 6729.8 7010.1 7606.2 7776.0 7788.7 7308.4 7696.6 7729.3 7878.0 7893.8 6712.4 6752.0 6864.4 6936.6 7070.4 6703.7 6761.5 6766.5 6900.5 6986.4 6426.2 6452.6 6459.1 6499.6 6503.5 4522.5 4548.7 4549.1 4564.5 4603.9 4540.6 4543.8 4550.9 4669.3 4695.8 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | [#4] prototype.html Cycles:180 Average:4081.56 Median:4561.27 stddev:1184.39 (26.0%) stddev-sans-first:1153.04 05:12:22 INFO - PROCESS | 18809 | Values: 290.9 292.2 297.6 303.9 305.1 4503.2 4649.4 4678.3 4718.5 4736.8 4537.8 4610.6 4686.6 4687.8 4708.9 3766.2 3766.8 3769.2 3769.9 3772.3 3551.9 3677.5 3768.9 3771.2 3778.5 3637.5 3718.8 3735.3 3736.5 3751.2 3720.7 3726.4 3729.1 3730.5 3732.6 3308.1 3308.6 3317.4 3319.4 3321.2 4499.8 4595.7 4598.9 4608.7 4618.0 4237.4 4240.4 4243.3 4252.6 4259.1 4920.4 4928.8 4938.4 4940.2 4940.6 3454.7 3599.4 3620.4 3626.7 3630.9 5099.9 5107.7 5115.0 5129.9 5155.2 3648.7 3665.1 3667.3 3667.9 3678.3 3715.2 3717.4 3719.7 3727.9 3728.5 3892.0 4134.8 4149.7 4158.3 4208.2 4877.4 4883.3 4892.1 4893.3 4896.2 1188.3 1214.9 1218.0 1243.9 1257.6 852.4 852.9 866.7 868.7 868.8 4312.4 4347.8 4349.2 4363.2 4375.3 5066.7 5074.4 5082.7 5088.1 5095.4 4370.4 4373.8 4374.3 4377.0 4378.8 2313.9 2415.7 2415.8 2420.3 2421.3 4269.8 4273.7 4278.4 4285.7 4291.5 4584.8 4598.4 4625.3 4631.7 4634.5 4253.1 4279.5 4469.9 4819.6 4847.9 5161.5 5171.9 5178.6 5184.3 5186.6 5088.2 5089.2 5090.8 5093.2 5098.0 4633.7 4766.5 4795.6 4811.4 4841.0 3620.3 3636.8 3647.2 3655.7 3655.7 5118.0 5129.6 5134.3 5134.9 5146.5 4714.3 4842.8 4886.1 4988.4 5018.3 5003.7 5004.2 5004.9 5005.3 5022.3 4899.9 4910.4 4911.7 4913.6 4933.5 4793.3 4986.4 5016.8 5023.3 5027.0 4920.1 4923.2 4927.7 4928.3 4937.7 05:12:22 INFO - PROCESS | 18809 | 05:12:22 INFO - PROCESS | 18809 | [#5] yui.html Cycles:180 Average:16917.42 Median:3907.43 stddev:24203.13 (619.4%) stddev-sans-first:24239.85 05:12:22 INFO - PROCESS | 18809 | Values: 554.5 559.7 622.1 721.7 759.8 11636.4 12612.4 12613.6 12613.8 12700.6 11953.2 12210.9 12567.3 12716.0 12735.8 491.7 759.0 779.7 781.9 782.6 648.7 660.4 660.7 660.8 735.4 815.1 823.8 825.0 825.3 825.9 819.9 820.0 821.0 822.5 822.7 477.5 490.8 599.8 599.9 600.7 11898.5 12399.1 12436.6 12646.9 12884.3 12618.2 12644.7 13648.6 13821.5 13891.9 10191.7 10195.6 10369.6 10598.3 10783.2 3337.4 3337.9 3353.4 3355.8 3356.1 60351.7 60446.1 60466.4 61639.7 61847.4 10122.9 10216.1 10439.3 10763.8 10853.5 18434.0 18476.0 18575.8 18595.7 18598.3 6759.6 6832.8 6851.4 6865.9 7113.0 3576.3 3691.6 3735.5 3794.5 3823.1 2925.5 3062.0 3068.0 3071.7 3075.8 499.0 509.2 516.4 545.9 564.3 492.9 504.4 530.5 533.6 552.4 6828.4 7266.3 7321.2 7368.6 7911.3 469.4 519.8 532.3 583.8 585.6 3552.8 3780.5 3878.3 3936.6 4071.8 87000.6 96650.0 103775.5 107425.0 107599.5 65661.0 66710.3 66912.0 76498.6 86676.6 43174.0 60415.4 75791.2 77293.0 78663.2 7512.2 7844.0 7893.7 8100.9 8191.7 29912.8 38168.4 38500.4 38630.1 43331.4 59480.4 59690.7 59712.7 59763.4 63866.7 10933.8 10947.5 10999.6 11146.6 11398.8 11835.5 11885.8 12056.4 12309.9 12928.2 11136.0 11223.6 11497.2 11582.2 11722.4 11170.4 11174.7 11489.4 11608.8 12004.9 10660.4 10698.4 10755.6 11397.3 11477.7 9587.8 9718.2 9783.4 9969.4 10179.4 10405.5 10662.3 10798.2 10868.5 11049.3 05:12:22 INFO - PROCESS | 18809 | -------- Summary: end -------- 05:12:22 INFO - PROCESS | 18809 | 05:12:23 INFO - TEST-INFO | 18809: exit 0 05:12:23 INFO - TEST-OK | dromaeo_css | took 1121405ms 05:12:23 INFO - TEST-START | kraken 05:12:23 INFO - operating with platform_type : linux_ 05:12:23 INFO - Initialising browser for kraken test... 05:12:23 INFO - TEST-INFO | started process 19111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6F0_gy/profile http://localhost:42110/getInfo.html) 05:12:28 INFO - PROCESS | 19111 | __metrics Screen width/height:1600/1200 05:12:28 INFO - PROCESS | 19111 | colorDepth:24 05:12:28 INFO - PROCESS | 19111 | Browser inner width/height: 1024/697 05:12:28 INFO - PROCESS | 19111 | __metrics 05:12:28 INFO - PROCESS | 19111 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:28 INFO - PROCESS | 19111 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:29 INFO - PROCESS | 19111 | console.error: PushService: 05:12:29 INFO - PROCESS | 19111 | stateChangeProcessEnqueue: Error transitioning state 05:12:29 INFO - PROCESS | 19111 | UnknownError 05:12:29 INFO - TEST-INFO | 19111: exit 0 05:12:29 INFO - Browser initialized. 05:12:29 INFO - Running cycle 1/1 for kraken test... 05:12:29 INFO - TEST-INFO | started process 19193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6F0_gy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:42 INFO - PROCESS | 19193 | RSS: Main: 174530560 05:12:42 INFO - PROCESS | 19193 | 05:12:45 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42110/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:46 INFO - PROCESS | 19193 | RSS: Main: 234090496 05:12:46 INFO - PROCESS | 19193 | 05:12:48 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42110/tests/kraken/driver.html?testName=audio-dft) 05:12:49 INFO - PROCESS | 19193 | RSS: Main: 218800128 05:12:49 INFO - PROCESS | 19193 | 05:12:52 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42110/tests/kraken/driver.html?testName=audio-fft) 05:12:53 INFO - PROCESS | 19193 | RSS: Main: 300269568 05:12:53 INFO - PROCESS | 19193 | 05:12:55 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42110/tests/kraken/driver.html?testName=audio-oscillator) 05:12:56 INFO - PROCESS | 19193 | RSS: Main: 210104320 05:12:56 INFO - PROCESS | 19193 | 05:12:58 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:58 INFO - PROCESS | 19193 | RSS: Main: 213397504 05:12:58 INFO - PROCESS | 19193 | 05:13:02 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42110/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:02 INFO - PROCESS | 19193 | RSS: Main: 250433536 05:13:02 INFO - PROCESS | 19193 | 05:13:06 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42110/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:06 INFO - PROCESS | 19193 | RSS: Main: 245047296 05:13:06 INFO - PROCESS | 19193 | 05:13:09 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42110/tests/kraken/driver.html?testName=json-parse-financial) 05:13:10 INFO - PROCESS | 19193 | RSS: Main: 247615488 05:13:10 INFO - PROCESS | 19193 | 05:13:11 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:12 INFO - PROCESS | 19193 | RSS: Main: 210550784 05:13:12 INFO - PROCESS | 19193 | 05:13:14 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:15 INFO - PROCESS | 19193 | RSS: Main: 219295744 05:13:15 INFO - PROCESS | 19193 | 05:13:17 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:18 INFO - PROCESS | 19193 | RSS: Main: 222334976 05:13:18 INFO - PROCESS | 19193 | 05:13:20 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:21 INFO - PROCESS | 19193 | RSS: Main: 223125504 05:13:21 INFO - PROCESS | 19193 | 05:13:24 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:24 INFO - PROCESS | 19193 | RSS: Main: 221286400 05:13:24 INFO - PROCESS | 19193 | 05:13:26 INFO - PROCESS | 19193 | Cycle 1(1): loaded http://localhost:42110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42110/tests/kraken/driver.html?testName=ai-astar) 05:13:27 INFO - PROCESS | 19193 | RSS: Main: 272781312 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | __start_tp_report 05:13:27 INFO - PROCESS | 19193 | _x_x_mozilla_page_load 05:13:27 INFO - PROCESS | 19193 | _x_x_mozilla_page_load_details 05:13:27 INFO - PROCESS | 19193 | |i|pagename|runs| 05:13:27 INFO - PROCESS | 19193 | |0;ai-astar;111;116;115;113;115;117;114;113;115;114 05:13:27 INFO - PROCESS | 19193 | |1;audio-beat-detection;149;122;124;171;129;124;122;122;153;129 05:13:27 INFO - PROCESS | 19193 | |2;audio-dft;160;164;161;162;162;162;162;160;161;161 05:13:27 INFO - PROCESS | 19193 | |3;audio-fft;75;77;75;108;78;79;76;77;100;78 05:13:27 INFO - PROCESS | 19193 | |4;audio-oscillator;84;84;121;85;86;85;107;85;84;117 05:13:27 INFO - PROCESS | 19193 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;118;117;117 05:13:27 INFO - PROCESS | 19193 | |6;imaging-darkroom;146;147;147;147;145;146;145;146;146;147 05:13:27 INFO - PROCESS | 19193 | |7;imaging-desaturate;95;96;96;96;95;95;95;94;95;95 05:13:27 INFO - PROCESS | 19193 | |8;json-parse-financial;62;61;61;61;63;64;63;63;63;68 05:13:27 INFO - PROCESS | 19193 | |9;json-stringify-tinderbox;67;66;67;66;67;66;68;67;67;67 05:13:27 INFO - PROCESS | 19193 | |10;stanford-crypto-aes;84;82;81;82;82;81;90;82;82;89 05:13:27 INFO - PROCESS | 19193 | |11;stanford-crypto-ccm;132;139;133;141;131;132;134;132;172;141 05:13:27 INFO - PROCESS | 19193 | |12;stanford-crypto-pbkdf2;173;181;180;171;171;169;173;173;172;175 05:13:27 INFO - PROCESS | 19193 | |13;stanford-crypto-sha256-iterative;69;74;73;68;69;74;68;68;68;66 05:13:27 INFO - PROCESS | 19193 | __end_tp_report 05:13:27 INFO - PROCESS | 19193 | __start_cc_report 05:13:27 INFO - PROCESS | 19193 | _x_x_mozilla_cycle_collect,1945 05:13:27 INFO - PROCESS | 19193 | __end_cc_report 05:13:27 INFO - PROCESS | 19193 | __startTimestamp1475064807008__endTimestamp 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | ------- Summary: start ------- 05:13:27 INFO - PROCESS | 19193 | Number of tests: 14 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:1.70 (1.5%) stddev-sans-first:1.32 05:13:27 INFO - PROCESS | 19193 | Values: 111.0 116.0 115.0 113.0 115.0 117.0 114.0 113.0 115.0 114.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:129.00 stddev:17.11 (13.3%) stddev-sans-first:17.32 05:13:27 INFO - PROCESS | 19193 | Values: 149.0 122.0 124.0 171.0 129.0 124.0 122.0 122.0 153.0 129.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 05:13:27 INFO - PROCESS | 19193 | Values: 160.0 164.0 161.0 162.0 162.0 162.0 162.0 160.0 161.0 161.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:11.66 (15.1%) stddev-sans-first:12.07 05:13:27 INFO - PROCESS | 19193 | Values: 75.0 77.0 75.0 108.0 78.0 79.0 76.0 77.0 100.0 78.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.50 stddev:15.03 (17.8%) stddev-sans-first:15.52 05:13:27 INFO - PROCESS | 19193 | Values: 84.0 84.0 121.0 85.0 86.0 85.0 107.0 85.0 84.0 117.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:13:27 INFO - PROCESS | 19193 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 117.0 117.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:13:27 INFO - PROCESS | 19193 | Values: 146.0 147.0 147.0 147.0 145.0 146.0 145.0 146.0 146.0 147.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:13:27 INFO - PROCESS | 19193 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:2.08 (3.3%) stddev-sans-first:2.18 05:13:27 INFO - PROCESS | 19193 | Values: 62.0 61.0 61.0 61.0 63.0 64.0 63.0 63.0 63.0 68.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 05:13:27 INFO - PROCESS | 19193 | Values: 67.0 66.0 67.0 66.0 67.0 66.0 68.0 67.0 67.0 67.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.00 stddev:3.27 (4.0%) stddev-sans-first:3.47 05:13:27 INFO - PROCESS | 19193 | Values: 84.0 82.0 81.0 82.0 82.0 81.0 90.0 82.0 82.0 89.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:136.50 stddev:12.33 (9.0%) stddev-sans-first:12.84 05:13:27 INFO - PROCESS | 19193 | Values: 132.0 139.0 133.0 141.0 131.0 132.0 134.0 132.0 172.0 141.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:173.00 stddev:3.88 (2.2%) stddev-sans-first:4.11 05:13:27 INFO - PROCESS | 19193 | Values: 173.0 181.0 180.0 171.0 171.0 169.0 173.0 173.0 172.0 175.0 05:13:27 INFO - PROCESS | 19193 | 05:13:27 INFO - PROCESS | 19193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:2.87 (4.2%) stddev-sans-first:3.03 05:13:27 INFO - PROCESS | 19193 | Values: 69.0 74.0 73.0 68.0 69.0 74.0 68.0 68.0 68.0 66.0 05:13:27 INFO - PROCESS | 19193 | -------- Summary: end -------- 05:13:27 INFO - PROCESS | 19193 | 05:13:28 INFO - TEST-INFO | 19193: exit 0 05:13:28 INFO - TEST-OK | kraken | took 64774ms 05:13:28 INFO - SUITE-END | took 1186s 05:13:28 INFO - Completed test suite (00:19:46) 05:13:28 INFO - javascript benchmark 05:13:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.8710564471776, 2611.438540713746, 2622.291981165086, 2636.0510216322123, 2647.907323243686, 4557.453105627321, 4629.0, 4730.550597693218, 4739.14695354836, 4746.169420351438, 4692.671512994092, 4699.788509517071, 4706.764661766906, 4708.458527269365, 4725.503822098682, 4295.119500502397, 4359.149965756663, 4384.18892504886, 4441.467023957113, 4442.022754993896, 4346.695731298811, 4400.097979914126, 4421.491528474218, 4454.844080457185, 4463.4420697412825, 4408.426904502427, 4447.155040542287, 4509.571590698878, 4515.729056256619, 4526.569975852305, 4447.5552444755585, 4474.261746811772, 4513.300438432048, 4527.411436513232, 4529.320601909707, 4240.851570195059, 4294.398784170218, 4296.5273819879785, 4342.088161486092, 4361.280388735887, 4722.126406614787, 4749.358836557055, 4750.192467280536, 4755.595774359183, 4761.785719642589, 4991.850244492671, 5022.070916880352, 5030.195168773015, 5059.924101138486, 5093.465186155438, 5053.646244762868, 5058.645894787366, 5064.265681476165, 5151.742412879341, 5214.556762675177, 4786.210275304606, 4794.7362895040405, 4795.376601041842, 4800.207965685623, 4854.126257273654, 5103.10695628271, 5153.458886816905, 5158.92261616076, 5203.375594928557, 5220.1647736362, 4970.428400733889, 5001.42483614389, 5003.574696150795, 5012.624053196025, 5076.771545280398, 5090.847274581768, 5104.9744751276, 5106.106431374495, 5108.642395032386, 5111.080005598954, 4879.804807807648, 4973.52751488608, 4976.377952755905, 5041.092603331363, 5047.141985862412, 4995.325631039763, 5018.799248030038, 5026.2460630904925, 5029.823956161516, 5033.0437216929395, 4290.313549832012, 4319.568043195718, 4331.696781225347, 4333.479982402132, 4334.1981733379425, 3757.962420375761, 3773.1699026214187, 3790.450384694204, 3790.962090379116, 3819.7708137511836, 4301.935470967938, 4341.804618792162, 4390.05613793036, 4396.670249731283, 4398.8020539075815, 5130.666506677054, 5135.306733590992, 5135.512126347991, 5136.871578210575, 5189.169732842727, 4256.723312984646, 4309.439772829574, 4324.827006919751, 4333.566643335705, 4386.166628340605, 4531.77341132942, 4578.633709303248, 4584.977075114603, 4622.95377046232, 4674.205385084544, 4779.784909679072, 4786.473487916396, 4788.0, 4789.137955168103, 4841.298011788342, 5139.460356662496, 5152.6650767699975, 5155.2782610435315, 5155.561777248976, 5216.686998780086, 4645.953540464688, 4703.012367402884, 4730.385049943486, 4730.739809310521, 4790.7844147012775, 5071.568916642127, 5071.721055341992, 5071.949280507148, 5075.2387141929, 5126.53861152498, 5111.3355263815465, 5140.485951404829, 5140.56305214061, 5141.691498510101, 5192.662476938987, 4785.569298763128, 4839.032193561231, 4930.802767889244, 4941.110600092018, 4999.700017998932, 4981.975090124526, 4989.875253118701, 4990.975045124751, 5039.143345631325, 5055.87360315995, 4879.902401952012, 4890.510948905081, 4909.042736666316, 4912.410510738734, 4984.127777638826, 4837.7581120944515, 4895.265710143364, 4944.75276236194, 4997.125503036881, 5073.7716802743225, 4873.780679869344, 4894.779734912009, 4898.632602554894, 4939.851804445872, 4940.604751619933], "value": 4671.483645741178, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.9627626066177, 543.9972800135998, 569.7265312649929, 583.1981026089128, 583.8336074218847, 28303.29241768957, 38405.239214117864, 39709.602903970954, 39802.60197398025, 43799.78100109495, 40163.598364016354, 40501.59498405015, 40572.0, 40595.0, 40644.39033414501, 7638.12161601416, 7793.454458187901, 7794.415418843581, 7794.922050779504, 7797.0, 7684.38524918008, 7772.572508512029, 7775.377969762406, 7777.18339574345, 7777.455578109534, 7794.259545343183, 7836.686532538692, 7847.0, 7847.96076019622, 7849.0, 7740.109887362941, 7793.259640334216, 7796.80507987302, 7797.649105790253, 7800.687972481094, 7729.265719756614, 7802.33680137189, 7803.375729941591, 7805.492642978188, 7810.882836757453, 36624.81687591545, 36943.0, 37001.814990924875, 37025.25949480995, 37044.629553704384, 2924.2543151496234, 3204.8878289259997, 3587.210813620999, 3603.0, 3616.9095772605897, 29122.271943201376, 29613.70386296131, 29673.554896676567, 30127.246818829484, 30546.694533054608, 3516.472529120627, 3550.8934731958084, 3743.681787048104, 3747.831347589365, 3759.0, 250481.0, 250669.0, 250904.0, 252481.0, 252805.0, 51785.48214517882, 52107.04983026606, 52156.73921630368, 52204.0, 52251.0, 55525.444745552835, 55719.0, 55829.7208513963, 55855.44144558503, 55899.0, 14190.574282771533, 14437.639059023608, 14446.0, 14449.205293708737, 14452.0, 10952.069074128789, 11002.559897604006, 11013.889861101447, 11025.393603351733, 11031.117510599133, 13878.0, 15721.764173537405, 15944.521664350088, 16007.199640017952, 16021.359145634044, 4360.193364227628, 4577.885552861138, 5183.2743415921805, 5255.369355677343, 5461.563074953994, 856.7986523167051, 894.7092195036639, 913.8257339318943, 915.190056799737, 916.7891384981492, 26468.470630587664, 27867.442651146863, 28274.71725282721, 28302.433951320858, 28463.71536284652, 921.8478950973148, 943.857931902392, 965.4738167698621, 968.8926584678296, 997.7954519323521, 14069.648258793408, 14958.0, 15057.085157859035, 15062.698746025018, 15073.924630376778, 352178.0, 356441.0, 357103.0, 357413.0, 357459.0, 49735.502644973814, 49783.751081244365, 49883.0, 49954.0, 49974.0, 1161.372858656333, 1174.1839421602076, 1178.187050934852, 1183.7336599265097, 1191.6901605582439, 26201.344966375993, 26940.191794246202, 27532.862335688194, 27579.862100689366, 27811.08174155935, 37113.0, 37851.0, 37872.242555148194, 37873.0, 37946.810265948494, 318496.0, 320292.0, 321014.0, 321029.0, 322071.0, 24493.877530612233, 25629.3592660185, 36757.0, 37086.072848179014, 37186.6281337194, 41363.586364137176, 41465.79267103645, 41889.16221675611, 42106.789466052476, 42494.0, 35293.117672058404, 35401.468977965866, 35459.64540354563, 35582.0, 35615.465768014015, 35143.297134056666, 35707.0, 35742.4638630426, 36038.099047524025, 36288.09279768027, 35161.29677406489, 35420.645793541735, 35757.82121089378, 36053.81973090118, 36505.0, 30520.694793052673, 31635.0, 31728.543792209275, 32002.19994500156, 32025.67974320227, 24986.625200621642, 25140.714821294678, 25375.873120634278, 25733.099341522957, 25782.742172578033], "value": 17294.3118197296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.33804250732334, 351.9313733821906, 361.26843142636164, 367.9540057492814, 380.72968192583267, 12181.147319687625, 15442.073475591458, 15856.286467108965, 16416.17919104043, 17225.22486488108, 16262.0, 16641.667166656658, 16691.248893799777, 16827.074510901897, 16833.074180920044, 4019.0, 4952.083864485064, 5088.23676448532, 5104.438511763703, 5144.4598317176715, 4978.900421991558, 5051.419086805009, 5056.924146137811, 5057.772400241998, 5058.696478211319, 4843.225083986563, 5017.122003649365, 5022.271770593262, 5072.873178170538, 5103.770330335144, 5079.2635067915135, 5094.617903657222, 5113.948860511385, 5122.641415100926, 5122.974385128051, 4411.073674528353, 4526.8868278292975, 4578.313253012042, 4578.633709303248, 4583.0, 19771.80228197714, 19774.80225197744, 19976.10107545164, 19986.10062547189, 20070.698939515918, 1845.3910209630924, 1863.4595967169505, 1879.20133943075, 1880.0787614069145, 2002.3792624286518, 12675.873241267562, 12717.109802313842, 12931.612051638465, 13438.12652177615, 13622.114562553501, 1618.174730887244, 1624.2609612626227, 1663.4344322930262, 1703.9403620873334, 1719.346648273648, 43415.565844341465, 64850.351496485375, 66339.66830165818, 66514.66742666304, 67435.0, 9229.953850230706, 9416.246700263962, 9673.274504412197, 9682.0, 9687.225021998223, 13086.934565327112, 13088.411021504055, 13088.869111308955, 13096.738065238642, 13100.21398716061, 6907.925972941993, 7025.578465292099, 7063.364297213276, 7266.564006159648, 7284.562926224337, 6873.20958089816, 6899.448044156456, 6941.409980151642, 7180.461465390116, 7207.315305046012, 5980.611260268069, 6046.093086037042, 6071.726772295257, 6085.5435842312, 6236.376362363727, 1613.2256516871732, 1644.7203975323985, 1714.768506251665, 1715.3653148334947, 1738.6696527659703, 802.8996375453069, 838.4172999765104, 849.392684230778, 975.2880397310004, 980.9313348065567, 16092.0, 16387.508374748777, 17380.13099345053, 17483.86354886928, 17948.641027179383, 855.170484629908, 862.943908645936, 867.9739607811775, 868.4702331577732, 895.0199531512983, 9054.456732596065, 9317.534123293808, 9804.607815687436, 10169.796604067877, 10215.897841021644, 362599.0, 365169.0, 367065.0, 367364.0, 370049.0, 75221.24778752252, 75788.24211757923, 77280.22719772843, 77556.0, 78704.60647696839, 900.8513595256841, 904.4934836491586, 914.4467597103657, 916.9174774270215, 917.7659696777413, 15279.847201527842, 15282.0, 15664.686706266039, 15984.680306393575, 16051.678966420373, 34076.488852666735, 36798.8160059198, 36966.0, 40443.59556404516, 41456.79271603622, 48385.0, 52131.73934130305, 52419.0, 52656.736716316176, 52723.736381317845, 4735.195016847076, 5874.882502349844, 6071.876702809995, 7354.6690398931105, 7604.657790399335, 9083.772905677146, 11750.23623464472, 11891.702707432383, 12055.457504412498, 12065.81901271464, 10417.270791044553, 10503.264771465923, 10662.89337106619, 10741.409222492837, 10881.782364352826, 9474.668386606436, 10273.280870339004, 10549.314294571135, 10618.09746171584, 10647.733806654585, 10250.692479225338, 10483.370997739856, 10799.514021868878, 10835.67492975212, 10894.836577451186, 7542.170361260147, 7639.885401718868, 7679.846403071795, 7775.650095745592, 7855.960720196363, 8905.975812781355, 10396.544483772126, 10476.00477954593, 10618.946905265424, 10732.624358147428], "value": 8127.8867129274095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1161.5992482593501, 1318.3210646517039, 1377.9311034448276, 1392.269058744159, 1695.4150817967804, 6771.424428923541, 7757.379409647228, 8004.559749213791, 8025.839483210332, 8259.752207433787, 8110.95944520278, 8190.754277371673, 8197.672093116269, 8202.056763472203, 8204.507729536232, 2197.395716178056, 2216.8891555422247, 2217.5010622609943, 2219.4562332228547, 2226.1763147635397, 2133.232036466871, 2168.1544197762805, 2189.4745261137373, 2191.233068426054, 2194.6378847490146, 2149.215536329244, 2154.472154322193, 2164.0478189596606, 2179.139240000199, 2206.6910632511463, 2129.4569884679386, 2132.115172203534, 2132.2110818996916, 2134.2210093315907, 2135.722356093713, 2107.062357251024, 2130.9680354794536, 2153.493928926701, 2155.385715071213, 2156.0728886578763, 7954.3636509079715, 8051.557164355958, 8054.23484768946, 8059.838803223961, 8116.797080072986, 4447.577480139382, 4617.561331673485, 4618.1687296286655, 4663.067386522675, 4687.6249900007915, 2786.317352248692, 2921.524630061805, 2933.0467598030514, 2953.3354995126138, 2953.5569664550276, 852.3394369363731, 873.2228316798055, 882.4749274181852, 893.0622846011727, 898.23201163006, 10896.945515272451, 11023.393713345762, 11052.944735276273, 11057.889421105847, 11061.944690276498, 3824.254270417242, 3939.6454319110844, 4106.835726570964, 4122.134351786099, 4123.773192474383, 8567.143285671507, 8570.700025499078, 8572.099929507436, 8572.228499435081, 8574.78563035929, 4440.622547083534, 4455.353973673799, 4460.77696115193, 4462.6876118672035, 4464.598186163261, 3699.2231631357718, 3842.634949679776, 4035.596440355941, 4180.226658068267, 4185.727927684691, 3354.3626710924846, 3388.542546756206, 3506.2461570762407, 3534.540509733718, 3536.4695295705337, 1001.7746007148479, 1014.4116412480744, 1018.3126389686931, 1020.0360659177006, 1035.166690813887, 668.488606216245, 795.431266644352, 807.6809660184311, 826.6404114210337, 848.4485084694998, 4825.4933232010835, 5000.774965126578, 5060.797568097309, 5156.1492353761205, 5312.0, 358.6503159419597, 368.7418806835226, 376.8793985924478, 380.46544604830257, 905.2531661379388, 3511.648835116519, 3610.4403817408343, 3615.6926661233565, 3655.8903232903053, 3658.762180458262, 9370.718878433658, 9707.514624268759, 9743.464109473905, 9778.41329520231, 9893.45585992763, 9686.564104615309, 9888.555015024342, 9892.0, 9917.752056198653, 9974.850377244202, 7429.5542267464125, 7595.810104747315, 7596.886046709304, 7608.733694320562, 7609.733659321897, 5191.22131680251, 5213.582913366998, 5220.504052115043, 5428.0, 5578.219049333015, 8638.524881131598, 8731.956340218258, 8983.730488085368, 9160.679376222068, 9283.814323713623, 9236.769080772765, 9250.167484926389, 9410.623575056921, 9444.905550944402, 9453.291003174927, 6729.831754206184, 7010.053642758162, 7606.163322034682, 7775.961120194363, 7788.727394541163, 7308.415326773952, 7696.615169241628, 7729.265719756614, 7878.0, 7893.802654933443, 6712.39588437043, 6752.0, 6864.38220560152, 6936.618485983319, 7070.36366726997, 6703.731850725916, 6761.52669313163, 6766.511367499143, 6900.516963812485, 6986.441084713312, 6426.196725409324, 6452.645104519109, 6459.063435801876, 6499.610023398611, 6503.51223658237, 4522.502524722212, 4548.681592288508, 4549.112922979987, 4564.475085365226, 4603.907921841477, 4540.591346778806, 4543.840965566189, 4550.863474095782, 4669.322948172564, 4695.765211739467], "value": 4055.0784802141907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.91563446600475, 292.1862612623842, 297.6101307287453, 303.89819410497483, 305.1151660185462, 4503.211937910861, 4649.395578574789, 4678.274867395555, 4718.480967093621, 4736.810527578897, 4537.752118167506, 4610.5850473457385, 4686.625069994401, 4687.8359257426, 4708.882277943053, 3766.2279232757355, 3766.8304926278247, 3769.18962423079, 3769.905752356199, 3772.302124107035, 3551.875684351048, 3677.5403074615674, 3768.868089616864, 3771.18919432322, 3778.508793856795, 3637.5271214742047, 3718.8326525306425, 3735.2529494101154, 3736.514253147087, 3751.1934933989187, 3720.720945929066, 3726.4037753959237, 3729.1236559408517, 3730.477733117366, 3732.552093748754, 3308.123347312964, 3308.586426696663, 3317.402867483876, 3319.40250754864, 3321.2029113012945, 4499.842505512324, 4595.678302518825, 4598.862034138948, 4608.654350923661, 4617.953820461786, 4237.406763053175, 4240.38514415408, 4243.299855523835, 4252.617264446215, 4259.1268789897995, 4920.409550853885, 4928.778204980785, 4938.38270216223, 4940.184869496528, 4940.604751619861, 3454.671806178409, 3599.3521166190076, 3620.3664358737115, 3626.673599376069, 3630.8547658093644, 5099.87250318745, 5107.719075450848, 5115.0, 5129.948700512984, 5155.226715992631, 3648.689861361761, 3665.120371110914, 3667.339878821838, 3667.9266414671556, 3678.2643471305846, 3715.1826598148364, 3717.423799311111, 3719.683826874692, 3727.8508859645854, 3728.520533845017, 3892.026993251687, 4134.834606615702, 4149.688773342012, 4158.251514727378, 4208.22147902639, 4877.414710234723, 4883.34074899891, 4892.143874821963, 4893.266010098514, 4896.2410826321975, 1188.3226560860226, 1214.8967337776387, 1217.9756404871853, 1243.9440225189887, 1257.6478585995935, 852.4331319672473, 852.8635418333037, 866.6923242249037, 868.7437206024238, 868.8045189832363, 4312.374705667723, 4347.782610869507, 4349.238883195429, 4363.211083455832, 4375.321825117112, 5066.721330326794, 5074.391073071181, 5082.74586270685, 5088.1350170471105, 5095.388553373619, 4370.431843860341, 4373.759443230653, 4374.321980093091, 4376.978115109404, 4378.846740364135, 2313.8611683299055, 2415.7463466336135, 2415.8188135889877, 2420.2739178246457, 2421.2736179146186, 4269.765162916069, 4273.722208056466, 4278.358246263023, 4285.700000999963, 4291.463567054118, 4584.7936842842155, 4598.425196850394, 4625.283081122431, 4631.652626053059, 4634.490206077328, 4253.107886637116, 4279.507856596531, 4469.865904022885, 4819.566239038503, 4847.854564363075, 5161.535461808456, 5171.9482805171465, 5178.559822415137, 5184.274201611853, 5186.585073194211, 5088.160453525127, 5089.211172268304, 5090.821821236239, 5093.159628661229, 5098.0, 4633.675642704979, 4766.523347665206, 4795.592374648055, 4811.398575178103, 4840.951590484191, 3620.31214069326, 3636.8181590919817, 3647.161152934787, 3655.670989610948, 3655.6892664123848, 5118.027574760784, 5129.563987061141, 5134.281200631989, 5134.922976155286, 5146.459621739813, 4714.316424118552, 4842.7578621068105, 4886.144924638245, 4988.376452943382, 5018.297438358706, 5003.724795136157, 5004.174311238605, 5004.9489607182895, 5005.274235235797, 5022.3219865317715, 4899.877503062452, 4910.386201724785, 4911.666958194972, 4913.557779799835, 4933.506649335038, 4793.32893394918, 4986.376702912136, 5016.792611251038, 5023.271625614192, 5026.974865125651, 4920.065187614342, 4923.163062279349, 4927.704337739747, 4928.285398617252, 4937.679050861682], "value": 3706.7662401300104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5369616370331, 559.7117484495483, 622.1410781794187, 721.7473884140552, 759.7834617134115, 11636.360000199986, 12612.369381530922, 12613.558525451612, 12613.810792838114, 12700.555480558194, 11953.163278570504, 12210.93894530526, 12567.308798016105, 12716.0, 12735.808962865542, 491.7442929676566, 759.0360242492046, 779.6569509415867, 781.9061712594497, 782.6165179062275, 648.6951132967498, 660.3825423229272, 660.6531570925279, 660.8215781738928, 735.4153448008846, 815.1440986963664, 823.7693445835175, 824.9793755156139, 825.2861274997115, 825.9008918929707, 819.8524265632154, 820.0159808230118, 821.0475848016273, 822.5475988206463, 822.7284995951321, 477.5463309855616, 490.75952783136364, 599.8260504453704, 599.9100134979744, 600.7236671131285, 11898.46456909441, 12399.13206075575, 12436.626901192889, 12646.936765316206, 12884.291363974977, 12618.17981831178, 12644.68388290291, 13648.590542283748, 13821.51624693141, 13891.930540347335, 10191.745206369826, 10195.643152489627, 10369.585216591327, 10598.31110977784, 10783.245172837904, 3337.4493208620547, 3337.8664853405835, 3353.3796247694254, 3355.8489867955755, 3356.127406874206, 60351.69824150895, 60446.09330860041, 60466.39533604652, 61639.69180154115, 61847.38152618506, 10122.88794158945, 10216.131628811485, 10439.321444106108, 10763.78472430547, 10853.45732713377, 18434.0, 18476.0, 18575.81424185768, 18595.721064184047, 18598.25606975706, 6759.5606285591275, 6832.795016149524, 6851.417629501449, 6865.897011544831, 7113.0, 3576.2668652926086, 3691.630836916287, 3735.477033215352, 3794.487744154559, 3823.0824602095295, 2925.473414785359, 3061.974238630084, 3067.9539806902912, 3071.7081877221626, 3075.815451072943, 498.9675671081368, 509.1802198460476, 516.4241870314572, 545.9344878614512, 564.3030856891735, 492.8743170491502, 504.41487874065905, 530.4695304695305, 533.6184627991005, 552.3592632546307, 6828.385445309946, 7266.346028857322, 7321.194668586451, 7368.59472729005, 7911.327537159291, 469.3522938345062, 519.8440467859627, 532.3186321508475, 583.8481994681329, 585.5813093638069, 3552.8223588820456, 3780.5085338905765, 3878.2825177342283, 3936.5866584008268, 4071.75569465833, 87000.5649971746, 96650.0, 103775.4811225939, 107425.0, 107599.46200268948, 65661.0, 66710.33289667139, 66912.0, 76498.61750691323, 86676.5666171665, 43174.0, 60415.39584604186, 75791.24208757952, 77293.0, 78663.21336786673, 7512.248775122444, 7843.960780196063, 7893.723719669784, 8100.87848682282, 8191.672333106609, 29912.80348786024, 38168.427473588476, 38500.42249366318, 38630.14242075619, 43331.35002975021, 59480.40519594749, 59690.70154649199, 59712.70143649254, 59763.40236597752, 63866.68066659637, 10933.83599246028, 10947.50736216888, 10999.560017599206, 11146.554137834395, 11398.772024559628, 11835.46740396667, 11885.811418858046, 12056.397180140782, 12309.892109710168, 12928.224306541637, 11136.0, 11223.551057957917, 11497.195196336175, 11582.247153934968, 11722.355270459866, 11170.441477925908, 11174.720631984266, 11489.368084755419, 11608.767824643292, 12004.879951200726, 10660.413677247825, 10698.411587362458, 10755.569777208824, 11397.259178153394, 11477.655670329903, 9587.760305992406, 9718.173955213886, 9783.36408133469, 9969.35199212049, 10179.389236645826, 10405.47972601382, 10662.306950048222, 10798.244122911321, 10868.456577171268, 11049.28179668319], "value": 6338.606866586307, "unit": "score"}], "name": "dromaeo_css", "value": 6300.801413952503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 115.0, 113.0, 115.0, 117.0, 114.0, 113.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 124.0, 171.0, 129.0, 124.0, 122.0, 122.0, 153.0, 129.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 161.0, 162.0, 162.0, 162.0, 162.0, 160.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 108.0, 78.0, 79.0, 76.0, 77.0, 100.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 121.0, 85.0, 86.0, 85.0, 107.0, 85.0, 84.0, 117.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 63.0, 64.0, 63.0, 63.0, 63.0, 68.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 82.0, 82.0, 81.0, 90.0, 82.0, 82.0, 89.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 133.0, 141.0, 131.0, 132.0, 134.0, 132.0, 172.0, 141.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 181.0, 180.0, 171.0, 171.0, 169.0, 173.0, 173.0, 172.0, 175.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 73.0, 68.0, 69.0, 74.0, 68.0, 68.0, 68.0, 66.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1540.0, "alertThreshold": 2.0}]} 05:13:28 INFO - Return code: 0 05:13:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:28 INFO - # TBPL SUCCESS # 05:13:28 INFO - Running post-action listener: _resource_record_post_action 05:13:28 INFO - [mozharness: 2016-09-28 12:13:28.810801Z] Finished run-tests step (success) 05:13:28 INFO - Running post-run listener: _resource_record_post_run 05:13:28 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 390696960; Read time: 356; Write time: 269400 05:13:28 INFO - TinderboxPrint: CPU usage
13.0% 05:13:28 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 356 05:13:28 INFO - TinderboxPrint: I/O write bytes / time
390,696,960 / 269,400 05:13:28 INFO - TinderboxPrint: CPU idle
8,350.2 (87.0%) 05:13:28 INFO - TinderboxPrint: CPU user
1,197.6 (12.5%) 05:13:28 INFO - TinderboxPrint: Swap in / out
0 / 0 05:13:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99057664; Read time: 188; Write time: 68748 05:13:28 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291639296; Read time: 156; Write time: 200652 05:13:29 INFO - Running post-run listener: _upload_blobber_files 05:13:29 INFO - Blob upload gear active. 05:13:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:29 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 05:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:30 INFO - (blobuploader) - INFO - Done attempting. 05:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:31 INFO - (blobuploader) - INFO - Done attempting. 05:13:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:34 INFO - (blobuploader) - INFO - Done attempting. 05:13:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:34 INFO - Return code: 0 05:13:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/773ee681dba2eb5002a661678b36b8c0b0d953b3965700945b681013b33abb6f401a403a3d2abe9435f26a0d7df512dc9c72eed7658c9ab8663df46179663585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23d9312fede01bd10863f197c3287f7dfc330255c03e8d6e4e39f0eaca2a13323bcb87f5c401e061fe4b3fd0f77b4ee2658ea487cab01f198b2f6ef25e7fd767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2d9fe5190125f16bb4b1b3d551d767f49f26aa4f44a95ca5b4ceb91a25a3978f43ed75e939a39295129aca817b86b7255f40272151e1469de5e40e3ec1fb6f6"} 05:13:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:34 INFO - Contents: 05:13:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/773ee681dba2eb5002a661678b36b8c0b0d953b3965700945b681013b33abb6f401a403a3d2abe9435f26a0d7df512dc9c72eed7658c9ab8663df46179663585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23d9312fede01bd10863f197c3287f7dfc330255c03e8d6e4e39f0eaca2a13323bcb87f5c401e061fe4b3fd0f77b4ee2658ea487cab01f198b2f6ef25e7fd767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2d9fe5190125f16bb4b1b3d551d767f49f26aa4f44a95ca5b4ceb91a25a3978f43ed75e939a39295129aca817b86b7255f40272151e1469de5e40e3ec1fb6f6"} 05:13:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:34 INFO - Copying logs to upload dir... 05:13:34 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.767395 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-28 05:13:34.457368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:34.461559) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/773ee681dba2eb5002a661678b36b8c0b0d953b3965700945b681013b33abb6f401a403a3d2abe9435f26a0d7df512dc9c72eed7658c9ab8663df46179663585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23d9312fede01bd10863f197c3287f7dfc330255c03e8d6e4e39f0eaca2a13323bcb87f5c401e061fe4b3fd0f77b4ee2658ea487cab01f198b2f6ef25e7fd767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2d9fe5190125f16bb4b1b3d551d767f49f26aa4f44a95ca5b4ceb91a25a3978f43ed75e939a39295129aca817b86b7255f40272151e1469de5e40e3ec1fb6f6"} build_url:https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/dVhxn5WIQkudYpLPo5DG3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/773ee681dba2eb5002a661678b36b8c0b0d953b3965700945b681013b33abb6f401a403a3d2abe9435f26a0d7df512dc9c72eed7658c9ab8663df46179663585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23d9312fede01bd10863f197c3287f7dfc330255c03e8d6e4e39f0eaca2a13323bcb87f5c401e061fe4b3fd0f77b4ee2658ea487cab01f198b2f6ef25e7fd767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2d9fe5190125f16bb4b1b3d551d767f49f26aa4f44a95ca5b4ceb91a25a3978f43ed75e939a39295129aca817b86b7255f40272151e1469de5e40e3ec1fb6f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:34.489570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:34.489906) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475063523.726300-1160113381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:34.568899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 05:13:34.572254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 05:13:34.572554) ========= ========= Total master_lag: 0.24 =========