builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1474062673.07 results: success (0) buildid: 20160916133317 builduid: 812e3f6f7a8e468bb6b655747b4147a8 revision: 0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.065445) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.065944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.066385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.081914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.082224) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-16 14:51:13-- 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% 46.6M=0s 2016-09-16 14:51:13 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076955 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.173464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.173819) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.224024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.224397) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7 --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 0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7 --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=c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-16 14:51:13,427 truncating revision to first 12 chars 2016-09-16 14:51:13,427 Setting DEBUG logging. 2016-09-16 14:51:13,427 attempt 1/10 2016-09-16 14:51:13,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e0c46418b14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-16 14:51:13,727 unpacking tar archive at: fx-team-0e0c46418b14/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676905 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.914820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.915139) ========= script_repo_revision: 0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.915540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.915839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 14:51:13.926432) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-16 14:51:13.926741) ========= /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=c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:51:14 INFO - MultiFileLogger online at 20160916 14:51:14 in /builds/slave/test 14:51:14 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 14:51:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:51:14 INFO - {'append_to_log': False, 14:51:14 INFO - 'base_work_dir': '/builds/slave/test', 14:51:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:51:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:51:14 INFO - 'branch': 'Fx-Team-Non-PGO', 14:51:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:51:14 INFO - 'config_files': ('talos/linux_config.py',), 14:51:14 INFO - 'default_actions': ('clobber', 14:51:14 INFO - 'read-buildbot-config', 14:51:14 INFO - 'download-and-extract', 14:51:14 INFO - 'populate-webroot', 14:51:14 INFO - 'create-virtualenv', 14:51:14 INFO - 'install', 14:51:14 INFO - 'run-tests'), 14:51:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:51:14 INFO - 'download_minidump_stackwalk': True, 14:51:14 INFO - 'download_symbols': 'ondemand', 14:51:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:51:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:51:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:51:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:51:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:51:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:51:14 INFO - 'installer_path': 'installer.exe', 14:51:14 INFO - 'log_level': 'info', 14:51:14 INFO - 'log_name': 'talos', 14:51:14 INFO - 'log_to_console': True, 14:51:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:51:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:51:14 INFO - 'opt_config_files': (), 14:51:14 INFO - 'pip_index': False, 14:51:14 INFO - 'sps_profile': False, 14:51:14 INFO - 'sps_profile_interval': 0, 14:51:14 INFO - 'suite': 'dromaeojs', 14:51:14 INFO - 'system_bits': '32', 14:51:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:51:14 INFO - 'title': 'talos-linux64-ix-004', 14:51:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:51:14 INFO - 'use_talos_json': True, 14:51:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:51:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:51:14 INFO - 'work_dir': 'build'} 14:51:14 INFO - [mozharness: 2016-09-16 21:51:14.218000Z] Running clobber step. 14:51:14 INFO - Running pre-action listener: _resource_record_pre_action 14:51:14 INFO - Running main action method: clobber 14:51:14 INFO - rmtree: /builds/slave/test/build 14:51:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:51:15 INFO - Running post-action listener: _resource_record_post_action 14:51:15 INFO - [mozharness: 2016-09-16 21:51:15.196894Z] Finished clobber step (success) 14:51:15 INFO - [mozharness: 2016-09-16 21:51:15.196994Z] Running read-buildbot-config step. 14:51:15 INFO - Running pre-action listener: _resource_record_pre_action 14:51:15 INFO - Running main action method: read_buildbot_config 14:51:15 INFO - Using buildbot properties: 14:51:15 INFO - { 14:51:15 INFO - "project": "", 14:51:15 INFO - "product": "firefox", 14:51:15 INFO - "script_repo_revision": "production", 14:51:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:51:15 INFO - "repository": "", 14:51:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:51:15 INFO - "buildid": "20160916133317", 14:51:15 INFO - "pgo_build": "False", 14:51:15 INFO - "basedir": "/builds/slave/test", 14:51:15 INFO - "buildnumber": 2163, 14:51:15 INFO - "slavename": "talos-linux64-ix-004", 14:51:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:51:15 INFO - "platform": "ubuntu64_hw", 14:51:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:51:15 INFO - "branch": "fx-team", 14:51:15 INFO - "repo_path": "integration/fx-team", 14:51:15 INFO - "revision": "0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7", 14:51:15 INFO - "stage_platform": "linux64", 14:51:15 INFO - "builduid": "812e3f6f7a8e468bb6b655747b4147a8", 14:51:15 INFO - "slavebuilddir": "test" 14:51:15 INFO - } 14:51:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:51:15 INFO - Running post-action listener: _resource_record_post_action 14:51:15 INFO - [mozharness: 2016-09-16 21:51:15.199453Z] Finished read-buildbot-config step (success) 14:51:15 INFO - [mozharness: 2016-09-16 21:51:15.199543Z] Running download-and-extract step. 14:51:15 INFO - Running pre-action listener: _resource_record_pre_action 14:51:15 INFO - Running main action method: download_and_extract 14:51:15 INFO - mkdir: /builds/slave/test/build/tests 14:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:15 INFO - trying https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:51:15 INFO - Downloading https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:51:15 INFO - Downloaded 1361 bytes. 14:51:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:51:15 INFO - Using the following test package requirements: 14:51:15 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:51:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:51:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'jsshell-linux-x86_64.zip'], 14:51:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:51:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:51:15 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:51:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:51:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:51:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:51:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:51:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:51:15 INFO - Fetch https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:51:16 INFO - Expected file size: 20364718 14:51:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:51:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:51:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:51:20 INFO - Fetch https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:51:21 INFO - Expected file size: 20364718 14:51:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:51:25 INFO - Fetch https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:51:26 INFO - Expected file size: 14414048 14:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:26 INFO - trying https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:51:26 INFO - Downloading https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:51:28 INFO - Downloaded 55592904 bytes. 14:51:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:51:28 INFO - mkdir: /builds/slave/test/properties 14:51:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:28 INFO - Contents: 14:51:28 INFO - build_url:https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:51:28 INFO - Running post-action listener: _resource_record_post_action 14:51:28 INFO - Running post-action listener: set_extra_try_arguments 14:51:28 INFO - [mozharness: 2016-09-16 21:51:28.724082Z] Finished download-and-extract step (success) 14:51:28 INFO - [mozharness: 2016-09-16 21:51:28.724426Z] Running populate-webroot step. 14:51:28 INFO - Running pre-action listener: _resource_record_pre_action 14:51:28 INFO - Running main action method: populate_webroot 14:51:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:28 INFO - '--tppagecycles', 14:51:28 INFO - '7'], 14:51:28 INFO - 'tests': ['tsvgm']}}, 14:51:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['damp', 'tps']}, 14:51:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'tests': ['damp', 'tps']}, 14:51:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['dromaeo_dom']}, 14:51:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['basic_compositor_video']}, 14:51:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:51:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['a11yr', 14:51:28 INFO - 'ts_paint', 14:51:28 INFO - 'tpaint', 14:51:28 INFO - 'sessionrestore', 14:51:28 INFO - 'sessionrestore_no_auto_restore', 14:51:28 INFO - 'tabpaint']}, 14:51:28 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:28 INFO - 'ts_paint', 14:51:28 INFO - 'tpaint', 14:51:28 INFO - 'sessionrestore', 14:51:28 INFO - 'sessionrestore_no_auto_restore', 14:51:28 INFO - 'tabpaint']}, 14:51:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:28 INFO - 'ts_paint', 14:51:28 INFO - 'tpaint', 14:51:28 INFO - 'sessionrestore', 14:51:28 INFO - 'sessionrestore_no_auto_restore', 14:51:28 INFO - 'tabpaint']}, 14:51:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:28 INFO - 'ts_paint', 14:51:28 INFO - 'tpaint', 14:51:28 INFO - 'sessionrestore', 14:51:28 INFO - 'sessionrestore_no_auto_restore', 14:51:28 INFO - 'tabpaint']}, 14:51:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['a11yr', 14:51:28 INFO - 'ts_paint', 14:51:28 INFO - 'tpaint', 14:51:28 INFO - 'sessionrestore', 14:51:28 INFO - 'sessionrestore_no_auto_restore', 14:51:28 INFO - 'tabpaint']}, 14:51:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['a11yr', 14:51:28 INFO - 'ts_paint', 14:51:28 INFO - 'tpaint', 14:51:28 INFO - 'sessionrestore', 14:51:28 INFO - 'sessionrestore_no_auto_restore', 14:51:28 INFO - 'tabpaint']}, 14:51:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['tsvgx', 14:51:28 INFO - 'tsvgr_opacity', 14:51:28 INFO - 'tart', 14:51:28 INFO - 'tscrollx', 14:51:28 INFO - 'cart']}, 14:51:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:28 INFO - 'tsvgr_opacity', 14:51:28 INFO - 'tart', 14:51:28 INFO - 'tscrollx', 14:51:28 INFO - 'cart']}, 14:51:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'talos_options': ['--disable-e10s'], 14:51:28 INFO - 'tests': ['tp5o']}, 14:51:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'tests': ['tp5o']}, 14:51:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'talos_options': ['--disable-e10s', 14:51:28 INFO - '--xperf_path', 14:51:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:28 INFO - 'tests': ['tp5n']}, 14:51:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:28 INFO - 'talos_options': ['--xperf_path', 14:51:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:28 INFO - 'tests': ['tp5n']}}, 14:51:28 INFO - 'talos.zip': {'path': '', 14:51:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:28 INFO - Running post-action listener: _resource_record_post_action 14:51:28 INFO - [mozharness: 2016-09-16 21:51:28.747226Z] Finished populate-webroot step (success) 14:51:28 INFO - [mozharness: 2016-09-16 21:51:28.747321Z] Running create-virtualenv step. 14:51:28 INFO - Running pre-action listener: _resource_record_pre_action 14:51:28 INFO - Running main action method: create_virtualenv 14:51:28 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:28 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 14:51:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:28 INFO - Using real prefix '/usr' 14:51:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:29 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:31 INFO - Installing pip.................done. 14:51:31 INFO - Return code: 0 14:51:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51:31 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')]} 14:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:31 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')]} 14:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:31 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:31 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 14:51:31 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 14:51:31 INFO - Using env: {'DISPLAY': ':0', 14:51:31 INFO - 'HOME': '/home/cltbld', 14:51:31 INFO - 'LANG': 'en_US.UTF-8', 14:51:31 INFO - 'LANGUAGE': 'en_US:en', 14:51:31 INFO - 'LOGNAME': 'cltbld', 14:51:31 INFO - 'MAIL': '/var/mail/cltbld', 14:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:31 INFO - 'MOZ_NO_REMOTE': '1', 14:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:31 INFO - 'NO_EM_RESTART': '1', 14:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:31 INFO - 'PWD': '/builds/slave/test', 14:51:31 INFO - 'SHELL': '/bin/bash', 14:51:31 INFO - 'SHLVL': '1', 14:51:31 INFO - 'TERM': 'linux', 14:51:31 INFO - 'TMOUT': '86400', 14:51:31 INFO - 'USER': 'cltbld', 14:51:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:31 INFO - '_': '/tools/buildbot/bin/python'} 14:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:31 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 14:51:31 INFO - Cleaning up... 14:51:31 INFO - Return code: 0 14:51:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:51:31 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')]} 14:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:31 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')]} 14:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:31 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:31 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 14:51:31 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 14:51:31 INFO - Using env: {'DISPLAY': ':0', 14:51:31 INFO - 'HOME': '/home/cltbld', 14:51:31 INFO - 'LANG': 'en_US.UTF-8', 14:51:31 INFO - 'LANGUAGE': 'en_US:en', 14:51:31 INFO - 'LOGNAME': 'cltbld', 14:51:31 INFO - 'MAIL': '/var/mail/cltbld', 14:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:31 INFO - 'MOZ_NO_REMOTE': '1', 14:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:31 INFO - 'NO_EM_RESTART': '1', 14:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:31 INFO - 'PWD': '/builds/slave/test', 14:51:31 INFO - 'SHELL': '/bin/bash', 14:51:31 INFO - 'SHLVL': '1', 14:51:31 INFO - 'TERM': 'linux', 14:51:31 INFO - 'TMOUT': '86400', 14:51:31 INFO - 'USER': 'cltbld', 14:51:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:31 INFO - '_': '/tools/buildbot/bin/python'} 14:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:31 INFO - Downloading/unpacking psutil>=3.1.1 14:51:31 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 14:51:31 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 14:51:31 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 14:51:31 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 14:51:31 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 14:51:31 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 14:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:33 INFO - Installing collected packages: psutil 14:51:33 INFO - Running setup.py install for psutil 14:51:33 INFO - building 'psutil._psutil_linux' extension 14:51:33 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 14:51:33 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 14:51:34 INFO - building 'psutil._psutil_posix' extension 14:51:34 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 14:51:34 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 14:51:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:34 INFO - Successfully installed psutil 14:51:34 INFO - Cleaning up... 14:51:34 INFO - Return code: 0 14:51:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:34 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:34 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 14:51:34 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 14:51:34 INFO - Using env: {'DISPLAY': ':0', 14:51:34 INFO - 'HOME': '/home/cltbld', 14:51:34 INFO - 'LANG': 'en_US.UTF-8', 14:51:34 INFO - 'LANGUAGE': 'en_US:en', 14:51:34 INFO - 'LOGNAME': 'cltbld', 14:51:34 INFO - 'MAIL': '/var/mail/cltbld', 14:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:34 INFO - 'MOZ_NO_REMOTE': '1', 14:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:34 INFO - 'NO_EM_RESTART': '1', 14:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:34 INFO - 'PWD': '/builds/slave/test', 14:51:34 INFO - 'SHELL': '/bin/bash', 14:51:34 INFO - 'SHLVL': '1', 14:51:34 INFO - 'TERM': 'linux', 14:51:34 INFO - 'TMOUT': '86400', 14:51:34 INFO - 'USER': 'cltbld', 14:51:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:34 INFO - '_': '/tools/buildbot/bin/python'} 14:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:51:34 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 14:51:34 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 14:51:34 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 14:51:34 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 14:51:34 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 14:51:34 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 14:51:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:51:36 INFO - Installing collected packages: mozsystemmonitor 14:51:36 INFO - Running setup.py install for mozsystemmonitor 14:51:36 INFO - Successfully installed mozsystemmonitor 14:51:36 INFO - Cleaning up... 14:51:36 INFO - Return code: 0 14:51:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:51:36 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')]} 14:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:36 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')]} 14:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:36 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:36 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 14:51:36 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 14:51:36 INFO - Using env: {'DISPLAY': ':0', 14:51:36 INFO - 'HOME': '/home/cltbld', 14:51:36 INFO - 'LANG': 'en_US.UTF-8', 14:51:36 INFO - 'LANGUAGE': 'en_US:en', 14:51:36 INFO - 'LOGNAME': 'cltbld', 14:51:36 INFO - 'MAIL': '/var/mail/cltbld', 14:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:36 INFO - 'MOZ_NO_REMOTE': '1', 14:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:36 INFO - 'NO_EM_RESTART': '1', 14:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:36 INFO - 'PWD': '/builds/slave/test', 14:51:36 INFO - 'SHELL': '/bin/bash', 14:51:36 INFO - 'SHLVL': '1', 14:51:36 INFO - 'TERM': 'linux', 14:51:36 INFO - 'TMOUT': '86400', 14:51:36 INFO - 'USER': 'cltbld', 14:51:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:36 INFO - '_': '/tools/buildbot/bin/python'} 14:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:36 INFO - Downloading/unpacking jsonschema==2.5.1 14:51:36 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 14:51:36 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 14:51:36 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 14:51:36 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 14:51:36 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 14:51:36 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 14:51:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:38 INFO - warning: no files found matching '*.txt' 14:51:38 INFO - no previously-included directories found matching 'build' 14:51:38 INFO - no previously-included directories found matching 'dist' 14:51:38 INFO - no previously-included directories found matching '.git*' 14:51:38 INFO - Installing collected packages: jsonschema, functools32 14:51:39 INFO - Running setup.py install for functools32 14:51:39 INFO - warning: no files found matching '*.txt' 14:51:39 INFO - no previously-included directories found matching 'build' 14:51:39 INFO - no previously-included directories found matching 'dist' 14:51:39 INFO - no previously-included directories found matching '.git*' 14:51:39 INFO - Successfully installed jsonschema functools32 14:51:39 INFO - Cleaning up... 14:51:39 INFO - Return code: 0 14:51:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:51:39 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')]} 14:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:39 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')]} 14:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:39 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:39 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 14:51:39 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 14:51:39 INFO - Using env: {'DISPLAY': ':0', 14:51:39 INFO - 'HOME': '/home/cltbld', 14:51:39 INFO - 'LANG': 'en_US.UTF-8', 14:51:39 INFO - 'LANGUAGE': 'en_US:en', 14:51:39 INFO - 'LOGNAME': 'cltbld', 14:51:39 INFO - 'MAIL': '/var/mail/cltbld', 14:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:39 INFO - 'MOZ_NO_REMOTE': '1', 14:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:39 INFO - 'NO_EM_RESTART': '1', 14:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:39 INFO - 'PWD': '/builds/slave/test', 14:51:39 INFO - 'SHELL': '/bin/bash', 14:51:39 INFO - 'SHLVL': '1', 14:51:39 INFO - 'TERM': 'linux', 14:51:39 INFO - 'TMOUT': '86400', 14:51:39 INFO - 'USER': 'cltbld', 14:51:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:39 INFO - '_': '/tools/buildbot/bin/python'} 14:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:51:39 INFO - Cleaning up... 14:51:39 INFO - Return code: 0 14:51:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:51:39 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')]} 14:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:39 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')]} 14:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:39 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:39 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 14:51:39 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 14:51:39 INFO - Using env: {'DISPLAY': ':0', 14:51:39 INFO - 'HOME': '/home/cltbld', 14:51:39 INFO - 'LANG': 'en_US.UTF-8', 14:51:39 INFO - 'LANGUAGE': 'en_US:en', 14:51:39 INFO - 'LOGNAME': 'cltbld', 14:51:39 INFO - 'MAIL': '/var/mail/cltbld', 14:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:39 INFO - 'MOZ_NO_REMOTE': '1', 14:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:39 INFO - 'NO_EM_RESTART': '1', 14:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:39 INFO - 'PWD': '/builds/slave/test', 14:51:39 INFO - 'SHELL': '/bin/bash', 14:51:39 INFO - 'SHLVL': '1', 14:51:39 INFO - 'TERM': 'linux', 14:51:39 INFO - 'TMOUT': '86400', 14:51:39 INFO - 'USER': 'cltbld', 14:51:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:39 INFO - '_': '/tools/buildbot/bin/python'} 14:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:39 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:39 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 14:51:39 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 14:51:39 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 14:51:39 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 14:51:39 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 14:51:39 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 14:51:41 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51:41 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 14:51:41 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 14:51:41 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 14:51:41 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 14:51:41 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 14:51:41 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 14:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:51:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:42 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 14:51:42 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 14:51:42 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 14:51:42 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 14:51:42 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 14:51:42 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 14:51:42 INFO - Downloading docopt-0.6.1.tar.gz 14:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:42 INFO - Running setup.py install for blobuploader 14:51:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:51:42 INFO - Running setup.py install for requests 14:51:42 INFO - Running setup.py install for docopt 14:51:42 INFO - Successfully installed blobuploader requests docopt 14:51:42 INFO - Cleaning up... 14:51:42 INFO - Return code: 0 14:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:42 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')]} 14:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:42 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')]} 14:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:42 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:42 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 14:51:42 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 14:51:42 INFO - Using env: {'DISPLAY': ':0', 14:51:42 INFO - 'HOME': '/home/cltbld', 14:51:42 INFO - 'LANG': 'en_US.UTF-8', 14:51:42 INFO - 'LANGUAGE': 'en_US:en', 14:51:42 INFO - 'LOGNAME': 'cltbld', 14:51:42 INFO - 'MAIL': '/var/mail/cltbld', 14:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:42 INFO - 'MOZ_NO_REMOTE': '1', 14:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:42 INFO - 'NO_EM_RESTART': '1', 14:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:42 INFO - 'PWD': '/builds/slave/test', 14:51:42 INFO - 'SHELL': '/bin/bash', 14:51:42 INFO - 'SHLVL': '1', 14:51:42 INFO - 'TERM': 'linux', 14:51:42 INFO - 'TMOUT': '86400', 14:51:42 INFO - 'USER': 'cltbld', 14:51:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:42 INFO - '_': '/tools/buildbot/bin/python'} 14:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:43 INFO - Running setup.py (path:/tmp/pip-SRX44d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:43 INFO - Running setup.py (path:/tmp/pip-OvlUoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:43 INFO - Running setup.py (path:/tmp/pip-APwTTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:43 INFO - Running setup.py (path:/tmp/pip-7jBJy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:43 INFO - Running setup.py (path:/tmp/pip-EO4heF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:43 INFO - Running setup.py (path:/tmp/pip-wD8e48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:43 INFO - Running setup.py (path:/tmp/pip-Kt1qj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:43 INFO - Running setup.py (path:/tmp/pip-4yEIMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:43 INFO - Running setup.py (path:/tmp/pip-YAOrKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:43 INFO - Running setup.py (path:/tmp/pip-A2uez9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:43 INFO - Running setup.py (path:/tmp/pip-G3MoHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:43 INFO - Running setup.py (path:/tmp/pip-4TLW52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:44 INFO - Running setup.py (path:/tmp/pip-e5u_YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:44 INFO - Running setup.py (path:/tmp/pip-3orGpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:44 INFO - Running setup.py (path:/tmp/pip-_Cg67C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:44 INFO - Running setup.py (path:/tmp/pip-9nxefJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:44 INFO - Running setup.py (path:/tmp/pip-heJVgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:44 INFO - Running setup.py install for manifestparser 14:51:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:51:44 INFO - Running setup.py install for mozcrash 14:51:44 INFO - Running setup.py install for mozdebug 14:51:44 INFO - Running setup.py install for mozdevice 14:51:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:51:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:51:44 INFO - Running setup.py install for mozfile 14:51:44 INFO - Running setup.py install for mozhttpd 14:51:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:51:44 INFO - Running setup.py install for mozinfo 14:51:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Running setup.py install for mozInstall 14:51:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Running setup.py install for mozleak 14:51:45 INFO - Running setup.py install for mozlog 14:51:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Running setup.py install for moznetwork 14:51:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Running setup.py install for mozprocess 14:51:45 INFO - Running setup.py install for mozprofile 14:51:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Running setup.py install for mozrunner 14:51:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:51:45 INFO - Running setup.py install for mozscreenshot 14:51:45 INFO - Running setup.py install for moztest 14:51:46 INFO - Running setup.py install for mozversion 14:51:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:51:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:46 INFO - Cleaning up... 14:51:46 INFO - Return code: 0 14:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:46 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:46 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 14:51:46 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 14:51:46 INFO - Using env: {'DISPLAY': ':0', 14:51:46 INFO - 'HOME': '/home/cltbld', 14:51:46 INFO - 'LANG': 'en_US.UTF-8', 14:51:46 INFO - 'LANGUAGE': 'en_US:en', 14:51:46 INFO - 'LOGNAME': 'cltbld', 14:51:46 INFO - 'MAIL': '/var/mail/cltbld', 14:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:46 INFO - 'MOZ_NO_REMOTE': '1', 14:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:46 INFO - 'NO_EM_RESTART': '1', 14:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:46 INFO - 'PWD': '/builds/slave/test', 14:51:46 INFO - 'SHELL': '/bin/bash', 14:51:46 INFO - 'SHLVL': '1', 14:51:46 INFO - 'TERM': 'linux', 14:51:46 INFO - 'TMOUT': '86400', 14:51:46 INFO - 'USER': 'cltbld', 14:51:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:46 INFO - '_': '/tools/buildbot/bin/python'} 14:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:46 INFO - Running setup.py (path:/tmp/pip-4kihid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:46 INFO - Running setup.py (path:/tmp/pip-iJIs35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:46 INFO - Running setup.py (path:/tmp/pip-M3faie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:46 INFO - Running setup.py (path:/tmp/pip-gHUaOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:46 INFO - Running setup.py (path:/tmp/pip-ZI8tYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:46 INFO - Running setup.py (path:/tmp/pip-Md4vA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:46 INFO - Running setup.py (path:/tmp/pip-74hlLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:46 INFO - Running setup.py (path:/tmp/pip-rMK0B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:46 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)) 14:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:46 INFO - Running setup.py (path:/tmp/pip-jY2mSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:47 INFO - Running setup.py (path:/tmp/pip-xGOIQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:47 INFO - Running setup.py (path:/tmp/pip-K6zVtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:47 INFO - Running setup.py (path:/tmp/pip-ReAIrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:47 INFO - Running setup.py (path:/tmp/pip-JLTAfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:47 INFO - Running setup.py (path:/tmp/pip-qeiIiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:47 INFO - Running setup.py (path:/tmp/pip-cbQoXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:47 INFO - Running setup.py (path:/tmp/pip-ntBMfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:47 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)) 14:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:47 INFO - Running setup.py (path:/tmp/pip-vqCd05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:47 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)) 14:51:47 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)) 14:51:47 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)) 14:51:47 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)) 14:51:47 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)) 14:51:47 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)) 14:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:47 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 14:51:47 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 14:51:47 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 14:51:47 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 14:51:47 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 14:51:47 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 14:51:49 INFO - Downloading blessings-1.6.tar.gz 14:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:49 INFO - Installing collected packages: blessings 14:51:49 INFO - Running setup.py install for blessings 14:51:49 INFO - Successfully installed blessings 14:51:49 INFO - Cleaning up... 14:51:49 INFO - Return code: 0 14:51:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:49 INFO - Reading from file tmpfile_stdout 14:51:49 INFO - Current package versions: 14:51:49 INFO - argparse == 1.2.1 14:51:49 INFO - blessings == 1.6 14:51:49 INFO - blobuploader == 1.2.4 14:51:49 INFO - docopt == 0.6.1 14:51:49 INFO - functools32 == 3.2.3-2 14:51:49 INFO - jsonschema == 2.5.1 14:51:49 INFO - manifestparser == 1.1 14:51:49 INFO - mozInstall == 1.12 14:51:49 INFO - mozcrash == 0.17 14:51:49 INFO - mozdebug == 0.1 14:51:49 INFO - mozdevice == 0.48 14:51:49 INFO - mozfile == 1.2 14:51:49 INFO - mozhttpd == 0.7 14:51:49 INFO - mozinfo == 0.9 14:51:49 INFO - mozleak == 0.1 14:51:49 INFO - mozlog == 3.3 14:51:49 INFO - moznetwork == 0.27 14:51:49 INFO - mozprocess == 0.23 14:51:49 INFO - mozprofile == 0.28 14:51:49 INFO - mozrunner == 6.12 14:51:49 INFO - mozscreenshot == 0.1 14:51:49 INFO - mozsystemmonitor == 0.3 14:51:49 INFO - moztest == 0.7 14:51:49 INFO - mozversion == 1.4 14:51:49 INFO - psutil == 3.1.1 14:51:49 INFO - requests == 1.2.3 14:51:49 INFO - wsgiref == 0.1.2 14:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:49 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:49 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 14:51:49 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 14:51:49 INFO - Using env: {'DISPLAY': ':0', 14:51:49 INFO - 'HOME': '/home/cltbld', 14:51:49 INFO - 'LANG': 'en_US.UTF-8', 14:51:49 INFO - 'LANGUAGE': 'en_US:en', 14:51:49 INFO - 'LOGNAME': 'cltbld', 14:51:49 INFO - 'MAIL': '/var/mail/cltbld', 14:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:49 INFO - 'MOZ_NO_REMOTE': '1', 14:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:49 INFO - 'NO_EM_RESTART': '1', 14:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:49 INFO - 'PWD': '/builds/slave/test', 14:51:49 INFO - 'SHELL': '/bin/bash', 14:51:49 INFO - 'SHLVL': '1', 14:51:49 INFO - 'TERM': 'linux', 14:51:49 INFO - 'TMOUT': '86400', 14:51:49 INFO - 'USER': 'cltbld', 14:51:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:49 INFO - '_': '/tools/buildbot/bin/python'} 14:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 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)) 14:51:50 INFO - Cleaning up... 14:51:50 INFO - Return code: 0 14:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51:50 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')]} 14:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:50 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')]} 14:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:50 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 0x7fb48f4e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2343ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', '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 14:51:50 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 14:51:50 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 14:51:50 INFO - Using env: {'DISPLAY': ':0', 14:51:50 INFO - 'HOME': '/home/cltbld', 14:51:50 INFO - 'LANG': 'en_US.UTF-8', 14:51:50 INFO - 'LANGUAGE': 'en_US:en', 14:51:50 INFO - 'LOGNAME': 'cltbld', 14:51:50 INFO - 'MAIL': '/var/mail/cltbld', 14:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:50 INFO - 'MOZ_NO_REMOTE': '1', 14:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:50 INFO - 'NO_EM_RESTART': '1', 14:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:50 INFO - 'PWD': '/builds/slave/test', 14:51:50 INFO - 'SHELL': '/bin/bash', 14:51:50 INFO - 'SHLVL': '1', 14:51:50 INFO - 'TERM': 'linux', 14:51:50 INFO - 'TMOUT': '86400', 14:51:50 INFO - 'USER': 'cltbld', 14:51:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:50 INFO - '_': '/tools/buildbot/bin/python'} 14:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:51:50 INFO - Cleaning up... 14:51:50 INFO - Return code: 0 14:51:50 INFO - Running post-action listener: _resource_record_post_action 14:51:50 INFO - Running post-action listener: _start_resource_monitoring 14:51:50 INFO - Starting resource monitoring. 14:51:50 INFO - [mozharness: 2016-09-16 21:51:50.425201Z] Finished create-virtualenv step (success) 14:51:50 INFO - [mozharness: 2016-09-16 21:51:50.425716Z] Running install step. 14:51:50 INFO - Running pre-action listener: _resource_record_pre_action 14:51:50 INFO - Running main action method: install 14:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:50 INFO - Reading from file tmpfile_stdout 14:51:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:50 INFO - Reading from file tmpfile_stdout 14:51:50 INFO - Output received: 14:51:50 INFO - Usage: mozinstall [options] installer 14:51:50 INFO - Options: 14:51:50 INFO - -h, --help show this help message and exit 14:51:50 INFO - -d DEST, --destination=DEST 14:51:50 INFO - Directory to install application into. [default: 14:51:50 INFO - "/builds/slave/test"] 14:51:50 INFO - --app=APP Application being installed. [default: firefox] 14:51:50 INFO - mkdir: /builds/slave/test/build/application 14:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:52:06 INFO - Reading from file tmpfile_stdout 14:52:06 INFO - Output received: 14:52:06 INFO - /builds/slave/test/build/application/firefox/firefox 14:52:06 INFO - Running post-action listener: _resource_record_post_action 14:52:06 INFO - [mozharness: 2016-09-16 21:52:06.765992Z] Finished install step (success) 14:52:06 INFO - [mozharness: 2016-09-16 21:52:06.766238Z] Running run-tests step. 14:52:06 INFO - Running pre-action listener: _resource_record_pre_action 14:52:06 INFO - Running main action method: run_tests 14:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:06 INFO - Python 2.7.3 14:52:06 INFO - Return code: 0 14:52:06 INFO - grabbing minidump binary from tooltool 14:52: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')]} 14:52:06 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 0x2340f60>, '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 0x2341d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23421d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:06 INFO - Return code: 0 14:52:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:06 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/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 14:52:06 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/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 14:52:06 INFO - Using env: {'DISPLAY': ':0', 14:52:06 INFO - 'HOME': '/home/cltbld', 14:52:06 INFO - 'LANG': 'en_US.UTF-8', 14:52:06 INFO - 'LANGUAGE': 'en_US:en', 14:52:06 INFO - 'LOGNAME': 'cltbld', 14:52:06 INFO - 'MAIL': '/var/mail/cltbld', 14:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:06 INFO - 'MOZ_NO_REMOTE': '1', 14:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:06 INFO - 'NO_EM_RESTART': '1', 14:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:06 INFO - 'PWD': '/builds/slave/test', 14:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:06 INFO - 'SHELL': '/bin/bash', 14:52:06 INFO - 'SHLVL': '1', 14:52:06 INFO - 'TERM': 'linux', 14:52:06 INFO - 'TMOUT': '86400', 14:52:06 INFO - 'USER': 'cltbld', 14:52:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972', 14:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:06 INFO - '_': '/tools/buildbot/bin/python'} 14:52:06 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/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 14:52:07 INFO - mozversion application_buildid: 20160916133317 14:52:07 INFO - mozversion application_changeset: 0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7 14:52:07 INFO - mozversion application_display_name: Nightly 14:52:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:07 INFO - mozversion application_name: Firefox 14:52:07 INFO - mozversion application_remotingname: firefox 14:52:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:52:07 INFO - mozversion application_vendor: Mozilla 14:52:07 INFO - mozversion application_version: 51.0a1 14:52:07 INFO - mozversion platform_buildid: 20160916133317 14:52:07 INFO - mozversion platform_changeset: 0e0c46418b14a6ac0cfb1f1e6efbc0feac8c2ab7 14:52:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:52:07 INFO - mozversion platform_version: 51.0a1 14:52:07 INFO - using testdate: 1474062727 14:52:07 INFO - actual date: 1474062727 14:52:07 INFO - starting webserver on 'localhost:58001' 14:52:07 INFO - SUITE-START | Running 2 tests 14:52:07 INFO - TEST-START | dromaeo_css 14:52:07 INFO - operating with platform_type : linux_ 14:52:07 INFO - Initialising browser for dromaeo_css test... 14:52:07 INFO - TEST-INFO | started process 21296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpch6G17/profile http://localhost:58001/getInfo.html) 14:52:11 INFO - PROCESS | 21296 | __metrics Screen width/height:1600/1200 14:52:11 INFO - PROCESS | 21296 | colorDepth:24 14:52:11 INFO - PROCESS | 21296 | Browser inner width/height: 1024/697 14:52:11 INFO - PROCESS | 21296 | __metrics 14:52:12 INFO - PROCESS | 21296 | 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" 14:52:12 INFO - PROCESS | 21296 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:52:12 INFO - PROCESS | 21296 | console.error: PushService: 14:52:12 INFO - PROCESS | 21296 | stateChangeProcessEnqueue: Error transitioning state 14:52:12 INFO - PROCESS | 21296 | UnknownError 14:52:13 INFO - TEST-INFO | 21296: exit 0 14:52:13 INFO - Browser initialized. 14:52:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:13 INFO - TEST-INFO | started process 21378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpch6G17/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:25 INFO - PROCESS | 21378 | RSS: Main: 175140864 14:52:25 INFO - PROCESS | 21378 | 14:52:43 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 14:52:45 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:53:03 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 14:53:14 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:53:17 INFO - PROCESS | 21378 | 1474062797675 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] 14:53:21 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 14:53:29 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:53:33 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0667 seconds. 14:53:38 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 14:53:45 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:53:47 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 14:53:53 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.55007 seconds. 14:54:04 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 14:54:06 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:54:08 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.1667 seconds. 14:54:22 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:54:24 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:54:26 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 14:54:33 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 14:54:38 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 14:54:40 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 14:54:46 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.16671 seconds. 14:54:51 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 14:55:21 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.1667 seconds. 14:55:24 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01665 seconds. 14:55:28 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 14:55:29 INFO - PROCESS | 21378 | Cycle 1(1): loaded http://localhost:58001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58001/tests/dromaeo/cssquery-ext.html) 14:55:31 INFO - PROCESS | 21378 | RSS: Main: 307363840 14:55:31 INFO - PROCESS | 21378 | 14:55:45 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:55:51 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:56:12 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:56:14 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 14:56:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:56:32 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 14:56:46 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 14:56:48 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 14:57:01 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 14:57:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 14:57:33 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:57:35 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 14:57:42 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 2.01668 seconds. 14:57:42 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 2.01668 seconds. 14:57:49 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:57:51 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 14:57:57 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 14:58:02 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 14:58:19 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:58:21 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:58:25 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:58:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 14:58:33 INFO - PROCESS | 21378 | Cycle 1(1): loaded http://localhost:58001/tests/dromaeo/cssquery-ext.html (next: http://localhost:58001/tests/dromaeo/cssquery-jquery.html) 14:58:34 INFO - PROCESS | 21378 | RSS: Main: 272556032 14:58:34 INFO - PROCESS | 21378 | 14:58:37 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 14:58:44 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:58:47 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:58:51 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:59:17 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 14:59:19 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:59:49 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 14:59:51 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:00:01 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:00:07 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:00:08 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 2.0167 seconds. 15:00:16 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:00:19 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:00:27 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 15:00:33 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:00:42 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:00:44 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:00:46 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:00:56 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:00:58 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:01:00 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:01:02 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:01:13 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:01:14 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:01:18 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:01:20 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:01:26 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:01:30 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:01:32 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:01:34 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:01:36 INFO - PROCESS | 21378 | Cycle 1(1): loaded http://localhost:58001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58001/tests/dromaeo/cssquery-mootools.html) 15:01:37 INFO - PROCESS | 21378 | RSS: Main: 253751296 15:01:37 INFO - PROCESS | 21378 | 15:01:40 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 15:01:45 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 15:01:52 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:01:54 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:02:00 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:02:06 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:02:22 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:02:24 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00392 seconds. 15:02:26 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:02:28 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:02:32 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:02:36 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:02:42 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:02:52 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:02:54 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:02:56 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 15:02:58 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:03:04 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:03:08 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:03:10 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:03:12 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:03:37 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:03:41 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:03:45 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:03:47 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 15:03:49 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:03:59 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00012 seconds. 15:04:01 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:04:03 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:04:05 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:04:07 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:04:11 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:04:21 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:04:27 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:04:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:04:33 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 15:04:39 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:04:39 INFO - PROCESS | 21378 | Cycle 1(1): loaded http://localhost:58001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58001/tests/dromaeo/cssquery-prototype.html) 15:04:40 INFO - PROCESS | 21378 | RSS: Main: 218497024 15:04:40 INFO - PROCESS | 21378 | 15:04:59 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:05:02 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:05:05 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:05:17 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 15:05:19 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:05:33 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 15:05:35 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:06:10 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:06:16 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 15:06:20 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 15:06:22 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 15:06:24 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:06:29 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:06:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 2.00003 seconds. 15:06:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 2.00003 seconds. 15:06:32 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 15:06:38 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 15:06:40 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:06:42 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:06:48 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:06:51 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:06:54 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:07:00 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:07:06 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 15:07:08 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:07:14 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:07:26 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:07:29 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:07:43 INFO - PROCESS | 21378 | Cycle 1(1): loaded http://localhost:58001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58001/tests/dromaeo/cssquery-yui.html) 15:07:44 INFO - PROCESS | 21378 | RSS: Main: 219914240 15:07:44 INFO - PROCESS | 21378 | 15:07:49 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 15:07:52 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:08:09 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 15:08:27 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:08:53 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:08:59 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 15:09:01 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:09:05 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:09:09 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 15:09:19 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01686 seconds. 15:09:31 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:09:50 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:09:54 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 15:10:08 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 15:10:10 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 15:10:24 INFO - PROCESS | 21378 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 15:10:47 INFO - PROCESS | 21378 | Cycle 1(1): loaded http://localhost:58001/tests/dromaeo/cssquery-yui.html (next: http://localhost:58001/tests/dromaeo/cssquery-dojo.html) 15:10:47 INFO - PROCESS | 21378 | RSS: Main: 310788096 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | __start_tp_report 15:10:47 INFO - PROCESS | 21378 | _x_x_mozilla_page_load 15:10:47 INFO - PROCESS | 21378 | _x_x_mozilla_page_load_details 15:10:47 INFO - PROCESS | 21378 | |i|pagename|runs| 15:10:47 INFO - PROCESS | 21378 | |0;dojo.html;2586.8059895507836;2609.3737502999284;2633.170551276348;2639.7096319404864;2647.3249321423023;4622.491525932145;4708.340832283483;4709.670323077386;4732.266498692704;4738.194506933821;4651.511591282917;4653.767311634421;4676.859694209171;4708.36437080994;4725.385699859022;4264.87205383839;4304.074623955848;4312.029793296499;4323.82704691812;4399.5160532341415;4362.541933097027;4413.933790993137;4439.445069366329;4451.532589078149;4498.460184777831;4271.359296105609;4293.806778694966;4394.472663280427;4437.245668236392;4460.710053846522;4329.090890912912;4349.543297953733;4361.149575832714;4388.5830846069575;4463.531329210451;4355.847545335898;4360.520342762294;4362.214801335758;4367.170237654867;4408.911821763579;4731.313959475891;4750.12122757291;4763.761811909425;4767.713937163781;4799.617703132536;4930.580900623451;4933.53131452515;4980.352554167971;4986.925196122061;4998.90002199954;5014.674046187022;5037.9244311335;5043.142665746832;5049.419316778581;5080.1617733074;4689.413823272091;4691.835785747482;4707.7881495332795;4734.455537613149;4766.904661906742;5046.571041461443;5103.821366252163;5118.769655365518;5163.148080566664;5171.63798534099;5030.541143068469;5032.521910418504;5036.899262014739;5049.242613607915;5084.135696931457;5107.770150343244;5112.130937740519;5130.307408499804;5133.5379815816;5185.533302002762;4921.630877684116;4929.654924155347;4959.0329885671945;5056.57019153376;5065.848024559269;4936.975315123402;4942.332785074041;4959.330490383824;5023.849284521397;5026.472220416877;4232.343986682007;4241.257779888507;4254.404383386328;4294.806733696991;4303.741775493418;3683.4843121962945;3696.1868388954927;3698.0385099874225;3737.439384092408;3805.8667946621736;4327.2643650579475;4337.371081193272;4337.587929146726;4345.413369195118;4350.129974005212;5096.388433387943;5103.336566246438;5110.616703747234;5114.079465696211;5141.614378921596;4389.539098394686;4395.758233297135;4404.097160082176;4437.64498840092;4449.154660614473;4474.507804141542;4491.820327186876;4505.707129036602;4529.411176547028;4557.111363284128;4775.06886157196;4781.641376896677;4789.137955167964;4791.856244312677;4827.42070951488;5115;5129.7691603877165;5135.3324067870935;5139.254808052737;5164.664296820694;4717.575418212377;4756.239001759702;4767.141914455431;4816.470188279216;4883.8290659826735;5006.69959802413;5046.772895219798;5052.671576347526;5101.617378696538;5104.106781313181;5101.897962040813;5103.157978933435;5110.616703747308;5112.590992720499;5144.331236939174;4738.289256611398;4738.33663287147;4955.331030310862;4959.876003099951;4967.801287948441;4886.53577910098;4892.535209155125;4940.777665005012;4946.35697359341;4947.084789313988;4808.014357056865;4820.325154478446;4830.7101573905675;4844.297576851407;4884.682495637772;4838.298446725275;4919.9754001231195;4929.457759646508;4939.678920870132;5002.974985125051;4772.236442169236;4817.542333478314;4831.613470922388;4836.927446088241;4841.927371089507 15:10:47 INFO - PROCESS | 21378 | |1;ext.html;548.747576114987;552.53586986931;560.587967843635;572.773754367025;574.3624576719842;27937.720622793768;39133;39806.80096599513;40308.79845600775;43037.569624303746;40038.59961400392;40419.797901010454;40461.393079103764;40481.79759101208;40522.79738601303;7106.467014973872;7526.172121066678;7665.348445382149;7674.53952762836;7680.961595192016;7065.540739851893;7287.453440991921;7290.671919763623;7291;9763.267754918374;9855.753606159868;10200.74498137545;10207.693769186937;10215;10215.38707677538;10042.648507302245;10127.696169114939;10127.949360253151;10143.543540540693;10148.746281342952;9855.852162217572;9923.503824808731;9928.50357482123;9938.90061099387;9940.850887236697;37643;37889.62110378916;37933.241335173145;37951.81024094862;37969.62030379689;2695.811293209476;2802.285417218596;2823.9294017649518;2834.5464725643797;2989.7309242168094;27931.720682793115;28118.578221326698;28248.85875570609;28815.56776648352;29341.85329073341;3144.905652830396;3222.8388580570877;3230.596175478065;3241.8216998065095;3290.851911663981;248708;249992;250199;250622;251141;30754.53868191979;31956.360872782414;51532.484675152766;51893.7405312971;51894.48105518972;33092.83453582717;33159;33273.66726332754;33395.83302083523;33458.66541334604;11373.601923932789;11475.942620287013;11483.827742583868;11486.597969071043;11495.425228738697;8671.21959023691;8686.609102590399;8763.824723505495;8780.034196238408;8785.077566855516;7170.928290717026;7343.669534870944;7588.962055189689;7811.375089992787;7822;3048.527478240876;3058.495348267511;3064.8314342711365;3086.2592977685645;3095.334503081848;793.1473665809278;814.9918500815035;895.7805337692307;895.9204158988404;914.085914085914;24694.50610987806;25932.87033564858;26266.212013639622;26525.734742652712;27339.45321093567;908.6047569307373;908.8591268353416;923.8244733500613;937.6577549194632;993.7018894331671;13873.86126138746;14722.63193420173;14783.556493305217;15032.473863414729;15112.697746045018;376669;381939.528466015;382187;383278;383366;42302.36546451806;43445.56554434415;47907.3232436863;48411.51588484141;48640.27039594409;990.7473594233425;1016.3596933931576;1087.4182312462954;1088.0860077534908;1092.6667366453307;26873.596896046183;28689.569656455587;29462;29951.400971980875;29952.25119372033;41780.16439671129;42216.78891605645;42272.5772742281;42291.57708423;42363.1527369457;316662;318373;318631;319996;320331;24318.392040199138;25020.374490637878;25471.745282546937;25495.490090198462;25633.231003069937;40971;41556.58443415527;41589.79205103955;41734.1653166941;42062.1587568253;34041;35340.29319413649;35397.29205415826;35558;35593.64406355903;34784.65215347814;34961.475577865844;35059.64940350564;35097.47353789644;35126.473102902964;34616.65383346134;34953.825230873685;34982.65017349794;35371.46942795809;35839;30474.390512190075;32661.17806148825;32759.34481310313;32848.83575582107;33344.833275833465;24732.876335618206;24835.25494235176;24954.750452495242;25002.499950000536;25079.373015674755 15:10:47 INFO - PROCESS | 21378 | |2;jquery.html;337.6404129601975;359.43748034326296;363.2444515407951;369.3683800700802;386.55353067207386;10953.507092180851;11843.230190037651;15870.444534441296;16624.83375166248;17730.202140903657;16885.915570422163;17217;17397.47807565772;17596.64806703865;17608.11959402031;4866.853994380174;5061.974690126563;5064.012517559077;5110.948890511085;5405.108157154064;3363.7477189210786;5411.756470958797;5435.402105768362;5441.619086663935;5442.755076021569;3550.982245088771;5791.247137872071;6026.789062382817;6083.330833608322;6173.660448675321;5946.375630558772;6048.123022161806;6085.676782944198;6147.969260153693;6159.168512250856;5390.19147127934;5402.297701298845;5403.78384864605;5406.324209473816;5409.26974858393;11478.253913495597;11734.178607497479;11851.348175850324;11895.583654572049;18851;1707.2829411647137;1765.5321339844822;1924.4611508777564;1993.6511110555596;2133.9466513337134;8363.83272334556;8734.51960142192;8971.775705607346;9151.313651476099;9196.954015229881;1689.4678176374402;1703.7018521758644;1705.6247625522365;1708.4959936818543;1719.2091637846481;68204.6589767053;69585.65207173982;69967.3003269971;70049;71152.644236779;9857;9897.554610042565;9966.152877005536;10158.561945133115;10166.745831354126;13777;13786.65533361674;13798.724025519634;13800.723985520433;13802.723945521033;6557.213134423804;6628.701708423133;6820.761273355409;6831.4534837212905;6936.34104760047;6056.091586262096;6070.908936365958;6259.874802503924;6280.560360774702;6282.528810339243;4058.8782336529953;4244.830206791756;4275.8882690500695;4371.519132895379;4428.512863585003;1741.2860727101827;1762.9823701763075;1787.374418953382;1789.4452719656947;1818.4635532517939;785.2147852147853;805.5690205739901;821.3839620284787;824.2334628795278;856.3149480415767;16583.253753581117;16736.665266694843;16750.66498670044;17078.914605426893;17760.200790964438;823.0945959444683;840.6007146605314;851.4635779459026;851.6252848746656;874.7622114707744;9365.953170234105;9411.341206115507;9812.313138080408;9847.641210281052;9864;384979;386259;392897;395029;398303;79475;81386.71563148637;81914;82627;84813.57593211994;869.5043825019804;878.5036454403241;929.4655573045391;936.7330310861372;941.2187884056353;15103.4713785017;15538.844611554192;16658.167091645126;16660.83339166593;16885.24016419289;38850.80574597109;39012.414813778385;39752.60078672569;40324.59675403326;40435.7978210107;53694.46305536895;54780.72609636926;54829.72585137208;55081;55500;7519.586422746802;7526.285002924714;7544.358729508053;7570.280823321776;7631.8855217172895;8941.821163576822;11068.501917413896;11164.665060048212;11891.46488408041;12396.690082747642;9386.67146649864;10117.29178957466;10144.340617859816;10651.94674026656;10886.455677216265;9628.133467987915;9881.901180988098;9889.357191782512;10918.836217456586;10935.726606834893;10142.442165680959;10491.94754026225;10636.574537018741;10679.359238445719;11263.943680281545;7392.741254056083;7514.849703006019;7581.12817026027;7587.810304742426;7661.616919154131;9608.855867162138;10203.438810865176;10278.691639250834;10319.845202322122;10661.09380702618 15:10:47 INFO - PROCESS | 21378 | |3;mootools.html;1190.6309044196305;1292.8254685617442;1335.0721248732132;1345.9461621535138;1667.5914400971765;6583.3416658334145;7121.679524421401;7353.301436363544;7442.40460763139;7695.038120234971;7518.924810751891;7574.280443357872;7594.886076708854;7609.809754756134;7614.73348432805;2047.877127372355;2103.6949642301856;2103.7791031941656;2107.557412943276;2116.3016204652504;2043.1520918818671;2074.388055523624;2079.386580958613;2088.6971389148566;2089.8641588296787;2068.8965551722354;2070;2089.2896415218825;2089.4149638101358;2091.5712278982774;2034.7558293004934;2035.460602940222;2036.5825005873835;2044.8261897738562;2046.907889144992;2012.6276638821864;2025.7265269188617;2036.5112373030515;2039.9286024989053;2043.4891277180704;7330.560166390033;7380.298871607189;7392.815179620498;7617.314441700273;7808.687652493893;4005.0988527581353;4175.436316097349;4185.267578173807;4186.037211441386;4189.706720529564;2657.827241229314;2781.680106787725;2817.1830169251098;2832.5892745551987;2843.530817415124;914.3873604684877;918.6049998500642;930.2790337488433;931.1759093202497;935.6818681648205;10212.642557510451;10293.279470437072;10304.79390412195;10335.94832025835;10342.948285258526;3588.085038315213;3777.3011992780876;3843.442700808367;3851.730378873508;3852.711046671455;7939.483933544301;7985.241402066795;7991.24083212094;7992.920070799334;7995.440319177718;4198.425590403599;4199.118185181085;4200.306949353384;4201.516825565038;4205.789710514462;3330.234046169395;3442.9827850860584;3720.3675375186285;3860.4595356650093;3884.028992751812;3319.103841962705;3346.548215990859;3434.347473979986;3447.3277710846646;3465.220325426759;1002.904724051214;1010.7473131717071;1012.2003617142523;1013.5692330759398;1031;703.7642389799372;710.9537880037781;730.7698075106324;734.7024455095694;754.1176823116966;4786.521347865255;4893.916832395639;5013.473585273567;5098.59211263098;5177.119889618699;392.11969129304896;400.1976038043704;404.5772168084359;420.63404837790705;421.0799403303791;3526.8765593204116;3537.3809583322814;3545.4859045438266;3560.7067644467074;3568.982155089208;9150.496722680184;9551.856722149174;9553.61785528585;9599.568019439143;9617.855732164024;8731.388802783871;9471.952640236756;9486.95256523713;9521.952390238004;9532.999035101353;6793.388595026471;6930.757423490154;6940.861182776417;6947.096877405905;6954.930450695429;5261.894762104813;5479.342478902558;5498.120300751861;5548.805791797267;5602.747876345493;8444.113368096261;8602.139786021347;8677.783055423664;8694.04365519805;8720;8569.528675922635;8893.110688931314;8913.197812196673;8927.642894284156;8999.415038022507;5652.915206271827;5825.184474173534;6744;6907.412869906114;6916.204636466669;7033.156021277275;7330.376917961819;7362.6318684066655;7558.811029724081;7570.091589009354;6424.336476861306;6556.409923106943;6581.992492289897;6691.498137639599;6711.597304161766;6194;6256.374362563707;6318.589291696025;6372.36276372359;6412.935870641234;5861.208736820645;5995.820125396245;5999.340072592098;6000.0999850022845;6002.339742628395;4427.446569178853;4440.378347031354;4498.415206023196;4533.387992621086;4630.976845115752;4496.460424749051;4504.842330518416;4535.863924082283;4549.977250113729;4618.307253911806 15:10:47 INFO - PROCESS | 21378 | |4;prototype.html;276.922461710721;276.95014897318487;286.1815208503679;286.1900820677483;287.55859755275657;4609.585137337639;4752.07334569759;4783.952160478394;4819.734914579697;4834.154023045966;4575.519570445097;4708.458527269357;4755.476897541276;4760.2383618621025;4799.856004319868;3572.821358932056;3684.244729830392;3771.6422088048416;3790.5261842269715;3802.9429558556576;3676.1544844685736;3765.4351847222997;3769;3774.5093137892172;3803.7527560708604;3747.250549890019;3748.6063963283873;3752.662260396564;3754.4180651998986;3755.1550901047317;3753.8498460061564;3762.529683789526;3771.1326394929183;3776;3781.5840257571645;3096.938061238785;3220.920991467861;3224.3873664004;3243.7835811570662;3364.596248450177;4650.511696271877;4651.302304654295;4652.930206046912;4658.324542941288;4689.2966055091665;4056.492938382702;4195.307774217251;4199.286121359346;4204.62158405745;4214.588112982155;4999.850004499871;5003.799848006075;5018.849434516934;5019.698818070928;5023.48356150696;3530.3645343838098;3531.417316142859;3536.328097661436;3539.424955894628;3540.9114772130647;5046.4953504649975;5228.2680424740565;5259.421463638997;5263.789448422059;5267.051930652481;3604.747667663238;3650.634936506328;3652.342578335925;3653.780773153619;3660.5790334111384;3694.538182727159;3698.3158115748674;3704.629537046274;3710.2950439416422;3719.3491139050557;4221.56466801289;4225.598568136023;4226.4716910386205;4227.387028880795;4231.2383770920915;4880.316755654211;5021.49785021495;5023.171176755867;5025.84922452327;5046.62150338726;1243.9004879609608;1249.7875361188437;1256.3278645924386;1264.4436447962867;1267.7020900088655;752.1838804896748;784.2784638132931;789.3566743104352;792.1365711374514;803.6102490292203;4004.6996475264473;4015.658669013108;4015.9397609035886;4020.19596080785;4047.494063242095;4567.721038109335;4578.2903649934315;4582.221022426195;4585.564371384779;4587.311903214478;4027.7180597357906;4029;4032.798360082043;4034.3141665916864;4041.3937909313836;2304.688867002933;2439.9634005489934;2445;2447.592634235322;2456.7666071723156;4362.607365337135;4366.868993930188;4370.7106403611015;4383.430154079949;4400.977995110004;4669.34629151919;4686.81252749893;4692.906141877143;4703.6246695418595;4717.787699553528;4376.693631445768;4410.25025745624;4488.349189367524;4872.098661747588;4880.365552478155;5140.228965655182;5141.588672906233;5156.2523434102595;5159.767810448464;5165.225216217597;5070.518300761421;5101.51535604117;5111.284420181252;5142.100132476727;5144.6655967362;4726.409198850144;4865.099956508057;4898.8775280618265;4901.485344038824;4910.459849416633;3319.6182439018858;3408.5909690836265;3447.379471695119;3557.092941299952;3576.7853928764357;5143.271128431857;5165.793368265227;5194.558462530727;5197.948020519746;5203.16749320107;4956.397891107197;5008.222081161281;5009.423916249532;5035.420926593489;5036;4784.497627749036;4988.553319537294;4989.451160372283;5031.698098114125;5033.421156566895;4901.730404827626;4942.505749425029;4945.876353091202;4982.7259500727805;4985.75071246429;5065.164247899055;5092.923606145985;5100.872478188075;5103.489651034867;5115.667481613683;4821.252705830602;4888.413390393175;4907.411110666742;4919.286703427912;4978.755311172207 15:10:47 INFO - PROCESS | 21378 | |5;yui.html;603.4237303375276;615.1265203411156;635.841039740065;670.8792417364872;682.6347903871426;12974.416151273192;14371.64070898228;14451.638709032279;14459.13245205287;14497.202653854034;13956.162630242192;13993.930030349835;14757.40970361187;14761.630959225999;14781.852181478182;736.1240124252149;759.3242014607005;761.6115780951727;763.7365109037373;763.9770806875803;570.8344580071774;598.5510866849862;716.8888822232562;756.2588663110155;758.6586036283694;792.6670798264714;794.8370584030289;795.4511387142882;796.0288448093316;796.6415113199055;790.154534647927;790.4190420041265;790.4664351562673;791.7545560876118;791.8178818871634;444.8887778055486;461.367925941459;549.6592112889994;577.8555361159711;580.6225953130499;12164.635060948185;12325.075619328587;12357.196782209128;12363.690907727289;12367.134300598962;12293.446794894251;12968.481260749559;12989;13189.406476708571;13278.867211327859;11883.287002779862;12021.338826364547;12092.818607720892;12230.14388992771;12561.371931403393;4180.498340199196;4193.287141186006;4242.406063151161;4313.61177494027;4447.8443254486265;67504;69085.65457172733;69158.65420672914;69261.65369173173;69271;10419.374837509773;10581.365118092785;10706.94646526778;11217.439128043565;11371.20401571882;19957.700634490495;19989;19989.200431982557;20001.799982000284;20169;6687.431568316651;6708.798736037927;6794.558353706993;6901.551399159039;6946.409555187764;3422.19578399076;3525.453554699026;3582.6238244984424;3726.925461490755;3736.1220113273357;2602.2193341997327;2682.3830518980744;2692.8115031947577;2697.3661189620425;2708.7832973362083;459.60014787134736;465.62284549515;466.5754163711007;474.6701042775238;476.9332293478916;510.7548376779093;517.8653550077007;530.7134147560351;532.6963630730523;546.1485563938253;7531.849363012819;7545.283198096282;7878.881816772753;8133.552654604054;8150.551719655357;461.5361561630607;515.5025400488547;526.2973929803754;536.35637235317;545.738045738048;3563.8565876970997;3748.456473811282;3789.5642001169667;3828.674562662205;4013.2776100301644;93338;93480.53259733658;94646.52676736572;95787.52106239564;98706;80406.59796700979;81306.59346703229;83685;83863;84829.57585212034;44415.55584444114;61886.38113618896;66604.6679066416;71499.2850071503;71766;8246.463979841292;8251.216134467217;8517.616707248064;8680.305575554066;8793.076726943835;31134.22164445907;39358.21283574255;42044.159116818104;42719.786401067795;43835.561644383146;39588;40177.598224018555;41025.589744103374;61713;62863.68568157313;10747.247692661438;10861.09028064032;10920.180986426209;10971.286866353661;11256.943715281372;11688.18182727201;11875.52497900109;12223.461239769751;12527.93736031314;12573;12123;12228.571999979958;12381.75236495247;13251.13867598603;13410.597682069554;11720.296782193096;12688.23870567769;12689.555865544662;12704.428300726675;12728.554500592434;12191.329476878856;12328.876711233132;12340.691482712646;12749;12994.80507792365;10015.59937602517;10418.947905260728;10650.680479585624;10921.290116142425;11028.503717332578;9939.900600994186;10358.533865975898;10722.303050301705;10767.515461804394;10872.510737017012 15:10:47 INFO - PROCESS | 21378 | __end_tp_report 15:10:47 INFO - PROCESS | 21378 | __start_cc_report 15:10:47 INFO - PROCESS | 21378 | _x_x_mozilla_cycle_collect,1202 15:10:47 INFO - PROCESS | 21378 | __end_cc_report 15:10:47 INFO - PROCESS | 21378 | __startTimestamp1474063847521__endTimestamp 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | ------- Summary: start ------- 15:10:47 INFO - PROCESS | 21378 | Number of tests: 6 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | [#0] dojo.html Cycles:165 Average:4675.25 Median:4789.14 stddev:492.38 (10.3%) stddev-sans-first:465.83 15:10:47 INFO - PROCESS | 21378 | Values: 2586.8 2609.4 2633.2 2639.7 2647.3 4622.5 4708.3 4709.7 4732.3 4738.2 4651.5 4653.8 4676.9 4708.4 4725.4 4264.9 4304.1 4312.0 4323.8 4399.5 4362.5 4413.9 4439.4 4451.5 4498.5 4271.4 4293.8 4394.5 4437.2 4460.7 4329.1 4349.5 4361.1 4388.6 4463.5 4355.8 4360.5 4362.2 4367.2 4408.9 4731.3 4750.1 4763.8 4767.7 4799.6 4930.6 4933.5 4980.4 4986.9 4998.9 5014.7 5037.9 5043.1 5049.4 5080.2 4689.4 4691.8 4707.8 4734.5 4766.9 5046.6 5103.8 5118.8 5163.1 5171.6 5030.5 5032.5 5036.9 5049.2 5084.1 5107.8 5112.1 5130.3 5133.5 5185.5 4921.6 4929.7 4959.0 5056.6 5065.8 4937.0 4942.3 4959.3 5023.8 5026.5 4232.3 4241.3 4254.4 4294.8 4303.7 3683.5 3696.2 3698.0 3737.4 3805.9 4327.3 4337.4 4337.6 4345.4 4350.1 5096.4 5103.3 5110.6 5114.1 5141.6 4389.5 4395.8 4404.1 4437.6 4449.2 4474.5 4491.8 4505.7 4529.4 4557.1 4775.1 4781.6 4789.1 4791.9 4827.4 5115.0 5129.8 5135.3 5139.3 5164.7 4717.6 4756.2 4767.1 4816.5 4883.8 5006.7 5046.8 5052.7 5101.6 5104.1 5101.9 5103.2 5110.6 5112.6 5144.3 4738.3 4738.3 4955.3 4959.9 4967.8 4886.5 4892.5 4940.8 4946.4 4947.1 4808.0 4820.3 4830.7 4844.3 4884.7 4838.3 4920.0 4929.5 4939.7 5003.0 4772.2 4817.5 4831.6 4836.9 4841.9 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | [#1] ext.html Cycles:180 Average:45707.10 Median:34972.06 stddev:84744.90 (242.3%) stddev-sans-first:84914.81 15:10:47 INFO - PROCESS | 21378 | Values: 548.7 552.5 560.6 572.8 574.4 27937.7 39133.0 39806.8 40308.8 43037.6 40038.6 40419.8 40461.4 40481.8 40522.8 7106.5 7526.2 7665.3 7674.5 7681.0 7065.5 7287.5 7290.7 7291.0 9763.3 9855.8 10200.7 10207.7 10215.0 10215.4 10042.6 10127.7 10127.9 10143.5 10148.7 9855.9 9923.5 9928.5 9938.9 9940.9 37643.0 37889.6 37933.2 37951.8 37969.6 2695.8 2802.3 2823.9 2834.5 2989.7 27931.7 28118.6 28248.9 28815.6 29341.9 3144.9 3222.8 3230.6 3241.8 3290.9 248708.0 249992.0 250199.0 250622.0 251141.0 30754.5 31956.4 51532.5 51893.7 51894.5 33092.8 33159.0 33273.7 33395.8 33458.7 11373.6 11475.9 11483.8 11486.6 11495.4 8671.2 8686.6 8763.8 8780.0 8785.1 7170.9 7343.7 7589.0 7811.4 7822.0 3048.5 3058.5 3064.8 3086.3 3095.3 793.1 815.0 895.8 895.9 914.1 24694.5 25932.9 26266.2 26525.7 27339.5 908.6 908.9 923.8 937.7 993.7 13873.9 14722.6 14783.6 15032.5 15112.7 376669.0 381939.5 382187.0 383278.0 383366.0 42302.4 43445.6 47907.3 48411.5 48640.3 990.7 1016.4 1087.4 1088.1 1092.7 26873.6 28689.6 29462.0 29951.4 29952.3 41780.2 42216.8 42272.6 42291.6 42363.2 316662.0 318373.0 318631.0 319996.0 320331.0 24318.4 25020.4 25471.7 25495.5 25633.2 40971.0 41556.6 41589.8 41734.2 42062.2 34041.0 35340.3 35397.3 35558.0 35593.6 34784.7 34961.5 35059.6 35097.5 35126.5 34616.7 34953.8 34982.7 35371.5 35839.0 30474.4 32661.2 32759.3 32848.8 33344.8 24732.9 24835.3 24954.8 25002.5 25079.4 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | [#2] jquery.html Cycles:180 Average:24405.78 Median:5087.48 stddev:64875.97 (1275.2%) stddev-sans-first:65032.80 15:10:47 INFO - PROCESS | 21378 | Values: 337.6 359.4 363.2 369.4 386.6 10953.5 11843.2 15870.4 16624.8 17730.2 16885.9 17217.0 17397.5 17596.6 17608.1 4866.9 5062.0 5064.0 5110.9 5405.1 3363.7 5411.8 5435.4 5441.6 5442.8 3551.0 5791.2 6026.8 6083.3 6173.7 5946.4 6048.1 6085.7 6148.0 6159.2 5390.2 5402.3 5403.8 5406.3 5409.3 11478.3 11734.2 11851.3 11895.6 18851.0 1707.3 1765.5 1924.5 1993.7 2133.9 8363.8 8734.5 8971.8 9151.3 9197.0 1689.5 1703.7 1705.6 1708.5 1719.2 68204.7 69585.7 69967.3 70049.0 71152.6 9857.0 9897.6 9966.2 10158.6 10166.7 13777.0 13786.7 13798.7 13800.7 13802.7 6557.2 6628.7 6820.8 6831.5 6936.3 6056.1 6070.9 6259.9 6280.6 6282.5 4058.9 4244.8 4275.9 4371.5 4428.5 1741.3 1763.0 1787.4 1789.4 1818.5 785.2 805.6 821.4 824.2 856.3 16583.3 16736.7 16750.7 17078.9 17760.2 823.1 840.6 851.5 851.6 874.8 9366.0 9411.3 9812.3 9847.6 9864.0 384979.0 386259.0 392897.0 395029.0 398303.0 79475.0 81386.7 81914.0 82627.0 84813.6 869.5 878.5 929.5 936.7 941.2 15103.5 15538.8 16658.2 16660.8 16885.2 38850.8 39012.4 39752.6 40324.6 40435.8 53694.5 54780.7 54829.7 55081.0 55500.0 7519.6 7526.3 7544.4 7570.3 7631.9 8941.8 11068.5 11164.7 11891.5 12396.7 9386.7 10117.3 10144.3 10651.9 10886.5 9628.1 9881.9 9889.4 10918.8 10935.7 10142.4 10491.9 10636.6 10679.4 11263.9 7392.7 7514.8 7581.1 7587.8 7661.6 9608.9 10203.4 10278.7 10319.8 10661.1 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | [#3] mootools.html Cycles:180 Average:4897.47 Median:4840.22 stddev:2806.95 (58.0%) stddev-sans-first:2801.00 15:10:47 INFO - PROCESS | 21378 | Values: 1190.6 1292.8 1335.1 1345.9 1667.6 6583.3 7121.7 7353.3 7442.4 7695.0 7518.9 7574.3 7594.9 7609.8 7614.7 2047.9 2103.7 2103.8 2107.6 2116.3 2043.2 2074.4 2079.4 2088.7 2089.9 2068.9 2070.0 2089.3 2089.4 2091.6 2034.8 2035.5 2036.6 2044.8 2046.9 2012.6 2025.7 2036.5 2039.9 2043.5 7330.6 7380.3 7392.8 7617.3 7808.7 4005.1 4175.4 4185.3 4186.0 4189.7 2657.8 2781.7 2817.2 2832.6 2843.5 914.4 918.6 930.3 931.2 935.7 10212.6 10293.3 10304.8 10335.9 10342.9 3588.1 3777.3 3843.4 3851.7 3852.7 7939.5 7985.2 7991.2 7992.9 7995.4 4198.4 4199.1 4200.3 4201.5 4205.8 3330.2 3443.0 3720.4 3860.5 3884.0 3319.1 3346.5 3434.3 3447.3 3465.2 1002.9 1010.7 1012.2 1013.6 1031.0 703.8 711.0 730.8 734.7 754.1 4786.5 4893.9 5013.5 5098.6 5177.1 392.1 400.2 404.6 420.6 421.1 3526.9 3537.4 3545.5 3560.7 3569.0 9150.5 9551.9 9553.6 9599.6 9617.9 8731.4 9472.0 9487.0 9522.0 9533.0 6793.4 6930.8 6940.9 6947.1 6954.9 5261.9 5479.3 5498.1 5548.8 5602.7 8444.1 8602.1 8677.8 8694.0 8720.0 8569.5 8893.1 8913.2 8927.6 8999.4 5652.9 5825.2 6744.0 6907.4 6916.2 7033.2 7330.4 7362.6 7558.8 7570.1 6424.3 6556.4 6582.0 6691.5 6711.6 6194.0 6256.4 6318.6 6372.4 6412.9 5861.2 5995.8 5999.3 6000.1 6002.3 4427.4 4440.4 4498.4 4533.4 4631.0 4496.5 4504.8 4535.9 4550.0 4618.3 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | [#4] prototype.html Cycles:180 Average:4073.13 Median:4580.26 stddev:1201.69 (26.2%) stddev-sans-first:1170.79 15:10:47 INFO - PROCESS | 21378 | Values: 276.9 277.0 286.2 286.2 287.6 4609.6 4752.1 4784.0 4819.7 4834.2 4575.5 4708.5 4755.5 4760.2 4799.9 3572.8 3684.2 3771.6 3790.5 3802.9 3676.2 3765.4 3769.0 3774.5 3803.8 3747.3 3748.6 3752.7 3754.4 3755.2 3753.8 3762.5 3771.1 3776.0 3781.6 3096.9 3220.9 3224.4 3243.8 3364.6 4650.5 4651.3 4652.9 4658.3 4689.3 4056.5 4195.3 4199.3 4204.6 4214.6 4999.9 5003.8 5018.8 5019.7 5023.5 3530.4 3531.4 3536.3 3539.4 3540.9 5046.5 5228.3 5259.4 5263.8 5267.1 3604.7 3650.6 3652.3 3653.8 3660.6 3694.5 3698.3 3704.6 3710.3 3719.3 4221.6 4225.6 4226.5 4227.4 4231.2 4880.3 5021.5 5023.2 5025.8 5046.6 1243.9 1249.8 1256.3 1264.4 1267.7 752.2 784.3 789.4 792.1 803.6 4004.7 4015.7 4015.9 4020.2 4047.5 4567.7 4578.3 4582.2 4585.6 4587.3 4027.7 4029.0 4032.8 4034.3 4041.4 2304.7 2440.0 2445.0 2447.6 2456.8 4362.6 4366.9 4370.7 4383.4 4401.0 4669.3 4686.8 4692.9 4703.6 4717.8 4376.7 4410.3 4488.3 4872.1 4880.4 5140.2 5141.6 5156.3 5159.8 5165.2 5070.5 5101.5 5111.3 5142.1 5144.7 4726.4 4865.1 4898.9 4901.5 4910.5 3319.6 3408.6 3447.4 3557.1 3576.8 5143.3 5165.8 5194.6 5197.9 5203.2 4956.4 5008.2 5009.4 5035.4 5036.0 4784.5 4988.6 4989.5 5031.7 5033.4 4901.7 4942.5 4945.9 4982.7 4985.8 5065.2 5092.9 5100.9 5103.5 5115.7 4821.3 4888.4 4907.4 4919.3 4978.8 15:10:47 INFO - PROCESS | 21378 | 15:10:47 INFO - PROCESS | 21378 | [#5] yui.html Cycles:180 Average:17251.66 Median:23118.72 stddev:24095.44 (104.2%) stddev-sans-first:24130.61 15:10:47 INFO - PROCESS | 21378 | Values: 603.4 615.1 635.8 670.9 682.6 12974.4 14371.6 14451.6 14459.1 14497.2 13956.2 13993.9 14757.4 14761.6 14781.9 736.1 759.3 761.6 763.7 764.0 570.8 598.6 716.9 756.3 758.7 792.7 794.8 795.5 796.0 796.6 790.2 790.4 790.5 791.8 791.8 444.9 461.4 549.7 577.9 580.6 12164.6 12325.1 12357.2 12363.7 12367.1 12293.4 12968.5 12989.0 13189.4 13278.9 11883.3 12021.3 12092.8 12230.1 12561.4 4180.5 4193.3 4242.4 4313.6 4447.8 67504.0 69085.7 69158.7 69261.7 69271.0 10419.4 10581.4 10706.9 11217.4 11371.2 19957.7 19989.0 19989.2 20001.8 20169.0 6687.4 6708.8 6794.6 6901.6 6946.4 3422.2 3525.5 3582.6 3726.9 3736.1 2602.2 2682.4 2692.8 2697.4 2708.8 459.6 465.6 466.6 474.7 476.9 510.8 517.9 530.7 532.7 546.1 7531.8 7545.3 7878.9 8133.6 8150.6 461.5 515.5 526.3 536.4 545.7 3563.9 3748.5 3789.6 3828.7 4013.3 93338.0 93480.5 94646.5 95787.5 98706.0 80406.6 81306.6 83685.0 83863.0 84829.6 44415.6 61886.4 66604.7 71499.3 71766.0 8246.5 8251.2 8517.6 8680.3 8793.1 31134.2 39358.2 42044.2 42719.8 43835.6 39588.0 40177.6 41025.6 61713.0 62863.7 10747.2 10861.1 10920.2 10971.3 11256.9 11688.2 11875.5 12223.5 12527.9 12573.0 12123.0 12228.6 12381.8 13251.1 13410.6 11720.3 12688.2 12689.6 12704.4 12728.6 12191.3 12328.9 12340.7 12749.0 12994.8 10015.6 10418.9 10650.7 10921.3 11028.5 9939.9 10358.5 10722.3 10767.5 10872.5 15:10:47 INFO - PROCESS | 21378 | -------- Summary: end -------- 15:10:47 INFO - PROCESS | 21378 | 15:10:48 INFO - TEST-INFO | 21378: exit 0 15:10:48 INFO - TEST-OK | dromaeo_css | took 1121528ms 15:10:48 INFO - TEST-START | kraken 15:10:48 INFO - operating with platform_type : linux_ 15:10:48 INFO - Initialising browser for kraken test... 15:10:48 INFO - TEST-INFO | started process 21682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp270qWH/profile http://localhost:58001/getInfo.html) 15:10:53 INFO - PROCESS | 21682 | __metrics Screen width/height:1600/1200 15:10:53 INFO - PROCESS | 21682 | colorDepth:24 15:10:53 INFO - PROCESS | 21682 | Browser inner width/height: 1024/697 15:10:53 INFO - PROCESS | 21682 | __metrics 15:10:53 INFO - PROCESS | 21682 | 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" 15:10:53 INFO - PROCESS | 21682 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:10:54 INFO - PROCESS | 21682 | console.error: PushService: 15:10:54 INFO - PROCESS | 21682 | stateChangeProcessEnqueue: Error transitioning state 15:10:54 INFO - PROCESS | 21682 | UnknownError 15:10:54 INFO - TEST-INFO | 21682: exit 0 15:10:54 INFO - Browser initialized. 15:10:54 INFO - Running cycle 1/1 for kraken test... 15:10:54 INFO - TEST-INFO | started process 21762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp270qWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:07 INFO - PROCESS | 21762 | RSS: Main: 174100480 15:11:07 INFO - PROCESS | 21762 | 15:11:09 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58001/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:10 INFO - PROCESS | 21762 | RSS: Main: 233742336 15:11:10 INFO - PROCESS | 21762 | 15:11:13 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58001/tests/kraken/driver.html?testName=audio-dft) 15:11:14 INFO - PROCESS | 21762 | RSS: Main: 218574848 15:11:14 INFO - PROCESS | 21762 | 15:11:17 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58001/tests/kraken/driver.html?testName=audio-fft) 15:11:18 INFO - PROCESS | 21762 | RSS: Main: 300044288 15:11:18 INFO - PROCESS | 21762 | 15:11:20 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58001/tests/kraken/driver.html?testName=audio-oscillator) 15:11:20 INFO - PROCESS | 21762 | RSS: Main: 209584128 15:11:20 INFO - PROCESS | 21762 | 15:11:23 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:23 INFO - PROCESS | 21762 | RSS: Main: 212942848 15:11:23 INFO - PROCESS | 21762 | 15:11:27 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58001/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:27 INFO - PROCESS | 21762 | RSS: Main: 249917440 15:11:27 INFO - PROCESS | 21762 | 15:11:31 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58001/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:31 INFO - PROCESS | 21762 | RSS: Main: 248967168 15:11:31 INFO - PROCESS | 21762 | 15:11:34 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58001/tests/kraken/driver.html?testName=json-parse-financial) 15:11:35 INFO - PROCESS | 21762 | RSS: Main: 248426496 15:11:35 INFO - PROCESS | 21762 | 15:11:36 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:37 INFO - PROCESS | 21762 | RSS: Main: 211255296 15:11:37 INFO - PROCESS | 21762 | 15:11:39 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:40 INFO - PROCESS | 21762 | RSS: Main: 218820608 15:11:40 INFO - PROCESS | 21762 | 15:11:42 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:43 INFO - PROCESS | 21762 | RSS: Main: 222851072 15:11:43 INFO - PROCESS | 21762 | 15:11:45 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:46 INFO - PROCESS | 21762 | RSS: Main: 224256000 15:11:46 INFO - PROCESS | 21762 | 15:11:49 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:50 INFO - PROCESS | 21762 | RSS: Main: 222023680 15:11:50 INFO - PROCESS | 21762 | 15:11:51 INFO - PROCESS | 21762 | Cycle 1(1): loaded http://localhost:58001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58001/tests/kraken/driver.html?testName=ai-astar) 15:11:52 INFO - PROCESS | 21762 | RSS: Main: 272904192 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | __start_tp_report 15:11:52 INFO - PROCESS | 21762 | _x_x_mozilla_page_load 15:11:52 INFO - PROCESS | 21762 | _x_x_mozilla_page_load_details 15:11:52 INFO - PROCESS | 21762 | |i|pagename|runs| 15:11:52 INFO - PROCESS | 21762 | |0;ai-astar;112;117;114;116;114;117;114;115;115;115 15:11:52 INFO - PROCESS | 21762 | |1;audio-beat-detection;153;123;128;180;125;125;128;126;158;125 15:11:52 INFO - PROCESS | 21762 | |2;audio-dft;163;162;163;160;161;163;163;161;161;160 15:11:52 INFO - PROCESS | 21762 | |3;audio-fft;76;75;77;103;76;76;78;76;105;77 15:11:52 INFO - PROCESS | 21762 | |4;audio-oscillator;85;84;116;84;84;84;112;84;84;110 15:11:52 INFO - PROCESS | 21762 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;117;117;118 15:11:52 INFO - PROCESS | 21762 | |6;imaging-darkroom;148;146;147;147;146;147;146;146;146;146 15:11:52 INFO - PROCESS | 21762 | |7;imaging-desaturate;95;96;95;95;96;95;96;96;96;96 15:11:52 INFO - PROCESS | 21762 | |8;json-parse-financial;64;66;63;64;65;64;66;65;64;65 15:11:52 INFO - PROCESS | 21762 | |9;json-stringify-tinderbox;65;66;67;66;68;66;67;67;67;68 15:11:52 INFO - PROCESS | 21762 | |10;stanford-crypto-aes;84;84;93;92;86;89;82;83;88;85 15:11:52 INFO - PROCESS | 21762 | |11;stanford-crypto-ccm;140;134;134;150;133;154;138;147;169;141 15:11:52 INFO - PROCESS | 21762 | |12;stanford-crypto-pbkdf2;176;176;169;176;175;172;174;170;177;178 15:11:52 INFO - PROCESS | 21762 | |13;stanford-crypto-sha256-iterative;70;69;73;68;68;66;69;67;67;66 15:11:52 INFO - PROCESS | 21762 | __end_tp_report 15:11:52 INFO - PROCESS | 21762 | __start_cc_report 15:11:52 INFO - PROCESS | 21762 | _x_x_mozilla_cycle_collect,1931 15:11:52 INFO - PROCESS | 21762 | __end_cc_report 15:11:52 INFO - PROCESS | 21762 | __startTimestamp1474063912040__endTimestamp 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | ------- Summary: start ------- 15:11:52 INFO - PROCESS | 21762 | Number of tests: 14 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.20 15:11:52 INFO - PROCESS | 21762 | Values: 112.0 117.0 114.0 116.0 114.0 117.0 114.0 115.0 115.0 115.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:128.00 stddev:19.60 (15.3%) stddev-sans-first:19.92 15:11:52 INFO - PROCESS | 21762 | Values: 153.0 123.0 128.0 180.0 125.0 125.0 128.0 126.0 158.0 125.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 15:11:52 INFO - PROCESS | 21762 | Values: 163.0 162.0 163.0 160.0 161.0 163.0 163.0 161.0 161.0 160.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:11.69 (15.4%) stddev-sans-first:12.20 15:11:52 INFO - PROCESS | 21762 | Values: 76.0 75.0 77.0 103.0 76.0 76.0 78.0 76.0 105.0 77.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:13.86 (16.5%) stddev-sans-first:14.41 15:11:52 INFO - PROCESS | 21762 | Values: 85.0 84.0 116.0 84.0 84.0 84.0 112.0 84.0 84.0 110.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:11:52 INFO - PROCESS | 21762 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 15:11:52 INFO - PROCESS | 21762 | Values: 148.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:11:52 INFO - PROCESS | 21762 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 15:11:52 INFO - PROCESS | 21762 | Values: 64.0 66.0 63.0 64.0 65.0 64.0 66.0 65.0 64.0 65.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 15:11:52 INFO - PROCESS | 21762 | Values: 65.0 66.0 67.0 66.0 68.0 66.0 67.0 67.0 67.0 68.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:3.78 (4.3%) stddev-sans-first:3.89 15:11:52 INFO - PROCESS | 21762 | Values: 84.0 84.0 93.0 92.0 86.0 89.0 82.0 83.0 88.0 85.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:144.00 stddev:11.31 (7.9%) stddev-sans-first:11.91 15:11:52 INFO - PROCESS | 21762 | Values: 140.0 134.0 134.0 150.0 133.0 154.0 138.0 147.0 169.0 141.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:176.00 stddev:3.02 (1.7%) stddev-sans-first:3.14 15:11:52 INFO - PROCESS | 21762 | Values: 176.0 176.0 169.0 176.0 175.0 172.0 174.0 170.0 177.0 178.0 15:11:52 INFO - PROCESS | 21762 | 15:11:52 INFO - PROCESS | 21762 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.11 (3.1%) stddev-sans-first:2.15 15:11:52 INFO - PROCESS | 21762 | Values: 70.0 69.0 73.0 68.0 68.0 66.0 69.0 67.0 67.0 66.0 15:11:52 INFO - PROCESS | 21762 | -------- Summary: end -------- 15:11:52 INFO - PROCESS | 21762 | 15:11:53 INFO - TEST-INFO | 21762: exit 0 15:11:53 INFO - TEST-OK | kraken | took 64763ms 15:11:53 INFO - SUITE-END | took 1186s 15:11:53 INFO - Completed test suite (00:19:46) 15:11:53 INFO - javascript benchmark 15:11:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.8059895507836, 2609.3737502999284, 2633.170551276348, 2639.7096319404864, 2647.3249321423023, 4622.491525932145, 4708.340832283483, 4709.670323077386, 4732.266498692704, 4738.194506933821, 4651.511591282917, 4653.767311634421, 4676.859694209171, 4708.36437080994, 4725.385699859022, 4264.87205383839, 4304.074623955848, 4312.029793296499, 4323.82704691812, 4399.5160532341415, 4362.541933097027, 4413.933790993137, 4439.445069366329, 4451.532589078149, 4498.460184777831, 4271.359296105609, 4293.806778694966, 4394.472663280427, 4437.245668236392, 4460.710053846522, 4329.090890912912, 4349.543297953733, 4361.149575832714, 4388.5830846069575, 4463.531329210451, 4355.847545335898, 4360.520342762294, 4362.214801335758, 4367.170237654867, 4408.911821763579, 4731.313959475891, 4750.12122757291, 4763.761811909425, 4767.713937163781, 4799.617703132536, 4930.580900623451, 4933.53131452515, 4980.352554167971, 4986.925196122061, 4998.90002199954, 5014.674046187022, 5037.9244311335, 5043.142665746832, 5049.419316778581, 5080.1617733074, 4689.413823272091, 4691.835785747482, 4707.7881495332795, 4734.455537613149, 4766.904661906742, 5046.571041461443, 5103.821366252163, 5118.769655365518, 5163.148080566664, 5171.63798534099, 5030.541143068469, 5032.521910418504, 5036.899262014739, 5049.242613607915, 5084.135696931457, 5107.770150343244, 5112.130937740519, 5130.307408499804, 5133.5379815816, 5185.533302002762, 4921.630877684116, 4929.654924155347, 4959.0329885671945, 5056.57019153376, 5065.848024559269, 4936.975315123402, 4942.332785074041, 4959.330490383824, 5023.849284521397, 5026.472220416877, 4232.343986682007, 4241.257779888507, 4254.404383386328, 4294.806733696991, 4303.741775493418, 3683.4843121962945, 3696.1868388954927, 3698.0385099874225, 3737.439384092408, 3805.8667946621736, 4327.2643650579475, 4337.371081193272, 4337.587929146726, 4345.413369195118, 4350.129974005212, 5096.388433387943, 5103.336566246438, 5110.616703747234, 5114.079465696211, 5141.614378921596, 4389.539098394686, 4395.758233297135, 4404.097160082176, 4437.64498840092, 4449.154660614473, 4474.507804141542, 4491.820327186876, 4505.707129036602, 4529.411176547028, 4557.111363284128, 4775.06886157196, 4781.641376896677, 4789.137955167964, 4791.856244312677, 4827.42070951488, 5115.0, 5129.7691603877165, 5135.3324067870935, 5139.254808052737, 5164.664296820694, 4717.575418212377, 4756.239001759702, 4767.141914455431, 4816.470188279216, 4883.8290659826735, 5006.69959802413, 5046.772895219798, 5052.671576347526, 5101.617378696538, 5104.106781313181, 5101.897962040813, 5103.157978933435, 5110.616703747308, 5112.590992720499, 5144.331236939174, 4738.289256611398, 4738.33663287147, 4955.331030310862, 4959.876003099951, 4967.801287948441, 4886.53577910098, 4892.535209155125, 4940.777665005012, 4946.35697359341, 4947.084789313988, 4808.014357056865, 4820.325154478446, 4830.7101573905675, 4844.297576851407, 4884.682495637772, 4838.298446725275, 4919.9754001231195, 4929.457759646508, 4939.678920870132, 5002.974985125051, 4772.236442169236, 4817.542333478314, 4831.613470922388, 4836.927446088241, 4841.927371089507], "value": 4643.454722899792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.747576114987, 552.53586986931, 560.587967843635, 572.773754367025, 574.3624576719842, 27937.720622793768, 39133.0, 39806.80096599513, 40308.79845600775, 43037.569624303746, 40038.59961400392, 40419.797901010454, 40461.393079103764, 40481.79759101208, 40522.79738601303, 7106.467014973872, 7526.172121066678, 7665.348445382149, 7674.53952762836, 7680.961595192016, 7065.540739851893, 7287.453440991921, 7290.671919763623, 7291.0, 9763.267754918374, 9855.753606159868, 10200.74498137545, 10207.693769186937, 10215.0, 10215.38707677538, 10042.648507302245, 10127.696169114939, 10127.949360253151, 10143.543540540693, 10148.746281342952, 9855.852162217572, 9923.503824808731, 9928.50357482123, 9938.90061099387, 9940.850887236697, 37643.0, 37889.62110378916, 37933.241335173145, 37951.81024094862, 37969.62030379689, 2695.811293209476, 2802.285417218596, 2823.9294017649518, 2834.5464725643797, 2989.7309242168094, 27931.720682793115, 28118.578221326698, 28248.85875570609, 28815.56776648352, 29341.85329073341, 3144.905652830396, 3222.8388580570877, 3230.596175478065, 3241.8216998065095, 3290.851911663981, 248708.0, 249992.0, 250199.0, 250622.0, 251141.0, 30754.53868191979, 31956.360872782414, 51532.484675152766, 51893.7405312971, 51894.48105518972, 33092.83453582717, 33159.0, 33273.66726332754, 33395.83302083523, 33458.66541334604, 11373.601923932789, 11475.942620287013, 11483.827742583868, 11486.597969071043, 11495.425228738697, 8671.21959023691, 8686.609102590399, 8763.824723505495, 8780.034196238408, 8785.077566855516, 7170.928290717026, 7343.669534870944, 7588.962055189689, 7811.375089992787, 7822.0, 3048.527478240876, 3058.495348267511, 3064.8314342711365, 3086.2592977685645, 3095.334503081848, 793.1473665809278, 814.9918500815035, 895.7805337692307, 895.9204158988404, 914.085914085914, 24694.50610987806, 25932.87033564858, 26266.212013639622, 26525.734742652712, 27339.45321093567, 908.6047569307373, 908.8591268353416, 923.8244733500613, 937.6577549194632, 993.7018894331671, 13873.86126138746, 14722.63193420173, 14783.556493305217, 15032.473863414729, 15112.697746045018, 376669.0, 381939.528466015, 382187.0, 383278.0, 383366.0, 42302.36546451806, 43445.56554434415, 47907.3232436863, 48411.51588484141, 48640.27039594409, 990.7473594233425, 1016.3596933931576, 1087.4182312462954, 1088.0860077534908, 1092.6667366453307, 26873.596896046183, 28689.569656455587, 29462.0, 29951.400971980875, 29952.25119372033, 41780.16439671129, 42216.78891605645, 42272.5772742281, 42291.57708423, 42363.1527369457, 316662.0, 318373.0, 318631.0, 319996.0, 320331.0, 24318.392040199138, 25020.374490637878, 25471.745282546937, 25495.490090198462, 25633.231003069937, 40971.0, 41556.58443415527, 41589.79205103955, 41734.1653166941, 42062.1587568253, 34041.0, 35340.29319413649, 35397.29205415826, 35558.0, 35593.64406355903, 34784.65215347814, 34961.475577865844, 35059.64940350564, 35097.47353789644, 35126.473102902964, 34616.65383346134, 34953.825230873685, 34982.65017349794, 35371.46942795809, 35839.0, 30474.390512190075, 32661.17806148825, 32759.34481310313, 32848.83575582107, 33344.833275833465, 24732.876335618206, 24835.25494235176, 24954.750452495242, 25002.499950000536, 25079.373015674755], "value": 16203.080480296552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.6404129601975, 359.43748034326296, 363.2444515407951, 369.3683800700802, 386.55353067207386, 10953.507092180851, 11843.230190037651, 15870.444534441296, 16624.83375166248, 17730.202140903657, 16885.915570422163, 17217.0, 17397.47807565772, 17596.64806703865, 17608.11959402031, 4866.853994380174, 5061.974690126563, 5064.012517559077, 5110.948890511085, 5405.108157154064, 3363.7477189210786, 5411.756470958797, 5435.402105768362, 5441.619086663935, 5442.755076021569, 3550.982245088771, 5791.247137872071, 6026.789062382817, 6083.330833608322, 6173.660448675321, 5946.375630558772, 6048.123022161806, 6085.676782944198, 6147.969260153693, 6159.168512250856, 5390.19147127934, 5402.297701298845, 5403.78384864605, 5406.324209473816, 5409.26974858393, 11478.253913495597, 11734.178607497479, 11851.348175850324, 11895.583654572049, 18851.0, 1707.2829411647137, 1765.5321339844822, 1924.4611508777564, 1993.6511110555596, 2133.9466513337134, 8363.83272334556, 8734.51960142192, 8971.775705607346, 9151.313651476099, 9196.954015229881, 1689.4678176374402, 1703.7018521758644, 1705.6247625522365, 1708.4959936818543, 1719.2091637846481, 68204.6589767053, 69585.65207173982, 69967.3003269971, 70049.0, 71152.644236779, 9857.0, 9897.554610042565, 9966.152877005536, 10158.561945133115, 10166.745831354126, 13777.0, 13786.65533361674, 13798.724025519634, 13800.723985520433, 13802.723945521033, 6557.213134423804, 6628.701708423133, 6820.761273355409, 6831.4534837212905, 6936.34104760047, 6056.091586262096, 6070.908936365958, 6259.874802503924, 6280.560360774702, 6282.528810339243, 4058.8782336529953, 4244.830206791756, 4275.8882690500695, 4371.519132895379, 4428.512863585003, 1741.2860727101827, 1762.9823701763075, 1787.374418953382, 1789.4452719656947, 1818.4635532517939, 785.2147852147853, 805.5690205739901, 821.3839620284787, 824.2334628795278, 856.3149480415767, 16583.253753581117, 16736.665266694843, 16750.66498670044, 17078.914605426893, 17760.200790964438, 823.0945959444683, 840.6007146605314, 851.4635779459026, 851.6252848746656, 874.7622114707744, 9365.953170234105, 9411.341206115507, 9812.313138080408, 9847.641210281052, 9864.0, 384979.0, 386259.0, 392897.0, 395029.0, 398303.0, 79475.0, 81386.71563148637, 81914.0, 82627.0, 84813.57593211994, 869.5043825019804, 878.5036454403241, 929.4655573045391, 936.7330310861372, 941.2187884056353, 15103.4713785017, 15538.844611554192, 16658.167091645126, 16660.83339166593, 16885.24016419289, 38850.80574597109, 39012.414813778385, 39752.60078672569, 40324.59675403326, 40435.7978210107, 53694.46305536895, 54780.72609636926, 54829.72585137208, 55081.0, 55500.0, 7519.586422746802, 7526.285002924714, 7544.358729508053, 7570.280823321776, 7631.8855217172895, 8941.821163576822, 11068.501917413896, 11164.665060048212, 11891.46488408041, 12396.690082747642, 9386.67146649864, 10117.29178957466, 10144.340617859816, 10651.94674026656, 10886.455677216265, 9628.133467987915, 9881.901180988098, 9889.357191782512, 10918.836217456586, 10935.726606834893, 10142.442165680959, 10491.94754026225, 10636.574537018741, 10679.359238445719, 11263.943680281545, 7392.741254056083, 7514.849703006019, 7581.12817026027, 7587.810304742426, 7661.616919154131, 9608.855867162138, 10203.438810865176, 10278.691639250834, 10319.845202322122, 10661.09380702618], "value": 8059.44137868824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.6309044196305, 1292.8254685617442, 1335.0721248732132, 1345.9461621535138, 1667.5914400971765, 6583.3416658334145, 7121.679524421401, 7353.301436363544, 7442.40460763139, 7695.038120234971, 7518.924810751891, 7574.280443357872, 7594.886076708854, 7609.809754756134, 7614.73348432805, 2047.877127372355, 2103.6949642301856, 2103.7791031941656, 2107.557412943276, 2116.3016204652504, 2043.1520918818671, 2074.388055523624, 2079.386580958613, 2088.6971389148566, 2089.8641588296787, 2068.8965551722354, 2070.0, 2089.2896415218825, 2089.4149638101358, 2091.5712278982774, 2034.7558293004934, 2035.460602940222, 2036.5825005873835, 2044.8261897738562, 2046.907889144992, 2012.6276638821864, 2025.7265269188617, 2036.5112373030515, 2039.9286024989053, 2043.4891277180704, 7330.560166390033, 7380.298871607189, 7392.815179620498, 7617.314441700273, 7808.687652493893, 4005.0988527581353, 4175.436316097349, 4185.267578173807, 4186.037211441386, 4189.706720529564, 2657.827241229314, 2781.680106787725, 2817.1830169251098, 2832.5892745551987, 2843.530817415124, 914.3873604684877, 918.6049998500642, 930.2790337488433, 931.1759093202497, 935.6818681648205, 10212.642557510451, 10293.279470437072, 10304.79390412195, 10335.94832025835, 10342.948285258526, 3588.085038315213, 3777.3011992780876, 3843.442700808367, 3851.730378873508, 3852.711046671455, 7939.483933544301, 7985.241402066795, 7991.24083212094, 7992.920070799334, 7995.440319177718, 4198.425590403599, 4199.118185181085, 4200.306949353384, 4201.516825565038, 4205.789710514462, 3330.234046169395, 3442.9827850860584, 3720.3675375186285, 3860.4595356650093, 3884.028992751812, 3319.103841962705, 3346.548215990859, 3434.347473979986, 3447.3277710846646, 3465.220325426759, 1002.904724051214, 1010.7473131717071, 1012.2003617142523, 1013.5692330759398, 1031.0, 703.7642389799372, 710.9537880037781, 730.7698075106324, 734.7024455095694, 754.1176823116966, 4786.521347865255, 4893.916832395639, 5013.473585273567, 5098.59211263098, 5177.119889618699, 392.11969129304896, 400.1976038043704, 404.5772168084359, 420.63404837790705, 421.0799403303791, 3526.8765593204116, 3537.3809583322814, 3545.4859045438266, 3560.7067644467074, 3568.982155089208, 9150.496722680184, 9551.856722149174, 9553.61785528585, 9599.568019439143, 9617.855732164024, 8731.388802783871, 9471.952640236756, 9486.95256523713, 9521.952390238004, 9532.999035101353, 6793.388595026471, 6930.757423490154, 6940.861182776417, 6947.096877405905, 6954.930450695429, 5261.894762104813, 5479.342478902558, 5498.120300751861, 5548.805791797267, 5602.747876345493, 8444.113368096261, 8602.139786021347, 8677.783055423664, 8694.04365519805, 8720.0, 8569.528675922635, 8893.110688931314, 8913.197812196673, 8927.642894284156, 8999.415038022507, 5652.915206271827, 5825.184474173534, 6744.0, 6907.412869906114, 6916.204636466669, 7033.156021277275, 7330.376917961819, 7362.6318684066655, 7558.811029724081, 7570.091589009354, 6424.336476861306, 6556.409923106943, 6581.992492289897, 6691.498137639599, 6711.597304161766, 6194.0, 6256.374362563707, 6318.589291696025, 6372.36276372359, 6412.935870641234, 5861.208736820645, 5995.820125396245, 5999.340072592098, 6000.0999850022845, 6002.339742628395, 4427.446569178853, 4440.378347031354, 4498.415206023196, 4533.387992621086, 4630.976845115752, 4496.460424749051, 4504.842330518416, 4535.863924082283, 4549.977250113729, 4618.307253911806], "value": 3851.5335987524363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.922461710721, 276.95014897318487, 286.1815208503679, 286.1900820677483, 287.55859755275657, 4609.585137337639, 4752.07334569759, 4783.952160478394, 4819.734914579697, 4834.154023045966, 4575.519570445097, 4708.458527269357, 4755.476897541276, 4760.2383618621025, 4799.856004319868, 3572.821358932056, 3684.244729830392, 3771.6422088048416, 3790.5261842269715, 3802.9429558556576, 3676.1544844685736, 3765.4351847222997, 3769.0, 3774.5093137892172, 3803.7527560708604, 3747.250549890019, 3748.6063963283873, 3752.662260396564, 3754.4180651998986, 3755.1550901047317, 3753.8498460061564, 3762.529683789526, 3771.1326394929183, 3776.0, 3781.5840257571645, 3096.938061238785, 3220.920991467861, 3224.3873664004, 3243.7835811570662, 3364.596248450177, 4650.511696271877, 4651.302304654295, 4652.930206046912, 4658.324542941288, 4689.2966055091665, 4056.492938382702, 4195.307774217251, 4199.286121359346, 4204.62158405745, 4214.588112982155, 4999.850004499871, 5003.799848006075, 5018.849434516934, 5019.698818070928, 5023.48356150696, 3530.3645343838098, 3531.417316142859, 3536.328097661436, 3539.424955894628, 3540.9114772130647, 5046.4953504649975, 5228.2680424740565, 5259.421463638997, 5263.789448422059, 5267.051930652481, 3604.747667663238, 3650.634936506328, 3652.342578335925, 3653.780773153619, 3660.5790334111384, 3694.538182727159, 3698.3158115748674, 3704.629537046274, 3710.2950439416422, 3719.3491139050557, 4221.56466801289, 4225.598568136023, 4226.4716910386205, 4227.387028880795, 4231.2383770920915, 4880.316755654211, 5021.49785021495, 5023.171176755867, 5025.84922452327, 5046.62150338726, 1243.9004879609608, 1249.7875361188437, 1256.3278645924386, 1264.4436447962867, 1267.7020900088655, 752.1838804896748, 784.2784638132931, 789.3566743104352, 792.1365711374514, 803.6102490292203, 4004.6996475264473, 4015.658669013108, 4015.9397609035886, 4020.19596080785, 4047.494063242095, 4567.721038109335, 4578.2903649934315, 4582.221022426195, 4585.564371384779, 4587.311903214478, 4027.7180597357906, 4029.0, 4032.798360082043, 4034.3141665916864, 4041.3937909313836, 2304.688867002933, 2439.9634005489934, 2445.0, 2447.592634235322, 2456.7666071723156, 4362.607365337135, 4366.868993930188, 4370.7106403611015, 4383.430154079949, 4400.977995110004, 4669.34629151919, 4686.81252749893, 4692.906141877143, 4703.6246695418595, 4717.787699553528, 4376.693631445768, 4410.25025745624, 4488.349189367524, 4872.098661747588, 4880.365552478155, 5140.228965655182, 5141.588672906233, 5156.2523434102595, 5159.767810448464, 5165.225216217597, 5070.518300761421, 5101.51535604117, 5111.284420181252, 5142.100132476727, 5144.6655967362, 4726.409198850144, 4865.099956508057, 4898.8775280618265, 4901.485344038824, 4910.459849416633, 3319.6182439018858, 3408.5909690836265, 3447.379471695119, 3557.092941299952, 3576.7853928764357, 5143.271128431857, 5165.793368265227, 5194.558462530727, 5197.948020519746, 5203.16749320107, 4956.397891107197, 5008.222081161281, 5009.423916249532, 5035.420926593489, 5036.0, 4784.497627749036, 4988.553319537294, 4989.451160372283, 5031.698098114125, 5033.421156566895, 4901.730404827626, 4942.505749425029, 4945.876353091202, 4982.7259500727805, 4985.75071246429, 5065.164247899055, 5092.923606145985, 5100.872478188075, 5103.489651034867, 5115.667481613683, 4821.252705830602, 4888.413390393175, 4907.411110666742, 4919.286703427912, 4978.755311172207], "value": 3685.4354098484478, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4237303375276, 615.1265203411156, 635.841039740065, 670.8792417364872, 682.6347903871426, 12974.416151273192, 14371.64070898228, 14451.638709032279, 14459.13245205287, 14497.202653854034, 13956.162630242192, 13993.930030349835, 14757.40970361187, 14761.630959225999, 14781.852181478182, 736.1240124252149, 759.3242014607005, 761.6115780951727, 763.7365109037373, 763.9770806875803, 570.8344580071774, 598.5510866849862, 716.8888822232562, 756.2588663110155, 758.6586036283694, 792.6670798264714, 794.8370584030289, 795.4511387142882, 796.0288448093316, 796.6415113199055, 790.154534647927, 790.4190420041265, 790.4664351562673, 791.7545560876118, 791.8178818871634, 444.8887778055486, 461.367925941459, 549.6592112889994, 577.8555361159711, 580.6225953130499, 12164.635060948185, 12325.075619328587, 12357.196782209128, 12363.690907727289, 12367.134300598962, 12293.446794894251, 12968.481260749559, 12989.0, 13189.406476708571, 13278.867211327859, 11883.287002779862, 12021.338826364547, 12092.818607720892, 12230.14388992771, 12561.371931403393, 4180.498340199196, 4193.287141186006, 4242.406063151161, 4313.61177494027, 4447.8443254486265, 67504.0, 69085.65457172733, 69158.65420672914, 69261.65369173173, 69271.0, 10419.374837509773, 10581.365118092785, 10706.94646526778, 11217.439128043565, 11371.20401571882, 19957.700634490495, 19989.0, 19989.200431982557, 20001.799982000284, 20169.0, 6687.431568316651, 6708.798736037927, 6794.558353706993, 6901.551399159039, 6946.409555187764, 3422.19578399076, 3525.453554699026, 3582.6238244984424, 3726.925461490755, 3736.1220113273357, 2602.2193341997327, 2682.3830518980744, 2692.8115031947577, 2697.3661189620425, 2708.7832973362083, 459.60014787134736, 465.62284549515, 466.5754163711007, 474.6701042775238, 476.9332293478916, 510.7548376779093, 517.8653550077007, 530.7134147560351, 532.6963630730523, 546.1485563938253, 7531.849363012819, 7545.283198096282, 7878.881816772753, 8133.552654604054, 8150.551719655357, 461.5361561630607, 515.5025400488547, 526.2973929803754, 536.35637235317, 545.738045738048, 3563.8565876970997, 3748.456473811282, 3789.5642001169667, 3828.674562662205, 4013.2776100301644, 93338.0, 93480.53259733658, 94646.52676736572, 95787.52106239564, 98706.0, 80406.59796700979, 81306.59346703229, 83685.0, 83863.0, 84829.57585212034, 44415.55584444114, 61886.38113618896, 66604.6679066416, 71499.2850071503, 71766.0, 8246.463979841292, 8251.216134467217, 8517.616707248064, 8680.305575554066, 8793.076726943835, 31134.22164445907, 39358.21283574255, 42044.159116818104, 42719.786401067795, 43835.561644383146, 39588.0, 40177.598224018555, 41025.589744103374, 61713.0, 62863.68568157313, 10747.247692661438, 10861.09028064032, 10920.180986426209, 10971.286866353661, 11256.943715281372, 11688.18182727201, 11875.52497900109, 12223.461239769751, 12527.93736031314, 12573.0, 12123.0, 12228.571999979958, 12381.75236495247, 13251.13867598603, 13410.597682069554, 11720.296782193096, 12688.23870567769, 12689.555865544662, 12704.428300726675, 12728.554500592434, 12191.329476878856, 12328.876711233132, 12340.691482712646, 12749.0, 12994.80507792365, 10015.59937602517, 10418.947905260728, 10650.680479585624, 10921.290116142425, 11028.503717332578, 9939.900600994186, 10358.533865975898, 10722.303050301705, 10767.515461804394, 10872.510737017012], "value": 6485.960303018304, "unit": "score"}], "name": "dromaeo_css", "value": 6182.277089353515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 114.0, 116.0, 114.0, 117.0, 114.0, 115.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 128.0, 180.0, 125.0, 125.0, 128.0, 126.0, 158.0, 125.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 160.0, 161.0, 163.0, 163.0, 161.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 103.0, 76.0, 76.0, 78.0, 76.0, 105.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 116.0, 84.0, 84.0, 84.0, 112.0, 84.0, 84.0, 110.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 64.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 68.0, 66.0, 67.0, 67.0, 67.0, 68.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 93.0, 92.0, 86.0, 89.0, 82.0, 83.0, 88.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 134.0, 150.0, 133.0, 154.0, 138.0, 147.0, 169.0, 141.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 169.0, 176.0, 175.0, 172.0, 174.0, 170.0, 177.0, 178.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 68.0, 68.0, 66.0, 69.0, 67.0, 67.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1552.1999999999998, "alertThreshold": 2.0}]} 15:11:53 INFO - Return code: 0 15:11:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:11:53 INFO - # TBPL SUCCESS # 15:11:53 INFO - Running post-action listener: _resource_record_post_action 15:11:53 INFO - [mozharness: 2016-09-16 22:11:53.867651Z] Finished run-tests step (success) 15:11:53 INFO - Running post-run listener: _resource_record_post_run 15:11:53 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 401059840; Read time: 20; Write time: 353968 15:11:53 INFO - TinderboxPrint: CPU usage
13.1% 15:11:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 15:11:53 INFO - TinderboxPrint: I/O write bytes / time
401,059,840 / 353,968 15:11:53 INFO - TinderboxPrint: CPU idle
8,341.6 (86.9%) 15:11:53 INFO - TinderboxPrint: CPU user
1,204.6 (12.5%) 15:11:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:11:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115986432; Read time: 0; Write time: 78404 15:11:53 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285073408; Read time: 8; Write time: 275564 15:11:54 INFO - Running post-run listener: _upload_blobber_files 15:11:54 INFO - Blob upload gear active. 15:11:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:11:54 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 15:11:54 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'] 15:11:54 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 15:11:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:55 INFO - (blobuploader) - INFO - Done attempting. 15:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:56 INFO - (blobuploader) - INFO - Done attempting. 15:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:01 INFO - (blobuploader) - INFO - Done attempting. 15:12:01 INFO - (blobuploader) - INFO - Iteration through files over. 15:12:01 INFO - Return code: 0 15:12:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:12:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:12:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b84affba9d55415902ac71c2e9e79dc84c8837f72a2c2ed28a87d3e6b76766ea81b28fea5d5841e3a8e3cd872f9185af73a8c403256fbe7f90391679eea563a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e16cc9c65c6d3495ed585d6ef0748434a63519a19a732705131d5c24147bf30f18a295ec47151f10bf174998b884444f874eeb74bfbf74c3bcc7169d6ef253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fabc8a8c0bb87b0f4492978b754af94d5756f3e5379d9797ffd4c9eef7d154ae39ece689bf3901a9acdde27b513996477929c13bc09070d2ae13af28a9a0706d"} 15:12:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:12:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:12:01 INFO - Contents: 15:12:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b84affba9d55415902ac71c2e9e79dc84c8837f72a2c2ed28a87d3e6b76766ea81b28fea5d5841e3a8e3cd872f9185af73a8c403256fbe7f90391679eea563a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e16cc9c65c6d3495ed585d6ef0748434a63519a19a732705131d5c24147bf30f18a295ec47151f10bf174998b884444f874eeb74bfbf74c3bcc7169d6ef253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fabc8a8c0bb87b0f4492978b754af94d5756f3e5379d9797ffd4c9eef7d154ae39ece689bf3901a9acdde27b513996477929c13bc09070d2ae13af28a9a0706d"} 15:12:01 INFO - Running post-run listener: copy_logs_to_upload_dir 15:12:01 INFO - Copying logs to upload dir... 15:12:01 INFO - mkdir: /builds/slave/test/build/upload/logs 15:12:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.427590 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-16 15:12:01.386252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 15:12:01.389411) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972 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/b84affba9d55415902ac71c2e9e79dc84c8837f72a2c2ed28a87d3e6b76766ea81b28fea5d5841e3a8e3cd872f9185af73a8c403256fbe7f90391679eea563a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e16cc9c65c6d3495ed585d6ef0748434a63519a19a732705131d5c24147bf30f18a295ec47151f10bf174998b884444f874eeb74bfbf74c3bcc7169d6ef253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fabc8a8c0bb87b0f4492978b754af94d5756f3e5379d9797ffd4c9eef7d154ae39ece689bf3901a9acdde27b513996477929c13bc09070d2ae13af28a9a0706d"} build_url:https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/CqSp1FncTQCGSKVtW5yh3Q/artifacts/public/build/firefox-51.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/b84affba9d55415902ac71c2e9e79dc84c8837f72a2c2ed28a87d3e6b76766ea81b28fea5d5841e3a8e3cd872f9185af73a8c403256fbe7f90391679eea563a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e16cc9c65c6d3495ed585d6ef0748434a63519a19a732705131d5c24147bf30f18a295ec47151f10bf174998b884444f874eeb74bfbf74c3bcc7169d6ef253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fabc8a8c0bb87b0f4492978b754af94d5756f3e5379d9797ffd4c9eef7d154ae39ece689bf3901a9acdde27b513996477929c13bc09070d2ae13af28a9a0706d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 15:12:01.415043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:12:01.415382) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474062574.477234-1479004972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 15:12:01.498098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 15:12:01.498453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 15:12:01.498784) ========= ========= Total master_lag: 0.19 =========