builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1475558338.82 results: success (0) buildid: 20161003203559 builduid: 945ef00ea061430cb323cfe4f6a37e2d revision: 509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.824101) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.825074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.825789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.858832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.859131) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 22:18:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-03 22:18:59 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.956259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:58.957059) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022041 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.014133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.015070) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f --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=bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 22:18:59,323 truncating revision to first 12 chars 2016-10-03 22:18:59,323 Setting DEBUG logging. 2016-10-03 22:18:59,323 attempt 1/10 2016-10-03 22:18:59,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/509bdef4e93c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 22:18:59,629 unpacking tar archive at: autoland-509bdef4e93c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731306 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.766706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.767488) ========= script_repo_revision: 509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.768443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.769275) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 22:18:59.784400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-03 22:18:59.784715) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:19:00 INFO - MultiFileLogger online at 20161003 22:19:00 in /builds/slave/test 22:19:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 22:19:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:19:00 INFO - {'append_to_log': False, 22:19:00 INFO - 'base_work_dir': '/builds/slave/test', 22:19:00 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:19:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:19:00 INFO - 'branch': 'Autoland-Non-PGO', 22:19:00 INFO - 'buildbot_json_path': 'buildprops.json', 22:19:00 INFO - 'config_files': ('talos/linux_config.py',), 22:19:00 INFO - 'default_actions': ('clobber', 22:19:00 INFO - 'read-buildbot-config', 22:19:00 INFO - 'download-and-extract', 22:19:00 INFO - 'populate-webroot', 22:19:00 INFO - 'create-virtualenv', 22:19:00 INFO - 'install', 22:19:00 INFO - 'run-tests'), 22:19:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:19:00 INFO - 'download_minidump_stackwalk': True, 22:19:00 INFO - 'download_symbols': 'ondemand', 22:19:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:19:00 INFO - 'tooltool.py': '/tools/tooltool.py', 22:19:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:19:00 INFO - '/tools/misc-python/virtualenv.py')}, 22:19:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:19:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:19:00 INFO - 'installer_path': 'installer.exe', 22:19:00 INFO - 'log_level': 'info', 22:19:00 INFO - 'log_name': 'talos', 22:19:00 INFO - 'log_to_console': True, 22:19:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:19:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:19:00 INFO - 'opt_config_files': (), 22:19:00 INFO - 'pip_index': False, 22:19:00 INFO - 'sps_profile': False, 22:19:00 INFO - 'sps_profile_interval': 0, 22:19:00 INFO - 'suite': 'dromaeojs', 22:19:00 INFO - 'system_bits': '32', 22:19:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:19:00 INFO - 'title': 'talos-linux64-ix-055', 22:19:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:19:00 INFO - 'use_talos_json': True, 22:19:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:19:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:19:00 INFO - 'work_dir': 'build'} 22:19:00 INFO - [mozharness: 2016-10-04 05:19:00.190324Z] Running clobber step. 22:19:00 INFO - Running pre-action listener: _resource_record_pre_action 22:19:00 INFO - Running main action method: clobber 22:19:00 INFO - rmtree: /builds/slave/test/build 22:19:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:19:01 INFO - Running post-action listener: _resource_record_post_action 22:19:01 INFO - [mozharness: 2016-10-04 05:19:01.160368Z] Finished clobber step (success) 22:19:01 INFO - [mozharness: 2016-10-04 05:19:01.160466Z] Running read-buildbot-config step. 22:19:01 INFO - Running pre-action listener: _resource_record_pre_action 22:19:01 INFO - Running main action method: read_buildbot_config 22:19:01 INFO - Using buildbot properties: 22:19:01 INFO - { 22:19:01 INFO - "project": "", 22:19:01 INFO - "product": "firefox", 22:19:01 INFO - "script_repo_revision": "production", 22:19:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 22:19:01 INFO - "repository": "", 22:19:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 22:19:01 INFO - "buildid": "20161003203559", 22:19:01 INFO - "pgo_build": "False", 22:19:01 INFO - "basedir": "/builds/slave/test", 22:19:01 INFO - "buildnumber": 619, 22:19:01 INFO - "slavename": "talos-linux64-ix-055", 22:19:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:19:01 INFO - "platform": "ubuntu64_hw", 22:19:01 INFO - "scheduler": "tests-autoland-linux64-talos", 22:19:01 INFO - "branch": "autoland", 22:19:01 INFO - "repo_path": "integration/autoland", 22:19:01 INFO - "revision": "509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f", 22:19:01 INFO - "stage_platform": "linux64", 22:19:01 INFO - "builduid": "945ef00ea061430cb323cfe4f6a37e2d", 22:19:01 INFO - "slavebuilddir": "test" 22:19:01 INFO - } 22:19:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:19:01 INFO - Running post-action listener: _resource_record_post_action 22:19:01 INFO - [mozharness: 2016-10-04 05:19:01.162875Z] Finished read-buildbot-config step (success) 22:19:01 INFO - [mozharness: 2016-10-04 05:19:01.162963Z] Running download-and-extract step. 22:19:01 INFO - Running pre-action listener: _resource_record_pre_action 22:19:01 INFO - Running main action method: download_and_extract 22:19:01 INFO - mkdir: /builds/slave/test/build/tests 22:19:01 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')]} 22:19:01 INFO - trying https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:19:01 INFO - Downloading https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:19:01 INFO - Downloaded 1361 bytes. 22:19:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:19:01 INFO - Using the following test package requirements: 22:19:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:19:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:19:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:19:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'jsshell-linux-x86_64.zip'], 22:19:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:19:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:19:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:19:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:19:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:19:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:19:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:19:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:19:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:19:01 INFO - Fetch https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:19:02 INFO - Http code: 200 22:19:02 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 22:19:02 INFO - x-amz-cf-id: ULfx69JymyV4ogdlU6O91PA6RGB9opqW7hcOpSJ9QQdS7dEkH0MmBA== 22:19:02 INFO - x-amz-version-id: uyl.geLMDqcMHtYPyQw4J.A10uhJ4A5n 22:19:02 INFO - Expected file size: 20420699 22:19:02 INFO - Obtained file size: 20420699 22:19:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:19:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:19:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:19:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:19:07 INFO - Http code: 200 22:19:07 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 22:19:07 INFO - x-amz-cf-id: fi4NcTjIiY0iWnTltqLIRaLQ0TOkykc5v_HsiPPkhDxTBLtVQqre4g== 22:19:07 INFO - x-amz-version-id: uyl.geLMDqcMHtYPyQw4J.A10uhJ4A5n 22:19:07 INFO - Expected file size: 20420699 22:19:07 INFO - Obtained file size: 20420699 22:19:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:19:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:19:11 INFO - Fetch https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:19:12 INFO - Http code: 200 22:19:12 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 22:19:12 INFO - x-amz-cf-id: _17USzD1bu6bgxv0GxUTXRbNx12QbSbDI4pi51UhsGFFZHFb0ukHtQ== 22:19:12 INFO - x-amz-version-id: 9_Et3i9TvM6JJ23YJ.XkuzXCJhgheWCB 22:19:13 INFO - Expected file size: 14408522 22:19:13 INFO - Obtained file size: 14408522 22:19: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')]} 22:19:13 INFO - trying https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:19:15 INFO - Downloaded 55831787 bytes. 22:19:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:15 INFO - mkdir: /builds/slave/test/properties 22:19:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:19:15 INFO - Writing to file /builds/slave/test/properties/build_url 22:19:15 INFO - Contents: 22:19:15 INFO - build_url:https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:16 INFO - Running post-action listener: _resource_record_post_action 22:19:16 INFO - Running post-action listener: set_extra_try_arguments 22:19:16 INFO - [mozharness: 2016-10-04 05:19:16.447244Z] Finished download-and-extract step (success) 22:19:16 INFO - [mozharness: 2016-10-04 05:19:16.447565Z] Running populate-webroot step. 22:19:16 INFO - Running pre-action listener: _resource_record_pre_action 22:19:16 INFO - Running main action method: populate_webroot 22:19:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:19:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:19:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:19:16 INFO - '--tppagecycles', 22:19:16 INFO - '7'], 22:19:16 INFO - 'tests': ['tsvgm']}}, 22:19:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:19:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:19:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:19:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:19:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['damp', 'tps']}, 22:19:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'tests': ['damp', 'tps']}, 22:19:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['dromaeo_dom']}, 22:19:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:19:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['basic_compositor_video']}, 22:19:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:19:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other-e10s': {'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tsvgx', 22:19:16 INFO - 'tsvgr_opacity', 22:19:16 INFO - 'tart', 22:19:16 INFO - 'tscrollx', 22:19:16 INFO - 'cart']}, 22:19:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:19:16 INFO - 'tsvgr_opacity', 22:19:16 INFO - 'tart', 22:19:16 INFO - 'tscrollx', 22:19:16 INFO - 'cart']}, 22:19:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tp5o']}, 22:19:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'tests': ['tp5o']}, 22:19:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s', 22:19:16 INFO - '--xperf_path', 22:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:16 INFO - 'tests': ['tp5n']}, 22:19:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--xperf_path', 22:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:16 INFO - 'tests': ['tp5n']}}, 22:19:16 INFO - 'talos.zip': {'path': '', 22:19:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:19:16 INFO - Running post-action listener: _resource_record_post_action 22:19:16 INFO - [mozharness: 2016-10-04 05:19:16.468252Z] Finished populate-webroot step (success) 22:19:16 INFO - [mozharness: 2016-10-04 05:19:16.468340Z] Running create-virtualenv step. 22:19:16 INFO - Running pre-action listener: _resource_record_pre_action 22:19:16 INFO - Running main action method: create_virtualenv 22:19:16 INFO - Creating virtualenv /builds/slave/test/build/venv 22:19:16 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 22:19:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:19:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:19:16 INFO - Using real prefix '/usr' 22:19:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:19:17 INFO - Installing distribute.............................................................................................................................................................................................done. 22:19:19 INFO - Installing pip.................done. 22:19:19 INFO - Return code: 0 22:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:19:19 INFO - Reading from file tmpfile_stdout 22:19:19 INFO - Output received: 22:19:19 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) 22:19:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:19:19 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')]} 22:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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')]} 22:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:19 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 22:19:19 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 22:19:19 INFO - Using env: {'DISPLAY': ':0', 22:19:19 INFO - 'HOME': '/home/cltbld', 22:19:19 INFO - 'LANG': 'en_US.UTF-8', 22:19:19 INFO - 'LANGUAGE': 'en_US:en', 22:19:19 INFO - 'LOGNAME': 'cltbld', 22:19:19 INFO - 'MAIL': '/var/mail/cltbld', 22:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:19 INFO - 'MOZ_NO_REMOTE': '1', 22:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:19 INFO - 'NO_EM_RESTART': '1', 22:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:19 INFO - 'PWD': '/builds/slave/test', 22:19:19 INFO - 'SHELL': '/bin/bash', 22:19:19 INFO - 'SHLVL': '1', 22:19:19 INFO - 'TERM': 'linux', 22:19:19 INFO - 'TMOUT': '86400', 22:19:19 INFO - 'USER': 'cltbld', 22:19:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:19 INFO - '_': '/tools/buildbot/bin/python'} 22:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:19 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 22:19:19 INFO - Cleaning up... 22:19:19 INFO - Return code: 0 22:19:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:19:19 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')]} 22:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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')]} 22:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:19 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 22:19:19 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 22:19:19 INFO - Using env: {'DISPLAY': ':0', 22:19:19 INFO - 'HOME': '/home/cltbld', 22:19:19 INFO - 'LANG': 'en_US.UTF-8', 22:19:19 INFO - 'LANGUAGE': 'en_US:en', 22:19:19 INFO - 'LOGNAME': 'cltbld', 22:19:19 INFO - 'MAIL': '/var/mail/cltbld', 22:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:19 INFO - 'MOZ_NO_REMOTE': '1', 22:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:19 INFO - 'NO_EM_RESTART': '1', 22:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:19 INFO - 'PWD': '/builds/slave/test', 22:19:19 INFO - 'SHELL': '/bin/bash', 22:19:19 INFO - 'SHLVL': '1', 22:19:19 INFO - 'TERM': 'linux', 22:19:19 INFO - 'TMOUT': '86400', 22:19:19 INFO - 'USER': 'cltbld', 22:19:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:19 INFO - '_': '/tools/buildbot/bin/python'} 22:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:19 INFO - Downloading/unpacking psutil>=3.1.1 22:19:19 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 22:19:19 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 22:19:19 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 22:19:19 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 22:19:19 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 22:19:19 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 22:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:21 INFO - Installing collected packages: psutil 22:19:21 INFO - Running setup.py install for psutil 22:19:21 INFO - building 'psutil._psutil_linux' extension 22:19:21 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 22:19:21 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 22:19:21 INFO - building 'psutil._psutil_posix' extension 22:19:21 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 22:19:22 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 22:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:22 INFO - Successfully installed psutil 22:19:22 INFO - Cleaning up... 22:19:22 INFO - Return code: 0 22:19:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:22 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:22 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 22:19:22 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 22:19:22 INFO - Using env: {'DISPLAY': ':0', 22:19:22 INFO - 'HOME': '/home/cltbld', 22:19:22 INFO - 'LANG': 'en_US.UTF-8', 22:19:22 INFO - 'LANGUAGE': 'en_US:en', 22:19:22 INFO - 'LOGNAME': 'cltbld', 22:19:22 INFO - 'MAIL': '/var/mail/cltbld', 22:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:22 INFO - 'MOZ_NO_REMOTE': '1', 22:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:22 INFO - 'NO_EM_RESTART': '1', 22:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:22 INFO - 'PWD': '/builds/slave/test', 22:19:22 INFO - 'SHELL': '/bin/bash', 22:19:22 INFO - 'SHLVL': '1', 22:19:22 INFO - 'TERM': 'linux', 22:19:22 INFO - 'TMOUT': '86400', 22:19:22 INFO - 'USER': 'cltbld', 22:19:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:22 INFO - '_': '/tools/buildbot/bin/python'} 22:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:19:24 INFO - Installing collected packages: mozsystemmonitor 22:19:24 INFO - Running setup.py install for mozsystemmonitor 22:19:24 INFO - Successfully installed mozsystemmonitor 22:19:24 INFO - Cleaning up... 22:19:24 INFO - Return code: 0 22:19:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:24 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:24 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 22:19:24 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 22:19:24 INFO - Using env: {'DISPLAY': ':0', 22:19:24 INFO - 'HOME': '/home/cltbld', 22:19:24 INFO - 'LANG': 'en_US.UTF-8', 22:19:24 INFO - 'LANGUAGE': 'en_US:en', 22:19:24 INFO - 'LOGNAME': 'cltbld', 22:19:24 INFO - 'MAIL': '/var/mail/cltbld', 22:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:24 INFO - 'MOZ_NO_REMOTE': '1', 22:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:24 INFO - 'NO_EM_RESTART': '1', 22:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:24 INFO - 'PWD': '/builds/slave/test', 22:19:24 INFO - 'SHELL': '/bin/bash', 22:19:24 INFO - 'SHLVL': '1', 22:19:24 INFO - 'TERM': 'linux', 22:19:24 INFO - 'TMOUT': '86400', 22:19:24 INFO - 'USER': 'cltbld', 22:19:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:24 INFO - '_': '/tools/buildbot/bin/python'} 22:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:24 INFO - Downloading/unpacking jsonschema==2.5.1 22:19:24 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 22:19:24 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 22:19:24 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 22:19:24 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 22:19:24 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 22:19:24 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 22:19:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:26 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:26 INFO - warning: no files found matching '*.txt' 22:19:26 INFO - no previously-included directories found matching 'build' 22:19:26 INFO - no previously-included directories found matching 'dist' 22:19:26 INFO - no previously-included directories found matching '.git*' 22:19:26 INFO - Installing collected packages: jsonschema, functools32 22:19:26 INFO - Running setup.py install for functools32 22:19:27 INFO - warning: no files found matching '*.txt' 22:19:27 INFO - no previously-included directories found matching 'build' 22:19:27 INFO - no previously-included directories found matching 'dist' 22:19:27 INFO - no previously-included directories found matching '.git*' 22:19:27 INFO - Successfully installed jsonschema functools32 22:19:27 INFO - Cleaning up... 22:19:27 INFO - Return code: 0 22:19:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:19:27 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')]} 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 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')]} 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:27 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 22:19:27 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 22:19:27 INFO - Using env: {'DISPLAY': ':0', 22:19:27 INFO - 'HOME': '/home/cltbld', 22:19:27 INFO - 'LANG': 'en_US.UTF-8', 22:19:27 INFO - 'LANGUAGE': 'en_US:en', 22:19:27 INFO - 'LOGNAME': 'cltbld', 22:19:27 INFO - 'MAIL': '/var/mail/cltbld', 22:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:27 INFO - 'MOZ_NO_REMOTE': '1', 22:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:27 INFO - 'NO_EM_RESTART': '1', 22:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:27 INFO - 'PWD': '/builds/slave/test', 22:19:27 INFO - 'SHELL': '/bin/bash', 22:19:27 INFO - 'SHLVL': '1', 22:19:27 INFO - 'TERM': 'linux', 22:19:27 INFO - 'TMOUT': '86400', 22:19:27 INFO - 'USER': 'cltbld', 22:19:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:27 INFO - '_': '/tools/buildbot/bin/python'} 22:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:19:27 INFO - Cleaning up... 22:19:27 INFO - Return code: 0 22:19:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19:27 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')]} 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 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')]} 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:27 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 22:19:27 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 22:19:27 INFO - Using env: {'DISPLAY': ':0', 22:19:27 INFO - 'HOME': '/home/cltbld', 22:19:27 INFO - 'LANG': 'en_US.UTF-8', 22:19:27 INFO - 'LANGUAGE': 'en_US:en', 22:19:27 INFO - 'LOGNAME': 'cltbld', 22:19:27 INFO - 'MAIL': '/var/mail/cltbld', 22:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:27 INFO - 'MOZ_NO_REMOTE': '1', 22:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:27 INFO - 'NO_EM_RESTART': '1', 22:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:27 INFO - 'PWD': '/builds/slave/test', 22:19:27 INFO - 'SHELL': '/bin/bash', 22:19:27 INFO - 'SHLVL': '1', 22:19:27 INFO - 'TERM': 'linux', 22:19:27 INFO - 'TMOUT': '86400', 22:19:27 INFO - 'USER': 'cltbld', 22:19:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:27 INFO - '_': '/tools/buildbot/bin/python'} 22:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:27 INFO - Downloading/unpacking blobuploader==1.2.4 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:29 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:30 INFO - Downloading docopt-0.6.1.tar.gz 22:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:30 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:30 INFO - Running setup.py install for blobuploader 22:19:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:30 INFO - Running setup.py install for requests 22:19:30 INFO - Running setup.py install for docopt 22:19:30 INFO - Successfully installed blobuploader requests docopt 22:19:30 INFO - Cleaning up... 22:19:30 INFO - Return code: 0 22:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:30 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')]} 22:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:30 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')]} 22:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:30 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:30 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 22:19:30 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 22:19:30 INFO - Using env: {'DISPLAY': ':0', 22:19:30 INFO - 'HOME': '/home/cltbld', 22:19:30 INFO - 'LANG': 'en_US.UTF-8', 22:19:30 INFO - 'LANGUAGE': 'en_US:en', 22:19:30 INFO - 'LOGNAME': 'cltbld', 22:19:30 INFO - 'MAIL': '/var/mail/cltbld', 22:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:30 INFO - 'MOZ_NO_REMOTE': '1', 22:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:30 INFO - 'NO_EM_RESTART': '1', 22:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:30 INFO - 'PWD': '/builds/slave/test', 22:19:30 INFO - 'SHELL': '/bin/bash', 22:19:30 INFO - 'SHLVL': '1', 22:19:30 INFO - 'TERM': 'linux', 22:19:30 INFO - 'TMOUT': '86400', 22:19:30 INFO - 'USER': 'cltbld', 22:19:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:30 INFO - '_': '/tools/buildbot/bin/python'} 22:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:31 INFO - Running setup.py (path:/tmp/pip-_1EK6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:31 INFO - Running setup.py (path:/tmp/pip-QIBovE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:31 INFO - Running setup.py (path:/tmp/pip-brFHHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:31 INFO - Running setup.py (path:/tmp/pip-ZOLJBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:31 INFO - Running setup.py (path:/tmp/pip-_gu9zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:31 INFO - Running setup.py (path:/tmp/pip-L5qB5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:31 INFO - Running setup.py (path:/tmp/pip-N31PXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:31 INFO - Running setup.py (path:/tmp/pip-QOfkho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:31 INFO - Running setup.py (path:/tmp/pip-8zdFdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:31 INFO - Running setup.py (path:/tmp/pip-89Y1bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:31 INFO - Running setup.py (path:/tmp/pip-rjQAOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:31 INFO - Running setup.py (path:/tmp/pip-n15JeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:31 INFO - Running setup.py (path:/tmp/pip-2A1Lc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:31 INFO - Running setup.py (path:/tmp/pip-FF0HhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:32 INFO - Running setup.py (path:/tmp/pip-y2_RX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:32 INFO - Running setup.py (path:/tmp/pip-dBpY4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:32 INFO - Running setup.py (path:/tmp/pip-WTPMSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:32 INFO - Running setup.py install for manifestparser 22:19:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:32 INFO - Running setup.py install for mozcrash 22:19:32 INFO - Running setup.py install for mozdebug 22:19:32 INFO - Running setup.py install for mozdevice 22:19:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:19:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:32 INFO - Running setup.py install for mozfile 22:19:32 INFO - Running setup.py install for mozhttpd 22:19:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:32 INFO - Running setup.py install for mozinfo 22:19:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:32 INFO - Running setup.py install for mozInstall 22:19:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozleak 22:19:33 INFO - Running setup.py install for mozlog 22:19:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for moznetwork 22:19:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozprocess 22:19:33 INFO - Running setup.py install for mozprofile 22:19:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozrunner 22:19:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozscreenshot 22:19:33 INFO - Running setup.py install for moztest 22:19:33 INFO - Running setup.py install for mozversion 22:19:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:34 INFO - Cleaning up... 22:19:34 INFO - Return code: 0 22:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:34 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:34 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 22:19:34 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 22:19:34 INFO - Using env: {'DISPLAY': ':0', 22:19:34 INFO - 'HOME': '/home/cltbld', 22:19:34 INFO - 'LANG': 'en_US.UTF-8', 22:19:34 INFO - 'LANGUAGE': 'en_US:en', 22:19:34 INFO - 'LOGNAME': 'cltbld', 22:19:34 INFO - 'MAIL': '/var/mail/cltbld', 22:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:34 INFO - 'MOZ_NO_REMOTE': '1', 22:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:34 INFO - 'NO_EM_RESTART': '1', 22:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:34 INFO - 'PWD': '/builds/slave/test', 22:19:34 INFO - 'SHELL': '/bin/bash', 22:19:34 INFO - 'SHLVL': '1', 22:19:34 INFO - 'TERM': 'linux', 22:19:34 INFO - 'TMOUT': '86400', 22:19:34 INFO - 'USER': 'cltbld', 22:19:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:34 INFO - '_': '/tools/buildbot/bin/python'} 22:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:34 INFO - Running setup.py (path:/tmp/pip-1eFyZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:34 INFO - Running setup.py (path:/tmp/pip-mTBYEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:34 INFO - Running setup.py (path:/tmp/pip-Cefbf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:34 INFO - Running setup.py (path:/tmp/pip-_ndlpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:34 INFO - Running setup.py (path:/tmp/pip-p4NxuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:34 INFO - Running setup.py (path:/tmp/pip-efQFEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:34 INFO - Running setup.py (path:/tmp/pip-htiK4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:34 INFO - Running setup.py (path:/tmp/pip-TN0CRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:34 INFO - Running setup.py (path:/tmp/pip-QctAL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:34 INFO - Running setup.py (path:/tmp/pip-1yBxPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:35 INFO - Running setup.py (path:/tmp/pip-k0zmkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:35 INFO - Running setup.py (path:/tmp/pip-NGBndg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:35 INFO - Running setup.py (path:/tmp/pip-T34DA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:35 INFO - Running setup.py (path:/tmp/pip-JYcXsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:35 INFO - Running setup.py (path:/tmp/pip-k9lPb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:35 INFO - Running setup.py (path:/tmp/pip-sBFpUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:35 INFO - Running setup.py (path:/tmp/pip-3LX9NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:35 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)) 22:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:35 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)) 22:19:35 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)) 22:19:35 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)) 22:19:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:35 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 22:19:35 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 22:19:35 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 22:19:35 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 22:19:35 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 22:19:35 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 22:19:37 INFO - Downloading blessings-1.6.tar.gz 22:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:37 INFO - Installing collected packages: blessings 22:19:37 INFO - Running setup.py install for blessings 22:19:37 INFO - Successfully installed blessings 22:19:37 INFO - Cleaning up... 22:19:37 INFO - Return code: 0 22:19:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:37 INFO - Reading from file tmpfile_stdout 22:19:37 INFO - Current package versions: 22:19:37 INFO - argparse == 1.2.1 22:19:37 INFO - blessings == 1.6 22:19:37 INFO - blobuploader == 1.2.4 22:19:37 INFO - docopt == 0.6.1 22:19:37 INFO - functools32 == 3.2.3-2 22:19:37 INFO - jsonschema == 2.5.1 22:19:37 INFO - manifestparser == 1.1 22:19:37 INFO - mozInstall == 1.12 22:19:37 INFO - mozcrash == 0.17 22:19:37 INFO - mozdebug == 0.1 22:19:37 INFO - mozdevice == 0.48 22:19:37 INFO - mozfile == 1.2 22:19:37 INFO - mozhttpd == 0.7 22:19:37 INFO - mozinfo == 0.9 22:19:37 INFO - mozleak == 0.1 22:19:37 INFO - mozlog == 3.4 22:19:37 INFO - moznetwork == 0.27 22:19:37 INFO - mozprocess == 0.23 22:19:37 INFO - mozprofile == 0.28 22:19:37 INFO - mozrunner == 6.12 22:19:37 INFO - mozscreenshot == 0.1 22:19:37 INFO - mozsystemmonitor == 0.3 22:19:37 INFO - moztest == 0.7 22:19:37 INFO - mozversion == 1.4 22:19:37 INFO - psutil == 3.1.1 22:19:37 INFO - requests == 1.2.3 22:19:37 INFO - wsgiref == 0.1.2 22:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:37 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')]} 22:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:37 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')]} 22:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:37 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:37 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 22:19:37 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 22:19:37 INFO - Using env: {'DISPLAY': ':0', 22:19:37 INFO - 'HOME': '/home/cltbld', 22:19:37 INFO - 'LANG': 'en_US.UTF-8', 22:19:37 INFO - 'LANGUAGE': 'en_US:en', 22:19:37 INFO - 'LOGNAME': 'cltbld', 22:19:37 INFO - 'MAIL': '/var/mail/cltbld', 22:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:37 INFO - 'MOZ_NO_REMOTE': '1', 22:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:37 INFO - 'NO_EM_RESTART': '1', 22:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:37 INFO - 'PWD': '/builds/slave/test', 22:19:37 INFO - 'SHELL': '/bin/bash', 22:19:37 INFO - 'SHLVL': '1', 22:19:37 INFO - 'TERM': 'linux', 22:19:37 INFO - 'TMOUT': '86400', 22:19:37 INFO - 'USER': 'cltbld', 22:19:37 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:37 INFO - '_': '/tools/buildbot/bin/python'} 22:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 INFO - Cleaning up... 22:19:38 INFO - Return code: 0 22:19:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19:38 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')]} 22:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:38 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')]} 22:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:38 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 0x7f5d2792ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', '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 22:19:38 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 22:19:38 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 22:19:38 INFO - Using env: {'DISPLAY': ':0', 22:19:38 INFO - 'HOME': '/home/cltbld', 22:19:38 INFO - 'LANG': 'en_US.UTF-8', 22:19:38 INFO - 'LANGUAGE': 'en_US:en', 22:19:38 INFO - 'LOGNAME': 'cltbld', 22:19:38 INFO - 'MAIL': '/var/mail/cltbld', 22:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:38 INFO - 'MOZ_NO_REMOTE': '1', 22:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:38 INFO - 'NO_EM_RESTART': '1', 22:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:38 INFO - 'PWD': '/builds/slave/test', 22:19:38 INFO - 'SHELL': '/bin/bash', 22:19:38 INFO - 'SHLVL': '1', 22:19:38 INFO - 'TERM': 'linux', 22:19:38 INFO - 'TMOUT': '86400', 22:19:38 INFO - 'USER': 'cltbld', 22:19:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:38 INFO - '_': '/tools/buildbot/bin/python'} 22:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:19:38 INFO - Cleaning up... 22:19:38 INFO - Return code: 0 22:19:38 INFO - Running post-action listener: _resource_record_post_action 22:19:38 INFO - Running post-action listener: _start_resource_monitoring 22:19:38 INFO - Starting resource monitoring. 22:19:38 INFO - [mozharness: 2016-10-04 05:19:38.384810Z] Finished create-virtualenv step (success) 22:19:38 INFO - [mozharness: 2016-10-04 05:19:38.385281Z] Running install step. 22:19:38 INFO - Running pre-action listener: _resource_record_pre_action 22:19:38 INFO - Running main action method: install 22:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:38 INFO - Reading from file tmpfile_stdout 22:19:38 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:38 INFO - Reading from file tmpfile_stdout 22:19:38 INFO - Output received: 22:19:38 INFO - Usage: mozinstall [options] installer 22:19:38 INFO - Options: 22:19:38 INFO - -h, --help show this help message and exit 22:19:38 INFO - -d DEST, --destination=DEST 22:19:38 INFO - Directory to install application into. [default: 22:19:38 INFO - "/builds/slave/test"] 22:19:38 INFO - --app=APP Application being installed. [default: firefox] 22:19:38 INFO - mkdir: /builds/slave/test/build/application 22:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:19:54 INFO - Reading from file tmpfile_stdout 22:19:54 INFO - Output received: 22:19:54 INFO - /builds/slave/test/build/application/firefox/firefox 22:19:54 INFO - Running post-action listener: _resource_record_post_action 22:19:54 INFO - [mozharness: 2016-10-04 05:19:54.813097Z] Finished install step (success) 22:19:54 INFO - [mozharness: 2016-10-04 05:19:54.813343Z] Running run-tests step. 22:19:54 INFO - Running pre-action listener: _resource_record_pre_action 22:19:54 INFO - Running main action method: run_tests 22:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:19:54 INFO - Python 2.7.3 22:19:54 INFO - Return code: 0 22:19:54 INFO - grabbing minidump binary from tooltool 22:19: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')]} 22:19:54 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 0x22c2f60>, '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 0x22c3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:19:54 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 22:19:54 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 22:19:54 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 22:19:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:54 INFO - Return code: 0 22:19:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:19:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:19:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:19:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:19:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:19:54 INFO - Using env: {'DISPLAY': ':0', 22:19:54 INFO - 'HOME': '/home/cltbld', 22:19:54 INFO - 'LANG': 'en_US.UTF-8', 22:19:54 INFO - 'LANGUAGE': 'en_US:en', 22:19:54 INFO - 'LOGNAME': 'cltbld', 22:19:54 INFO - 'MAIL': '/var/mail/cltbld', 22:19:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:19:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:54 INFO - 'MOZ_NO_REMOTE': '1', 22:19:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:54 INFO - 'NO_EM_RESTART': '1', 22:19:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:54 INFO - 'PWD': '/builds/slave/test', 22:19:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:19:54 INFO - 'SHELL': '/bin/bash', 22:19:54 INFO - 'SHLVL': '1', 22:19:54 INFO - 'TERM': 'linux', 22:19:54 INFO - 'TMOUT': '86400', 22:19:54 INFO - 'USER': 'cltbld', 22:19:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302', 22:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:54 INFO - '_': '/tools/buildbot/bin/python'} 22:19:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:19:55 INFO - mozversion application_buildid: 20161003203559 22:19:55 INFO - mozversion application_changeset: 509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f 22:19:55 INFO - mozversion application_display_name: Nightly 22:19:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:19:55 INFO - mozversion application_name: Firefox 22:19:55 INFO - mozversion application_remotingname: firefox 22:19:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:19:55 INFO - mozversion application_vendor: Mozilla 22:19:55 INFO - mozversion application_version: 52.0a1 22:19:55 INFO - mozversion platform_buildid: 20161003203559 22:19:55 INFO - mozversion platform_changeset: 509bdef4e93c86dac71cb50689f5fbc6ad9a0e2f 22:19:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:19:55 INFO - mozversion platform_version: 52.0a1 22:19:55 INFO - using testdate: 1475558395 22:19:55 INFO - actual date: 1475558395 22:19:55 INFO - starting webserver on 'localhost:40631' 22:19:55 INFO - SUITE-START | Running 2 tests 22:19:55 INFO - TEST-START | dromaeo_css 22:19:55 INFO - operating with platform_type : linux_ 22:19:55 INFO - Initialising browser for dromaeo_css test... 22:19:55 INFO - TEST-INFO | started process 1431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7XWi6q/profile http://localhost:40631/getInfo.html) 22:19:59 INFO - PROCESS | 1431 | __metrics Screen width/height:1600/1200 22:19:59 INFO - PROCESS | 1431 | colorDepth:24 22:19:59 INFO - PROCESS | 1431 | Browser inner width/height: 1024/697 22:19:59 INFO - PROCESS | 1431 | __metrics 22:20:00 INFO - PROCESS | 1431 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:20:00 INFO - PROCESS | 1431 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:20:00 INFO - PROCESS | 1431 | console.error: PushService: 22:20:00 INFO - PROCESS | 1431 | stateChangeProcessEnqueue: Error transitioning state 22:20:00 INFO - PROCESS | 1431 | UnknownError 22:20:01 INFO - TEST-INFO | 1431: exit 0 22:20:01 INFO - Browser initialized. 22:20:01 INFO - Running cycle 1/1 for dromaeo_css test... 22:20:01 INFO - TEST-INFO | started process 1511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7XWi6q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:13 INFO - PROCESS | 1511 | RSS: Main: 175341568 22:20:13 INFO - PROCESS | 1511 | 22:21:05 INFO - PROCESS | 1511 | 1475558465241 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:23:18 INFO - PROCESS | 1511 | Cycle 1(1): loaded http://localhost:40631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40631/tests/dromaeo/cssquery-ext.html) 22:23:20 INFO - PROCESS | 1511 | RSS: Main: 319447040 22:23:20 INFO - PROCESS | 1511 | 22:26:22 INFO - PROCESS | 1511 | Cycle 1(1): loaded http://localhost:40631/tests/dromaeo/cssquery-ext.html (next: http://localhost:40631/tests/dromaeo/cssquery-jquery.html) 22:26:23 INFO - PROCESS | 1511 | RSS: Main: 275402752 22:26:23 INFO - PROCESS | 1511 | 22:29:25 INFO - PROCESS | 1511 | Cycle 1(1): loaded http://localhost:40631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40631/tests/dromaeo/cssquery-mootools.html) 22:29:26 INFO - PROCESS | 1511 | RSS: Main: 215281664 22:29:26 INFO - PROCESS | 1511 | 22:32:28 INFO - PROCESS | 1511 | Cycle 1(1): loaded http://localhost:40631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40631/tests/dromaeo/cssquery-prototype.html) 22:32:29 INFO - PROCESS | 1511 | RSS: Main: 219590656 22:32:29 INFO - PROCESS | 1511 | 22:35:32 INFO - PROCESS | 1511 | Cycle 1(1): loaded http://localhost:40631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40631/tests/dromaeo/cssquery-yui.html) 22:35:33 INFO - PROCESS | 1511 | RSS: Main: 220655616 22:35:33 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | Cycle 1(1): loaded http://localhost:40631/tests/dromaeo/cssquery-yui.html (next: http://localhost:40631/tests/dromaeo/cssquery-dojo.html) 22:38:36 INFO - PROCESS | 1511 | RSS: Main: 306872320 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | __start_tp_report 22:38:36 INFO - PROCESS | 1511 | _x_x_mozilla_page_load 22:38:36 INFO - PROCESS | 1511 | _x_x_mozilla_page_load_details 22:38:36 INFO - PROCESS | 1511 | |i|pagename|runs| 22:38:36 INFO - PROCESS | 1511 | |0;dojo.html;2546.325223815689;2554.948901021981;2598.753118453746;2602.128287023847;2616.8691565421723;4580.679352445331;4667.276572131325;4678.064387122577;4695.248760198369;4697.976510117449;4686.531346865312;4701.905961880769;4719.362886010387;4771.165046116925;4809.663323567352;4276.97861510692;4282.272013757669;4327.4157988671595;4350.97824510877;4352.151330490556;4350.3474478828275;4450;4458.063806600618;4465.263231566788;4473.038296766194;4203.453551038346;4384.561543845622;4385.035292235703;4414.80133393998;4496.707713998596;4231.280682284019;4241.172971270604;4285.100128972919;4302.870913872589;4327.913441731148;4253.8723838284905;4263.019505513749;4313.374560688714;4321.913561728779;4329.696921215516;4602.769861506945;4605.976970115162;4634.21218392874;4653.418322709661;4683.555062269079;4861.683990540603;4924.778384972685;4953.876153096166;4957.727324997124;4965.677230980011;5028.572571331441;5039.143345631252;5046.646734728571;5094.261332106824;5106.974465127688;4695.483496815347;4701.506341834058;4702.576768090854;4704.1767690654;4762.452317983476;4976.825811096594;5020.59835213182;5167.044096842096;5168.956406211897;5232.633715639869;4822.493638167942;4872.317875497433;4876.439209490883;4876.634252431082;4879.194932836042;5046;5090.898182036412;5094.898102037939;5167.844964651066;5173.198154286091;4894.632902532324;4929.112759703288;5001.89996200074;5090.567301779316;5101.923471147936;4956.950430495721;4960.627952903546;4966.404031516241;4968.0312339093525;5030.522100400456;4060.3706425504092;4090.5295890972325;4158.812853421603;4194.098268872207;4257.957420425756;3650.7444478886755;3681.2821499807815;3691.963080369162;3699.204670995749;3722.683571896419;4384.298512238091;4387.473503179639;4391.231534481517;4396.802143903468;4450.910981780346;4936.605071594336;4997.275395067695;5095.592352611782;5110.744462776846;5172.327597412387;4319.200947824663;4374.212641724456;4379.211741886427;4384.912301753947;4392.297232442794;4448.399466072104;4455.532169122261;4473.306637471197;4501.7974191161475;4506.909861802811;4667.206574882211;4668.0569694692595;4671.392718946515;4671.8364857229835;4728.219843725747;4898.9020219594695;4954.083494553375;4983.152864013054;4991.051700176955;5048.873778155576;4724.929126063043;4770.379850619397;4772.188727916193;4778.474367819467;4842.58837998774;5019.121653710513;5022.623303252344;5029.5221953914315;5029.949700502948;5092.3125378074965;4872.537108974641;5100.18397056484;5107.565856902056;5108.591312694901;5174.379074511083;4838.637102217277;4906.3376444181;4934.235193545006;4955.925661115159;5020;4925.310456536159;4944.357233559758;4952.628552858622;4954.00919816031;5014.323066386137;4862.756862156949;4866.95133048665;4878.487758785276;4881.341018962395;4945.505449455026;4743.525647435229;4776.808927642855;4777.761111944319;4913.140200464976;4974.0797952378925;4808.326834243278;4819.831305904277;4827.324174615627;4883.804647814048;4894.045661096052 22:38:36 INFO - PROCESS | 1511 | |1;ext.html;531.479150432576;559.4740943513095;565.282091743486;570.3070769015646;578.6354596604139;27290.86354568227;27725.861370693143;32768.50847237293;33635.99092027237;33645.83177084111;37723.81138094312;38073;38137.61862381375;38143;38149.42775858357;7506.887396689054;7647.770566883002;7649.1585925548425;7649.961750191242;7653.693852245903;7487.850242995137;7560.773176804704;7565.810854728648;7578.583177925212;7582.620868956557;7572.469927105105;7608.7336943207;7619.923800762004;7626.771196864103;7630.2751238632245;7537.660805263777;7584.014078169857;7593.430492713069;7594.5822979736095;7601.125870524905;7563;7623.466357354987;7651.1583725790115;7651.6556754945605;7653.272939070779;35435;35682.464763028576;35724.10689732777;35813;35819;2692.340376607724;2801.971980280212;2810.4941110600084;2907.0697376839207;3349.7822641528223;27519.58720619192;27617.585736213972;27672;27872.581911271347;28242.29394265139;3464.9653503464897;3481.1645205150835;3502.833246727523;3515.789052656849;3597.1366871950804;234669;235131;235243;235602;236001;48033;48314;48358.51641483611;48381;48397.27404088942;31588;32573.511397329057;32744.508832367057;34574.481382779275;34579.65420345814;12888.548900788428;13027.739445211233;13030.739385212431;13041.413136408695;13046.934765326112;10231.641892533726;10318.484075796181;10363.119134873621;10388.636397726195;10399.012093851072;16655;16789;16798;16813.831861681472;16952.406665766637;6692.130023096966;6717.328267173243;6750.1562304711915;6835.93164068353;6862.553933994274;790.6125998260926;849.2653854416009;862.9568521573896;908.9681861134828;932.1238036245907;25116.372090697878;25331.493370132495;25563.744362556135;25604.487910241693;25901.8704906478;759.506320891425;929.4655573045526;943.193569498083;949.4350861237691;971.771633666102;13057;13464.798028029587;13697.383617737225;13761.449542018407;13899.722005559832;364488;365142;366314;366464;369190;45976.540234597895;46564.7671761639;46588.534114659094;46606.533934660896;46621.30068048982;1066.9359838409564;1105.4472763618191;1147.5409836065473;1155.364549497773;1182.8994535464583;25844.741552584233;26980.865095674395;27671.584926226526;27885.442291154468;28122.578161327187;37915.431268531545;38484.30609857283;38558.228835423695;38569;38615.6138438612;234762;235096;235247;235729;580872;35561.288774224886;36037.45943810898;36240.456393153596;36375.272494549434;36782.816085919396;39554.802225988686;39599.60400395959;39975.80012100037;40237;40544;34134.487982679784;35135.297294054486;35220.295594088486;35231.64768352284;35397.82301088478;34636.65363346334;34756.30487390289;34869.651303486644;35000.64999349974;35505.467417988235;34083.31833363369;34498.82750586231;34567.2593844198;34748.47877281792;34924.30151397009;29731;32093.518597221526;32340;32393.51409728903;32440.67559324471;24358.26925192247;24380;24436.51126977415;24722.752772472046;24743.257702268962 22:38:36 INFO - PROCESS | 1511 | |2;jquery.html;342.8241132914107;354.54618088846286;366.8844314041078;368.95203623528937;382.3366459193299;12350.135490515668;15455.768163477544;15778.763318550216;16213.756793648105;17378.913105434487;15672;15791.763123553155;17016;17115.82884171158;17209.13954302283;4822.5177482251665;4870.342503762;4919.4096708395045;4977.47736487669;5100.515451032146;3673.210259794144;3847.6729477994404;4988.351514303154;5035.546800787928;5042.117629414856;5664.886702265952;5913.467787899088;5944.821655350324;6047.244094488189;6052.909206361908;5704.401037891044;5849.38581448946;5900.350961394243;6019.729112189962;6021.458068773832;5136.101182293084;5141.665791723563;5155.793768249266;5158.587313014949;5161.5870730341485;19611.509712257164;20562.79437205639;20706.171753129856;20719.5856082879;20758;1982.9900850495799;2022.595480903825;2041.5508588110592;2041.8697451881487;2252.977470225293;12444.937775311157;13207.40566674502;13539.729205415837;13774.517891873737;13883.791743123862;1716.9828301716948;1759.6304775997055;1760.9119544022747;1765.62921786425;1776.7829037109493;52900.47099528994;58903.41096589022;67951;68484;69312;9537.809243815085;9676.70969870905;9700.417974921527;9713.174380177765;9889;13256.469741210436;13258.801117983237;13262.668433289053;13272.535461258809;13304.201747895157;7004;7249.456290778213;7288.12542494904;7421.443391745641;7435;6936.757213497604;7129.536580122275;7315.926840731631;7341.74303899361;7347.853042939111;3986.8604598839484;4092.9795351023054;4187.1625674865145;4254.064105896698;4299.269124248885;1731.5497970527754;1734.1935999760171;1801.25248022072;1816.1554876982266;1818.418106206028;798.6805277888891;811.2617518058538;816.6284340625001;885.6014793343021;900.1628485508539;16114.194290285439;16599.751003734953;16958.745618815727;17341.7398739019;17574.209160587805;851;863.6933888469503;878.4904755241944;882.6160620130264;919.6597259014208;7778.338841198448;9389.62441502346;9633.373830700983;9744.805103897883;9793.314467987173;364144;364578;366556;367690;367944;54546.454535454934;65715.34284657188;68261.31738682649;72065;76411.23588764042;832.7930982895255;875.9518226497477;899.3075331994328;899.8065415935605;904.9321300902459;11714.648560543197;15433.614159646098;16100.758488622914;16112.516624501284;16337.264823082753;36868.26263474769;37063.629363706015;37854;37918.431223531115;38623.806880965414;44891;46282.76858615685;46423.76788116173;46425.30362044505;48282.517174829205;7163.391111755559;7247;7484.401247900264;7531.8493630125995;7677.232276772278;8300.667973281;10592.682219533426;10839.945800270949;11266.830997535208;12277.69305767363;10112.797744045225;10208.183345332207;10249.846252306072;10509.474526273809;10626.73433164146;9629.229661627192;10074.597016119273;10137.543810528692;10251;10282;9963.402195868272;10071.84892226632;10160.288779785344;10238.948805255926;10682.145428365868;7439.665215065444;7444.628890184959;7509.7371591994015;7613.771586852404;7790.376769858511;8398.412111152405;9864.85202721974;9875.604975800887;10094.293399461967;10508.159347252355 22:38:36 INFO - PROCESS | 1511 | |3;mootools.html;1278.2713853103733;1338.5448947357897;1344.4622151139545;1626.2902050949165;1639.0493513762026;6661.833454163649;6885.48358873084;7005.369516743492;7548.584827834474;7564.773056808298;7027;7336.082989626297;7348.889766653491;7495.587742674151;7496.287852654003;2005.8696184748017;2035.9491012724652;2038.2662241593014;2038.98980505098;2040.1839264294254;1608.1396452897702;1670.0480725986192;1854.5641774183123;1882.4823173627226;1885.038630298544;1883.2184643372984;1948.2012374926212;1958.4810025343295;1962.2641509433963;1966.1840336260434;1986.850986176028;1996.17158879065;1997.1611922992306;2003.07858385143;2025;1980.3068925875973;1986.145957238387;1987.920483180671;1994.99002504988;1995.7904420035832;7366.521176123535;7606.581638009908;7606.657700403495;7624.313811756913;7625.275598818103;4121.8969525761795;4234.322508398642;4241.533431322552;4250.06498570314;4253.638440732541;2602.414456747236;2764.626775385317;2767.875445604953;2778.513760091996;2781.1656503049207;816.1675091406731;851.6337974670889;866.8959724832997;868.452874688942;874.3180319350917;10131.138853197486;10151.441670708182;10173.694789156338;10183.592656293813;10190.439525826077;3682.208325210039;3823.6941044716355;3883.0874744435037;3961.920761584752;3980.721349505565;8633.568321583896;8657.22085012352;8662.653493860302;8665.220130188314;8666.393352465393;4254.149170165917;4256.87229383119;4264.829406823755;4265.232258193493;4266.914661706748;3893.104585945192;3900.1029763154634;3902.6097390261316;3903.785291808921;3910.9804450977563;3171.904842854718;3289.654586268455;3304.9173770655443;3338.8163650999427;3389.1696534349244;905.4431524612447;909.0591238068699;946.3706635087727;961.2694352292308;976.3995142987012;757.6666266842572;761.9809504762314;809.6437567470412;817.4237162800212;851.3061854588491;4829.758512074382;4864.854054378375;4980.850574482772;5117.797317630354;5145.4597267287145;829.531314807132;830.2030051150963;846.995765021171;861.9569021549023;896.233720169259;3326.5841769778776;3341.5823022122236;3523.94714079289;3530.6116327203986;3592.1019745063736;8728.65085396577;9123.635054597875;9159.49622770754;9165.404248723811;9167.587458564381;9135.817283654289;9138.680146194984;9144.085591440802;9171.40385874916;9191.862122068174;6766.966165169241;6797.4901882358035;6870.416014638712;6956.373926346653;6962.582245065413;4950.331705219749;4953.653244272867;5105.8723531912;5108.846734597968;5117.718525481134;8256.215659512576;8291.33669306466;8435.409521333448;8481.915180848113;8545.060043395346;8459.196376344238;8492.150784921705;8613.26787223093;8616.310695144499;8667.826643467222;5815.563832712479;5949.553783466171;5951.970240148771;5953.91069133972;5958.463738263577;6722;7139.036230108869;7202.063731714844;7208.927910721035;7219.45854060937;6362.809115726535;6459.547831651739;6491.545591808528;6620.3710647488415;6780.762673306608;6416.839579010562;6423.8394040147505;6501.837454063686;6502.187226596676;6540.934590654033;6041.879162416639;6085.543584231112;6102.816915492543;6131.877362452637;6203.844903877439;4464.866054018385;4480.843170489017;4563.178627847019;4579.267317229227;4735.786889590046;4517.548245175456;4558.407407037064;4572.199865023541;4576.702514336557;4658.324542941186 22:38:36 INFO - PROCESS | 1511 | |4;prototype.html;268.814517982592;278.7992645295387;281.1663417965732;282.15213284081335;290.44235068668155;4760.547747963947;4871.756412179395;4872.515017341159;4931.6301277404245;4941.579965702915;4703.529647035295;4804.207305794548;4813;4822.614190864731;4842.564169224778;3562.6259242779524;3661.4324779659196;3776.6978641708733;3785.5268091488565;3797.449369841371;3648.343298206322;3755;3763.473113764075;3786.5266841644793;3799;3762.8118594070324;3765.905852353699;3766.811659417032;3767.133559281367;3773.3208022555928;3756.4740936268945;3770.8680196193;3788.8592944985994;3791.5639701434275;3797.246995927958;3118.7193152616373;3264.5919260092487;3264.820434876081;3285.605727312714;3346.297277571713;4703.6942598730975;4706.74112923789;4709.246520556694;4721.929171062402;4772.2125849234835;4057.2494088593703;4220.6412454941365;4226.154769046203;4230.894227644303;4245.532991370947;5024.3670806987875;5031.169856973595;5053.797848086072;5060.165072763027;5072.51811077947;3495.7727747696317;3505.3164632896596;3507.333606614735;3509.8245087745768;3523.6828685418177;5304.522592966651;5311.920321195185;5326.680399176062;5326.680399176062;5332.440093790174;3374.4263475209273;3559.5728512578658;3582.3014512169875;3583.7133029357587;3589.192431702846;3639.836207370675;3647.471116688065;3648.6533779290926;3656.3601369760186;3659.780413175218;4207.158568286355;4222.451081359403;4227.492700875914;4235.745855248695;4239.936400953989;4857.222844344888;4988.678000329915;5104.234364845229;5111.642185047085;5112.693238405707;1229.6679896427913;1237.406045098358;1239.324568110382;1242.546470538247;1251.6495381293253;770.9036370453694;794.8648729715962;799.9240072193132;803.8070862992839;806.435495153395;4001.47980762499;4037.6366127048705;4040.959590404117;4043.9890027493125;4099.2416402964955;4602.88492787683;4609.700369476041;4612.630989520831;4623.884402889955;4692.81228750853;4066.959330406717;4071.6742660587083;4089.7137200395687;4107.815148318333;4134.586541345841;2352.6472278439965;2474.4679893822913;2489.7634724701124;2499.7000359956924;2509.3475696318724;4339.457567804025;4356.1268654478245;4371.628411584988;4415.492218394926;4416.668749843775;4711.95288047122;4730.597899178609;4742.976285118552;4749.786259618326;4801.135795556834;4315.956840431555;4350.8042138103865;4517.983453722886;4924.891899322623;4948.90102197954;5268.446813084724;5281.1286137788375;5286.444923283;5293.497117773805;5316.920246196388;5137.970501651752;5160.587153027674;5171.01750667372;5177.792888284426;5183;4694.694844835075;4917.360743103373;4946.258061290835;4948.144445832812;4980.402351717817;3416.4362880125495;3504.5969713483278;3518.3139287838626;3600.3519366513233;3606.621304763067;5216.530512253916;5259.55293800016;5269.736513174403;5280.155175171954;5286.603504737083;5142.6400151989;5153.793848246029;5156.664816786897;5168.3797944246935;5169.250458683395;5013.674111182761;5056.317397151338;5081.161608334583;5082.822101226439;5097.770600323069;5003.574696150868;5008.899822003466;5017.096922553976;5034.3455350805625;5041.395032595965;5056.443791183041;5145.176771716657;5171.50870667286;5183.92224116631;5195.064788394545;4956.157453232887;4958.45456999737;4963.553280204799;4978.85486338137;4985.551300382983 22:38:36 INFO - PROCESS | 1511 | |5;yui.html;632.6552029144119;640.3820313397571;655.5050936542909;697.9057827193327;749.5540153608601;12498;13119.47522099115;13504.797428038588;13530.458781648735;13565.321733913303;12441.253524788497;12584.370781460913;12591.874081259184;12597.118201725883;12605.558805441811;620.8323752586799;759.1232126893433;778.1634742651644;780.2314720000795;780.3484090784174;623.8689875126229;747.8466914282559;773.8026803165185;782.0615261685971;784.2040329066002;812.4394168024074;814.5927036481759;820.5774026376421;821.8726097454904;825.1707034430419;645.2450632759683;818.7134502923989;819.3772732723173;819.491915012693;819.7663665855202;485.2866286558753;557.4202829057775;574.247735466536;576.8557860534867;578.2107423367115;11919.642410727693;11965.222260553122;12036.87963120375;12058.276503409823;12059.638210853689;11261.605843795427;12082.214656047418;12083;12400.379981000913;12603.74792504154;10138.949305253427;10289.3311934724;11493.885061149365;11508.079353651772;11744.236624619458;4053.939190912109;4073.8574149904907;4106.281400754856;4200.180964711883;4309.59058889405;46896.29655555169;49171.50828491705;49261.26108108345;54539.45460545384;54586.45413545893;10075.697729068139;10387.68836934893;10413.635522756667;10436.321639093434;10483.947580262049;18340.908295458437;18344;18395;18400;18477.353292634692;6696.363845434676;6894.655267236719;6920.5847649141215;7069.293070692993;7339.77980660581;3645.908852278661;3692.9446058309145;3701.0932321581386;3753.868614598476;3783.564890037681;2850.8859645613943;2933.6186295781413;2962.555616657519;2965.258685328668;2969.6881827408242;505.7774579185147;508.7863097499059;509.9923501147486;516.9508896654812;522.5819344524365;483.37885816726043;507.6015327967602;508.4381758157183;538.004691321053;561.9775208991595;8396.160383961555;8546.188112129463;8734.471084774548;8798.736037918872;9016.278697704169;494.7155385653192;561.878763468934;568.7326956330518;573.7332140554579;586.2378907420422;4082.9387559186634;4132.194222126716;4142.834286628501;4205.11692544563;4214.726042807208;53556.73221633867;53839.461605384226;53951;54041.1893821593;78160;81854.59072704718;82765.58617206996;83368;83877;84877;75005.62497187479;75437;76096;77547;77828.83256751153;7713.922860771545;7899.486533375312;7946.500382281855;8044.597770111354;8337.207965243293;45866.541334586225;46694.29958550556;47044.29433558568;47360.289595655406;48396.27405588848;35578;37680.81159594184;46308.53691463177;50912;53516.46483535115;10909.83635245456;10968.341899486057;11264.718382040515;11324.37715925599;11859.881401185878;11650.6504804856;11870.832918698103;12356.814647780471;12481.56314528987;12923.741525169631;11842.703932401759;11932.940335298268;12186.817197741864;12239.816402753788;12281;11923.403829808301;12106.939465302617;12163.513459461523;12543.87456125427;13105.606831795061;11536.25014374063;11774.116941229613;12437.62687119388;12993.285369304778;13026.54407095747;9095.590698418455;9179.954100229455;9495.335326527076;9710.17463515609;9717.368371055858;8009.91990080115;8920.197182253629;9103.681371151977;9181.724548263563;9412.95293523528 22:38:36 INFO - PROCESS | 1511 | __end_tp_report 22:38:36 INFO - PROCESS | 1511 | __start_cc_report 22:38:36 INFO - PROCESS | 1511 | _x_x_mozilla_cycle_collect,1365 22:38:36 INFO - PROCESS | 1511 | __end_cc_report 22:38:36 INFO - PROCESS | 1511 | __startTimestamp1475559516280__endTimestamp 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | ------- Summary: start ------- 22:38:36 INFO - PROCESS | 1511 | Number of tests: 6 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | [#0] dojo.html Cycles:165 Average:4644.57 Median:4772.19 stddev:496.57 (10.4%) stddev-sans-first:470.02 22:38:36 INFO - PROCESS | 1511 | Values: 2546.3 2554.9 2598.8 2602.1 2616.9 4580.7 4667.3 4678.1 4695.2 4698.0 4686.5 4701.9 4719.4 4771.2 4809.7 4277.0 4282.3 4327.4 4351.0 4352.2 4350.3 4450.0 4458.1 4465.3 4473.0 4203.5 4384.6 4385.0 4414.8 4496.7 4231.3 4241.2 4285.1 4302.9 4327.9 4253.9 4263.0 4313.4 4321.9 4329.7 4602.8 4606.0 4634.2 4653.4 4683.6 4861.7 4924.8 4953.9 4957.7 4965.7 5028.6 5039.1 5046.6 5094.3 5107.0 4695.5 4701.5 4702.6 4704.2 4762.5 4976.8 5020.6 5167.0 5169.0 5232.6 4822.5 4872.3 4876.4 4876.6 4879.2 5046.0 5090.9 5094.9 5167.8 5173.2 4894.6 4929.1 5001.9 5090.6 5101.9 4957.0 4960.6 4966.4 4968.0 5030.5 4060.4 4090.5 4158.8 4194.1 4258.0 3650.7 3681.3 3692.0 3699.2 3722.7 4384.3 4387.5 4391.2 4396.8 4450.9 4936.6 4997.3 5095.6 5110.7 5172.3 4319.2 4374.2 4379.2 4384.9 4392.3 4448.4 4455.5 4473.3 4501.8 4506.9 4667.2 4668.1 4671.4 4671.8 4728.2 4898.9 4954.1 4983.2 4991.1 5048.9 4724.9 4770.4 4772.2 4778.5 4842.6 5019.1 5022.6 5029.5 5029.9 5092.3 4872.5 5100.2 5107.6 5108.6 5174.4 4838.6 4906.3 4934.2 4955.9 5020.0 4925.3 4944.4 4952.6 4954.0 5014.3 4862.8 4867.0 4878.5 4881.3 4945.5 4743.5 4776.8 4777.8 4913.1 4974.1 4808.3 4819.8 4827.3 4883.8 4894.0 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | [#1] ext.html Cycles:180 Average:44532.94 Median:35314.74 stddev:83919.56 (237.6%) stddev-sans-first:84089.95 22:38:36 INFO - PROCESS | 1511 | Values: 531.5 559.5 565.3 570.3 578.6 27290.9 27725.9 32768.5 33636.0 33645.8 37723.8 38073.0 38137.6 38143.0 38149.4 7506.9 7647.8 7649.2 7650.0 7653.7 7487.9 7560.8 7565.8 7578.6 7582.6 7572.5 7608.7 7619.9 7626.8 7630.3 7537.7 7584.0 7593.4 7594.6 7601.1 7563.0 7623.5 7651.2 7651.7 7653.3 35435.0 35682.5 35724.1 35813.0 35819.0 2692.3 2802.0 2810.5 2907.1 3349.8 27519.6 27617.6 27672.0 27872.6 28242.3 3465.0 3481.2 3502.8 3515.8 3597.1 234669.0 235131.0 235243.0 235602.0 236001.0 48033.0 48314.0 48358.5 48381.0 48397.3 31588.0 32573.5 32744.5 34574.5 34579.7 12888.5 13027.7 13030.7 13041.4 13046.9 10231.6 10318.5 10363.1 10388.6 10399.0 16655.0 16789.0 16798.0 16813.8 16952.4 6692.1 6717.3 6750.2 6835.9 6862.6 790.6 849.3 863.0 909.0 932.1 25116.4 25331.5 25563.7 25604.5 25901.9 759.5 929.5 943.2 949.4 971.8 13057.0 13464.8 13697.4 13761.4 13899.7 364488.0 365142.0 366314.0 366464.0 369190.0 45976.5 46564.8 46588.5 46606.5 46621.3 1066.9 1105.4 1147.5 1155.4 1182.9 25844.7 26980.9 27671.6 27885.4 28122.6 37915.4 38484.3 38558.2 38569.0 38615.6 234762.0 235096.0 235247.0 235729.0 580872.0 35561.3 36037.5 36240.5 36375.3 36782.8 39554.8 39599.6 39975.8 40237.0 40544.0 34134.5 35135.3 35220.3 35231.6 35397.8 34636.7 34756.3 34869.7 35000.6 35505.5 34083.3 34498.8 34567.3 34748.5 34924.3 29731.0 32093.5 32340.0 32393.5 32440.7 24358.3 24380.0 24436.5 24722.8 24743.3 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | [#2] jquery.html Cycles:180 Average:23084.46 Median:24595.13 stddev:60274.64 (245.1%) stddev-sans-first:60419.54 22:38:36 INFO - PROCESS | 1511 | Values: 342.8 354.5 366.9 369.0 382.3 12350.1 15455.8 15778.8 16213.8 17378.9 15672.0 15791.8 17016.0 17115.8 17209.1 4822.5 4870.3 4919.4 4977.5 5100.5 3673.2 3847.7 4988.4 5035.5 5042.1 5664.9 5913.5 5944.8 6047.2 6052.9 5704.4 5849.4 5900.4 6019.7 6021.5 5136.1 5141.7 5155.8 5158.6 5161.6 19611.5 20562.8 20706.2 20719.6 20758.0 1983.0 2022.6 2041.6 2041.9 2253.0 12444.9 13207.4 13539.7 13774.5 13883.8 1717.0 1759.6 1760.9 1765.6 1776.8 52900.5 58903.4 67951.0 68484.0 69312.0 9537.8 9676.7 9700.4 9713.2 9889.0 13256.5 13258.8 13262.7 13272.5 13304.2 7004.0 7249.5 7288.1 7421.4 7435.0 6936.8 7129.5 7315.9 7341.7 7347.9 3986.9 4093.0 4187.2 4254.1 4299.3 1731.5 1734.2 1801.3 1816.2 1818.4 798.7 811.3 816.6 885.6 900.2 16114.2 16599.8 16958.7 17341.7 17574.2 851.0 863.7 878.5 882.6 919.7 7778.3 9389.6 9633.4 9744.8 9793.3 364144.0 364578.0 366556.0 367690.0 367944.0 54546.5 65715.3 68261.3 72065.0 76411.2 832.8 876.0 899.3 899.8 904.9 11714.6 15433.6 16100.8 16112.5 16337.3 36868.3 37063.6 37854.0 37918.4 38623.8 44891.0 46282.8 46423.8 46425.3 48282.5 7163.4 7247.0 7484.4 7531.8 7677.2 8300.7 10592.7 10839.9 11266.8 12277.7 10112.8 10208.2 10249.8 10509.5 10626.7 9629.2 10074.6 10137.5 10251.0 10282.0 9963.4 10071.8 10160.3 10238.9 10682.1 7439.7 7444.6 7509.7 7613.8 7790.4 8398.4 9864.9 9875.6 10094.3 10508.2 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | [#3] mootools.html Cycles:180 Average:4851.53 Median:5882.56 stddev:2751.81 (46.8%) stddev-sans-first:2746.43 22:38:36 INFO - PROCESS | 1511 | Values: 1278.3 1338.5 1344.5 1626.3 1639.0 6661.8 6885.5 7005.4 7548.6 7564.8 7027.0 7336.1 7348.9 7495.6 7496.3 2005.9 2035.9 2038.3 2039.0 2040.2 1608.1 1670.0 1854.6 1882.5 1885.0 1883.2 1948.2 1958.5 1962.3 1966.2 1986.9 1996.2 1997.2 2003.1 2025.0 1980.3 1986.1 1987.9 1995.0 1995.8 7366.5 7606.6 7606.7 7624.3 7625.3 4121.9 4234.3 4241.5 4250.1 4253.6 2602.4 2764.6 2767.9 2778.5 2781.2 816.2 851.6 866.9 868.5 874.3 10131.1 10151.4 10173.7 10183.6 10190.4 3682.2 3823.7 3883.1 3961.9 3980.7 8633.6 8657.2 8662.7 8665.2 8666.4 4254.1 4256.9 4264.8 4265.2 4266.9 3893.1 3900.1 3902.6 3903.8 3911.0 3171.9 3289.7 3304.9 3338.8 3389.2 905.4 909.1 946.4 961.3 976.4 757.7 762.0 809.6 817.4 851.3 4829.8 4864.9 4980.9 5117.8 5145.5 829.5 830.2 847.0 862.0 896.2 3326.6 3341.6 3523.9 3530.6 3592.1 8728.7 9123.6 9159.5 9165.4 9167.6 9135.8 9138.7 9144.1 9171.4 9191.9 6767.0 6797.5 6870.4 6956.4 6962.6 4950.3 4953.7 5105.9 5108.8 5117.7 8256.2 8291.3 8435.4 8481.9 8545.1 8459.2 8492.2 8613.3 8616.3 8667.8 5815.6 5949.6 5952.0 5953.9 5958.5 6722.0 7139.0 7202.1 7208.9 7219.5 6362.8 6459.5 6491.5 6620.4 6780.8 6416.8 6423.8 6501.8 6502.2 6540.9 6041.9 6085.5 6102.8 6131.9 6203.8 4464.9 4480.8 4563.2 4579.3 4735.8 4517.5 4558.4 4572.2 4576.7 4658.3 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | [#4] prototype.html Cycles:180 Average:4110.72 Median:4618.26 stddev:1228.17 (26.6%) stddev-sans-first:1197.28 22:38:36 INFO - PROCESS | 1511 | Values: 268.8 278.8 281.2 282.2 290.4 4760.5 4871.8 4872.5 4931.6 4941.6 4703.5 4804.2 4813.0 4822.6 4842.6 3562.6 3661.4 3776.7 3785.5 3797.4 3648.3 3755.0 3763.5 3786.5 3799.0 3762.8 3765.9 3766.8 3767.1 3773.3 3756.5 3770.9 3788.9 3791.6 3797.2 3118.7 3264.6 3264.8 3285.6 3346.3 4703.7 4706.7 4709.2 4721.9 4772.2 4057.2 4220.6 4226.2 4230.9 4245.5 5024.4 5031.2 5053.8 5060.2 5072.5 3495.8 3505.3 3507.3 3509.8 3523.7 5304.5 5311.9 5326.7 5326.7 5332.4 3374.4 3559.6 3582.3 3583.7 3589.2 3639.8 3647.5 3648.7 3656.4 3659.8 4207.2 4222.5 4227.5 4235.7 4239.9 4857.2 4988.7 5104.2 5111.6 5112.7 1229.7 1237.4 1239.3 1242.5 1251.6 770.9 794.9 799.9 803.8 806.4 4001.5 4037.6 4041.0 4044.0 4099.2 4602.9 4609.7 4612.6 4623.9 4692.8 4067.0 4071.7 4089.7 4107.8 4134.6 2352.6 2474.5 2489.8 2499.7 2509.3 4339.5 4356.1 4371.6 4415.5 4416.7 4712.0 4730.6 4743.0 4749.8 4801.1 4316.0 4350.8 4518.0 4924.9 4948.9 5268.4 5281.1 5286.4 5293.5 5316.9 5138.0 5160.6 5171.0 5177.8 5183.0 4694.7 4917.4 4946.3 4948.1 4980.4 3416.4 3504.6 3518.3 3600.4 3606.6 5216.5 5259.6 5269.7 5280.2 5286.6 5142.6 5153.8 5156.7 5168.4 5169.3 5013.7 5056.3 5081.2 5082.8 5097.8 5003.6 5008.9 5017.1 5034.3 5041.4 5056.4 5145.2 5171.5 5183.9 5195.1 4956.2 4958.5 4963.6 4978.9 4985.6 22:38:36 INFO - PROCESS | 1511 | 22:38:36 INFO - PROCESS | 1511 | [#5] yui.html Cycles:180 Average:15948.15 Median:24828.40 stddev:21391.58 (86.2%) stddev-sans-first:21420.68 22:38:36 INFO - PROCESS | 1511 | Values: 632.7 640.4 655.5 697.9 749.6 12498.0 13119.5 13504.8 13530.5 13565.3 12441.3 12584.4 12591.9 12597.1 12605.6 620.8 759.1 778.2 780.2 780.3 623.9 747.8 773.8 782.1 784.2 812.4 814.6 820.6 821.9 825.2 645.2 818.7 819.4 819.5 819.8 485.3 557.4 574.2 576.9 578.2 11919.6 11965.2 12036.9 12058.3 12059.6 11261.6 12082.2 12083.0 12400.4 12603.7 10138.9 10289.3 11493.9 11508.1 11744.2 4053.9 4073.9 4106.3 4200.2 4309.6 46896.3 49171.5 49261.3 54539.5 54586.5 10075.7 10387.7 10413.6 10436.3 10483.9 18340.9 18344.0 18395.0 18400.0 18477.4 6696.4 6894.7 6920.6 7069.3 7339.8 3645.9 3692.9 3701.1 3753.9 3783.6 2850.9 2933.6 2962.6 2965.3 2969.7 505.8 508.8 510.0 517.0 522.6 483.4 507.6 508.4 538.0 562.0 8396.2 8546.2 8734.5 8798.7 9016.3 494.7 561.9 568.7 573.7 586.2 4082.9 4132.2 4142.8 4205.1 4214.7 53556.7 53839.5 53951.0 54041.2 78160.0 81854.6 82765.6 83368.0 83877.0 84877.0 75005.6 75437.0 76096.0 77547.0 77828.8 7713.9 7899.5 7946.5 8044.6 8337.2 45866.5 46694.3 47044.3 47360.3 48396.3 35578.0 37680.8 46308.5 50912.0 53516.5 10909.8 10968.3 11264.7 11324.4 11859.9 11650.7 11870.8 12356.8 12481.6 12923.7 11842.7 11932.9 12186.8 12239.8 12281.0 11923.4 12106.9 12163.5 12543.9 13105.6 11536.3 11774.1 12437.6 12993.3 13026.5 9095.6 9180.0 9495.3 9710.2 9717.4 8009.9 8920.2 9103.7 9181.7 9413.0 22:38:36 INFO - PROCESS | 1511 | -------- Summary: end -------- 22:38:36 INFO - PROCESS | 1511 | 22:38:37 INFO - TEST-INFO | 1511: exit 0 22:38:37 INFO - TEST-OK | dromaeo_css | took 1122184ms 22:38:37 INFO - TEST-START | kraken 22:38:37 INFO - operating with platform_type : linux_ 22:38:37 INFO - Initialising browser for kraken test... 22:38:37 INFO - TEST-INFO | started process 1816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1PjLW/profile http://localhost:40631/getInfo.html) 22:38:41 INFO - PROCESS | 1816 | __metrics Screen width/height:1600/1200 22:38:41 INFO - PROCESS | 1816 | colorDepth:24 22:38:41 INFO - PROCESS | 1816 | Browser inner width/height: 1024/697 22:38:41 INFO - PROCESS | 1816 | __metrics 22:38:42 INFO - PROCESS | 1816 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:38:42 INFO - PROCESS | 1816 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:42 INFO - PROCESS | 1816 | console.error: PushService: 22:38:42 INFO - PROCESS | 1816 | stateChangeProcessEnqueue: Error transitioning state 22:38:42 INFO - PROCESS | 1816 | UnknownError 22:38:43 INFO - TEST-INFO | 1816: exit 0 22:38:43 INFO - Browser initialized. 22:38:43 INFO - Running cycle 1/1 for kraken test... 22:38:43 INFO - TEST-INFO | started process 1896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1PjLW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:55 INFO - PROCESS | 1896 | RSS: Main: 175394816 22:38:55 INFO - PROCESS | 1896 | 22:38:58 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40631/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:59 INFO - PROCESS | 1896 | RSS: Main: 234262528 22:38:59 INFO - PROCESS | 1896 | 22:39:02 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40631/tests/kraken/driver.html?testName=audio-dft) 22:39:02 INFO - PROCESS | 1896 | RSS: Main: 219508736 22:39:02 INFO - PROCESS | 1896 | 22:39:06 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40631/tests/kraken/driver.html?testName=audio-fft) 22:39:06 INFO - PROCESS | 1896 | RSS: Main: 301240320 22:39:06 INFO - PROCESS | 1896 | 22:39:08 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40631/tests/kraken/driver.html?testName=audio-oscillator) 22:39:09 INFO - PROCESS | 1896 | RSS: Main: 212090880 22:39:09 INFO - PROCESS | 1896 | 22:39:11 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:39:12 INFO - PROCESS | 1896 | RSS: Main: 215367680 22:39:12 INFO - PROCESS | 1896 | 22:39:15 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40631/tests/kraken/driver.html?testName=imaging-darkroom) 22:39:16 INFO - PROCESS | 1896 | RSS: Main: 251412480 22:39:16 INFO - PROCESS | 1896 | 22:39:19 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40631/tests/kraken/driver.html?testName=imaging-desaturate) 22:39:20 INFO - PROCESS | 1896 | RSS: Main: 249880576 22:39:20 INFO - PROCESS | 1896 | 22:39:23 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40631/tests/kraken/driver.html?testName=json-parse-financial) 22:39:23 INFO - PROCESS | 1896 | RSS: Main: 249753600 22:39:23 INFO - PROCESS | 1896 | 22:39:25 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:39:26 INFO - PROCESS | 1896 | RSS: Main: 212140032 22:39:26 INFO - PROCESS | 1896 | 22:39:27 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:39:28 INFO - PROCESS | 1896 | RSS: Main: 218886144 22:39:28 INFO - PROCESS | 1896 | 22:39:30 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:39:31 INFO - PROCESS | 1896 | RSS: Main: 228474880 22:39:31 INFO - PROCESS | 1896 | 22:39:34 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:39:34 INFO - PROCESS | 1896 | RSS: Main: 237207552 22:39:34 INFO - PROCESS | 1896 | 22:39:37 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:39:38 INFO - PROCESS | 1896 | RSS: Main: 233537536 22:39:38 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:40631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40631/tests/kraken/driver.html?testName=ai-astar) 22:39:40 INFO - PROCESS | 1896 | RSS: Main: 284102656 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | __start_tp_report 22:39:40 INFO - PROCESS | 1896 | _x_x_mozilla_page_load 22:39:40 INFO - PROCESS | 1896 | _x_x_mozilla_page_load_details 22:39:40 INFO - PROCESS | 1896 | |i|pagename|runs| 22:39:40 INFO - PROCESS | 1896 | |0;ai-astar;113;114;114;115;115;115;114;114;116;113 22:39:40 INFO - PROCESS | 1896 | |1;audio-beat-detection;147;132;129;171;129;129;132;129;168;132 22:39:40 INFO - PROCESS | 1896 | |2;audio-dft;162;162;162;163;162;162;162;162;161;160 22:39:40 INFO - PROCESS | 1896 | |3;audio-fft;76;76;77;110;76;76;76;76;106;77 22:39:40 INFO - PROCESS | 1896 | |4;audio-oscillator;85;84;123;84;83;84;114;84;83;124 22:39:40 INFO - PROCESS | 1896 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 22:39:40 INFO - PROCESS | 1896 | |6;imaging-darkroom;147;147;148;146;146;147;146;146;146;147 22:39:40 INFO - PROCESS | 1896 | |7;imaging-desaturate;96;96;96;96;97;96;95;96;95;96 22:39:40 INFO - PROCESS | 1896 | |8;json-parse-financial;64;64;62;64;65;67;65;65;64;64 22:39:40 INFO - PROCESS | 1896 | |9;json-stringify-tinderbox;66;67;66;66;68;66;66;65;66;66 22:39:40 INFO - PROCESS | 1896 | |10;stanford-crypto-aes;85;84;83;82;83;82;82;83;82;82 22:39:40 INFO - PROCESS | 1896 | |11;stanford-crypto-ccm;147;141;138;147;136;140;138;148;180;143 22:39:40 INFO - PROCESS | 1896 | |12;stanford-crypto-pbkdf2;174;173;174;172;173;173;173;174;177;172 22:39:40 INFO - PROCESS | 1896 | |13;stanford-crypto-sha256-iterative;70;73;70;73;69;72;70;73;70;69 22:39:40 INFO - PROCESS | 1896 | __end_tp_report 22:39:40 INFO - PROCESS | 1896 | __start_cc_report 22:39:40 INFO - PROCESS | 1896 | _x_x_mozilla_cycle_collect,1932 22:39:40 INFO - PROCESS | 1896 | __end_cc_report 22:39:40 INFO - PROCESS | 1896 | __startTimestamp1475559580573__endTimestamp 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | ------- Summary: start ------- 22:39:40 INFO - PROCESS | 1896 | Number of tests: 14 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:0.95 (0.8%) stddev-sans-first:0.88 22:39:40 INFO - PROCESS | 1896 | Values: 113.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 116.0 113.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:132.00 stddev:16.57 (12.5%) stddev-sans-first:17.36 22:39:40 INFO - PROCESS | 1896 | Values: 147.0 132.0 129.0 171.0 129.0 129.0 132.0 129.0 168.0 132.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:39:40 INFO - PROCESS | 1896 | Values: 162.0 162.0 162.0 163.0 162.0 162.0 162.0 162.0 161.0 160.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.43 (17.7%) stddev-sans-first:14.03 22:39:40 INFO - PROCESS | 1896 | Values: 76.0 76.0 77.0 110.0 76.0 76.0 76.0 76.0 106.0 77.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.82 (21.2%) stddev-sans-first:18.54 22:39:40 INFO - PROCESS | 1896 | Values: 85.0 84.0 123.0 84.0 83.0 84.0 114.0 84.0 83.0 124.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:39:40 INFO - PROCESS | 1896 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:39:40 INFO - PROCESS | 1896 | Values: 147.0 147.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:39:40 INFO - PROCESS | 1896 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 95.0 96.0 95.0 96.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.26 (2.0%) stddev-sans-first:1.33 22:39:40 INFO - PROCESS | 1896 | Values: 64.0 64.0 62.0 64.0 65.0 67.0 65.0 65.0 64.0 64.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 22:39:40 INFO - PROCESS | 1896 | Values: 66.0 67.0 66.0 66.0 68.0 66.0 66.0 65.0 66.0 66.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.03 (1.2%) stddev-sans-first:0.73 22:39:40 INFO - PROCESS | 1896 | Values: 85.0 84.0 83.0 82.0 83.0 82.0 82.0 83.0 82.0 82.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:145.00 stddev:12.73 (8.8%) stddev-sans-first:13.50 22:39:40 INFO - PROCESS | 1896 | Values: 147.0 141.0 138.0 147.0 136.0 140.0 138.0 148.0 180.0 143.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:173.50 stddev:1.43 (0.8%) stddev-sans-first:1.51 22:39:40 INFO - PROCESS | 1896 | Values: 174.0 173.0 174.0 172.0 173.0 173.0 173.0 174.0 177.0 172.0 22:39:40 INFO - PROCESS | 1896 | 22:39:40 INFO - PROCESS | 1896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.66 (2.3%) stddev-sans-first:1.73 22:39:40 INFO - PROCESS | 1896 | Values: 70.0 73.0 70.0 73.0 69.0 72.0 70.0 73.0 70.0 69.0 22:39:40 INFO - PROCESS | 1896 | -------- Summary: end -------- 22:39:40 INFO - PROCESS | 1896 | 22:39:41 INFO - TEST-INFO | 1896: exit 0 22:39:41 INFO - TEST-OK | kraken | took 64714ms 22:39:41 INFO - SUITE-END | took 1186s 22:39:42 INFO - Completed test suite (00:19:47) 22:39:42 INFO - javascript benchmark 22:39:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2546.325223815689, 2554.948901021981, 2598.753118453746, 2602.128287023847, 2616.8691565421723, 4580.679352445331, 4667.276572131325, 4678.064387122577, 4695.248760198369, 4697.976510117449, 4686.531346865312, 4701.905961880769, 4719.362886010387, 4771.165046116925, 4809.663323567352, 4276.97861510692, 4282.272013757669, 4327.4157988671595, 4350.97824510877, 4352.151330490556, 4350.3474478828275, 4450.0, 4458.063806600618, 4465.263231566788, 4473.038296766194, 4203.453551038346, 4384.561543845622, 4385.035292235703, 4414.80133393998, 4496.707713998596, 4231.280682284019, 4241.172971270604, 4285.100128972919, 4302.870913872589, 4327.913441731148, 4253.8723838284905, 4263.019505513749, 4313.374560688714, 4321.913561728779, 4329.696921215516, 4602.769861506945, 4605.976970115162, 4634.21218392874, 4653.418322709661, 4683.555062269079, 4861.683990540603, 4924.778384972685, 4953.876153096166, 4957.727324997124, 4965.677230980011, 5028.572571331441, 5039.143345631252, 5046.646734728571, 5094.261332106824, 5106.974465127688, 4695.483496815347, 4701.506341834058, 4702.576768090854, 4704.1767690654, 4762.452317983476, 4976.825811096594, 5020.59835213182, 5167.044096842096, 5168.956406211897, 5232.633715639869, 4822.493638167942, 4872.317875497433, 4876.439209490883, 4876.634252431082, 4879.194932836042, 5046.0, 5090.898182036412, 5094.898102037939, 5167.844964651066, 5173.198154286091, 4894.632902532324, 4929.112759703288, 5001.89996200074, 5090.567301779316, 5101.923471147936, 4956.950430495721, 4960.627952903546, 4966.404031516241, 4968.0312339093525, 5030.522100400456, 4060.3706425504092, 4090.5295890972325, 4158.812853421603, 4194.098268872207, 4257.957420425756, 3650.7444478886755, 3681.2821499807815, 3691.963080369162, 3699.204670995749, 3722.683571896419, 4384.298512238091, 4387.473503179639, 4391.231534481517, 4396.802143903468, 4450.910981780346, 4936.605071594336, 4997.275395067695, 5095.592352611782, 5110.744462776846, 5172.327597412387, 4319.200947824663, 4374.212641724456, 4379.211741886427, 4384.912301753947, 4392.297232442794, 4448.399466072104, 4455.532169122261, 4473.306637471197, 4501.7974191161475, 4506.909861802811, 4667.206574882211, 4668.0569694692595, 4671.392718946515, 4671.8364857229835, 4728.219843725747, 4898.9020219594695, 4954.083494553375, 4983.152864013054, 4991.051700176955, 5048.873778155576, 4724.929126063043, 4770.379850619397, 4772.188727916193, 4778.474367819467, 4842.58837998774, 5019.121653710513, 5022.623303252344, 5029.5221953914315, 5029.949700502948, 5092.3125378074965, 4872.537108974641, 5100.18397056484, 5107.565856902056, 5108.591312694901, 5174.379074511083, 4838.637102217277, 4906.3376444181, 4934.235193545006, 4955.925661115159, 5020.0, 4925.310456536159, 4944.357233559758, 4952.628552858622, 4954.00919816031, 5014.323066386137, 4862.756862156949, 4866.95133048665, 4878.487758785276, 4881.341018962395, 4945.505449455026, 4743.525647435229, 4776.808927642855, 4777.761111944319, 4913.140200464976, 4974.0797952378925, 4808.326834243278, 4819.831305904277, 4827.324174615627, 4883.804647814048, 4894.045661096052], "value": 4612.047357150809, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.479150432576, 559.4740943513095, 565.282091743486, 570.3070769015646, 578.6354596604139, 27290.86354568227, 27725.861370693143, 32768.50847237293, 33635.99092027237, 33645.83177084111, 37723.81138094312, 38073.0, 38137.61862381375, 38143.0, 38149.42775858357, 7506.887396689054, 7647.770566883002, 7649.1585925548425, 7649.961750191242, 7653.693852245903, 7487.850242995137, 7560.773176804704, 7565.810854728648, 7578.583177925212, 7582.620868956557, 7572.469927105105, 7608.7336943207, 7619.923800762004, 7626.771196864103, 7630.2751238632245, 7537.660805263777, 7584.014078169857, 7593.430492713069, 7594.5822979736095, 7601.125870524905, 7563.0, 7623.466357354987, 7651.1583725790115, 7651.6556754945605, 7653.272939070779, 35435.0, 35682.464763028576, 35724.10689732777, 35813.0, 35819.0, 2692.340376607724, 2801.971980280212, 2810.4941110600084, 2907.0697376839207, 3349.7822641528223, 27519.58720619192, 27617.585736213972, 27672.0, 27872.581911271347, 28242.29394265139, 3464.9653503464897, 3481.1645205150835, 3502.833246727523, 3515.789052656849, 3597.1366871950804, 234669.0, 235131.0, 235243.0, 235602.0, 236001.0, 48033.0, 48314.0, 48358.51641483611, 48381.0, 48397.27404088942, 31588.0, 32573.511397329057, 32744.508832367057, 34574.481382779275, 34579.65420345814, 12888.548900788428, 13027.739445211233, 13030.739385212431, 13041.413136408695, 13046.934765326112, 10231.641892533726, 10318.484075796181, 10363.119134873621, 10388.636397726195, 10399.012093851072, 16655.0, 16789.0, 16798.0, 16813.831861681472, 16952.406665766637, 6692.130023096966, 6717.328267173243, 6750.1562304711915, 6835.93164068353, 6862.553933994274, 790.6125998260926, 849.2653854416009, 862.9568521573896, 908.9681861134828, 932.1238036245907, 25116.372090697878, 25331.493370132495, 25563.744362556135, 25604.487910241693, 25901.8704906478, 759.506320891425, 929.4655573045526, 943.193569498083, 949.4350861237691, 971.771633666102, 13057.0, 13464.798028029587, 13697.383617737225, 13761.449542018407, 13899.722005559832, 364488.0, 365142.0, 366314.0, 366464.0, 369190.0, 45976.540234597895, 46564.7671761639, 46588.534114659094, 46606.533934660896, 46621.30068048982, 1066.9359838409564, 1105.4472763618191, 1147.5409836065473, 1155.364549497773, 1182.8994535464583, 25844.741552584233, 26980.865095674395, 27671.584926226526, 27885.442291154468, 28122.578161327187, 37915.431268531545, 38484.30609857283, 38558.228835423695, 38569.0, 38615.6138438612, 234762.0, 235096.0, 235247.0, 235729.0, 580872.0, 35561.288774224886, 36037.45943810898, 36240.456393153596, 36375.272494549434, 36782.816085919396, 39554.802225988686, 39599.60400395959, 39975.80012100037, 40237.0, 40544.0, 34134.487982679784, 35135.297294054486, 35220.295594088486, 35231.64768352284, 35397.82301088478, 34636.65363346334, 34756.30487390289, 34869.651303486644, 35000.64999349974, 35505.467417988235, 34083.31833363369, 34498.82750586231, 34567.2593844198, 34748.47877281792, 34924.30151397009, 29731.0, 32093.518597221526, 32340.0, 32393.51409728903, 32440.67559324471, 24358.26925192247, 24380.0, 24436.51126977415, 24722.752772472046, 24743.257702268962], "value": 16575.336656074178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8241132914107, 354.54618088846286, 366.8844314041078, 368.95203623528937, 382.3366459193299, 12350.135490515668, 15455.768163477544, 15778.763318550216, 16213.756793648105, 17378.913105434487, 15672.0, 15791.763123553155, 17016.0, 17115.82884171158, 17209.13954302283, 4822.5177482251665, 4870.342503762, 4919.4096708395045, 4977.47736487669, 5100.515451032146, 3673.210259794144, 3847.6729477994404, 4988.351514303154, 5035.546800787928, 5042.117629414856, 5664.886702265952, 5913.467787899088, 5944.821655350324, 6047.244094488189, 6052.909206361908, 5704.401037891044, 5849.38581448946, 5900.350961394243, 6019.729112189962, 6021.458068773832, 5136.101182293084, 5141.665791723563, 5155.793768249266, 5158.587313014949, 5161.5870730341485, 19611.509712257164, 20562.79437205639, 20706.171753129856, 20719.5856082879, 20758.0, 1982.9900850495799, 2022.595480903825, 2041.5508588110592, 2041.8697451881487, 2252.977470225293, 12444.937775311157, 13207.40566674502, 13539.729205415837, 13774.517891873737, 13883.791743123862, 1716.9828301716948, 1759.6304775997055, 1760.9119544022747, 1765.62921786425, 1776.7829037109493, 52900.47099528994, 58903.41096589022, 67951.0, 68484.0, 69312.0, 9537.809243815085, 9676.70969870905, 9700.417974921527, 9713.174380177765, 9889.0, 13256.469741210436, 13258.801117983237, 13262.668433289053, 13272.535461258809, 13304.201747895157, 7004.0, 7249.456290778213, 7288.12542494904, 7421.443391745641, 7435.0, 6936.757213497604, 7129.536580122275, 7315.926840731631, 7341.74303899361, 7347.853042939111, 3986.8604598839484, 4092.9795351023054, 4187.1625674865145, 4254.064105896698, 4299.269124248885, 1731.5497970527754, 1734.1935999760171, 1801.25248022072, 1816.1554876982266, 1818.418106206028, 798.6805277888891, 811.2617518058538, 816.6284340625001, 885.6014793343021, 900.1628485508539, 16114.194290285439, 16599.751003734953, 16958.745618815727, 17341.7398739019, 17574.209160587805, 851.0, 863.6933888469503, 878.4904755241944, 882.6160620130264, 919.6597259014208, 7778.338841198448, 9389.62441502346, 9633.373830700983, 9744.805103897883, 9793.314467987173, 364144.0, 364578.0, 366556.0, 367690.0, 367944.0, 54546.454535454934, 65715.34284657188, 68261.31738682649, 72065.0, 76411.23588764042, 832.7930982895255, 875.9518226497477, 899.3075331994328, 899.8065415935605, 904.9321300902459, 11714.648560543197, 15433.614159646098, 16100.758488622914, 16112.516624501284, 16337.264823082753, 36868.26263474769, 37063.629363706015, 37854.0, 37918.431223531115, 38623.806880965414, 44891.0, 46282.76858615685, 46423.76788116173, 46425.30362044505, 48282.517174829205, 7163.391111755559, 7247.0, 7484.401247900264, 7531.8493630125995, 7677.232276772278, 8300.667973281, 10592.682219533426, 10839.945800270949, 11266.830997535208, 12277.69305767363, 10112.797744045225, 10208.183345332207, 10249.846252306072, 10509.474526273809, 10626.73433164146, 9629.229661627192, 10074.597016119273, 10137.543810528692, 10251.0, 10282.0, 9963.402195868272, 10071.84892226632, 10160.288779785344, 10238.948805255926, 10682.145428365868, 7439.665215065444, 7444.628890184959, 7509.7371591994015, 7613.771586852404, 7790.376769858511, 8398.412111152405, 9864.85202721974, 9875.604975800887, 10094.293399461967, 10508.159347252355], "value": 8093.865880294954, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.2713853103733, 1338.5448947357897, 1344.4622151139545, 1626.2902050949165, 1639.0493513762026, 6661.833454163649, 6885.48358873084, 7005.369516743492, 7548.584827834474, 7564.773056808298, 7027.0, 7336.082989626297, 7348.889766653491, 7495.587742674151, 7496.287852654003, 2005.8696184748017, 2035.9491012724652, 2038.2662241593014, 2038.98980505098, 2040.1839264294254, 1608.1396452897702, 1670.0480725986192, 1854.5641774183123, 1882.4823173627226, 1885.038630298544, 1883.2184643372984, 1948.2012374926212, 1958.4810025343295, 1962.2641509433963, 1966.1840336260434, 1986.850986176028, 1996.17158879065, 1997.1611922992306, 2003.07858385143, 2025.0, 1980.3068925875973, 1986.145957238387, 1987.920483180671, 1994.99002504988, 1995.7904420035832, 7366.521176123535, 7606.581638009908, 7606.657700403495, 7624.313811756913, 7625.275598818103, 4121.8969525761795, 4234.322508398642, 4241.533431322552, 4250.06498570314, 4253.638440732541, 2602.414456747236, 2764.626775385317, 2767.875445604953, 2778.513760091996, 2781.1656503049207, 816.1675091406731, 851.6337974670889, 866.8959724832997, 868.452874688942, 874.3180319350917, 10131.138853197486, 10151.441670708182, 10173.694789156338, 10183.592656293813, 10190.439525826077, 3682.208325210039, 3823.6941044716355, 3883.0874744435037, 3961.920761584752, 3980.721349505565, 8633.568321583896, 8657.22085012352, 8662.653493860302, 8665.220130188314, 8666.393352465393, 4254.149170165917, 4256.87229383119, 4264.829406823755, 4265.232258193493, 4266.914661706748, 3893.104585945192, 3900.1029763154634, 3902.6097390261316, 3903.785291808921, 3910.9804450977563, 3171.904842854718, 3289.654586268455, 3304.9173770655443, 3338.8163650999427, 3389.1696534349244, 905.4431524612447, 909.0591238068699, 946.3706635087727, 961.2694352292308, 976.3995142987012, 757.6666266842572, 761.9809504762314, 809.6437567470412, 817.4237162800212, 851.3061854588491, 4829.758512074382, 4864.854054378375, 4980.850574482772, 5117.797317630354, 5145.4597267287145, 829.531314807132, 830.2030051150963, 846.995765021171, 861.9569021549023, 896.233720169259, 3326.5841769778776, 3341.5823022122236, 3523.94714079289, 3530.6116327203986, 3592.1019745063736, 8728.65085396577, 9123.635054597875, 9159.49622770754, 9165.404248723811, 9167.587458564381, 9135.817283654289, 9138.680146194984, 9144.085591440802, 9171.40385874916, 9191.862122068174, 6766.966165169241, 6797.4901882358035, 6870.416014638712, 6956.373926346653, 6962.582245065413, 4950.331705219749, 4953.653244272867, 5105.8723531912, 5108.846734597968, 5117.718525481134, 8256.215659512576, 8291.33669306466, 8435.409521333448, 8481.915180848113, 8545.060043395346, 8459.196376344238, 8492.150784921705, 8613.26787223093, 8616.310695144499, 8667.826643467222, 5815.563832712479, 5949.553783466171, 5951.970240148771, 5953.91069133972, 5958.463738263577, 6722.0, 7139.036230108869, 7202.063731714844, 7208.927910721035, 7219.45854060937, 6362.809115726535, 6459.547831651739, 6491.545591808528, 6620.3710647488415, 6780.762673306608, 6416.839579010562, 6423.8394040147505, 6501.837454063686, 6502.187226596676, 6540.934590654033, 6041.879162416639, 6085.543584231112, 6102.816915492543, 6131.877362452637, 6203.844903877439, 4464.866054018385, 4480.843170489017, 4563.178627847019, 4579.267317229227, 4735.786889590046, 4517.548245175456, 4558.407407037064, 4572.199865023541, 4576.702514336557, 4658.324542941186], "value": 3878.1954841831976, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.814517982592, 278.7992645295387, 281.1663417965732, 282.15213284081335, 290.44235068668155, 4760.547747963947, 4871.756412179395, 4872.515017341159, 4931.6301277404245, 4941.579965702915, 4703.529647035295, 4804.207305794548, 4813.0, 4822.614190864731, 4842.564169224778, 3562.6259242779524, 3661.4324779659196, 3776.6978641708733, 3785.5268091488565, 3797.449369841371, 3648.343298206322, 3755.0, 3763.473113764075, 3786.5266841644793, 3799.0, 3762.8118594070324, 3765.905852353699, 3766.811659417032, 3767.133559281367, 3773.3208022555928, 3756.4740936268945, 3770.8680196193, 3788.8592944985994, 3791.5639701434275, 3797.246995927958, 3118.7193152616373, 3264.5919260092487, 3264.820434876081, 3285.605727312714, 3346.297277571713, 4703.6942598730975, 4706.74112923789, 4709.246520556694, 4721.929171062402, 4772.2125849234835, 4057.2494088593703, 4220.6412454941365, 4226.154769046203, 4230.894227644303, 4245.532991370947, 5024.3670806987875, 5031.169856973595, 5053.797848086072, 5060.165072763027, 5072.51811077947, 3495.7727747696317, 3505.3164632896596, 3507.333606614735, 3509.8245087745768, 3523.6828685418177, 5304.522592966651, 5311.920321195185, 5326.680399176062, 5326.680399176062, 5332.440093790174, 3374.4263475209273, 3559.5728512578658, 3582.3014512169875, 3583.7133029357587, 3589.192431702846, 3639.836207370675, 3647.471116688065, 3648.6533779290926, 3656.3601369760186, 3659.780413175218, 4207.158568286355, 4222.451081359403, 4227.492700875914, 4235.745855248695, 4239.936400953989, 4857.222844344888, 4988.678000329915, 5104.234364845229, 5111.642185047085, 5112.693238405707, 1229.6679896427913, 1237.406045098358, 1239.324568110382, 1242.546470538247, 1251.6495381293253, 770.9036370453694, 794.8648729715962, 799.9240072193132, 803.8070862992839, 806.435495153395, 4001.47980762499, 4037.6366127048705, 4040.959590404117, 4043.9890027493125, 4099.2416402964955, 4602.88492787683, 4609.700369476041, 4612.630989520831, 4623.884402889955, 4692.81228750853, 4066.959330406717, 4071.6742660587083, 4089.7137200395687, 4107.815148318333, 4134.586541345841, 2352.6472278439965, 2474.4679893822913, 2489.7634724701124, 2499.7000359956924, 2509.3475696318724, 4339.457567804025, 4356.1268654478245, 4371.628411584988, 4415.492218394926, 4416.668749843775, 4711.95288047122, 4730.597899178609, 4742.976285118552, 4749.786259618326, 4801.135795556834, 4315.956840431555, 4350.8042138103865, 4517.983453722886, 4924.891899322623, 4948.90102197954, 5268.446813084724, 5281.1286137788375, 5286.444923283, 5293.497117773805, 5316.920246196388, 5137.970501651752, 5160.587153027674, 5171.01750667372, 5177.792888284426, 5183.0, 4694.694844835075, 4917.360743103373, 4946.258061290835, 4948.144445832812, 4980.402351717817, 3416.4362880125495, 3504.5969713483278, 3518.3139287838626, 3600.3519366513233, 3606.621304763067, 5216.530512253916, 5259.55293800016, 5269.736513174403, 5280.155175171954, 5286.603504737083, 5142.6400151989, 5153.793848246029, 5156.664816786897, 5168.3797944246935, 5169.250458683395, 5013.674111182761, 5056.317397151338, 5081.161608334583, 5082.822101226439, 5097.770600323069, 5003.574696150868, 5008.899822003466, 5017.096922553976, 5034.3455350805625, 5041.395032595965, 5056.443791183041, 5145.176771716657, 5171.50870667286, 5183.92224116631, 5195.064788394545, 4956.157453232887, 4958.45456999737, 4963.553280204799, 4978.85486338137, 4985.551300382983], "value": 3713.57743920141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.6552029144119, 640.3820313397571, 655.5050936542909, 697.9057827193327, 749.5540153608601, 12498.0, 13119.47522099115, 13504.797428038588, 13530.458781648735, 13565.321733913303, 12441.253524788497, 12584.370781460913, 12591.874081259184, 12597.118201725883, 12605.558805441811, 620.8323752586799, 759.1232126893433, 778.1634742651644, 780.2314720000795, 780.3484090784174, 623.8689875126229, 747.8466914282559, 773.8026803165185, 782.0615261685971, 784.2040329066002, 812.4394168024074, 814.5927036481759, 820.5774026376421, 821.8726097454904, 825.1707034430419, 645.2450632759683, 818.7134502923989, 819.3772732723173, 819.491915012693, 819.7663665855202, 485.2866286558753, 557.4202829057775, 574.247735466536, 576.8557860534867, 578.2107423367115, 11919.642410727693, 11965.222260553122, 12036.87963120375, 12058.276503409823, 12059.638210853689, 11261.605843795427, 12082.214656047418, 12083.0, 12400.379981000913, 12603.74792504154, 10138.949305253427, 10289.3311934724, 11493.885061149365, 11508.079353651772, 11744.236624619458, 4053.939190912109, 4073.8574149904907, 4106.281400754856, 4200.180964711883, 4309.59058889405, 46896.29655555169, 49171.50828491705, 49261.26108108345, 54539.45460545384, 54586.45413545893, 10075.697729068139, 10387.68836934893, 10413.635522756667, 10436.321639093434, 10483.947580262049, 18340.908295458437, 18344.0, 18395.0, 18400.0, 18477.353292634692, 6696.363845434676, 6894.655267236719, 6920.5847649141215, 7069.293070692993, 7339.77980660581, 3645.908852278661, 3692.9446058309145, 3701.0932321581386, 3753.868614598476, 3783.564890037681, 2850.8859645613943, 2933.6186295781413, 2962.555616657519, 2965.258685328668, 2969.6881827408242, 505.7774579185147, 508.7863097499059, 509.9923501147486, 516.9508896654812, 522.5819344524365, 483.37885816726043, 507.6015327967602, 508.4381758157183, 538.004691321053, 561.9775208991595, 8396.160383961555, 8546.188112129463, 8734.471084774548, 8798.736037918872, 9016.278697704169, 494.7155385653192, 561.878763468934, 568.7326956330518, 573.7332140554579, 586.2378907420422, 4082.9387559186634, 4132.194222126716, 4142.834286628501, 4205.11692544563, 4214.726042807208, 53556.73221633867, 53839.461605384226, 53951.0, 54041.1893821593, 78160.0, 81854.59072704718, 82765.58617206996, 83368.0, 83877.0, 84877.0, 75005.62497187479, 75437.0, 76096.0, 77547.0, 77828.83256751153, 7713.922860771545, 7899.486533375312, 7946.500382281855, 8044.597770111354, 8337.207965243293, 45866.541334586225, 46694.29958550556, 47044.29433558568, 47360.289595655406, 48396.27405588848, 35578.0, 37680.81159594184, 46308.53691463177, 50912.0, 53516.46483535115, 10909.83635245456, 10968.341899486057, 11264.718382040515, 11324.37715925599, 11859.881401185878, 11650.6504804856, 11870.832918698103, 12356.814647780471, 12481.56314528987, 12923.741525169631, 11842.703932401759, 11932.940335298268, 12186.817197741864, 12239.816402753788, 12281.0, 11923.403829808301, 12106.939465302617, 12163.513459461523, 12543.87456125427, 13105.606831795061, 11536.25014374063, 11774.116941229613, 12437.62687119388, 12993.285369304778, 13026.54407095747, 9095.590698418455, 9179.954100229455, 9495.335326527076, 9710.17463515609, 9717.368371055858, 8009.91990080115, 8920.197182253629, 9103.681371151977, 9181.724548263563, 9412.95293523528], "value": 6350.698531605546, "unit": "score"}], "name": "dromaeo_css", "value": 6196.3284636409435, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 116.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 132.0, 129.0, 171.0, 129.0, 129.0, 132.0, 129.0, 168.0, 132.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 110.0, 76.0, 76.0, 76.0, 76.0, 106.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 123.0, 84.0, 83.0, 84.0, 114.0, 84.0, 83.0, 124.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 64.0, 65.0, 67.0, 65.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 82.0, 83.0, 82.0, 82.0, 83.0, 82.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 138.0, 147.0, 136.0, 140.0, 138.0, 148.0, 180.0, 143.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 174.0, 172.0, 173.0, 173.0, 173.0, 174.0, 177.0, 172.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 70.0, 73.0, 69.0, 72.0, 70.0, 73.0, 70.0, 69.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1556.1999999999998, "alertThreshold": 2.0}]} 22:39:42 INFO - Return code: 0 22:39:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:39:42 INFO - # TBPL SUCCESS # 22:39:42 INFO - Running post-action listener: _resource_record_post_action 22:39:42 INFO - [mozharness: 2016-10-04 05:39:42.396745Z] Finished run-tests step (success) 22:39:42 INFO - Running post-run listener: _resource_record_post_run 22:39:42 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 408731648; Read time: 0; Write time: 220916 22:39:42 INFO - TinderboxPrint: CPU usage
13.0% 22:39:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:39:42 INFO - TinderboxPrint: I/O write bytes / time
408,731,648 / 220,916 22:39:42 INFO - TinderboxPrint: CPU idle
8,345.9 (86.9%) 22:39:42 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 22:39:42 INFO - TinderboxPrint: Swap in / out
0 / 0 22:39:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99983360; Read time: 0; Write time: 65460 22:39:42 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291885056; Read time: 0; Write time: 151440 22:39:43 INFO - Running post-run listener: _upload_blobber_files 22:39:43 INFO - Blob upload gear active. 22:39:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:39:43 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 22:39:43 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:39:43 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:39:43 INFO - (blobuploader) - INFO - Open directory for files ... 22:39:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:39:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:44 INFO - (blobuploader) - INFO - Done attempting. 22:39:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:39:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:44 INFO - (blobuploader) - INFO - Done attempting. 22:39:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:39:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:49 INFO - (blobuploader) - INFO - Done attempting. 22:39:49 INFO - (blobuploader) - INFO - Iteration through files over. 22:39:49 INFO - Return code: 0 22:39:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:39:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:39:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8752bc7a9295f870931f2db3a1f0823a5f5a9cf20029464f92bc46da9d4503fadb18e20fa9720f40868f6e9e014be4a836608f71d53b694728759924da994fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ed7760fce853eed69a4ed75fce7a7c8cad72793ccbe7003c820106fe3b1cf930dac4d063d333608d06adf6ee4f3b5e8ba4d93ad2f273c874a30789c91da9f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/78afa87f1a9160c22c0d53831e0a9250f9eee573c03a7c841f8519c4c08f29c70728a18dbfb82e1196070e205445407ad43d627c9c77b43dfcc5d5e4dd6879b8"} 22:39:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:39:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:39:49 INFO - Contents: 22:39:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8752bc7a9295f870931f2db3a1f0823a5f5a9cf20029464f92bc46da9d4503fadb18e20fa9720f40868f6e9e014be4a836608f71d53b694728759924da994fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ed7760fce853eed69a4ed75fce7a7c8cad72793ccbe7003c820106fe3b1cf930dac4d063d333608d06adf6ee4f3b5e8ba4d93ad2f273c874a30789c91da9f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/78afa87f1a9160c22c0d53831e0a9250f9eee573c03a7c841f8519c4c08f29c70728a18dbfb82e1196070e205445407ad43d627c9c77b43dfcc5d5e4dd6879b8"} 22:39:49 INFO - Running post-run listener: copy_logs_to_upload_dir 22:39:49 INFO - Copying logs to upload dir... 22:39:49 INFO - mkdir: /builds/slave/test/build/upload/logs 22:39:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.042286 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-03 22:39:48.835614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 22:39:48.840651) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8752bc7a9295f870931f2db3a1f0823a5f5a9cf20029464f92bc46da9d4503fadb18e20fa9720f40868f6e9e014be4a836608f71d53b694728759924da994fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ed7760fce853eed69a4ed75fce7a7c8cad72793ccbe7003c820106fe3b1cf930dac4d063d333608d06adf6ee4f3b5e8ba4d93ad2f273c874a30789c91da9f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/78afa87f1a9160c22c0d53831e0a9250f9eee573c03a7c841f8519c4c08f29c70728a18dbfb82e1196070e205445407ad43d627c9c77b43dfcc5d5e4dd6879b8"} build_url:https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/FFqfhELhQXO4rWZuXEB3CA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8752bc7a9295f870931f2db3a1f0823a5f5a9cf20029464f92bc46da9d4503fadb18e20fa9720f40868f6e9e014be4a836608f71d53b694728759924da994fb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ed7760fce853eed69a4ed75fce7a7c8cad72793ccbe7003c820106fe3b1cf930dac4d063d333608d06adf6ee4f3b5e8ba4d93ad2f273c874a30789c91da9f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/78afa87f1a9160c22c0d53831e0a9250f9eee573c03a7c841f8519c4c08f29c70728a18dbfb82e1196070e205445407ad43d627c9c77b43dfcc5d5e4dd6879b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 22:39:48.865891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:39:48.866255) ========= 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=bb9b54edd4a927dc735d112f000001d9-1475557681.578180-933102302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 22:39:48.950180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 22:39:48.950517) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 22:39:48.950850) ========= ========= Total master_lag: 0.17 =========