builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-082 starttime: 1486771292.97 results: success (0) buildid: 20170210140619 builduid: 7e0b380381ae4d14b1a86bc205ece827 revision: f29a51aaae32824ec1202953991cdb098f25b056 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:32.968754) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:32.969223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:32.969523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:32.982370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:32.982753) ========= 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=51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-10 16:01:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.3M=0s 2017-02-10 16:01:33 (37.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:33.093550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:33.093906) ========= 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=51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:33.143574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:33.143944) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f29a51aaae32824ec1202953991cdb098f25b056 --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 f29a51aaae32824ec1202953991cdb098f25b056 --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=51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-10 16:01:33,322 truncating revision to first 12 chars 2017-02-10 16:01:33,322 Setting DEBUG logging. 2017-02-10 16:01:33,322 attempt 1/10 2017-02-10 16:01:33,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f29a51aaae32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 16:01:33,895 unpacking tar archive at: mozilla-beta-f29a51aaae32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.870879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:34.027980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:34.028300) ========= script_repo_revision: f29a51aaae32824ec1202953991cdb098f25b056 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:34.028690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:34.028956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 16:01:34.038808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-10 16:01:34.039187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:01:34 INFO - MultiFileLogger online at 20170210 16:01:34 in /builds/slave/test 16:01:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:01:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:01:34 INFO - {'append_to_log': False, 16:01:34 INFO - 'base_work_dir': '/builds/slave/test', 16:01:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:01:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:01:34 INFO - 'branch': 'Mozilla-Beta', 16:01:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:34 INFO - 'config_files': ('talos/linux_config.py',), 16:01:34 INFO - 'default_actions': ('clobber', 16:01:34 INFO - 'read-buildbot-config', 16:01:34 INFO - 'download-and-extract', 16:01:34 INFO - 'populate-webroot', 16:01:34 INFO - 'create-virtualenv', 16:01:34 INFO - 'install', 16:01:34 INFO - 'run-tests'), 16:01:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:34 INFO - 'download_minidump_stackwalk': True, 16:01:34 INFO - 'download_symbols': 'ondemand', 16:01:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:34 INFO - 'installer_path': 'installer.exe', 16:01:34 INFO - 'log_level': 'info', 16:01:34 INFO - 'log_name': 'talos', 16:01:34 INFO - 'log_to_console': True, 16:01:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:01:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:01:34 INFO - 'opt_config_files': (), 16:01:34 INFO - 'pip_index': False, 16:01:34 INFO - 'sps_profile': False, 16:01:34 INFO - 'sps_profile_interval': 0, 16:01:34 INFO - 'suite': 'dromaeojs-e10s', 16:01:34 INFO - 'system_bits': '32', 16:01:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:34 INFO - 'title': 'talos-linux64-ix-082', 16:01:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:34 INFO - 'use_talos_json': True, 16:01:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:01:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:34 INFO - 'work_dir': 'build'} 16:01:34 INFO - [mozharness: 2017-02-11 00:01:34.313347Z] Running clobber step. 16:01:34 INFO - Running pre-action listener: _resource_record_pre_action 16:01:34 INFO - Running main action method: clobber 16:01:34 INFO - rmtree: /builds/slave/test/build 16:01:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:01:35 INFO - Running post-action listener: _resource_record_post_action 16:01:35 INFO - [mozharness: 2017-02-11 00:01:35.286043Z] Finished clobber step (success) 16:01:35 INFO - [mozharness: 2017-02-11 00:01:35.286140Z] Running read-buildbot-config step. 16:01:35 INFO - Running pre-action listener: _resource_record_pre_action 16:01:35 INFO - Running main action method: read_buildbot_config 16:01:35 INFO - Using buildbot properties: 16:01:35 INFO - { 16:01:35 INFO - "project": "", 16:01:35 INFO - "product": "firefox", 16:01:35 INFO - "script_repo_revision": "production", 16:01:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:01:35 INFO - "repository": "", 16:01:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:01:35 INFO - "buildid": "20170210140619", 16:01:35 INFO - "pgo_build": "True", 16:01:35 INFO - "basedir": "/builds/slave/test", 16:01:35 INFO - "buildnumber": 406, 16:01:35 INFO - "slavename": "talos-linux64-ix-082", 16:01:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:01:35 INFO - "platform": "ubuntu64_hw", 16:01:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:01:35 INFO - "branch": "mozilla-beta", 16:01:35 INFO - "repo_path": "releases/mozilla-beta", 16:01:35 INFO - "revision": "f29a51aaae32824ec1202953991cdb098f25b056", 16:01:35 INFO - "stage_platform": "linux64-pgo", 16:01:35 INFO - "builduid": "7e0b380381ae4d14b1a86bc205ece827", 16:01:35 INFO - "slavebuilddir": "test" 16:01:35 INFO - } 16:01:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 16:01:35 INFO - Running post-action listener: _resource_record_post_action 16:01:35 INFO - [mozharness: 2017-02-11 00:01:35.288530Z] Finished read-buildbot-config step (success) 16:01:35 INFO - [mozharness: 2017-02-11 00:01:35.288617Z] Running download-and-extract step. 16:01:35 INFO - Running pre-action listener: _resource_record_pre_action 16:01:35 INFO - Running main action method: download_and_extract 16:01:35 INFO - mkdir: /builds/slave/test/build/tests 16:01:35 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')]} 16:01:35 INFO - trying https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/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 16:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/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 16:01:35 INFO - Downloaded 1327 bytes. 16:01:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:01:35 INFO - Using the following test package requirements: 16:01:35 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:01:35 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:01:35 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 16:01:35 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'jsshell-linux-x86_64.zip'], 16:01:35 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:01:35 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:01:35 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 16:01:35 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 16:01:35 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:01:35 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:01:35 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:01:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:01:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:01:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:01:35 INFO - Fetch https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:01:36 INFO - Http code: 200 16:01:36 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 16:01:36 INFO - x-amz-cf-id: W3iv-IvOO1yyqY9BZENvDbdjw6YI9fZ-0AoFMjNB8_EwSz-owibOmw== 16:01:36 INFO - x-amz-version-id: ..zD17bRNCaAfCHw9Ss8UbC9hZiEUplI 16:01:37 INFO - Expected file size: 21959313 16:01:37 INFO - Obtained file size: 21959313 16:01:41 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 16:01:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:01:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:01:41 INFO - Fetch https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:01:42 INFO - Http code: 200 16:01:42 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 16:01:42 INFO - x-amz-cf-id: TNoLyluBfDVFR-WVBSSB5gPZP3EpVnrQoSrzniWNSWPZ6dsuCyWXaQ== 16:01:42 INFO - x-amz-version-id: ..zD17bRNCaAfCHw9Ss8UbC9hZiEUplI 16:01:42 INFO - Expected file size: 21959313 16:01:42 INFO - Obtained file size: 21959313 16:01:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 16:01:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:01:46 INFO - Fetch https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 16:01:47 INFO - Http code: 200 16:01:47 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 16:01:47 INFO - x-amz-cf-id: fh5Wa64NwrcqBWOOm-ZlF5SbzrDv1LSHEGYl6tE79RNuUR_7bVnk9w== 16:01:47 INFO - x-amz-version-id: Ji_Y2hqulCGxWIy4yEaZ4jIo.pluMYYX 16:01:48 INFO - Expected file size: 14403005 16:01:48 INFO - Obtained file size: 14403005 16:01:48 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')]} 16:01:48 INFO - trying https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:01:48 INFO - Downloading https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/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 16:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/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 16:01:50 INFO - Downloaded 57712181 bytes. 16:01:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:01:50 INFO - mkdir: /builds/slave/test/properties 16:01:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:50 INFO - Contents: 16:01:50 INFO - build_url:https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:01:51 INFO - Running post-action listener: _resource_record_post_action 16:01:51 INFO - Running post-action listener: set_extra_try_arguments 16:01:51 INFO - [mozharness: 2017-02-11 00:01:51.512829Z] Finished download-and-extract step (success) 16:01:51 INFO - [mozharness: 2017-02-11 00:01:51.513055Z] Running populate-webroot step. 16:01:51 INFO - Running pre-action listener: _resource_record_pre_action 16:01:51 INFO - Running main action method: populate_webroot 16:01:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:51 INFO - '--tppagecycles', 16:01:51 INFO - '7'], 16:01:51 INFO - 'tests': ['tsvgm']}}, 16:01:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['damp', 'tps']}, 16:01:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'tests': ['damp', 'tps']}, 16:01:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['dromaeo_dom']}, 16:01:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['basic_compositor_video']}, 16:01:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:01:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['a11yr', 16:01:51 INFO - 'ts_paint', 16:01:51 INFO - 'tpaint', 16:01:51 INFO - 'sessionrestore', 16:01:51 INFO - 'sessionrestore_no_auto_restore', 16:01:51 INFO - 'tabpaint']}, 16:01:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:51 INFO - 'ts_paint', 16:01:51 INFO - 'tpaint', 16:01:51 INFO - 'sessionrestore', 16:01:51 INFO - 'sessionrestore_no_auto_restore', 16:01:51 INFO - 'tabpaint']}, 16:01:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:01:51 INFO - 'ts_paint', 16:01:51 INFO - 'tpaint', 16:01:51 INFO - 'sessionrestore', 16:01:51 INFO - 'sessionrestore_no_auto_restore', 16:01:51 INFO - 'tabpaint']}, 16:01:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:01:51 INFO - 'ts_paint', 16:01:51 INFO - 'tpaint', 16:01:51 INFO - 'sessionrestore', 16:01:51 INFO - 'sessionrestore_no_auto_restore', 16:01:51 INFO - 'tabpaint']}, 16:01:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['a11yr', 16:01:51 INFO - 'ts_paint', 16:01:51 INFO - 'tpaint', 16:01:51 INFO - 'sessionrestore', 16:01:51 INFO - 'sessionrestore_no_auto_restore', 16:01:51 INFO - 'tabpaint']}, 16:01:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['a11yr', 16:01:51 INFO - 'ts_paint', 16:01:51 INFO - 'tpaint', 16:01:51 INFO - 'sessionrestore', 16:01:51 INFO - 'sessionrestore_no_auto_restore', 16:01:51 INFO - 'tabpaint']}, 16:01:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['tsvgx', 16:01:51 INFO - 'tsvgr_opacity', 16:01:51 INFO - 'tart', 16:01:51 INFO - 'tscrollx', 16:01:51 INFO - 'cart']}, 16:01:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:51 INFO - 'tsvgr_opacity', 16:01:51 INFO - 'tart', 16:01:51 INFO - 'tscrollx', 16:01:51 INFO - 'cart']}, 16:01:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'talos_options': ['--disable-e10s'], 16:01:51 INFO - 'tests': ['tp5o']}, 16:01:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'tests': ['tp5o']}, 16:01:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'talos_options': ['--disable-e10s', 16:01:51 INFO - '--xperf_path', 16:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:51 INFO - 'tests': ['tp5n']}, 16:01:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:51 INFO - 'talos_options': ['--xperf_path', 16:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:51 INFO - 'tests': ['tp5n']}}, 16:01:51 INFO - 'talos.zip': {'path': '', 16:01:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:51 INFO - Running post-action listener: _resource_record_post_action 16:01:51 INFO - [mozharness: 2017-02-11 00:01:51.529375Z] Finished populate-webroot step (success) 16:01:51 INFO - [mozharness: 2017-02-11 00:01:51.529463Z] Running create-virtualenv step. 16:01:51 INFO - Running pre-action listener: _resource_record_pre_action 16:01:51 INFO - Running main action method: create_virtualenv 16:01:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:51 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 16:01:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:51 INFO - Using real prefix '/usr' 16:01:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:54 INFO - Installing pip.................done. 16:01:54 INFO - Return code: 0 16:01:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:01:54 INFO - Reading from file tmpfile_stdout 16:01:54 INFO - Output received: 16:01:54 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) 16:01:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:54 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')]} 16:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:54 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')]} 16:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:54 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:01:54 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 16:01:54 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 16:01:54 INFO - Using env: {'DISPLAY': ':0', 16:01:54 INFO - 'HOME': '/home/cltbld', 16:01:54 INFO - 'LANG': 'en_US.UTF-8', 16:01:54 INFO - 'LANGUAGE': 'en_US:en', 16:01:54 INFO - 'LOGNAME': 'cltbld', 16:01:54 INFO - 'MAIL': '/var/mail/cltbld', 16:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:54 INFO - 'MOZ_NO_REMOTE': '1', 16:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:54 INFO - 'NO_EM_RESTART': '1', 16:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:54 INFO - 'PWD': '/builds/slave/test', 16:01:54 INFO - 'SHELL': '/bin/bash', 16:01:54 INFO - 'SHLVL': '1', 16:01:54 INFO - 'TERM': 'linux', 16:01:54 INFO - 'TMOUT': '86400', 16:01:54 INFO - 'USER': 'cltbld', 16:01:54 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:54 INFO - '_': '/tools/buildbot/bin/python'} 16:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:54 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 16:01:54 INFO - Cleaning up... 16:01:54 INFO - Return code: 0 16:01:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01:54 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')]} 16:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:54 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')]} 16:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:54 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:01:54 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 16:01:54 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 16:01:54 INFO - Using env: {'DISPLAY': ':0', 16:01:54 INFO - 'HOME': '/home/cltbld', 16:01:54 INFO - 'LANG': 'en_US.UTF-8', 16:01:54 INFO - 'LANGUAGE': 'en_US:en', 16:01:54 INFO - 'LOGNAME': 'cltbld', 16:01:54 INFO - 'MAIL': '/var/mail/cltbld', 16:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:54 INFO - 'MOZ_NO_REMOTE': '1', 16:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:54 INFO - 'NO_EM_RESTART': '1', 16:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:54 INFO - 'PWD': '/builds/slave/test', 16:01:54 INFO - 'SHELL': '/bin/bash', 16:01:54 INFO - 'SHLVL': '1', 16:01:54 INFO - 'TERM': 'linux', 16:01:54 INFO - 'TMOUT': '86400', 16:01:54 INFO - 'USER': 'cltbld', 16:01:54 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:54 INFO - '_': '/tools/buildbot/bin/python'} 16:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:54 INFO - Downloading/unpacking psutil>=3.1.1 16:01:54 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 16:01:54 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 16:01:54 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 16:01:54 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 16:01:54 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 16:01:54 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 16:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:56 INFO - Installing collected packages: psutil 16:01:56 INFO - Running setup.py install for psutil 16:01:56 INFO - building 'psutil._psutil_linux' extension 16:01:56 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 16:01:57 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 16:01:57 INFO - building 'psutil._psutil_posix' extension 16:01:57 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 16:01:57 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 16:01:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:57 INFO - Successfully installed psutil 16:01:57 INFO - Cleaning up... 16:01:57 INFO - Return code: 0 16:01:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:57 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')]} 16:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:57 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')]} 16:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:57 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:01:57 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 16:01:57 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 16:01:57 INFO - Using env: {'DISPLAY': ':0', 16:01:57 INFO - 'HOME': '/home/cltbld', 16:01:57 INFO - 'LANG': 'en_US.UTF-8', 16:01:57 INFO - 'LANGUAGE': 'en_US:en', 16:01:57 INFO - 'LOGNAME': 'cltbld', 16:01:57 INFO - 'MAIL': '/var/mail/cltbld', 16:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:57 INFO - 'MOZ_NO_REMOTE': '1', 16:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:57 INFO - 'NO_EM_RESTART': '1', 16:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:57 INFO - 'PWD': '/builds/slave/test', 16:01:57 INFO - 'SHELL': '/bin/bash', 16:01:57 INFO - 'SHLVL': '1', 16:01:57 INFO - 'TERM': 'linux', 16:01:57 INFO - 'TMOUT': '86400', 16:01:57 INFO - 'USER': 'cltbld', 16:01:57 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:57 INFO - '_': '/tools/buildbot/bin/python'} 16:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:57 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 16:01:57 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 16:01:57 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 16:01:57 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 16:01:57 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 16:01:57 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 16:01:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:59 INFO - Installing collected packages: mozsystemmonitor 16:01:59 INFO - Running setup.py install for mozsystemmonitor 16:01:59 INFO - Successfully installed mozsystemmonitor 16:01:59 INFO - Cleaning up... 16:01:59 INFO - Return code: 0 16:01:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:59 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:01:59 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 16:01:59 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 16:01:59 INFO - Using env: {'DISPLAY': ':0', 16:01:59 INFO - 'HOME': '/home/cltbld', 16:01:59 INFO - 'LANG': 'en_US.UTF-8', 16:01:59 INFO - 'LANGUAGE': 'en_US:en', 16:01:59 INFO - 'LOGNAME': 'cltbld', 16:01:59 INFO - 'MAIL': '/var/mail/cltbld', 16:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:59 INFO - 'MOZ_NO_REMOTE': '1', 16:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:59 INFO - 'NO_EM_RESTART': '1', 16:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:59 INFO - 'PWD': '/builds/slave/test', 16:01:59 INFO - 'SHELL': '/bin/bash', 16:01:59 INFO - 'SHLVL': '1', 16:01:59 INFO - 'TERM': 'linux', 16:01:59 INFO - 'TMOUT': '86400', 16:01:59 INFO - 'USER': 'cltbld', 16:01:59 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:59 INFO - '_': '/tools/buildbot/bin/python'} 16:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:00 INFO - Downloading/unpacking jsonschema==2.5.1 16:02:00 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 16:02:00 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 16:02:00 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 16:02:00 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 16:02:00 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 16:02:00 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 16:02:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:02:02 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 16:02:02 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 16:02:02 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 16:02:02 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 16:02:02 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 16:02:02 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 16:02:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:02 INFO - warning: no files found matching '*.txt' 16:02:02 INFO - no previously-included directories found matching 'build' 16:02:02 INFO - no previously-included directories found matching 'dist' 16:02:02 INFO - no previously-included directories found matching '.git*' 16:02:02 INFO - Installing collected packages: jsonschema, functools32 16:02:02 INFO - Running setup.py install for functools32 16:02:02 INFO - warning: no files found matching '*.txt' 16:02:02 INFO - no previously-included directories found matching 'build' 16:02:02 INFO - no previously-included directories found matching 'dist' 16:02:02 INFO - no previously-included directories found matching '.git*' 16:02:02 INFO - Successfully installed jsonschema functools32 16:02:02 INFO - Cleaning up... 16:02:02 INFO - Return code: 0 16:02:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:02:02 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')]} 16:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:02 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')]} 16:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:02 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:02:02 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 16:02:02 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 16:02:02 INFO - Using env: {'DISPLAY': ':0', 16:02:02 INFO - 'HOME': '/home/cltbld', 16:02:02 INFO - 'LANG': 'en_US.UTF-8', 16:02:02 INFO - 'LANGUAGE': 'en_US:en', 16:02:02 INFO - 'LOGNAME': 'cltbld', 16:02:02 INFO - 'MAIL': '/var/mail/cltbld', 16:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:02 INFO - 'MOZ_NO_REMOTE': '1', 16:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:02 INFO - 'NO_EM_RESTART': '1', 16:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:02 INFO - 'PWD': '/builds/slave/test', 16:02:02 INFO - 'SHELL': '/bin/bash', 16:02:02 INFO - 'SHLVL': '1', 16:02:02 INFO - 'TERM': 'linux', 16:02:02 INFO - 'TMOUT': '86400', 16:02:02 INFO - 'USER': 'cltbld', 16:02:02 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:02 INFO - '_': '/tools/buildbot/bin/python'} 16:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:02:02 INFO - Cleaning up... 16:02:02 INFO - Return code: 0 16:02:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:02:02 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')]} 16:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:02 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')]} 16:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:02 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:02:02 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 16:02:02 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 16:02:02 INFO - Using env: {'DISPLAY': ':0', 16:02:02 INFO - 'HOME': '/home/cltbld', 16:02:02 INFO - 'LANG': 'en_US.UTF-8', 16:02:02 INFO - 'LANGUAGE': 'en_US:en', 16:02:02 INFO - 'LOGNAME': 'cltbld', 16:02:02 INFO - 'MAIL': '/var/mail/cltbld', 16:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:02 INFO - 'MOZ_NO_REMOTE': '1', 16:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:02 INFO - 'NO_EM_RESTART': '1', 16:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:02 INFO - 'PWD': '/builds/slave/test', 16:02:02 INFO - 'SHELL': '/bin/bash', 16:02:02 INFO - 'SHLVL': '1', 16:02:02 INFO - 'TERM': 'linux', 16:02:02 INFO - 'TMOUT': '86400', 16:02:02 INFO - 'USER': 'cltbld', 16:02:02 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:02 INFO - '_': '/tools/buildbot/bin/python'} 16:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:03 INFO - Downloading/unpacking blobuploader==1.2.4 16:02:03 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 16:02:03 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 16:02:03 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 16:02:03 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 16:02:03 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 16:02:03 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 16:02:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:02:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 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 16:02:05 INFO - Downloading docopt-0.6.1.tar.gz 16:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:06 INFO - Running setup.py install for blobuploader 16:02:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:02:06 INFO - Running setup.py install for requests 16:02:06 INFO - Running setup.py install for docopt 16:02:06 INFO - Successfully installed blobuploader requests docopt 16:02:06 INFO - Cleaning up... 16:02:06 INFO - Return code: 0 16:02:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:02:06 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 16:02:06 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 16:02:06 INFO - Using env: {'DISPLAY': ':0', 16:02:06 INFO - 'HOME': '/home/cltbld', 16:02:06 INFO - 'LANG': 'en_US.UTF-8', 16:02:06 INFO - 'LANGUAGE': 'en_US:en', 16:02:06 INFO - 'LOGNAME': 'cltbld', 16:02:06 INFO - 'MAIL': '/var/mail/cltbld', 16:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:06 INFO - 'MOZ_NO_REMOTE': '1', 16:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:06 INFO - 'NO_EM_RESTART': '1', 16:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:06 INFO - 'PWD': '/builds/slave/test', 16:02:06 INFO - 'SHELL': '/bin/bash', 16:02:06 INFO - 'SHLVL': '1', 16:02:06 INFO - 'TERM': 'linux', 16:02:06 INFO - 'TMOUT': '86400', 16:02:06 INFO - 'USER': 'cltbld', 16:02:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:06 INFO - '_': '/tools/buildbot/bin/python'} 16:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:06 INFO - Running setup.py (path:/tmp/pip-yhPlSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:06 INFO - Running setup.py (path:/tmp/pip-ZCkD9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:07 INFO - Running setup.py (path:/tmp/pip-iwlQbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:07 INFO - Running setup.py (path:/tmp/pip-NjEA8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:07 INFO - Running setup.py (path:/tmp/pip-xdWj7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:07 INFO - Running setup.py (path:/tmp/pip-0gZGHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:07 INFO - Running setup.py (path:/tmp/pip-62sFw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:07 INFO - Running setup.py (path:/tmp/pip-le8diX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:07 INFO - Running setup.py (path:/tmp/pip-Citkja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:07 INFO - Running setup.py (path:/tmp/pip-C2YAXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:07 INFO - Running setup.py (path:/tmp/pip-W9HKHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:07 INFO - Running setup.py (path:/tmp/pip-QeelDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:07 INFO - Running setup.py (path:/tmp/pip-58SUNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:07 INFO - Running setup.py (path:/tmp/pip-Xj1g6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:07 INFO - Running setup.py (path:/tmp/pip-cFuQsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:07 INFO - Running setup.py (path:/tmp/pip-j_Eyoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:08 INFO - Running setup.py (path:/tmp/pip-DrJu85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:08 INFO - Running setup.py install for manifestparser 16:02:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Running setup.py install for mozcrash 16:02:08 INFO - Running setup.py install for mozdebug 16:02:08 INFO - Running setup.py install for mozdevice 16:02:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Running setup.py install for mozfile 16:02:08 INFO - Running setup.py install for mozhttpd 16:02:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Running setup.py install for mozinfo 16:02:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Running setup.py install for mozInstall 16:02:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:08 INFO - Running setup.py install for mozleak 16:02:09 INFO - Running setup.py install for mozlog 16:02:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Running setup.py install for moznetwork 16:02:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Running setup.py install for mozprocess 16:02:09 INFO - Running setup.py install for mozprofile 16:02:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Running setup.py install for mozrunner 16:02:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Running setup.py install for mozscreenshot 16:02:09 INFO - Running setup.py install for moztest 16:02:09 INFO - Running setup.py install for mozversion 16:02:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:09 INFO - Cleaning up... 16:02:09 INFO - Return code: 0 16:02:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:09 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:02:09 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 16:02:09 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 16:02:09 INFO - Using env: {'DISPLAY': ':0', 16:02:09 INFO - 'HOME': '/home/cltbld', 16:02:09 INFO - 'LANG': 'en_US.UTF-8', 16:02:09 INFO - 'LANGUAGE': 'en_US:en', 16:02:09 INFO - 'LOGNAME': 'cltbld', 16:02:09 INFO - 'MAIL': '/var/mail/cltbld', 16:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:09 INFO - 'MOZ_NO_REMOTE': '1', 16:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:09 INFO - 'NO_EM_RESTART': '1', 16:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:09 INFO - 'PWD': '/builds/slave/test', 16:02:09 INFO - 'SHELL': '/bin/bash', 16:02:09 INFO - 'SHLVL': '1', 16:02:09 INFO - 'TERM': 'linux', 16:02:09 INFO - 'TMOUT': '86400', 16:02:09 INFO - 'USER': 'cltbld', 16:02:09 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:09 INFO - '_': '/tools/buildbot/bin/python'} 16:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:10 INFO - Running setup.py (path:/tmp/pip-CNnwbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:10 INFO - Running setup.py (path:/tmp/pip-U75a9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:10 INFO - Running setup.py (path:/tmp/pip-ePjsyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:10 INFO - Running setup.py (path:/tmp/pip-SnOhts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:10 INFO - Running setup.py (path:/tmp/pip-1DH1DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:10 INFO - Running setup.py (path:/tmp/pip-Wg2aXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:10 INFO - Running setup.py (path:/tmp/pip-XEc7cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:10 INFO - Running setup.py (path:/tmp/pip-Ra1z3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:10 INFO - Running setup.py (path:/tmp/pip-rc1ni6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:10 INFO - Running setup.py (path:/tmp/pip-QxoiJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:10 INFO - Running setup.py (path:/tmp/pip-vHB_Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:10 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)) 16:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:10 INFO - Running setup.py (path:/tmp/pip-gyBp9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:11 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)) 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:11 INFO - Running setup.py (path:/tmp/pip-HR6EEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:11 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)) 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:11 INFO - Running setup.py (path:/tmp/pip-UbB2wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:11 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)) 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:11 INFO - Running setup.py (path:/tmp/pip-qQ1Z_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:11 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)) 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:11 INFO - Running setup.py (path:/tmp/pip-OlnsaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:11 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)) 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:11 INFO - Running setup.py (path:/tmp/pip-wKeuyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:11 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)) 16:02:11 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)) 16:02:11 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)) 16:02:11 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)) 16:02:11 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)) 16:02:11 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)) 16:02:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:13 INFO - Downloading blessings-1.6.tar.gz 16:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:13 INFO - Installing collected packages: blessings 16:02:13 INFO - Running setup.py install for blessings 16:02:13 INFO - Successfully installed blessings 16:02:13 INFO - Cleaning up... 16:02:13 INFO - Return code: 0 16:02:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:13 INFO - Reading from file tmpfile_stdout 16:02:13 INFO - Current package versions: 16:02:13 INFO - argparse == 1.2.1 16:02:13 INFO - blessings == 1.6 16:02:13 INFO - blobuploader == 1.2.4 16:02:13 INFO - docopt == 0.6.1 16:02:13 INFO - functools32 == 3.2.3-2 16:02:13 INFO - jsonschema == 2.5.1 16:02:13 INFO - manifestparser == 1.1 16:02:13 INFO - mozInstall == 1.12 16:02:13 INFO - mozcrash == 1.0 16:02:13 INFO - mozdebug == 0.1 16:02:13 INFO - mozdevice == 0.48 16:02:13 INFO - mozfile == 1.2 16:02:13 INFO - mozhttpd == 0.7 16:02:13 INFO - mozinfo == 0.9 16:02:13 INFO - mozleak == 0.1 16:02:13 INFO - mozlog == 3.4 16:02:13 INFO - moznetwork == 0.27 16:02:13 INFO - mozprocess == 0.23 16:02:13 INFO - mozprofile == 0.28 16:02:13 INFO - mozrunner == 6.13 16:02:13 INFO - mozscreenshot == 0.1 16:02:13 INFO - mozsystemmonitor == 0.3 16:02:13 INFO - moztest == 0.8 16:02:13 INFO - mozversion == 1.4 16:02:13 INFO - psutil == 3.1.1 16:02:13 INFO - requests == 1.2.3 16:02:13 INFO - wsgiref == 0.1.2 16:02:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:13 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 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:02:13 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 16:02:13 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 16:02:13 INFO - Using env: {'DISPLAY': ':0', 16:02:13 INFO - 'HOME': '/home/cltbld', 16:02:13 INFO - 'LANG': 'en_US.UTF-8', 16:02:13 INFO - 'LANGUAGE': 'en_US:en', 16:02:13 INFO - 'LOGNAME': 'cltbld', 16:02:13 INFO - 'MAIL': '/var/mail/cltbld', 16:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:13 INFO - 'MOZ_NO_REMOTE': '1', 16:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:13 INFO - 'NO_EM_RESTART': '1', 16:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:13 INFO - 'PWD': '/builds/slave/test', 16:02:13 INFO - 'SHELL': '/bin/bash', 16:02:13 INFO - 'SHLVL': '1', 16:02:13 INFO - 'TERM': 'linux', 16:02:13 INFO - 'TMOUT': '86400', 16:02:13 INFO - 'USER': 'cltbld', 16:02:13 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:13 INFO - '_': '/tools/buildbot/bin/python'} 16:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 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)) 16:02:14 INFO - Cleaning up... 16:02:14 INFO - Return code: 0 16:02:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcac2caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, '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': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', '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 16:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:02:14 INFO - Using env: {'DISPLAY': ':0', 16:02:14 INFO - 'HOME': '/home/cltbld', 16:02:14 INFO - 'LANG': 'en_US.UTF-8', 16:02:14 INFO - 'LANGUAGE': 'en_US:en', 16:02:14 INFO - 'LOGNAME': 'cltbld', 16:02:14 INFO - 'MAIL': '/var/mail/cltbld', 16:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:14 INFO - 'MOZ_NO_REMOTE': '1', 16:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:14 INFO - 'NO_EM_RESTART': '1', 16:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:14 INFO - 'PWD': '/builds/slave/test', 16:02:14 INFO - 'SHELL': '/bin/bash', 16:02:14 INFO - 'SHLVL': '1', 16:02:14 INFO - 'TERM': 'linux', 16:02:14 INFO - 'TMOUT': '86400', 16:02:14 INFO - 'USER': 'cltbld', 16:02:14 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:14 INFO - '_': '/tools/buildbot/bin/python'} 16:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:02:14 INFO - Cleaning up... 16:02:14 INFO - Return code: 0 16:02:14 INFO - Running post-action listener: _resource_record_post_action 16:02:14 INFO - Running post-action listener: _start_resource_monitoring 16:02:14 INFO - Starting resource monitoring. 16:02:14 INFO - [mozharness: 2017-02-11 00:02:14.370671Z] Finished create-virtualenv step (success) 16:02:14 INFO - [mozharness: 2017-02-11 00:02:14.371122Z] Running install step. 16:02:14 INFO - Running pre-action listener: _resource_record_pre_action 16:02:14 INFO - Running main action method: install 16:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:14 INFO - Reading from file tmpfile_stdout 16:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:02:14 INFO - Reading from file tmpfile_stdout 16:02:14 INFO - Output received: 16:02:14 INFO - Usage: mozinstall [options] installer 16:02:14 INFO - Options: 16:02:14 INFO - -h, --help show this help message and exit 16:02:14 INFO - -d DEST, --destination=DEST 16:02:14 INFO - Directory to install application into. [default: 16:02:14 INFO - "/builds/slave/test"] 16:02:14 INFO - --app=APP Application being installed. [default: firefox] 16:02:14 INFO - mkdir: /builds/slave/test/build/application 16:02:14 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'] 16:02:14 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 16:02:28 INFO - Reading from file tmpfile_stdout 16:02:28 INFO - Output received: 16:02:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:02:28 INFO - Running post-action listener: _resource_record_post_action 16:02:28 INFO - [mozharness: 2017-02-11 00:02:28.290665Z] Finished install step (success) 16:02:28 INFO - [mozharness: 2017-02-11 00:02:28.290906Z] Running run-tests step. 16:02:28 INFO - Running pre-action listener: _resource_record_pre_action 16:02:28 INFO - Running main action method: run_tests 16:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:02:28 INFO - Python 2.7.3 16:02:28 INFO - Return code: 0 16:02:28 INFO - grabbing minidump binary from tooltool 16:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:28 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 0x2ab0f60>, '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 0x2ab1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:02:28 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 16:02:28 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 16:02:28 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 16:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:02:28 INFO - Return code: 0 16:02:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:02:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:02:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:02:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:02:28 INFO - Using env: {'DISPLAY': ':0', 16:02:28 INFO - 'HOME': '/home/cltbld', 16:02:28 INFO - 'LANG': 'en_US.UTF-8', 16:02:28 INFO - 'LANGUAGE': 'en_US:en', 16:02:28 INFO - 'LOGNAME': 'cltbld', 16:02:28 INFO - 'MAIL': '/var/mail/cltbld', 16:02:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:28 INFO - 'MOZ_NO_REMOTE': '1', 16:02:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:28 INFO - 'NO_EM_RESTART': '1', 16:02:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:28 INFO - 'PWD': '/builds/slave/test', 16:02:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:28 INFO - 'SHELL': '/bin/bash', 16:02:28 INFO - 'SHLVL': '1', 16:02:28 INFO - 'TERM': 'linux', 16:02:28 INFO - 'TMOUT': '86400', 16:02:28 INFO - 'USER': 'cltbld', 16:02:28 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664', 16:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:28 INFO - '_': '/tools/buildbot/bin/python'} 16:02:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:02:28 INFO - mozversion application_buildid: 20170210140619 16:02:28 INFO - mozversion application_changeset: f29a51aaae32824ec1202953991cdb098f25b056 16:02:28 INFO - mozversion application_display_name: Firefox 16:02:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:02:28 INFO - mozversion application_name: Firefox 16:02:28 INFO - mozversion application_remotingname: firefox 16:02:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:02:28 INFO - mozversion application_vendor: Mozilla 16:02:28 INFO - mozversion application_version: 52.0 16:02:28 INFO - mozversion platform_buildid: 20170210140619 16:02:28 INFO - mozversion platform_changeset: f29a51aaae32824ec1202953991cdb098f25b056 16:02:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:02:28 INFO - mozversion platform_version: 52.0 16:02:28 INFO - using testdate: 1486771348 16:02:28 INFO - actual date: 1486771348 16:02:28 INFO - starting webserver on 'localhost:46124' 16:02:28 INFO - SUITE-START | Running 2 tests 16:02:28 INFO - TEST-START | dromaeo_css 16:02:28 INFO - operating with platform_type : linux_ 16:02:28 INFO - Initialising browser for dromaeo_css test... 16:02:28 INFO - TEST-INFO | started process 32057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYCOnB/profile http://localhost:46124/getInfo.html) 16:02:33 INFO - PROCESS | 32057 | __metrics Screen width/height:1600/1200 16:02:33 INFO - PROCESS | 32057 | colorDepth:24 16:02:33 INFO - PROCESS | 32057 | Browser inner width/height: 1024/697 16:02:33 INFO - PROCESS | 32057 | __metrics 16:02:33 ERROR - PROCESS | 32057 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 16:02:34 INFO - TEST-INFO | 32057: exit 0 16:02:34 INFO - Browser initialized. 16:02:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:02:34 INFO - TEST-INFO | started process 32187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYCOnB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:46 INFO - PROCESS | 32187 | RSS: Main: 148033536 16:02:46 INFO - PROCESS | 32187 | 16:05:46 INFO - PROCESS | 32187 | Cycle 1(1): loaded http://localhost:46124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46124/tests/dromaeo/cssquery-ext.html) 16:05:47 INFO - PROCESS | 32187 | RSS: Main: 154099712 16:05:47 INFO - PROCESS | 32187 | 16:08:49 INFO - PROCESS | 32187 | Cycle 1(1): loaded http://localhost:46124/tests/dromaeo/cssquery-ext.html (next: http://localhost:46124/tests/dromaeo/cssquery-jquery.html) 16:08:50 INFO - PROCESS | 32187 | RSS: Main: 151736320 16:08:50 INFO - PROCESS | 32187 | 16:11:51 INFO - PROCESS | 32187 | Cycle 1(1): loaded http://localhost:46124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46124/tests/dromaeo/cssquery-mootools.html) 16:11:52 INFO - PROCESS | 32187 | RSS: Main: 152117248 16:11:52 INFO - PROCESS | 32187 | 16:14:54 INFO - PROCESS | 32187 | Cycle 1(1): loaded http://localhost:46124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46124/tests/dromaeo/cssquery-prototype.html) 16:14:54 INFO - PROCESS | 32187 | RSS: Main: 153370624 16:14:54 INFO - PROCESS | 32187 | 16:17:57 INFO - PROCESS | 32187 | Cycle 1(1): loaded http://localhost:46124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46124/tests/dromaeo/cssquery-yui.html) 16:17:57 INFO - PROCESS | 32187 | RSS: Main: 153739264 16:17:57 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | Cycle 1(1): loaded http://localhost:46124/tests/dromaeo/cssquery-yui.html (next: http://localhost:46124/tests/dromaeo/cssquery-dojo.html) 16:21:00 INFO - PROCESS | 32187 | RSS: Main: 154988544 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | __start_tp_report 16:21:00 INFO - PROCESS | 32187 | _x_x_mozilla_page_load 16:21:00 INFO - PROCESS | 32187 | _x_x_mozilla_page_load_details 16:21:00 INFO - PROCESS | 32187 | |i|pagename|runs| 16:21:00 INFO - PROCESS | 32187 | |0;dojo.html;3291.6708329167086;3310.5696259486263;3314.8729431993124;3320.966790332096;3336.2993771308024;5652.152177173426;5688.317401911776;5708.971455142729;5740.770369185233;5744.33940096889;5735.340435849868;5793.623414478056;5803.274590676166;5815.244018277618;5857;5192.714400707969;5250.186221135711;5264;5292.788288468476;5302.681839089648;5282.550983166436;5287.154055351145;5288.206768984644;5295.602829787781;5316.893662126755;4993.101241776479;5017.874553136165;5309.787608495655;5318.946810531884;5323.22813192087;5116.437191908887;5179.430262671103;5215.348081489814;5234.502722241381;5321.122014867542;5149.613778966593;5222.268882356435;5241.764120614582;5253.290805741214;5270.446603106657;5698.230738850244;5719.8570035749435;5764.538836893039;5797.565182611321;5836.795712150054;5860.384659610765;5938.049912014057;5948.940510594882;5975.043992961106;6010.489108425789;6049.909251361233;6060.212172417558;6077.574569780118;6140.780336713802;6157.969210153965;5715.485606295453;5717.71411429431;5730.140478928152;5739.913901291484;5740.684262365527;6116.1836049259855;6135.2326666699655;6158.922188616974;6258.155149054819;6261.592996455216;5953;5984.491318237911;5995.490383317379;5997.430244126801;6007.879842403215;6063.878722425527;6072.8785424292155;6078.3921607838865;6084.604500707528;6093.96953015241;5828.854278643068;5936.673482958478;5979.880402392015;6014.278286605635;6028;6051.394860514001;6056.878862422815;6059.666718330534;6063.787767428119;6079.817605471843;4610.792514336863;4670.416197975253;4678.391809064799;4680.157571637138;4684.039771846763;4061.756294622332;4069.674426045909;4100.671946244293;4124.422580838685;4143.3784932260405;5796.188533605298;5821.650700957956;5824.970875145597;5827.009408400582;5869.383714709979;6089.756409743649;6144;6154.723037463235;6156.984097623931;6161.137440758297;5601.831945041656;5611.326640803048;5624.943750562524;5809.883802324014;5854.151148083504;5173.120569503193;5182.663126896739;5196.818111366084;5201.063808514504;5236.136037553837;6050.54620903434;6089.269287685506;6093.939060609426;6098.14625952367;6105.32841387447;5907.172995780508;5965.821025369246;5995.820125396245;6015.939840601538;6034.487068599043;6135.11040899076;6138.570300078952;6145.569810113249;6214.5028397728975;6226.750929962751;5934.732937017931;5934.7922822701;5939.10913362999;5941.287045554561;5941.792037278675;5916.319623243382;6051.243594550681;6065.484433822998;6068.544859135494;6082.787102451393;5767.5385969121535;5850.64896106235;5871.500922421471;5889.175515427929;5969.134475500941;5892.793752218652;5893.410658934073;5893.793717220048;5895.380984996514;5900.468957793819;5751.626144300607;5852.770918107245;5859.44335288147;5868.970655146697;5871.412858714094;5711.371749107512;5771.336296325809;5831.475167234969;5894.410558944071;5898.734556945034;5811.970940145441;5822.737976791139;5867.559933005127;5868.794592189253;5875.148103525051 16:21:00 INFO - PROCESS | 32187 | |1;ext.html;588.8939990801657;620.8230654263534;634.5399585300657;651.4657980456028;660.857915548157;44566.33150502741;45607;45828;45985.62043138707;46001.53998460019;44837.55162448374;44963;45170.548294517044;45308.77345613275;45352.3197152043;8907.10928907109;9036.728898133033;9051.366404351698;9061.773455663628;9085.954570227173;8984;9048.366614337;9061.728148155566;9098.954505227464;9113.544322783868;9051.049639787827;9081.091890810932;9099.04460031697;9099.95450022749;9108.22580080694;9036.186743193079;9053.366264361497;9089.136532029446;9090.545472726337;9093.727188184364;8935;8968.05835387288;8986.101389861027;9033;9047.592858321392;42165.78917105425;42499.15001699948;42522;42533.36199957003;42744.3588346175;3556.5020897074432;3667.743257971943;3728.850845966158;3791.1280405506614;3821.73247872649;31515.369692606248;31678;31741.523877141863;32074.198145046328;32506.18734531632;4189.944134078222;4210.32634778437;4241.4698162729655;4266.146770645883;4272.273713468718;330867;332132;333755;334578;335488;59795.402045979856;60174.699126504085;60241.39758602445;60333.69833150894;60392.39607603956;60739.39260607426;60870.39129608736;61157.08264376038;61637.38362616406;61940;18173.182206800724;18219.635607288044;18290;18369.63260734778;18392.356267530573;14119;14236.501722439665;14267.85732142686;14276.643083922985;14286.142831430148;16873.831261687472;16923.238454269587;17271.654566908845;17274.568135796704;17400.129993500275;6140.324564297924;6185;6218.875622487525;6242.1261023456755;6292.779752708633;1004.9899501004896;1045.1273186888882;1090.334895713614;1136.852209212797;1155.6359746679768;31434.68565314363;31630.525542116888;31664.442478495184;31722.206944826565;32216.19459513531;1127.2729089737074;1136.4374634555948;1142.737170450801;1202.1765090912752;1251.224240970586;16598.41905533325;16687.666246675;16715.247813848408;16880.662386752196;17086.48740537786;465629;470087;470519;471223;473579;59124.70437647784;59240;59448.70275648594;59526.40473595295;59534.70232648809;1383.5503461375092;1385.930703464843;1432.2480697633616;1433.118632041308;1436.3967133803828;30133.698663013965;30352.010955671944;30939.84530077335;31481.842590787815;31958;51417.228741569656;51614.483855160965;51690.22464662958;51696.48303517067;51905.7404712974;395828;395871;397309;397802;398257;41665.16669666529;41896;43226.567734322256;43234;43315;46029.76985115053;46779.53220467888;47364.289535657685;47657.285140722226;48062.03875922532;38397.232055359294;39076;40651.59348406478;43865;44381;40982.38526422166;41346.38338505548;41424;41918;42127.57872421236;39510;40376.1924761509;40498.190036198524;40623.187536248515;40963.59036409598;33672.326553469284;34612;35154;35404.46893296551;35499.82250088733;27490.312742181606;28445.431091378472;28627.713722862503;28649.42701146007;28662.856685717274 16:21:00 INFO - PROCESS | 32187 | |2;jquery.html;431.5464407316493;434.87584593824965;436.3149854728078;437.4990635722098;448.3118413235686;18834.34079807207;19089.23643054278;20217.59564808703;20310.593788124228;20392.286269980552;19662.115204815782;19873.304434344802;19967.60064798703;20143.395698129043;20248.493787655316;5858.53131749459;6119.3574674659185;6127.7855275065385;6136.3863613638505;6145.446909778119;5872.207252020987;5993.820185394445;6016.338202797689;6044.576879618428;6054.364291749369;6024.789132380368;6026.758929642831;6032.7285272162635;6033.607815492001;6044.274687037561;5822.563307751914;5943.791967281124;5959.195508606348;5981.9401805981815;6023.969880150615;5403;5420.13277875542;5424.511793938565;5428.9185662215095;5430.456954304538;14064.156150630995;15573.299201535958;21923;22699.978500967332;22919.312420627408;2465.469923966356;2498.287987923451;2924.6051783009234;3099.0857696979447;3131.5146152346424;10453.372797632166;10793.460326983697;10960.12319014477;11099.83350249747;11482.425878706032;1943.689009758432;2080.4382816639572;2083.0834432849497;2085.655866781979;2088.4361222469847;79384;82902.58548707278;85325.57337213337;85751;87252.56373718154;11723;11736;11863.881361186277;11869.5845645402;12057.095717821023;16896.915515422344;16898.74651880223;16906.40827571029;16945.152742362832;16950.321987120624;7559.1684914659345;7939.364850811921;8011.519308841372;8210.507369557727;8221;7393.816989281797;7473.58895260755;7617.809554761176;7632.8473430532185;7681.5775132367135;5019.799208031638;5108.310378098983;5156.355455568054;5173.960721762506;5223.895522089613;2010.266252817711;2059.6086743518686;2086.7287252657056;2098.3390232076845;2130.1585873579847;967.260046064761;985.8126955878361;991.8016396720685;995.8605795188679;1000.2448151645607;19333.226670933003;19546.90226548858;19767.703484447746;19827.900860495894;19914.90042549807;996.1035068438464;1014.4369874719454;1017.7557386227252;1032.7624646331385;1086.9076128529005;10729.731756705989;11144.554217831359;11167.664970050912;11185.105191584817;11217.775644487065;448411;482086;483697;487308;487826;53109;64615;89618;94392;95943;980.2501086668705;1014.4572653630272;1017.5522769981185;1024.8770147582188;1025.1542477456128;16893.239804209086;17176.82823171752;17567.560810979827;17588.208530616408;17777.46667599974;41191.382129267484;41693;41868.3719744198;42340.78829605832;43340;54576.45423545714;58046.709766452586;58641.41358586359;59661.10508342465;60236.39763602308;8810.779730506789;8842.91157088421;8956.328275379243;9103.90896091057;9350.309697190482;9834.508274586386;12850.293233871853;13162.736745264849;13550.59348219555;13795.724085518434;11347.659570212907;11818.586349477728;11850.466728997388;12005.279683219034;12037.277763334228;11488.02351800073;11726.296422214695;11774.234674746114;11838.763224735629;12112.818307725214;11942.820857687315;12030.458629361874;12051.57819476314;12101.576444824741;12263.509459621515;8841.115888411108;9032.729018129467;9104.726858194264;9190.586423611087;9402.717918462457;8955.552222388986;11396.145289103184;11446.599369022044;11452.14108941816;11479.713007174887 16:21:00 INFO - PROCESS | 32187 | |3;mootools.html;1511.9092854428732;1532.6664504702271;1711.9315227390905;1820.0353812479382;1826.97259541107;8020.799480012988;8274.2966847818;8640.65437382504;9201.539923003857;9212.170904618582;8239;8589;8592.35557333201;8745.34409919257;8780.517071561078;2467.0871777442326;2500.6624105745673;2501.8373805702663;2508.159766478232;2512.108201588428;2333.6032874411308;2436.196055301746;2437.244454219189;2438.0979037756056;2442.523707876956;2473.8763061846926;2477.4549599088173;2487.328421326241;2502.874856257189;2506.147909710698;2394.95210095798;2426.3934016495878;2431.756824317572;2435.8538487690794;2450.5956517174645;2439.353571303606;2450.7059152901766;2451.521953219123;2460.8400453970435;2472.27068014936;8779;8817.79749947534;8829.867551986725;8846.646134154626;8858.778530536723;5565.0817615093865;5630.690312032836;5711.8000869969765;5714.1428785682065;5716.056850619642;3420.4698271767916;3448.81031543265;3463.688268055887;3464.670856268676;3521.7710848795004;1083.1389045708681;1085.0234788690163;1095.2388090277261;1096.5065720425841;1138.4421633399656;12736.554220602235;12762.489500419972;12768;12769.042321825807;12842.678933026657;4770.737609431445;4964.329815474937;4994.40067191932;4995.950040499549;5007.69953802773;10237.641682541223;10242.48787560619;10257.281990260759;10260.948695256626;10272.743181420376;5578.023845826964;5583.497485226349;5589.413111623302;5595.076812326002;5599.412061733541;5060.924086138711;5156.149235376196;5222.817201397933;5269.394019687708;5269.604779641542;3968.583298753647;4048.9797551012057;4086.9182616347507;4114.1977314424;4140.358244472111;1209.407390378708;1211.7818792617413;1218.3603608105816;1221.712897469094;1262.9810552841714;977.6040703515088;984.3257368702461;989.7228775942748;1009.1623952119724;1020.8009438159488;6095.055266433621;6185.288691800501;6256.155419018374;6401.3598640135615;6425.228972523327;970.6069042037985;982.7199248214367;992.2905122837207;1018.4602160854758;1035.5081336365317;3867.1878905430176;3999.3642342002126;4016.397540368968;4041.131156801243;4044.130511939888;10464.424456654957;11247;11293.54825806975;11295.774084518427;11328.03711684516;11077.335359878432;11145.108391328675;11231.326120432801;11249.66251012471;11285;8310.667573297122;8443;8470.407071504935;8472.110428405053;8473.067962524117;5743.540516758733;5769.884602308014;5829.53363730892;5886.58793884424;5897.5576831736935;10242.283040187116;10367.170626350025;10405.375677459377;10486.108680762221;10506.21203409732;10526.421046842497;10608.098311643596;10644.095251903365;10666.146708263475;10689.9465502672;7659.272369124924;7724.150343462103;7772.067351917806;7905.367570594223;8029.598520073856;8766.386352955233;8817.779555510908;8821.823563528566;8823.294136469196;8826.91173088261;7188.856222875409;7289.635518223961;7449.776506704808;7478.4765066444825;7485.139208990818;7369.963150184215;7384.076990376203;7401.5189012714;7431.591262480615;7531.209223031722;7171.856562868609;7259.6007219603425;7286.7085316586745;7307.7807665770115;7334.853302933805;5337;5362.249285100167;5393.541548968225;5396.892062158657;5405.081136206775;5299.973500132474;5362.088444964287;5384.865378365572;5420.566354691694;5440.347158341025 16:21:00 INFO - PROCESS | 32187 | |4;prototype.html;359.915419876329;359.96040435552084;366.748777087695;373.3503703555814;377.64690014836145;5458.699771512565;5535.750891209896;5732.168835518847;5774.393688662688;5776.768929242825;5359.464053594638;5552.972235138819;5581.944180558193;5585.519837243134;5631.887362252753;4416.2933930571035;4417.801198946056;4450.132224216279;4485.340424043093;4487.708298960557;4200.915981680365;4397.714148580332;4410.448693913261;4489.406260777426;4504.527024662412;4373.322135069054;4375.8249670013165;4380.780960951955;4389.47326320842;4391.297392417214;4364.25807612705;4388.420168739267;4411.911761764747;4413.6607597973125;4477.529859364752;3855.383138697795;3933.331333673282;3955.3473676843287;3960.128771670228;3964.980175099135;5418.864528386822;5433.483819037225;5433.864153396157;5459.181122831567;5469.206964990054;5037.420696619899;5039.647224694273;5055.368078990126;5072.898542029176;5089.4147173074825;5706.315242170925;5900.468957793776;5918.478505289346;5929.703514824241;5940.821775346746;4236.4492615959725;4259.488861336628;4276.2089013532595;4278.507971583276;4284.892877678083;6096.847578810521;6132.754689812402;6149.169862068608;6154.63072215664;6187.783427580058;4311.361682560607;4335.566443355639;4352.499462561783;4357.389965404783;4393.75834329115;4392.231359512072;4408.206522825923;4413.801378937956;4414.889627759268;4421.624161946206;5010.799568017239;5021.14640511114;5024.723640199824;5054.69671819692;5055.266986286968;5773.364929857712;5804.303483581913;5909.852253693606;5929.140274660236;5947.5539334550085;1477.56411858502;1488.2112480385413;1493.2160615676858;1500.4298366620833;1500.4748338081583;971.3394891473724;998.6654470752234;1004.0060340263087;1008.8991100889853;1009.152312057875;5500.834974950758;5524.502794748411;5554.888902221933;5557.3886872444;5563.193336966117;5936.5250779937505;5956.672383018976;5986.73059712314;6037.766026570197;6065.423784740443;5445.618806683494;5525.557955363562;5533.557315414757;5559.360673522516;5574.219609254707;3161.351922855809;3162.0355791483357;3180.3480286541203;3192.393445245396;3195.4981158855303;5735.569832262597;5920.8815823684145;5982.282126144803;5984.174826677818;5996.940030599725;5865.794697185578;5927.95485557482;5954.940450595525;5957.702114894325;6003.189569408074;5953.255843019622;5967.433093856077;5994.730237139339;6030.246219222598;6033.728482218311;5822;5903.321118071477;6135.570510064253;6178.62928224308;6194.473469755121;6053.60651557665;6135.601185922901;6151.169592105188;6162.691865406622;6172.969135154295;6131.816045518642;6205.286392064971;6212.378762123752;6307.779227727007;6314.968425157845;4355.237833379209;4381.225603630534;4385.934210986901;4400.69195156336;4400.867973960786;5978.790742323998;6150.969245153746;6170;6188.597741146811;6205.627662340274;5943.257092863392;5982.820515384546;5984.640921544721;5996.130561068708;6011.87976240464;5943.662675898061;6027.065804800263;6028.849278768066;6028.969855150696;6036.63780173191;5656.632318899258;5880.794172203952;5916.763329466773;5924.259467566554;5938.168656388023;5946.881062378641;5993.430624090704;6022.728977196124;6036.849078773066;6091.634501929899;5646.616578938187;5808.244928159313;5871.6770577616935;5884.32330282023;5919.4080591940465 16:21:00 INFO - PROCESS | 32187 | |5;yui.html;727.9708811647535;738.6491416577127;767.5049593012507;776.1346099099499;824.7031068815226;12493.875061249397;12878.3560821959;12906.032047596422;12929.288889111107;12990.870091299084;14220.431182752704;14488.058276212065;14501.564953051398;14510.492132775329;14513.564593062225;836.514821403586;886.1315910407804;890.2210565754932;895.6999405199266;896.8385690575694;876.7545087375545;877.6577134917387;878.9516576588285;879.0857508191473;879.432765866016;934.9065093490665;935.1863878425745;935.2377812083131;935.3546053223288;940.5485367023832;925.6575067225102;929.0709290709291;930.2465003347277;931.5714771205186;934.9485778282192;686.5983399711175;687.3538873458982;690;690.0167261652176;690.1063123255396;15166.31751571182;15341.463048793239;15387.923060384739;15396.923015384964;15472.767908481383;13920.721585568232;14329.641758956006;14423;14468.927655361762;14563.490277840225;11127.332360058423;11190.472654915913;11287.717807054807;11299.322040677585;11480.71298217543;3735.495708079429;3754.5869954305003;3776.716746244015;3790.6777923876502;3818.8663396781258;62822.85885705696;63851.68074159599;64245.35754642487;64747.352526474606;65038.34961650417;9815.10367507517;9945.15466185368;9988.900110998797;10351.534180961875;10587.205959553065;20490.897545512176;20519.794802052085;20524.973751312376;20581.897090514452;20685.896570517052;6351.269603995507;6762.797116086525;6875.140607424072;6894.207166175854;7770.650320735581;4355.324924636687;4357.085012147421;4401.2517871961845;4424.889377765581;4444.577765112309;3340.599128104643;3437.4843773434186;3455.274392377629;3459.584849818038;3463.913402164966;605.7637521366671;611.1321922869536;615.5937081526171;617.4658920034138;623.6102435977514;528.8862894477705;578.9318706985605;657.273712547628;681.3595220492721;686.8763622547889;8211.548364839991;8479.19447652472;8582.356323275779;8698.086700896441;8730.432521886058;575.4590684756315;582.5805420097523;611.4924612571555;626.8025571944822;670.6847781542667;4305.935410968838;4319.416878721395;4406.162829062468;4457.04173602677;4462.531434199427;86431.56784216038;88711;89505.55247223722;92313.0768692318;93485.5325723367;51307.486925131016;62660;71486;76504.61747691338;79721.60139199383;63984;64224.357756422774;64643.35356646373;64901.35098649048;65215.34784652188;8982;9074.137956894085;9154;9200.35597508168;9308.208802251613;34434.82782586071;37875.62124378721;40850.38724419195;42314.36528452137;46209.53790462052;57884.4211557879;59651.40348596458;60581.39418605757;61005;62527.6873615629;11221.66335009951;11400.372979485875;11582.710432238924;11868.287902725864;11986.160968732454;12656.683582910133;12932.482700691868;13198.07613467048;13247.693681182345;13478.460861565427;12374.319412432042;12735.426905789076;12991.870081299445;13068.085234033526;13223.933880330536;11805.527778888749;11819.349935753617;12111.576094836992;12291.75416491683;12452.439640216393;11220.831687524531;11344.659660210207;11644.6506604802;11981.341026243641;12246.203996740183;9821.263405244492;9955.651552195639;10107.949460252652;10170.949145254226;10202.183825294107;10526.31578947366;10590.364578125029;10616.628418005334;10671;10752 16:21:00 INFO - PROCESS | 32187 | __end_tp_report 16:21:00 INFO - PROCESS | 32187 | __start_cc_report 16:21:00 INFO - PROCESS | 32187 | _x_x_mozilla_cycle_collect,299 16:21:00 INFO - PROCESS | 32187 | __end_cc_report 16:21:00 INFO - PROCESS | 32187 | __startTimestamp1486772460376__endTimestamp 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | ------- Summary: start ------- 16:21:00 INFO - PROCESS | 32187 | Number of tests: 6 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | [#0] dojo.html Cycles:165 Average:5634.73 Median:5854.15 stddev:615.99 (10.5%) stddev-sans-first:589.82 16:21:00 INFO - PROCESS | 32187 | Values: 3291.7 3310.6 3314.9 3321.0 3336.3 5652.2 5688.3 5709.0 5740.8 5744.3 5735.3 5793.6 5803.3 5815.2 5857.0 5192.7 5250.2 5264.0 5292.8 5302.7 5282.6 5287.2 5288.2 5295.6 5316.9 4993.1 5017.9 5309.8 5318.9 5323.2 5116.4 5179.4 5215.3 5234.5 5321.1 5149.6 5222.3 5241.8 5253.3 5270.4 5698.2 5719.9 5764.5 5797.6 5836.8 5860.4 5938.0 5948.9 5975.0 6010.5 6049.9 6060.2 6077.6 6140.8 6158.0 5715.5 5717.7 5730.1 5739.9 5740.7 6116.2 6135.2 6158.9 6258.2 6261.6 5953.0 5984.5 5995.5 5997.4 6007.9 6063.9 6072.9 6078.4 6084.6 6094.0 5828.9 5936.7 5979.9 6014.3 6028.0 6051.4 6056.9 6059.7 6063.8 6079.8 4610.8 4670.4 4678.4 4680.2 4684.0 4061.8 4069.7 4100.7 4124.4 4143.4 5796.2 5821.7 5825.0 5827.0 5869.4 6089.8 6144.0 6154.7 6157.0 6161.1 5601.8 5611.3 5624.9 5809.9 5854.2 5173.1 5182.7 5196.8 5201.1 5236.1 6050.5 6089.3 6093.9 6098.1 6105.3 5907.2 5965.8 5995.8 6015.9 6034.5 6135.1 6138.6 6145.6 6214.5 6226.8 5934.7 5934.8 5939.1 5941.3 5941.8 5916.3 6051.2 6065.5 6068.5 6082.8 5767.5 5850.6 5871.5 5889.2 5969.1 5892.8 5893.4 5893.8 5895.4 5900.5 5751.6 5852.8 5859.4 5869.0 5871.4 5711.4 5771.3 5831.5 5894.4 5898.7 5812.0 5822.7 5867.6 5868.8 5875.1 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | [#1] ext.html Cycles:180 Average:57427.98 Median:23168.95 stddev:106538.12 (459.8%) stddev-sans-first:106751.51 16:21:00 INFO - PROCESS | 32187 | Values: 588.9 620.8 634.5 651.5 660.9 44566.3 45607.0 45828.0 45985.6 46001.5 44837.6 44963.0 45170.5 45308.8 45352.3 8907.1 9036.7 9051.4 9061.8 9086.0 8984.0 9048.4 9061.7 9099.0 9113.5 9051.0 9081.1 9099.0 9100.0 9108.2 9036.2 9053.4 9089.1 9090.5 9093.7 8935.0 8968.1 8986.1 9033.0 9047.6 42165.8 42499.2 42522.0 42533.4 42744.4 3556.5 3667.7 3728.9 3791.1 3821.7 31515.4 31678.0 31741.5 32074.2 32506.2 4189.9 4210.3 4241.5 4266.1 4272.3 330867.0 332132.0 333755.0 334578.0 335488.0 59795.4 60174.7 60241.4 60333.7 60392.4 60739.4 60870.4 61157.1 61637.4 61940.0 18173.2 18219.6 18290.0 18369.6 18392.4 14119.0 14236.5 14267.9 14276.6 14286.1 16873.8 16923.2 17271.7 17274.6 17400.1 6140.3 6185.0 6218.9 6242.1 6292.8 1005.0 1045.1 1090.3 1136.9 1155.6 31434.7 31630.5 31664.4 31722.2 32216.2 1127.3 1136.4 1142.7 1202.2 1251.2 16598.4 16687.7 16715.2 16880.7 17086.5 465629.0 470087.0 470519.0 471223.0 473579.0 59124.7 59240.0 59448.7 59526.4 59534.7 1383.6 1385.9 1432.2 1433.1 1436.4 30133.7 30352.0 30939.8 31481.8 31958.0 51417.2 51614.5 51690.2 51696.5 51905.7 395828.0 395871.0 397309.0 397802.0 398257.0 41665.2 41896.0 43226.6 43234.0 43315.0 46029.8 46779.5 47364.3 47657.3 48062.0 38397.2 39076.0 40651.6 43865.0 44381.0 40982.4 41346.4 41424.0 41918.0 42127.6 39510.0 40376.2 40498.2 40623.2 40963.6 33672.3 34612.0 35154.0 35404.5 35499.8 27490.3 28445.4 28627.7 28649.4 28662.9 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | [#2] jquery.html Cycles:180 Average:28524.88 Median:3115.30 stddev:78732.99 (2527.3%) stddev-sans-first:78925.60 16:21:00 INFO - PROCESS | 32187 | Values: 431.5 434.9 436.3 437.5 448.3 18834.3 19089.2 20217.6 20310.6 20392.3 19662.1 19873.3 19967.6 20143.4 20248.5 5858.5 6119.4 6127.8 6136.4 6145.4 5872.2 5993.8 6016.3 6044.6 6054.4 6024.8 6026.8 6032.7 6033.6 6044.3 5822.6 5943.8 5959.2 5981.9 6024.0 5403.0 5420.1 5424.5 5428.9 5430.5 14064.2 15573.3 21923.0 22700.0 22919.3 2465.5 2498.3 2924.6 3099.1 3131.5 10453.4 10793.5 10960.1 11099.8 11482.4 1943.7 2080.4 2083.1 2085.7 2088.4 79384.0 82902.6 85325.6 85751.0 87252.6 11723.0 11736.0 11863.9 11869.6 12057.1 16896.9 16898.7 16906.4 16945.2 16950.3 7559.2 7939.4 8011.5 8210.5 8221.0 7393.8 7473.6 7617.8 7632.8 7681.6 5019.8 5108.3 5156.4 5174.0 5223.9 2010.3 2059.6 2086.7 2098.3 2130.2 967.3 985.8 991.8 995.9 1000.2 19333.2 19546.9 19767.7 19827.9 19914.9 996.1 1014.4 1017.8 1032.8 1086.9 10729.7 11144.6 11167.7 11185.1 11217.8 448411.0 482086.0 483697.0 487308.0 487826.0 53109.0 64615.0 89618.0 94392.0 95943.0 980.3 1014.5 1017.6 1024.9 1025.2 16893.2 17176.8 17567.6 17588.2 17777.5 41191.4 41693.0 41868.4 42340.8 43340.0 54576.5 58046.7 58641.4 59661.1 60236.4 8810.8 8842.9 8956.3 9103.9 9350.3 9834.5 12850.3 13162.7 13550.6 13795.7 11347.7 11818.6 11850.5 12005.3 12037.3 11488.0 11726.3 11774.2 11838.8 12112.8 11942.8 12030.5 12051.6 12101.6 12263.5 8841.1 9032.7 9104.7 9190.6 9402.7 8955.6 11396.1 11446.6 11452.1 11479.7 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | [#3] mootools.html Cycles:180 Average:5935.58 Median:4979.37 stddev:3335.45 (67.0%) stddev-sans-first:3328.24 16:21:00 INFO - PROCESS | 32187 | Values: 1511.9 1532.7 1711.9 1820.0 1827.0 8020.8 8274.3 8640.7 9201.5 9212.2 8239.0 8589.0 8592.4 8745.3 8780.5 2467.1 2500.7 2501.8 2508.2 2512.1 2333.6 2436.2 2437.2 2438.1 2442.5 2473.9 2477.5 2487.3 2502.9 2506.1 2395.0 2426.4 2431.8 2435.9 2450.6 2439.4 2450.7 2451.5 2460.8 2472.3 8779.0 8817.8 8829.9 8846.6 8858.8 5565.1 5630.7 5711.8 5714.1 5716.1 3420.5 3448.8 3463.7 3464.7 3521.8 1083.1 1085.0 1095.2 1096.5 1138.4 12736.6 12762.5 12768.0 12769.0 12842.7 4770.7 4964.3 4994.4 4996.0 5007.7 10237.6 10242.5 10257.3 10260.9 10272.7 5578.0 5583.5 5589.4 5595.1 5599.4 5060.9 5156.1 5222.8 5269.4 5269.6 3968.6 4049.0 4086.9 4114.2 4140.4 1209.4 1211.8 1218.4 1221.7 1263.0 977.6 984.3 989.7 1009.2 1020.8 6095.1 6185.3 6256.2 6401.4 6425.2 970.6 982.7 992.3 1018.5 1035.5 3867.2 3999.4 4016.4 4041.1 4044.1 10464.4 11247.0 11293.5 11295.8 11328.0 11077.3 11145.1 11231.3 11249.7 11285.0 8310.7 8443.0 8470.4 8472.1 8473.1 5743.5 5769.9 5829.5 5886.6 5897.6 10242.3 10367.2 10405.4 10486.1 10506.2 10526.4 10608.1 10644.1 10666.1 10689.9 7659.3 7724.2 7772.1 7905.4 8029.6 8766.4 8817.8 8821.8 8823.3 8826.9 7188.9 7289.6 7449.8 7478.5 7485.1 7370.0 7384.1 7401.5 7431.6 7531.2 7171.9 7259.6 7286.7 7307.8 7334.9 5337.0 5362.2 5393.5 5396.9 5405.1 5300.0 5362.1 5384.9 5420.6 5440.3 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | [#4] prototype.html Cycles:180 Average:4967.86 Median:5568.71 stddev:1448.73 (26.0%) stddev-sans-first:1410.91 16:21:00 INFO - PROCESS | 32187 | Values: 359.9 360.0 366.7 373.4 377.6 5458.7 5535.8 5732.2 5774.4 5776.8 5359.5 5553.0 5581.9 5585.5 5631.9 4416.3 4417.8 4450.1 4485.3 4487.7 4200.9 4397.7 4410.4 4489.4 4504.5 4373.3 4375.8 4380.8 4389.5 4391.3 4364.3 4388.4 4411.9 4413.7 4477.5 3855.4 3933.3 3955.3 3960.1 3965.0 5418.9 5433.5 5433.9 5459.2 5469.2 5037.4 5039.6 5055.4 5072.9 5089.4 5706.3 5900.5 5918.5 5929.7 5940.8 4236.4 4259.5 4276.2 4278.5 4284.9 6096.8 6132.8 6149.2 6154.6 6187.8 4311.4 4335.6 4352.5 4357.4 4393.8 4392.2 4408.2 4413.8 4414.9 4421.6 5010.8 5021.1 5024.7 5054.7 5055.3 5773.4 5804.3 5909.9 5929.1 5947.6 1477.6 1488.2 1493.2 1500.4 1500.5 971.3 998.7 1004.0 1008.9 1009.2 5500.8 5524.5 5554.9 5557.4 5563.2 5936.5 5956.7 5986.7 6037.8 6065.4 5445.6 5525.6 5533.6 5559.4 5574.2 3161.4 3162.0 3180.3 3192.4 3195.5 5735.6 5920.9 5982.3 5984.2 5996.9 5865.8 5928.0 5954.9 5957.7 6003.2 5953.3 5967.4 5994.7 6030.2 6033.7 5822.0 5903.3 6135.6 6178.6 6194.5 6053.6 6135.6 6151.2 6162.7 6173.0 6131.8 6205.3 6212.4 6307.8 6315.0 4355.2 4381.2 4385.9 4400.7 4400.9 5978.8 6151.0 6170.0 6188.6 6205.6 5943.3 5982.8 5984.6 5996.1 6011.9 5943.7 6027.1 6028.8 6029.0 6036.6 5656.6 5880.8 5916.8 5924.3 5938.2 5946.9 5993.4 6022.7 6036.8 6091.6 5646.6 5808.2 5871.7 5884.3 5919.4 16:21:00 INFO - PROCESS | 32187 | 16:21:00 INFO - PROCESS | 32187 | [#5] yui.html Cycles:180 Average:17121.89 Median:25918.19 stddev:22811.61 (88.0%) stddev-sans-first:22842.38 16:21:00 INFO - PROCESS | 32187 | Values: 728.0 738.6 767.5 776.1 824.7 12493.9 12878.4 12906.0 12929.3 12990.9 14220.4 14488.1 14501.6 14510.5 14513.6 836.5 886.1 890.2 895.7 896.8 876.8 877.7 879.0 879.1 879.4 934.9 935.2 935.2 935.4 940.5 925.7 929.1 930.2 931.6 934.9 686.6 687.4 690.0 690.0 690.1 15166.3 15341.5 15387.9 15396.9 15472.8 13920.7 14329.6 14423.0 14468.9 14563.5 11127.3 11190.5 11287.7 11299.3 11480.7 3735.5 3754.6 3776.7 3790.7 3818.9 62822.9 63851.7 64245.4 64747.4 65038.3 9815.1 9945.2 9988.9 10351.5 10587.2 20490.9 20519.8 20525.0 20581.9 20685.9 6351.3 6762.8 6875.1 6894.2 7770.7 4355.3 4357.1 4401.3 4424.9 4444.6 3340.6 3437.5 3455.3 3459.6 3463.9 605.8 611.1 615.6 617.5 623.6 528.9 578.9 657.3 681.4 686.9 8211.5 8479.2 8582.4 8698.1 8730.4 575.5 582.6 611.5 626.8 670.7 4305.9 4319.4 4406.2 4457.0 4462.5 86431.6 88711.0 89505.6 92313.1 93485.5 51307.5 62660.0 71486.0 76504.6 79721.6 63984.0 64224.4 64643.4 64901.4 65215.3 8982.0 9074.1 9154.0 9200.4 9308.2 34434.8 37875.6 40850.4 42314.4 46209.5 57884.4 59651.4 60581.4 61005.0 62527.7 11221.7 11400.4 11582.7 11868.3 11986.2 12656.7 12932.5 13198.1 13247.7 13478.5 12374.3 12735.4 12991.9 13068.1 13223.9 11805.5 11819.3 12111.6 12291.8 12452.4 11220.8 11344.7 11644.7 11981.3 12246.2 9821.3 9955.7 10107.9 10170.9 10202.2 10526.3 10590.4 10616.6 10671.0 10752.0 16:21:00 INFO - PROCESS | 32187 | -------- Summary: end -------- 16:21:00 INFO - PROCESS | 32187 | 16:21:01 INFO - TEST-INFO | 32187: exit 0 16:21:01 INFO - TEST-OK | dromaeo_css | took 1112600ms 16:21:01 INFO - TEST-START | kraken 16:21:01 INFO - operating with platform_type : linux_ 16:21:01 INFO - Initialising browser for kraken test... 16:21:01 INFO - TEST-INFO | started process 32540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkn4G_/profile http://localhost:46124/getInfo.html) 16:21:05 INFO - PROCESS | 32540 | __metrics Screen width/height:1600/1200 16:21:05 INFO - PROCESS | 32540 | colorDepth:24 16:21:05 INFO - PROCESS | 32540 | Browser inner width/height: 1024/697 16:21:05 INFO - PROCESS | 32540 | __metrics 16:21:06 ERROR - PROCESS | 32540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 16:21:06 INFO - TEST-INFO | 32540: exit 0 16:21:06 INFO - Browser initialized. 16:21:06 INFO - Running cycle 1/1 for kraken test... 16:21:06 INFO - TEST-INFO | started process 32667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkn4G_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:18 INFO - PROCESS | 32667 | RSS: Main: 147628032 16:21:18 INFO - PROCESS | 32667 | 16:21:21 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46124/tests/kraken/driver.html?testName=audio-beat-detection) 16:21:22 INFO - PROCESS | 32667 | RSS: Main: 153546752 16:21:22 INFO - PROCESS | 32667 | 16:21:24 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46124/tests/kraken/driver.html?testName=audio-dft) 16:21:25 INFO - PROCESS | 32667 | RSS: Main: 152289280 16:21:25 INFO - PROCESS | 32667 | 16:21:28 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46124/tests/kraken/driver.html?testName=audio-fft) 16:21:28 INFO - PROCESS | 32667 | RSS: Main: 152756224 16:21:28 INFO - PROCESS | 32667 | 16:21:30 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46124/tests/kraken/driver.html?testName=audio-oscillator) 16:21:31 INFO - PROCESS | 32667 | RSS: Main: 152551424 16:21:31 INFO - PROCESS | 32667 | 16:21:33 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:34 INFO - PROCESS | 32667 | RSS: Main: 152485888 16:21:34 INFO - PROCESS | 32667 | 16:21:37 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46124/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:37 INFO - PROCESS | 32667 | RSS: Main: 155295744 16:21:37 INFO - PROCESS | 32667 | 16:21:41 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46124/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:41 INFO - PROCESS | 32667 | RSS: Main: 155361280 16:21:41 INFO - PROCESS | 32667 | 16:21:44 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46124/tests/kraken/driver.html?testName=json-parse-financial) 16:21:45 INFO - PROCESS | 32667 | RSS: Main: 155111424 16:21:45 INFO - PROCESS | 32667 | 16:21:46 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:47 INFO - PROCESS | 32667 | RSS: Main: 154652672 16:21:47 INFO - PROCESS | 32667 | 16:21:48 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:49 INFO - PROCESS | 32667 | RSS: Main: 153821184 16:21:49 INFO - PROCESS | 32667 | 16:21:51 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:52 INFO - PROCESS | 32667 | RSS: Main: 153296896 16:21:52 INFO - PROCESS | 32667 | 16:21:54 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:55 INFO - PROCESS | 32667 | RSS: Main: 154066944 16:21:55 INFO - PROCESS | 32667 | 16:21:58 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:58 INFO - PROCESS | 32667 | RSS: Main: 154513408 16:21:58 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | Cycle 1(1): loaded http://localhost:46124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46124/tests/kraken/driver.html?testName=ai-astar) 16:22:00 INFO - PROCESS | 32667 | RSS: Main: 156311552 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | __start_tp_report 16:22:00 INFO - PROCESS | 32667 | _x_x_mozilla_page_load 16:22:00 INFO - PROCESS | 32667 | _x_x_mozilla_page_load_details 16:22:00 INFO - PROCESS | 32667 | |i|pagename|runs| 16:22:00 INFO - PROCESS | 32667 | |0;ai-astar;103;113;112;111;114;113;114;112;111;111 16:22:00 INFO - PROCESS | 32667 | |1;audio-beat-detection;142;119;118;154;124;123;119;119;153;125 16:22:00 INFO - PROCESS | 32667 | |2;audio-dft;161;163;162;162;162;165;164;162;161;162 16:22:00 INFO - PROCESS | 32667 | |3;audio-fft;77;75;75;113;75;75;77;75;102;81 16:22:00 INFO - PROCESS | 32667 | |4;audio-oscillator;82;81;109;82;82;83;111;82;81;111 16:22:00 INFO - PROCESS | 32667 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;118 16:22:00 INFO - PROCESS | 32667 | |6;imaging-darkroom;147;147;146;147;148;147;147;147;147;147 16:22:00 INFO - PROCESS | 32667 | |7;imaging-desaturate;84;84;85;85;87;85;85;85;85;85 16:22:00 INFO - PROCESS | 32667 | |8;json-parse-financial;52;58;53;54;54;54;58;54;54;54 16:22:00 INFO - PROCESS | 32667 | |9;json-stringify-tinderbox;60;60;61;60;60;62;60;60;60;60 16:22:00 INFO - PROCESS | 32667 | |10;stanford-crypto-aes;77;76;81;74;74;73;74;74;82;75 16:22:00 INFO - PROCESS | 32667 | |11;stanford-crypto-ccm;125;130;122;122;121;122;124;130;173;123 16:22:00 INFO - PROCESS | 32667 | |12;stanford-crypto-pbkdf2;160;159;156;155;159;156;155;158;161;158 16:22:00 INFO - PROCESS | 32667 | |13;stanford-crypto-sha256-iterative;65;63;65;67;62;63;62;61;63;63 16:22:00 INFO - PROCESS | 32667 | __end_tp_report 16:22:00 INFO - PROCESS | 32667 | __start_cc_report 16:22:00 INFO - PROCESS | 32667 | _x_x_mozilla_cycle_collect,766 16:22:00 INFO - PROCESS | 32667 | __end_cc_report 16:22:00 INFO - PROCESS | 32667 | __startTimestamp1486772520633__endTimestamp 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | ------- Summary: start ------- 16:22:00 INFO - PROCESS | 32667 | Number of tests: 14 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.17 (2.8%) stddev-sans-first:1.22 16:22:00 INFO - PROCESS | 32667 | Values: 103.0 113.0 112.0 111.0 114.0 113.0 114.0 112.0 111.0 111.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:124.50 stddev:14.39 (11.6%) stddev-sans-first:14.55 16:22:00 INFO - PROCESS | 32667 | Values: 142.0 119.0 118.0 154.0 124.0 123.0 119.0 119.0 153.0 125.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 16:22:00 INFO - PROCESS | 32667 | Values: 161.0 163.0 162.0 162.0 162.0 165.0 164.0 162.0 161.0 162.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:13.56 (18.1%) stddev-sans-first:14.23 16:22:00 INFO - PROCESS | 32667 | Values: 77.0 75.0 75.0 113.0 75.0 75.0 77.0 75.0 102.0 81.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:13.78 (16.8%) stddev-sans-first:14.27 16:22:00 INFO - PROCESS | 32667 | Values: 82.0 81.0 109.0 82.0 82.0 83.0 111.0 82.0 81.0 111.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:22:00 INFO - PROCESS | 32667 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 16:22:00 INFO - PROCESS | 32667 | Values: 147.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 16:22:00 INFO - PROCESS | 32667 | Values: 84.0 84.0 85.0 85.0 87.0 85.0 85.0 85.0 85.0 85.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:1.96 (3.6%) stddev-sans-first:1.86 16:22:00 INFO - PROCESS | 32667 | Values: 52.0 58.0 53.0 54.0 54.0 54.0 58.0 54.0 54.0 54.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 16:22:00 INFO - PROCESS | 32667 | Values: 60.0 60.0 61.0 60.0 60.0 62.0 60.0 60.0 60.0 60.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.50 stddev:3.13 (4.1%) stddev-sans-first:3.30 16:22:00 INFO - PROCESS | 32667 | Values: 77.0 76.0 81.0 74.0 74.0 73.0 74.0 74.0 82.0 75.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:124.50 stddev:15.73 (12.6%) stddev-sans-first:16.61 16:22:00 INFO - PROCESS | 32667 | Values: 125.0 130.0 122.0 122.0 121.0 122.0 124.0 130.0 173.0 123.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.50 stddev:2.11 (1.3%) stddev-sans-first:2.07 16:22:00 INFO - PROCESS | 32667 | Values: 160.0 159.0 156.0 155.0 159.0 156.0 155.0 158.0 161.0 158.0 16:22:00 INFO - PROCESS | 32667 | 16:22:00 INFO - PROCESS | 32667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.79 16:22:00 INFO - PROCESS | 32667 | Values: 65.0 63.0 65.0 67.0 62.0 63.0 62.0 61.0 63.0 63.0 16:22:00 INFO - PROCESS | 32667 | -------- Summary: end -------- 16:22:00 INFO - PROCESS | 32667 | 16:22:01 INFO - TEST-INFO | 32667: exit 0 16:22:01 INFO - TEST-OK | kraken | took 60491ms 16:22:01 INFO - SUITE-END | took 1173s 16:22:01 INFO - Completed test suite (00:19:33) 16:22:01 INFO - javascript benchmark 16:22:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7371.738694282841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.6708329167086, 3310.5696259486263, 3314.8729431993124, 3320.966790332096, 3336.2993771308024, 5652.152177173426, 5688.317401911776, 5708.971455142729, 5740.770369185233, 5744.33940096889, 5735.340435849868, 5793.623414478056, 5803.274590676166, 5815.244018277618, 5857.0, 5192.714400707969, 5250.186221135711, 5264.0, 5292.788288468476, 5302.681839089648, 5282.550983166436, 5287.154055351145, 5288.206768984644, 5295.602829787781, 5316.893662126755, 4993.101241776479, 5017.874553136165, 5309.787608495655, 5318.946810531884, 5323.22813192087, 5116.437191908887, 5179.430262671103, 5215.348081489814, 5234.502722241381, 5321.122014867542, 5149.613778966593, 5222.268882356435, 5241.764120614582, 5253.290805741214, 5270.446603106657, 5698.230738850244, 5719.8570035749435, 5764.538836893039, 5797.565182611321, 5836.795712150054, 5860.384659610765, 5938.049912014057, 5948.940510594882, 5975.043992961106, 6010.489108425789, 6049.909251361233, 6060.212172417558, 6077.574569780118, 6140.780336713802, 6157.969210153965, 5715.485606295453, 5717.71411429431, 5730.140478928152, 5739.913901291484, 5740.684262365527, 6116.1836049259855, 6135.2326666699655, 6158.922188616974, 6258.155149054819, 6261.592996455216, 5953.0, 5984.491318237911, 5995.490383317379, 5997.430244126801, 6007.879842403215, 6063.878722425527, 6072.8785424292155, 6078.3921607838865, 6084.604500707528, 6093.96953015241, 5828.854278643068, 5936.673482958478, 5979.880402392015, 6014.278286605635, 6028.0, 6051.394860514001, 6056.878862422815, 6059.666718330534, 6063.787767428119, 6079.817605471843, 4610.792514336863, 4670.416197975253, 4678.391809064799, 4680.157571637138, 4684.039771846763, 4061.756294622332, 4069.674426045909, 4100.671946244293, 4124.422580838685, 4143.3784932260405, 5796.188533605298, 5821.650700957956, 5824.970875145597, 5827.009408400582, 5869.383714709979, 6089.756409743649, 6144.0, 6154.723037463235, 6156.984097623931, 6161.137440758297, 5601.831945041656, 5611.326640803048, 5624.943750562524, 5809.883802324014, 5854.151148083504, 5173.120569503193, 5182.663126896739, 5196.818111366084, 5201.063808514504, 5236.136037553837, 6050.54620903434, 6089.269287685506, 6093.939060609426, 6098.14625952367, 6105.32841387447, 5907.172995780508, 5965.821025369246, 5995.820125396245, 6015.939840601538, 6034.487068599043, 6135.11040899076, 6138.570300078952, 6145.569810113249, 6214.5028397728975, 6226.750929962751, 5934.732937017931, 5934.7922822701, 5939.10913362999, 5941.287045554561, 5941.792037278675, 5916.319623243382, 6051.243594550681, 6065.484433822998, 6068.544859135494, 6082.787102451393, 5767.5385969121535, 5850.64896106235, 5871.500922421471, 5889.175515427929, 5969.134475500941, 5892.793752218652, 5893.410658934073, 5893.793717220048, 5895.380984996514, 5900.468957793819, 5751.626144300607, 5852.770918107245, 5859.44335288147, 5868.970655146697, 5871.412858714094, 5711.371749107512, 5771.336296325809, 5831.475167234969, 5894.410558944071, 5898.734556945034, 5811.970940145441, 5822.737976791139, 5867.559933005127, 5868.794592189253, 5875.148103525051], "value": 5594.252540013399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.8939990801657, 620.8230654263534, 634.5399585300657, 651.4657980456028, 660.857915548157, 44566.33150502741, 45607.0, 45828.0, 45985.62043138707, 46001.53998460019, 44837.55162448374, 44963.0, 45170.548294517044, 45308.77345613275, 45352.3197152043, 8907.10928907109, 9036.728898133033, 9051.366404351698, 9061.773455663628, 9085.954570227173, 8984.0, 9048.366614337, 9061.728148155566, 9098.954505227464, 9113.544322783868, 9051.049639787827, 9081.091890810932, 9099.04460031697, 9099.95450022749, 9108.22580080694, 9036.186743193079, 9053.366264361497, 9089.136532029446, 9090.545472726337, 9093.727188184364, 8935.0, 8968.05835387288, 8986.101389861027, 9033.0, 9047.592858321392, 42165.78917105425, 42499.15001699948, 42522.0, 42533.36199957003, 42744.3588346175, 3556.5020897074432, 3667.743257971943, 3728.850845966158, 3791.1280405506614, 3821.73247872649, 31515.369692606248, 31678.0, 31741.523877141863, 32074.198145046328, 32506.18734531632, 4189.944134078222, 4210.32634778437, 4241.4698162729655, 4266.146770645883, 4272.273713468718, 330867.0, 332132.0, 333755.0, 334578.0, 335488.0, 59795.402045979856, 60174.699126504085, 60241.39758602445, 60333.69833150894, 60392.39607603956, 60739.39260607426, 60870.39129608736, 61157.08264376038, 61637.38362616406, 61940.0, 18173.182206800724, 18219.635607288044, 18290.0, 18369.63260734778, 18392.356267530573, 14119.0, 14236.501722439665, 14267.85732142686, 14276.643083922985, 14286.142831430148, 16873.831261687472, 16923.238454269587, 17271.654566908845, 17274.568135796704, 17400.129993500275, 6140.324564297924, 6185.0, 6218.875622487525, 6242.1261023456755, 6292.779752708633, 1004.9899501004896, 1045.1273186888882, 1090.334895713614, 1136.852209212797, 1155.6359746679768, 31434.68565314363, 31630.525542116888, 31664.442478495184, 31722.206944826565, 32216.19459513531, 1127.2729089737074, 1136.4374634555948, 1142.737170450801, 1202.1765090912752, 1251.224240970586, 16598.41905533325, 16687.666246675, 16715.247813848408, 16880.662386752196, 17086.48740537786, 465629.0, 470087.0, 470519.0, 471223.0, 473579.0, 59124.70437647784, 59240.0, 59448.70275648594, 59526.40473595295, 59534.70232648809, 1383.5503461375092, 1385.930703464843, 1432.2480697633616, 1433.118632041308, 1436.3967133803828, 30133.698663013965, 30352.010955671944, 30939.84530077335, 31481.842590787815, 31958.0, 51417.228741569656, 51614.483855160965, 51690.22464662958, 51696.48303517067, 51905.7404712974, 395828.0, 395871.0, 397309.0, 397802.0, 398257.0, 41665.16669666529, 41896.0, 43226.567734322256, 43234.0, 43315.0, 46029.76985115053, 46779.53220467888, 47364.289535657685, 47657.285140722226, 48062.03875922532, 38397.232055359294, 39076.0, 40651.59348406478, 43865.0, 44381.0, 40982.38526422166, 41346.38338505548, 41424.0, 41918.0, 42127.57872421236, 39510.0, 40376.1924761509, 40498.190036198524, 40623.187536248515, 40963.59036409598, 33672.326553469284, 34612.0, 35154.0, 35404.46893296551, 35499.82250088733, 27490.312742181606, 28445.431091378472, 28627.713722862503, 28649.42701146007, 28662.856685717274], "value": 20379.787003435806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.5464407316493, 434.87584593824965, 436.3149854728078, 437.4990635722098, 448.3118413235686, 18834.34079807207, 19089.23643054278, 20217.59564808703, 20310.593788124228, 20392.286269980552, 19662.115204815782, 19873.304434344802, 19967.60064798703, 20143.395698129043, 20248.493787655316, 5858.53131749459, 6119.3574674659185, 6127.7855275065385, 6136.3863613638505, 6145.446909778119, 5872.207252020987, 5993.820185394445, 6016.338202797689, 6044.576879618428, 6054.364291749369, 6024.789132380368, 6026.758929642831, 6032.7285272162635, 6033.607815492001, 6044.274687037561, 5822.563307751914, 5943.791967281124, 5959.195508606348, 5981.9401805981815, 6023.969880150615, 5403.0, 5420.13277875542, 5424.511793938565, 5428.9185662215095, 5430.456954304538, 14064.156150630995, 15573.299201535958, 21923.0, 22699.978500967332, 22919.312420627408, 2465.469923966356, 2498.287987923451, 2924.6051783009234, 3099.0857696979447, 3131.5146152346424, 10453.372797632166, 10793.460326983697, 10960.12319014477, 11099.83350249747, 11482.425878706032, 1943.689009758432, 2080.4382816639572, 2083.0834432849497, 2085.655866781979, 2088.4361222469847, 79384.0, 82902.58548707278, 85325.57337213337, 85751.0, 87252.56373718154, 11723.0, 11736.0, 11863.881361186277, 11869.5845645402, 12057.095717821023, 16896.915515422344, 16898.74651880223, 16906.40827571029, 16945.152742362832, 16950.321987120624, 7559.1684914659345, 7939.364850811921, 8011.519308841372, 8210.507369557727, 8221.0, 7393.816989281797, 7473.58895260755, 7617.809554761176, 7632.8473430532185, 7681.5775132367135, 5019.799208031638, 5108.310378098983, 5156.355455568054, 5173.960721762506, 5223.895522089613, 2010.266252817711, 2059.6086743518686, 2086.7287252657056, 2098.3390232076845, 2130.1585873579847, 967.260046064761, 985.8126955878361, 991.8016396720685, 995.8605795188679, 1000.2448151645607, 19333.226670933003, 19546.90226548858, 19767.703484447746, 19827.900860495894, 19914.90042549807, 996.1035068438464, 1014.4369874719454, 1017.7557386227252, 1032.7624646331385, 1086.9076128529005, 10729.731756705989, 11144.554217831359, 11167.664970050912, 11185.105191584817, 11217.775644487065, 448411.0, 482086.0, 483697.0, 487308.0, 487826.0, 53109.0, 64615.0, 89618.0, 94392.0, 95943.0, 980.2501086668705, 1014.4572653630272, 1017.5522769981185, 1024.8770147582188, 1025.1542477456128, 16893.239804209086, 17176.82823171752, 17567.560810979827, 17588.208530616408, 17777.46667599974, 41191.382129267484, 41693.0, 41868.3719744198, 42340.78829605832, 43340.0, 54576.45423545714, 58046.709766452586, 58641.41358586359, 59661.10508342465, 60236.39763602308, 8810.779730506789, 8842.91157088421, 8956.328275379243, 9103.90896091057, 9350.309697190482, 9834.508274586386, 12850.293233871853, 13162.736745264849, 13550.59348219555, 13795.724085518434, 11347.659570212907, 11818.586349477728, 11850.466728997388, 12005.279683219034, 12037.277763334228, 11488.02351800073, 11726.296422214695, 11774.234674746114, 11838.763224735629, 12112.818307725214, 11942.820857687315, 12030.458629361874, 12051.57819476314, 12101.576444824741, 12263.509459621515, 8841.115888411108, 9032.729018129467, 9104.726858194264, 9190.586423611087, 9402.717918462457, 8955.552222388986, 11396.145289103184, 11446.599369022044, 11452.14108941816, 11479.713007174887], "value": 9417.488434050487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.9092854428732, 1532.6664504702271, 1711.9315227390905, 1820.0353812479382, 1826.97259541107, 8020.799480012988, 8274.2966847818, 8640.65437382504, 9201.539923003857, 9212.170904618582, 8239.0, 8589.0, 8592.35557333201, 8745.34409919257, 8780.517071561078, 2467.0871777442326, 2500.6624105745673, 2501.8373805702663, 2508.159766478232, 2512.108201588428, 2333.6032874411308, 2436.196055301746, 2437.244454219189, 2438.0979037756056, 2442.523707876956, 2473.8763061846926, 2477.4549599088173, 2487.328421326241, 2502.874856257189, 2506.147909710698, 2394.95210095798, 2426.3934016495878, 2431.756824317572, 2435.8538487690794, 2450.5956517174645, 2439.353571303606, 2450.7059152901766, 2451.521953219123, 2460.8400453970435, 2472.27068014936, 8779.0, 8817.79749947534, 8829.867551986725, 8846.646134154626, 8858.778530536723, 5565.0817615093865, 5630.690312032836, 5711.8000869969765, 5714.1428785682065, 5716.056850619642, 3420.4698271767916, 3448.81031543265, 3463.688268055887, 3464.670856268676, 3521.7710848795004, 1083.1389045708681, 1085.0234788690163, 1095.2388090277261, 1096.5065720425841, 1138.4421633399656, 12736.554220602235, 12762.489500419972, 12768.0, 12769.042321825807, 12842.678933026657, 4770.737609431445, 4964.329815474937, 4994.40067191932, 4995.950040499549, 5007.69953802773, 10237.641682541223, 10242.48787560619, 10257.281990260759, 10260.948695256626, 10272.743181420376, 5578.023845826964, 5583.497485226349, 5589.413111623302, 5595.076812326002, 5599.412061733541, 5060.924086138711, 5156.149235376196, 5222.817201397933, 5269.394019687708, 5269.604779641542, 3968.583298753647, 4048.9797551012057, 4086.9182616347507, 4114.1977314424, 4140.358244472111, 1209.407390378708, 1211.7818792617413, 1218.3603608105816, 1221.712897469094, 1262.9810552841714, 977.6040703515088, 984.3257368702461, 989.7228775942748, 1009.1623952119724, 1020.8009438159488, 6095.055266433621, 6185.288691800501, 6256.155419018374, 6401.3598640135615, 6425.228972523327, 970.6069042037985, 982.7199248214367, 992.2905122837207, 1018.4602160854758, 1035.5081336365317, 3867.1878905430176, 3999.3642342002126, 4016.397540368968, 4041.131156801243, 4044.130511939888, 10464.424456654957, 11247.0, 11293.54825806975, 11295.774084518427, 11328.03711684516, 11077.335359878432, 11145.108391328675, 11231.326120432801, 11249.66251012471, 11285.0, 8310.667573297122, 8443.0, 8470.407071504935, 8472.110428405053, 8473.067962524117, 5743.540516758733, 5769.884602308014, 5829.53363730892, 5886.58793884424, 5897.5576831736935, 10242.283040187116, 10367.170626350025, 10405.375677459377, 10486.108680762221, 10506.21203409732, 10526.421046842497, 10608.098311643596, 10644.095251903365, 10666.146708263475, 10689.9465502672, 7659.272369124924, 7724.150343462103, 7772.067351917806, 7905.367570594223, 8029.598520073856, 8766.386352955233, 8817.779555510908, 8821.823563528566, 8823.294136469196, 8826.91173088261, 7188.856222875409, 7289.635518223961, 7449.776506704808, 7478.4765066444825, 7485.139208990818, 7369.963150184215, 7384.076990376203, 7401.5189012714, 7431.591262480615, 7531.209223031722, 7171.856562868609, 7259.6007219603425, 7286.7085316586745, 7307.7807665770115, 7334.853302933805, 5337.0, 5362.249285100167, 5393.541548968225, 5396.892062158657, 5405.081136206775, 5299.973500132474, 5362.088444964287, 5384.865378365572, 5420.566354691694, 5440.347158341025], "value": 4771.303580185897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.915419876329, 359.96040435552084, 366.748777087695, 373.3503703555814, 377.64690014836145, 5458.699771512565, 5535.750891209896, 5732.168835518847, 5774.393688662688, 5776.768929242825, 5359.464053594638, 5552.972235138819, 5581.944180558193, 5585.519837243134, 5631.887362252753, 4416.2933930571035, 4417.801198946056, 4450.132224216279, 4485.340424043093, 4487.708298960557, 4200.915981680365, 4397.714148580332, 4410.448693913261, 4489.406260777426, 4504.527024662412, 4373.322135069054, 4375.8249670013165, 4380.780960951955, 4389.47326320842, 4391.297392417214, 4364.25807612705, 4388.420168739267, 4411.911761764747, 4413.6607597973125, 4477.529859364752, 3855.383138697795, 3933.331333673282, 3955.3473676843287, 3960.128771670228, 3964.980175099135, 5418.864528386822, 5433.483819037225, 5433.864153396157, 5459.181122831567, 5469.206964990054, 5037.420696619899, 5039.647224694273, 5055.368078990126, 5072.898542029176, 5089.4147173074825, 5706.315242170925, 5900.468957793776, 5918.478505289346, 5929.703514824241, 5940.821775346746, 4236.4492615959725, 4259.488861336628, 4276.2089013532595, 4278.507971583276, 4284.892877678083, 6096.847578810521, 6132.754689812402, 6149.169862068608, 6154.63072215664, 6187.783427580058, 4311.361682560607, 4335.566443355639, 4352.499462561783, 4357.389965404783, 4393.75834329115, 4392.231359512072, 4408.206522825923, 4413.801378937956, 4414.889627759268, 4421.624161946206, 5010.799568017239, 5021.14640511114, 5024.723640199824, 5054.69671819692, 5055.266986286968, 5773.364929857712, 5804.303483581913, 5909.852253693606, 5929.140274660236, 5947.5539334550085, 1477.56411858502, 1488.2112480385413, 1493.2160615676858, 1500.4298366620833, 1500.4748338081583, 971.3394891473724, 998.6654470752234, 1004.0060340263087, 1008.8991100889853, 1009.152312057875, 5500.834974950758, 5524.502794748411, 5554.888902221933, 5557.3886872444, 5563.193336966117, 5936.5250779937505, 5956.672383018976, 5986.73059712314, 6037.766026570197, 6065.423784740443, 5445.618806683494, 5525.557955363562, 5533.557315414757, 5559.360673522516, 5574.219609254707, 3161.351922855809, 3162.0355791483357, 3180.3480286541203, 3192.393445245396, 3195.4981158855303, 5735.569832262597, 5920.8815823684145, 5982.282126144803, 5984.174826677818, 5996.940030599725, 5865.794697185578, 5927.95485557482, 5954.940450595525, 5957.702114894325, 6003.189569408074, 5953.255843019622, 5967.433093856077, 5994.730237139339, 6030.246219222598, 6033.728482218311, 5822.0, 5903.321118071477, 6135.570510064253, 6178.62928224308, 6194.473469755121, 6053.60651557665, 6135.601185922901, 6151.169592105188, 6162.691865406622, 6172.969135154295, 6131.816045518642, 6205.286392064971, 6212.378762123752, 6307.779227727007, 6314.968425157845, 4355.237833379209, 4381.225603630534, 4385.934210986901, 4400.69195156336, 4400.867973960786, 5978.790742323998, 6150.969245153746, 6170.0, 6188.597741146811, 6205.627662340274, 5943.257092863392, 5982.820515384546, 5984.640921544721, 5996.130561068708, 6011.87976240464, 5943.662675898061, 6027.065804800263, 6028.849278768066, 6028.969855150696, 6036.63780173191, 5656.632318899258, 5880.794172203952, 5916.763329466773, 5924.259467566554, 5938.168656388023, 5946.881062378641, 5993.430624090704, 6022.728977196124, 6036.849078773066, 6091.634501929899, 5646.616578938187, 5808.244928159313, 5871.6770577616935, 5884.32330282023, 5919.4080591940465], "value": 4508.187392140335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.9708811647535, 738.6491416577127, 767.5049593012507, 776.1346099099499, 824.7031068815226, 12493.875061249397, 12878.3560821959, 12906.032047596422, 12929.288889111107, 12990.870091299084, 14220.431182752704, 14488.058276212065, 14501.564953051398, 14510.492132775329, 14513.564593062225, 836.514821403586, 886.1315910407804, 890.2210565754932, 895.6999405199266, 896.8385690575694, 876.7545087375545, 877.6577134917387, 878.9516576588285, 879.0857508191473, 879.432765866016, 934.9065093490665, 935.1863878425745, 935.2377812083131, 935.3546053223288, 940.5485367023832, 925.6575067225102, 929.0709290709291, 930.2465003347277, 931.5714771205186, 934.9485778282192, 686.5983399711175, 687.3538873458982, 690.0, 690.0167261652176, 690.1063123255396, 15166.31751571182, 15341.463048793239, 15387.923060384739, 15396.923015384964, 15472.767908481383, 13920.721585568232, 14329.641758956006, 14423.0, 14468.927655361762, 14563.490277840225, 11127.332360058423, 11190.472654915913, 11287.717807054807, 11299.322040677585, 11480.71298217543, 3735.495708079429, 3754.5869954305003, 3776.716746244015, 3790.6777923876502, 3818.8663396781258, 62822.85885705696, 63851.68074159599, 64245.35754642487, 64747.352526474606, 65038.34961650417, 9815.10367507517, 9945.15466185368, 9988.900110998797, 10351.534180961875, 10587.205959553065, 20490.897545512176, 20519.794802052085, 20524.973751312376, 20581.897090514452, 20685.896570517052, 6351.269603995507, 6762.797116086525, 6875.140607424072, 6894.207166175854, 7770.650320735581, 4355.324924636687, 4357.085012147421, 4401.2517871961845, 4424.889377765581, 4444.577765112309, 3340.599128104643, 3437.4843773434186, 3455.274392377629, 3459.584849818038, 3463.913402164966, 605.7637521366671, 611.1321922869536, 615.5937081526171, 617.4658920034138, 623.6102435977514, 528.8862894477705, 578.9318706985605, 657.273712547628, 681.3595220492721, 686.8763622547889, 8211.548364839991, 8479.19447652472, 8582.356323275779, 8698.086700896441, 8730.432521886058, 575.4590684756315, 582.5805420097523, 611.4924612571555, 626.8025571944822, 670.6847781542667, 4305.935410968838, 4319.416878721395, 4406.162829062468, 4457.04173602677, 4462.531434199427, 86431.56784216038, 88711.0, 89505.55247223722, 92313.0768692318, 93485.5325723367, 51307.486925131016, 62660.0, 71486.0, 76504.61747691338, 79721.60139199383, 63984.0, 64224.357756422774, 64643.35356646373, 64901.35098649048, 65215.34784652188, 8982.0, 9074.137956894085, 9154.0, 9200.35597508168, 9308.208802251613, 34434.82782586071, 37875.62124378721, 40850.38724419195, 42314.36528452137, 46209.53790462052, 57884.4211557879, 59651.40348596458, 60581.39418605757, 61005.0, 62527.6873615629, 11221.66335009951, 11400.372979485875, 11582.710432238924, 11868.287902725864, 11986.160968732454, 12656.683582910133, 12932.482700691868, 13198.07613467048, 13247.693681182345, 13478.460861565427, 12374.319412432042, 12735.426905789076, 12991.870081299445, 13068.085234033526, 13223.933880330536, 11805.527778888749, 11819.349935753617, 12111.576094836992, 12291.75416491683, 12452.439640216393, 11220.831687524531, 11344.659660210207, 11644.6506604802, 11981.341026243641, 12246.203996740183, 9821.263405244492, 9955.651552195639, 10107.949460252652, 10170.949145254226, 10202.183825294107, 10526.31578947366, 10590.364578125029, 10616.628418005334, 10671.0, 10752.0], "value": 6948.040651891929, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 111.0, 114.0, 113.0, 114.0, 112.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 118.0, 154.0, 124.0, 123.0, 119.0, 119.0, 153.0, 125.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 165.0, 164.0, 162.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 113.0, 75.0, 75.0, 77.0, 75.0, 102.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 82.0, 82.0, 83.0, 111.0, 82.0, 81.0, 111.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 87.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 58.0, 53.0, 54.0, 54.0, 54.0, 58.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 81.0, 74.0, 74.0, 73.0, 74.0, 74.0, 82.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 122.0, 122.0, 121.0, 122.0, 124.0, 130.0, 173.0, 123.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 156.0, 155.0, 159.0, 156.0, 155.0, 158.0, 161.0, 158.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 67.0, 62.0, 63.0, 62.0, 61.0, 63.0, 63.0], "value": 63.4, "unit": "score"}]}]} 16:22:01 INFO - Return code: 0 16:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:22:01 ERROR - # TBPL SUCCESS # 16:22:01 INFO - Running post-action listener: _resource_record_post_action 16:22:01 INFO - [mozharness: 2017-02-11 00:22:01.941516Z] Finished run-tests step (success) 16:22:01 INFO - Running post-run listener: _resource_record_post_run 16:22:02 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 331411456; Read time: 24; Write time: 201384 16:22:02 INFO - TinderboxPrint: CPU usage
13.2% 16:22:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 16:22:02 INFO - TinderboxPrint: I/O write bytes / time
331,411,456 / 201,384 16:22:02 INFO - TinderboxPrint: CPU idle
8,221.5 (86.8%) 16:22:02 INFO - TinderboxPrint: CPU user
1,200.4 (12.7%) 16:22:02 INFO - TinderboxPrint: Swap in / out
0 / 0 16:22:02 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 112074752; Read time: 0; Write time: 67984 16:22:02 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219336704; Read time: 24; Write time: 133400 16:22:02 INFO - Running post-run listener: _upload_blobber_files 16:22:02 INFO - Blob upload gear active. 16:22:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:22:02 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 16:22:02 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'] 16:22:02 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 16:22:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:07 INFO - (blobuploader) - INFO - Done attempting. 16:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:07 INFO - (blobuploader) - INFO - Done attempting. 16:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:08 INFO - (blobuploader) - INFO - Done attempting. 16:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:22:08 INFO - Return code: 0 16:22:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:22:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:22:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20e5a525f71fda79fdd96e6044d64ed91f703441e75d04c2e8f710d4c8bb11ef011873e854d465e47cc1cb9ab0e1eb81a47bc7bd3bcc94d3d0926637a82c792e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c5783cd4e169d601b783a0e8375fd9d0020aee18b5d38b13de10db22f5b525fbbe5cc3f686c72b2e001715bb66c523de26db7f395a471319e6918c407f462ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a634b6663542ff27ac7d5b3bba8e4b4905250dae17d3629efbe341869c4ea43ac4cce8f7a2e1e908d547e031a1d2d884365584a2c8ad6c6d6e74a8aa6ab0b39c"} 16:22:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:22:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:22:08 INFO - Contents: 16:22:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20e5a525f71fda79fdd96e6044d64ed91f703441e75d04c2e8f710d4c8bb11ef011873e854d465e47cc1cb9ab0e1eb81a47bc7bd3bcc94d3d0926637a82c792e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c5783cd4e169d601b783a0e8375fd9d0020aee18b5d38b13de10db22f5b525fbbe5cc3f686c72b2e001715bb66c523de26db7f395a471319e6918c407f462ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a634b6663542ff27ac7d5b3bba8e4b4905250dae17d3629efbe341869c4ea43ac4cce8f7a2e1e908d547e031a1d2d884365584a2c8ad6c6d6e74a8aa6ab0b39c"} 16:22:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:22:08 INFO - Copying logs to upload dir... 16:22:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:22:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.653374 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-10 16:22:08.696465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 16:22:08.700043) ========= 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=51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20e5a525f71fda79fdd96e6044d64ed91f703441e75d04c2e8f710d4c8bb11ef011873e854d465e47cc1cb9ab0e1eb81a47bc7bd3bcc94d3d0926637a82c792e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c5783cd4e169d601b783a0e8375fd9d0020aee18b5d38b13de10db22f5b525fbbe5cc3f686c72b2e001715bb66c523de26db7f395a471319e6918c407f462ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a634b6663542ff27ac7d5b3bba8e4b4905250dae17d3629efbe341869c4ea43ac4cce8f7a2e1e908d547e031a1d2d884365584a2c8ad6c6d6e74a8aa6ab0b39c"} build_url:https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/N9x0X9wQSdm9ukRICHUepg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20e5a525f71fda79fdd96e6044d64ed91f703441e75d04c2e8f710d4c8bb11ef011873e854d465e47cc1cb9ab0e1eb81a47bc7bd3bcc94d3d0926637a82c792e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c5783cd4e169d601b783a0e8375fd9d0020aee18b5d38b13de10db22f5b525fbbe5cc3f686c72b2e001715bb66c523de26db7f395a471319e6918c407f462ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a634b6663542ff27ac7d5b3bba8e4b4905250dae17d3629efbe341869c4ea43ac4cce8f7a2e1e908d547e031a1d2d884365584a2c8ad6c6d6e74a8aa6ab0b39c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 16:22:08.728659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:22:08.729333) ========= 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=51fc86400edbde9650d2781a000001d0-1486771292.434894-2073554664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 16:22:08.813285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 16:22:08.814026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 16:22:08.814736) ========= ========= Total master_lag: 0.16 =========