builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1475308858.65 results: success (0) buildid: 20160930232855 builduid: a54fca0281bc40bcb9d1942dd2b378a4 revision: 87cd291d2db621da6b3eb1057027cc0725b6eb1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.654833) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.656873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.657215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.673093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.673471) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 01:00:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-10-01 01:00:59 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.826872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.827445) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018017 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:00:58.879865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 01:00:58.880567) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87cd291d2db621da6b3eb1057027cc0725b6eb1d --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 87cd291d2db621da6b3eb1057027cc0725b6eb1d --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=74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 01:00:59,966 truncating revision to first 12 chars 2016-10-01 01:00:59,966 Setting DEBUG logging. 2016-10-01 01:00:59,966 attempt 1/10 2016-10-01 01:00:59,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/87cd291d2db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 01:01:00,838 unpacking tar archive at: fx-team-87cd291d2db6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.253219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 01:01:00.148789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 01:01:00.149163) ========= script_repo_revision: 87cd291d2db621da6b3eb1057027cc0725b6eb1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 01:01:00.149570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 01:01:00.149866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 01:01:00.160997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-01 01:01:00.161388) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:01:01 INFO - MultiFileLogger online at 20161001 01:01:01 in /builds/slave/test 01:01:01 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 01:01:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:01:01 INFO - {'append_to_log': False, 01:01:01 INFO - 'base_work_dir': '/builds/slave/test', 01:01:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:01:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:01:01 INFO - 'branch': 'Fx-Team-Non-PGO', 01:01:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:01:01 INFO - 'config_files': ('talos/linux_config.py',), 01:01:01 INFO - 'default_actions': ('clobber', 01:01:01 INFO - 'read-buildbot-config', 01:01:01 INFO - 'download-and-extract', 01:01:01 INFO - 'populate-webroot', 01:01:01 INFO - 'create-virtualenv', 01:01:01 INFO - 'install', 01:01:01 INFO - 'run-tests'), 01:01:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:01:01 INFO - 'download_minidump_stackwalk': True, 01:01:01 INFO - 'download_symbols': 'ondemand', 01:01:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:01:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:01:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:01:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:01:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:01:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:01:01 INFO - 'installer_path': 'installer.exe', 01:01:01 INFO - 'log_level': 'info', 01:01:01 INFO - 'log_name': 'talos', 01:01:01 INFO - 'log_to_console': True, 01:01:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:01:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:01:01 INFO - 'opt_config_files': (), 01:01:01 INFO - 'pip_index': False, 01:01:01 INFO - 'sps_profile': False, 01:01:01 INFO - 'sps_profile_interval': 0, 01:01:01 INFO - 'suite': 'dromaeojs', 01:01:01 INFO - 'system_bits': '32', 01:01:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:01:01 INFO - 'title': 'talos-linux64-ix-042', 01:01:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:01:01 INFO - 'use_talos_json': True, 01:01:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:01:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:01:01 INFO - 'work_dir': 'build'} 01:01:01 INFO - [mozharness: 2016-10-01 08:01:01.340095Z] Running clobber step. 01:01:01 INFO - Running pre-action listener: _resource_record_pre_action 01:01:01 INFO - Running main action method: clobber 01:01:01 INFO - rmtree: /builds/slave/test/build 01:01:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:01:01 INFO - Running post-action listener: _resource_record_post_action 01:01:01 INFO - [mozharness: 2016-10-01 08:01:01.800415Z] Finished clobber step (success) 01:01:01 INFO - [mozharness: 2016-10-01 08:01:01.800796Z] Running read-buildbot-config step. 01:01:01 INFO - Running pre-action listener: _resource_record_pre_action 01:01:01 INFO - Running main action method: read_buildbot_config 01:01:01 INFO - Using buildbot properties: 01:01:01 INFO - { 01:01:01 INFO - "project": "", 01:01:01 INFO - "product": "firefox", 01:01:01 INFO - "script_repo_revision": "production", 01:01:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:01:01 INFO - "repository": "", 01:01:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:01:01 INFO - "buildid": "20160930232855", 01:01:01 INFO - "pgo_build": "False", 01:01:01 INFO - "basedir": "/builds/slave/test", 01:01:01 INFO - "buildnumber": 2183, 01:01:01 INFO - "slavename": "talos-linux64-ix-042", 01:01:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:01:01 INFO - "platform": "ubuntu64_hw", 01:01:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:01:01 INFO - "branch": "fx-team", 01:01:01 INFO - "repo_path": "integration/fx-team", 01:01:01 INFO - "revision": "87cd291d2db621da6b3eb1057027cc0725b6eb1d", 01:01:01 INFO - "stage_platform": "linux64", 01:01:01 INFO - "builduid": "a54fca0281bc40bcb9d1942dd2b378a4", 01:01:01 INFO - "slavebuilddir": "test" 01:01:01 INFO - } 01:01:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:01:01 INFO - Running post-action listener: _resource_record_post_action 01:01:01 INFO - [mozharness: 2016-10-01 08:01:01.803230Z] Finished read-buildbot-config step (success) 01:01:01 INFO - [mozharness: 2016-10-01 08:01:01.803318Z] Running download-and-extract step. 01:01:01 INFO - Running pre-action listener: _resource_record_pre_action 01:01:01 INFO - Running main action method: download_and_extract 01:01:01 INFO - mkdir: /builds/slave/test/build/tests 01:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:01 INFO - trying https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:01:01 INFO - Downloading https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/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 01:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/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 01:01:02 INFO - Downloaded 1361 bytes. 01:01:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:01:02 INFO - Using the following test package requirements: 01:01:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:01:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:01:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:01:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'jsshell-linux-x86_64.zip'], 01:01:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:01:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:01:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:01:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:01:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:01:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:01:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:01:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:01:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:01:02 INFO - Fetch https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:01:02 INFO - Http code: 200 01:01:02 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 01:01:02 INFO - x-amz-cf-id: GSI-Ccrn3MhS9CyrBqVrjyrlWXWlZm5G3FJ7p7tzyEfhh4qB11yTqg== 01:01:02 INFO - x-amz-version-id: PZvNXFfVuKb01VC4o38Aiz_iBCpjckEt 01:01:03 INFO - Expected file size: 20419996 01:01:03 INFO - Obtained file size: 20419996 01:01:07 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 01:01:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:01:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:01:07 INFO - Fetch https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:01:07 INFO - Http code: 200 01:01:07 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 01:01:07 INFO - x-amz-cf-id: H4N6BCHDh2SQoCzP6eSCEQSrdCm599pe3YJY-52fhO6yhjGqU9MIyA== 01:01:07 INFO - x-amz-version-id: PZvNXFfVuKb01VC4o38Aiz_iBCpjckEt 01:01:07 INFO - Expected file size: 20419996 01:01:07 INFO - Obtained file size: 20419996 01:01:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:01:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:01:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:01:12 INFO - Http code: 200 01:01:12 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 01:01:12 INFO - x-amz-cf-id: kN0wIVHeXG-d4vGSq2QhUf7ElsAANsXqpubsfZ02D_CUe-iObIsk8w== 01:01:12 INFO - x-amz-version-id: whk6fLRjvcPMQYlrptIHBPDrH1_jQuPB 01:01:13 INFO - Expected file size: 14408522 01:01:13 INFO - Obtained file size: 14408522 01:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:13 INFO - trying https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:01:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/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 01:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/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 01:01:14 INFO - Downloaded 55816757 bytes. 01:01:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:01:14 INFO - mkdir: /builds/slave/test/properties 01:01:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:01:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:01:14 INFO - Contents: 01:01:14 INFO - build_url:https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:01:15 INFO - Running post-action listener: _resource_record_post_action 01:01:15 INFO - Running post-action listener: set_extra_try_arguments 01:01:15 INFO - [mozharness: 2016-10-01 08:01:15.264825Z] Finished download-and-extract step (success) 01:01:15 INFO - [mozharness: 2016-10-01 08:01:15.265053Z] Running populate-webroot step. 01:01:15 INFO - Running pre-action listener: _resource_record_pre_action 01:01:15 INFO - Running main action method: populate_webroot 01:01:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:01:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:01:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:01:15 INFO - '--tppagecycles', 01:01:15 INFO - '7'], 01:01:15 INFO - 'tests': ['tsvgm']}}, 01:01:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:01:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:01:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:01:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:01:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:01:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:01:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['damp', 'tps']}, 01:01:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'tests': ['damp', 'tps']}, 01:01:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['dromaeo_dom']}, 01:01:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:01:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['basic_compositor_video']}, 01:01:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:01:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['a11yr', 01:01:15 INFO - 'ts_paint', 01:01:15 INFO - 'tpaint', 01:01:15 INFO - 'sessionrestore', 01:01:15 INFO - 'sessionrestore_no_auto_restore', 01:01:15 INFO - 'tabpaint']}, 01:01:15 INFO - 'other-e10s': {'tests': ['a11yr', 01:01:15 INFO - 'ts_paint', 01:01:15 INFO - 'tpaint', 01:01:15 INFO - 'sessionrestore', 01:01:15 INFO - 'sessionrestore_no_auto_restore', 01:01:15 INFO - 'tabpaint']}, 01:01:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:01:15 INFO - 'ts_paint', 01:01:15 INFO - 'tpaint', 01:01:15 INFO - 'sessionrestore', 01:01:15 INFO - 'sessionrestore_no_auto_restore', 01:01:15 INFO - 'tabpaint']}, 01:01:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:01:15 INFO - 'ts_paint', 01:01:15 INFO - 'tpaint', 01:01:15 INFO - 'sessionrestore', 01:01:15 INFO - 'sessionrestore_no_auto_restore', 01:01:15 INFO - 'tabpaint']}, 01:01:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['a11yr', 01:01:15 INFO - 'ts_paint', 01:01:15 INFO - 'tpaint', 01:01:15 INFO - 'sessionrestore', 01:01:15 INFO - 'sessionrestore_no_auto_restore', 01:01:15 INFO - 'tabpaint']}, 01:01:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['a11yr', 01:01:15 INFO - 'ts_paint', 01:01:15 INFO - 'tpaint', 01:01:15 INFO - 'sessionrestore', 01:01:15 INFO - 'sessionrestore_no_auto_restore', 01:01:15 INFO - 'tabpaint']}, 01:01:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['tsvgx', 01:01:15 INFO - 'tsvgr_opacity', 01:01:15 INFO - 'tart', 01:01:15 INFO - 'tscrollx', 01:01:15 INFO - 'cart']}, 01:01:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:01:15 INFO - 'tsvgr_opacity', 01:01:15 INFO - 'tart', 01:01:15 INFO - 'tscrollx', 01:01:15 INFO - 'cart']}, 01:01:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'talos_options': ['--disable-e10s'], 01:01:15 INFO - 'tests': ['tp5o']}, 01:01:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'tests': ['tp5o']}, 01:01:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'talos_options': ['--disable-e10s', 01:01:15 INFO - '--xperf_path', 01:01:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:01:15 INFO - 'tests': ['tp5n']}, 01:01:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:15 INFO - 'talos_options': ['--xperf_path', 01:01:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:01:15 INFO - 'tests': ['tp5n']}}, 01:01:15 INFO - 'talos.zip': {'path': '', 01:01:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:01:15 INFO - Running post-action listener: _resource_record_post_action 01:01:15 INFO - [mozharness: 2016-10-01 08:01:15.280672Z] Finished populate-webroot step (success) 01:01:15 INFO - [mozharness: 2016-10-01 08:01:15.280761Z] Running create-virtualenv step. 01:01:15 INFO - Running pre-action listener: _resource_record_pre_action 01:01:15 INFO - Running main action method: create_virtualenv 01:01:15 INFO - Creating virtualenv /builds/slave/test/build/venv 01:01:15 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 01:01:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:01:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:01:15 INFO - Using real prefix '/usr' 01:01:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:01:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:01:17 INFO - Installing pip.................done. 01:01:17 INFO - Return code: 0 01:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:01:18 INFO - Reading from file tmpfile_stdout 01:01:18 INFO - Output received: 01:01:18 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) 01:01:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:01:18 INFO - Using env: {'DISPLAY': ':0', 01:01:18 INFO - 'HOME': '/home/cltbld', 01:01:18 INFO - 'LANG': 'en_US.UTF-8', 01:01:18 INFO - 'LANGUAGE': 'en_US:en', 01:01:18 INFO - 'LOGNAME': 'cltbld', 01:01:18 INFO - 'MAIL': '/var/mail/cltbld', 01:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:18 INFO - 'MOZ_NO_REMOTE': '1', 01:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:18 INFO - 'NO_EM_RESTART': '1', 01:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:18 INFO - 'PWD': '/builds/slave/test', 01:01:18 INFO - 'SHELL': '/bin/bash', 01:01:18 INFO - 'SHLVL': '1', 01:01:18 INFO - 'TERM': 'linux', 01:01:18 INFO - 'TMOUT': '86400', 01:01:18 INFO - 'USER': 'cltbld', 01:01:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:18 INFO - '_': '/tools/buildbot/bin/python'} 01:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:18 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 01:01:18 INFO - Cleaning up... 01:01:18 INFO - Return code: 0 01:01:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:01:18 INFO - Using env: {'DISPLAY': ':0', 01:01:18 INFO - 'HOME': '/home/cltbld', 01:01:18 INFO - 'LANG': 'en_US.UTF-8', 01:01:18 INFO - 'LANGUAGE': 'en_US:en', 01:01:18 INFO - 'LOGNAME': 'cltbld', 01:01:18 INFO - 'MAIL': '/var/mail/cltbld', 01:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:18 INFO - 'MOZ_NO_REMOTE': '1', 01:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:18 INFO - 'NO_EM_RESTART': '1', 01:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:18 INFO - 'PWD': '/builds/slave/test', 01:01:18 INFO - 'SHELL': '/bin/bash', 01:01:18 INFO - 'SHLVL': '1', 01:01:18 INFO - 'TERM': 'linux', 01:01:18 INFO - 'TMOUT': '86400', 01:01:18 INFO - 'USER': 'cltbld', 01:01:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:18 INFO - '_': '/tools/buildbot/bin/python'} 01:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:18 INFO - Downloading/unpacking psutil>=3.1.1 01:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:20 INFO - Installing collected packages: psutil 01:01:20 INFO - Running setup.py install for psutil 01:01:20 INFO - building 'psutil._psutil_linux' extension 01:01:20 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 01:01:20 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 01:01:20 INFO - building 'psutil._psutil_posix' extension 01:01:20 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 01:01:20 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 01:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:20 INFO - Successfully installed psutil 01:01:20 INFO - Cleaning up... 01:01:21 INFO - Return code: 0 01:01:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:01:21 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')]} 01:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:21 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')]} 01:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:21 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:21 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 01:01:21 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 01:01:21 INFO - Using env: {'DISPLAY': ':0', 01:01:21 INFO - 'HOME': '/home/cltbld', 01:01:21 INFO - 'LANG': 'en_US.UTF-8', 01:01:21 INFO - 'LANGUAGE': 'en_US:en', 01:01:21 INFO - 'LOGNAME': 'cltbld', 01:01:21 INFO - 'MAIL': '/var/mail/cltbld', 01:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:21 INFO - 'MOZ_NO_REMOTE': '1', 01:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:21 INFO - 'NO_EM_RESTART': '1', 01:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:21 INFO - 'PWD': '/builds/slave/test', 01:01:21 INFO - 'SHELL': '/bin/bash', 01:01:21 INFO - 'SHLVL': '1', 01:01:21 INFO - 'TERM': 'linux', 01:01:21 INFO - 'TMOUT': '86400', 01:01:21 INFO - 'USER': 'cltbld', 01:01:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:21 INFO - '_': '/tools/buildbot/bin/python'} 01:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:01:23 INFO - Installing collected packages: mozsystemmonitor 01:01:23 INFO - Running setup.py install for mozsystemmonitor 01:01:23 INFO - Successfully installed mozsystemmonitor 01:01:23 INFO - Cleaning up... 01:01:23 INFO - Return code: 0 01:01:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:01:23 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')]} 01:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:23 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')]} 01:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:23 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:23 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 01:01:23 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 01:01:23 INFO - Using env: {'DISPLAY': ':0', 01:01:23 INFO - 'HOME': '/home/cltbld', 01:01:23 INFO - 'LANG': 'en_US.UTF-8', 01:01:23 INFO - 'LANGUAGE': 'en_US:en', 01:01:23 INFO - 'LOGNAME': 'cltbld', 01:01:23 INFO - 'MAIL': '/var/mail/cltbld', 01:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:23 INFO - 'MOZ_NO_REMOTE': '1', 01:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:23 INFO - 'NO_EM_RESTART': '1', 01:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:23 INFO - 'PWD': '/builds/slave/test', 01:01:23 INFO - 'SHELL': '/bin/bash', 01:01:23 INFO - 'SHLVL': '1', 01:01:23 INFO - 'TERM': 'linux', 01:01:23 INFO - 'TMOUT': '86400', 01:01:23 INFO - 'USER': 'cltbld', 01:01:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:23 INFO - '_': '/tools/buildbot/bin/python'} 01:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:23 INFO - Downloading/unpacking jsonschema==2.5.1 01:01:23 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 01:01:23 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 01:01:23 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 01:01:23 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 01:01:23 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 01:01:23 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 01:01:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:01:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:01:25 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 01:01:25 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 01:01:25 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 01:01:25 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 01:01:25 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 01:01:25 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 01:01:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:01:25 INFO - warning: no files found matching '*.txt' 01:01:25 INFO - no previously-included directories found matching 'build' 01:01:25 INFO - no previously-included directories found matching 'dist' 01:01:25 INFO - no previously-included directories found matching '.git*' 01:01:25 INFO - Installing collected packages: jsonschema, functools32 01:01:25 INFO - Running setup.py install for functools32 01:01:25 INFO - warning: no files found matching '*.txt' 01:01:25 INFO - no previously-included directories found matching 'build' 01:01:25 INFO - no previously-included directories found matching 'dist' 01:01:25 INFO - no previously-included directories found matching '.git*' 01:01:25 INFO - Successfully installed jsonschema functools32 01:01:25 INFO - Cleaning up... 01:01:25 INFO - Return code: 0 01:01:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:25 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:25 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 01:01:25 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 01:01:25 INFO - Using env: {'DISPLAY': ':0', 01:01:25 INFO - 'HOME': '/home/cltbld', 01:01:25 INFO - 'LANG': 'en_US.UTF-8', 01:01:25 INFO - 'LANGUAGE': 'en_US:en', 01:01:25 INFO - 'LOGNAME': 'cltbld', 01:01:25 INFO - 'MAIL': '/var/mail/cltbld', 01:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:25 INFO - 'MOZ_NO_REMOTE': '1', 01:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:25 INFO - 'NO_EM_RESTART': '1', 01:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:25 INFO - 'PWD': '/builds/slave/test', 01:01:25 INFO - 'SHELL': '/bin/bash', 01:01:25 INFO - 'SHLVL': '1', 01:01:25 INFO - 'TERM': 'linux', 01:01:25 INFO - 'TMOUT': '86400', 01:01:25 INFO - 'USER': 'cltbld', 01:01:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:25 INFO - '_': '/tools/buildbot/bin/python'} 01:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:01:26 INFO - Cleaning up... 01:01:26 INFO - Return code: 0 01:01:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:26 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:26 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 01:01:26 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 01:01:26 INFO - Using env: {'DISPLAY': ':0', 01:01:26 INFO - 'HOME': '/home/cltbld', 01:01:26 INFO - 'LANG': 'en_US.UTF-8', 01:01:26 INFO - 'LANGUAGE': 'en_US:en', 01:01:26 INFO - 'LOGNAME': 'cltbld', 01:01:26 INFO - 'MAIL': '/var/mail/cltbld', 01:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:26 INFO - 'MOZ_NO_REMOTE': '1', 01:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:26 INFO - 'NO_EM_RESTART': '1', 01:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:26 INFO - 'PWD': '/builds/slave/test', 01:01:26 INFO - 'SHELL': '/bin/bash', 01:01:26 INFO - 'SHLVL': '1', 01:01:26 INFO - 'TERM': 'linux', 01:01:26 INFO - 'TMOUT': '86400', 01:01:26 INFO - 'USER': 'cltbld', 01:01:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:26 INFO - '_': '/tools/buildbot/bin/python'} 01:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:28 INFO - Downloading blobuploader-1.2.4.tar.gz 01:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:01:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:01:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 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 01:01:28 INFO - Downloading docopt-0.6.1.tar.gz 01:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:01:29 INFO - Installing collected packages: blobuploader, requests, docopt 01:01:29 INFO - Running setup.py install for blobuploader 01:01:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:01:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:01:29 INFO - Running setup.py install for requests 01:01:29 INFO - Running setup.py install for docopt 01:01:29 INFO - Successfully installed blobuploader requests docopt 01:01:29 INFO - Cleaning up... 01:01:29 INFO - Return code: 0 01:01:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:29 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:29 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 01:01:29 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 01:01:29 INFO - Using env: {'DISPLAY': ':0', 01:01:29 INFO - 'HOME': '/home/cltbld', 01:01:29 INFO - 'LANG': 'en_US.UTF-8', 01:01:29 INFO - 'LANGUAGE': 'en_US:en', 01:01:29 INFO - 'LOGNAME': 'cltbld', 01:01:29 INFO - 'MAIL': '/var/mail/cltbld', 01:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:29 INFO - 'MOZ_NO_REMOTE': '1', 01:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:29 INFO - 'NO_EM_RESTART': '1', 01:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:29 INFO - 'PWD': '/builds/slave/test', 01:01:29 INFO - 'SHELL': '/bin/bash', 01:01:29 INFO - 'SHLVL': '1', 01:01:29 INFO - 'TERM': 'linux', 01:01:29 INFO - 'TMOUT': '86400', 01:01:29 INFO - 'USER': 'cltbld', 01:01:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:29 INFO - '_': '/tools/buildbot/bin/python'} 01:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:29 INFO - Running setup.py (path:/tmp/pip-mLAuLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:29 INFO - Running setup.py (path:/tmp/pip-vM9BNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:30 INFO - Running setup.py (path:/tmp/pip-Z4rMgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:30 INFO - Running setup.py (path:/tmp/pip-cjjZIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:30 INFO - Running setup.py (path:/tmp/pip-zbZYFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:30 INFO - Running setup.py (path:/tmp/pip-dogaqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:30 INFO - Running setup.py (path:/tmp/pip-0EXdhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:30 INFO - Running setup.py (path:/tmp/pip-ETjOq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:30 INFO - Running setup.py (path:/tmp/pip-IwYOJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:30 INFO - Running setup.py (path:/tmp/pip-41KIct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:30 INFO - Running setup.py (path:/tmp/pip-lLC_Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:30 INFO - Running setup.py (path:/tmp/pip-rfCZZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:30 INFO - Running setup.py (path:/tmp/pip-6Bc8cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:30 INFO - Running setup.py (path:/tmp/pip-N7nO0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:30 INFO - Running setup.py (path:/tmp/pip-3x32gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:30 INFO - Running setup.py (path:/tmp/pip-yy2ilY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:31 INFO - Running setup.py (path:/tmp/pip-NTkwdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:01:31 INFO - Running setup.py install for manifestparser 01:01:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Running setup.py install for mozcrash 01:01:31 INFO - Running setup.py install for mozdebug 01:01:31 INFO - Running setup.py install for mozdevice 01:01:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Running setup.py install for mozfile 01:01:31 INFO - Running setup.py install for mozhttpd 01:01:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Running setup.py install for mozinfo 01:01:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Running setup.py install for mozInstall 01:01:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:01:31 INFO - Running setup.py install for mozleak 01:01:31 INFO - Running setup.py install for mozlog 01:01:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Running setup.py install for moznetwork 01:01:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Running setup.py install for mozprocess 01:01:32 INFO - Running setup.py install for mozprofile 01:01:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Running setup.py install for mozrunner 01:01:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Running setup.py install for mozscreenshot 01:01:32 INFO - Running setup.py install for moztest 01:01:32 INFO - Running setup.py install for mozversion 01:01:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:01:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:01:32 INFO - Cleaning up... 01:01:32 INFO - Return code: 0 01:01:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:32 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')]} 01:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:32 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')]} 01:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:32 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:32 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 01:01:32 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 01:01:32 INFO - Using env: {'DISPLAY': ':0', 01:01:32 INFO - 'HOME': '/home/cltbld', 01:01:32 INFO - 'LANG': 'en_US.UTF-8', 01:01:32 INFO - 'LANGUAGE': 'en_US:en', 01:01:32 INFO - 'LOGNAME': 'cltbld', 01:01:32 INFO - 'MAIL': '/var/mail/cltbld', 01:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:32 INFO - 'MOZ_NO_REMOTE': '1', 01:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:32 INFO - 'NO_EM_RESTART': '1', 01:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:32 INFO - 'PWD': '/builds/slave/test', 01:01:32 INFO - 'SHELL': '/bin/bash', 01:01:32 INFO - 'SHLVL': '1', 01:01:32 INFO - 'TERM': 'linux', 01:01:32 INFO - 'TMOUT': '86400', 01:01:32 INFO - 'USER': 'cltbld', 01:01:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:32 INFO - '_': '/tools/buildbot/bin/python'} 01:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:33 INFO - Running setup.py (path:/tmp/pip-5LanhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:33 INFO - Running setup.py (path:/tmp/pip-LBVohd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:33 INFO - Running setup.py (path:/tmp/pip-Eb5vZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:33 INFO - Running setup.py (path:/tmp/pip-s6PQEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:33 INFO - Running setup.py (path:/tmp/pip-t3WFUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:33 INFO - Running setup.py (path:/tmp/pip-hYWWy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:33 INFO - Running setup.py (path:/tmp/pip-b2b0NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:33 INFO - Running setup.py (path:/tmp/pip-ZVy2x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:33 INFO - Running setup.py (path:/tmp/pip-dOpWtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:33 INFO - Running setup.py (path:/tmp/pip-tMen1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:33 INFO - Running setup.py (path:/tmp/pip-o4rvco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:33 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)) 01:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:33 INFO - Running setup.py (path:/tmp/pip-zNjH4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:34 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)) 01:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:34 INFO - Running setup.py (path:/tmp/pip-sUiKik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:34 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)) 01:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:34 INFO - Running setup.py (path:/tmp/pip-j0oO3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:34 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)) 01:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:34 INFO - Running setup.py (path:/tmp/pip-kACYTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:34 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)) 01:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:34 INFO - Running setup.py (path:/tmp/pip-twZzfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:34 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)) 01:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:34 INFO - Running setup.py (path:/tmp/pip-J1lmGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:34 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)) 01:01:34 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)) 01:01:34 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)) 01:01:34 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)) 01:01:34 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)) 01:01:34 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)) 01:01:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:36 INFO - Downloading blessings-1.6.tar.gz 01:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:01:36 INFO - Installing collected packages: blessings 01:01:36 INFO - Running setup.py install for blessings 01:01:36 INFO - Successfully installed blessings 01:01:36 INFO - Cleaning up... 01:01:36 INFO - Return code: 0 01:01:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:36 INFO - Reading from file tmpfile_stdout 01:01:36 INFO - Current package versions: 01:01:36 INFO - argparse == 1.2.1 01:01:36 INFO - blessings == 1.6 01:01:36 INFO - blobuploader == 1.2.4 01:01:36 INFO - docopt == 0.6.1 01:01:36 INFO - functools32 == 3.2.3-2 01:01:36 INFO - jsonschema == 2.5.1 01:01:36 INFO - manifestparser == 1.1 01:01:36 INFO - mozInstall == 1.12 01:01:36 INFO - mozcrash == 0.17 01:01:36 INFO - mozdebug == 0.1 01:01:36 INFO - mozdevice == 0.48 01:01:36 INFO - mozfile == 1.2 01:01:36 INFO - mozhttpd == 0.7 01:01:36 INFO - mozinfo == 0.9 01:01:36 INFO - mozleak == 0.1 01:01:36 INFO - mozlog == 3.4 01:01:36 INFO - moznetwork == 0.27 01:01:36 INFO - mozprocess == 0.23 01:01:36 INFO - mozprofile == 0.28 01:01:36 INFO - mozrunner == 6.12 01:01:36 INFO - mozscreenshot == 0.1 01:01:36 INFO - mozsystemmonitor == 0.3 01:01:36 INFO - moztest == 0.7 01:01:36 INFO - mozversion == 1.4 01:01:36 INFO - psutil == 3.1.1 01:01:36 INFO - requests == 1.2.3 01:01:36 INFO - wsgiref == 0.1.2 01:01:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:36 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 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:36 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 01:01:36 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 01:01:36 INFO - Using env: {'DISPLAY': ':0', 01:01:36 INFO - 'HOME': '/home/cltbld', 01:01:36 INFO - 'LANG': 'en_US.UTF-8', 01:01:36 INFO - 'LANGUAGE': 'en_US:en', 01:01:36 INFO - 'LOGNAME': 'cltbld', 01:01:36 INFO - 'MAIL': '/var/mail/cltbld', 01:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:36 INFO - 'MOZ_NO_REMOTE': '1', 01:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:36 INFO - 'NO_EM_RESTART': '1', 01:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:36 INFO - 'PWD': '/builds/slave/test', 01:01:36 INFO - 'SHELL': '/bin/bash', 01:01:36 INFO - 'SHLVL': '1', 01:01:36 INFO - 'TERM': 'linux', 01:01:36 INFO - 'TMOUT': '86400', 01:01:36 INFO - 'USER': 'cltbld', 01:01:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:36 INFO - '_': '/tools/buildbot/bin/python'} 01:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 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)) 01:01:36 INFO - Cleaning up... 01:01:36 INFO - Return code: 0 01:01:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e2dba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f36ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', '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 01:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:01:36 INFO - Using env: {'DISPLAY': ':0', 01:01:36 INFO - 'HOME': '/home/cltbld', 01:01:36 INFO - 'LANG': 'en_US.UTF-8', 01:01:36 INFO - 'LANGUAGE': 'en_US:en', 01:01:36 INFO - 'LOGNAME': 'cltbld', 01:01:36 INFO - 'MAIL': '/var/mail/cltbld', 01:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:36 INFO - 'MOZ_NO_REMOTE': '1', 01:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:36 INFO - 'NO_EM_RESTART': '1', 01:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:36 INFO - 'PWD': '/builds/slave/test', 01:01:36 INFO - 'SHELL': '/bin/bash', 01:01:36 INFO - 'SHLVL': '1', 01:01:36 INFO - 'TERM': 'linux', 01:01:36 INFO - 'TMOUT': '86400', 01:01:36 INFO - 'USER': 'cltbld', 01:01:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:36 INFO - '_': '/tools/buildbot/bin/python'} 01:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:01:37 INFO - Cleaning up... 01:01:37 INFO - Return code: 0 01:01:37 INFO - Running post-action listener: _resource_record_post_action 01:01:37 INFO - Running post-action listener: _start_resource_monitoring 01:01:37 INFO - Starting resource monitoring. 01:01:37 INFO - [mozharness: 2016-10-01 08:01:37.221746Z] Finished create-virtualenv step (success) 01:01:37 INFO - [mozharness: 2016-10-01 08:01:37.222252Z] Running install step. 01:01:37 INFO - Running pre-action listener: _resource_record_pre_action 01:01:37 INFO - Running main action method: install 01:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:37 INFO - Reading from file tmpfile_stdout 01:01:37 INFO - Detecting whether we're running mozinstall >=1.0... 01:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:01:37 INFO - Reading from file tmpfile_stdout 01:01:37 INFO - Output received: 01:01:37 INFO - Usage: mozinstall [options] installer 01:01:37 INFO - Options: 01:01:37 INFO - -h, --help show this help message and exit 01:01:37 INFO - -d DEST, --destination=DEST 01:01:37 INFO - Directory to install application into. [default: 01:01:37 INFO - "/builds/slave/test"] 01:01:37 INFO - --app=APP Application being installed. [default: firefox] 01:01:37 INFO - mkdir: /builds/slave/test/build/application 01:01:37 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'] 01:01:37 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 01:01:53 INFO - Reading from file tmpfile_stdout 01:01:53 INFO - Output received: 01:01:53 INFO - /builds/slave/test/build/application/firefox/firefox 01:01:53 INFO - Running post-action listener: _resource_record_post_action 01:01:53 INFO - [mozharness: 2016-10-01 08:01:53.668418Z] Finished install step (success) 01:01:53 INFO - [mozharness: 2016-10-01 08:01:53.668730Z] Running run-tests step. 01:01:53 INFO - Running pre-action listener: _resource_record_pre_action 01:01:53 INFO - Running main action method: run_tests 01:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:01:53 INFO - Python 2.7.3 01:01:53 INFO - Return code: 0 01:01:53 INFO - grabbing minidump binary from tooltool 01:01: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')]} 01:01:53 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 0x1f33f60>, '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 0x1f34d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f351d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:01:53 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 01:01:53 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 01:01:53 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 01:01:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:01:53 INFO - Return code: 0 01:01:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:01:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:01:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:01:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:01:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:01:53 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/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 01:01:53 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/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 01:01:53 INFO - Using env: {'DISPLAY': ':0', 01:01:53 INFO - 'HOME': '/home/cltbld', 01:01:53 INFO - 'LANG': 'en_US.UTF-8', 01:01:53 INFO - 'LANGUAGE': 'en_US:en', 01:01:53 INFO - 'LOGNAME': 'cltbld', 01:01:53 INFO - 'MAIL': '/var/mail/cltbld', 01:01:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:01:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:53 INFO - 'MOZ_NO_REMOTE': '1', 01:01:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:53 INFO - 'NO_EM_RESTART': '1', 01:01:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:53 INFO - 'PWD': '/builds/slave/test', 01:01:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:01:53 INFO - 'SHELL': '/bin/bash', 01:01:53 INFO - 'SHLVL': '1', 01:01:53 INFO - 'TERM': 'linux', 01:01:53 INFO - 'TMOUT': '86400', 01:01:53 INFO - 'USER': 'cltbld', 01:01:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316', 01:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:53 INFO - '_': '/tools/buildbot/bin/python'} 01:01:53 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/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 01:01:53 INFO - mozversion application_buildid: 20160930232855 01:01:53 INFO - mozversion application_changeset: 87cd291d2db621da6b3eb1057027cc0725b6eb1d 01:01:53 INFO - mozversion application_display_name: Nightly 01:01:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:01:53 INFO - mozversion application_name: Firefox 01:01:53 INFO - mozversion application_remotingname: firefox 01:01:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:01:53 INFO - mozversion application_vendor: Mozilla 01:01:53 INFO - mozversion application_version: 52.0a1 01:01:53 INFO - mozversion platform_buildid: 20160930232855 01:01:53 INFO - mozversion platform_changeset: 87cd291d2db621da6b3eb1057027cc0725b6eb1d 01:01:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:01:53 INFO - mozversion platform_version: 52.0a1 01:01:53 INFO - using testdate: 1475308913 01:01:53 INFO - actual date: 1475308913 01:01:53 INFO - starting webserver on 'localhost:44925' 01:01:53 INFO - SUITE-START | Running 2 tests 01:01:53 INFO - TEST-START | dromaeo_css 01:01:53 INFO - operating with platform_type : linux_ 01:01:53 INFO - Initialising browser for dromaeo_css test... 01:01:53 INFO - TEST-INFO | started process 19232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw33Z9M/profile http://localhost:44925/getInfo.html) 01:01:58 INFO - PROCESS | 19232 | __metrics Screen width/height:1600/1200 01:01:58 INFO - PROCESS | 19232 | colorDepth:24 01:01:58 INFO - PROCESS | 19232 | Browser inner width/height: 1024/697 01:01:58 INFO - PROCESS | 19232 | __metrics 01:01:59 INFO - PROCESS | 19232 | 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" 01:01:59 INFO - PROCESS | 19232 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:01:59 INFO - PROCESS | 19232 | console.error: PushService: 01:01:59 INFO - PROCESS | 19232 | stateChangeProcessEnqueue: Error transitioning state 01:01:59 INFO - PROCESS | 19232 | UnknownError 01:02:00 INFO - TEST-INFO | 19232: exit 0 01:02:00 INFO - Browser initialized. 01:02:00 INFO - Running cycle 1/1 for dromaeo_css test... 01:02:00 INFO - TEST-INFO | started process 19315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw33Z9M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:02:12 INFO - PROCESS | 19315 | RSS: Main: 175128576 01:02:12 INFO - PROCESS | 19315 | 01:03:03 INFO - PROCESS | 19315 | 1475308983797 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] 01:05:17 INFO - PROCESS | 19315 | Cycle 1(1): loaded http://localhost:44925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44925/tests/dromaeo/cssquery-ext.html) 01:05:19 INFO - PROCESS | 19315 | RSS: Main: 315973632 01:05:19 INFO - PROCESS | 19315 | 01:08:22 INFO - PROCESS | 19315 | Cycle 1(1): loaded http://localhost:44925/tests/dromaeo/cssquery-ext.html (next: http://localhost:44925/tests/dromaeo/cssquery-jquery.html) 01:08:22 INFO - PROCESS | 19315 | RSS: Main: 278151168 01:08:22 INFO - PROCESS | 19315 | 01:11:25 INFO - PROCESS | 19315 | Cycle 1(1): loaded http://localhost:44925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44925/tests/dromaeo/cssquery-mootools.html) 01:11:25 INFO - PROCESS | 19315 | RSS: Main: 260526080 01:11:25 INFO - PROCESS | 19315 | 01:14:28 INFO - PROCESS | 19315 | Cycle 1(1): loaded http://localhost:44925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44925/tests/dromaeo/cssquery-prototype.html) 01:14:28 INFO - PROCESS | 19315 | RSS: Main: 219914240 01:14:28 INFO - PROCESS | 19315 | 01:17:31 INFO - PROCESS | 19315 | Cycle 1(1): loaded http://localhost:44925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44925/tests/dromaeo/cssquery-yui.html) 01:17:32 INFO - PROCESS | 19315 | RSS: Main: 219385856 01:17:32 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | Cycle 1(1): loaded http://localhost:44925/tests/dromaeo/cssquery-yui.html (next: http://localhost:44925/tests/dromaeo/cssquery-dojo.html) 01:20:35 INFO - PROCESS | 19315 | RSS: Main: 312008704 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | __start_tp_report 01:20:35 INFO - PROCESS | 19315 | _x_x_mozilla_page_load 01:20:35 INFO - PROCESS | 19315 | _x_x_mozilla_page_load_details 01:20:35 INFO - PROCESS | 19315 | |i|pagename|runs| 01:20:35 INFO - PROCESS | 19315 | |0;dojo.html;2555.7955363570914;2589.5597748382775;2622.3181972687094;2626.2121363590923;2639.3929396238877;4569.520200378962;4623.14471822713;4662.696924699892;4681.227597446422;4702.24764037754;4661.184292748764;4702.0360826030665;4739.573438390544;4790.401199850019;4837.685550439219;4281.978590107045;4313.374560688699;4341.088371442001;4353.825846966118;4374.7156434831795;4370.497392799821;4408;4409.426774519308;4412.646988240949;4433.5566443355565;4350.934735978963;4361.542038085987;4419.756913369763;4422.115576884636;4465.642748580122;4213.262679031157;4258;4260.659147268242;4291.206126866539;4348.152110338485;4225.408442818008;4242.045539753562;4256.170046840836;4349.499807522144;4370.934435983463;4661.114388266218;4669.743164125972;4670.392848929618;4708.764561771932;4750.738709370983;4857.514248575114;4917.065757506062;4966.776495057731;5007.899842003176;5015.04714104319;5001.149804533238;5010.674306170087;5011.649184557083;5029.5221953914315;5059.974700126476;4686.765661716935;4707.388039554904;4709.011107667359;4709.434867815816;4717;4962.5533701967;5019.447860735316;5038.647294689336;5160.664556803796;5189.962007598496;4863.051704917507;4875.756212189376;4878.341423907798;4880.511948805091;4883.706977581356;4949.133901567211;4957.355543779286;4960.627952903546;4964.205727083649;4971.055499455092;4865.854024379274;4900.95099049005;4912.410510738734;4941.431735350408;4941.43173535048;4915.729634870117;4941.530554597308;4982.5515703586125;4984.850454486371;4993.350864387679;4166.729162604421;4191.685623578243;4195.098053918422;4241.915161696748;4246.596573325529;3655.9817200913826;3665.8350374233223;3680.3743363628246;3719.9442008369897;3769.227308401771;4298.978505107454;4323.891902702395;4351.912961740747;4358.21552120615;4404.4494438195225;5068.467810879878;5073.239014147834;5081.339425874613;5082.186850103965;5155.639105262596;4233.047564298008;4366.8034938427845;4370.150672654651;4372.366006928977;4422.933655995163;4411.933820992687;4435.489918659331;4435.822567097344;4453.732776033448;4504.729716216972;4687.62499000086;4689.507601701772;4692.343071969859;4693.272542755878;4740.644451666208;4998.6500944933505;5001.949980500149;5003.249512573143;5012.3233363495465;5067.341245638191;4634.745089020136;4666.673332866667;4666.859994200179;4672.7429991349445;4675.9011632267075;4932.975335123301;4934.383202099738;4935.975320123376;4937.308776771327;4987.800487980585;4998.725070121178;5003.749812509433;5008.524190201925;5008.9499105009945;5060;4343.9357357447625;4701.271302948048;4741.004389078194;4845.370101886732;4886.389201349832;4884.853454396374;4887.975560122177;4890.388701412324;4914.557689807934;4940.431850337257;4824.324594556695;4829.66192366531;4830.830920917751;4837.37114175155;4897.118518666674;4853.223484242504;4915.213565829593;4919.877003074808;4925.581325587365;4930.654854160174;4765.642576806823;4832.927506087482;4836.564709176191;4840.95159048405;4844.854654360375 01:20:35 INFO - PROCESS | 19315 | |1;ext.html;544.801147581133;554.282204545114;559.4154108956141;572.4018400771193;576.3487259396882;26895.865520672392;36787;37913.052173695636;37918.62081379185;41722;38072.238555228876;38419;38467.23065538688;38484.42273365895;38551.614483855155;7579.772606821791;7709.38324934004;7720.652570634335;7732.497387669811;7739.845203095934;7579.279968402993;7662.501937374052;7663.3869290456905;7668.616569171547;7671.2712292332135;7668.731594394198;7706.267904549087;7706.499077559941;7719.228077192292;7719.884201736979;7644.426667999895;7695.3843692505025;7701.383889288843;7704.460687751832;7709.6916123354995;7590.620468976529;7649.349805266559;7657.846843063163;7659.463837531375;7661.272179142972;36542.81728591367;36758.44862327067;37012.44481332782;37061.62938370609;37090;2632.670916135483;2777.125205560242;2800.649918760155;2835.5888396182645;2870.81339712918;27946;28059.57910631342;28207.85896070527;28264.717352826414;28848;3183.108729555728;3281.950770738441;3327.617324007722;3351.6480769519094;3366.2257680733323;200556;259643.70178149178;259775;260476;260854;51961.48038519567;52504;52527.47472525302;52559.47440525546;52644.473555264725;32725.67274327274;33014.66985330164;33158.17104572357;54865.72567137139;55278;12587.118901676795;12843.935780321039;12848.550300739429;12849.357532123544;12857.100002999887;10126.949365253127;10216.08055275014;10241.692749217535;10248.538815753309;10250.231232657581;17470.38853640142;17478;17502;17548.210330535156;17565.560860978323;6713.943268078326;6758.797236082925;6776.491763117786;6941.652917354112;7030.54301470413;800.9679612815422;926.416357694648;931.417863835103;970.898055704155;976.6825781621002;26747.598786018225;27243.182704518895;27359;27591.86204068967;27688;970.3547141151056;983.9262055345878;988.0761488008735;991.1377101921374;995.8456439251928;13613.455461781417;14347;14350.282485875665;14462.710745785025;14666.706665866835;334835;335927;337212;339036;339108;31641.683583164333;47709.522904771206;47741.135531868196;47787.522124779;47789;1124.1512657943201;1139.880312567185;1152.7060599547062;1165.318288801044;1170.6897672116895;25854;26505.867470662524;26529.469410612066;27003;27191.320216994733;40774.38838417367;41203.7939810311;41338.379924301764;41369.1726165481;41404.58595414007;282073;282232;282667;283661;283978;24514.38714032092;24781.876090620153;25000.874995624905;25076.62385064189;25151.87424062868;39415;39663.2067358657;39787.40318895277;40069.1986160281;40332.1933561333;33622.83188584042;34212.65787342095;34439.31121377508;34928;35012.29975400529;34184.65815341914;34592.82703586466;34647;34734;34978;33969.475145682125;33993.490097649046;34653.82673086719;34809.16793721494;34988.47517287192;29545.409091818474;31656.683433165374;31693;31723.365532688757;31953.840230798698;18422.539436514195;18819.717704234172;24445.144419945216;24463.51072978566;24934.37664058413 01:20:35 INFO - PROCESS | 19315 | |2;jquery.html;343.8607364017574;361.56250936367013;363.92721455708846;368.5246032617922;384.99615003849954;12307.138500304982;13256.668583285411;14664.193469359194;16556.172191390444;17237.741433878502;16732.498025059238;17051.57371065724;17255.827441725578;17425;17511.474655760314;4795.25673520604;5169.043726910515;5194.766235519392;5199.376074871002;5200.271961925334;3552.662497062775;3736.9252614947686;5120.61595380348;5211.296474975868;5219.243209734586;3687.7234207434417;3834.175652234769;3905.6875449964077;6058.666773327465;6147.323794382614;5896.439838215363;6123.571350005502;6126.326104128565;6131.540134489886;6132.724027418754;5394.649347792381;5400.270963419927;5417.322834645669;5423.484768946943;5423.864403389907;19954.401367958984;20458.74953755086;20467;20692.58614827695;20706.79293207064;1726.1541844496107;1825.963480730378;1930.6138772245606;1951.8828870267687;2027.3917824652544;9036.954815225947;9197.218236449842;9444.811103777954;9656.565454554562;12710.809337859939;1629.2994012574588;1642.9096399698012;1713.8200488948605;1727.6631056943902;1745.3716662001668;69345.65327173383;69848.6507567464;70598;70712.64643676749;71510.64244678796;9662.275329350327;9847.950760246153;10052.346597471142;10207.46887966796;10349.379037257788;14112.929435352962;14117.57647270563;14125.929370353288;14127.434902603985;14130.434782608581;6817.522773405814;6963.82590435233;6975.686094125776;7150.320719531636;7322.816929576803;6316.304961597425;6326.905096423558;6405.519586031066;6430.935690643128;6652.7671531497135;4176.916461670749;4205.642520385802;4245.660347172219;4272.230998420252;4544.954550454519;1737.904415257173;1814.6915024445875;1834.7064469684785;1863.1336428560514;1865.0861078071648;851.3061854588615;857.4169564696067;861.9525926074001;881.5107615273585;939.8684184214216;16661.750073748903;17013;17584.208710608054;17624.1187940605;18086.27654893816;849.6856163219525;871.7515508080166;875.8598624220094;884.4030279561399;899.9460032398077;9285.25717942563;10024.699259022242;10050.899491005142;10082.143017843418;10190.490475476197;343111;350122;352651;353714;354814;54820.72589637026;74175.3901836689;76151;78035.60982195166;80028;853.1587988599001;878.9824203515894;890.3900827932757;904.4754042655376;910.6630546697631;11534.423278836193;15775.605609859385;16005.279762410486;16706.49880503587;16997.49007529776;34509.13727156841;35193.64806351904;36173.638263617024;39245.803770980965;40890.18219635531;45025.77487112543;48926.75536622294;50221;50933.490665092875;51117.74441127919;7586.24137586237;7606.8098297543;7701.345385642283;7827.843443130992;7930;11357.602483913024;11789.410529473664;12055.51777928873;12085.15403921717;12517.56188533397;9837.163841073589;10012.799744005224;10020.749481263027;10249.74375640615;10786.946065269623;10205.540750666089;10404.375737455777;10521.947390263;10703.732406689584;10966.17753668494;10228;10368.481575921023;10502.264841461025;10640.308379955279;10949.178811589003;7443.218462061405;7580.05249343832;7710.575918324322;7775.14473407936;7827.9608601956625;9885.456299903286;9909.65316213929;10213.642522511676;10505.216117728654;10732.26327286537 01:20:35 INFO - PROCESS | 19315 | |3;mootools.html;1345.4618152738904;1386.1890793885577;1388.0699931046197;1638.664073864857;1663.1102360237276;6821.6930238139275;7058.400035996947;7447.515911465751;8062.274395304429;8067.59662016899;7461.5523068615785;7752.1860204678405;7758.146603873583;7886.723964661238;7929.286364227219;2125.5855108253895;2148.151480165334;2151.397608669567;2151.8816465094415;2154.687570302305;1741.2947756158712;1808.0507733439918;2076.0761461149796;2126.6597344424895;2151.300827231148;2108.536122053146;2139.513038438286;2141.6680414535695;2142.442964829148;2146.774588668191;2073.699313599527;2082.1255072869358;2163.599734049206;2169;2169.533550286696;2040.0819631166034;2057.845661575373;2076.8442366822396;2087.5929193807215;2111.166089394696;7848.646810893523;7994.960025199837;8000.279974802237;8004.799880002988;8006.239407256301;4350.129974005212;4468.19572476954;4479.193745125876;4482.305242687356;4484.170428470743;2785.359367345522;2901.6227890374325;2930.3846192299643;2980.7168319009875;2983.2840118371437;815.9102498725135;849.5370023337296;864.7059999600166;865.0268447996004;871.904090550039;10602;10622.09712174466;10629.5216715248;10634.308769930007;10651.84022239667;3874.5737968823405;3976.343903255988;4009.418634298069;4142;4163.646090082377;8974.506402147814;9000.50497222659;9006.369554131148;9006.59470323837;9014.053524379977;4447.221736196153;4455.242608756519;4463.375127482155;4475.411229013718;4480.977595112004;4026.1142548639255;4044.939325910114;4046.0896298333228;4047.2917239483563;4048.6558642515715;3214.1964508872784;3357.8824741133944;3481.3211423772123;3599.9640003600152;3660.6888414484533;1151.9136064795173;1157.7279339355246;1171.109956433117;1171.6075114836456;1174.8590169179754;599.4694695194784;647.6243778608396;698.1308271202386;713.6681443128866;726.6802606852967;4642.3500709900645;4692.741899195509;4751.168545504523;4853.417589889236;4992.700437973661;850.4436880508654;851.948883067018;912.5209265135724;914.9862752058724;917.7613820406742;3328.916777080544;3371.696547310754;3389.8305084746157;3411.4541673332146;3527.8588856445454;9628;9714;9809.901900981042;9822.803543929082;9830.4101753895;9679.564419600994;9688.273379496566;9700.27247956406;9718.902810971942;9734.659286924923;6884.793456196322;7034.331738484836;7202.603856787822;7216.8917466238045;7225.205227424979;4955.562886762798;4982.800687972585;5019.84940451787;5091.338126043591;5256.290400795843;8554.27288680469;8619.224269815746;8801.515916624647;8901.821963560564;8903.510306932922;9029.291212636314;9063.728088157366;9120.087991200828;9197.862032069657;9258.814823703622;6521.184851893513;6676.89984650221;6681.599104053772;6681.632510211985;6684.197896252286;6395.136656551492;6528.706208220737;7032.367086962198;7191.137063552407;7226.494145409981;6445.613263204223;6453.741850325934;6484.221893372825;6484.902726459012;6513.283538810632;6105.633661980295;6307.684615769102;6315.210598675166;6317.715702793477;6438.581492202992;5603.35561410443;5720.942790572208;5785.103308987113;5852.882942341044;5855.9121613176685;4266.424032755663;4282.293421585528;4389.582989615981;4393.956060439483;4394.318880573516;4151.294279972351;4179.770112643834;4250.936235956401;4265.701400902031;4287 01:20:35 INFO - PROCESS | 19315 | |4;prototype.html;285.7642444982889;291.4026246195299;292.25037778099176;294.1572395088073;294.7435730914105;4743.739094349814;4828.927566086511;4877.536634019767;4892.87767805805;4895.926561101577;4820.662553621248;4822.373091498109;4823.927641085386;4830.4686484486765;4851.908320627857;3554.253606742587;3667.963320366789;3684.5025921500524;3810;3813.8474461021524;3767.4537192107127;3773.18876441565;3778.338790711628;3778.848846046155;3781.5651200111924;3748.550173979126;3748.981255093721;3749.343864823659;3753.5173606425446;3794.8102594870147;3509.8768394113895;3682.3371793077235;3753.9249215015548;3776.8866933992026;3777.6966946403445;3190.952135717966;3266.3140740444537;3267.728928394743;3275.950860737091;3285.6385797562248;4705.223638099709;4706.717596944194;4711.623070154414;4712.246040633517;4713.316569097496;4262.87211383659;4270.636995855356;4279.229738647043;4279.807408666617;4287.935680964788;4817.205161148407;4991.575716064139;5005.399352077774;5008.8229266122435;5022.723750193738;3570.285942811448;3580.534530511017;3608.116011577154;3618.8914332569802;3623.4927110204594;5280.128778751501;5291.814786482493;5300.734963251822;5300.893982120375;5316.308879845634;3397.9490307645406;3609.5848977367414;3616.511770910946;3694.559121942391;3706.8702595409572;3668.3396988542318;3668.6514781095752;3671.2290419011774;3673.2837096765875;3680.9631903681156;4209.326507758744;4211.178820130107;4223.640990515779;4245.766482843412;4261.829526818955;4869.196582563837;5003.924941125886;5048.545630893237;5063.240533909028;5068.6451948364;1245.9190152640049;1257.2142410993129;1265.354669118756;1265.411583613624;1266.290877108822;759.4152502572988;775.3874439193087;778.6184769462923;785.3991696352296;786.9488483248685;3977.343738283209;4025.637692607621;4270.871873843789;4390.15613442355;4411.757353345597;5043.319151914445;5054.292399064134;5078.187490001582;5205.765740541685;5248;4509.210888094571;4515.9839036217245;4520.480144783326;4545.318202269686;4547.681662283675;2666.9599956000675;2773.764230040469;2780.9304767380977;2795.9440811184068;2799.572218168749;4879.658423910363;4938.012397520511;4938.308636790852;4947.060058588857;4954.256861470736;5365.973170134124;5368.9731551342775;5434.510894019557;5457.508824205841;5474.987127381368;4661.347411362412;4845.9030819383415;4881.365422495124;4894.363732714724;4991.775370108354;5216.66091704038;5227.869303267449;5294.761735721979;5316.308879845596;5316.521513063843;5073.568746656576;5076.568491678248;5093.847184584469;5112.054269960069;5209.921851172159;4664.416947881515;4883.316335713074;4885;4886.29148773433;4887.877803054952;3630.854765809338;3649.7627654202392;3654.7258955577904;3680.944785828161;3701.0192299040236;5170.612204084633;5182.922256166085;5210;5229.764660590206;5236.345456817898;4926.236433352836;5068.428787076018;5087.694738315713;5134.5341894222;5138.711224816196;5110.310108135503;5125.410577783454;5126.154184559506;5132.178076782689;5147.433782283871;4957.423322557686;5022.146235139962;5022.4977502249485;5048.7728052237;5160.819371321985;4852.369192005017;5005.6996580205305;5122.308488354173;5130.871728206825;5160.948390516047;4838.903221935612;4936.976364263114;4972.403311602486;5012.47369026247;5046.520580544842 01:20:35 INFO - PROCESS | 19315 | |5;yui.html;516.0556182186599;534.7379783905886;555.8415851482329;557.2727590494405;584.4768931806034;10199.184065274769;11408.08735301176;11420.714482137952;11436.599719009837;11437.714057148576;10444.060034596885;10830.025297723203;10905.18211134164;10913.34519928805;10919;599.194083957077;748.6331697468256;748.7416841189781;753.932146106853;755.4070055006821;747.9364254038413;751.0424209133344;753.1188509443964;753.8002429356225;758.1584441270186;808.8544062068826;809.0938149272794;809.4253080312985;810.3395732478041;810.6473683947502;802.8073262417037;802.9919700802975;803.0965164190286;803.995980020102;804.9919500804975;593.3295376224881;593.5874567175814;593.7328202308978;597.2713289786453;597.745957967862;9766.804663906752;9780.510974451248;9798.069183427562;9800.803983920354;9811.067948544876;9236.538173091385;9377.812443751087;9614.567344469446;9821.214302855755;10008.549615267331;8855.380123391365;8960;9072.410293330979;9085.409448385833;9258.861117083248;3036.4230796148663;3069.4474994501206;3133.576967109434;3136.9686303136905;3155.0534839548272;56512.71743641297;58380;59197.7040114801;59364;59427.70286148585;7651.426143039294;7879.881801772978;7918.524888506708;7977.760667179994;8162.7143049992965;14977.625559360886;15169.696606068037;15176;15243.314050867737;15248.23758812055;6403.263624683221;6421.8715625688155;6509.641969691617;6591.670416479253;6604.438622717027;3413.4709120086427;3466.4453687410396;3496.667816557423;3540.929181416357;3578.4453409721536;2746.0800631788175;2823.0966090851143;2863.040881304786;2868.8995885144336;2869.426114777053;493.3512431153022;495.6109454078603;496.5208573726371;499.19878594854737;505.92411138329544;434.641420827812;477.7085977553759;497.36585853037667;505.11100463184323;529.1084522579466;6967.499650426472;7415.1843297237265;7534.54792712439;7717.2282771722375;7731.497452665559;443.27967053538003;459.30415420637763;467.0006186760336;472.78724573941867;477.36748807829764;3376.7636265461674;3482.529858469074;3533.3286675531567;3561.198730285665;3581.247937933011;54261.1860822088;66525;96409;101241.49379253057;101916.49041754892;78989.60505197552;79974;82606;83481;85708;71059.2894071063;73191.26808731844;74730.62634686792;77453;79092;6359.777407790705;6425.209126615133;6491.707873145814;6631.1048008520165;6836.179658441019;40829.38755918723;41281.793591031856;41395.379069314586;41504.58495415007;44200.77899610481;55248.72375638096;58347.70826145842;59850.401495984486;63057.36942630515;64332.67833660802;9440.197583205505;9585.856212156683;9693.515324233902;9722.222222222346;9967.302288839712;10765.89234107649;11440.71398215018;11543.422828858356;11599.014083802971;11985.880141198477;10792.406417647106;11194.776104477702;11205.215634905479;11608.6517404478;12326.75346493083;10661.680149595524;10952.069074128789;11246.1565382595;11401.885981140082;12069.818952715541;10844.783104338027;10911.727206819893;11518.424078796193;11585.710357241136;12252.203606765532;9478.763030924281;9623.374480658735;9960.900390995997;10044.792333219384;10138.543765530421;8871.911280887109;9477;10239.897601023895;10260.640877569249;10341.121004714683 01:20:35 INFO - PROCESS | 19315 | __end_tp_report 01:20:35 INFO - PROCESS | 19315 | __start_cc_report 01:20:35 INFO - PROCESS | 19315 | _x_x_mozilla_cycle_collect,1416 01:20:35 INFO - PROCESS | 19315 | __end_cc_report 01:20:35 INFO - PROCESS | 19315 | __startTimestamp1475310035370__endTimestamp 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | ------- Summary: start ------- 01:20:35 INFO - PROCESS | 19315 | Number of tests: 6 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | [#0] dojo.html Cycles:165 Average:4622.50 Median:4739.57 stddev:479.49 (10.1%) stddev-sans-first:452.73 01:20:35 INFO - PROCESS | 19315 | Values: 2555.8 2589.6 2622.3 2626.2 2639.4 4569.5 4623.1 4662.7 4681.2 4702.2 4661.2 4702.0 4739.6 4790.4 4837.7 4282.0 4313.4 4341.1 4353.8 4374.7 4370.5 4408.0 4409.4 4412.6 4433.6 4350.9 4361.5 4419.8 4422.1 4465.6 4213.3 4258.0 4260.7 4291.2 4348.2 4225.4 4242.0 4256.2 4349.5 4370.9 4661.1 4669.7 4670.4 4708.8 4750.7 4857.5 4917.1 4966.8 5007.9 5015.0 5001.1 5010.7 5011.6 5029.5 5060.0 4686.8 4707.4 4709.0 4709.4 4717.0 4962.6 5019.4 5038.6 5160.7 5190.0 4863.1 4875.8 4878.3 4880.5 4883.7 4949.1 4957.4 4960.6 4964.2 4971.1 4865.9 4901.0 4912.4 4941.4 4941.4 4915.7 4941.5 4982.6 4984.9 4993.4 4166.7 4191.7 4195.1 4241.9 4246.6 3656.0 3665.8 3680.4 3719.9 3769.2 4299.0 4323.9 4351.9 4358.2 4404.4 5068.5 5073.2 5081.3 5082.2 5155.6 4233.0 4366.8 4370.2 4372.4 4422.9 4411.9 4435.5 4435.8 4453.7 4504.7 4687.6 4689.5 4692.3 4693.3 4740.6 4998.7 5001.9 5003.2 5012.3 5067.3 4634.7 4666.7 4666.9 4672.7 4675.9 4933.0 4934.4 4936.0 4937.3 4987.8 4998.7 5003.7 5008.5 5008.9 5060.0 4343.9 4701.3 4741.0 4845.4 4886.4 4884.9 4888.0 4890.4 4914.6 4940.4 4824.3 4829.7 4830.8 4837.4 4897.1 4853.2 4915.2 4919.9 4925.6 4930.7 4765.6 4832.9 4836.6 4841.0 4844.9 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | [#1] ext.html Cycles:180 Average:43715.13 Median:34516.07 stddev:76653.49 (222.1%) stddev-sans-first:76799.99 01:20:35 INFO - PROCESS | 19315 | Values: 544.8 554.3 559.4 572.4 576.3 26895.9 36787.0 37913.1 37918.6 41722.0 38072.2 38419.0 38467.2 38484.4 38551.6 7579.8 7709.4 7720.7 7732.5 7739.8 7579.3 7662.5 7663.4 7668.6 7671.3 7668.7 7706.3 7706.5 7719.2 7719.9 7644.4 7695.4 7701.4 7704.5 7709.7 7590.6 7649.3 7657.8 7659.5 7661.3 36542.8 36758.4 37012.4 37061.6 37090.0 2632.7 2777.1 2800.6 2835.6 2870.8 27946.0 28059.6 28207.9 28264.7 28848.0 3183.1 3282.0 3327.6 3351.6 3366.2 200556.0 259643.7 259775.0 260476.0 260854.0 51961.5 52504.0 52527.5 52559.5 52644.5 32725.7 33014.7 33158.2 54865.7 55278.0 12587.1 12843.9 12848.6 12849.4 12857.1 10126.9 10216.1 10241.7 10248.5 10250.2 17470.4 17478.0 17502.0 17548.2 17565.6 6713.9 6758.8 6776.5 6941.7 7030.5 801.0 926.4 931.4 970.9 976.7 26747.6 27243.2 27359.0 27591.9 27688.0 970.4 983.9 988.1 991.1 995.8 13613.5 14347.0 14350.3 14462.7 14666.7 334835.0 335927.0 337212.0 339036.0 339108.0 31641.7 47709.5 47741.1 47787.5 47789.0 1124.2 1139.9 1152.7 1165.3 1170.7 25854.0 26505.9 26529.5 27003.0 27191.3 40774.4 41203.8 41338.4 41369.2 41404.6 282073.0 282232.0 282667.0 283661.0 283978.0 24514.4 24781.9 25000.9 25076.6 25151.9 39415.0 39663.2 39787.4 40069.2 40332.2 33622.8 34212.7 34439.3 34928.0 35012.3 34184.7 34592.8 34647.0 34734.0 34978.0 33969.5 33993.5 34653.8 34809.2 34988.5 29545.4 31656.7 31693.0 31723.4 31953.8 18422.5 18819.7 24445.1 24463.5 24934.4 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | [#2] jquery.html Cycles:180 Average:23074.31 Median:2109.59 stddev:58146.50 (2756.3%) stddev-sans-first:58284.57 01:20:35 INFO - PROCESS | 19315 | Values: 343.9 361.6 363.9 368.5 385.0 12307.1 13256.7 14664.2 16556.2 17237.7 16732.5 17051.6 17255.8 17425.0 17511.5 4795.3 5169.0 5194.8 5199.4 5200.3 3552.7 3736.9 5120.6 5211.3 5219.2 3687.7 3834.2 3905.7 6058.7 6147.3 5896.4 6123.6 6126.3 6131.5 6132.7 5394.6 5400.3 5417.3 5423.5 5423.9 19954.4 20458.7 20467.0 20692.6 20706.8 1726.2 1826.0 1930.6 1951.9 2027.4 9037.0 9197.2 9444.8 9656.6 12710.8 1629.3 1642.9 1713.8 1727.7 1745.4 69345.7 69848.7 70598.0 70712.6 71510.6 9662.3 9848.0 10052.3 10207.5 10349.4 14112.9 14117.6 14125.9 14127.4 14130.4 6817.5 6963.8 6975.7 7150.3 7322.8 6316.3 6326.9 6405.5 6430.9 6652.8 4176.9 4205.6 4245.7 4272.2 4545.0 1737.9 1814.7 1834.7 1863.1 1865.1 851.3 857.4 862.0 881.5 939.9 16661.8 17013.0 17584.2 17624.1 18086.3 849.7 871.8 875.9 884.4 899.9 9285.3 10024.7 10050.9 10082.1 10190.5 343111.0 350122.0 352651.0 353714.0 354814.0 54820.7 74175.4 76151.0 78035.6 80028.0 853.2 879.0 890.4 904.5 910.7 11534.4 15775.6 16005.3 16706.5 16997.5 34509.1 35193.6 36173.6 39245.8 40890.2 45025.8 48926.8 50221.0 50933.5 51117.7 7586.2 7606.8 7701.3 7827.8 7930.0 11357.6 11789.4 12055.5 12085.2 12517.6 9837.2 10012.8 10020.7 10249.7 10786.9 10205.5 10404.4 10521.9 10703.7 10966.2 10228.0 10368.5 10502.3 10640.3 10949.2 7443.2 7580.1 7710.6 7775.1 7828.0 9885.5 9909.7 10213.6 10505.2 10732.3 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | [#3] mootools.html Cycles:180 Average:5003.17 Median:4987.75 stddev:2879.95 (57.7%) stddev-sans-first:2874.91 01:20:35 INFO - PROCESS | 19315 | Values: 1345.5 1386.2 1388.1 1638.7 1663.1 6821.7 7058.4 7447.5 8062.3 8067.6 7461.6 7752.2 7758.1 7886.7 7929.3 2125.6 2148.2 2151.4 2151.9 2154.7 1741.3 1808.1 2076.1 2126.7 2151.3 2108.5 2139.5 2141.7 2142.4 2146.8 2073.7 2082.1 2163.6 2169.0 2169.5 2040.1 2057.8 2076.8 2087.6 2111.2 7848.6 7995.0 8000.3 8004.8 8006.2 4350.1 4468.2 4479.2 4482.3 4484.2 2785.4 2901.6 2930.4 2980.7 2983.3 815.9 849.5 864.7 865.0 871.9 10602.0 10622.1 10629.5 10634.3 10651.8 3874.6 3976.3 4009.4 4142.0 4163.6 8974.5 9000.5 9006.4 9006.6 9014.1 4447.2 4455.2 4463.4 4475.4 4481.0 4026.1 4044.9 4046.1 4047.3 4048.7 3214.2 3357.9 3481.3 3600.0 3660.7 1151.9 1157.7 1171.1 1171.6 1174.9 599.5 647.6 698.1 713.7 726.7 4642.4 4692.7 4751.2 4853.4 4992.7 850.4 851.9 912.5 915.0 917.8 3328.9 3371.7 3389.8 3411.5 3527.9 9628.0 9714.0 9809.9 9822.8 9830.4 9679.6 9688.3 9700.3 9718.9 9734.7 6884.8 7034.3 7202.6 7216.9 7225.2 4955.6 4982.8 5019.8 5091.3 5256.3 8554.3 8619.2 8801.5 8901.8 8903.5 9029.3 9063.7 9120.1 9197.9 9258.8 6521.2 6676.9 6681.6 6681.6 6684.2 6395.1 6528.7 7032.4 7191.1 7226.5 6445.6 6453.7 6484.2 6484.9 6513.3 6105.6 6307.7 6315.2 6317.7 6438.6 5603.4 5720.9 5785.1 5852.9 5855.9 4266.4 4282.3 4389.6 4394.0 4394.3 4151.3 4179.8 4250.9 4265.7 4287.0 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | [#4] prototype.html Cycles:180 Average:4188.11 Median:4823.15 stddev:1238.19 (25.7%) stddev-sans-first:1206.52 01:20:35 INFO - PROCESS | 19315 | Values: 285.8 291.4 292.3 294.2 294.7 4743.7 4828.9 4877.5 4892.9 4895.9 4820.7 4822.4 4823.9 4830.5 4851.9 3554.3 3668.0 3684.5 3810.0 3813.8 3767.5 3773.2 3778.3 3778.8 3781.6 3748.6 3749.0 3749.3 3753.5 3794.8 3509.9 3682.3 3753.9 3776.9 3777.7 3191.0 3266.3 3267.7 3276.0 3285.6 4705.2 4706.7 4711.6 4712.2 4713.3 4262.9 4270.6 4279.2 4279.8 4287.9 4817.2 4991.6 5005.4 5008.8 5022.7 3570.3 3580.5 3608.1 3618.9 3623.5 5280.1 5291.8 5300.7 5300.9 5316.3 3397.9 3609.6 3616.5 3694.6 3706.9 3668.3 3668.7 3671.2 3673.3 3681.0 4209.3 4211.2 4223.6 4245.8 4261.8 4869.2 5003.9 5048.5 5063.2 5068.6 1245.9 1257.2 1265.4 1265.4 1266.3 759.4 775.4 778.6 785.4 786.9 3977.3 4025.6 4270.9 4390.2 4411.8 5043.3 5054.3 5078.2 5205.8 5248.0 4509.2 4516.0 4520.5 4545.3 4547.7 2667.0 2773.8 2780.9 2795.9 2799.6 4879.7 4938.0 4938.3 4947.1 4954.3 5366.0 5369.0 5434.5 5457.5 5475.0 4661.3 4845.9 4881.4 4894.4 4991.8 5216.7 5227.9 5294.8 5316.3 5316.5 5073.6 5076.6 5093.8 5112.1 5209.9 4664.4 4883.3 4885.0 4886.3 4887.9 3630.9 3649.8 3654.7 3680.9 3701.0 5170.6 5182.9 5210.0 5229.8 5236.3 4926.2 5068.4 5087.7 5134.5 5138.7 5110.3 5125.4 5126.2 5132.2 5147.4 4957.4 5022.1 5022.5 5048.8 5160.8 4852.4 5005.7 5122.3 5130.9 5160.9 4838.9 4937.0 4972.4 5012.5 5046.5 01:20:35 INFO - PROCESS | 19315 | 01:20:35 INFO - PROCESS | 19315 | [#5] yui.html Cycles:180 Average:16375.99 Median:58363.85 stddev:24118.91 (41.3%) stddev-sans-first:24157.17 01:20:35 INFO - PROCESS | 19315 | Values: 516.1 534.7 555.8 557.3 584.5 10199.2 11408.1 11420.7 11436.6 11437.7 10444.1 10830.0 10905.2 10913.3 10919.0 599.2 748.6 748.7 753.9 755.4 747.9 751.0 753.1 753.8 758.2 808.9 809.1 809.4 810.3 810.6 802.8 803.0 803.1 804.0 805.0 593.3 593.6 593.7 597.3 597.7 9766.8 9780.5 9798.1 9800.8 9811.1 9236.5 9377.8 9614.6 9821.2 10008.5 8855.4 8960.0 9072.4 9085.4 9258.9 3036.4 3069.4 3133.6 3137.0 3155.1 56512.7 58380.0 59197.7 59364.0 59427.7 7651.4 7879.9 7918.5 7977.8 8162.7 14977.6 15169.7 15176.0 15243.3 15248.2 6403.3 6421.9 6509.6 6591.7 6604.4 3413.5 3466.4 3496.7 3540.9 3578.4 2746.1 2823.1 2863.0 2868.9 2869.4 493.4 495.6 496.5 499.2 505.9 434.6 477.7 497.4 505.1 529.1 6967.5 7415.2 7534.5 7717.2 7731.5 443.3 459.3 467.0 472.8 477.4 3376.8 3482.5 3533.3 3561.2 3581.2 54261.2 66525.0 96409.0 101241.5 101916.5 78989.6 79974.0 82606.0 83481.0 85708.0 71059.3 73191.3 74730.6 77453.0 79092.0 6359.8 6425.2 6491.7 6631.1 6836.2 40829.4 41281.8 41395.4 41504.6 44200.8 55248.7 58347.7 59850.4 63057.4 64332.7 9440.2 9585.9 9693.5 9722.2 9967.3 10765.9 11440.7 11543.4 11599.0 11985.9 10792.4 11194.8 11205.2 11608.7 12326.8 10661.7 10952.1 11246.2 11401.9 12069.8 10844.8 10911.7 11518.4 11585.7 12252.2 9478.8 9623.4 9960.9 10044.8 10138.5 8871.9 9477.0 10239.9 10260.6 10341.1 01:20:35 INFO - PROCESS | 19315 | -------- Summary: end -------- 01:20:35 INFO - PROCESS | 19315 | 01:20:36 INFO - TEST-INFO | 19315: exit 0 01:20:36 INFO - TEST-OK | dromaeo_css | took 1122450ms 01:20:36 INFO - TEST-START | kraken 01:20:36 INFO - operating with platform_type : linux_ 01:20:36 INFO - Initialising browser for kraken test... 01:20:36 INFO - TEST-INFO | started process 19620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRv22YH/profile http://localhost:44925/getInfo.html) 01:20:40 INFO - PROCESS | 19620 | __metrics Screen width/height:1600/1200 01:20:40 INFO - PROCESS | 19620 | colorDepth:24 01:20:40 INFO - PROCESS | 19620 | Browser inner width/height: 1024/697 01:20:40 INFO - PROCESS | 19620 | __metrics 01:20:41 INFO - PROCESS | 19620 | 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" 01:20:41 INFO - PROCESS | 19620 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:41 INFO - PROCESS | 19620 | console.error: PushService: 01:20:41 INFO - PROCESS | 19620 | stateChangeProcessEnqueue: Error transitioning state 01:20:41 INFO - PROCESS | 19620 | UnknownError 01:20:42 INFO - TEST-INFO | 19620: exit 0 01:20:42 INFO - Browser initialized. 01:20:42 INFO - Running cycle 1/1 for kraken test... 01:20:42 INFO - TEST-INFO | started process 19702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRv22YH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:55 INFO - PROCESS | 19702 | RSS: Main: 175480832 01:20:55 INFO - PROCESS | 19702 | 01:20:57 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44925/tests/kraken/driver.html?testName=audio-beat-detection) 01:20:58 INFO - PROCESS | 19702 | RSS: Main: 234270720 01:20:58 INFO - PROCESS | 19702 | 01:21:01 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44925/tests/kraken/driver.html?testName=audio-dft) 01:21:02 INFO - PROCESS | 19702 | RSS: Main: 218972160 01:21:02 INFO - PROCESS | 19702 | 01:21:05 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44925/tests/kraken/driver.html?testName=audio-fft) 01:21:06 INFO - PROCESS | 19702 | RSS: Main: 301223936 01:21:06 INFO - PROCESS | 19702 | 01:21:08 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44925/tests/kraken/driver.html?testName=audio-oscillator) 01:21:08 INFO - PROCESS | 19702 | RSS: Main: 210317312 01:21:08 INFO - PROCESS | 19702 | 01:21:11 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:21:11 INFO - PROCESS | 19702 | RSS: Main: 214224896 01:21:11 INFO - PROCESS | 19702 | 01:21:14 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44925/tests/kraken/driver.html?testName=imaging-darkroom) 01:21:15 INFO - PROCESS | 19702 | RSS: Main: 250806272 01:21:15 INFO - PROCESS | 19702 | 01:21:19 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44925/tests/kraken/driver.html?testName=imaging-desaturate) 01:21:19 INFO - PROCESS | 19702 | RSS: Main: 245092352 01:21:19 INFO - PROCESS | 19702 | 01:21:22 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44925/tests/kraken/driver.html?testName=json-parse-financial) 01:21:23 INFO - PROCESS | 19702 | RSS: Main: 247820288 01:21:23 INFO - PROCESS | 19702 | 01:21:24 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:21:25 INFO - PROCESS | 19702 | RSS: Main: 211124224 01:21:25 INFO - PROCESS | 19702 | 01:21:27 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:21:28 INFO - PROCESS | 19702 | RSS: Main: 218800128 01:21:28 INFO - PROCESS | 19702 | 01:21:30 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:21:31 INFO - PROCESS | 19702 | RSS: Main: 223469568 01:21:31 INFO - PROCESS | 19702 | 01:21:33 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:21:34 INFO - PROCESS | 19702 | RSS: Main: 217759744 01:21:34 INFO - PROCESS | 19702 | 01:21:37 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:21:38 INFO - PROCESS | 19702 | RSS: Main: 222748672 01:21:38 INFO - PROCESS | 19702 | 01:21:39 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:44925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44925/tests/kraken/driver.html?testName=ai-astar) 01:21:40 INFO - PROCESS | 19702 | RSS: Main: 274145280 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | __start_tp_report 01:21:40 INFO - PROCESS | 19702 | _x_x_mozilla_page_load 01:21:40 INFO - PROCESS | 19702 | _x_x_mozilla_page_load_details 01:21:40 INFO - PROCESS | 19702 | |i|pagename|runs| 01:21:40 INFO - PROCESS | 19702 | |0;ai-astar;111;114;113;116;115;113;113;115;112;113 01:21:40 INFO - PROCESS | 19702 | |1;audio-beat-detection;164;128;135;171;127;128;126;131;171;126 01:21:40 INFO - PROCESS | 19702 | |2;audio-dft;164;163;163;164;163;162;162;161;174;162 01:21:40 INFO - PROCESS | 19702 | |3;audio-fft;76;77;76;117;79;77;76;76;111;75 01:21:40 INFO - PROCESS | 19702 | |4;audio-oscillator;90;82;117;85;84;83;111;83;83;115 01:21:40 INFO - PROCESS | 19702 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 01:21:40 INFO - PROCESS | 19702 | |6;imaging-darkroom;147;146;146;146;146;147;146;146;146;146 01:21:40 INFO - PROCESS | 19702 | |7;imaging-desaturate;95;95;96;96;94;95;95;94;95;95 01:21:40 INFO - PROCESS | 19702 | |8;json-parse-financial;65;63;64;63;63;64;64;64;64;63 01:21:40 INFO - PROCESS | 19702 | |9;json-stringify-tinderbox;65;67;65;65;69;65;66;66;66;67 01:21:40 INFO - PROCESS | 19702 | |10;stanford-crypto-aes;93;93;87;83;86;90;82;93;83;83 01:21:40 INFO - PROCESS | 19702 | |11;stanford-crypto-ccm;141;144;138;139;136;136;140;135;167;138 01:21:40 INFO - PROCESS | 19702 | |12;stanford-crypto-pbkdf2;178;176;174;175;175;176;187;173;174;176 01:21:40 INFO - PROCESS | 19702 | |13;stanford-crypto-sha256-iterative;70;72;69;70;70;69;70;71;71;73 01:21:40 INFO - PROCESS | 19702 | __end_tp_report 01:21:40 INFO - PROCESS | 19702 | __start_cc_report 01:21:40 INFO - PROCESS | 19702 | _x_x_mozilla_cycle_collect,1895 01:21:40 INFO - PROCESS | 19702 | __end_cc_report 01:21:40 INFO - PROCESS | 19702 | __startTimestamp1475310100110__endTimestamp 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | ------- Summary: start ------- 01:21:40 INFO - PROCESS | 19702 | Number of tests: 14 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.50 stddev:1.51 (1.3%) stddev-sans-first:1.30 01:21:40 INFO - PROCESS | 19702 | Values: 111.0 114.0 113.0 116.0 115.0 113.0 113.0 115.0 112.0 113.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:133.00 stddev:19.57 (14.7%) stddev-sans-first:18.86 01:21:40 INFO - PROCESS | 19702 | Values: 164.0 128.0 135.0 171.0 127.0 128.0 126.0 131.0 171.0 126.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.71 (2.3%) stddev-sans-first:3.93 01:21:40 INFO - PROCESS | 19702 | Values: 164.0 163.0 163.0 164.0 163.0 162.0 162.0 161.0 174.0 162.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:15.91 (20.9%) stddev-sans-first:16.61 01:21:40 INFO - PROCESS | 19702 | Values: 76.0 77.0 76.0 117.0 79.0 77.0 76.0 76.0 111.0 75.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:14.75 (17.8%) stddev-sans-first:15.60 01:21:40 INFO - PROCESS | 19702 | Values: 90.0 82.0 117.0 85.0 84.0 83.0 111.0 83.0 83.0 115.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:21:40 INFO - PROCESS | 19702 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 01:21:40 INFO - PROCESS | 19702 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:21:40 INFO - PROCESS | 19702 | Values: 95.0 95.0 96.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 01:21:40 INFO - PROCESS | 19702 | Values: 65.0 63.0 64.0 63.0 63.0 64.0 64.0 64.0 64.0 63.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 01:21:40 INFO - PROCESS | 19702 | Values: 65.0 67.0 65.0 65.0 69.0 65.0 66.0 66.0 66.0 67.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:88.50 stddev:4.60 (5.2%) stddev-sans-first:4.39 01:21:40 INFO - PROCESS | 19702 | Values: 93.0 93.0 87.0 83.0 86.0 90.0 82.0 93.0 83.0 83.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:139.50 stddev:9.38 (6.7%) stddev-sans-first:9.95 01:21:40 INFO - PROCESS | 19702 | Values: 141.0 144.0 138.0 139.0 136.0 136.0 140.0 135.0 167.0 138.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:176.00 stddev:3.98 (2.3%) stddev-sans-first:4.18 01:21:40 INFO - PROCESS | 19702 | Values: 178.0 176.0 174.0 175.0 175.0 176.0 187.0 173.0 174.0 176.0 01:21:40 INFO - PROCESS | 19702 | 01:21:40 INFO - PROCESS | 19702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 01:21:40 INFO - PROCESS | 19702 | Values: 70.0 72.0 69.0 70.0 70.0 69.0 70.0 71.0 71.0 73.0 01:21:40 INFO - PROCESS | 19702 | -------- Summary: end -------- 01:21:40 INFO - PROCESS | 19702 | 01:21:41 INFO - TEST-INFO | 19702: exit 0 01:21:41 INFO - TEST-OK | kraken | took 65031ms 01:21:41 INFO - SUITE-END | took 1187s 01:21:41 INFO - Completed test suite (00:19:47) 01:21:41 INFO - javascript benchmark 01:21:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2555.7955363570914, 2589.5597748382775, 2622.3181972687094, 2626.2121363590923, 2639.3929396238877, 4569.520200378962, 4623.14471822713, 4662.696924699892, 4681.227597446422, 4702.24764037754, 4661.184292748764, 4702.0360826030665, 4739.573438390544, 4790.401199850019, 4837.685550439219, 4281.978590107045, 4313.374560688699, 4341.088371442001, 4353.825846966118, 4374.7156434831795, 4370.497392799821, 4408.0, 4409.426774519308, 4412.646988240949, 4433.5566443355565, 4350.934735978963, 4361.542038085987, 4419.756913369763, 4422.115576884636, 4465.642748580122, 4213.262679031157, 4258.0, 4260.659147268242, 4291.206126866539, 4348.152110338485, 4225.408442818008, 4242.045539753562, 4256.170046840836, 4349.499807522144, 4370.934435983463, 4661.114388266218, 4669.743164125972, 4670.392848929618, 4708.764561771932, 4750.738709370983, 4857.514248575114, 4917.065757506062, 4966.776495057731, 5007.899842003176, 5015.04714104319, 5001.149804533238, 5010.674306170087, 5011.649184557083, 5029.5221953914315, 5059.974700126476, 4686.765661716935, 4707.388039554904, 4709.011107667359, 4709.434867815816, 4717.0, 4962.5533701967, 5019.447860735316, 5038.647294689336, 5160.664556803796, 5189.962007598496, 4863.051704917507, 4875.756212189376, 4878.341423907798, 4880.511948805091, 4883.706977581356, 4949.133901567211, 4957.355543779286, 4960.627952903546, 4964.205727083649, 4971.055499455092, 4865.854024379274, 4900.95099049005, 4912.410510738734, 4941.431735350408, 4941.43173535048, 4915.729634870117, 4941.530554597308, 4982.5515703586125, 4984.850454486371, 4993.350864387679, 4166.729162604421, 4191.685623578243, 4195.098053918422, 4241.915161696748, 4246.596573325529, 3655.9817200913826, 3665.8350374233223, 3680.3743363628246, 3719.9442008369897, 3769.227308401771, 4298.978505107454, 4323.891902702395, 4351.912961740747, 4358.21552120615, 4404.4494438195225, 5068.467810879878, 5073.239014147834, 5081.339425874613, 5082.186850103965, 5155.639105262596, 4233.047564298008, 4366.8034938427845, 4370.150672654651, 4372.366006928977, 4422.933655995163, 4411.933820992687, 4435.489918659331, 4435.822567097344, 4453.732776033448, 4504.729716216972, 4687.62499000086, 4689.507601701772, 4692.343071969859, 4693.272542755878, 4740.644451666208, 4998.6500944933505, 5001.949980500149, 5003.249512573143, 5012.3233363495465, 5067.341245638191, 4634.745089020136, 4666.673332866667, 4666.859994200179, 4672.7429991349445, 4675.9011632267075, 4932.975335123301, 4934.383202099738, 4935.975320123376, 4937.308776771327, 4987.800487980585, 4998.725070121178, 5003.749812509433, 5008.524190201925, 5008.9499105009945, 5060.0, 4343.9357357447625, 4701.271302948048, 4741.004389078194, 4845.370101886732, 4886.389201349832, 4884.853454396374, 4887.975560122177, 4890.388701412324, 4914.557689807934, 4940.431850337257, 4824.324594556695, 4829.66192366531, 4830.830920917751, 4837.37114175155, 4897.118518666674, 4853.223484242504, 4915.213565829593, 4919.877003074808, 4925.581325587365, 4930.654854160174, 4765.642576806823, 4832.927506087482, 4836.564709176191, 4840.95159048405, 4844.854654360375], "value": 4592.043621797229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.801147581133, 554.282204545114, 559.4154108956141, 572.4018400771193, 576.3487259396882, 26895.865520672392, 36787.0, 37913.052173695636, 37918.62081379185, 41722.0, 38072.238555228876, 38419.0, 38467.23065538688, 38484.42273365895, 38551.614483855155, 7579.772606821791, 7709.38324934004, 7720.652570634335, 7732.497387669811, 7739.845203095934, 7579.279968402993, 7662.501937374052, 7663.3869290456905, 7668.616569171547, 7671.2712292332135, 7668.731594394198, 7706.267904549087, 7706.499077559941, 7719.228077192292, 7719.884201736979, 7644.426667999895, 7695.3843692505025, 7701.383889288843, 7704.460687751832, 7709.6916123354995, 7590.620468976529, 7649.349805266559, 7657.846843063163, 7659.463837531375, 7661.272179142972, 36542.81728591367, 36758.44862327067, 37012.44481332782, 37061.62938370609, 37090.0, 2632.670916135483, 2777.125205560242, 2800.649918760155, 2835.5888396182645, 2870.81339712918, 27946.0, 28059.57910631342, 28207.85896070527, 28264.717352826414, 28848.0, 3183.108729555728, 3281.950770738441, 3327.617324007722, 3351.6480769519094, 3366.2257680733323, 200556.0, 259643.70178149178, 259775.0, 260476.0, 260854.0, 51961.48038519567, 52504.0, 52527.47472525302, 52559.47440525546, 52644.473555264725, 32725.67274327274, 33014.66985330164, 33158.17104572357, 54865.72567137139, 55278.0, 12587.118901676795, 12843.935780321039, 12848.550300739429, 12849.357532123544, 12857.100002999887, 10126.949365253127, 10216.08055275014, 10241.692749217535, 10248.538815753309, 10250.231232657581, 17470.38853640142, 17478.0, 17502.0, 17548.210330535156, 17565.560860978323, 6713.943268078326, 6758.797236082925, 6776.491763117786, 6941.652917354112, 7030.54301470413, 800.9679612815422, 926.416357694648, 931.417863835103, 970.898055704155, 976.6825781621002, 26747.598786018225, 27243.182704518895, 27359.0, 27591.86204068967, 27688.0, 970.3547141151056, 983.9262055345878, 988.0761488008735, 991.1377101921374, 995.8456439251928, 13613.455461781417, 14347.0, 14350.282485875665, 14462.710745785025, 14666.706665866835, 334835.0, 335927.0, 337212.0, 339036.0, 339108.0, 31641.683583164333, 47709.522904771206, 47741.135531868196, 47787.522124779, 47789.0, 1124.1512657943201, 1139.880312567185, 1152.7060599547062, 1165.318288801044, 1170.6897672116895, 25854.0, 26505.867470662524, 26529.469410612066, 27003.0, 27191.320216994733, 40774.38838417367, 41203.7939810311, 41338.379924301764, 41369.1726165481, 41404.58595414007, 282073.0, 282232.0, 282667.0, 283661.0, 283978.0, 24514.38714032092, 24781.876090620153, 25000.874995624905, 25076.62385064189, 25151.87424062868, 39415.0, 39663.2067358657, 39787.40318895277, 40069.1986160281, 40332.1933561333, 33622.83188584042, 34212.65787342095, 34439.31121377508, 34928.0, 35012.29975400529, 34184.65815341914, 34592.82703586466, 34647.0, 34734.0, 34978.0, 33969.475145682125, 33993.490097649046, 34653.82673086719, 34809.16793721494, 34988.47517287192, 29545.409091818474, 31656.683433165374, 31693.0, 31723.365532688757, 31953.840230798698, 18422.539436514195, 18819.717704234172, 24445.144419945216, 24463.51072978566, 24934.37664058413], "value": 16644.678796073254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.8607364017574, 361.56250936367013, 363.92721455708846, 368.5246032617922, 384.99615003849954, 12307.138500304982, 13256.668583285411, 14664.193469359194, 16556.172191390444, 17237.741433878502, 16732.498025059238, 17051.57371065724, 17255.827441725578, 17425.0, 17511.474655760314, 4795.25673520604, 5169.043726910515, 5194.766235519392, 5199.376074871002, 5200.271961925334, 3552.662497062775, 3736.9252614947686, 5120.61595380348, 5211.296474975868, 5219.243209734586, 3687.7234207434417, 3834.175652234769, 3905.6875449964077, 6058.666773327465, 6147.323794382614, 5896.439838215363, 6123.571350005502, 6126.326104128565, 6131.540134489886, 6132.724027418754, 5394.649347792381, 5400.270963419927, 5417.322834645669, 5423.484768946943, 5423.864403389907, 19954.401367958984, 20458.74953755086, 20467.0, 20692.58614827695, 20706.79293207064, 1726.1541844496107, 1825.963480730378, 1930.6138772245606, 1951.8828870267687, 2027.3917824652544, 9036.954815225947, 9197.218236449842, 9444.811103777954, 9656.565454554562, 12710.809337859939, 1629.2994012574588, 1642.9096399698012, 1713.8200488948605, 1727.6631056943902, 1745.3716662001668, 69345.65327173383, 69848.6507567464, 70598.0, 70712.64643676749, 71510.64244678796, 9662.275329350327, 9847.950760246153, 10052.346597471142, 10207.46887966796, 10349.379037257788, 14112.929435352962, 14117.57647270563, 14125.929370353288, 14127.434902603985, 14130.434782608581, 6817.522773405814, 6963.82590435233, 6975.686094125776, 7150.320719531636, 7322.816929576803, 6316.304961597425, 6326.905096423558, 6405.519586031066, 6430.935690643128, 6652.7671531497135, 4176.916461670749, 4205.642520385802, 4245.660347172219, 4272.230998420252, 4544.954550454519, 1737.904415257173, 1814.6915024445875, 1834.7064469684785, 1863.1336428560514, 1865.0861078071648, 851.3061854588615, 857.4169564696067, 861.9525926074001, 881.5107615273585, 939.8684184214216, 16661.750073748903, 17013.0, 17584.208710608054, 17624.1187940605, 18086.27654893816, 849.6856163219525, 871.7515508080166, 875.8598624220094, 884.4030279561399, 899.9460032398077, 9285.25717942563, 10024.699259022242, 10050.899491005142, 10082.143017843418, 10190.490475476197, 343111.0, 350122.0, 352651.0, 353714.0, 354814.0, 54820.72589637026, 74175.3901836689, 76151.0, 78035.60982195166, 80028.0, 853.1587988599001, 878.9824203515894, 890.3900827932757, 904.4754042655376, 910.6630546697631, 11534.423278836193, 15775.605609859385, 16005.279762410486, 16706.49880503587, 16997.49007529776, 34509.13727156841, 35193.64806351904, 36173.638263617024, 39245.803770980965, 40890.18219635531, 45025.77487112543, 48926.75536622294, 50221.0, 50933.490665092875, 51117.74441127919, 7586.24137586237, 7606.8098297543, 7701.345385642283, 7827.843443130992, 7930.0, 11357.602483913024, 11789.410529473664, 12055.51777928873, 12085.15403921717, 12517.56188533397, 9837.163841073589, 10012.799744005224, 10020.749481263027, 10249.74375640615, 10786.946065269623, 10205.540750666089, 10404.375737455777, 10521.947390263, 10703.732406689584, 10966.17753668494, 10228.0, 10368.481575921023, 10502.264841461025, 10640.308379955279, 10949.178811589003, 7443.218462061405, 7580.05249343832, 7710.575918324322, 7775.14473407936, 7827.9608601956625, 9885.456299903286, 9909.65316213929, 10213.642522511676, 10505.216117728654, 10732.26327286537], "value": 8117.42787038007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.4618152738904, 1386.1890793885577, 1388.0699931046197, 1638.664073864857, 1663.1102360237276, 6821.6930238139275, 7058.400035996947, 7447.515911465751, 8062.274395304429, 8067.59662016899, 7461.5523068615785, 7752.1860204678405, 7758.146603873583, 7886.723964661238, 7929.286364227219, 2125.5855108253895, 2148.151480165334, 2151.397608669567, 2151.8816465094415, 2154.687570302305, 1741.2947756158712, 1808.0507733439918, 2076.0761461149796, 2126.6597344424895, 2151.300827231148, 2108.536122053146, 2139.513038438286, 2141.6680414535695, 2142.442964829148, 2146.774588668191, 2073.699313599527, 2082.1255072869358, 2163.599734049206, 2169.0, 2169.533550286696, 2040.0819631166034, 2057.845661575373, 2076.8442366822396, 2087.5929193807215, 2111.166089394696, 7848.646810893523, 7994.960025199837, 8000.279974802237, 8004.799880002988, 8006.239407256301, 4350.129974005212, 4468.19572476954, 4479.193745125876, 4482.305242687356, 4484.170428470743, 2785.359367345522, 2901.6227890374325, 2930.3846192299643, 2980.7168319009875, 2983.2840118371437, 815.9102498725135, 849.5370023337296, 864.7059999600166, 865.0268447996004, 871.904090550039, 10602.0, 10622.09712174466, 10629.5216715248, 10634.308769930007, 10651.84022239667, 3874.5737968823405, 3976.343903255988, 4009.418634298069, 4142.0, 4163.646090082377, 8974.506402147814, 9000.50497222659, 9006.369554131148, 9006.59470323837, 9014.053524379977, 4447.221736196153, 4455.242608756519, 4463.375127482155, 4475.411229013718, 4480.977595112004, 4026.1142548639255, 4044.939325910114, 4046.0896298333228, 4047.2917239483563, 4048.6558642515715, 3214.1964508872784, 3357.8824741133944, 3481.3211423772123, 3599.9640003600152, 3660.6888414484533, 1151.9136064795173, 1157.7279339355246, 1171.109956433117, 1171.6075114836456, 1174.8590169179754, 599.4694695194784, 647.6243778608396, 698.1308271202386, 713.6681443128866, 726.6802606852967, 4642.3500709900645, 4692.741899195509, 4751.168545504523, 4853.417589889236, 4992.700437973661, 850.4436880508654, 851.948883067018, 912.5209265135724, 914.9862752058724, 917.7613820406742, 3328.916777080544, 3371.696547310754, 3389.8305084746157, 3411.4541673332146, 3527.8588856445454, 9628.0, 9714.0, 9809.901900981042, 9822.803543929082, 9830.4101753895, 9679.564419600994, 9688.273379496566, 9700.27247956406, 9718.902810971942, 9734.659286924923, 6884.793456196322, 7034.331738484836, 7202.603856787822, 7216.8917466238045, 7225.205227424979, 4955.562886762798, 4982.800687972585, 5019.84940451787, 5091.338126043591, 5256.290400795843, 8554.27288680469, 8619.224269815746, 8801.515916624647, 8901.821963560564, 8903.510306932922, 9029.291212636314, 9063.728088157366, 9120.087991200828, 9197.862032069657, 9258.814823703622, 6521.184851893513, 6676.89984650221, 6681.599104053772, 6681.632510211985, 6684.197896252286, 6395.136656551492, 6528.706208220737, 7032.367086962198, 7191.137063552407, 7226.494145409981, 6445.613263204223, 6453.741850325934, 6484.221893372825, 6484.902726459012, 6513.283538810632, 6105.633661980295, 6307.684615769102, 6315.210598675166, 6317.715702793477, 6438.581492202992, 5603.35561410443, 5720.942790572208, 5785.103308987113, 5852.882942341044, 5855.9121613176685, 4266.424032755663, 4282.293421585528, 4389.582989615981, 4393.956060439483, 4394.318880573516, 4151.294279972351, 4179.770112643834, 4250.936235956401, 4265.701400902031, 4287.0], "value": 3996.092840087343, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7642444982889, 291.4026246195299, 292.25037778099176, 294.1572395088073, 294.7435730914105, 4743.739094349814, 4828.927566086511, 4877.536634019767, 4892.87767805805, 4895.926561101577, 4820.662553621248, 4822.373091498109, 4823.927641085386, 4830.4686484486765, 4851.908320627857, 3554.253606742587, 3667.963320366789, 3684.5025921500524, 3810.0, 3813.8474461021524, 3767.4537192107127, 3773.18876441565, 3778.338790711628, 3778.848846046155, 3781.5651200111924, 3748.550173979126, 3748.981255093721, 3749.343864823659, 3753.5173606425446, 3794.8102594870147, 3509.8768394113895, 3682.3371793077235, 3753.9249215015548, 3776.8866933992026, 3777.6966946403445, 3190.952135717966, 3266.3140740444537, 3267.728928394743, 3275.950860737091, 3285.6385797562248, 4705.223638099709, 4706.717596944194, 4711.623070154414, 4712.246040633517, 4713.316569097496, 4262.87211383659, 4270.636995855356, 4279.229738647043, 4279.807408666617, 4287.935680964788, 4817.205161148407, 4991.575716064139, 5005.399352077774, 5008.8229266122435, 5022.723750193738, 3570.285942811448, 3580.534530511017, 3608.116011577154, 3618.8914332569802, 3623.4927110204594, 5280.128778751501, 5291.814786482493, 5300.734963251822, 5300.893982120375, 5316.308879845634, 3397.9490307645406, 3609.5848977367414, 3616.511770910946, 3694.559121942391, 3706.8702595409572, 3668.3396988542318, 3668.6514781095752, 3671.2290419011774, 3673.2837096765875, 3680.9631903681156, 4209.326507758744, 4211.178820130107, 4223.640990515779, 4245.766482843412, 4261.829526818955, 4869.196582563837, 5003.924941125886, 5048.545630893237, 5063.240533909028, 5068.6451948364, 1245.9190152640049, 1257.2142410993129, 1265.354669118756, 1265.411583613624, 1266.290877108822, 759.4152502572988, 775.3874439193087, 778.6184769462923, 785.3991696352296, 786.9488483248685, 3977.343738283209, 4025.637692607621, 4270.871873843789, 4390.15613442355, 4411.757353345597, 5043.319151914445, 5054.292399064134, 5078.187490001582, 5205.765740541685, 5248.0, 4509.210888094571, 4515.9839036217245, 4520.480144783326, 4545.318202269686, 4547.681662283675, 2666.9599956000675, 2773.764230040469, 2780.9304767380977, 2795.9440811184068, 2799.572218168749, 4879.658423910363, 4938.012397520511, 4938.308636790852, 4947.060058588857, 4954.256861470736, 5365.973170134124, 5368.9731551342775, 5434.510894019557, 5457.508824205841, 5474.987127381368, 4661.347411362412, 4845.9030819383415, 4881.365422495124, 4894.363732714724, 4991.775370108354, 5216.66091704038, 5227.869303267449, 5294.761735721979, 5316.308879845596, 5316.521513063843, 5073.568746656576, 5076.568491678248, 5093.847184584469, 5112.054269960069, 5209.921851172159, 4664.416947881515, 4883.316335713074, 4885.0, 4886.29148773433, 4887.877803054952, 3630.854765809338, 3649.7627654202392, 3654.7258955577904, 3680.944785828161, 3701.0192299040236, 5170.612204084633, 5182.922256166085, 5210.0, 5229.764660590206, 5236.345456817898, 4926.236433352836, 5068.428787076018, 5087.694738315713, 5134.5341894222, 5138.711224816196, 5110.310108135503, 5125.410577783454, 5126.154184559506, 5132.178076782689, 5147.433782283871, 4957.423322557686, 5022.146235139962, 5022.4977502249485, 5048.7728052237, 5160.819371321985, 4852.369192005017, 5005.6996580205305, 5122.308488354173, 5130.871728206825, 5160.948390516047, 4838.903221935612, 4936.976364263114, 4972.403311602486, 5012.47369026247, 5046.520580544842], "value": 3786.3960198093623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.0556182186599, 534.7379783905886, 555.8415851482329, 557.2727590494405, 584.4768931806034, 10199.184065274769, 11408.08735301176, 11420.714482137952, 11436.599719009837, 11437.714057148576, 10444.060034596885, 10830.025297723203, 10905.18211134164, 10913.34519928805, 10919.0, 599.194083957077, 748.6331697468256, 748.7416841189781, 753.932146106853, 755.4070055006821, 747.9364254038413, 751.0424209133344, 753.1188509443964, 753.8002429356225, 758.1584441270186, 808.8544062068826, 809.0938149272794, 809.4253080312985, 810.3395732478041, 810.6473683947502, 802.8073262417037, 802.9919700802975, 803.0965164190286, 803.995980020102, 804.9919500804975, 593.3295376224881, 593.5874567175814, 593.7328202308978, 597.2713289786453, 597.745957967862, 9766.804663906752, 9780.510974451248, 9798.069183427562, 9800.803983920354, 9811.067948544876, 9236.538173091385, 9377.812443751087, 9614.567344469446, 9821.214302855755, 10008.549615267331, 8855.380123391365, 8960.0, 9072.410293330979, 9085.409448385833, 9258.861117083248, 3036.4230796148663, 3069.4474994501206, 3133.576967109434, 3136.9686303136905, 3155.0534839548272, 56512.71743641297, 58380.0, 59197.7040114801, 59364.0, 59427.70286148585, 7651.426143039294, 7879.881801772978, 7918.524888506708, 7977.760667179994, 8162.7143049992965, 14977.625559360886, 15169.696606068037, 15176.0, 15243.314050867737, 15248.23758812055, 6403.263624683221, 6421.8715625688155, 6509.641969691617, 6591.670416479253, 6604.438622717027, 3413.4709120086427, 3466.4453687410396, 3496.667816557423, 3540.929181416357, 3578.4453409721536, 2746.0800631788175, 2823.0966090851143, 2863.040881304786, 2868.8995885144336, 2869.426114777053, 493.3512431153022, 495.6109454078603, 496.5208573726371, 499.19878594854737, 505.92411138329544, 434.641420827812, 477.7085977553759, 497.36585853037667, 505.11100463184323, 529.1084522579466, 6967.499650426472, 7415.1843297237265, 7534.54792712439, 7717.2282771722375, 7731.497452665559, 443.27967053538003, 459.30415420637763, 467.0006186760336, 472.78724573941867, 477.36748807829764, 3376.7636265461674, 3482.529858469074, 3533.3286675531567, 3561.198730285665, 3581.247937933011, 54261.1860822088, 66525.0, 96409.0, 101241.49379253057, 101916.49041754892, 78989.60505197552, 79974.0, 82606.0, 83481.0, 85708.0, 71059.2894071063, 73191.26808731844, 74730.62634686792, 77453.0, 79092.0, 6359.777407790705, 6425.209126615133, 6491.707873145814, 6631.1048008520165, 6836.179658441019, 40829.38755918723, 41281.793591031856, 41395.379069314586, 41504.58495415007, 44200.77899610481, 55248.72375638096, 58347.70826145842, 59850.401495984486, 63057.36942630515, 64332.67833660802, 9440.197583205505, 9585.856212156683, 9693.515324233902, 9722.222222222346, 9967.302288839712, 10765.89234107649, 11440.71398215018, 11543.422828858356, 11599.014083802971, 11985.880141198477, 10792.406417647106, 11194.776104477702, 11205.215634905479, 11608.6517404478, 12326.75346493083, 10661.680149595524, 10952.069074128789, 11246.1565382595, 11401.885981140082, 12069.818952715541, 10844.783104338027, 10911.727206819893, 11518.424078796193, 11585.710357241136, 12252.203606765532, 9478.763030924281, 9623.374480658735, 9960.900390995997, 10044.792333219384, 10138.543765530421, 8871.911280887109, 9477.0, 10239.897601023895, 10260.640877569249, 10341.121004714683], "value": 5930.672936497614, "unit": "score"}], "name": "dromaeo_css", "value": 6179.486961430632, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 116.0, 115.0, 113.0, 113.0, 115.0, 112.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 135.0, 171.0, 127.0, 128.0, 126.0, 131.0, 171.0, 126.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 164.0, 163.0, 162.0, 162.0, 161.0, 174.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 117.0, 79.0, 77.0, 76.0, 76.0, 111.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 117.0, 85.0, 84.0, 83.0, 111.0, 83.0, 83.0, 115.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 69.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 87.0, 83.0, 86.0, 90.0, 82.0, 93.0, 83.0, 83.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 138.0, 139.0, 136.0, 136.0, 140.0, 135.0, 167.0, 138.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 174.0, 175.0, 175.0, 176.0, 187.0, 173.0, 174.0, 176.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 70.0, 70.0, 69.0, 70.0, 71.0, 71.0, 73.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1558.7, "alertThreshold": 2.0}]} 01:21:41 INFO - Return code: 0 01:21:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:21:41 INFO - # TBPL SUCCESS # 01:21:41 INFO - Running post-action listener: _resource_record_post_action 01:21:41 INFO - [mozharness: 2016-10-01 08:21:41.915761Z] Finished run-tests step (success) 01:21:41 INFO - Running post-run listener: _resource_record_post_run 01:21:41 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401518592; Read time: 8; Write time: 346300 01:21:41 INFO - TinderboxPrint: CPU usage
13.0% 01:21:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:21:41 INFO - TinderboxPrint: I/O write bytes / time
401,518,592 / 346,300 01:21:41 INFO - TinderboxPrint: CPU idle
8,355.1 (87.0%) 01:21:41 INFO - TinderboxPrint: CPU user
1,202.7 (12.5%) 01:21:41 INFO - TinderboxPrint: Swap in / out
0 / 0 01:21:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110542848; Read time: 0; Write time: 78048 01:21:42 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290975744; Read time: 0; Write time: 268252 01:21:42 INFO - Running post-run listener: _upload_blobber_files 01:21:42 INFO - Blob upload gear active. 01:21:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:21:42 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 01:21:42 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'] 01:21:42 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 01:21:42 INFO - (blobuploader) - INFO - Open directory for files ... 01:21:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:21:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:21:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:43 INFO - (blobuploader) - INFO - Done attempting. 01:21:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:21:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:21:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:44 INFO - (blobuploader) - INFO - Done attempting. 01:21:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:21:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:49 INFO - (blobuploader) - INFO - Done attempting. 01:21:49 INFO - (blobuploader) - INFO - Iteration through files over. 01:21:49 INFO - Return code: 0 01:21:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:21:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:21:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b518af7740e2ac03a98e44726c9524c022ccb9ab2413f2e952bfb11414f5e7ebbac8b242d76383ba74f53a4dfe8bfdd893cd6cec207499a2e809571f1c948f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/826f1d18c6341159652e7b5a9c9d0c7834dbb59cd457a84f8e3137e56bdfcade5740fe320e13fe41f1d757a12c36cdd18339a0b60b5f5d7ca391cb2c56b6dd7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4eb60a66e48e0df442b5a368c5eb6ae575fb47023e4841f9309fb8534da8f15a7153f105e43c8af52c1fdb00c853bd97ca0398805946e7362b9fb28d560b7f"} 01:21:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:21:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:21:49 INFO - Contents: 01:21:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b518af7740e2ac03a98e44726c9524c022ccb9ab2413f2e952bfb11414f5e7ebbac8b242d76383ba74f53a4dfe8bfdd893cd6cec207499a2e809571f1c948f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/826f1d18c6341159652e7b5a9c9d0c7834dbb59cd457a84f8e3137e56bdfcade5740fe320e13fe41f1d757a12c36cdd18339a0b60b5f5d7ca391cb2c56b6dd7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4eb60a66e48e0df442b5a368c5eb6ae575fb47023e4841f9309fb8534da8f15a7153f105e43c8af52c1fdb00c853bd97ca0398805946e7362b9fb28d560b7f"} 01:21:49 INFO - Running post-run listener: copy_logs_to_upload_dir 01:21:49 INFO - Copying logs to upload dir... 01:21:49 INFO - mkdir: /builds/slave/test/build/upload/logs 01:21:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.318843 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-01 01:21:48.490067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 01:21:48.493700) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316 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/b518af7740e2ac03a98e44726c9524c022ccb9ab2413f2e952bfb11414f5e7ebbac8b242d76383ba74f53a4dfe8bfdd893cd6cec207499a2e809571f1c948f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/826f1d18c6341159652e7b5a9c9d0c7834dbb59cd457a84f8e3137e56bdfcade5740fe320e13fe41f1d757a12c36cdd18339a0b60b5f5d7ca391cb2c56b6dd7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4eb60a66e48e0df442b5a368c5eb6ae575fb47023e4841f9309fb8534da8f15a7153f105e43c8af52c1fdb00c853bd97ca0398805946e7362b9fb28d560b7f"} build_url:https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/DCJabm75THWRU0hI6HVqFg/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/b518af7740e2ac03a98e44726c9524c022ccb9ab2413f2e952bfb11414f5e7ebbac8b242d76383ba74f53a4dfe8bfdd893cd6cec207499a2e809571f1c948f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/826f1d18c6341159652e7b5a9c9d0c7834dbb59cd457a84f8e3137e56bdfcade5740fe320e13fe41f1d757a12c36cdd18339a0b60b5f5d7ca391cb2c56b6dd7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4eb60a66e48e0df442b5a368c5eb6ae575fb47023e4841f9309fb8534da8f15a7153f105e43c8af52c1fdb00c853bd97ca0398805946e7362b9fb28d560b7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 01:21:48.523209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:21:48.523572) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475308761.642298-1680905316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:21:48.606278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 01:21:48.606600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 01:21:48.606912) ========= ========= Total master_lag: 0.17 =========