builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1476379951.42 results: success (0) buildid: 20161013093024 builduid: edc515266e094507ab0fb9367024ef42 revision: 83461556cda59e8bcd54f09b9263e3202ce01dc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.416380) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.416903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.417217) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.431906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.432230) ========= 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=cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 10:32:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2016-10-13 10:32:32 (23.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.557022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.557442) ========= 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=cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.607696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:31.608086) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 83461556cda59e8bcd54f09b9263e3202ce01dc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 83461556cda59e8bcd54f09b9263e3202ce01dc2 --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=cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 10:32:32,113 truncating revision to first 12 chars 2016-10-13 10:32:32,113 Setting DEBUG logging. 2016-10-13 10:32:32,114 attempt 1/10 2016-10-13 10:32:32,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/83461556cda5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 10:32:32,544 unpacking tar archive at: fx-team-83461556cda5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772210 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:32.394124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:32.394486) ========= script_repo_revision: 83461556cda59e8bcd54f09b9263e3202ce01dc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:32.394944) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:32.395242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 10:32:32.405538) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-13 10:32:32.405972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:32:32 INFO - MultiFileLogger online at 20161013 10:32:32 in /builds/slave/test 10:32:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:32:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:32:33 INFO - {'append_to_log': False, 10:32:33 INFO - 'base_work_dir': '/builds/slave/test', 10:32:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:32:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:32:33 INFO - 'branch': 'Fx-Team-Non-PGO', 10:32:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:32:33 INFO - 'config_files': ('talos/linux_config.py',), 10:32:33 INFO - 'default_actions': ('clobber', 10:32:33 INFO - 'read-buildbot-config', 10:32:33 INFO - 'download-and-extract', 10:32:33 INFO - 'populate-webroot', 10:32:33 INFO - 'create-virtualenv', 10:32:33 INFO - 'install', 10:32:33 INFO - 'run-tests'), 10:32:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:32:33 INFO - 'download_minidump_stackwalk': True, 10:32:33 INFO - 'download_symbols': 'ondemand', 10:32:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:32:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:32:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:32:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:32:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:32:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:32:33 INFO - 'installer_path': 'installer.exe', 10:32:33 INFO - 'log_level': 'info', 10:32:33 INFO - 'log_name': 'talos', 10:32:33 INFO - 'log_to_console': True, 10:32:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:32:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:32:33 INFO - 'opt_config_files': (), 10:32:33 INFO - 'pip_index': False, 10:32:33 INFO - 'sps_profile': False, 10:32:33 INFO - 'sps_profile_interval': 0, 10:32:33 INFO - 'suite': 'dromaeojs', 10:32:33 INFO - 'system_bits': '32', 10:32:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:32:33 INFO - 'title': 'talos-linux64-ix-054', 10:32:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:32:33 INFO - 'use_talos_json': True, 10:32:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:32:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:32:33 INFO - 'work_dir': 'build'} 10:32:33 INFO - [mozharness: 2016-10-13 17:32:33.005899Z] Running clobber step. 10:32:33 INFO - Running pre-action listener: _resource_record_pre_action 10:32:33 INFO - Running main action method: clobber 10:32:33 INFO - rmtree: /builds/slave/test/build 10:32:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:32:33 INFO - Running post-action listener: _resource_record_post_action 10:32:33 INFO - [mozharness: 2016-10-13 17:32:33.479599Z] Finished clobber step (success) 10:32:33 INFO - [mozharness: 2016-10-13 17:32:33.479700Z] Running read-buildbot-config step. 10:32:33 INFO - Running pre-action listener: _resource_record_pre_action 10:32:33 INFO - Running main action method: read_buildbot_config 10:32:33 INFO - Using buildbot properties: 10:32:33 INFO - { 10:32:33 INFO - "project": "", 10:32:33 INFO - "product": "firefox", 10:32:33 INFO - "script_repo_revision": "production", 10:32:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:32:33 INFO - "repository": "", 10:32:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:32:33 INFO - "buildid": "20161013093024", 10:32:33 INFO - "pgo_build": "False", 10:32:33 INFO - "basedir": "/builds/slave/test", 10:32:33 INFO - "buildnumber": 3388, 10:32:33 INFO - "slavename": "talos-linux64-ix-054", 10:32:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:32:33 INFO - "platform": "ubuntu64_hw", 10:32:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:32:33 INFO - "branch": "fx-team", 10:32:33 INFO - "repo_path": "integration/fx-team", 10:32:33 INFO - "revision": "83461556cda59e8bcd54f09b9263e3202ce01dc2", 10:32:33 INFO - "stage_platform": "linux64", 10:32:33 INFO - "builduid": "edc515266e094507ab0fb9367024ef42", 10:32:33 INFO - "slavebuilddir": "test" 10:32:33 INFO - } 10:32:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:32:33 INFO - Running post-action listener: _resource_record_post_action 10:32:33 INFO - [mozharness: 2016-10-13 17:32:33.482184Z] Finished read-buildbot-config step (success) 10:32:33 INFO - [mozharness: 2016-10-13 17:32:33.482272Z] Running download-and-extract step. 10:32:33 INFO - Running pre-action listener: _resource_record_pre_action 10:32:33 INFO - Running main action method: download_and_extract 10:32:33 INFO - mkdir: /builds/slave/test/build/tests 10:32:33 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')]} 10:32:33 INFO - trying https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/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 10:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/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 10:32:34 INFO - Downloaded 1361 bytes. 10:32:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:32:34 INFO - Using the following test package requirements: 10:32:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:32:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:32:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:32:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'jsshell-linux-x86_64.zip'], 10:32:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:32:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:32:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:32:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:32:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:32:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:32:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:32:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:32:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:32:34 INFO - Fetch https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:32:34 INFO - Http code: 200 10:32:34 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 10:32:34 INFO - x-amz-cf-id: 6dYgnLufaDPoonipKewbr2S1laf7wAhnbCP5T6TA4PTm6I0l-Oce7Q== 10:32:34 INFO - x-amz-version-id: zASQYa8CfpC1KDgwJqCwF1QJHbKlbp.o 10:32:34 INFO - Expected file size: 20557785 10:32:34 INFO - Obtained file size: 20557785 10:32:38 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 10:32:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:32:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:32:38 INFO - Fetch https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:32:39 INFO - Http code: 200 10:32:39 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 10:32:39 INFO - x-amz-cf-id: rhh_h8YhbRgEXgKA69rfOdFIQsix1vlPp4nJBSL3RtuH-LOZJvx15A== 10:32:39 INFO - x-amz-version-id: zASQYa8CfpC1KDgwJqCwF1QJHbKlbp.o 10:32:39 INFO - Expected file size: 20557785 10:32:39 INFO - Obtained file size: 20557785 10:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:32:45 INFO - Http code: 200 10:32:45 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:32:45 INFO - x-amz-cf-id: RTSondhwPUaYuoAMlgxh911Wb4pPzPCkIcBB9fNrGzVKtwe0zcPsfw== 10:32:45 INFO - x-amz-version-id: CTw8ctAbulWz6b8W9hh.bMN1Ofxn3A5x 10:32:45 INFO - Expected file size: 14409006 10:32:45 INFO - Obtained file size: 14409006 10:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:46 INFO - trying https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/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 10:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/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 10:32:47 INFO - Downloaded 55941310 bytes. 10:32:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:32:47 INFO - mkdir: /builds/slave/test/properties 10:32:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:47 INFO - Contents: 10:32:47 INFO - build_url:https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:32:48 INFO - Running post-action listener: _resource_record_post_action 10:32:48 INFO - Running post-action listener: set_extra_try_arguments 10:32:48 INFO - [mozharness: 2016-10-13 17:32:48.050080Z] Finished download-and-extract step (success) 10:32:48 INFO - [mozharness: 2016-10-13 17:32:48.050375Z] Running populate-webroot step. 10:32:48 INFO - Running pre-action listener: _resource_record_pre_action 10:32:48 INFO - Running main action method: populate_webroot 10:32:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:32:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:32:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:32:48 INFO - '--tppagecycles', 10:32:48 INFO - '7'], 10:32:48 INFO - 'tests': ['tsvgm']}}, 10:32:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:32:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:32:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['damp', 'tps']}, 10:32:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'tests': ['damp', 'tps']}, 10:32:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['dromaeo_dom']}, 10:32:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['basic_compositor_video']}, 10:32:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:32:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['a11yr', 10:32:48 INFO - 'ts_paint', 10:32:48 INFO - 'tpaint', 10:32:48 INFO - 'sessionrestore', 10:32:48 INFO - 'sessionrestore_no_auto_restore', 10:32:48 INFO - 'tabpaint']}, 10:32:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:48 INFO - 'ts_paint', 10:32:48 INFO - 'tpaint', 10:32:48 INFO - 'sessionrestore', 10:32:48 INFO - 'sessionrestore_no_auto_restore', 10:32:48 INFO - 'tabpaint']}, 10:32:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:32:48 INFO - 'ts_paint', 10:32:48 INFO - 'tpaint', 10:32:48 INFO - 'sessionrestore', 10:32:48 INFO - 'sessionrestore_no_auto_restore', 10:32:48 INFO - 'tabpaint']}, 10:32:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:32:48 INFO - 'ts_paint', 10:32:48 INFO - 'tpaint', 10:32:48 INFO - 'sessionrestore', 10:32:48 INFO - 'sessionrestore_no_auto_restore', 10:32:48 INFO - 'tabpaint']}, 10:32:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['a11yr', 10:32:48 INFO - 'ts_paint', 10:32:48 INFO - 'tpaint', 10:32:48 INFO - 'sessionrestore', 10:32:48 INFO - 'sessionrestore_no_auto_restore', 10:32:48 INFO - 'tabpaint']}, 10:32:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['a11yr', 10:32:48 INFO - 'ts_paint', 10:32:48 INFO - 'tpaint', 10:32:48 INFO - 'sessionrestore', 10:32:48 INFO - 'sessionrestore_no_auto_restore', 10:32:48 INFO - 'tabpaint']}, 10:32:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['tsvgx', 10:32:48 INFO - 'tsvgr_opacity', 10:32:48 INFO - 'tart', 10:32:48 INFO - 'tscrollx', 10:32:48 INFO - 'cart']}, 10:32:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:48 INFO - 'tsvgr_opacity', 10:32:48 INFO - 'tart', 10:32:48 INFO - 'tscrollx', 10:32:48 INFO - 'cart']}, 10:32:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'talos_options': ['--disable-e10s'], 10:32:48 INFO - 'tests': ['tp5o']}, 10:32:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'tests': ['tp5o']}, 10:32:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'talos_options': ['--disable-e10s', 10:32:48 INFO - '--xperf_path', 10:32:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:48 INFO - 'tests': ['tp5n']}, 10:32:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:48 INFO - 'talos_options': ['--xperf_path', 10:32:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:48 INFO - 'tests': ['tp5n']}}, 10:32:48 INFO - 'talos.zip': {'path': '', 10:32:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:32:48 INFO - Running post-action listener: _resource_record_post_action 10:32:48 INFO - [mozharness: 2016-10-13 17:32:48.071781Z] Finished populate-webroot step (success) 10:32:48 INFO - [mozharness: 2016-10-13 17:32:48.071871Z] Running create-virtualenv step. 10:32:48 INFO - Running pre-action listener: _resource_record_pre_action 10:32:48 INFO - Running main action method: create_virtualenv 10:32:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:48 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 10:32:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:48 INFO - Using real prefix '/usr' 10:32:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:50 INFO - Installing pip.................done. 10:32:50 INFO - Return code: 0 10:32:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:32:50 INFO - Reading from file tmpfile_stdout 10:32:50 INFO - Output received: 10:32:50 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) 10:32:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:32:50 INFO - Using env: {'DISPLAY': ':0', 10:32:50 INFO - 'HOME': '/home/cltbld', 10:32:50 INFO - 'LANG': 'en_US.UTF-8', 10:32:50 INFO - 'LANGUAGE': 'en_US:en', 10:32:50 INFO - 'LOGNAME': 'cltbld', 10:32:50 INFO - 'MAIL': '/var/mail/cltbld', 10:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:50 INFO - 'MOZ_NO_REMOTE': '1', 10:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:50 INFO - 'NO_EM_RESTART': '1', 10:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:50 INFO - 'PWD': '/builds/slave/test', 10:32:50 INFO - 'SHELL': '/bin/bash', 10:32:50 INFO - 'SHLVL': '1', 10:32:50 INFO - 'TERM': 'linux', 10:32:50 INFO - 'TMOUT': '86400', 10:32:50 INFO - 'USER': 'cltbld', 10:32:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:50 INFO - '_': '/tools/buildbot/bin/python'} 10:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:51 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 10:32:51 INFO - Cleaning up... 10:32:51 INFO - Return code: 0 10:32:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:32:51 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')]} 10:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:51 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')]} 10:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:51 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:32:51 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 10:32:51 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 10:32:51 INFO - Using env: {'DISPLAY': ':0', 10:32:51 INFO - 'HOME': '/home/cltbld', 10:32:51 INFO - 'LANG': 'en_US.UTF-8', 10:32:51 INFO - 'LANGUAGE': 'en_US:en', 10:32:51 INFO - 'LOGNAME': 'cltbld', 10:32:51 INFO - 'MAIL': '/var/mail/cltbld', 10:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:51 INFO - 'MOZ_NO_REMOTE': '1', 10:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:51 INFO - 'NO_EM_RESTART': '1', 10:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:51 INFO - 'PWD': '/builds/slave/test', 10:32:51 INFO - 'SHELL': '/bin/bash', 10:32:51 INFO - 'SHLVL': '1', 10:32:51 INFO - 'TERM': 'linux', 10:32:51 INFO - 'TMOUT': '86400', 10:32:51 INFO - 'USER': 'cltbld', 10:32:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:51 INFO - '_': '/tools/buildbot/bin/python'} 10:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:51 INFO - Downloading/unpacking psutil>=3.1.1 10:32:51 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 10:32:51 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 10:32:51 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 10:32:51 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 10:32:51 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 10:32:51 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 10:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:53 INFO - Installing collected packages: psutil 10:32:53 INFO - Running setup.py install for psutil 10:32:53 INFO - building 'psutil._psutil_linux' extension 10:32:53 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 10:32:53 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 10:32:53 INFO - building 'psutil._psutil_posix' extension 10:32:53 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 10:32:53 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 10:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:53 INFO - Successfully installed psutil 10:32:53 INFO - Cleaning up... 10:32:53 INFO - Return code: 0 10:32:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:53 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:32:53 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 10:32:53 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 10:32:53 INFO - Using env: {'DISPLAY': ':0', 10:32:53 INFO - 'HOME': '/home/cltbld', 10:32:53 INFO - 'LANG': 'en_US.UTF-8', 10:32:53 INFO - 'LANGUAGE': 'en_US:en', 10:32:53 INFO - 'LOGNAME': 'cltbld', 10:32:53 INFO - 'MAIL': '/var/mail/cltbld', 10:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:53 INFO - 'MOZ_NO_REMOTE': '1', 10:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:53 INFO - 'NO_EM_RESTART': '1', 10:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:53 INFO - 'PWD': '/builds/slave/test', 10:32:53 INFO - 'SHELL': '/bin/bash', 10:32:53 INFO - 'SHLVL': '1', 10:32:53 INFO - 'TERM': 'linux', 10:32:53 INFO - 'TMOUT': '86400', 10:32:53 INFO - 'USER': 'cltbld', 10:32:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:53 INFO - '_': '/tools/buildbot/bin/python'} 10:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:32:56 INFO - Installing collected packages: mozsystemmonitor 10:32:56 INFO - Running setup.py install for mozsystemmonitor 10:32:56 INFO - Successfully installed mozsystemmonitor 10:32:56 INFO - Cleaning up... 10:32:56 INFO - Return code: 0 10:32:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:32:56 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')]} 10:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:56 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')]} 10:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:56 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:32:56 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 10:32:56 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 10:32:56 INFO - Using env: {'DISPLAY': ':0', 10:32:56 INFO - 'HOME': '/home/cltbld', 10:32:56 INFO - 'LANG': 'en_US.UTF-8', 10:32:56 INFO - 'LANGUAGE': 'en_US:en', 10:32:56 INFO - 'LOGNAME': 'cltbld', 10:32:56 INFO - 'MAIL': '/var/mail/cltbld', 10:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:56 INFO - 'MOZ_NO_REMOTE': '1', 10:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:56 INFO - 'NO_EM_RESTART': '1', 10:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:56 INFO - 'PWD': '/builds/slave/test', 10:32:56 INFO - 'SHELL': '/bin/bash', 10:32:56 INFO - 'SHLVL': '1', 10:32:56 INFO - 'TERM': 'linux', 10:32:56 INFO - 'TMOUT': '86400', 10:32:56 INFO - 'USER': 'cltbld', 10:32:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:56 INFO - '_': '/tools/buildbot/bin/python'} 10:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:56 INFO - Downloading/unpacking jsonschema==2.5.1 10:32:56 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 10:32:56 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 10:32:56 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 10:32:56 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 10:32:56 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 10:32:56 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 10:32:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:32:58 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 10:32:58 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 10:32:58 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 10:32:58 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 10:32:58 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 10:32:58 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 10:32:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:58 INFO - warning: no files found matching '*.txt' 10:32:58 INFO - no previously-included directories found matching 'build' 10:32:58 INFO - no previously-included directories found matching 'dist' 10:32:58 INFO - no previously-included directories found matching '.git*' 10:32:58 INFO - Installing collected packages: jsonschema, functools32 10:32:58 INFO - Running setup.py install for functools32 10:32:58 INFO - warning: no files found matching '*.txt' 10:32:58 INFO - no previously-included directories found matching 'build' 10:32:58 INFO - no previously-included directories found matching 'dist' 10:32:58 INFO - no previously-included directories found matching '.git*' 10:32:58 INFO - Successfully installed jsonschema functools32 10:32:58 INFO - Cleaning up... 10:32:58 INFO - Return code: 0 10:32:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:32:58 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')]} 10:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:58 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')]} 10:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:58 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:32:58 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 10:32:58 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 10:32:58 INFO - Using env: {'DISPLAY': ':0', 10:32:58 INFO - 'HOME': '/home/cltbld', 10:32:58 INFO - 'LANG': 'en_US.UTF-8', 10:32:58 INFO - 'LANGUAGE': 'en_US:en', 10:32:58 INFO - 'LOGNAME': 'cltbld', 10:32:58 INFO - 'MAIL': '/var/mail/cltbld', 10:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:58 INFO - 'MOZ_NO_REMOTE': '1', 10:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:58 INFO - 'NO_EM_RESTART': '1', 10:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:58 INFO - 'PWD': '/builds/slave/test', 10:32:58 INFO - 'SHELL': '/bin/bash', 10:32:58 INFO - 'SHLVL': '1', 10:32:58 INFO - 'TERM': 'linux', 10:32:58 INFO - 'TMOUT': '86400', 10:32:58 INFO - 'USER': 'cltbld', 10:32:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:58 INFO - '_': '/tools/buildbot/bin/python'} 10:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:32:59 INFO - Cleaning up... 10:32:59 INFO - Return code: 0 10:32:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:32:59 INFO - Using env: {'DISPLAY': ':0', 10:32:59 INFO - 'HOME': '/home/cltbld', 10:32:59 INFO - 'LANG': 'en_US.UTF-8', 10:32:59 INFO - 'LANGUAGE': 'en_US:en', 10:32:59 INFO - 'LOGNAME': 'cltbld', 10:32:59 INFO - 'MAIL': '/var/mail/cltbld', 10:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:59 INFO - 'MOZ_NO_REMOTE': '1', 10:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:59 INFO - 'NO_EM_RESTART': '1', 10:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:59 INFO - 'PWD': '/builds/slave/test', 10:32:59 INFO - 'SHELL': '/bin/bash', 10:32:59 INFO - 'SHLVL': '1', 10:32:59 INFO - 'TERM': 'linux', 10:32:59 INFO - 'TMOUT': '86400', 10:32:59 INFO - 'USER': 'cltbld', 10:32:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:59 INFO - '_': '/tools/buildbot/bin/python'} 10:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:59 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 10:32:59 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 10:32:59 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 10:32:59 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 10:32:59 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 10:32:59 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 10:33:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:33:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:33:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 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 10:33:01 INFO - Downloading docopt-0.6.1.tar.gz 10:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:33:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:33:02 INFO - Running setup.py install for blobuploader 10:33:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:33:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:33:02 INFO - Running setup.py install for requests 10:33:02 INFO - Running setup.py install for docopt 10:33:02 INFO - Successfully installed blobuploader requests docopt 10:33:02 INFO - Cleaning up... 10:33:02 INFO - Return code: 0 10:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:02 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:33:02 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 10:33:02 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 10:33:02 INFO - Using env: {'DISPLAY': ':0', 10:33:02 INFO - 'HOME': '/home/cltbld', 10:33:02 INFO - 'LANG': 'en_US.UTF-8', 10:33:02 INFO - 'LANGUAGE': 'en_US:en', 10:33:02 INFO - 'LOGNAME': 'cltbld', 10:33:02 INFO - 'MAIL': '/var/mail/cltbld', 10:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:02 INFO - 'MOZ_NO_REMOTE': '1', 10:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:02 INFO - 'NO_EM_RESTART': '1', 10:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:02 INFO - 'PWD': '/builds/slave/test', 10:33:02 INFO - 'SHELL': '/bin/bash', 10:33:02 INFO - 'SHLVL': '1', 10:33:02 INFO - 'TERM': 'linux', 10:33:02 INFO - 'TMOUT': '86400', 10:33:02 INFO - 'USER': 'cltbld', 10:33:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:02 INFO - '_': '/tools/buildbot/bin/python'} 10:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:02 INFO - Running setup.py (path:/tmp/pip-_wOq0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:02 INFO - Running setup.py (path:/tmp/pip-NaYSy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:03 INFO - Running setup.py (path:/tmp/pip-oICpD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:03 INFO - Running setup.py (path:/tmp/pip-36PjSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:03 INFO - Running setup.py (path:/tmp/pip-5yx0Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:03 INFO - Running setup.py (path:/tmp/pip-Xfk1mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:03 INFO - Running setup.py (path:/tmp/pip-KDOobz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:03 INFO - Running setup.py (path:/tmp/pip-0SFfjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:03 INFO - Running setup.py (path:/tmp/pip-8LoBWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:03 INFO - Running setup.py (path:/tmp/pip-dtR1Yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:03 INFO - Running setup.py (path:/tmp/pip-wAp9Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:03 INFO - Running setup.py (path:/tmp/pip-CM_11F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:03 INFO - Running setup.py (path:/tmp/pip-pWTgSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:03 INFO - Running setup.py (path:/tmp/pip-cow_pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:03 INFO - Running setup.py (path:/tmp/pip-PlXZa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:04 INFO - Running setup.py (path:/tmp/pip-3fbrwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:04 INFO - Running setup.py (path:/tmp/pip-go7qZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:33:04 INFO - Running setup.py install for manifestparser 10:33:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Running setup.py install for mozcrash 10:33:04 INFO - Running setup.py install for mozdebug 10:33:04 INFO - Running setup.py install for mozdevice 10:33:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Running setup.py install for mozfile 10:33:04 INFO - Running setup.py install for mozhttpd 10:33:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Running setup.py install for mozinfo 10:33:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Running setup.py install for mozInstall 10:33:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:33:04 INFO - Running setup.py install for mozleak 10:33:05 INFO - Running setup.py install for mozlog 10:33:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Running setup.py install for moznetwork 10:33:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Running setup.py install for mozprocess 10:33:05 INFO - Running setup.py install for mozprofile 10:33:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Running setup.py install for mozrunner 10:33:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Running setup.py install for mozscreenshot 10:33:05 INFO - Running setup.py install for moztest 10:33:05 INFO - Running setup.py install for mozversion 10:33:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:33:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:33:05 INFO - Cleaning up... 10:33:05 INFO - Return code: 0 10:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:05 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:33:05 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 10:33:05 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 10:33:05 INFO - Using env: {'DISPLAY': ':0', 10:33:05 INFO - 'HOME': '/home/cltbld', 10:33:05 INFO - 'LANG': 'en_US.UTF-8', 10:33:05 INFO - 'LANGUAGE': 'en_US:en', 10:33:05 INFO - 'LOGNAME': 'cltbld', 10:33:05 INFO - 'MAIL': '/var/mail/cltbld', 10:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:05 INFO - 'MOZ_NO_REMOTE': '1', 10:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:05 INFO - 'NO_EM_RESTART': '1', 10:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:05 INFO - 'PWD': '/builds/slave/test', 10:33:05 INFO - 'SHELL': '/bin/bash', 10:33:05 INFO - 'SHLVL': '1', 10:33:05 INFO - 'TERM': 'linux', 10:33:05 INFO - 'TMOUT': '86400', 10:33:05 INFO - 'USER': 'cltbld', 10:33:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:05 INFO - '_': '/tools/buildbot/bin/python'} 10:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:06 INFO - Running setup.py (path:/tmp/pip-LVu3U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:06 INFO - Running setup.py (path:/tmp/pip-gd3djY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:06 INFO - Running setup.py (path:/tmp/pip-JYWSu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:06 INFO - Running setup.py (path:/tmp/pip-9reIX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:06 INFO - Running setup.py (path:/tmp/pip-RwCART-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:06 INFO - Running setup.py (path:/tmp/pip-1W8w9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:06 INFO - Running setup.py (path:/tmp/pip-aBQlwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:06 INFO - Running setup.py (path:/tmp/pip-cpL2df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:06 INFO - Running setup.py (path:/tmp/pip-dMiUK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:06 INFO - Running setup.py (path:/tmp/pip-gpltBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:06 INFO - Running setup.py (path:/tmp/pip-p2hk0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:06 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)) 10:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:06 INFO - Running setup.py (path:/tmp/pip-bHn0lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:07 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)) 10:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:07 INFO - Running setup.py (path:/tmp/pip-ylz7pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:07 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)) 10:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:07 INFO - Running setup.py (path:/tmp/pip-DnZtbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:07 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)) 10:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:07 INFO - Running setup.py (path:/tmp/pip-xnfB6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:07 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)) 10:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:07 INFO - Running setup.py (path:/tmp/pip-Qjxjnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:07 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)) 10:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:07 INFO - Running setup.py (path:/tmp/pip-QxoL3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:07 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)) 10:33:07 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)) 10:33:07 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)) 10:33:07 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)) 10:33:07 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)) 10:33:07 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)) 10:33:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:07 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 10:33:07 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 10:33:07 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 10:33:07 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 10:33:07 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 10:33:07 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 10:33:09 INFO - Downloading blessings-1.6.tar.gz 10:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:33:09 INFO - Installing collected packages: blessings 10:33:09 INFO - Running setup.py install for blessings 10:33:09 INFO - Successfully installed blessings 10:33:09 INFO - Cleaning up... 10:33:09 INFO - Return code: 0 10:33:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:09 INFO - Reading from file tmpfile_stdout 10:33:09 INFO - Current package versions: 10:33:09 INFO - argparse == 1.2.1 10:33:09 INFO - blessings == 1.6 10:33:09 INFO - blobuploader == 1.2.4 10:33:09 INFO - docopt == 0.6.1 10:33:09 INFO - functools32 == 3.2.3-2 10:33:09 INFO - jsonschema == 2.5.1 10:33:09 INFO - manifestparser == 1.1 10:33:09 INFO - mozInstall == 1.12 10:33:09 INFO - mozcrash == 0.17 10:33:09 INFO - mozdebug == 0.1 10:33:09 INFO - mozdevice == 0.48 10:33:09 INFO - mozfile == 1.2 10:33:09 INFO - mozhttpd == 0.7 10:33:09 INFO - mozinfo == 0.9 10:33:09 INFO - mozleak == 0.1 10:33:09 INFO - mozlog == 3.4 10:33:09 INFO - moznetwork == 0.27 10:33:09 INFO - mozprocess == 0.23 10:33:09 INFO - mozprofile == 0.28 10:33:09 INFO - mozrunner == 6.12 10:33:09 INFO - mozscreenshot == 0.1 10:33:09 INFO - mozsystemmonitor == 0.3 10:33:09 INFO - moztest == 0.7 10:33:09 INFO - mozversion == 1.4 10:33:09 INFO - psutil == 3.1.1 10:33:09 INFO - requests == 1.2.3 10:33:09 INFO - wsgiref == 0.1.2 10:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:09 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 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:33:09 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 10:33:09 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 10:33:09 INFO - Using env: {'DISPLAY': ':0', 10:33:09 INFO - 'HOME': '/home/cltbld', 10:33:09 INFO - 'LANG': 'en_US.UTF-8', 10:33:09 INFO - 'LANGUAGE': 'en_US:en', 10:33:09 INFO - 'LOGNAME': 'cltbld', 10:33:09 INFO - 'MAIL': '/var/mail/cltbld', 10:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:09 INFO - 'MOZ_NO_REMOTE': '1', 10:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:09 INFO - 'NO_EM_RESTART': '1', 10:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:09 INFO - 'PWD': '/builds/slave/test', 10:33:09 INFO - 'SHELL': '/bin/bash', 10:33:09 INFO - 'SHLVL': '1', 10:33:09 INFO - 'TERM': 'linux', 10:33:09 INFO - 'TMOUT': '86400', 10:33:09 INFO - 'USER': 'cltbld', 10:33:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:09 INFO - '_': '/tools/buildbot/bin/python'} 10:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 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)) 10:33:10 INFO - Cleaning up... 10:33:10 INFO - Return code: 0 10:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa21408f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', '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 10:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:33:10 INFO - Using env: {'DISPLAY': ':0', 10:33:10 INFO - 'HOME': '/home/cltbld', 10:33:10 INFO - 'LANG': 'en_US.UTF-8', 10:33:10 INFO - 'LANGUAGE': 'en_US:en', 10:33:10 INFO - 'LOGNAME': 'cltbld', 10:33:10 INFO - 'MAIL': '/var/mail/cltbld', 10:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:10 INFO - 'MOZ_NO_REMOTE': '1', 10:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:10 INFO - 'NO_EM_RESTART': '1', 10:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:10 INFO - 'PWD': '/builds/slave/test', 10:33:10 INFO - 'SHELL': '/bin/bash', 10:33:10 INFO - 'SHLVL': '1', 10:33:10 INFO - 'TERM': 'linux', 10:33:10 INFO - 'TMOUT': '86400', 10:33:10 INFO - 'USER': 'cltbld', 10:33:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:10 INFO - '_': '/tools/buildbot/bin/python'} 10:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:33:10 INFO - Cleaning up... 10:33:10 INFO - Return code: 0 10:33:10 INFO - Running post-action listener: _resource_record_post_action 10:33:10 INFO - Running post-action listener: _start_resource_monitoring 10:33:10 INFO - Starting resource monitoring. 10:33:10 INFO - [mozharness: 2016-10-13 17:33:10.314233Z] Finished create-virtualenv step (success) 10:33:10 INFO - [mozharness: 2016-10-13 17:33:10.314736Z] Running install step. 10:33:10 INFO - Running pre-action listener: _resource_record_pre_action 10:33:10 INFO - Running main action method: install 10:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:10 INFO - Reading from file tmpfile_stdout 10:33:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:33:10 INFO - Reading from file tmpfile_stdout 10:33:10 INFO - Output received: 10:33:10 INFO - Usage: mozinstall [options] installer 10:33:10 INFO - Options: 10:33:10 INFO - -h, --help show this help message and exit 10:33:10 INFO - -d DEST, --destination=DEST 10:33:10 INFO - Directory to install application into. [default: 10:33:10 INFO - "/builds/slave/test"] 10:33:10 INFO - --app=APP Application being installed. [default: firefox] 10:33:10 INFO - mkdir: /builds/slave/test/build/application 10:33:10 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'] 10:33:10 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 10:33:26 INFO - Reading from file tmpfile_stdout 10:33:26 INFO - Output received: 10:33:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:33:26 INFO - Running post-action listener: _resource_record_post_action 10:33:26 INFO - [mozharness: 2016-10-13 17:33:26.774750Z] Finished install step (success) 10:33:26 INFO - [mozharness: 2016-10-13 17:33:26.774995Z] Running run-tests step. 10:33:26 INFO - Running pre-action listener: _resource_record_pre_action 10:33:26 INFO - Running main action method: run_tests 10:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:33:26 INFO - Python 2.7.3 10:33:26 INFO - Return code: 0 10:33:26 INFO - grabbing minidump binary from tooltool 10:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:26 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 0x273ff60>, '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 0x2740d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27411d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:33:26 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 10:33:26 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 10:33:26 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 10:33:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:33:26 INFO - Return code: 0 10:33:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:33:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:33:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:33:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:33:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 10:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 10:33:26 INFO - Using env: {'DISPLAY': ':0', 10:33:26 INFO - 'HOME': '/home/cltbld', 10:33:26 INFO - 'LANG': 'en_US.UTF-8', 10:33:26 INFO - 'LANGUAGE': 'en_US:en', 10:33:26 INFO - 'LOGNAME': 'cltbld', 10:33:26 INFO - 'MAIL': '/var/mail/cltbld', 10:33:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:33:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:26 INFO - 'MOZ_NO_REMOTE': '1', 10:33:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:26 INFO - 'NO_EM_RESTART': '1', 10:33:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:26 INFO - 'PWD': '/builds/slave/test', 10:33:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:33:26 INFO - 'SHELL': '/bin/bash', 10:33:26 INFO - 'SHLVL': '1', 10:33:26 INFO - 'TERM': 'linux', 10:33:26 INFO - 'TMOUT': '86400', 10:33:26 INFO - 'USER': 'cltbld', 10:33:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640', 10:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:26 INFO - '_': '/tools/buildbot/bin/python'} 10:33:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 10:33:27 INFO - mozversion application_buildid: 20161013093024 10:33:27 INFO - mozversion application_changeset: 83461556cda59e8bcd54f09b9263e3202ce01dc2 10:33:27 INFO - mozversion application_display_name: Nightly 10:33:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:33:27 INFO - mozversion application_name: Firefox 10:33:27 INFO - mozversion application_remotingname: firefox 10:33:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:33:27 INFO - mozversion application_vendor: Mozilla 10:33:27 INFO - mozversion application_version: 52.0a1 10:33:27 INFO - mozversion platform_buildid: 20161013093024 10:33:27 INFO - mozversion platform_changeset: 83461556cda59e8bcd54f09b9263e3202ce01dc2 10:33:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:33:27 INFO - mozversion platform_version: 52.0a1 10:33:27 INFO - using testdate: 1476380007 10:33:27 INFO - actual date: 1476380007 10:33:27 INFO - starting webserver on 'localhost:58901' 10:33:27 INFO - SUITE-START | Running 2 tests 10:33:27 INFO - TEST-START | dromaeo_css 10:33:27 INFO - operating with platform_type : linux_ 10:33:27 INFO - Initialising browser for dromaeo_css test... 10:33:27 INFO - TEST-INFO | started process 943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzIF5JO/profile http://localhost:58901/getInfo.html) 10:33:31 INFO - PROCESS | 943 | __metrics Screen width/height:1600/1200 10:33:31 INFO - PROCESS | 943 | colorDepth:24 10:33:31 INFO - PROCESS | 943 | Browser inner width/height: 1024/697 10:33:31 INFO - PROCESS | 943 | __metrics 10:33:32 INFO - PROCESS | 943 | 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" 10:33:32 INFO - PROCESS | 943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:33:32 INFO - PROCESS | 943 | console.error: PushService: 10:33:32 INFO - PROCESS | 943 | stateChangeProcessEnqueue: Error transitioning state 10:33:32 INFO - PROCESS | 943 | UnknownError 10:33:33 INFO - TEST-INFO | 943: exit 0 10:33:33 INFO - Browser initialized. 10:33:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:33 INFO - TEST-INFO | started process 1027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzIF5JO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:45 INFO - PROCESS | 1027 | RSS: Main: 176091136 10:33:45 INFO - PROCESS | 1027 | 10:34:36 INFO - PROCESS | 1027 | 1476380076529 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] 10:36:50 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:58901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58901/tests/dromaeo/cssquery-ext.html) 10:36:52 INFO - PROCESS | 1027 | RSS: Main: 394596352 10:36:52 INFO - PROCESS | 1027 | 10:39:55 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:58901/tests/dromaeo/cssquery-ext.html (next: http://localhost:58901/tests/dromaeo/cssquery-jquery.html) 10:39:56 INFO - PROCESS | 1027 | RSS: Main: 285683712 10:39:56 INFO - PROCESS | 1027 | 10:42:58 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:58901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58901/tests/dromaeo/cssquery-mootools.html) 10:42:58 INFO - PROCESS | 1027 | RSS: Main: 221835264 10:42:58 INFO - PROCESS | 1027 | 10:46:01 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:58901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58901/tests/dromaeo/cssquery-prototype.html) 10:46:01 INFO - PROCESS | 1027 | RSS: Main: 224030720 10:46:01 INFO - PROCESS | 1027 | 10:49:05 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:58901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58901/tests/dromaeo/cssquery-yui.html) 10:49:05 INFO - PROCESS | 1027 | RSS: Main: 222539776 10:49:05 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:58901/tests/dromaeo/cssquery-yui.html (next: http://localhost:58901/tests/dromaeo/cssquery-dojo.html) 10:52:08 INFO - PROCESS | 1027 | RSS: Main: 313253888 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | __start_tp_report 10:52:08 INFO - PROCESS | 1027 | _x_x_mozilla_page_load 10:52:08 INFO - PROCESS | 1027 | _x_x_mozilla_page_load_details 10:52:08 INFO - PROCESS | 1027 | |i|pagename|runs| 10:52:08 INFO - PROCESS | 1027 | |0;dojo.html;2557.4757174779165;2592;2619.908303209388;2624.6325514427976;2639.1158961747815;4548.181327361073;4607.654425918053;4771.689840160391;4804.735739534324;4808.422989241291;4630.166570017395;4705.788239529221;4734.171519984006;4788.976055119728;4831.202851529493;4303.505096913848;4332.588404101621;4362.956370436303;4368.956310436903;4372.825086996516;4349;4447.644188464931;4449.33284891678;4454.287314029756;4468.151051300259;4410.823567057314;4433.423654924855;4453.398791163184;4457.888552786174;4490.9550904491025;4199.391088292181;4243.893902652428;4250;4304.80628371724;4306.35404689296;4239.215745087138;4253.957460425387;4254.064105896698;4257.106007738379;4260.211860805761;4630.120277147331;4670.6497012724185;4680.508546602592;4686.507916668735;4717.410323709536;4993.90012199754;5019.096562618727;5050.84847454577;5058.822941197041;5114.360704911886;4919.434265059528;5069.923951140736;5070.340855688773;5087.592992560586;5147.305113809625;4622.052479241747;4648.907021859612;4671.906561868812;4706.082313948816;4708.223143181337;5095.592352611782;5122.743862806845;5133.409657889316;5142.434332223453;5196.506331898464;4841.1285968526;4958.528939750718;4971.328870602422;4972.627052971042;5036.974815125901;4956.776945037482;5036.622253331015;5040.319556859777;5041.420236672756;5068.543831055223;5070.594352451869;5074.873128171751;5089.287499750038;5114.028334616411;5134.229865520202;5008.29883816266;5025.698458092526;5027.899442011212;5030.8239211627415;5092.363454568179;4149.937750933738;4200.705950583491;4202.831886724558;4250.638695710837;4261;3735.3276410246417;3748.175401411685;3770.8303126358833;3779.9433008504893;3784.243151369737;4278.379634952915;4300.8709738707885;4304.246756817544;4308.849190278325;4309.569043095728;5069.44236134025;5077.289179514871;5086.109930762102;5086.872828179326;5088.796448142033;4277.615014648696;4280.357946308017;4316.330968699856;4376.905773556611;4388.824447022083;4518.344839998182;4528;4528.479224889114;4533.070720502289;4588.862334129982;4765.499622539653;4772;4773.618110551078;4775.2598347256235;4833.130036593447;4917.950820491749;4970.279309500174;4991.9001619966675;4998.100341938486;4999.525045120708;4684.976575117103;4685.5782979532005;4689.624830013522;4691.014886873795;4694.43666759991;4899.510048995215;4905.9018819624125;4911.4106307243355;4911.63162762787;4913.263010548446;4956.256561515802;4960.429550601727;4967.528084831935;4973.229149481692;4977.427595826382;4850.272459131159;4851.296561998561;4854.538818812207;4867.902641947212;4910.508949105061;4937.432195297443;4996.750162491933;4996.775145118406;4998.700077995332;5001.349824522788;4852.611791056777;4859.538343857469;4862.5380588844;4914.36113305268;4916.852494425173;4799.184138696361;4963.652544322007;4978.228374601942;4978.7510624467905;5038.949610503848;4682.812687492462;4719.1977363847545;4823.445303790109;4871.658983871095;4881.072596206709 10:52:08 INFO - PROCESS | 1027 | |1;ext.html;555.3585608622041;557.9637323573968;561.0350197660026;566.2610293566895;581.7033313010363;36915.261694766086;38367.80816095919;38550.80724596376;42490;42490.7875460623;39947.00132496682;40420.393694094615;40428;40434.7978260109;40469;7626.694932202705;7759.767206983771;7761.844763104763;7764.767056988299;7775.961120194391;7496.812579685524;7529.1341495727875;7531.962340188292;7532.924670753305;7625.694972201133;7595.582242976661;7608.163102058769;7608.885866712004;7610.885836712426;7633.847323053536;7497.47517673763;7508.436867234952;7530.9623451882935;7531.811704707371;7535.698572057111;7556.622168891534;7607.391408687292;7663;7663.6168191590195;7664.846703065963;36816.26367472662;37153;37192.81403592992;37221.09178536242;37241.44137837934;2950.5721670357893;3001.564773107909;3031.439183751013;3131.4676504993977;3233.7089661930304;25724.228273151835;27390.178294651192;27579;27613;28422.85788571044;3148.9055328340187;3204.6635103314284;3218.7907785993834;3250.8699652013893;3287.260366417561;242470;243822;243954;244388;244451.77774111193;50263.24605130926;50579.747101264256;50587.241191382156;50636.74681626642;50666.74666626643;32001.67998319987;53188.07465589352;53246.20130698042;53391.46608533942;53430.46569534333;12327.815082773766;12863.099583029098;12945.158564693265;12950.935245323713;13030.609081727564;10764.246502744889;10778.29941053829;10843.891561084445;10907.345559266469;10910.23628346008;17105;17262;17403;17444.772717047133;17479.21343539544;6393.1369265148605;6420.486361091102;6489.70796314167;6555.80332590023;6602.669866506655;765.3494529649864;888.9022207557164;897.2328658996595;929.8465753150655;941.026038050628;27512;28153.296167595563;28533.71466285352;28569.42861142807;28756.856215719206;890.8975467821283;909.7581800841936;914.1955079529971;959.5681943125621;973.352720440913;14036.789448158286;14986.47547335838;15059.397624094914;15293.770593441108;15302.770458443132;402919;404566;407018;407146;407525;49344;49786.75106624444;49811.50188498069;49886;49895.75052124716;1118.1948996722347;1171.344047333496;1175.2478413815165;1180.527788884453;1199.6041306368877;27462;28484.57273140946;28779.712202877705;28930.27674308159;29511.852440737657;42079;42912.78543607262;42936;42972;42997.570024299355;343886;344651;344772;345349;345568;24062;24803.62794558047;24884.626730598695;24889;24891.502169956137;38972.6102738969;39107.413388798625;39121.60878391293;40328.7983560092;41013;34415.65584344124;34505.654943450245;34565;34713.30573388569;35200.471992919614;33974.66025339715;34289.48565771466;34407.31185376328;34721.30557388889;34779.82610086934;34127;34439;34492.65507344894;34493.482597761555;34767.65232347745;29326.70673293325;31597.21006974752;31728.841355793073;31804.204894877814;31825;24152.396190095387;24482.51034979255;24515;24608.261752147464;24860.62709059402 10:52:08 INFO - PROCESS | 1027 | |2;jquery.html;349.66781557520363;364.4187520904157;366.0220994475138;367.32962343722704;369.7337916699975;12236.082293827965;12626.36868156592;12856.1643493173;13264.734705305887;17401.651966960686;14628.853711462882;14784.926075369609;16679.08265045422;16776.32894684211;16815.91592042041;4818.566329030386;4822.541858523435;4998.950010499885;5039.0425819094435;5074.746262686851;3591.4612808078737;4932.08756380069;5026.497350264963;5027.2207807789855;5060.51925067118;3702.629737026303;5585.74864131113;5832.795852145176;5838.124281357809;5955.225820643311;5612.607117501777;5780.364159942403;5923;5930.673812940287;5934.28788545373;5123.897522049539;5124.0776660201145;5125.589952803767;5126.53861152498;5129.281900533928;19413.4175974721;19950.900245498826;19997.600047999105;20073.498162546053;20099.296524621568;1804.2782886845237;1857.4149143019906;1895.649304878588;2014.29499675114;2222.14447437736;12223.716509766435;12590.81113783294;12930.806037909439;12965.416556254897;13578.117422367613;1640.4012535424604;1647.3492970276793;1653.8346165383366;1657.8425049620266;1698.4395149600603;65192.674036629985;66675;66874.33125668729;67030.66484667594;68652.656736716;9306.395084319498;9477.147056764925;9692.51537423126;9897.455639939728;9982.101610855058;13477.797833032513;13504.729905402033;13521.661958451117;13549.59351219465;13551.796723049161;6862.794116176523;6915.930840691629;7034.2965703429245;7047.788566343018;7467.365273951775;6563.409293163638;6581.676253491956;6647.700853461606;6840.213375461885;6874.175098988054;5741.7990370337675;5828.562857785599;5975.193348897843;5992.850178745566;6006.279246490449;1704.752810842421;1748.1259370314842;1756.7189249719984;1759.1731886013554;1778.6709458750172;838.6854929401475;850.8638617821119;860.7891066688701;907.4918045894188;957.9425234485954;16329.91835040841;16586.917065414596;16991.91504042472;17290.877077799923;17387.73918391225;859.4284800607651;862.0904945282662;867.2931560777946;874.2306770042322;900.2617853360182;9251.213646840093;9768.413895166314;9821.852672209923;9896.158826499684;9909.20726341891;343659;349262;350284;352096;356309;65252;66304;66366;67078.32921670818;67611.32388676149;870.2950610005789;883.650957871637;905.0903841639242;906.1980147569449;918.5085979001336;14736.26318684083;14747.483838065617;15000.624984375478;15352.155631440379;15470.767938480707;33873.49189762106;35023.47464787979;35223.647763522036;35263;35440.64559354373;43017;44161.33757993569;44927.775361122985;45231;46919.79505173581;7587.734429294948;7630.198829122862;7812.140664526783;7832.686692532235;7844.921550784419;11001.22991390595;12136.75726485483;12295.32375719344;12741.745165096832;12761.425735841724;10213.897861021593;10492.475376231005;10883.23817332779;10896.291741036806;10934.781304374028;10274.434906080238;10297.227707921786;10322.483875806029;10404.375737455777;10773.138148948223;10781.245312828027;10821.56713731442;10832.891671083189;11062.17033722458;11323.660290191307;7295.124585049616;7523.029937673284;7581.658825352762;7733.304002639789;7865.488743231672;10059;10188.388696678223;10250.692479225636;10308.072273495422;10704.571817127227 10:52:08 INFO - PROCESS | 1027 | |3;mootools.html;1184.319016565475;1356.4506374918158;1394.2819447984286;1443.9278036098192;1660.3358656537384;6381.521385896059;7344.485885987976;7550.697972081124;7671.424643151758;7931.881021784663;7812.453128281023;7875.291223789858;7882.448228623999;7888.09286932003;7895.881561776578;2145.292053622301;2156.8490205685607;2175.7280339957506;2177.520945392011;2178.085204214226;2096.2139197800825;2151.924682636108;2163.610550100981;2168.447046003267;2171.4354267890303;2076.5743022680313;2111.4826867417505;2122.936311910645;2123.957520849582;2166.9891650541726;2134.210342173398;2137.0810551462864;2143.8284937204985;2144.3138195777356;2144.613969485492;2058.3310424112074;2125.3942626351572;2127.5000374911883;2129.755078166015;2131.1688441507827;7724;7732.110807257125;7835.4123440741605;7866.370690344758;7878.409119316017;4440.977795111036;4615.399998000272;4622.815087396534;4652.953470465286;4657.091867085919;2731.153342463823;2875.3817929145125;2910.519764238898;2929.3262549613496;2935.985320073386;887.9866801997975;891.1994058670628;901.8421776189206;905.7328088213927;913.1963871792847;10540.104091152261;10577.36535807854;10638.521266543024;10702.839457408067;10722.571097156104;3919.470871432377;4081.163361510883;4211.347241177622;4248.2565551029065;4263.4031235627035;8073.919260807317;8130.552819594861;8135.145809690016;8160.102388737234;8166.570850101328;4642.396488456547;4643.024964757371;4646.674732768742;4648.209804333272;4652.13935421948;3510.7717998330027;3636.5090712753968;4085.9182816343505;4299.527052024275;4318.740875547477;3235.142687187897;3259.9674003259665;3319.817410042471;3345.481450375196;3366.3267346530793;1037.3723897042332;1042.2756184451885;1047.4291511126455;1049.3494033699003;1059.6715018344337;808.3088958940139;826.7561069484517;831.6881169561415;836.8451536879068;840.0885039731959;5316.441773613715;5671.347795003545;5683.204351390808;5688.516476099578;5857.326407463111;856.6873091321622;858.3476557816105;859.7291853066264;888.2050564744646;892.5001998880648;3623.894712112778;3704.9629503705155;3729.5524537055185;3758.492603498493;3770.9434358484646;9543.618255269712;9656.27577931658;9762.609495620238;9786.070323319273;9847.950760246153;9669.129778319844;9685.6610018649;9707.563159657833;9716.125548700651;9725.756856078655;7298.4891057625455;7430.591317477591;7446.515976461621;7447.851042979219;7452.329290363785;5134.640575159852;5242.633015688865;5415.783368665209;5504.339479262514;5723.3418156912485;8657.61040753155;8779.648814047367;8960.551972401485;8994.550272486218;9034.819303614022;8819.382643214913;9026.864597030919;9205;9244.491552964651;9266.583003764712;5723.341815691082;6588.6046837188005;6780.186377634715;6788.898166527605;6789.185297764102;6289.654069026247;6400.39196276353;6414.743410263537;6421.036844473367;7190.352868241884;6436.259830119409;6610.272869984202;6655.667216639245;6690.29751876046;6837.3162683731225;6707.798766037026;6742.561733487308;6767;6807.978803179562;6832.316768323128;6292.937070629235;6378.90431643535;6395.42441180296;6403.743850245938;6411.93588064132;4570.977145114253;4657.417822772153;4695.295705644181;4763.16644587189;4851.369321988119;4519.525449827721;4675.438947326343;4752.97623511894;4806.591439727662;4981.526754958273 10:52:08 INFO - PROCESS | 1027 | |4;prototype.html;300.81950829502296;302.8410084705528;306.7561288775423;309.72434533265397;316.1779373628565;4561.407017087774;4747.311639812229;4756.072565849652;4766.833160839371;4839.443464001636;4593.1961906666365;4649.930515981327;4714.9057018859685;4731.935314554232;4754.9049019019685;3782.56500502443;3790.355639541278;3790.848366065368;3801.182745709672;3802.790846503441;3609.747317687763;3792.7294356390644;3804.5054142961376;3805.82873770681;3806.7715937043727;3488.7034602058857;3746.925061498768;3767.60440153784;3770.4532842737785;3780.432935059749;3731.8134093295225;3736.6823819975334;3748.737588368815;3752.3058234226755;3755.267722794056;3324.517944897976;3337.666233376667;3343.548620936191;3346;3362.1258472797003;4490.820367185309;4610.608098311614;4611.169989401907;4674.626029917598;4680.204365257914;4219.662427005832;4229.97885010576;4253.149370125987;4266.637335826458;4284.271673815459;4983.72589507577;4983.75730921087;5006.924896126561;5016.473270306602;5026.974865125688;3448.9655103449145;3627.7279204059537;3632.673059424638;3635;3644.2347107107275;5128.282040514331;5153.5361817436615;5172.741362931876;5179.171332586768;5197.168453047494;3732.346839303111;3746.3631182699005;3750.887473375803;3753.230587729509;3757.1546402059316;3782.8108594570713;3793.108619474421;3799.430085487144;3809.238152369537;3809.561900381492;4136.420901073852;4207.558206388347;4258.787060646955;4271.67962402821;4282.207791558571;4974.676646017997;4978.651494395358;4979.726115063706;4994.225894986283;4997.426839809554;1245.6761242076943;1274.4838340472124;1303.589369348652;1319.4722111155615;1324.1922427319328;884.8097659003216;922.377395258198;924.4176169013613;924.5654542365078;927.9907200927904;4359.346098085312;4375.234333991539;4396.3845061690745;4396.428089567575;4404.801783919731;5099.413567439792;5106.974465127651;5111.642185047085;5121.590272778169;5131.281620573122;4267.231898258343;4378.10248898975;4388.232059389594;4418.608138436446;4429.449692607626;2724.3189202699327;2737.86310684465;2738.835669859815;2740.5204089284694;2742.890284388642;4846.418429788448;4847.5394837490385;4848.345473361122;4860.659753817199;4876.244182151772;4994.325766021613;5204.4535323791215;5221.373435187726;5249.238860365225;5258.553022993088;4769.66612337133;4777.928331074967;4796.880077998078;4820.855374338776;4827.710337379839;5107.642465027412;5108.489151084862;5122.410922743932;5136.460671629425;5149.768260428365;4876.829310974099;5106.183010718267;5143.92284115746;5146.279520867157;5151.484851514819;4926.359573255454;4926.3842019747535;4933.1613625683;4944.802207911644;4945.455999839943;3752.6622603964684;3770.547534295902;3814.9237015260096;3825.923481530298;3830.291396091732;5021.548060674557;5112.616553758408;5116.820911268088;5135.178371460548;5143.6399452039495;5008.874778130576;5019.749012549285;5029.899402011866;5032.723200223876;5034.84895453137;4855.684380515255;4995.525425084611;5000.274960130833;5003.548970798428;5006.549410553068;4735.597474214593;4871.658983871095;4876.390451193601;4916.7541622919425;4965.851024469272;4920.729359885097;5093.567046801063;5100.2349647553165;5109.9744501277255;5118.488151184852;4923.286123511999;4924.694955836634;4936.777844997056;4948.406191257072;4973.801047958041 10:52:08 INFO - PROCESS | 1027 | |5;yui.html;624.2477814233848;629.7134803664334;658.611419262635;662.7978466567698;695.822565245862;13493;13939;14208.076475029116;14230.359633816477;14262.286885655714;13252.734945301088;13410.26243556604;13620;14114.294285285747;14139.505117320896;608.382491770853;772.8261141243217;788.0818846044351;789.3763926498088;789.6920201121567;626.3798839149232;637.8277864976453;638.7221558622015;638.7860066877579;747.2900744292916;816.3673153306205;820.1429506166071;824.1305422778966;826.3348004856089;826.3926014379426;814.2102160903913;814.7148498025703;814.9633266502963;815.5066184958104;816.098211476316;476.1738383903924;485.366596591448;599.6402158704786;599.8200539838075;599.8590331272147;13080.280584567845;13340.933295333558;13357.33213339329;13815.654608634864;13977.23125228112;12057.336846473441;12778.68053298675;12895.548655797002;13049.673758156026;13536.729265414735;10729.195310351677;10757.907221272597;10810.35137891729;10811.729706757395;10930.344179349264;3222.7905186163057;3280.934381312384;3309.387763263804;3342.2647017656077;3414.4024795660907;62092.37907620956;62492.37507624956;62691.373086269006;62803.37196628021;64049;9200.90799092014;9367.578458969227;9395.812083758286;9420.811583768285;10043.246756493292;18618.255269789326;19108.23567057302;19117;19128.139233734237;19141.61716765657;6945.89581156283;6973.302669732986;7019.227884932653;7026.473014523829;7111.715531378791;3673.2837096765875;3717.126475278307;3750.6624403803244;3823.1206822430995;3851.1912498375095;2867.0825335892314;2972.910812675623;2976.583278341034;2981.5527670849547;2982.3438843454405;488.7043338780058;493.7087118600043;500.65955150497285;505.3001592793933;505.3910038403788;527.8229548107741;563.2986931270594;569.1036617327726;615.4430240632146;616.2727980982484;8021;8134.145914678992;8229.588520573947;8435.536045517432;8518.233358997595;576.3285772075569;587.1523112902389;588.5526999480426;596.6449962272441;620.3238470067648;3840.711946604016;3869.5743468218475;3987.6211759882763;4051.91896162081;4143.295639741251;56076;73025.6348718253;76063.61968190235;76425.61787191029;87157.56421217853;45950.310745338844;54967.45032549703;56166.91081990448;65546;71512;50597.49402505928;61684.38315616787;66921.33078669151;67619.66190169116;71369;8219.779123974915;8696.21734043939;8704.56477176126;8750.737477875675;8871.822563548563;39338.409923850595;40383.79808100941;40904.386434204105;42119.789401052796;42570;56989;59689.524824566666;59716.701416494376;60699.69650151721;63829.68085159545;11181.217314788211;11233.101351891992;11360.147988901032;11455.828162577402;11614.70963225926;12540.87459125397;12761.106722529334;12787.296698681661;13008.739825203633;13707.109037912503;11948.880511194777;11949.163558550817;11962.222455540363;11993.700157496132;12813.712097795371;11597.18819682614;11644.41777911118;11770.823437648613;12039.157258992136;12117;11507.658349614312;11517.94241028823;11612.88387116118;11756.698347086922;11903.76192476163;8905.287576993955;9229.953850230706;9406.43561386319;9407.43555386679;9526.333156678966;8494.490330579938;8794.340424468062;9422.811543769223;9434.433933963985;9579.856302155613 10:52:08 INFO - PROCESS | 1027 | __end_tp_report 10:52:08 INFO - PROCESS | 1027 | __start_cc_report 10:52:08 INFO - PROCESS | 1027 | _x_x_mozilla_cycle_collect,2482 10:52:08 INFO - PROCESS | 1027 | __end_cc_report 10:52:08 INFO - PROCESS | 1027 | __startTimestamp1476381128968__endTimestamp 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | ------- Summary: start ------- 10:52:08 INFO - PROCESS | 1027 | Number of tests: 6 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | [#0] dojo.html Cycles:165 Average:4652.76 Median:4788.98 stddev:490.93 (10.3%) stddev-sans-first:464.10 10:52:08 INFO - PROCESS | 1027 | Values: 2557.5 2592.0 2619.9 2624.6 2639.1 4548.2 4607.7 4771.7 4804.7 4808.4 4630.2 4705.8 4734.2 4789.0 4831.2 4303.5 4332.6 4363.0 4369.0 4372.8 4349.0 4447.6 4449.3 4454.3 4468.2 4410.8 4433.4 4453.4 4457.9 4491.0 4199.4 4243.9 4250.0 4304.8 4306.4 4239.2 4254.0 4254.1 4257.1 4260.2 4630.1 4670.6 4680.5 4686.5 4717.4 4993.9 5019.1 5050.8 5058.8 5114.4 4919.4 5069.9 5070.3 5087.6 5147.3 4622.1 4648.9 4671.9 4706.1 4708.2 5095.6 5122.7 5133.4 5142.4 5196.5 4841.1 4958.5 4971.3 4972.6 5037.0 4956.8 5036.6 5040.3 5041.4 5068.5 5070.6 5074.9 5089.3 5114.0 5134.2 5008.3 5025.7 5027.9 5030.8 5092.4 4149.9 4200.7 4202.8 4250.6 4261.0 3735.3 3748.2 3770.8 3779.9 3784.2 4278.4 4300.9 4304.2 4308.8 4309.6 5069.4 5077.3 5086.1 5086.9 5088.8 4277.6 4280.4 4316.3 4376.9 4388.8 4518.3 4528.0 4528.5 4533.1 4588.9 4765.5 4772.0 4773.6 4775.3 4833.1 4918.0 4970.3 4991.9 4998.1 4999.5 4685.0 4685.6 4689.6 4691.0 4694.4 4899.5 4905.9 4911.4 4911.6 4913.3 4956.3 4960.4 4967.5 4973.2 4977.4 4850.3 4851.3 4854.5 4867.9 4910.5 4937.4 4996.8 4996.8 4998.7 5001.3 4852.6 4859.5 4862.5 4914.4 4916.9 4799.2 4963.7 4978.2 4978.8 5038.9 4682.8 4719.2 4823.4 4871.7 4881.1 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | [#1] ext.html Cycles:180 Average:47839.46 Median:36008.37 stddev:89299.92 (248.0%) stddev-sans-first:89479.86 10:52:08 INFO - PROCESS | 1027 | Values: 555.4 558.0 561.0 566.3 581.7 36915.3 38367.8 38550.8 42490.0 42490.8 39947.0 40420.4 40428.0 40434.8 40469.0 7626.7 7759.8 7761.8 7764.8 7776.0 7496.8 7529.1 7532.0 7532.9 7625.7 7595.6 7608.2 7608.9 7610.9 7633.8 7497.5 7508.4 7531.0 7531.8 7535.7 7556.6 7607.4 7663.0 7663.6 7664.8 36816.3 37153.0 37192.8 37221.1 37241.4 2950.6 3001.6 3031.4 3131.5 3233.7 25724.2 27390.2 27579.0 27613.0 28422.9 3148.9 3204.7 3218.8 3250.9 3287.3 242470.0 243822.0 243954.0 244388.0 244451.8 50263.2 50579.7 50587.2 50636.7 50666.7 32001.7 53188.1 53246.2 53391.5 53430.5 12327.8 12863.1 12945.2 12950.9 13030.6 10764.2 10778.3 10843.9 10907.3 10910.2 17105.0 17262.0 17403.0 17444.8 17479.2 6393.1 6420.5 6489.7 6555.8 6602.7 765.3 888.9 897.2 929.8 941.0 27512.0 28153.3 28533.7 28569.4 28756.9 890.9 909.8 914.2 959.6 973.4 14036.8 14986.5 15059.4 15293.8 15302.8 402919.0 404566.0 407018.0 407146.0 407525.0 49344.0 49786.8 49811.5 49886.0 49895.8 1118.2 1171.3 1175.2 1180.5 1199.6 27462.0 28484.6 28779.7 28930.3 29511.9 42079.0 42912.8 42936.0 42972.0 42997.6 343886.0 344651.0 344772.0 345349.0 345568.0 24062.0 24803.6 24884.6 24889.0 24891.5 38972.6 39107.4 39121.6 40328.8 41013.0 34415.7 34505.7 34565.0 34713.3 35200.5 33974.7 34289.5 34407.3 34721.3 34779.8 34127.0 34439.0 34492.7 34493.5 34767.7 29326.7 31597.2 31728.8 31804.2 31825.0 24152.4 24482.5 24515.0 24608.3 24860.6 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | [#2] jquery.html Cycles:180 Average:22633.38 Median:2036.18 stddev:57732.90 (2835.4%) stddev-sans-first:57870.61 10:52:08 INFO - PROCESS | 1027 | Values: 349.7 364.4 366.0 367.3 369.7 12236.1 12626.4 12856.2 13264.7 17401.7 14628.9 14784.9 16679.1 16776.3 16815.9 4818.6 4822.5 4999.0 5039.0 5074.7 3591.5 4932.1 5026.5 5027.2 5060.5 3702.6 5585.7 5832.8 5838.1 5955.2 5612.6 5780.4 5923.0 5930.7 5934.3 5123.9 5124.1 5125.6 5126.5 5129.3 19413.4 19950.9 19997.6 20073.5 20099.3 1804.3 1857.4 1895.6 2014.3 2222.1 12223.7 12590.8 12930.8 12965.4 13578.1 1640.4 1647.3 1653.8 1657.8 1698.4 65192.7 66675.0 66874.3 67030.7 68652.7 9306.4 9477.1 9692.5 9897.5 9982.1 13477.8 13504.7 13521.7 13549.6 13551.8 6862.8 6915.9 7034.3 7047.8 7467.4 6563.4 6581.7 6647.7 6840.2 6874.2 5741.8 5828.6 5975.2 5992.9 6006.3 1704.8 1748.1 1756.7 1759.2 1778.7 838.7 850.9 860.8 907.5 957.9 16329.9 16586.9 16991.9 17290.9 17387.7 859.4 862.1 867.3 874.2 900.3 9251.2 9768.4 9821.9 9896.2 9909.2 343659.0 349262.0 350284.0 352096.0 356309.0 65252.0 66304.0 66366.0 67078.3 67611.3 870.3 883.7 905.1 906.2 918.5 14736.3 14747.5 15000.6 15352.2 15470.8 33873.5 35023.5 35223.6 35263.0 35440.6 43017.0 44161.3 44927.8 45231.0 46919.8 7587.7 7630.2 7812.1 7832.7 7844.9 11001.2 12136.8 12295.3 12741.7 12761.4 10213.9 10492.5 10883.2 10896.3 10934.8 10274.4 10297.2 10322.5 10404.4 10773.1 10781.2 10821.6 10832.9 11062.2 11323.7 7295.1 7523.0 7581.7 7733.3 7865.5 10059.0 10188.4 10250.7 10308.1 10704.6 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | [#3] mootools.html Cycles:180 Average:5084.36 Median:5677.28 stddev:2852.43 (50.2%) stddev-sans-first:2845.37 10:52:08 INFO - PROCESS | 1027 | Values: 1184.3 1356.5 1394.3 1443.9 1660.3 6381.5 7344.5 7550.7 7671.4 7931.9 7812.5 7875.3 7882.4 7888.1 7895.9 2145.3 2156.8 2175.7 2177.5 2178.1 2096.2 2151.9 2163.6 2168.4 2171.4 2076.6 2111.5 2122.9 2124.0 2167.0 2134.2 2137.1 2143.8 2144.3 2144.6 2058.3 2125.4 2127.5 2129.8 2131.2 7724.0 7732.1 7835.4 7866.4 7878.4 4441.0 4615.4 4622.8 4653.0 4657.1 2731.2 2875.4 2910.5 2929.3 2936.0 888.0 891.2 901.8 905.7 913.2 10540.1 10577.4 10638.5 10702.8 10722.6 3919.5 4081.2 4211.3 4248.3 4263.4 8073.9 8130.6 8135.1 8160.1 8166.6 4642.4 4643.0 4646.7 4648.2 4652.1 3510.8 3636.5 4085.9 4299.5 4318.7 3235.1 3260.0 3319.8 3345.5 3366.3 1037.4 1042.3 1047.4 1049.3 1059.7 808.3 826.8 831.7 836.8 840.1 5316.4 5671.3 5683.2 5688.5 5857.3 856.7 858.3 859.7 888.2 892.5 3623.9 3705.0 3729.6 3758.5 3770.9 9543.6 9656.3 9762.6 9786.1 9848.0 9669.1 9685.7 9707.6 9716.1 9725.8 7298.5 7430.6 7446.5 7447.9 7452.3 5134.6 5242.6 5415.8 5504.3 5723.3 8657.6 8779.6 8960.6 8994.6 9034.8 8819.4 9026.9 9205.0 9244.5 9266.6 5723.3 6588.6 6780.2 6788.9 6789.2 6289.7 6400.4 6414.7 6421.0 7190.4 6436.3 6610.3 6655.7 6690.3 6837.3 6707.8 6742.6 6767.0 6808.0 6832.3 6292.9 6378.9 6395.4 6403.7 6411.9 4571.0 4657.4 4695.3 4763.2 4851.4 4519.5 4675.4 4753.0 4806.6 4981.5 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | [#4] prototype.html Cycles:180 Average:4168.78 Median:4741.45 stddev:1188.78 (25.1%) stddev-sans-first:1156.12 10:52:08 INFO - PROCESS | 1027 | Values: 300.8 302.8 306.8 309.7 316.2 4561.4 4747.3 4756.1 4766.8 4839.4 4593.2 4649.9 4714.9 4731.9 4754.9 3782.6 3790.4 3790.8 3801.2 3802.8 3609.7 3792.7 3804.5 3805.8 3806.8 3488.7 3746.9 3767.6 3770.5 3780.4 3731.8 3736.7 3748.7 3752.3 3755.3 3324.5 3337.7 3343.5 3346.0 3362.1 4490.8 4610.6 4611.2 4674.6 4680.2 4219.7 4230.0 4253.1 4266.6 4284.3 4983.7 4983.8 5006.9 5016.5 5027.0 3449.0 3627.7 3632.7 3635.0 3644.2 5128.3 5153.5 5172.7 5179.2 5197.2 3732.3 3746.4 3750.9 3753.2 3757.2 3782.8 3793.1 3799.4 3809.2 3809.6 4136.4 4207.6 4258.8 4271.7 4282.2 4974.7 4978.7 4979.7 4994.2 4997.4 1245.7 1274.5 1303.6 1319.5 1324.2 884.8 922.4 924.4 924.6 928.0 4359.3 4375.2 4396.4 4396.4 4404.8 5099.4 5107.0 5111.6 5121.6 5131.3 4267.2 4378.1 4388.2 4418.6 4429.4 2724.3 2737.9 2738.8 2740.5 2742.9 4846.4 4847.5 4848.3 4860.7 4876.2 4994.3 5204.5 5221.4 5249.2 5258.6 4769.7 4777.9 4796.9 4820.9 4827.7 5107.6 5108.5 5122.4 5136.5 5149.8 4876.8 5106.2 5143.9 5146.3 5151.5 4926.4 4926.4 4933.2 4944.8 4945.5 3752.7 3770.5 3814.9 3825.9 3830.3 5021.5 5112.6 5116.8 5135.2 5143.6 5008.9 5019.7 5029.9 5032.7 5034.8 4855.7 4995.5 5000.3 5003.5 5006.5 4735.6 4871.7 4876.4 4916.8 4965.9 4920.7 5093.6 5100.2 5110.0 5118.5 4923.3 4924.7 4936.8 4948.4 4973.8 10:52:08 INFO - PROCESS | 1027 | 10:52:08 INFO - PROCESS | 1027 | [#5] yui.html Cycles:180 Average:15999.50 Median:27747.64 stddev:20919.90 (75.4%) stddev-sans-first:20946.73 10:52:08 INFO - PROCESS | 1027 | Values: 624.2 629.7 658.6 662.8 695.8 13493.0 13939.0 14208.1 14230.4 14262.3 13252.7 13410.3 13620.0 14114.3 14139.5 608.4 772.8 788.1 789.4 789.7 626.4 637.8 638.7 638.8 747.3 816.4 820.1 824.1 826.3 826.4 814.2 814.7 815.0 815.5 816.1 476.2 485.4 599.6 599.8 599.9 13080.3 13340.9 13357.3 13815.7 13977.2 12057.3 12778.7 12895.5 13049.7 13536.7 10729.2 10757.9 10810.4 10811.7 10930.3 3222.8 3280.9 3309.4 3342.3 3414.4 62092.4 62492.4 62691.4 62803.4 64049.0 9200.9 9367.6 9395.8 9420.8 10043.2 18618.3 19108.2 19117.0 19128.1 19141.6 6945.9 6973.3 7019.2 7026.5 7111.7 3673.3 3717.1 3750.7 3823.1 3851.2 2867.1 2972.9 2976.6 2981.6 2982.3 488.7 493.7 500.7 505.3 505.4 527.8 563.3 569.1 615.4 616.3 8021.0 8134.1 8229.6 8435.5 8518.2 576.3 587.2 588.6 596.6 620.3 3840.7 3869.6 3987.6 4051.9 4143.3 56076.0 73025.6 76063.6 76425.6 87157.6 45950.3 54967.5 56166.9 65546.0 71512.0 50597.5 61684.4 66921.3 67619.7 71369.0 8219.8 8696.2 8704.6 8750.7 8871.8 39338.4 40383.8 40904.4 42119.8 42570.0 56989.0 59689.5 59716.7 60699.7 63829.7 11181.2 11233.1 11360.1 11455.8 11614.7 12540.9 12761.1 12787.3 13008.7 13707.1 11948.9 11949.2 11962.2 11993.7 12813.7 11597.2 11644.4 11770.8 12039.2 12117.0 11507.7 11517.9 11612.9 11756.7 11903.8 8905.3 9230.0 9406.4 9407.4 9526.3 8494.5 8794.3 9422.8 9434.4 9579.9 10:52:08 INFO - PROCESS | 1027 | -------- Summary: end -------- 10:52:08 INFO - PROCESS | 1027 | 10:52:09 INFO - TEST-INFO | 1027: exit 0 10:52:09 INFO - TEST-OK | dromaeo_css | took 1122947ms 10:52:09 INFO - TEST-START | kraken 10:52:09 INFO - operating with platform_type : linux_ 10:52:09 INFO - Initialising browser for kraken test... 10:52:10 INFO - TEST-INFO | started process 1421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxF9Q0_/profile http://localhost:58901/getInfo.html) 10:52:14 INFO - PROCESS | 1421 | __metrics Screen width/height:1600/1200 10:52:14 INFO - PROCESS | 1421 | colorDepth:24 10:52:14 INFO - PROCESS | 1421 | Browser inner width/height: 1024/697 10:52:14 INFO - PROCESS | 1421 | __metrics 10:52:15 INFO - PROCESS | 1421 | 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" 10:52:15 INFO - PROCESS | 1421 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:15 INFO - PROCESS | 1421 | console.error: PushService: 10:52:15 INFO - PROCESS | 1421 | stateChangeProcessEnqueue: Error transitioning state 10:52:15 INFO - PROCESS | 1421 | UnknownError 10:52:16 INFO - TEST-INFO | 1421: exit 0 10:52:16 INFO - Browser initialized. 10:52:16 INFO - Running cycle 1/1 for kraken test... 10:52:16 INFO - TEST-INFO | started process 1504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxF9Q0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:28 INFO - PROCESS | 1504 | RSS: Main: 176349184 10:52:28 INFO - PROCESS | 1504 | 10:52:31 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58901/tests/kraken/driver.html?testName=audio-beat-detection) 10:52:32 INFO - PROCESS | 1504 | RSS: Main: 238886912 10:52:32 INFO - PROCESS | 1504 | 10:52:35 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58901/tests/kraken/driver.html?testName=audio-dft) 10:52:35 INFO - PROCESS | 1504 | RSS: Main: 219828224 10:52:35 INFO - PROCESS | 1504 | 10:52:39 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58901/tests/kraken/driver.html?testName=audio-fft) 10:52:39 INFO - PROCESS | 1504 | RSS: Main: 301641728 10:52:39 INFO - PROCESS | 1504 | 10:52:41 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58901/tests/kraken/driver.html?testName=audio-oscillator) 10:52:42 INFO - PROCESS | 1504 | RSS: Main: 212258816 10:52:42 INFO - PROCESS | 1504 | 10:52:44 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:52:45 INFO - PROCESS | 1504 | RSS: Main: 215912448 10:52:45 INFO - PROCESS | 1504 | 10:52:48 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58901/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:49 INFO - PROCESS | 1504 | RSS: Main: 251199488 10:52:49 INFO - PROCESS | 1504 | 10:52:52 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58901/tests/kraken/driver.html?testName=imaging-desaturate) 10:52:53 INFO - PROCESS | 1504 | RSS: Main: 250494976 10:52:53 INFO - PROCESS | 1504 | 10:52:56 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58901/tests/kraken/driver.html?testName=json-parse-financial) 10:52:56 INFO - PROCESS | 1504 | RSS: Main: 250368000 10:52:56 INFO - PROCESS | 1504 | 10:52:58 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:52:59 INFO - PROCESS | 1504 | RSS: Main: 212922368 10:52:59 INFO - PROCESS | 1504 | 10:53:00 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:01 INFO - PROCESS | 1504 | RSS: Main: 220577792 10:53:01 INFO - PROCESS | 1504 | 10:53:03 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:04 INFO - PROCESS | 1504 | RSS: Main: 228679680 10:53:04 INFO - PROCESS | 1504 | 10:53:07 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:53:08 INFO - PROCESS | 1504 | RSS: Main: 237338624 10:53:08 INFO - PROCESS | 1504 | 10:53:11 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:53:11 INFO - PROCESS | 1504 | RSS: Main: 233435136 10:53:11 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | Cycle 1(1): loaded http://localhost:58901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58901/tests/kraken/driver.html?testName=ai-astar) 10:53:13 INFO - PROCESS | 1504 | RSS: Main: 284532736 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | __start_tp_report 10:53:13 INFO - PROCESS | 1504 | _x_x_mozilla_page_load 10:53:13 INFO - PROCESS | 1504 | _x_x_mozilla_page_load_details 10:53:13 INFO - PROCESS | 1504 | |i|pagename|runs| 10:53:13 INFO - PROCESS | 1504 | |0;ai-astar;110;115;114;115;114;115;116;116;115;116 10:53:13 INFO - PROCESS | 1504 | |1;audio-beat-detection;158;130;128;174;135;133;124;128;169;127 10:53:13 INFO - PROCESS | 1504 | |2;audio-dft;161;162;162;162;160;160;162;162;161;160 10:53:13 INFO - PROCESS | 1504 | |3;audio-fft;77;76;77;103;77;76;77;77;101;76 10:53:13 INFO - PROCESS | 1504 | |4;audio-oscillator;83;85;116;83;83;83;120;84;83;116 10:53:13 INFO - PROCESS | 1504 | |5;imaging-gaussian-blur;117;118;116;117;116;117;117;117;116;116 10:53:13 INFO - PROCESS | 1504 | |6;imaging-darkroom;147;147;147;147;146;146;147;146;146;146 10:53:13 INFO - PROCESS | 1504 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;95;95 10:53:13 INFO - PROCESS | 1504 | |8;json-parse-financial;67;65;65;67;66;66;67;67;66;67 10:53:13 INFO - PROCESS | 1504 | |9;json-stringify-tinderbox;65;66;66;67;67;66;67;66;67;67 10:53:13 INFO - PROCESS | 1504 | |10;stanford-crypto-aes;86;85;85;86;84;85;86;85;85;83 10:53:13 INFO - PROCESS | 1504 | |11;stanford-crypto-ccm;144;147;147;136;138;141;139;140;180;141 10:53:13 INFO - PROCESS | 1504 | |12;stanford-crypto-pbkdf2;181;178;173;172;180;183;184;176;176;181 10:53:13 INFO - PROCESS | 1504 | |13;stanford-crypto-sha256-iterative;69;70;74;72;70;72;71;70;69;69 10:53:13 INFO - PROCESS | 1504 | __end_tp_report 10:53:13 INFO - PROCESS | 1504 | __start_cc_report 10:53:13 INFO - PROCESS | 1504 | _x_x_mozilla_cycle_collect,1990 10:53:13 INFO - PROCESS | 1504 | __end_cc_report 10:53:13 INFO - PROCESS | 1504 | __startTimestamp1476381193664__endTimestamp 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | ------- Summary: start ------- 10:53:13 INFO - PROCESS | 1504 | Number of tests: 14 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.78 (1.5%) stddev-sans-first:0.78 10:53:13 INFO - PROCESS | 1504 | Values: 110.0 115.0 114.0 115.0 114.0 115.0 116.0 116.0 115.0 116.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:134.00 stddev:18.87 (14.1%) stddev-sans-first:18.93 10:53:13 INFO - PROCESS | 1504 | Values: 158.0 130.0 128.0 174.0 135.0 133.0 124.0 128.0 169.0 127.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:53:13 INFO - PROCESS | 1504 | Values: 161.0 162.0 162.0 162.0 160.0 160.0 162.0 162.0 161.0 160.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.00 stddev:10.72 (13.9%) stddev-sans-first:11.23 10:53:13 INFO - PROCESS | 1504 | Values: 77.0 76.0 77.0 103.0 77.0 76.0 77.0 77.0 101.0 76.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:16.43 (19.8%) stddev-sans-first:16.97 10:53:13 INFO - PROCESS | 1504 | Values: 83.0 85.0 116.0 83.0 83.0 83.0 120.0 84.0 83.0 116.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:53:13 INFO - PROCESS | 1504 | Values: 117.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:53:13 INFO - PROCESS | 1504 | Values: 147.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:53:13 INFO - PROCESS | 1504 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 10:53:13 INFO - PROCESS | 1504 | Values: 67.0 65.0 65.0 67.0 66.0 66.0 67.0 67.0 66.0 67.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 10:53:13 INFO - PROCESS | 1504 | Values: 65.0 66.0 66.0 67.0 67.0 66.0 67.0 66.0 67.0 67.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 10:53:13 INFO - PROCESS | 1504 | Values: 86.0 85.0 85.0 86.0 84.0 85.0 86.0 85.0 85.0 83.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:142.50 stddev:12.72 (8.9%) stddev-sans-first:13.48 10:53:13 INFO - PROCESS | 1504 | Values: 144.0 147.0 147.0 136.0 138.0 141.0 139.0 140.0 180.0 141.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:180.50 stddev:4.09 (2.3%) stddev-sans-first:4.23 10:53:13 INFO - PROCESS | 1504 | Values: 181.0 178.0 173.0 172.0 180.0 183.0 184.0 176.0 176.0 181.0 10:53:13 INFO - PROCESS | 1504 | 10:53:13 INFO - PROCESS | 1504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.65 (2.3%) stddev-sans-first:1.64 10:53:13 INFO - PROCESS | 1504 | Values: 69.0 70.0 74.0 72.0 70.0 72.0 71.0 70.0 69.0 69.0 10:53:13 INFO - PROCESS | 1504 | -------- Summary: end -------- 10:53:13 INFO - PROCESS | 1504 | 10:53:14 INFO - TEST-INFO | 1504: exit 0 10:53:15 INFO - TEST-OK | kraken | took 65051ms 10:53:15 INFO - SUITE-END | took 1187s 10:53:15 INFO - Completed test suite (00:19:48) 10:53:15 INFO - javascript benchmark 10:53:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2557.4757174779165, 2592.0, 2619.908303209388, 2624.6325514427976, 2639.1158961747815, 4548.181327361073, 4607.654425918053, 4771.689840160391, 4804.735739534324, 4808.422989241291, 4630.166570017395, 4705.788239529221, 4734.171519984006, 4788.976055119728, 4831.202851529493, 4303.505096913848, 4332.588404101621, 4362.956370436303, 4368.956310436903, 4372.825086996516, 4349.0, 4447.644188464931, 4449.33284891678, 4454.287314029756, 4468.151051300259, 4410.823567057314, 4433.423654924855, 4453.398791163184, 4457.888552786174, 4490.9550904491025, 4199.391088292181, 4243.893902652428, 4250.0, 4304.80628371724, 4306.35404689296, 4239.215745087138, 4253.957460425387, 4254.064105896698, 4257.106007738379, 4260.211860805761, 4630.120277147331, 4670.6497012724185, 4680.508546602592, 4686.507916668735, 4717.410323709536, 4993.90012199754, 5019.096562618727, 5050.84847454577, 5058.822941197041, 5114.360704911886, 4919.434265059528, 5069.923951140736, 5070.340855688773, 5087.592992560586, 5147.305113809625, 4622.052479241747, 4648.907021859612, 4671.906561868812, 4706.082313948816, 4708.223143181337, 5095.592352611782, 5122.743862806845, 5133.409657889316, 5142.434332223453, 5196.506331898464, 4841.1285968526, 4958.528939750718, 4971.328870602422, 4972.627052971042, 5036.974815125901, 4956.776945037482, 5036.622253331015, 5040.319556859777, 5041.420236672756, 5068.543831055223, 5070.594352451869, 5074.873128171751, 5089.287499750038, 5114.028334616411, 5134.229865520202, 5008.29883816266, 5025.698458092526, 5027.899442011212, 5030.8239211627415, 5092.363454568179, 4149.937750933738, 4200.705950583491, 4202.831886724558, 4250.638695710837, 4261.0, 3735.3276410246417, 3748.175401411685, 3770.8303126358833, 3779.9433008504893, 3784.243151369737, 4278.379634952915, 4300.8709738707885, 4304.246756817544, 4308.849190278325, 4309.569043095728, 5069.44236134025, 5077.289179514871, 5086.109930762102, 5086.872828179326, 5088.796448142033, 4277.615014648696, 4280.357946308017, 4316.330968699856, 4376.905773556611, 4388.824447022083, 4518.344839998182, 4528.0, 4528.479224889114, 4533.070720502289, 4588.862334129982, 4765.499622539653, 4772.0, 4773.618110551078, 4775.2598347256235, 4833.130036593447, 4917.950820491749, 4970.279309500174, 4991.9001619966675, 4998.100341938486, 4999.525045120708, 4684.976575117103, 4685.5782979532005, 4689.624830013522, 4691.014886873795, 4694.43666759991, 4899.510048995215, 4905.9018819624125, 4911.4106307243355, 4911.63162762787, 4913.263010548446, 4956.256561515802, 4960.429550601727, 4967.528084831935, 4973.229149481692, 4977.427595826382, 4850.272459131159, 4851.296561998561, 4854.538818812207, 4867.902641947212, 4910.508949105061, 4937.432195297443, 4996.750162491933, 4996.775145118406, 4998.700077995332, 5001.349824522788, 4852.611791056777, 4859.538343857469, 4862.5380588844, 4914.36113305268, 4916.852494425173, 4799.184138696361, 4963.652544322007, 4978.228374601942, 4978.7510624467905, 5038.949610503848, 4682.812687492462, 4719.1977363847545, 4823.445303790109, 4871.658983871095, 4881.072596206709], "value": 4621.0411791010965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3585608622041, 557.9637323573968, 561.0350197660026, 566.2610293566895, 581.7033313010363, 36915.261694766086, 38367.80816095919, 38550.80724596376, 42490.0, 42490.7875460623, 39947.00132496682, 40420.393694094615, 40428.0, 40434.7978260109, 40469.0, 7626.694932202705, 7759.767206983771, 7761.844763104763, 7764.767056988299, 7775.961120194391, 7496.812579685524, 7529.1341495727875, 7531.962340188292, 7532.924670753305, 7625.694972201133, 7595.582242976661, 7608.163102058769, 7608.885866712004, 7610.885836712426, 7633.847323053536, 7497.47517673763, 7508.436867234952, 7530.9623451882935, 7531.811704707371, 7535.698572057111, 7556.622168891534, 7607.391408687292, 7663.0, 7663.6168191590195, 7664.846703065963, 36816.26367472662, 37153.0, 37192.81403592992, 37221.09178536242, 37241.44137837934, 2950.5721670357893, 3001.564773107909, 3031.439183751013, 3131.4676504993977, 3233.7089661930304, 25724.228273151835, 27390.178294651192, 27579.0, 27613.0, 28422.85788571044, 3148.9055328340187, 3204.6635103314284, 3218.7907785993834, 3250.8699652013893, 3287.260366417561, 242470.0, 243822.0, 243954.0, 244388.0, 244451.77774111193, 50263.24605130926, 50579.747101264256, 50587.241191382156, 50636.74681626642, 50666.74666626643, 32001.67998319987, 53188.07465589352, 53246.20130698042, 53391.46608533942, 53430.46569534333, 12327.815082773766, 12863.099583029098, 12945.158564693265, 12950.935245323713, 13030.609081727564, 10764.246502744889, 10778.29941053829, 10843.891561084445, 10907.345559266469, 10910.23628346008, 17105.0, 17262.0, 17403.0, 17444.772717047133, 17479.21343539544, 6393.1369265148605, 6420.486361091102, 6489.70796314167, 6555.80332590023, 6602.669866506655, 765.3494529649864, 888.9022207557164, 897.2328658996595, 929.8465753150655, 941.026038050628, 27512.0, 28153.296167595563, 28533.71466285352, 28569.42861142807, 28756.856215719206, 890.8975467821283, 909.7581800841936, 914.1955079529971, 959.5681943125621, 973.352720440913, 14036.789448158286, 14986.47547335838, 15059.397624094914, 15293.770593441108, 15302.770458443132, 402919.0, 404566.0, 407018.0, 407146.0, 407525.0, 49344.0, 49786.75106624444, 49811.50188498069, 49886.0, 49895.75052124716, 1118.1948996722347, 1171.344047333496, 1175.2478413815165, 1180.527788884453, 1199.6041306368877, 27462.0, 28484.57273140946, 28779.712202877705, 28930.27674308159, 29511.852440737657, 42079.0, 42912.78543607262, 42936.0, 42972.0, 42997.570024299355, 343886.0, 344651.0, 344772.0, 345349.0, 345568.0, 24062.0, 24803.62794558047, 24884.626730598695, 24889.0, 24891.502169956137, 38972.6102738969, 39107.413388798625, 39121.60878391293, 40328.7983560092, 41013.0, 34415.65584344124, 34505.654943450245, 34565.0, 34713.30573388569, 35200.471992919614, 33974.66025339715, 34289.48565771466, 34407.31185376328, 34721.30557388889, 34779.82610086934, 34127.0, 34439.0, 34492.65507344894, 34493.482597761555, 34767.65232347745, 29326.70673293325, 31597.21006974752, 31728.841355793073, 31804.204894877814, 31825.0, 24152.396190095387, 24482.51034979255, 24515.0, 24608.261752147464, 24860.62709059402], "value": 17084.366224576628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.66781557520363, 364.4187520904157, 366.0220994475138, 367.32962343722704, 369.7337916699975, 12236.082293827965, 12626.36868156592, 12856.1643493173, 13264.734705305887, 17401.651966960686, 14628.853711462882, 14784.926075369609, 16679.08265045422, 16776.32894684211, 16815.91592042041, 4818.566329030386, 4822.541858523435, 4998.950010499885, 5039.0425819094435, 5074.746262686851, 3591.4612808078737, 4932.08756380069, 5026.497350264963, 5027.2207807789855, 5060.51925067118, 3702.629737026303, 5585.74864131113, 5832.795852145176, 5838.124281357809, 5955.225820643311, 5612.607117501777, 5780.364159942403, 5923.0, 5930.673812940287, 5934.28788545373, 5123.897522049539, 5124.0776660201145, 5125.589952803767, 5126.53861152498, 5129.281900533928, 19413.4175974721, 19950.900245498826, 19997.600047999105, 20073.498162546053, 20099.296524621568, 1804.2782886845237, 1857.4149143019906, 1895.649304878588, 2014.29499675114, 2222.14447437736, 12223.716509766435, 12590.81113783294, 12930.806037909439, 12965.416556254897, 13578.117422367613, 1640.4012535424604, 1647.3492970276793, 1653.8346165383366, 1657.8425049620266, 1698.4395149600603, 65192.674036629985, 66675.0, 66874.33125668729, 67030.66484667594, 68652.656736716, 9306.395084319498, 9477.147056764925, 9692.51537423126, 9897.455639939728, 9982.101610855058, 13477.797833032513, 13504.729905402033, 13521.661958451117, 13549.59351219465, 13551.796723049161, 6862.794116176523, 6915.930840691629, 7034.2965703429245, 7047.788566343018, 7467.365273951775, 6563.409293163638, 6581.676253491956, 6647.700853461606, 6840.213375461885, 6874.175098988054, 5741.7990370337675, 5828.562857785599, 5975.193348897843, 5992.850178745566, 6006.279246490449, 1704.752810842421, 1748.1259370314842, 1756.7189249719984, 1759.1731886013554, 1778.6709458750172, 838.6854929401475, 850.8638617821119, 860.7891066688701, 907.4918045894188, 957.9425234485954, 16329.91835040841, 16586.917065414596, 16991.91504042472, 17290.877077799923, 17387.73918391225, 859.4284800607651, 862.0904945282662, 867.2931560777946, 874.2306770042322, 900.2617853360182, 9251.213646840093, 9768.413895166314, 9821.852672209923, 9896.158826499684, 9909.20726341891, 343659.0, 349262.0, 350284.0, 352096.0, 356309.0, 65252.0, 66304.0, 66366.0, 67078.32921670818, 67611.32388676149, 870.2950610005789, 883.650957871637, 905.0903841639242, 906.1980147569449, 918.5085979001336, 14736.26318684083, 14747.483838065617, 15000.624984375478, 15352.155631440379, 15470.767938480707, 33873.49189762106, 35023.47464787979, 35223.647763522036, 35263.0, 35440.64559354373, 43017.0, 44161.33757993569, 44927.775361122985, 45231.0, 46919.79505173581, 7587.734429294948, 7630.198829122862, 7812.140664526783, 7832.686692532235, 7844.921550784419, 11001.22991390595, 12136.75726485483, 12295.32375719344, 12741.745165096832, 12761.425735841724, 10213.897861021593, 10492.475376231005, 10883.23817332779, 10896.291741036806, 10934.781304374028, 10274.434906080238, 10297.227707921786, 10322.483875806029, 10404.375737455777, 10773.138148948223, 10781.245312828027, 10821.56713731442, 10832.891671083189, 11062.17033722458, 11323.660290191307, 7295.124585049616, 7523.029937673284, 7581.658825352762, 7733.304002639789, 7865.488743231672, 10059.0, 10188.388696678223, 10250.692479225636, 10308.072273495422, 10704.571817127227], "value": 8139.22162720792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.319016565475, 1356.4506374918158, 1394.2819447984286, 1443.9278036098192, 1660.3358656537384, 6381.521385896059, 7344.485885987976, 7550.697972081124, 7671.424643151758, 7931.881021784663, 7812.453128281023, 7875.291223789858, 7882.448228623999, 7888.09286932003, 7895.881561776578, 2145.292053622301, 2156.8490205685607, 2175.7280339957506, 2177.520945392011, 2178.085204214226, 2096.2139197800825, 2151.924682636108, 2163.610550100981, 2168.447046003267, 2171.4354267890303, 2076.5743022680313, 2111.4826867417505, 2122.936311910645, 2123.957520849582, 2166.9891650541726, 2134.210342173398, 2137.0810551462864, 2143.8284937204985, 2144.3138195777356, 2144.613969485492, 2058.3310424112074, 2125.3942626351572, 2127.5000374911883, 2129.755078166015, 2131.1688441507827, 7724.0, 7732.110807257125, 7835.4123440741605, 7866.370690344758, 7878.409119316017, 4440.977795111036, 4615.399998000272, 4622.815087396534, 4652.953470465286, 4657.091867085919, 2731.153342463823, 2875.3817929145125, 2910.519764238898, 2929.3262549613496, 2935.985320073386, 887.9866801997975, 891.1994058670628, 901.8421776189206, 905.7328088213927, 913.1963871792847, 10540.104091152261, 10577.36535807854, 10638.521266543024, 10702.839457408067, 10722.571097156104, 3919.470871432377, 4081.163361510883, 4211.347241177622, 4248.2565551029065, 4263.4031235627035, 8073.919260807317, 8130.552819594861, 8135.145809690016, 8160.102388737234, 8166.570850101328, 4642.396488456547, 4643.024964757371, 4646.674732768742, 4648.209804333272, 4652.13935421948, 3510.7717998330027, 3636.5090712753968, 4085.9182816343505, 4299.527052024275, 4318.740875547477, 3235.142687187897, 3259.9674003259665, 3319.817410042471, 3345.481450375196, 3366.3267346530793, 1037.3723897042332, 1042.2756184451885, 1047.4291511126455, 1049.3494033699003, 1059.6715018344337, 808.3088958940139, 826.7561069484517, 831.6881169561415, 836.8451536879068, 840.0885039731959, 5316.441773613715, 5671.347795003545, 5683.204351390808, 5688.516476099578, 5857.326407463111, 856.6873091321622, 858.3476557816105, 859.7291853066264, 888.2050564744646, 892.5001998880648, 3623.894712112778, 3704.9629503705155, 3729.5524537055185, 3758.492603498493, 3770.9434358484646, 9543.618255269712, 9656.27577931658, 9762.609495620238, 9786.070323319273, 9847.950760246153, 9669.129778319844, 9685.6610018649, 9707.563159657833, 9716.125548700651, 9725.756856078655, 7298.4891057625455, 7430.591317477591, 7446.515976461621, 7447.851042979219, 7452.329290363785, 5134.640575159852, 5242.633015688865, 5415.783368665209, 5504.339479262514, 5723.3418156912485, 8657.61040753155, 8779.648814047367, 8960.551972401485, 8994.550272486218, 9034.819303614022, 8819.382643214913, 9026.864597030919, 9205.0, 9244.491552964651, 9266.583003764712, 5723.341815691082, 6588.6046837188005, 6780.186377634715, 6788.898166527605, 6789.185297764102, 6289.654069026247, 6400.39196276353, 6414.743410263537, 6421.036844473367, 7190.352868241884, 6436.259830119409, 6610.272869984202, 6655.667216639245, 6690.29751876046, 6837.3162683731225, 6707.798766037026, 6742.561733487308, 6767.0, 6807.978803179562, 6832.316768323128, 6292.937070629235, 6378.90431643535, 6395.42441180296, 6403.743850245938, 6411.93588064132, 4570.977145114253, 4657.417822772153, 4695.295705644181, 4763.16644587189, 4851.369321988119, 4519.525449827721, 4675.438947326343, 4752.97623511894, 4806.591439727662, 4981.526754958273], "value": 4083.2270385399356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.81950829502296, 302.8410084705528, 306.7561288775423, 309.72434533265397, 316.1779373628565, 4561.407017087774, 4747.311639812229, 4756.072565849652, 4766.833160839371, 4839.443464001636, 4593.1961906666365, 4649.930515981327, 4714.9057018859685, 4731.935314554232, 4754.9049019019685, 3782.56500502443, 3790.355639541278, 3790.848366065368, 3801.182745709672, 3802.790846503441, 3609.747317687763, 3792.7294356390644, 3804.5054142961376, 3805.82873770681, 3806.7715937043727, 3488.7034602058857, 3746.925061498768, 3767.60440153784, 3770.4532842737785, 3780.432935059749, 3731.8134093295225, 3736.6823819975334, 3748.737588368815, 3752.3058234226755, 3755.267722794056, 3324.517944897976, 3337.666233376667, 3343.548620936191, 3346.0, 3362.1258472797003, 4490.820367185309, 4610.608098311614, 4611.169989401907, 4674.626029917598, 4680.204365257914, 4219.662427005832, 4229.97885010576, 4253.149370125987, 4266.637335826458, 4284.271673815459, 4983.72589507577, 4983.75730921087, 5006.924896126561, 5016.473270306602, 5026.974865125688, 3448.9655103449145, 3627.7279204059537, 3632.673059424638, 3635.0, 3644.2347107107275, 5128.282040514331, 5153.5361817436615, 5172.741362931876, 5179.171332586768, 5197.168453047494, 3732.346839303111, 3746.3631182699005, 3750.887473375803, 3753.230587729509, 3757.1546402059316, 3782.8108594570713, 3793.108619474421, 3799.430085487144, 3809.238152369537, 3809.561900381492, 4136.420901073852, 4207.558206388347, 4258.787060646955, 4271.67962402821, 4282.207791558571, 4974.676646017997, 4978.651494395358, 4979.726115063706, 4994.225894986283, 4997.426839809554, 1245.6761242076943, 1274.4838340472124, 1303.589369348652, 1319.4722111155615, 1324.1922427319328, 884.8097659003216, 922.377395258198, 924.4176169013613, 924.5654542365078, 927.9907200927904, 4359.346098085312, 4375.234333991539, 4396.3845061690745, 4396.428089567575, 4404.801783919731, 5099.413567439792, 5106.974465127651, 5111.642185047085, 5121.590272778169, 5131.281620573122, 4267.231898258343, 4378.10248898975, 4388.232059389594, 4418.608138436446, 4429.449692607626, 2724.3189202699327, 2737.86310684465, 2738.835669859815, 2740.5204089284694, 2742.890284388642, 4846.418429788448, 4847.5394837490385, 4848.345473361122, 4860.659753817199, 4876.244182151772, 4994.325766021613, 5204.4535323791215, 5221.373435187726, 5249.238860365225, 5258.553022993088, 4769.66612337133, 4777.928331074967, 4796.880077998078, 4820.855374338776, 4827.710337379839, 5107.642465027412, 5108.489151084862, 5122.410922743932, 5136.460671629425, 5149.768260428365, 4876.829310974099, 5106.183010718267, 5143.92284115746, 5146.279520867157, 5151.484851514819, 4926.359573255454, 4926.3842019747535, 4933.1613625683, 4944.802207911644, 4945.455999839943, 3752.6622603964684, 3770.547534295902, 3814.9237015260096, 3825.923481530298, 3830.291396091732, 5021.548060674557, 5112.616553758408, 5116.820911268088, 5135.178371460548, 5143.6399452039495, 5008.874778130576, 5019.749012549285, 5029.899402011866, 5032.723200223876, 5034.84895453137, 4855.684380515255, 4995.525425084611, 5000.274960130833, 5003.548970798428, 5006.549410553068, 4735.597474214593, 4871.658983871095, 4876.390451193601, 4916.7541622919425, 4965.851024469272, 4920.729359885097, 5093.567046801063, 5100.2349647553165, 5109.9744501277255, 5118.488151184852, 4923.286123511999, 4924.694955836634, 4936.777844997056, 4948.406191257072, 4973.801047958041], "value": 3797.58245031212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.2477814233848, 629.7134803664334, 658.611419262635, 662.7978466567698, 695.822565245862, 13493.0, 13939.0, 14208.076475029116, 14230.359633816477, 14262.286885655714, 13252.734945301088, 13410.26243556604, 13620.0, 14114.294285285747, 14139.505117320896, 608.382491770853, 772.8261141243217, 788.0818846044351, 789.3763926498088, 789.6920201121567, 626.3798839149232, 637.8277864976453, 638.7221558622015, 638.7860066877579, 747.2900744292916, 816.3673153306205, 820.1429506166071, 824.1305422778966, 826.3348004856089, 826.3926014379426, 814.2102160903913, 814.7148498025703, 814.9633266502963, 815.5066184958104, 816.098211476316, 476.1738383903924, 485.366596591448, 599.6402158704786, 599.8200539838075, 599.8590331272147, 13080.280584567845, 13340.933295333558, 13357.33213339329, 13815.654608634864, 13977.23125228112, 12057.336846473441, 12778.68053298675, 12895.548655797002, 13049.673758156026, 13536.729265414735, 10729.195310351677, 10757.907221272597, 10810.35137891729, 10811.729706757395, 10930.344179349264, 3222.7905186163057, 3280.934381312384, 3309.387763263804, 3342.2647017656077, 3414.4024795660907, 62092.37907620956, 62492.37507624956, 62691.373086269006, 62803.37196628021, 64049.0, 9200.90799092014, 9367.578458969227, 9395.812083758286, 9420.811583768285, 10043.246756493292, 18618.255269789326, 19108.23567057302, 19117.0, 19128.139233734237, 19141.61716765657, 6945.89581156283, 6973.302669732986, 7019.227884932653, 7026.473014523829, 7111.715531378791, 3673.2837096765875, 3717.126475278307, 3750.6624403803244, 3823.1206822430995, 3851.1912498375095, 2867.0825335892314, 2972.910812675623, 2976.583278341034, 2981.5527670849547, 2982.3438843454405, 488.7043338780058, 493.7087118600043, 500.65955150497285, 505.3001592793933, 505.3910038403788, 527.8229548107741, 563.2986931270594, 569.1036617327726, 615.4430240632146, 616.2727980982484, 8021.0, 8134.145914678992, 8229.588520573947, 8435.536045517432, 8518.233358997595, 576.3285772075569, 587.1523112902389, 588.5526999480426, 596.6449962272441, 620.3238470067648, 3840.711946604016, 3869.5743468218475, 3987.6211759882763, 4051.91896162081, 4143.295639741251, 56076.0, 73025.6348718253, 76063.61968190235, 76425.61787191029, 87157.56421217853, 45950.310745338844, 54967.45032549703, 56166.91081990448, 65546.0, 71512.0, 50597.49402505928, 61684.38315616787, 66921.33078669151, 67619.66190169116, 71369.0, 8219.779123974915, 8696.21734043939, 8704.56477176126, 8750.737477875675, 8871.822563548563, 39338.409923850595, 40383.79808100941, 40904.386434204105, 42119.789401052796, 42570.0, 56989.0, 59689.524824566666, 59716.701416494376, 60699.69650151721, 63829.68085159545, 11181.217314788211, 11233.101351891992, 11360.147988901032, 11455.828162577402, 11614.70963225926, 12540.87459125397, 12761.106722529334, 12787.296698681661, 13008.739825203633, 13707.109037912503, 11948.880511194777, 11949.163558550817, 11962.222455540363, 11993.700157496132, 12813.712097795371, 11597.18819682614, 11644.41777911118, 11770.823437648613, 12039.157258992136, 12117.0, 11507.658349614312, 11517.94241028823, 11612.88387116118, 11756.698347086922, 11903.76192476163, 8905.287576993955, 9229.953850230706, 9406.43561386319, 9407.43555386679, 9526.333156678966, 8494.490330579938, 8794.340424468062, 9422.811543769223, 9434.433933963985, 9579.856302155613], "value": 6370.5799948239855, "unit": "score"}], "name": "dromaeo_css", "value": 6316.0185313993525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 114.0, 115.0, 114.0, 115.0, 116.0, 116.0, 115.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 128.0, 174.0, 135.0, 133.0, 124.0, 128.0, 169.0, 127.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 160.0, 160.0, 162.0, 162.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 103.0, 77.0, 76.0, 77.0, 77.0, 101.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 116.0, 83.0, 83.0, 83.0, 120.0, 84.0, 83.0, 116.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 84.0, 85.0, 86.0, 85.0, 85.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 147.0, 136.0, 138.0, 141.0, 139.0, 140.0, 180.0, 141.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 178.0, 173.0, 172.0, 180.0, 183.0, 184.0, 176.0, 176.0, 181.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 74.0, 72.0, 70.0, 72.0, 71.0, 70.0, 69.0, 69.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1562.3999999999999, "alertThreshold": 2.0}]} 10:53:15 INFO - Return code: 0 10:53:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:53:15 INFO - # TBPL SUCCESS # 10:53:15 INFO - Running post-action listener: _resource_record_post_action 10:53:15 INFO - [mozharness: 2016-10-13 17:53:15.472746Z] Finished run-tests step (success) 10:53:15 INFO - Running post-run listener: _resource_record_post_run 10:53:15 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 392286208; Read time: 0; Write time: 238664 10:53:15 INFO - TinderboxPrint: CPU usage
13.0% 10:53:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:53:15 INFO - TinderboxPrint: I/O write bytes / time
392,286,208 / 238,664 10:53:15 INFO - TinderboxPrint: CPU idle
8,361.5 (87.0%) 10:53:15 INFO - TinderboxPrint: CPU user
1,203.2 (12.5%) 10:53:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:53:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100032512; Read time: 0; Write time: 82020 10:53:15 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 292253696; Read time: 0; Write time: 156644 10:53:16 INFO - Running post-run listener: _upload_blobber_files 10:53:16 INFO - Blob upload gear active. 10:53:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:53:16 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 10:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:53:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:17 INFO - (blobuploader) - INFO - Done attempting. 10:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:21 INFO - (blobuploader) - INFO - Done attempting. 10:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:22 INFO - (blobuploader) - INFO - Done attempting. 10:53:22 INFO - (blobuploader) - INFO - Iteration through files over. 10:53:22 INFO - Return code: 0 10:53:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:53:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:53:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a539877a5fa7bd6c086ad822d8a4347d5d409da8b497d8de40ead03162e15fc4ae750372130febaac9b028efd9025eeda5e3407cbc14d93d339b05a3c5ff96d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8941e4f1f398e77e22b6ff02dec6de3b58a0ab6fb8b1e57587821f4ee90865454b6c840d63f7c00974c4158a024c54354c22b897c9b59f5f48f1fb4a1201d48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8472619c0f16637d7110539a61d05a36e4bcdba6db394f006b368c113c0d386d17b90debd88b72c6b063e4d202245210b71b3d515d880dda19b3ef582dc1a707"} 10:53:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:53:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:53:22 INFO - Contents: 10:53:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a539877a5fa7bd6c086ad822d8a4347d5d409da8b497d8de40ead03162e15fc4ae750372130febaac9b028efd9025eeda5e3407cbc14d93d339b05a3c5ff96d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8941e4f1f398e77e22b6ff02dec6de3b58a0ab6fb8b1e57587821f4ee90865454b6c840d63f7c00974c4158a024c54354c22b897c9b59f5f48f1fb4a1201d48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8472619c0f16637d7110539a61d05a36e4bcdba6db394f006b368c113c0d386d17b90debd88b72c6b063e4d202245210b71b3d515d880dda19b3ef582dc1a707"} 10:53:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:53:22 INFO - Copying logs to upload dir... 10:53:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:53:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.344400 ========= master_lag: 1.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-13 10:53:22.874285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 10:53:22.881051) ========= 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=cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a539877a5fa7bd6c086ad822d8a4347d5d409da8b497d8de40ead03162e15fc4ae750372130febaac9b028efd9025eeda5e3407cbc14d93d339b05a3c5ff96d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8941e4f1f398e77e22b6ff02dec6de3b58a0ab6fb8b1e57587821f4ee90865454b6c840d63f7c00974c4158a024c54354c22b897c9b59f5f48f1fb4a1201d48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8472619c0f16637d7110539a61d05a36e4bcdba6db394f006b368c113c0d386d17b90debd88b72c6b063e4d202245210b71b3d515d880dda19b3ef582dc1a707"} build_url:https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/BIsxe1IrQJSoXC20Cci-KQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a539877a5fa7bd6c086ad822d8a4347d5d409da8b497d8de40ead03162e15fc4ae750372130febaac9b028efd9025eeda5e3407cbc14d93d339b05a3c5ff96d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8941e4f1f398e77e22b6ff02dec6de3b58a0ab6fb8b1e57587821f4ee90865454b6c840d63f7c00974c4158a024c54354c22b897c9b59f5f48f1fb4a1201d48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8472619c0f16637d7110539a61d05a36e4bcdba6db394f006b368c113c0d386d17b90debd88b72c6b063e4d202245210b71b3d515d880dda19b3ef582dc1a707"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 10:53:22.906044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:53:22.906353) ========= 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=cbe409c6de289db6ac707de3000001d4-1476379951.45046-752007640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:53:23.364617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 10:53:23.364959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 10:53:23.365587) ========= ========= Total master_lag: 1.65 =========