builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-084 starttime: 1487698730.7 results: success (0) buildid: 20170221075028 builduid: 9725abebfac74a75a7c863a84cbbb18d revision: 68546cbfc3e025042f2c26eb0a1caca91de407b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.698522) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.699577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.700346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.716261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.716815) ========= 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=ea65d483da93c827905c2090000001f5-1487698730.213700-86446525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-21 09:38:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-02-21 09:38:51 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.815924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.816268) ========= 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=ea65d483da93c827905c2090000001f5-1487698730.213700-86446525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.865803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:50.866186) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 68546cbfc3e025042f2c26eb0a1caca91de407b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 68546cbfc3e025042f2c26eb0a1caca91de407b1 --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=ea65d483da93c827905c2090000001f5-1487698730.213700-86446525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-21 09:38:51,226 truncating revision to first 12 chars 2017-02-21 09:38:51,226 Setting DEBUG logging. 2017-02-21 09:38:51,226 attempt 1/10 2017-02-21 09:38:51,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/68546cbfc3e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 09:38:51,822 unpacking tar archive at: mozilla-beta-68546cbfc3e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.915046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:51.796193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:51.796542) ========= script_repo_revision: 68546cbfc3e025042f2c26eb0a1caca91de407b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:51.796961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:51.797250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 09:38:51.806915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-21 09:38:51.807232) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=ea65d483da93c827905c2090000001f5-1487698730.213700-86446525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:38:52 INFO - MultiFileLogger online at 20170221 09:38:52 in /builds/slave/test 09:38:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:38:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:52 INFO - {'append_to_log': False, 09:38:52 INFO - 'base_work_dir': '/builds/slave/test', 09:38:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:38:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:52 INFO - 'branch': 'Mozilla-Beta', 09:38:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:52 INFO - 'config_files': ('talos/linux_config.py',), 09:38:52 INFO - 'default_actions': ('clobber', 09:38:52 INFO - 'read-buildbot-config', 09:38:52 INFO - 'download-and-extract', 09:38:52 INFO - 'populate-webroot', 09:38:52 INFO - 'create-virtualenv', 09:38:52 INFO - 'install', 09:38:52 INFO - 'run-tests'), 09:38:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:52 INFO - 'download_minidump_stackwalk': True, 09:38:52 INFO - 'download_symbols': 'ondemand', 09:38:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:52 INFO - 'installer_path': 'installer.exe', 09:38:52 INFO - 'log_level': 'info', 09:38:52 INFO - 'log_name': 'talos', 09:38:52 INFO - 'log_to_console': True, 09:38:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:38:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:38:52 INFO - 'opt_config_files': (), 09:38:52 INFO - 'pip_index': False, 09:38:52 INFO - 'sps_profile': False, 09:38:52 INFO - 'sps_profile_interval': 0, 09:38:52 INFO - 'suite': 'dromaeojs', 09:38:52 INFO - 'system_bits': '32', 09:38:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:52 INFO - 'title': 'talos-linux64-ix-084', 09:38:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:52 INFO - 'use_talos_json': True, 09:38:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:52 INFO - 'work_dir': 'build'} 09:38:52 INFO - [mozharness: 2017-02-21 17:38:52.271420Z] Running clobber step. 09:38:52 INFO - Running pre-action listener: _resource_record_pre_action 09:38:52 INFO - Running main action method: clobber 09:38:52 INFO - rmtree: /builds/slave/test/build 09:38:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:53 INFO - Running post-action listener: _resource_record_post_action 09:38:53 INFO - [mozharness: 2017-02-21 17:38:53.318419Z] Finished clobber step (success) 09:38:53 INFO - [mozharness: 2017-02-21 17:38:53.318518Z] Running read-buildbot-config step. 09:38:53 INFO - Running pre-action listener: _resource_record_pre_action 09:38:53 INFO - Running main action method: read_buildbot_config 09:38:53 INFO - Using buildbot properties: 09:38:53 INFO - { 09:38:53 INFO - "project": "", 09:38:53 INFO - "product": "firefox", 09:38:53 INFO - "script_repo_revision": "production", 09:38:53 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:38:53 INFO - "repository": "", 09:38:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:38:53 INFO - "buildid": "20170221075028", 09:38:53 INFO - "pgo_build": "True", 09:38:53 INFO - "basedir": "/builds/slave/test", 09:38:53 INFO - "buildnumber": 148, 09:38:53 INFO - "slavename": "talos-linux64-ix-084", 09:38:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:38:53 INFO - "platform": "ubuntu64_hw", 09:38:53 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:38:53 INFO - "branch": "mozilla-beta", 09:38:53 INFO - "repo_path": "releases/mozilla-beta", 09:38:53 INFO - "revision": "68546cbfc3e025042f2c26eb0a1caca91de407b1", 09:38:53 INFO - "stage_platform": "linux64-pgo", 09:38:53 INFO - "builduid": "9725abebfac74a75a7c863a84cbbb18d", 09:38:53 INFO - "slavebuilddir": "test" 09:38:53 INFO - } 09:38:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:38:53 INFO - Running post-action listener: _resource_record_post_action 09:38:53 INFO - [mozharness: 2017-02-21 17:38:53.320960Z] Finished read-buildbot-config step (success) 09:38:53 INFO - [mozharness: 2017-02-21 17:38:53.321048Z] Running download-and-extract step. 09:38:53 INFO - Running pre-action listener: _resource_record_pre_action 09:38:53 INFO - Running main action method: download_and_extract 09:38:53 INFO - mkdir: /builds/slave/test/build/tests 09:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:53 INFO - trying https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:38:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:38:53 INFO - Downloaded 1327 bytes. 09:38:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:38:53 INFO - Using the following test package requirements: 09:38:53 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:38:53 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:38:53 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:38:53 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'jsshell-linux-x86_64.zip'], 09:38:53 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:38:53 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:38:53 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:38:53 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:38:53 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:38:53 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:38:53 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:38:53 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:38:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:38:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:38:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:38:54 INFO - Http code: 200 09:38:54 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 09:38:54 INFO - x-amz-cf-id: iN-lc6DRt5TwTx59uYgbpFP5RDskuDRygzbfd4helkHLCb_DKoT7lw== 09:38:54 INFO - x-amz-version-id: WRss14cQUMdqnRbXFWKOcFluDNn0B5Dn 09:38:54 INFO - Expected file size: 21963963 09:38:54 INFO - Obtained file size: 21963963 09:38:58 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:38:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:38:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:38:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:38:59 INFO - Http code: 200 09:38:59 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 09:38:59 INFO - x-amz-cf-id: InJucfoPVxftwJS0UAv96-7UX-FjyjYJmN3G3T2DmHcw6LAw82XTLQ== 09:38:59 INFO - x-amz-version-id: WRss14cQUMdqnRbXFWKOcFluDNn0B5Dn 09:38:59 INFO - Expected file size: 21963963 09:38:59 INFO - Obtained file size: 21963963 09:39:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 09:39:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:39:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 09:39:04 INFO - Http code: 200 09:39:04 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:39:04 INFO - x-amz-cf-id: YcghTwiV89QoLAEVytIoSRCx3dv1EkO3CYMacGg_U_iZwrqcT-1Bbg== 09:39:04 INFO - x-amz-version-id: b1JIRy9ritniP71fuxUsQkqwTNpgzpPz 09:39:05 INFO - Expected file size: 14403005 09:39:05 INFO - Obtained file size: 14403005 09:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:05 INFO - trying https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:39:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:39:06 INFO - Downloaded 57743042 bytes. 09:39:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:39:06 INFO - mkdir: /builds/slave/test/properties 09:39:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:06 INFO - Contents: 09:39:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:39:07 INFO - Running post-action listener: _resource_record_post_action 09:39:07 INFO - Running post-action listener: set_extra_try_arguments 09:39:07 INFO - [mozharness: 2017-02-21 17:39:07.367125Z] Finished download-and-extract step (success) 09:39:07 INFO - [mozharness: 2017-02-21 17:39:07.367352Z] Running populate-webroot step. 09:39:07 INFO - Running pre-action listener: _resource_record_pre_action 09:39:07 INFO - Running main action method: populate_webroot 09:39:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:07 INFO - '--tppagecycles', 09:39:07 INFO - '7'], 09:39:07 INFO - 'tests': ['tsvgm']}}, 09:39:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['damp', 'tps']}, 09:39:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'tests': ['damp', 'tps']}, 09:39:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['dromaeo_dom']}, 09:39:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['basic_compositor_video']}, 09:39:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['a11yr', 09:39:07 INFO - 'ts_paint', 09:39:07 INFO - 'tpaint', 09:39:07 INFO - 'sessionrestore', 09:39:07 INFO - 'sessionrestore_no_auto_restore', 09:39:07 INFO - 'tabpaint']}, 09:39:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:07 INFO - 'ts_paint', 09:39:07 INFO - 'tpaint', 09:39:07 INFO - 'sessionrestore', 09:39:07 INFO - 'sessionrestore_no_auto_restore', 09:39:07 INFO - 'tabpaint']}, 09:39:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:07 INFO - 'ts_paint', 09:39:07 INFO - 'tpaint', 09:39:07 INFO - 'sessionrestore', 09:39:07 INFO - 'sessionrestore_no_auto_restore', 09:39:07 INFO - 'tabpaint']}, 09:39:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:07 INFO - 'ts_paint', 09:39:07 INFO - 'tpaint', 09:39:07 INFO - 'sessionrestore', 09:39:07 INFO - 'sessionrestore_no_auto_restore', 09:39:07 INFO - 'tabpaint']}, 09:39:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['a11yr', 09:39:07 INFO - 'ts_paint', 09:39:07 INFO - 'tpaint', 09:39:07 INFO - 'sessionrestore', 09:39:07 INFO - 'sessionrestore_no_auto_restore', 09:39:07 INFO - 'tabpaint']}, 09:39:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['a11yr', 09:39:07 INFO - 'ts_paint', 09:39:07 INFO - 'tpaint', 09:39:07 INFO - 'sessionrestore', 09:39:07 INFO - 'sessionrestore_no_auto_restore', 09:39:07 INFO - 'tabpaint']}, 09:39:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['tsvgx', 09:39:07 INFO - 'tsvgr_opacity', 09:39:07 INFO - 'tart', 09:39:07 INFO - 'tscrollx', 09:39:07 INFO - 'cart']}, 09:39:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:07 INFO - 'tsvgr_opacity', 09:39:07 INFO - 'tart', 09:39:07 INFO - 'tscrollx', 09:39:07 INFO - 'cart']}, 09:39:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'talos_options': ['--disable-e10s'], 09:39:07 INFO - 'tests': ['tp5o']}, 09:39:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'tests': ['tp5o']}, 09:39:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'talos_options': ['--disable-e10s', 09:39:07 INFO - '--xperf_path', 09:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:07 INFO - 'tests': ['tp5n']}, 09:39:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:07 INFO - 'talos_options': ['--xperf_path', 09:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:07 INFO - 'tests': ['tp5n']}}, 09:39:07 INFO - 'talos.zip': {'path': '', 09:39:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:07 INFO - Running post-action listener: _resource_record_post_action 09:39:07 INFO - [mozharness: 2017-02-21 17:39:07.386322Z] Finished populate-webroot step (success) 09:39:07 INFO - [mozharness: 2017-02-21 17:39:07.386409Z] Running create-virtualenv step. 09:39:07 INFO - Running pre-action listener: _resource_record_pre_action 09:39:07 INFO - Running main action method: create_virtualenv 09:39:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:07 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 09:39:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:07 INFO - Using real prefix '/usr' 09:39:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:09 INFO - Installing pip.................done. 09:39:09 INFO - Return code: 0 09:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:39:10 INFO - Reading from file tmpfile_stdout 09:39:10 INFO - Output received: 09:39:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:39:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:39:10 INFO - Using env: {'DISPLAY': ':0', 09:39:10 INFO - 'HOME': '/home/cltbld', 09:39:10 INFO - 'LANG': 'en_US.UTF-8', 09:39:10 INFO - 'LANGUAGE': 'en_US:en', 09:39:10 INFO - 'LOGNAME': 'cltbld', 09:39:10 INFO - 'MAIL': '/var/mail/cltbld', 09:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:10 INFO - 'MOZ_NO_REMOTE': '1', 09:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:10 INFO - 'NO_EM_RESTART': '1', 09:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:10 INFO - 'PWD': '/builds/slave/test', 09:39:10 INFO - 'SHELL': '/bin/bash', 09:39:10 INFO - 'SHLVL': '1', 09:39:10 INFO - 'TERM': 'linux', 09:39:10 INFO - 'TMOUT': '86400', 09:39:10 INFO - 'USER': 'cltbld', 09:39:10 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:10 INFO - '_': '/tools/buildbot/bin/python'} 09:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:10 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 09:39:10 INFO - Cleaning up... 09:39:10 INFO - Return code: 0 09:39:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:39:10 INFO - Using env: {'DISPLAY': ':0', 09:39:10 INFO - 'HOME': '/home/cltbld', 09:39:10 INFO - 'LANG': 'en_US.UTF-8', 09:39:10 INFO - 'LANGUAGE': 'en_US:en', 09:39:10 INFO - 'LOGNAME': 'cltbld', 09:39:10 INFO - 'MAIL': '/var/mail/cltbld', 09:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:10 INFO - 'MOZ_NO_REMOTE': '1', 09:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:10 INFO - 'NO_EM_RESTART': '1', 09:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:10 INFO - 'PWD': '/builds/slave/test', 09:39:10 INFO - 'SHELL': '/bin/bash', 09:39:10 INFO - 'SHLVL': '1', 09:39:10 INFO - 'TERM': 'linux', 09:39:10 INFO - 'TMOUT': '86400', 09:39:10 INFO - 'USER': 'cltbld', 09:39:10 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:10 INFO - '_': '/tools/buildbot/bin/python'} 09:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:10 INFO - Downloading/unpacking psutil>=3.1.1 09:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:12 INFO - Installing collected packages: psutil 09:39:12 INFO - Running setup.py install for psutil 09:39:12 INFO - building 'psutil._psutil_linux' extension 09:39:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:39:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:39:13 INFO - building 'psutil._psutil_posix' extension 09:39:13 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 09:39:13 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 09:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:13 INFO - Successfully installed psutil 09:39:13 INFO - Cleaning up... 09:39:13 INFO - Return code: 0 09:39:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:39:13 INFO - Using env: {'DISPLAY': ':0', 09:39:13 INFO - 'HOME': '/home/cltbld', 09:39:13 INFO - 'LANG': 'en_US.UTF-8', 09:39:13 INFO - 'LANGUAGE': 'en_US:en', 09:39:13 INFO - 'LOGNAME': 'cltbld', 09:39:13 INFO - 'MAIL': '/var/mail/cltbld', 09:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:13 INFO - 'MOZ_NO_REMOTE': '1', 09:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:13 INFO - 'NO_EM_RESTART': '1', 09:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:13 INFO - 'PWD': '/builds/slave/test', 09:39:13 INFO - 'SHELL': '/bin/bash', 09:39:13 INFO - 'SHLVL': '1', 09:39:13 INFO - 'TERM': 'linux', 09:39:13 INFO - 'TMOUT': '86400', 09:39:13 INFO - 'USER': 'cltbld', 09:39:13 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:13 INFO - '_': '/tools/buildbot/bin/python'} 09:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:15 INFO - Installing collected packages: mozsystemmonitor 09:39:15 INFO - Running setup.py install for mozsystemmonitor 09:39:15 INFO - Successfully installed mozsystemmonitor 09:39:15 INFO - Cleaning up... 09:39:15 INFO - Return code: 0 09:39:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:15 INFO - Using env: {'DISPLAY': ':0', 09:39:15 INFO - 'HOME': '/home/cltbld', 09:39:15 INFO - 'LANG': 'en_US.UTF-8', 09:39:15 INFO - 'LANGUAGE': 'en_US:en', 09:39:15 INFO - 'LOGNAME': 'cltbld', 09:39:15 INFO - 'MAIL': '/var/mail/cltbld', 09:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:15 INFO - 'MOZ_NO_REMOTE': '1', 09:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:15 INFO - 'NO_EM_RESTART': '1', 09:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:15 INFO - 'PWD': '/builds/slave/test', 09:39:15 INFO - 'SHELL': '/bin/bash', 09:39:15 INFO - 'SHLVL': '1', 09:39:15 INFO - 'TERM': 'linux', 09:39:15 INFO - 'TMOUT': '86400', 09:39:15 INFO - 'USER': 'cltbld', 09:39:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:15 INFO - '_': '/tools/buildbot/bin/python'} 09:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:18 INFO - warning: no files found matching '*.txt' 09:39:18 INFO - no previously-included directories found matching 'build' 09:39:18 INFO - no previously-included directories found matching 'dist' 09:39:18 INFO - no previously-included directories found matching '.git*' 09:39:18 INFO - Installing collected packages: jsonschema, functools32 09:39:18 INFO - Running setup.py install for functools32 09:39:18 INFO - warning: no files found matching '*.txt' 09:39:18 INFO - no previously-included directories found matching 'build' 09:39:18 INFO - no previously-included directories found matching 'dist' 09:39:18 INFO - no previously-included directories found matching '.git*' 09:39:18 INFO - Successfully installed jsonschema functools32 09:39:18 INFO - Cleaning up... 09:39:18 INFO - Return code: 0 09:39:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:39:18 INFO - Using env: {'DISPLAY': ':0', 09:39:18 INFO - 'HOME': '/home/cltbld', 09:39:18 INFO - 'LANG': 'en_US.UTF-8', 09:39:18 INFO - 'LANGUAGE': 'en_US:en', 09:39:18 INFO - 'LOGNAME': 'cltbld', 09:39:18 INFO - 'MAIL': '/var/mail/cltbld', 09:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:18 INFO - 'MOZ_NO_REMOTE': '1', 09:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:18 INFO - 'NO_EM_RESTART': '1', 09:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:18 INFO - 'PWD': '/builds/slave/test', 09:39:18 INFO - 'SHELL': '/bin/bash', 09:39:18 INFO - 'SHLVL': '1', 09:39:18 INFO - 'TERM': 'linux', 09:39:18 INFO - 'TMOUT': '86400', 09:39:18 INFO - 'USER': 'cltbld', 09:39:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:18 INFO - '_': '/tools/buildbot/bin/python'} 09:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:18 INFO - Cleaning up... 09:39:18 INFO - Return code: 0 09:39:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:39:18 INFO - Using env: {'DISPLAY': ':0', 09:39:18 INFO - 'HOME': '/home/cltbld', 09:39:18 INFO - 'LANG': 'en_US.UTF-8', 09:39:18 INFO - 'LANGUAGE': 'en_US:en', 09:39:18 INFO - 'LOGNAME': 'cltbld', 09:39:18 INFO - 'MAIL': '/var/mail/cltbld', 09:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:18 INFO - 'MOZ_NO_REMOTE': '1', 09:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:18 INFO - 'NO_EM_RESTART': '1', 09:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:18 INFO - 'PWD': '/builds/slave/test', 09:39:18 INFO - 'SHELL': '/bin/bash', 09:39:18 INFO - 'SHLVL': '1', 09:39:18 INFO - 'TERM': 'linux', 09:39:18 INFO - 'TMOUT': '86400', 09:39:18 INFO - 'USER': 'cltbld', 09:39:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:18 INFO - '_': '/tools/buildbot/bin/python'} 09:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:20 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:21 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 09:39:21 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 09:39:21 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 09:39:21 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 09:39:21 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 09:39:21 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 09:39:21 INFO - Downloading docopt-0.6.1.tar.gz 09:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:21 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:21 INFO - Running setup.py install for blobuploader 09:39:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:21 INFO - Running setup.py install for requests 09:39:22 INFO - Running setup.py install for docopt 09:39:22 INFO - Successfully installed blobuploader requests docopt 09:39:22 INFO - Cleaning up... 09:39:22 INFO - Return code: 0 09:39:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:22 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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:22 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 09:39:22 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 09:39:22 INFO - Using env: {'DISPLAY': ':0', 09:39:22 INFO - 'HOME': '/home/cltbld', 09:39:22 INFO - 'LANG': 'en_US.UTF-8', 09:39:22 INFO - 'LANGUAGE': 'en_US:en', 09:39:22 INFO - 'LOGNAME': 'cltbld', 09:39:22 INFO - 'MAIL': '/var/mail/cltbld', 09:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:22 INFO - 'MOZ_NO_REMOTE': '1', 09:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:22 INFO - 'NO_EM_RESTART': '1', 09:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:22 INFO - 'PWD': '/builds/slave/test', 09:39:22 INFO - 'SHELL': '/bin/bash', 09:39:22 INFO - 'SHLVL': '1', 09:39:22 INFO - 'TERM': 'linux', 09:39:22 INFO - 'TMOUT': '86400', 09:39:22 INFO - 'USER': 'cltbld', 09:39:22 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:22 INFO - '_': '/tools/buildbot/bin/python'} 09:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:22 INFO - Running setup.py (path:/tmp/pip-1AtQk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:22 INFO - Running setup.py (path:/tmp/pip-CcHfBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:22 INFO - Running setup.py (path:/tmp/pip-SfoqNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:22 INFO - Running setup.py (path:/tmp/pip-LFGHyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:22 INFO - Running setup.py (path:/tmp/pip-hNjx8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:22 INFO - Running setup.py (path:/tmp/pip-Cd5cHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:22 INFO - Running setup.py (path:/tmp/pip-Xq3gQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:23 INFO - Running setup.py (path:/tmp/pip-eNuMzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:23 INFO - Running setup.py (path:/tmp/pip-NGnVgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:23 INFO - Running setup.py (path:/tmp/pip-eP8eCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:23 INFO - Running setup.py (path:/tmp/pip-0CJkOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:23 INFO - Running setup.py (path:/tmp/pip-CRryP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:23 INFO - Running setup.py (path:/tmp/pip-zxV7G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:23 INFO - Running setup.py (path:/tmp/pip-k4wGmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:23 INFO - Running setup.py (path:/tmp/pip-wCcgGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:23 INFO - Running setup.py (path:/tmp/pip-itDt_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:23 INFO - Running setup.py (path:/tmp/pip-g8XkoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:23 INFO - Running setup.py install for manifestparser 09:39:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:23 INFO - Running setup.py install for mozcrash 09:39:23 INFO - Running setup.py install for mozdebug 09:39:24 INFO - Running setup.py install for mozdevice 09:39:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Running setup.py install for mozfile 09:39:24 INFO - Running setup.py install for mozhttpd 09:39:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Running setup.py install for mozinfo 09:39:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Running setup.py install for mozInstall 09:39:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Running setup.py install for mozleak 09:39:24 INFO - Running setup.py install for mozlog 09:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Running setup.py install for moznetwork 09:39:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:24 INFO - Running setup.py install for mozprocess 09:39:24 INFO - Running setup.py install for mozprofile 09:39:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:25 INFO - Running setup.py install for mozrunner 09:39:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:25 INFO - Running setup.py install for mozscreenshot 09:39:25 INFO - Running setup.py install for moztest 09:39:25 INFO - Running setup.py install for mozversion 09:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:25 INFO - Cleaning up... 09:39:25 INFO - Return code: 0 09:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:25 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 09:39:25 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 09:39:25 INFO - Using env: {'DISPLAY': ':0', 09:39:25 INFO - 'HOME': '/home/cltbld', 09:39:25 INFO - 'LANG': 'en_US.UTF-8', 09:39:25 INFO - 'LANGUAGE': 'en_US:en', 09:39:25 INFO - 'LOGNAME': 'cltbld', 09:39:25 INFO - 'MAIL': '/var/mail/cltbld', 09:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:25 INFO - 'MOZ_NO_REMOTE': '1', 09:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:25 INFO - 'NO_EM_RESTART': '1', 09:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:25 INFO - 'PWD': '/builds/slave/test', 09:39:25 INFO - 'SHELL': '/bin/bash', 09:39:25 INFO - 'SHLVL': '1', 09:39:25 INFO - 'TERM': 'linux', 09:39:25 INFO - 'TMOUT': '86400', 09:39:25 INFO - 'USER': 'cltbld', 09:39:25 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:25 INFO - '_': '/tools/buildbot/bin/python'} 09:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:25 INFO - Running setup.py (path:/tmp/pip-B09nFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:25 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)) 09:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:25 INFO - Running setup.py (path:/tmp/pip-ExO2sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:25 INFO - Running setup.py (path:/tmp/pip-_uTReN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:26 INFO - Running setup.py (path:/tmp/pip-SngSO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:26 INFO - Running setup.py (path:/tmp/pip-bISkvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:26 INFO - Running setup.py (path:/tmp/pip-cwohii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:26 INFO - Running setup.py (path:/tmp/pip-XMrZfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:26 INFO - Running setup.py (path:/tmp/pip-56DjIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:26 INFO - Running setup.py (path:/tmp/pip-8rcTiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:26 INFO - Running setup.py (path:/tmp/pip-btPHK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:26 INFO - Running setup.py (path:/tmp/pip-FIXC5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:26 INFO - Running setup.py (path:/tmp/pip-ribi1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:26 INFO - Running setup.py (path:/tmp/pip-FaAx5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:26 INFO - Running setup.py (path:/tmp/pip-0oy20E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:26 INFO - Running setup.py (path:/tmp/pip-VkFvf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:26 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:26 INFO - Running setup.py (path:/tmp/pip-gtyEJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:26 INFO - Running setup.py (path:/tmp/pip-OacdZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:27 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)) 09:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:27 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)) 09:39:27 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)) 09:39:27 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)) 09:39:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:29 INFO - Downloading blessings-1.6.tar.gz 09:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:29 INFO - Installing collected packages: blessings 09:39:29 INFO - Running setup.py install for blessings 09:39:29 INFO - Successfully installed blessings 09:39:29 INFO - Cleaning up... 09:39:29 INFO - Return code: 0 09:39:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:29 INFO - Reading from file tmpfile_stdout 09:39:29 INFO - Current package versions: 09:39:29 INFO - argparse == 1.2.1 09:39:29 INFO - blessings == 1.6 09:39:29 INFO - blobuploader == 1.2.4 09:39:29 INFO - docopt == 0.6.1 09:39:29 INFO - functools32 == 3.2.3-2 09:39:29 INFO - jsonschema == 2.5.1 09:39:29 INFO - manifestparser == 1.1 09:39:29 INFO - mozInstall == 1.12 09:39:29 INFO - mozcrash == 1.0 09:39:29 INFO - mozdebug == 0.1 09:39:29 INFO - mozdevice == 0.48 09:39:29 INFO - mozfile == 1.2 09:39:29 INFO - mozhttpd == 0.7 09:39:29 INFO - mozinfo == 0.9 09:39:29 INFO - mozleak == 0.1 09:39:29 INFO - mozlog == 3.4 09:39:29 INFO - moznetwork == 0.27 09:39:29 INFO - mozprocess == 0.23 09:39:29 INFO - mozprofile == 0.28 09:39:29 INFO - mozrunner == 6.13 09:39:29 INFO - mozscreenshot == 0.1 09:39:29 INFO - mozsystemmonitor == 0.3 09:39:29 INFO - moztest == 0.8 09:39:29 INFO - mozversion == 1.4 09:39:29 INFO - psutil == 3.1.1 09:39:29 INFO - requests == 1.2.3 09:39:29 INFO - wsgiref == 0.1.2 09:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:29 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')]} 09:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:29 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')]} 09:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:29 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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:29 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 09:39:29 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 09:39:29 INFO - Using env: {'DISPLAY': ':0', 09:39:29 INFO - 'HOME': '/home/cltbld', 09:39:29 INFO - 'LANG': 'en_US.UTF-8', 09:39:29 INFO - 'LANGUAGE': 'en_US:en', 09:39:29 INFO - 'LOGNAME': 'cltbld', 09:39:29 INFO - 'MAIL': '/var/mail/cltbld', 09:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:29 INFO - 'MOZ_NO_REMOTE': '1', 09:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:29 INFO - 'NO_EM_RESTART': '1', 09:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:29 INFO - 'PWD': '/builds/slave/test', 09:39:29 INFO - 'SHELL': '/bin/bash', 09:39:29 INFO - 'SHLVL': '1', 09:39:29 INFO - 'TERM': 'linux', 09:39:29 INFO - 'TMOUT': '86400', 09:39:29 INFO - 'USER': 'cltbld', 09:39:29 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:29 INFO - '_': '/tools/buildbot/bin/python'} 09:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 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)) 09:39:29 INFO - Cleaning up... 09:39:29 INFO - Return code: 0 09:39:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39:29 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')]} 09:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:29 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')]} 09:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:29 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 0x7feca69d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, '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': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', '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 09:39:29 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 09:39:29 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 09:39:29 INFO - Using env: {'DISPLAY': ':0', 09:39:29 INFO - 'HOME': '/home/cltbld', 09:39:29 INFO - 'LANG': 'en_US.UTF-8', 09:39:29 INFO - 'LANGUAGE': 'en_US:en', 09:39:29 INFO - 'LOGNAME': 'cltbld', 09:39:29 INFO - 'MAIL': '/var/mail/cltbld', 09:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:29 INFO - 'MOZ_NO_REMOTE': '1', 09:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:29 INFO - 'NO_EM_RESTART': '1', 09:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:29 INFO - 'PWD': '/builds/slave/test', 09:39:29 INFO - 'SHELL': '/bin/bash', 09:39:29 INFO - 'SHLVL': '1', 09:39:29 INFO - 'TERM': 'linux', 09:39:29 INFO - 'TMOUT': '86400', 09:39:29 INFO - 'USER': 'cltbld', 09:39:29 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:29 INFO - '_': '/tools/buildbot/bin/python'} 09:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:39:29 INFO - Cleaning up... 09:39:29 INFO - Return code: 0 09:39:29 INFO - Running post-action listener: _resource_record_post_action 09:39:29 INFO - Running post-action listener: _start_resource_monitoring 09:39:29 INFO - Starting resource monitoring. 09:39:29 INFO - [mozharness: 2017-02-21 17:39:29.976633Z] Finished create-virtualenv step (success) 09:39:29 INFO - [mozharness: 2017-02-21 17:39:29.977134Z] Running install step. 09:39:29 INFO - Running pre-action listener: _resource_record_pre_action 09:39:29 INFO - Running main action method: install 09:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:30 INFO - Reading from file tmpfile_stdout 09:39:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:30 INFO - Reading from file tmpfile_stdout 09:39:30 INFO - Output received: 09:39:30 INFO - Usage: mozinstall [options] installer 09:39:30 INFO - Options: 09:39:30 INFO - -h, --help show this help message and exit 09:39:30 INFO - -d DEST, --destination=DEST 09:39:30 INFO - Directory to install application into. [default: 09:39:30 INFO - "/builds/slave/test"] 09:39:30 INFO - --app=APP Application being installed. [default: firefox] 09:39:30 INFO - mkdir: /builds/slave/test/build/application 09:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:39:43 INFO - Reading from file tmpfile_stdout 09:39:43 INFO - Output received: 09:39:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:39:43 INFO - Running post-action listener: _resource_record_post_action 09:39:43 INFO - [mozharness: 2017-02-21 17:39:43.918651Z] Finished install step (success) 09:39:43 INFO - [mozharness: 2017-02-21 17:39:43.918894Z] Running run-tests step. 09:39:43 INFO - Running pre-action listener: _resource_record_pre_action 09:39:43 INFO - Running main action method: run_tests 09:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:43 INFO - Python 2.7.3 09:39:43 INFO - Return code: 0 09:39:43 INFO - grabbing minidump binary from tooltool 09:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3f60>, '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 0x11d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:39:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:39:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:39:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:43 INFO - Return code: 0 09:39:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:39:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:39:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 09:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 09:39:44 INFO - Using env: {'DISPLAY': ':0', 09:39:44 INFO - 'HOME': '/home/cltbld', 09:39:44 INFO - 'LANG': 'en_US.UTF-8', 09:39:44 INFO - 'LANGUAGE': 'en_US:en', 09:39:44 INFO - 'LOGNAME': 'cltbld', 09:39:44 INFO - 'MAIL': '/var/mail/cltbld', 09:39:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:44 INFO - 'MOZ_NO_REMOTE': '1', 09:39:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:44 INFO - 'NO_EM_RESTART': '1', 09:39:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:44 INFO - 'PWD': '/builds/slave/test', 09:39:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:44 INFO - 'SHELL': '/bin/bash', 09:39:44 INFO - 'SHLVL': '1', 09:39:44 INFO - 'TERM': 'linux', 09:39:44 INFO - 'TMOUT': '86400', 09:39:44 INFO - 'USER': 'cltbld', 09:39:44 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1487698730.213700-86446525', 09:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:44 INFO - '_': '/tools/buildbot/bin/python'} 09:39:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 09:39:44 INFO - mozversion application_buildid: 20170221075028 09:39:44 INFO - mozversion application_changeset: 68546cbfc3e025042f2c26eb0a1caca91de407b1 09:39:44 INFO - mozversion application_display_name: Firefox 09:39:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:44 INFO - mozversion application_name: Firefox 09:39:44 INFO - mozversion application_remotingname: firefox 09:39:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:44 INFO - mozversion application_vendor: Mozilla 09:39:44 INFO - mozversion application_version: 52.0 09:39:44 INFO - mozversion platform_buildid: 20170221075028 09:39:44 INFO - mozversion platform_changeset: 68546cbfc3e025042f2c26eb0a1caca91de407b1 09:39:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:44 INFO - mozversion platform_version: 52.0 09:39:44 INFO - using testdate: 1487698784 09:39:44 INFO - actual date: 1487698784 09:39:44 INFO - starting webserver on 'localhost:44398' 09:39:44 INFO - SUITE-START | Running 2 tests 09:39:44 INFO - TEST-START | dromaeo_css 09:39:44 INFO - operating with platform_type : linux_ 09:39:44 INFO - Initialising browser for dromaeo_css test... 09:39:44 INFO - TEST-INFO | started process 21507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8atUfg/profile http://localhost:44398/getInfo.html) 09:39:48 INFO - PROCESS | 21507 | __metrics Screen width/height:1600/1200 09:39:48 INFO - PROCESS | 21507 | colorDepth:24 09:39:48 INFO - PROCESS | 21507 | Browser inner width/height: 1024/697 09:39:48 INFO - PROCESS | 21507 | __metrics 09:39:49 INFO - PROCESS | 21507 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:39:49 INFO - PROCESS | 21507 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:39:49 INFO - PROCESS | 21507 | console.error: PushService: 09:39:49 INFO - PROCESS | 21507 | stateChangeProcessEnqueue: Error transitioning state 09:39:49 INFO - PROCESS | 21507 | UnknownError 09:39:50 INFO - TEST-INFO | 21507: exit 0 09:39:50 INFO - Browser initialized. 09:39:50 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:50 INFO - TEST-INFO | started process 21600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8atUfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:02 INFO - PROCESS | 21600 | RSS: Main: 142303232 09:40:02 INFO - PROCESS | 21600 | 09:43:03 INFO - PROCESS | 21600 | Cycle 1(1): loaded http://localhost:44398/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44398/tests/dromaeo/cssquery-ext.html) 09:43:04 INFO - PROCESS | 21600 | RSS: Main: 256675840 09:43:04 INFO - PROCESS | 21600 | 09:46:06 INFO - PROCESS | 21600 | Cycle 1(1): loaded http://localhost:44398/tests/dromaeo/cssquery-ext.html (next: http://localhost:44398/tests/dromaeo/cssquery-jquery.html) 09:46:07 INFO - PROCESS | 21600 | RSS: Main: 231809024 09:46:07 INFO - PROCESS | 21600 | 09:49:09 INFO - PROCESS | 21600 | Cycle 1(1): loaded http://localhost:44398/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44398/tests/dromaeo/cssquery-mootools.html) 09:49:10 INFO - PROCESS | 21600 | RSS: Main: 245157888 09:49:10 INFO - PROCESS | 21600 | 09:52:11 INFO - PROCESS | 21600 | Cycle 1(1): loaded http://localhost:44398/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44398/tests/dromaeo/cssquery-prototype.html) 09:52:12 INFO - PROCESS | 21600 | RSS: Main: 235745280 09:52:12 INFO - PROCESS | 21600 | 09:55:15 INFO - PROCESS | 21600 | Cycle 1(1): loaded http://localhost:44398/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44398/tests/dromaeo/cssquery-yui.html) 09:55:15 INFO - PROCESS | 21600 | RSS: Main: 173232128 09:55:15 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | Cycle 1(1): loaded http://localhost:44398/tests/dromaeo/cssquery-yui.html (next: http://localhost:44398/tests/dromaeo/cssquery-dojo.html) 09:58:18 INFO - PROCESS | 21600 | RSS: Main: 265490432 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | __start_tp_report 09:58:18 INFO - PROCESS | 21600 | _x_x_mozilla_page_load 09:58:18 INFO - PROCESS | 21600 | _x_x_mozilla_page_load_details 09:58:18 INFO - PROCESS | 21600 | |i|pagename|runs| 09:58:18 INFO - PROCESS | 21600 | |0;dojo.html;3185.8247796371197;3202.7597930155243;3227.790193637414;3230.709236168744;3241.918952026199;5522.199281104243;5616.550675945925;5617.550595952319;5630.211770352154;5630.605857589971;5586.24585680933;5651.1523271509295;5656.2929633795675;5657.490825825675;5691.174779656947;5113.054084994279;5140.228965655144;5161.6958860096265;5186.533212010918;5208.0885844977165;4965.205567109263;5006.173981293082;5014.423341315759;5162.457941916101;5190.455002224769;4998.075356059123;5092.388913330406;5100.540951314381;5159;5164.6384753067305;5171.301874246966;5175.094358487268;5183.352080989876;5185;5208.791648334062;4883.4628190898975;4922;5002.849914502571;5075.873103172414;5082.23766435034;5404.648697834628;5456.508914197741;5459.645123066988;5494.395616482184;5514.283143191399;5916.704164791743;5951.851203719898;5957.493613042897;5958.165856780054;5968.1644569760265;5766.740496677659;5827.35899051104;5958.314793798682;6002.249718785152;6009.399060094;5555.861103472405;5615.101583746622;5618.831435056954;5640.8871822563315;5664.54683625309;6170.475509581735;6172;6184.845378865564;6185.257769067741;6194.566380353423;5720.2849643794525;5775.971120144456;5933.2286802716235;5938.257717785277;5946.583739138306;5859;5886.882262354815;5920.259967504062;5983.970080149658;6004.609700369462;5919.970400147971;5934.881302374015;5936.7328470218945;5937.376575459601;5938.762449501972;5744.626599271118;5751.194832723422;5948.702564871739;5954.3152537458745;5988.131720900445;4615.561521655437;4616.3306320584;4638.744869032168;4695.671303008757;4705.4588722296685;4143.958560414418;4148.79256037203;4155.148194620156;4159.688023398257;4174.895627609334;5536.474034966672;5773.249477567973;5785.913211301834;5794.739236734357;5842.766289348378;5855.502282305966;5913.05391137416;5965.492933100648;5974.3428222895445;6062.2725272966645;5697.772089116389;5727.742251598688;5735.741891614887;5740.712964351766;5742.138679198154;5193.974030129825;5208.348956380452;5216.426193118754;5216.478352164753;5239.214117882349;5983.311919129356;5993.9700301498215;6138.357744607992;6149.446549810538;6201.81394558173;6049.425304596057;6050.485708714808;6050.6369617823075;6056.939430605637;6078.45293923549;6257.78097766576;6283.717232724447;6287.74849006053;6291.1192433058495;6302.054691796267;5671.631343962629;5697.54419646419;5881.206037184926;5932.762689492372;5945.435183657545;6032.607880487754;6035.637861728311;6037.45662890342;6049.879002419839;6076.058210977306;5783.7397317119985;5855.38518455556;5870.14882841994;5874.530037597067;5879.73541190656;5671.574631902541;5684.147377893184;5772.653640781398;5811.593188476766;5836.037053886231;5841.853953651193;5845.912311315248;5846.853828654318;5857.912131318119;5871.412858714094;5903.970480147572;5905.379935106752;5907.143464197753;5907.556933230111;5924.081767326072;5596.244506991504;5638.4925356718095;5652.4064973178865;5673.517750991047;5699.772009119589 09:58:18 INFO - PROCESS | 21600 | |1;ext.html;580.2253990922119;622.5268795715257;649.3344322069879;654.9476041916647;663.4924282923562;33280.33439331215;36316.63683363166;36332.455013174826;36361.63638363622;36369.818150909276;36414;45370;46176.53823461773;46406.76796616012;49265.50734492654;8836.204741573274;8955.776105597379;8965.506897120657;8969.551522423886;8972.551372431384;8410.201030902084;8890.288776897865;9003.819923601524;9009.549522523848;9028.638854445815;8375.664973401057;10589.947050264776;10835.079018283455;10844.67465976018;11133;10691.732706682356;10746.731331716692;10762.35425874446;10772.784544309108;10776.030157285804;10675.786484270271;10741.570337186504;10748.73128171794;10763.892361076367;10773.084287835543;43532.782336088436;43824;43900.146490478015;43934.56065439337;44003;3576.2311103112957;3719.851205951759;3795.1840354323676;3941.605839416064;4152.065785198306;32455;32635;32762.180945476317;32818.3436331272;32848.3430331392;4508.143452743968;4567.497575266718;4730.62155027597;4784.856454306377;4799.304100905384;328867;329116;329177;330328;330910.9999999976;37124;38396.23207535833;38432.231355372736;59603.701981489816;59839;40527;40580.79709601433;40592.39111413331;40613;40660.1867962645;16397;16469;16494;16503;16512.75230871538;13941.024128311125;13958.371873265525;13961.581152565439;14011.789823152661;14018.018738688397;8718.95640521806;9024.774380640405;9026.142516460926;9519.143277105093;9595.904040959502;3587.892363229107;3593;3623.8550457981914;3629.455581662719;3689.612590677994;1015.3653966271081;1020.7754294055296;1031.7523794289316;1051.5898799468214;1055.3748520386475;31616.841915790275;31707.36585268282;31987.840060800012;32081.420874077125;32250.35499290048;1129.390129330169;1145.352875625269;1163.627639155462;1193.5106606291379;1200.8739082396398;16072.598185045468;16687.91656041736;17091.230894609773;17263.939555750847;17282.913585431994;513631;518336;519607;520616;521661;58631;58885;60063.69968150131;60279.09581356283;61381;1400.3418393355107;1423.7579611466076;1428.8428272889973;1438.3814959567278;1452.0126314106299;30675;32544.34911301808;32764.50853237251;33077.17307067246;33246.667533324355;51061;52318;52361.21458178054;52489.21266181087;52869.47130528645;407554;451851;458982;607310;614794;28404.715952840208;28528.42943141084;28629.141125766262;28790;28811.85594072016;45632.54367456416;46479;46525.3021204689;46651.53348466472;46769.766151169024;39580.80209598933;39731;39831.40252896151;40451.59548404596;42048.15903681971;39351.80324098476;39580.60419395769;39711.80144099377;41398.1720365597;41414.58585414107;39067.609323907534;39457.21085578215;40397.798011009756;40485;40495.79752101221;32276.19309517281;34929.65070349264;35004.299914002084;35892.64107358998;36144.27711445809;26657.600135998364;27053.72946270512;27214.455710886068;27250;27502.587461187697 09:58:18 INFO - PROCESS | 21600 | |2;jquery.html;414.74700432736006;416.55844804507245;422.98308067677294;436.3781611204033;439.7647258716585;18772.718409223857;18948.715769263472;19977.60044799103;20069.197232110735;20171.59656806865;18952;19077;19220.519487012833;19301.13144908479;19355.516112097204;5312.70780107093;5594.384617692071;5622.437756224385;5692.6299790513485;5701.372848986608;5580.469855363734;5624.606277560552;5626;5630.802921897734;5894.086416605433;6120.20437343147;6259.874802503947;6270.780522681707;6271;6271.027990661455;6028.6684232367425;6113.23584551931;6165.969170154121;6255.62466252024;6268.561200715929;5990.371011043865;5994.250718660168;5997.910031349533;5999.250093738283;5999.490043346321;18339.26642934281;23501.41246468835;23579.646305305436;23613.645795313085;23849.523009539884;2292.289390289016;2375.845570037942;2447.4003869052017;2506.7994560435122;2558.255327623987;9698;10922.29005114665;11197.272177308449;11284.435778211138;13514.391852366667;1817.854571634266;1827.0681952204338;1876.7841698204609;1908.7709474862966;1926.4413320137144;83539.5823020887;83547.91135204048;84137.15862841415;84449.57775211147;84489.15510844935;11320;11628.069754419626;11672.182947193785;11774.116941229442;11839.11206659504;17008.57478563046;17012.06433646161;17022.404215852384;17041.659166816593;17068.31726730917;8314.043884953307;8647.481151130953;8752.69365572202;8755.737327880173;8778.692745753868;8432.747017589481;8471.95764021176;8480.787980300542;8624.482531048032;8670.696525621574;4774.40319960005;4839.951600484021;5018.84943451697;5097.260897169964;5224.869378265574;1964.8231659150745;1996.5807180492259;1999.6500612392774;2006.1173083843062;2099.2967355935934;970.2722957781664;984.1388784813288;993;1016.11090295991;1026.2200727447193;18139.18373673188;19865.503362416057;19933.501662458264;20146.89926550358;20219.696704549442;1012.2307046644456;1031.159604921986;1048.7640280936728;1073.1629329123296;1080.773037662084;10377.429241391796;11159.776804463865;11174.66476005721;11205.60780372683;11223.775524489465;444775;445980;449140.2628960568;461318;462855;87739;90316;97453;99756.5012174949;103657.48171259096;1052.1057101463848;1063.4948399510172;1080.0765345629375;1100.7963526747578;1101.9559217631365;17348.653026939643;17708.91145544264;18071.548211294823;18110.81889181091;18119.275228990693;33832.66167338295;38638.613613863505;41119.177616446905;41140.97147571335;41637.268833659706;60019;60757.392426075174;60804;61084.38915610787;62189.68905155445;8726.476411415335;8955.686550970684;9039.774005649911;9040.41237319572;9166.495842728715;12344.75310493803;12609.87390126087;13030.348482575644;13082.738345233232;13532.86467135316;11487.712807179887;11597.536098555964;11715.414229288332;11805.881941180822;12106.394680266128;11322.490487928228;11515.654530364103;11547;11797.705057373634;11964.880351196376;11015.173861960226;11402.600908968147;11492.482838272465;11850.407479625812;12064.155509114278;8747.956260218658;8864.20222180007;8908.73273801787;9132.36073474877;9228.723138305593;9118.498482583256;11293.71765705831;11479.4260286987;11544.19190656646;11613.3612651305 09:58:18 INFO - PROCESS | 21600 | |3;mootools.html;1337.7592033433978;1478.2239324354716;1511.6901035287767;1653.214723006572;1810.3844692804453;7418.591977441239;7969.68121275149;8395.076541580422;8414.116517765638;8612.483251004944;8470.152984701526;8518.27594654455;8530.829383412329;8533.018702849175;8549.316054715624;2416.6375043743406;2445.559799236146;2447.278052974377;2449.2652204338715;2450.13020377766;2424.665686308257;2476.9101595298102;2477.6407420923956;2479.6528486011885;2487.3781554611346;2344.8006919411787;2369.1471070414636;2377.061060880951;2379.0364902214546;2390.1873363056557;2247.3932038349717;2274.5678321118935;2289.3360925331635;2314.5486630107134;2319.188284100568;2330.0097458580035;2351.7883390494767;2367.786899179065;2368.4315764216635;2371.454565449939;8165.1426600207315;8348.457350272274;8417.326613870875;8493.617787199591;8495.44779589331;5155.149400348938;5391.703456309901;5395.271638328814;5397.62216644835;5397.7031263280505;3354.127926739041;3422.5550678411896;3461.913452163716;3476.843542040589;3552.0587044433246;1202.0744027099086;1212.818077288405;1223.2171410297417;1234.3396282988558;1265.5633806336798;10825.783484330348;10898.291611045257;10928.453577321103;10949.726256843642;10968.725781855357;4295.763732994716;4447.3329000650165;4565.589096981287;4607.216773148572;4629.583337499641;9031.096890310917;9032.45805251687;9036.774080648036;9043.954780226188;9051.411658242194;5171.81898633546;5195.220716892496;5202.687838729688;5204;5210.53105220532;4144.357624568136;4283.528811830696;4350.129974005212;4387.5393083726385;4852.636052296092;3698.852045918187;3719.0702324418894;3850.0952276215066;3852.653261206449;3858.479105320746;1237.5854088880146;1245.2466257914014;1245.4333278358506;1248.2822377133184;1269.041873385588;947.2280091725222;954.8854137503544;955.2644463762864;959.7792507723124;976.951152442375;5775.682337471395;5882.882342353129;5933;5951.642901425928;5964.1650168976375;497.62926619668576;498.88026873550086;500.384527031753;500.3970215889844;503.3908970146091;4201.159768046403;4227.450431443893;4256.489221293465;4324.437823082979;4325.84859529915;9986.151177150025;10223.284370094021;10310.742231444125;10316.43259620728;10333.328333658288;9475.431474111576;9892.80214395708;9901;10218.744531386776;10252.538635761408;7862.174471680506;8060.637271322805;8062.153473885158;8063.395245356622;8064.395170362246;5795.391483894299;5804.361520232856;5901.645901245939;5954.553408494294;6120.60216085953;9165.450072995642;9275.72172834816;9314.95342523283;9351.018143094878;9490.952545237229;8247.587620618826;8459.577021149042;9562.521873906417;9663.082007209305;9669.468179250209;6920.826979325557;6932.445404367538;7088;7096.574205547684;7185.640717963976;7785.649645766068;7990.92009079925;8068.273855352812;8083.434159608771;8120.14738452454;7368.042154519878;7479.775606731807;7502.287282708134;7546;7606.619669016416;7279.745208917662;7381.926180738339;7532.096148462;7647.158812530728;7683.039620047494;6895.241523432318;6971;7049.718011279491;7096;7097.609631470319;5011.4236862761245;5170.6380553360905;5406.567474602101;5417;5427.701476418835;5176.352955880515;5242.737863106753;5318.0959236930585;5365.65123267002;5451.672899626035 09:58:18 INFO - PROCESS | 21600 | |4;prototype.html;334.2296007702247;348.25473486738366;353.23877044968094;353.5439283324512;354.39752420884486;5357.8392648220515;5493.2034854946005;5514.862128446791;5523.9999999999945;5537.473939975695;5376.892462150755;5404.32445944257;5420.620556561043;5421.647592906468;5435;4032.802122843043;4286.035641980545;4287.292596721552;4294.947737804242;4358.912821743564;3781.338265803487;4141.834326626931;4195.307774217251;4197.685173611976;4220.957790422087;4161.500619925613;4163.542010378856;4167.45823043004;4167.83328666853;4172.687048471362;4170.7279279819795;4185.372194170868;4187.288161012635;4204.285271503852;4208.074223670787;3651.507046548735;3677.7128005198233;3693.741438099334;3733.757305775116;3747.2505498900055;5261.86845328866;5271.207789351639;5287.391949925769;5288.524032837063;5310.362756469249;4807.302941073524;4842.176829938919;4844.442889067767;4860.441049279308;4866.245731911559;5470.699111548864;5634.3520495143175;5649.435056494318;5688.203651488795;5694.715264236772;4097.918041639151;4104.4664193654635;4104.6044344922575;4107.794610269475;4121.752694838319;5641.68970706611;5840.6053518057815;5901.704914754245;5929.466348028655;5947.464728174485;4051.331530297527;4164.91670166601;4165.75005499671;4169.145325208325;4172.311568591209;4191.266528357525;4214.115035842446;4230.682698797603;4236.851710190129;4237.427947227146;4593.28804035375;4796.2805579162705;4813.229883218668;4822.493638167942;4840.903181936342;5655.773769049274;5722.456366645162;5730.455606717355;5730.627509211971;5731.197632331394;1417.3409364645283;1427.229296180072;1427.3291552970088;1433.5699290212895;1438.3671184678708;942.2603256443659;970.8106919150698;976.5019839881711;980.6126580001003;992.9226788933943;5319.973400132974;5327.413984461706;5344.625876188629;5360.437154098841;5367.490088441592;5565.749541270652;5651.237082993744;5684.602077854511;5699.031164702011;5700.25896633435;5125.052480057629;5316.893662126813;5384.492342144206;5387.1649894265665;5397.136458166675;3001.3342594860064;3011.472992226352;3018.2907016851022;3024.516077427601;3025.7579393648457;5761.803695069774;5845.561582881301;5874.295084589877;5901.704914754245;5925.34821169671;5552.666839989613;5650.971745141248;5726.911886741505;5756.740946657411;5764.308283005982;5848.795292164839;5860.794872179454;5890.705464726747;5890.9999999999145;5912.733926973297;5453.400125986218;5584.078627026658;5609.915851262316;5634.408387119293;5693.722510995635;5550.69471179089;5561.249231353877;5564.1931919870585;5652.830415087554;5666.660000399989;5824.242848429846;5926.851828704317;5945.464908158287;6043.607165534227;6072.089186622042;4198.4961804583645;4200.6219440250525;4200.85297014603;4226.535081141011;4248.34150706641;5723.225800002013;5939.792107276225;5959.731812068554;5971.701414929323;5971.91042134377;5732.627379220337;5746.339170995389;5748.511376533042;5750.712464376848;5757.107648314518;5649.485978739422;5681.659100453986;5684.573656975661;5701.686407247641;5725.740337125826;5377.677339359651;5564.860878478071;5587.636803607753;5595.160725891149;5646.181303711021;5627.833284185536;5698.487136157766;5705.686187259741;5706.543476521952;5711.8576284742385;5531.280933478622;5557.44425557441;5560.46998615637;5571.3871474137;5571.916421253765 09:58:18 INFO - PROCESS | 21600 | |5;yui.html;792.4928046050533;792.5046845721424;808.6482380164625;815.5636734347124;876.9298456123511;13241.668958276048;13750.449982000708;13853.722925541482;13899.30503474826;13917.37371818268;12315.261084334947;12364.443600037997;12367.567135150271;12374.071944604146;12399.442025108869;714.3071220915704;734.0054226523065;821.2772759971217;842.7219017724152;853.7012045783988;862.2843040276556;863.201538576817;863.4732812984074;864.0279685353977;865.7748985263813;903.4759839293195;904.8506996345595;911.7857303533664;913.2876356441952;913.6162811619135;902.4630344944748;911.1162172692544;911.9088091190828;912.2200518556605;912.2291663544295;663.5322097921003;664.6444152378502;668.4284936379374;669.2838662630987;669.6919417068154;12989.350532473338;13288.667783305398;13308.866911330859;13327.26700031498;13337.133086349453;13649.666483443023;14194.85805141956;14264.857351426457;14275.21486318252;14352.06711563745;11300;11477.885221147764;11587.768244635145;11687.240329378648;11713.180077394585;3603.387424137903;3638.9272214555563;3642.3807952648112;3659.304732100892;3756.0234339071767;60517.39482605162;60861;60941.69529152326;62306.0654090189;62991;10534.20993425496;10854.78290434187;10915.890841091488;11061;11164.553417863357;19931.701024484646;20038.59922801536;20071.29750458727;20098.79901200969;20122.19511219535;7207.675654595556;7420.5176663516695;7482.625868706652;7601.46789724725;7700.075990881131;4494;4521.525239849834;4575.839845605455;4620.168369693488;4649.721016739007;3148.087054754096;3246.8376581170846;3252.463343548335;3262.9021129366156;3266.2487627845253;560.1150182711307;560.1737437280061;560.5095541401274;566.9971650141723;580.5645765675744;636.6880228688002;695.4401706626113;734.1300558837687;743.1490942870383;763.9274268944441;8401.579921003926;8462.746117616482;8685.174908383693;8794.824103517894;9032.412893161923;646.977355792545;703.9401650859631;724.5543990445838;741.5847125609675;742.3764038207931;4229.873103806891;4339.132173565299;4371.825126994948;4380.802863871069;4469.374287599739;80201;89739.63865575516;90692;92334.15331693462;92497.537512312;60669.69665151734;63150.36849631445;78875.60562197152;79026;79577.20422795814;65603.67198164074;65788;68562;68687.31312686909;69280.30719692839;9014.954925225333;9205.225125622912;9280.443173409618;9328.300377471853;9404.952975235354;43503;44736;45269.32096018628;46020;46055;54098.72950635222;54529;59779.70110149421;62345.37654623577;62710.37289627228;11296.717582060186;11380.886191137983;11452.14108941816;11607.477663504993;12135.332556709465;13651.180929144282;13794.448222071005;13991.58025259244;14269.500567480089;14547.709045819236;11741.882581174079;12347.320897350732;12706.555270565486;13231.735365292448;13568;11666.241694290184;11883.940580297043;12035.638930832089;12123.393830308272;12187.451564679433;10142.949285253526;11957.738595018163;11968.341741204318;12332.136750427384;12760.6809829755;10848.728781780519;10856.891431085589;10942.288751231144;11053.889461105286;11209.327440353605;10962.616308429167;11055.336679799238;11136.944315278372;11172.832407513732;11304.095672346028 09:58:18 INFO - PROCESS | 21600 | __end_tp_report 09:58:18 INFO - PROCESS | 21600 | __start_cc_report 09:58:18 INFO - PROCESS | 21600 | _x_x_mozilla_cycle_collect,1115 09:58:18 INFO - PROCESS | 21600 | __end_cc_report 09:58:18 INFO - PROCESS | 21600 | __startTimestamp1487699898518__endTimestamp 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | ------- Summary: start ------- 09:58:18 INFO - PROCESS | 21600 | Number of tests: 6 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | [#0] dojo.html Cycles:165 Average:5560.59 Median:5751.19 stddev:621.05 (10.8%) stddev-sans-first:594.35 09:58:18 INFO - PROCESS | 21600 | Values: 3185.8 3202.8 3227.8 3230.7 3241.9 5522.2 5616.6 5617.6 5630.2 5630.6 5586.2 5651.2 5656.3 5657.5 5691.2 5113.1 5140.2 5161.7 5186.5 5208.1 4965.2 5006.2 5014.4 5162.5 5190.5 4998.1 5092.4 5100.5 5159.0 5164.6 5171.3 5175.1 5183.4 5185.0 5208.8 4883.5 4922.0 5002.8 5075.9 5082.2 5404.6 5456.5 5459.6 5494.4 5514.3 5916.7 5951.9 5957.5 5958.2 5968.2 5766.7 5827.4 5958.3 6002.2 6009.4 5555.9 5615.1 5618.8 5640.9 5664.5 6170.5 6172.0 6184.8 6185.3 6194.6 5720.3 5776.0 5933.2 5938.3 5946.6 5859.0 5886.9 5920.3 5984.0 6004.6 5920.0 5934.9 5936.7 5937.4 5938.8 5744.6 5751.2 5948.7 5954.3 5988.1 4615.6 4616.3 4638.7 4695.7 4705.5 4144.0 4148.8 4155.1 4159.7 4174.9 5536.5 5773.2 5785.9 5794.7 5842.8 5855.5 5913.1 5965.5 5974.3 6062.3 5697.8 5727.7 5735.7 5740.7 5742.1 5194.0 5208.3 5216.4 5216.5 5239.2 5983.3 5994.0 6138.4 6149.4 6201.8 6049.4 6050.5 6050.6 6056.9 6078.5 6257.8 6283.7 6287.7 6291.1 6302.1 5671.6 5697.5 5881.2 5932.8 5945.4 6032.6 6035.6 6037.5 6049.9 6076.1 5783.7 5855.4 5870.1 5874.5 5879.7 5671.6 5684.1 5772.7 5811.6 5836.0 5841.9 5845.9 5846.9 5857.9 5871.4 5904.0 5905.4 5907.1 5907.6 5924.1 5596.2 5638.5 5652.4 5673.5 5699.8 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | [#1] ext.html Cycles:180 Average:59930.01 Median:20406.81 stddev:123252.92 (604.0%) stddev-sans-first:123518.12 09:58:18 INFO - PROCESS | 21600 | Values: 580.2 622.5 649.3 654.9 663.5 33280.3 36316.6 36332.5 36361.6 36369.8 36414.0 45370.0 46176.5 46406.8 49265.5 8836.2 8955.8 8965.5 8969.6 8972.6 8410.2 8890.3 9003.8 9009.5 9028.6 8375.7 10589.9 10835.1 10844.7 11133.0 10691.7 10746.7 10762.4 10772.8 10776.0 10675.8 10741.6 10748.7 10763.9 10773.1 43532.8 43824.0 43900.1 43934.6 44003.0 3576.2 3719.9 3795.2 3941.6 4152.1 32455.0 32635.0 32762.2 32818.3 32848.3 4508.1 4567.5 4730.6 4784.9 4799.3 328867.0 329116.0 329177.0 330328.0 330911.0 37124.0 38396.2 38432.2 59603.7 59839.0 40527.0 40580.8 40592.4 40613.0 40660.2 16397.0 16469.0 16494.0 16503.0 16512.8 13941.0 13958.4 13961.6 14011.8 14018.0 8719.0 9024.8 9026.1 9519.1 9595.9 3587.9 3593.0 3623.9 3629.5 3689.6 1015.4 1020.8 1031.8 1051.6 1055.4 31616.8 31707.4 31987.8 32081.4 32250.4 1129.4 1145.4 1163.6 1193.5 1200.9 16072.6 16687.9 17091.2 17263.9 17282.9 513631.0 518336.0 519607.0 520616.0 521661.0 58631.0 58885.0 60063.7 60279.1 61381.0 1400.3 1423.8 1428.8 1438.4 1452.0 30675.0 32544.3 32764.5 33077.2 33246.7 51061.0 52318.0 52361.2 52489.2 52869.5 407554.0 451851.0 458982.0 607310.0 614794.0 28404.7 28528.4 28629.1 28790.0 28811.9 45632.5 46479.0 46525.3 46651.5 46769.8 39580.8 39731.0 39831.4 40451.6 42048.2 39351.8 39580.6 39711.8 41398.2 41414.6 39067.6 39457.2 40397.8 40485.0 40495.8 32276.2 34929.7 35004.3 35892.6 36144.3 26657.6 27053.7 27214.5 27250.0 27502.6 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | [#2] jquery.html Cycles:180 Average:28370.00 Median:12994.75 stddev:75030.50 (577.4%) stddev-sans-first:75211.62 09:58:18 INFO - PROCESS | 21600 | Values: 414.7 416.6 423.0 436.4 439.8 18772.7 18948.7 19977.6 20069.2 20171.6 18952.0 19077.0 19220.5 19301.1 19355.5 5312.7 5594.4 5622.4 5692.6 5701.4 5580.5 5624.6 5626.0 5630.8 5894.1 6120.2 6259.9 6270.8 6271.0 6271.0 6028.7 6113.2 6166.0 6255.6 6268.6 5990.4 5994.3 5997.9 5999.3 5999.5 18339.3 23501.4 23579.6 23613.6 23849.5 2292.3 2375.8 2447.4 2506.8 2558.3 9698.0 10922.3 11197.3 11284.4 13514.4 1817.9 1827.1 1876.8 1908.8 1926.4 83539.6 83547.9 84137.2 84449.6 84489.2 11320.0 11628.1 11672.2 11774.1 11839.1 17008.6 17012.1 17022.4 17041.7 17068.3 8314.0 8647.5 8752.7 8755.7 8778.7 8432.7 8472.0 8480.8 8624.5 8670.7 4774.4 4840.0 5018.8 5097.3 5224.9 1964.8 1996.6 1999.7 2006.1 2099.3 970.3 984.1 993.0 1016.1 1026.2 18139.2 19865.5 19933.5 20146.9 20219.7 1012.2 1031.2 1048.8 1073.2 1080.8 10377.4 11159.8 11174.7 11205.6 11223.8 444775.0 445980.0 449140.3 461318.0 462855.0 87739.0 90316.0 97453.0 99756.5 103657.5 1052.1 1063.5 1080.1 1100.8 1102.0 17348.7 17708.9 18071.5 18110.8 18119.3 33832.7 38638.6 41119.2 41141.0 41637.3 60019.0 60757.4 60804.0 61084.4 62189.7 8726.5 8955.7 9039.8 9040.4 9166.5 12344.8 12609.9 13030.3 13082.7 13532.9 11487.7 11597.5 11715.4 11805.9 12106.4 11322.5 11515.7 11547.0 11797.7 11964.9 11015.2 11402.6 11492.5 11850.4 12064.2 8748.0 8864.2 8908.7 9132.4 9228.7 9118.5 11293.7 11479.4 11544.2 11613.4 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | [#3] mootools.html Cycles:180 Average:5543.27 Median:5280.42 stddev:2989.00 (56.6%) stddev-sans-first:2980.67 09:58:18 INFO - PROCESS | 21600 | Values: 1337.8 1478.2 1511.7 1653.2 1810.4 7418.6 7969.7 8395.1 8414.1 8612.5 8470.2 8518.3 8530.8 8533.0 8549.3 2416.6 2445.6 2447.3 2449.3 2450.1 2424.7 2476.9 2477.6 2479.7 2487.4 2344.8 2369.1 2377.1 2379.0 2390.2 2247.4 2274.6 2289.3 2314.5 2319.2 2330.0 2351.8 2367.8 2368.4 2371.5 8165.1 8348.5 8417.3 8493.6 8495.4 5155.1 5391.7 5395.3 5397.6 5397.7 3354.1 3422.6 3461.9 3476.8 3552.1 1202.1 1212.8 1223.2 1234.3 1265.6 10825.8 10898.3 10928.5 10949.7 10968.7 4295.8 4447.3 4565.6 4607.2 4629.6 9031.1 9032.5 9036.8 9044.0 9051.4 5171.8 5195.2 5202.7 5204.0 5210.5 4144.4 4283.5 4350.1 4387.5 4852.6 3698.9 3719.1 3850.1 3852.7 3858.5 1237.6 1245.2 1245.4 1248.3 1269.0 947.2 954.9 955.3 959.8 977.0 5775.7 5882.9 5933.0 5951.6 5964.2 497.6 498.9 500.4 500.4 503.4 4201.2 4227.5 4256.5 4324.4 4325.8 9986.2 10223.3 10310.7 10316.4 10333.3 9475.4 9892.8 9901.0 10218.7 10252.5 7862.2 8060.6 8062.2 8063.4 8064.4 5795.4 5804.4 5901.6 5954.6 6120.6 9165.5 9275.7 9315.0 9351.0 9491.0 8247.6 8459.6 9562.5 9663.1 9669.5 6920.8 6932.4 7088.0 7096.6 7185.6 7785.6 7990.9 8068.3 8083.4 8120.1 7368.0 7479.8 7502.3 7546.0 7606.6 7279.7 7381.9 7532.1 7647.2 7683.0 6895.2 6971.0 7049.7 7096.0 7097.6 5011.4 5170.6 5406.6 5417.0 5427.7 5176.4 5242.7 5318.1 5365.7 5451.7 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | [#4] prototype.html Cycles:180 Average:4748.15 Median:5428.32 stddev:1388.16 (25.6%) stddev-sans-first:1351.94 09:58:18 INFO - PROCESS | 21600 | Values: 334.2 348.3 353.2 353.5 354.4 5357.8 5493.2 5514.9 5524.0 5537.5 5376.9 5404.3 5420.6 5421.6 5435.0 4032.8 4286.0 4287.3 4294.9 4358.9 3781.3 4141.8 4195.3 4197.7 4221.0 4161.5 4163.5 4167.5 4167.8 4172.7 4170.7 4185.4 4187.3 4204.3 4208.1 3651.5 3677.7 3693.7 3733.8 3747.3 5261.9 5271.2 5287.4 5288.5 5310.4 4807.3 4842.2 4844.4 4860.4 4866.2 5470.7 5634.4 5649.4 5688.2 5694.7 4097.9 4104.5 4104.6 4107.8 4121.8 5641.7 5840.6 5901.7 5929.5 5947.5 4051.3 4164.9 4165.8 4169.1 4172.3 4191.3 4214.1 4230.7 4236.9 4237.4 4593.3 4796.3 4813.2 4822.5 4840.9 5655.8 5722.5 5730.5 5730.6 5731.2 1417.3 1427.2 1427.3 1433.6 1438.4 942.3 970.8 976.5 980.6 992.9 5320.0 5327.4 5344.6 5360.4 5367.5 5565.7 5651.2 5684.6 5699.0 5700.3 5125.1 5316.9 5384.5 5387.2 5397.1 3001.3 3011.5 3018.3 3024.5 3025.8 5761.8 5845.6 5874.3 5901.7 5925.3 5552.7 5651.0 5726.9 5756.7 5764.3 5848.8 5860.8 5890.7 5891.0 5912.7 5453.4 5584.1 5609.9 5634.4 5693.7 5550.7 5561.2 5564.2 5652.8 5666.7 5824.2 5926.9 5945.5 6043.6 6072.1 4198.5 4200.6 4200.9 4226.5 4248.3 5723.2 5939.8 5959.7 5971.7 5971.9 5732.6 5746.3 5748.5 5750.7 5757.1 5649.5 5681.7 5684.6 5701.7 5725.7 5377.7 5564.9 5587.6 5595.2 5646.2 5627.8 5698.5 5705.7 5706.5 5711.9 5531.3 5557.4 5560.5 5571.4 5571.9 09:58:18 INFO - PROCESS | 21600 | 09:58:18 INFO - PROCESS | 21600 | [#5] yui.html Cycles:180 Average:17297.88 Median:25297.92 stddev:23044.70 (91.1%) stddev-sans-first:23076.02 09:58:18 INFO - PROCESS | 21600 | Values: 792.5 792.5 808.6 815.6 876.9 13241.7 13750.4 13853.7 13899.3 13917.4 12315.3 12364.4 12367.6 12374.1 12399.4 714.3 734.0 821.3 842.7 853.7 862.3 863.2 863.5 864.0 865.8 903.5 904.9 911.8 913.3 913.6 902.5 911.1 911.9 912.2 912.2 663.5 664.6 668.4 669.3 669.7 12989.4 13288.7 13308.9 13327.3 13337.1 13649.7 14194.9 14264.9 14275.2 14352.1 11300.0 11477.9 11587.8 11687.2 11713.2 3603.4 3638.9 3642.4 3659.3 3756.0 60517.4 60861.0 60941.7 62306.1 62991.0 10534.2 10854.8 10915.9 11061.0 11164.6 19931.7 20038.6 20071.3 20098.8 20122.2 7207.7 7420.5 7482.6 7601.5 7700.1 4494.0 4521.5 4575.8 4620.2 4649.7 3148.1 3246.8 3252.5 3262.9 3266.2 560.1 560.2 560.5 567.0 580.6 636.7 695.4 734.1 743.1 763.9 8401.6 8462.7 8685.2 8794.8 9032.4 647.0 703.9 724.6 741.6 742.4 4229.9 4339.1 4371.8 4380.8 4469.4 80201.0 89739.6 90692.0 92334.2 92497.5 60669.7 63150.4 78875.6 79026.0 79577.2 65603.7 65788.0 68562.0 68687.3 69280.3 9015.0 9205.2 9280.4 9328.3 9405.0 43503.0 44736.0 45269.3 46020.0 46055.0 54098.7 54529.0 59779.7 62345.4 62710.4 11296.7 11380.9 11452.1 11607.5 12135.3 13651.2 13794.4 13991.6 14269.5 14547.7 11741.9 12347.3 12706.6 13231.7 13568.0 11666.2 11883.9 12035.6 12123.4 12187.5 10142.9 11957.7 11968.3 12332.1 12760.7 10848.7 10856.9 10942.3 11053.9 11209.3 10962.6 11055.3 11136.9 11172.8 11304.1 09:58:18 INFO - PROCESS | 21600 | -------- Summary: end -------- 09:58:18 INFO - PROCESS | 21600 | 09:58:19 INFO - TEST-INFO | 21600: exit 0 09:58:19 INFO - TEST-OK | dromaeo_css | took 1115157ms 09:58:19 INFO - TEST-START | kraken 09:58:19 INFO - operating with platform_type : linux_ 09:58:19 INFO - Initialising browser for kraken test... 09:58:19 INFO - TEST-INFO | started process 21900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1L3WS/profile http://localhost:44398/getInfo.html) 09:58:23 INFO - PROCESS | 21900 | __metrics Screen width/height:1600/1200 09:58:23 INFO - PROCESS | 21900 | colorDepth:24 09:58:23 INFO - PROCESS | 21900 | Browser inner width/height: 1024/697 09:58:23 INFO - PROCESS | 21900 | __metrics 09:58:24 INFO - PROCESS | 21900 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:58:24 INFO - PROCESS | 21900 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:25 INFO - TEST-INFO | 21900: exit 0 09:58:25 INFO - Browser initialized. 09:58:25 INFO - Running cycle 1/1 for kraken test... 09:58:25 INFO - TEST-INFO | started process 21992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1L3WS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:37 INFO - PROCESS | 21992 | RSS: Main: 141975552 09:58:37 INFO - PROCESS | 21992 | 09:58:39 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44398/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:40 INFO - PROCESS | 21992 | RSS: Main: 183742464 09:58:40 INFO - PROCESS | 21992 | 09:58:42 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44398/tests/kraken/driver.html?testName=audio-dft) 09:58:43 INFO - PROCESS | 21992 | RSS: Main: 173793280 09:58:43 INFO - PROCESS | 21992 | 09:58:46 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44398/tests/kraken/driver.html?testName=audio-fft) 09:58:46 INFO - PROCESS | 21992 | RSS: Main: 265080832 09:58:46 INFO - PROCESS | 21992 | 09:58:49 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44398/tests/kraken/driver.html?testName=audio-oscillator) 09:58:49 INFO - PROCESS | 21992 | RSS: Main: 171544576 09:58:49 INFO - PROCESS | 21992 | 09:58:51 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44398/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:52 INFO - PROCESS | 21992 | RSS: Main: 174166016 09:58:52 INFO - PROCESS | 21992 | 09:58:55 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44398/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:55 INFO - PROCESS | 21992 | RSS: Main: 212668416 09:58:55 INFO - PROCESS | 21992 | 09:58:59 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44398/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:59 INFO - PROCESS | 21992 | RSS: Main: 211398656 09:58:59 INFO - PROCESS | 21992 | 09:59:02 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44398/tests/kraken/driver.html?testName=json-parse-financial) 09:59:03 INFO - PROCESS | 21992 | RSS: Main: 210604032 09:59:03 INFO - PROCESS | 21992 | 09:59:04 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44398/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:05 INFO - PROCESS | 21992 | RSS: Main: 172597248 09:59:05 INFO - PROCESS | 21992 | 09:59:06 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:07 INFO - PROCESS | 21992 | RSS: Main: 178843648 09:59:07 INFO - PROCESS | 21992 | 09:59:09 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:10 INFO - PROCESS | 21992 | RSS: Main: 188264448 09:59:10 INFO - PROCESS | 21992 | 09:59:12 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:13 INFO - PROCESS | 21992 | RSS: Main: 196534272 09:59:13 INFO - PROCESS | 21992 | 09:59:15 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:16 INFO - PROCESS | 21992 | RSS: Main: 192643072 09:59:16 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | Cycle 1(1): loaded http://localhost:44398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44398/tests/kraken/driver.html?testName=ai-astar) 09:59:18 INFO - PROCESS | 21992 | RSS: Main: 245551104 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | __start_tp_report 09:59:18 INFO - PROCESS | 21992 | _x_x_mozilla_page_load 09:59:18 INFO - PROCESS | 21992 | _x_x_mozilla_page_load_details 09:59:18 INFO - PROCESS | 21992 | |i|pagename|runs| 09:59:18 INFO - PROCESS | 21992 | |0;ai-astar;102;111;109;110;111;112;110;109;110;110 09:59:18 INFO - PROCESS | 21992 | |1;audio-beat-detection;140;119;120;152;131;117;117;120;145;121 09:59:18 INFO - PROCESS | 21992 | |2;audio-dft;161;161;161;161;160;160;160;160;161;160 09:59:18 INFO - PROCESS | 21992 | |3;audio-fft;76;75;75;114;75;75;76;76;108;76 09:59:18 INFO - PROCESS | 21992 | |4;audio-oscillator;82;81;119;81;82;81;104;82;81;112 09:59:18 INFO - PROCESS | 21992 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 09:59:18 INFO - PROCESS | 21992 | |6;imaging-darkroom;147;146;146;146;146;145;147;146;145;146 09:59:18 INFO - PROCESS | 21992 | |7;imaging-desaturate;84;85;85;85;85;84;85;85;85;84 09:59:18 INFO - PROCESS | 21992 | |8;json-parse-financial;54;49;50;49;50;51;50;51;49;50 09:59:18 INFO - PROCESS | 21992 | |9;json-stringify-tinderbox;58;60;58;59;59;58;59;58;59;59 09:59:18 INFO - PROCESS | 21992 | |10;stanford-crypto-aes;75;84;76;75;80;84;86;77;74;74 09:59:18 INFO - PROCESS | 21992 | |11;stanford-crypto-ccm;130;121;124;124;122;121;125;129;165;126 09:59:18 INFO - PROCESS | 21992 | |12;stanford-crypto-pbkdf2;162;160;162;159;156;157;154;155;162;156 09:59:18 INFO - PROCESS | 21992 | |13;stanford-crypto-sha256-iterative;66;62;64;62;61;61;63;62;65;60 09:59:18 INFO - PROCESS | 21992 | __end_tp_report 09:59:18 INFO - PROCESS | 21992 | __start_cc_report 09:59:18 INFO - PROCESS | 21992 | _x_x_mozilla_cycle_collect,1601 09:59:18 INFO - PROCESS | 21992 | __end_cc_report 09:59:18 INFO - PROCESS | 21992 | __startTimestamp1487699958410__endTimestamp 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | ------- Summary: start ------- 09:59:18 INFO - PROCESS | 21992 | Number of tests: 14 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.76 (2.5%) stddev-sans-first:0.97 09:59:18 INFO - PROCESS | 21992 | Values: 102.0 111.0 109.0 110.0 111.0 112.0 110.0 109.0 110.0 110.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:126.00 stddev:12.99 (10.3%) stddev-sans-first:13.05 09:59:18 INFO - PROCESS | 21992 | Values: 140.0 119.0 120.0 152.0 131.0 117.0 117.0 120.0 145.0 121.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 09:59:18 INFO - PROCESS | 21992 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 160.0 160.0 161.0 160.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:15.04 (19.9%) stddev-sans-first:15.76 09:59:18 INFO - PROCESS | 21992 | Values: 76.0 75.0 75.0 114.0 75.0 75.0 76.0 76.0 108.0 76.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.00 stddev:15.04 (18.6%) stddev-sans-first:15.63 09:59:18 INFO - PROCESS | 21992 | Values: 82.0 81.0 119.0 81.0 82.0 81.0 104.0 82.0 81.0 112.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:59:18 INFO - PROCESS | 21992 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:59:18 INFO - PROCESS | 21992 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 09:59:18 INFO - PROCESS | 21992 | Values: 84.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 84.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:1.49 (3.0%) stddev-sans-first:0.78 09:59:18 INFO - PROCESS | 21992 | Values: 54.0 49.0 50.0 49.0 50.0 51.0 50.0 51.0 49.0 50.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 09:59:18 INFO - PROCESS | 21992 | Values: 58.0 60.0 58.0 59.0 59.0 58.0 59.0 58.0 59.0 59.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:4.62 (5.9%) stddev-sans-first:4.73 09:59:18 INFO - PROCESS | 21992 | Values: 75.0 84.0 76.0 75.0 80.0 84.0 86.0 77.0 74.0 74.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:125.50 stddev:13.12 (10.5%) stddev-sans-first:13.90 09:59:18 INFO - PROCESS | 21992 | Values: 130.0 121.0 124.0 124.0 122.0 121.0 125.0 129.0 165.0 126.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.50 stddev:3.09 (1.9%) stddev-sans-first:2.98 09:59:18 INFO - PROCESS | 21992 | Values: 162.0 160.0 162.0 159.0 156.0 157.0 154.0 155.0 162.0 156.0 09:59:18 INFO - PROCESS | 21992 | 09:59:18 INFO - PROCESS | 21992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.90 (3.0%) stddev-sans-first:1.56 09:59:18 INFO - PROCESS | 21992 | Values: 66.0 62.0 64.0 62.0 61.0 61.0 63.0 62.0 65.0 60.0 09:59:18 INFO - PROCESS | 21992 | -------- Summary: end -------- 09:59:18 INFO - PROCESS | 21992 | 09:59:19 INFO - TEST-INFO | 21992: exit 0 09:59:19 INFO - TEST-OK | kraken | took 60095ms 09:59:19 INFO - SUITE-END | took 1175s 09:59:19 INFO - Completed test suite (00:19:35) 09:59:19 INFO - javascript benchmark 09:59:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.8247796371197, 3202.7597930155243, 3227.790193637414, 3230.709236168744, 3241.918952026199, 5522.199281104243, 5616.550675945925, 5617.550595952319, 5630.211770352154, 5630.605857589971, 5586.24585680933, 5651.1523271509295, 5656.2929633795675, 5657.490825825675, 5691.174779656947, 5113.054084994279, 5140.228965655144, 5161.6958860096265, 5186.533212010918, 5208.0885844977165, 4965.205567109263, 5006.173981293082, 5014.423341315759, 5162.457941916101, 5190.455002224769, 4998.075356059123, 5092.388913330406, 5100.540951314381, 5159.0, 5164.6384753067305, 5171.301874246966, 5175.094358487268, 5183.352080989876, 5185.0, 5208.791648334062, 4883.4628190898975, 4922.0, 5002.849914502571, 5075.873103172414, 5082.23766435034, 5404.648697834628, 5456.508914197741, 5459.645123066988, 5494.395616482184, 5514.283143191399, 5916.704164791743, 5951.851203719898, 5957.493613042897, 5958.165856780054, 5968.1644569760265, 5766.740496677659, 5827.35899051104, 5958.314793798682, 6002.249718785152, 6009.399060094, 5555.861103472405, 5615.101583746622, 5618.831435056954, 5640.8871822563315, 5664.54683625309, 6170.475509581735, 6172.0, 6184.845378865564, 6185.257769067741, 6194.566380353423, 5720.2849643794525, 5775.971120144456, 5933.2286802716235, 5938.257717785277, 5946.583739138306, 5859.0, 5886.882262354815, 5920.259967504062, 5983.970080149658, 6004.609700369462, 5919.970400147971, 5934.881302374015, 5936.7328470218945, 5937.376575459601, 5938.762449501972, 5744.626599271118, 5751.194832723422, 5948.702564871739, 5954.3152537458745, 5988.131720900445, 4615.561521655437, 4616.3306320584, 4638.744869032168, 4695.671303008757, 4705.4588722296685, 4143.958560414418, 4148.79256037203, 4155.148194620156, 4159.688023398257, 4174.895627609334, 5536.474034966672, 5773.249477567973, 5785.913211301834, 5794.739236734357, 5842.766289348378, 5855.502282305966, 5913.05391137416, 5965.492933100648, 5974.3428222895445, 6062.2725272966645, 5697.772089116389, 5727.742251598688, 5735.741891614887, 5740.712964351766, 5742.138679198154, 5193.974030129825, 5208.348956380452, 5216.426193118754, 5216.478352164753, 5239.214117882349, 5983.311919129356, 5993.9700301498215, 6138.357744607992, 6149.446549810538, 6201.81394558173, 6049.425304596057, 6050.485708714808, 6050.6369617823075, 6056.939430605637, 6078.45293923549, 6257.78097766576, 6283.717232724447, 6287.74849006053, 6291.1192433058495, 6302.054691796267, 5671.631343962629, 5697.54419646419, 5881.206037184926, 5932.762689492372, 5945.435183657545, 6032.607880487754, 6035.637861728311, 6037.45662890342, 6049.879002419839, 6076.058210977306, 5783.7397317119985, 5855.38518455556, 5870.14882841994, 5874.530037597067, 5879.73541190656, 5671.574631902541, 5684.147377893184, 5772.653640781398, 5811.593188476766, 5836.037053886231, 5841.853953651193, 5845.912311315248, 5846.853828654318, 5857.912131318119, 5871.412858714094, 5903.970480147572, 5905.379935106752, 5907.143464197753, 5907.556933230111, 5924.081767326072, 5596.244506991504, 5638.4925356718095, 5652.4064973178865, 5673.517750991047, 5699.772009119589], "value": 5519.207928648026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.2253990922119, 622.5268795715257, 649.3344322069879, 654.9476041916647, 663.4924282923562, 33280.33439331215, 36316.63683363166, 36332.455013174826, 36361.63638363622, 36369.818150909276, 36414.0, 45370.0, 46176.53823461773, 46406.76796616012, 49265.50734492654, 8836.204741573274, 8955.776105597379, 8965.506897120657, 8969.551522423886, 8972.551372431384, 8410.201030902084, 8890.288776897865, 9003.819923601524, 9009.549522523848, 9028.638854445815, 8375.664973401057, 10589.947050264776, 10835.079018283455, 10844.67465976018, 11133.0, 10691.732706682356, 10746.731331716692, 10762.35425874446, 10772.784544309108, 10776.030157285804, 10675.786484270271, 10741.570337186504, 10748.73128171794, 10763.892361076367, 10773.084287835543, 43532.782336088436, 43824.0, 43900.146490478015, 43934.56065439337, 44003.0, 3576.2311103112957, 3719.851205951759, 3795.1840354323676, 3941.605839416064, 4152.065785198306, 32455.0, 32635.0, 32762.180945476317, 32818.3436331272, 32848.3430331392, 4508.143452743968, 4567.497575266718, 4730.62155027597, 4784.856454306377, 4799.304100905384, 328867.0, 329116.0, 329177.0, 330328.0, 330910.9999999976, 37124.0, 38396.23207535833, 38432.231355372736, 59603.701981489816, 59839.0, 40527.0, 40580.79709601433, 40592.39111413331, 40613.0, 40660.1867962645, 16397.0, 16469.0, 16494.0, 16503.0, 16512.75230871538, 13941.024128311125, 13958.371873265525, 13961.581152565439, 14011.789823152661, 14018.018738688397, 8718.95640521806, 9024.774380640405, 9026.142516460926, 9519.143277105093, 9595.904040959502, 3587.892363229107, 3593.0, 3623.8550457981914, 3629.455581662719, 3689.612590677994, 1015.3653966271081, 1020.7754294055296, 1031.7523794289316, 1051.5898799468214, 1055.3748520386475, 31616.841915790275, 31707.36585268282, 31987.840060800012, 32081.420874077125, 32250.35499290048, 1129.390129330169, 1145.352875625269, 1163.627639155462, 1193.5106606291379, 1200.8739082396398, 16072.598185045468, 16687.91656041736, 17091.230894609773, 17263.939555750847, 17282.913585431994, 513631.0, 518336.0, 519607.0, 520616.0, 521661.0, 58631.0, 58885.0, 60063.69968150131, 60279.09581356283, 61381.0, 1400.3418393355107, 1423.7579611466076, 1428.8428272889973, 1438.3814959567278, 1452.0126314106299, 30675.0, 32544.34911301808, 32764.50853237251, 33077.17307067246, 33246.667533324355, 51061.0, 52318.0, 52361.21458178054, 52489.21266181087, 52869.47130528645, 407554.0, 451851.0, 458982.0, 607310.0, 614794.0, 28404.715952840208, 28528.42943141084, 28629.141125766262, 28790.0, 28811.85594072016, 45632.54367456416, 46479.0, 46525.3021204689, 46651.53348466472, 46769.766151169024, 39580.80209598933, 39731.0, 39831.40252896151, 40451.59548404596, 42048.15903681971, 39351.80324098476, 39580.60419395769, 39711.80144099377, 41398.1720365597, 41414.58585414107, 39067.609323907534, 39457.21085578215, 40397.798011009756, 40485.0, 40495.79752101221, 32276.19309517281, 34929.65070349264, 35004.299914002084, 35892.64107358998, 36144.27711445809, 26657.600135998364, 27053.72946270512, 27214.455710886068, 27250.0, 27502.587461187697], "value": 19426.59195038259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.74700432736006, 416.55844804507245, 422.98308067677294, 436.3781611204033, 439.7647258716585, 18772.718409223857, 18948.715769263472, 19977.60044799103, 20069.197232110735, 20171.59656806865, 18952.0, 19077.0, 19220.519487012833, 19301.13144908479, 19355.516112097204, 5312.70780107093, 5594.384617692071, 5622.437756224385, 5692.6299790513485, 5701.372848986608, 5580.469855363734, 5624.606277560552, 5626.0, 5630.802921897734, 5894.086416605433, 6120.20437343147, 6259.874802503947, 6270.780522681707, 6271.0, 6271.027990661455, 6028.6684232367425, 6113.23584551931, 6165.969170154121, 6255.62466252024, 6268.561200715929, 5990.371011043865, 5994.250718660168, 5997.910031349533, 5999.250093738283, 5999.490043346321, 18339.26642934281, 23501.41246468835, 23579.646305305436, 23613.645795313085, 23849.523009539884, 2292.289390289016, 2375.845570037942, 2447.4003869052017, 2506.7994560435122, 2558.255327623987, 9698.0, 10922.29005114665, 11197.272177308449, 11284.435778211138, 13514.391852366667, 1817.854571634266, 1827.0681952204338, 1876.7841698204609, 1908.7709474862966, 1926.4413320137144, 83539.5823020887, 83547.91135204048, 84137.15862841415, 84449.57775211147, 84489.15510844935, 11320.0, 11628.069754419626, 11672.182947193785, 11774.116941229442, 11839.11206659504, 17008.57478563046, 17012.06433646161, 17022.404215852384, 17041.659166816593, 17068.31726730917, 8314.043884953307, 8647.481151130953, 8752.69365572202, 8755.737327880173, 8778.692745753868, 8432.747017589481, 8471.95764021176, 8480.787980300542, 8624.482531048032, 8670.696525621574, 4774.40319960005, 4839.951600484021, 5018.84943451697, 5097.260897169964, 5224.869378265574, 1964.8231659150745, 1996.5807180492259, 1999.6500612392774, 2006.1173083843062, 2099.2967355935934, 970.2722957781664, 984.1388784813288, 993.0, 1016.11090295991, 1026.2200727447193, 18139.18373673188, 19865.503362416057, 19933.501662458264, 20146.89926550358, 20219.696704549442, 1012.2307046644456, 1031.159604921986, 1048.7640280936728, 1073.1629329123296, 1080.773037662084, 10377.429241391796, 11159.776804463865, 11174.66476005721, 11205.60780372683, 11223.775524489465, 444775.0, 445980.0, 449140.2628960568, 461318.0, 462855.0, 87739.0, 90316.0, 97453.0, 99756.5012174949, 103657.48171259096, 1052.1057101463848, 1063.4948399510172, 1080.0765345629375, 1100.7963526747578, 1101.9559217631365, 17348.653026939643, 17708.91145544264, 18071.548211294823, 18110.81889181091, 18119.275228990693, 33832.66167338295, 38638.613613863505, 41119.177616446905, 41140.97147571335, 41637.268833659706, 60019.0, 60757.392426075174, 60804.0, 61084.38915610787, 62189.68905155445, 8726.476411415335, 8955.686550970684, 9039.774005649911, 9040.41237319572, 9166.495842728715, 12344.75310493803, 12609.87390126087, 13030.348482575644, 13082.738345233232, 13532.86467135316, 11487.712807179887, 11597.536098555964, 11715.414229288332, 11805.881941180822, 12106.394680266128, 11322.490487928228, 11515.654530364103, 11547.0, 11797.705057373634, 11964.880351196376, 11015.173861960226, 11402.600908968147, 11492.482838272465, 11850.407479625812, 12064.155509114278, 8747.956260218658, 8864.20222180007, 8908.73273801787, 9132.36073474877, 9228.723138305593, 9118.498482583256, 11293.71765705831, 11479.4260286987, 11544.19190656646, 11613.3612651305], "value": 9468.002853502321, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.7592033433978, 1478.2239324354716, 1511.6901035287767, 1653.214723006572, 1810.3844692804453, 7418.591977441239, 7969.68121275149, 8395.076541580422, 8414.116517765638, 8612.483251004944, 8470.152984701526, 8518.27594654455, 8530.829383412329, 8533.018702849175, 8549.316054715624, 2416.6375043743406, 2445.559799236146, 2447.278052974377, 2449.2652204338715, 2450.13020377766, 2424.665686308257, 2476.9101595298102, 2477.6407420923956, 2479.6528486011885, 2487.3781554611346, 2344.8006919411787, 2369.1471070414636, 2377.061060880951, 2379.0364902214546, 2390.1873363056557, 2247.3932038349717, 2274.5678321118935, 2289.3360925331635, 2314.5486630107134, 2319.188284100568, 2330.0097458580035, 2351.7883390494767, 2367.786899179065, 2368.4315764216635, 2371.454565449939, 8165.1426600207315, 8348.457350272274, 8417.326613870875, 8493.617787199591, 8495.44779589331, 5155.149400348938, 5391.703456309901, 5395.271638328814, 5397.62216644835, 5397.7031263280505, 3354.127926739041, 3422.5550678411896, 3461.913452163716, 3476.843542040589, 3552.0587044433246, 1202.0744027099086, 1212.818077288405, 1223.2171410297417, 1234.3396282988558, 1265.5633806336798, 10825.783484330348, 10898.291611045257, 10928.453577321103, 10949.726256843642, 10968.725781855357, 4295.763732994716, 4447.3329000650165, 4565.589096981287, 4607.216773148572, 4629.583337499641, 9031.096890310917, 9032.45805251687, 9036.774080648036, 9043.954780226188, 9051.411658242194, 5171.81898633546, 5195.220716892496, 5202.687838729688, 5204.0, 5210.53105220532, 4144.357624568136, 4283.528811830696, 4350.129974005212, 4387.5393083726385, 4852.636052296092, 3698.852045918187, 3719.0702324418894, 3850.0952276215066, 3852.653261206449, 3858.479105320746, 1237.5854088880146, 1245.2466257914014, 1245.4333278358506, 1248.2822377133184, 1269.041873385588, 947.2280091725222, 954.8854137503544, 955.2644463762864, 959.7792507723124, 976.951152442375, 5775.682337471395, 5882.882342353129, 5933.0, 5951.642901425928, 5964.1650168976375, 497.62926619668576, 498.88026873550086, 500.384527031753, 500.3970215889844, 503.3908970146091, 4201.159768046403, 4227.450431443893, 4256.489221293465, 4324.437823082979, 4325.84859529915, 9986.151177150025, 10223.284370094021, 10310.742231444125, 10316.43259620728, 10333.328333658288, 9475.431474111576, 9892.80214395708, 9901.0, 10218.744531386776, 10252.538635761408, 7862.174471680506, 8060.637271322805, 8062.153473885158, 8063.395245356622, 8064.395170362246, 5795.391483894299, 5804.361520232856, 5901.645901245939, 5954.553408494294, 6120.60216085953, 9165.450072995642, 9275.72172834816, 9314.95342523283, 9351.018143094878, 9490.952545237229, 8247.587620618826, 8459.577021149042, 9562.521873906417, 9663.082007209305, 9669.468179250209, 6920.826979325557, 6932.445404367538, 7088.0, 7096.574205547684, 7185.640717963976, 7785.649645766068, 7990.92009079925, 8068.273855352812, 8083.434159608771, 8120.14738452454, 7368.042154519878, 7479.775606731807, 7502.287282708134, 7546.0, 7606.619669016416, 7279.745208917662, 7381.926180738339, 7532.096148462, 7647.158812530728, 7683.039620047494, 6895.241523432318, 6971.0, 7049.718011279491, 7096.0, 7097.609631470319, 5011.4236862761245, 5170.6380553360905, 5406.567474602101, 5417.0, 5427.701476418835, 5176.352955880515, 5242.737863106753, 5318.0959236930585, 5365.65123267002, 5451.672899626035], "value": 4460.742169889554, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.2296007702247, 348.25473486738366, 353.23877044968094, 353.5439283324512, 354.39752420884486, 5357.8392648220515, 5493.2034854946005, 5514.862128446791, 5523.9999999999945, 5537.473939975695, 5376.892462150755, 5404.32445944257, 5420.620556561043, 5421.647592906468, 5435.0, 4032.802122843043, 4286.035641980545, 4287.292596721552, 4294.947737804242, 4358.912821743564, 3781.338265803487, 4141.834326626931, 4195.307774217251, 4197.685173611976, 4220.957790422087, 4161.500619925613, 4163.542010378856, 4167.45823043004, 4167.83328666853, 4172.687048471362, 4170.7279279819795, 4185.372194170868, 4187.288161012635, 4204.285271503852, 4208.074223670787, 3651.507046548735, 3677.7128005198233, 3693.741438099334, 3733.757305775116, 3747.2505498900055, 5261.86845328866, 5271.207789351639, 5287.391949925769, 5288.524032837063, 5310.362756469249, 4807.302941073524, 4842.176829938919, 4844.442889067767, 4860.441049279308, 4866.245731911559, 5470.699111548864, 5634.3520495143175, 5649.435056494318, 5688.203651488795, 5694.715264236772, 4097.918041639151, 4104.4664193654635, 4104.6044344922575, 4107.794610269475, 4121.752694838319, 5641.68970706611, 5840.6053518057815, 5901.704914754245, 5929.466348028655, 5947.464728174485, 4051.331530297527, 4164.91670166601, 4165.75005499671, 4169.145325208325, 4172.311568591209, 4191.266528357525, 4214.115035842446, 4230.682698797603, 4236.851710190129, 4237.427947227146, 4593.28804035375, 4796.2805579162705, 4813.229883218668, 4822.493638167942, 4840.903181936342, 5655.773769049274, 5722.456366645162, 5730.455606717355, 5730.627509211971, 5731.197632331394, 1417.3409364645283, 1427.229296180072, 1427.3291552970088, 1433.5699290212895, 1438.3671184678708, 942.2603256443659, 970.8106919150698, 976.5019839881711, 980.6126580001003, 992.9226788933943, 5319.973400132974, 5327.413984461706, 5344.625876188629, 5360.437154098841, 5367.490088441592, 5565.749541270652, 5651.237082993744, 5684.602077854511, 5699.031164702011, 5700.25896633435, 5125.052480057629, 5316.893662126813, 5384.492342144206, 5387.1649894265665, 5397.136458166675, 3001.3342594860064, 3011.472992226352, 3018.2907016851022, 3024.516077427601, 3025.7579393648457, 5761.803695069774, 5845.561582881301, 5874.295084589877, 5901.704914754245, 5925.34821169671, 5552.666839989613, 5650.971745141248, 5726.911886741505, 5756.740946657411, 5764.308283005982, 5848.795292164839, 5860.794872179454, 5890.705464726747, 5890.9999999999145, 5912.733926973297, 5453.400125986218, 5584.078627026658, 5609.915851262316, 5634.408387119293, 5693.722510995635, 5550.69471179089, 5561.249231353877, 5564.1931919870585, 5652.830415087554, 5666.660000399989, 5824.242848429846, 5926.851828704317, 5945.464908158287, 6043.607165534227, 6072.089186622042, 4198.4961804583645, 4200.6219440250525, 4200.85297014603, 4226.535081141011, 4248.34150706641, 5723.225800002013, 5939.792107276225, 5959.731812068554, 5971.701414929323, 5971.91042134377, 5732.627379220337, 5746.339170995389, 5748.511376533042, 5750.712464376848, 5757.107648314518, 5649.485978739422, 5681.659100453986, 5684.573656975661, 5701.686407247641, 5725.740337125826, 5377.677339359651, 5564.860878478071, 5587.636803607753, 5595.160725891149, 5646.181303711021, 5627.833284185536, 5698.487136157766, 5705.686187259741, 5706.543476521952, 5711.8576284742385, 5531.280933478622, 5557.44425557441, 5560.46998615637, 5571.3871474137, 5571.916421253765], "value": 4308.544395137222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.4928046050533, 792.5046845721424, 808.6482380164625, 815.5636734347124, 876.9298456123511, 13241.668958276048, 13750.449982000708, 13853.722925541482, 13899.30503474826, 13917.37371818268, 12315.261084334947, 12364.443600037997, 12367.567135150271, 12374.071944604146, 12399.442025108869, 714.3071220915704, 734.0054226523065, 821.2772759971217, 842.7219017724152, 853.7012045783988, 862.2843040276556, 863.201538576817, 863.4732812984074, 864.0279685353977, 865.7748985263813, 903.4759839293195, 904.8506996345595, 911.7857303533664, 913.2876356441952, 913.6162811619135, 902.4630344944748, 911.1162172692544, 911.9088091190828, 912.2200518556605, 912.2291663544295, 663.5322097921003, 664.6444152378502, 668.4284936379374, 669.2838662630987, 669.6919417068154, 12989.350532473338, 13288.667783305398, 13308.866911330859, 13327.26700031498, 13337.133086349453, 13649.666483443023, 14194.85805141956, 14264.857351426457, 14275.21486318252, 14352.06711563745, 11300.0, 11477.885221147764, 11587.768244635145, 11687.240329378648, 11713.180077394585, 3603.387424137903, 3638.9272214555563, 3642.3807952648112, 3659.304732100892, 3756.0234339071767, 60517.39482605162, 60861.0, 60941.69529152326, 62306.0654090189, 62991.0, 10534.20993425496, 10854.78290434187, 10915.890841091488, 11061.0, 11164.553417863357, 19931.701024484646, 20038.59922801536, 20071.29750458727, 20098.79901200969, 20122.19511219535, 7207.675654595556, 7420.5176663516695, 7482.625868706652, 7601.46789724725, 7700.075990881131, 4494.0, 4521.525239849834, 4575.839845605455, 4620.168369693488, 4649.721016739007, 3148.087054754096, 3246.8376581170846, 3252.463343548335, 3262.9021129366156, 3266.2487627845253, 560.1150182711307, 560.1737437280061, 560.5095541401274, 566.9971650141723, 580.5645765675744, 636.6880228688002, 695.4401706626113, 734.1300558837687, 743.1490942870383, 763.9274268944441, 8401.579921003926, 8462.746117616482, 8685.174908383693, 8794.824103517894, 9032.412893161923, 646.977355792545, 703.9401650859631, 724.5543990445838, 741.5847125609675, 742.3764038207931, 4229.873103806891, 4339.132173565299, 4371.825126994948, 4380.802863871069, 4469.374287599739, 80201.0, 89739.63865575516, 90692.0, 92334.15331693462, 92497.537512312, 60669.69665151734, 63150.36849631445, 78875.60562197152, 79026.0, 79577.20422795814, 65603.67198164074, 65788.0, 68562.0, 68687.31312686909, 69280.30719692839, 9014.954925225333, 9205.225125622912, 9280.443173409618, 9328.300377471853, 9404.952975235354, 43503.0, 44736.0, 45269.32096018628, 46020.0, 46055.0, 54098.72950635222, 54529.0, 59779.70110149421, 62345.37654623577, 62710.37289627228, 11296.717582060186, 11380.886191137983, 11452.14108941816, 11607.477663504993, 12135.332556709465, 13651.180929144282, 13794.448222071005, 13991.58025259244, 14269.500567480089, 14547.709045819236, 11741.882581174079, 12347.320897350732, 12706.555270565486, 13231.735365292448, 13568.0, 11666.241694290184, 11883.940580297043, 12035.638930832089, 12123.393830308272, 12187.451564679433, 10142.949285253526, 11957.738595018163, 11968.341741204318, 12332.136750427384, 12760.6809829755, 10848.728781780519, 10856.891431085589, 10942.288751231144, 11053.889461105286, 11209.327440353605, 10962.616308429167, 11055.336679799238, 11136.944315278372, 11172.832407513732, 11304.095672346028], "value": 6995.966997490365, "unit": "score"}], "name": "dromaeo_css", "value": 7175.6326836153885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 109.0, 110.0, 111.0, 112.0, 110.0, 109.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 119.0, 120.0, 152.0, 131.0, 117.0, 117.0, 120.0, 145.0, 121.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 114.0, 75.0, 75.0, 76.0, 76.0, 108.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 119.0, 81.0, 82.0, 81.0, 104.0, 82.0, 81.0, 112.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 49.0, 50.0, 49.0, 50.0, 51.0, 50.0, 51.0, 49.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 75.0, 80.0, 84.0, 86.0, 77.0, 74.0, 74.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 124.0, 124.0, 122.0, 121.0, 125.0, 129.0, 165.0, 126.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 159.0, 156.0, 157.0, 154.0, 155.0, 162.0, 156.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 64.0, 62.0, 61.0, 61.0, 63.0, 62.0, 65.0, 60.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1455.8, "alertThreshold": 2.0}]} 09:59:19 INFO - Return code: 0 09:59:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:19 INFO - # TBPL SUCCESS # 09:59:19 INFO - Running post-action listener: _resource_record_post_action 09:59:19 INFO - [mozharness: 2017-02-21 17:59:19.719028Z] Finished run-tests step (success) 09:59:19 INFO - Running post-run listener: _resource_record_post_run 09:59:19 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 1003520; Write bytes: 320958464; Read time: 340; Write time: 169000 09:59:19 INFO - TinderboxPrint: CPU usage
13.0% 09:59:19 INFO - TinderboxPrint: I/O read bytes / time
1,003,520 / 340 09:59:19 INFO - TinderboxPrint: I/O write bytes / time
320,958,464 / 169,000 09:59:19 INFO - TinderboxPrint: CPU idle
8,259.0 (87.0%) 09:59:19 INFO - TinderboxPrint: CPU user
1,190.5 (12.5%) 09:59:19 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:19 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101289984; Read time: 0; Write time: 84636 09:59:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 1003520; Write bytes: 219668480; Read time: 340; Write time: 84364 09:59:20 INFO - Running post-run listener: _upload_blobber_files 09:59:20 INFO - Blob upload gear active. 09:59:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:20 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 09:59:20 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:59:20 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:59:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:23 INFO - (blobuploader) - INFO - Done attempting. 09:59:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:59:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:24 INFO - (blobuploader) - INFO - Done attempting. 09:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:59:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:25 INFO - (blobuploader) - INFO - Done attempting. 09:59:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:25 INFO - Return code: 0 09:59:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc885d02ba476f2bd70d258e30bbacc8dbc3c1cb964a39a744a161f050364656ef8bdf96aa2fa1709fe2d656cbbe1f7c497e3d23d5987ac067beb7469c44c839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/987ca48100742bf7ca1ed9ed54b831d8e43903e62882e50c821565e6430a40a747c38641bcd956ebb51f7f6dfb84277b1672d9db5d39405f77c91d7ea04015bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/306597c6dbb8bfd6ef3a0abc51ab9da611a19a3724fcd62223e702c1e6a17bce1137e56b2c21d11ab413d52d54427447044293a21d02a8df1d0dcc42406282ef"} 09:59:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:25 INFO - Contents: 09:59:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc885d02ba476f2bd70d258e30bbacc8dbc3c1cb964a39a744a161f050364656ef8bdf96aa2fa1709fe2d656cbbe1f7c497e3d23d5987ac067beb7469c44c839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/987ca48100742bf7ca1ed9ed54b831d8e43903e62882e50c821565e6430a40a747c38641bcd956ebb51f7f6dfb84277b1672d9db5d39405f77c91d7ea04015bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/306597c6dbb8bfd6ef3a0abc51ab9da611a19a3724fcd62223e702c1e6a17bce1137e56b2c21d11ab413d52d54427447044293a21d02a8df1d0dcc42406282ef"} 09:59:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:25 INFO - Copying logs to upload dir... 09:59:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.275442 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-21 09:59:25.085130) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 09:59:25.090320) ========= 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=ea65d483da93c827905c2090000001f5-1487698730.213700-86446525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc885d02ba476f2bd70d258e30bbacc8dbc3c1cb964a39a744a161f050364656ef8bdf96aa2fa1709fe2d656cbbe1f7c497e3d23d5987ac067beb7469c44c839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/987ca48100742bf7ca1ed9ed54b831d8e43903e62882e50c821565e6430a40a747c38641bcd956ebb51f7f6dfb84277b1672d9db5d39405f77c91d7ea04015bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/306597c6dbb8bfd6ef3a0abc51ab9da611a19a3724fcd62223e702c1e6a17bce1137e56b2c21d11ab413d52d54427447044293a21d02a8df1d0dcc42406282ef"} build_url:https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/Tw4PLhgYScuGPAuAC2dA0w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc885d02ba476f2bd70d258e30bbacc8dbc3c1cb964a39a744a161f050364656ef8bdf96aa2fa1709fe2d656cbbe1f7c497e3d23d5987ac067beb7469c44c839", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/987ca48100742bf7ca1ed9ed54b831d8e43903e62882e50c821565e6430a40a747c38641bcd956ebb51f7f6dfb84277b1672d9db5d39405f77c91d7ea04015bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/306597c6dbb8bfd6ef3a0abc51ab9da611a19a3724fcd62223e702c1e6a17bce1137e56b2c21d11ab413d52d54427447044293a21d02a8df1d0dcc42406282ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 09:59:25.117956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:59:25.118327) ========= 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=ea65d483da93c827905c2090000001f5-1487698730.213700-86446525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 09:59:25.200804) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 09:59:25.201149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 09:59:25.201438) ========= ========= Total master_lag: 0.16 =========