builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1475530310.81 results: success (0) buildid: 20161003131557 builduid: 088bdbae1413404abd8ebc5312e5bcd1 revision: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.807942) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.808451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.808779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.825448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.825822) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 14:31:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.8M=0s 2016-10-03 14:31:51 (35.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.934409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.934760) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.985080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:50.985758) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 --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 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 --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=14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 14:31:51,467 truncating revision to first 12 chars 2016-10-03 14:31:51,467 Setting DEBUG logging. 2016-10-03 14:31:51,467 attempt 1/10 2016-10-03 14:31:51,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8db4b1b5dfae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 14:31:51,775 unpacking tar archive at: fx-team-8db4b1b5dfae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:51.664459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:51.665057) ========= script_repo_revision: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:51.665866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:51.666427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 14:31:51.678216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 14:31:51.678641) ========= /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=14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:52 INFO - MultiFileLogger online at 20161003 14:31:52 in /builds/slave/test 14:31:52 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 14:31:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:52 INFO - {'append_to_log': False, 14:31:52 INFO - 'base_work_dir': '/builds/slave/test', 14:31:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:31:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:52 INFO - 'branch': 'Fx-Team-Non-PGO', 14:31:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:52 INFO - 'config_files': ('talos/linux_config.py',), 14:31:52 INFO - 'default_actions': ('clobber', 14:31:52 INFO - 'read-buildbot-config', 14:31:52 INFO - 'download-and-extract', 14:31:52 INFO - 'populate-webroot', 14:31:52 INFO - 'create-virtualenv', 14:31:52 INFO - 'install', 14:31:52 INFO - 'run-tests'), 14:31:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:52 INFO - 'download_minidump_stackwalk': True, 14:31:52 INFO - 'download_symbols': 'ondemand', 14:31:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:52 INFO - 'installer_path': 'installer.exe', 14:31:52 INFO - 'log_level': 'info', 14:31:52 INFO - 'log_name': 'talos', 14:31:52 INFO - 'log_to_console': True, 14:31:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:52 INFO - 'opt_config_files': (), 14:31:52 INFO - 'pip_index': False, 14:31:52 INFO - 'sps_profile': False, 14:31:52 INFO - 'sps_profile_interval': 0, 14:31:52 INFO - 'suite': 'dromaeojs', 14:31:52 INFO - 'system_bits': '32', 14:31:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:52 INFO - 'title': 'talos-linux64-ix-036', 14:31:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:52 INFO - 'use_talos_json': True, 14:31:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:52 INFO - 'work_dir': 'build'} 14:31:52 INFO - [mozharness: 2016-10-03 21:31:52.259157Z] Running clobber step. 14:31:52 INFO - Running pre-action listener: _resource_record_pre_action 14:31:52 INFO - Running main action method: clobber 14:31:52 INFO - rmtree: /builds/slave/test/build 14:31:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:53 INFO - Running post-action listener: _resource_record_post_action 14:31:53 INFO - [mozharness: 2016-10-03 21:31:53.263842Z] Finished clobber step (success) 14:31:53 INFO - [mozharness: 2016-10-03 21:31:53.263941Z] Running read-buildbot-config step. 14:31:53 INFO - Running pre-action listener: _resource_record_pre_action 14:31:53 INFO - Running main action method: read_buildbot_config 14:31:53 INFO - Using buildbot properties: 14:31:53 INFO - { 14:31:53 INFO - "project": "", 14:31:53 INFO - "product": "firefox", 14:31:53 INFO - "script_repo_revision": "production", 14:31:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:31:53 INFO - "repository": "", 14:31:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:31:53 INFO - "buildid": "20161003131557", 14:31:53 INFO - "pgo_build": "False", 14:31:53 INFO - "basedir": "/builds/slave/test", 14:31:53 INFO - "buildnumber": 2189, 14:31:53 INFO - "slavename": "talos-linux64-ix-036", 14:31:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:31:53 INFO - "platform": "ubuntu64_hw", 14:31:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:31:53 INFO - "branch": "fx-team", 14:31:53 INFO - "repo_path": "integration/fx-team", 14:31:53 INFO - "revision": "8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9", 14:31:53 INFO - "stage_platform": "linux64", 14:31:53 INFO - "builduid": "088bdbae1413404abd8ebc5312e5bcd1", 14:31:53 INFO - "slavebuilddir": "test" 14:31:53 INFO - } 14:31:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:31:53 INFO - Running post-action listener: _resource_record_post_action 14:31:53 INFO - [mozharness: 2016-10-03 21:31:53.266360Z] Finished read-buildbot-config step (success) 14:31:53 INFO - [mozharness: 2016-10-03 21:31:53.266448Z] Running download-and-extract step. 14:31:53 INFO - Running pre-action listener: _resource_record_pre_action 14:31:53 INFO - Running main action method: download_and_extract 14:31:53 INFO - mkdir: /builds/slave/test/build/tests 14:31: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')]} 14:31:53 INFO - trying https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/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 14:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/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 14:31:53 INFO - Downloaded 1361 bytes. 14:31:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:31:53 INFO - Using the following test package requirements: 14:31:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:31:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'jsshell-linux-x86_64.zip'], 14:31:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:31:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:31:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:53 INFO - Fetch https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:31:54 INFO - Http code: 200 14:31:54 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 14:31:54 INFO - x-amz-cf-id: dBvahrhFHx7irdeBs5tR7FZtOQPp1INj9xDeP_VYU02zmAViTVmFHA== 14:31:54 INFO - x-amz-version-id: kN_muVH5WQOTBLynmBtZhiIhbaQPSJv8 14:31:54 INFO - Expected file size: 20419996 14:31:54 INFO - Obtained file size: 20419996 14:31:58 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 14:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:31:59 INFO - Http code: 200 14:31:59 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 14:31:59 INFO - x-amz-cf-id: aUIlwlNniZeCKankxx7NB48MF3n5ogipOMTQJBSuOM62bJ-g4Hiddg== 14:31:59 INFO - x-amz-version-id: kN_muVH5WQOTBLynmBtZhiIhbaQPSJv8 14:31:59 INFO - Expected file size: 20419996 14:31:59 INFO - Obtained file size: 20419996 14:32:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:32:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:32:03 INFO - Fetch https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:32:04 INFO - Http code: 200 14:32:04 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 14:32:04 INFO - x-amz-cf-id: -u5Yqow_4v4J_HwzbxWDooHvIWQG1VQA8suDlt9Kui_LJ1tjAWUHSA== 14:32:04 INFO - x-amz-version-id: sDzWBeFMMz0f_p5TisQkPyXBqCaLNC7_ 14:32:05 INFO - Expected file size: 14409006 14:32:05 INFO - Obtained file size: 14409006 14:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:05 INFO - trying https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:32:05 INFO - Downloading https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/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 14:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/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 14:32:08 INFO - Downloaded 55822657 bytes. 14:32:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:32:08 INFO - mkdir: /builds/slave/test/properties 14:32:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:08 INFO - Contents: 14:32:08 INFO - build_url:https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:32:08 INFO - Running post-action listener: _resource_record_post_action 14:32:08 INFO - Running post-action listener: set_extra_try_arguments 14:32:08 INFO - [mozharness: 2016-10-03 21:32:08.844805Z] Finished download-and-extract step (success) 14:32:08 INFO - [mozharness: 2016-10-03 21:32:08.845033Z] Running populate-webroot step. 14:32:08 INFO - Running pre-action listener: _resource_record_pre_action 14:32:08 INFO - Running main action method: populate_webroot 14:32:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:08 INFO - '--tppagecycles', 14:32:08 INFO - '7'], 14:32:08 INFO - 'tests': ['tsvgm']}}, 14:32:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['damp', 'tps']}, 14:32:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'tests': ['damp', 'tps']}, 14:32:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['dromaeo_dom']}, 14:32:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['basic_compositor_video']}, 14:32:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['a11yr', 14:32:08 INFO - 'ts_paint', 14:32:08 INFO - 'tpaint', 14:32:08 INFO - 'sessionrestore', 14:32:08 INFO - 'sessionrestore_no_auto_restore', 14:32:08 INFO - 'tabpaint']}, 14:32:08 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:08 INFO - 'ts_paint', 14:32:08 INFO - 'tpaint', 14:32:08 INFO - 'sessionrestore', 14:32:08 INFO - 'sessionrestore_no_auto_restore', 14:32:08 INFO - 'tabpaint']}, 14:32:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:08 INFO - 'ts_paint', 14:32:08 INFO - 'tpaint', 14:32:08 INFO - 'sessionrestore', 14:32:08 INFO - 'sessionrestore_no_auto_restore', 14:32:08 INFO - 'tabpaint']}, 14:32:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:08 INFO - 'ts_paint', 14:32:08 INFO - 'tpaint', 14:32:08 INFO - 'sessionrestore', 14:32:08 INFO - 'sessionrestore_no_auto_restore', 14:32:08 INFO - 'tabpaint']}, 14:32:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['a11yr', 14:32:08 INFO - 'ts_paint', 14:32:08 INFO - 'tpaint', 14:32:08 INFO - 'sessionrestore', 14:32:08 INFO - 'sessionrestore_no_auto_restore', 14:32:08 INFO - 'tabpaint']}, 14:32:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['a11yr', 14:32:08 INFO - 'ts_paint', 14:32:08 INFO - 'tpaint', 14:32:08 INFO - 'sessionrestore', 14:32:08 INFO - 'sessionrestore_no_auto_restore', 14:32:08 INFO - 'tabpaint']}, 14:32:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['tsvgx', 14:32:08 INFO - 'tsvgr_opacity', 14:32:08 INFO - 'tart', 14:32:08 INFO - 'tscrollx', 14:32:08 INFO - 'cart']}, 14:32:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:08 INFO - 'tsvgr_opacity', 14:32:08 INFO - 'tart', 14:32:08 INFO - 'tscrollx', 14:32:08 INFO - 'cart']}, 14:32:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'talos_options': ['--disable-e10s'], 14:32:08 INFO - 'tests': ['tp5o']}, 14:32:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'tests': ['tp5o']}, 14:32:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'talos_options': ['--disable-e10s', 14:32:08 INFO - '--xperf_path', 14:32:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:08 INFO - 'tests': ['tp5n']}, 14:32:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:08 INFO - 'talos_options': ['--xperf_path', 14:32:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:08 INFO - 'tests': ['tp5n']}}, 14:32:08 INFO - 'talos.zip': {'path': '', 14:32:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:08 INFO - Running post-action listener: _resource_record_post_action 14:32:08 INFO - [mozharness: 2016-10-03 21:32:08.861903Z] Finished populate-webroot step (success) 14:32:08 INFO - [mozharness: 2016-10-03 21:32:08.861991Z] Running create-virtualenv step. 14:32:08 INFO - Running pre-action listener: _resource_record_pre_action 14:32:08 INFO - Running main action method: create_virtualenv 14:32:08 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:08 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 14:32:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:08 INFO - Using real prefix '/usr' 14:32:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:11 INFO - Installing pip.................done. 14:32:11 INFO - Return code: 0 14:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:32:11 INFO - Reading from file tmpfile_stdout 14:32:11 INFO - Output received: 14:32:11 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) 14:32:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:11 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')]} 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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')]} 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:11 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 14:32:11 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 14:32:11 INFO - Using env: {'DISPLAY': ':0', 14:32:11 INFO - 'HOME': '/home/cltbld', 14:32:11 INFO - 'LANG': 'en_US.UTF-8', 14:32:11 INFO - 'LANGUAGE': 'en_US:en', 14:32:11 INFO - 'LOGNAME': 'cltbld', 14:32:11 INFO - 'MAIL': '/var/mail/cltbld', 14:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:11 INFO - 'MOZ_NO_REMOTE': '1', 14:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:11 INFO - 'NO_EM_RESTART': '1', 14:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:11 INFO - 'PWD': '/builds/slave/test', 14:32:11 INFO - 'SHELL': '/bin/bash', 14:32:11 INFO - 'SHLVL': '1', 14:32:11 INFO - 'TERM': 'linux', 14:32:11 INFO - 'TMOUT': '86400', 14:32:11 INFO - 'USER': 'cltbld', 14:32:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:11 INFO - '_': '/tools/buildbot/bin/python'} 14:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:11 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 14:32:11 INFO - Cleaning up... 14:32:11 INFO - Return code: 0 14:32:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32:11 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')]} 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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')]} 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:11 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:11 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 14:32:11 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 14:32:11 INFO - Using env: {'DISPLAY': ':0', 14:32:11 INFO - 'HOME': '/home/cltbld', 14:32:11 INFO - 'LANG': 'en_US.UTF-8', 14:32:11 INFO - 'LANGUAGE': 'en_US:en', 14:32:11 INFO - 'LOGNAME': 'cltbld', 14:32:11 INFO - 'MAIL': '/var/mail/cltbld', 14:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:11 INFO - 'MOZ_NO_REMOTE': '1', 14:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:11 INFO - 'NO_EM_RESTART': '1', 14:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:11 INFO - 'PWD': '/builds/slave/test', 14:32:11 INFO - 'SHELL': '/bin/bash', 14:32:11 INFO - 'SHLVL': '1', 14:32:11 INFO - 'TERM': 'linux', 14:32:11 INFO - 'TMOUT': '86400', 14:32:11 INFO - 'USER': 'cltbld', 14:32:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:11 INFO - '_': '/tools/buildbot/bin/python'} 14:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:12 INFO - Downloading/unpacking psutil>=3.1.1 14:32:12 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 14:32:12 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 14:32:12 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 14:32:12 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 14:32:12 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 14:32:12 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 14:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:14 INFO - Installing collected packages: psutil 14:32:14 INFO - Running setup.py install for psutil 14:32:14 INFO - building 'psutil._psutil_linux' extension 14:32:14 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 14:32:14 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 14:32:14 INFO - building 'psutil._psutil_posix' extension 14:32:14 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 14:32:14 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 14:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:14 INFO - Successfully installed psutil 14:32:14 INFO - Cleaning up... 14:32:14 INFO - Return code: 0 14:32:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:32:14 INFO - Using env: {'DISPLAY': ':0', 14:32:14 INFO - 'HOME': '/home/cltbld', 14:32:14 INFO - 'LANG': 'en_US.UTF-8', 14:32:14 INFO - 'LANGUAGE': 'en_US:en', 14:32:14 INFO - 'LOGNAME': 'cltbld', 14:32:14 INFO - 'MAIL': '/var/mail/cltbld', 14:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:14 INFO - 'MOZ_NO_REMOTE': '1', 14:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:14 INFO - 'NO_EM_RESTART': '1', 14:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:14 INFO - 'PWD': '/builds/slave/test', 14:32:14 INFO - 'SHELL': '/bin/bash', 14:32:14 INFO - 'SHLVL': '1', 14:32:14 INFO - 'TERM': 'linux', 14:32:14 INFO - 'TMOUT': '86400', 14:32:14 INFO - 'USER': 'cltbld', 14:32:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:14 INFO - '_': '/tools/buildbot/bin/python'} 14:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32:14 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 14:32:14 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 14:32:14 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 14:32:14 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 14:32:14 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 14:32:14 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 14:32:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:32:16 INFO - Installing collected packages: mozsystemmonitor 14:32:16 INFO - Running setup.py install for mozsystemmonitor 14:32:16 INFO - Successfully installed mozsystemmonitor 14:32:16 INFO - Cleaning up... 14:32:16 INFO - Return code: 0 14:32:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:32:16 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')]} 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:16 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')]} 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:16 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:16 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 14:32:16 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 14:32:16 INFO - Using env: {'DISPLAY': ':0', 14:32:16 INFO - 'HOME': '/home/cltbld', 14:32:16 INFO - 'LANG': 'en_US.UTF-8', 14:32:16 INFO - 'LANGUAGE': 'en_US:en', 14:32:16 INFO - 'LOGNAME': 'cltbld', 14:32:16 INFO - 'MAIL': '/var/mail/cltbld', 14:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:16 INFO - 'MOZ_NO_REMOTE': '1', 14:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:16 INFO - 'NO_EM_RESTART': '1', 14:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:16 INFO - 'PWD': '/builds/slave/test', 14:32:16 INFO - 'SHELL': '/bin/bash', 14:32:16 INFO - 'SHLVL': '1', 14:32:16 INFO - 'TERM': 'linux', 14:32:16 INFO - 'TMOUT': '86400', 14:32:16 INFO - 'USER': 'cltbld', 14:32:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:16 INFO - '_': '/tools/buildbot/bin/python'} 14:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:17 INFO - Downloading/unpacking jsonschema==2.5.1 14:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:19 INFO - warning: no files found matching '*.txt' 14:32:19 INFO - no previously-included directories found matching 'build' 14:32:19 INFO - no previously-included directories found matching 'dist' 14:32:19 INFO - no previously-included directories found matching '.git*' 14:32:19 INFO - Installing collected packages: jsonschema, functools32 14:32:19 INFO - Running setup.py install for functools32 14:32:19 INFO - warning: no files found matching '*.txt' 14:32:19 INFO - no previously-included directories found matching 'build' 14:32:19 INFO - no previously-included directories found matching 'dist' 14:32:19 INFO - no previously-included directories found matching '.git*' 14:32:19 INFO - Successfully installed jsonschema functools32 14:32:19 INFO - Cleaning up... 14:32:19 INFO - Return code: 0 14:32:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:32:19 INFO - Using env: {'DISPLAY': ':0', 14:32:19 INFO - 'HOME': '/home/cltbld', 14:32:19 INFO - 'LANG': 'en_US.UTF-8', 14:32:19 INFO - 'LANGUAGE': 'en_US:en', 14:32:19 INFO - 'LOGNAME': 'cltbld', 14:32:19 INFO - 'MAIL': '/var/mail/cltbld', 14:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:19 INFO - 'MOZ_NO_REMOTE': '1', 14:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:19 INFO - 'NO_EM_RESTART': '1', 14:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:19 INFO - 'PWD': '/builds/slave/test', 14:32:19 INFO - 'SHELL': '/bin/bash', 14:32:19 INFO - 'SHLVL': '1', 14:32:19 INFO - 'TERM': 'linux', 14:32:19 INFO - 'TMOUT': '86400', 14:32:19 INFO - 'USER': 'cltbld', 14:32:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:19 INFO - '_': '/tools/buildbot/bin/python'} 14:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:32:19 INFO - Cleaning up... 14:32:19 INFO - Return code: 0 14:32:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:32:19 INFO - Using env: {'DISPLAY': ':0', 14:32:19 INFO - 'HOME': '/home/cltbld', 14:32:19 INFO - 'LANG': 'en_US.UTF-8', 14:32:19 INFO - 'LANGUAGE': 'en_US:en', 14:32:19 INFO - 'LOGNAME': 'cltbld', 14:32:19 INFO - 'MAIL': '/var/mail/cltbld', 14:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:19 INFO - 'MOZ_NO_REMOTE': '1', 14:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:19 INFO - 'NO_EM_RESTART': '1', 14:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:19 INFO - 'PWD': '/builds/slave/test', 14:32:19 INFO - 'SHELL': '/bin/bash', 14:32:19 INFO - 'SHLVL': '1', 14:32:19 INFO - 'TERM': 'linux', 14:32:19 INFO - 'TMOUT': '86400', 14:32:19 INFO - 'USER': 'cltbld', 14:32:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:19 INFO - '_': '/tools/buildbot/bin/python'} 14:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:22 INFO - Downloading docopt-0.6.1.tar.gz 14:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:22 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:22 INFO - Running setup.py install for blobuploader 14:32:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:22 INFO - Running setup.py install for requests 14:32:23 INFO - Running setup.py install for docopt 14:32:23 INFO - Successfully installed blobuploader requests docopt 14:32:23 INFO - Cleaning up... 14:32:23 INFO - Return code: 0 14:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:23 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:23 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 14:32:23 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 14:32:23 INFO - Using env: {'DISPLAY': ':0', 14:32:23 INFO - 'HOME': '/home/cltbld', 14:32:23 INFO - 'LANG': 'en_US.UTF-8', 14:32:23 INFO - 'LANGUAGE': 'en_US:en', 14:32:23 INFO - 'LOGNAME': 'cltbld', 14:32:23 INFO - 'MAIL': '/var/mail/cltbld', 14:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:23 INFO - 'MOZ_NO_REMOTE': '1', 14:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:23 INFO - 'NO_EM_RESTART': '1', 14:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:23 INFO - 'PWD': '/builds/slave/test', 14:32:23 INFO - 'SHELL': '/bin/bash', 14:32:23 INFO - 'SHLVL': '1', 14:32:23 INFO - 'TERM': 'linux', 14:32:23 INFO - 'TMOUT': '86400', 14:32:23 INFO - 'USER': 'cltbld', 14:32:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:23 INFO - '_': '/tools/buildbot/bin/python'} 14:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:23 INFO - Running setup.py (path:/tmp/pip-5xbee7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:23 INFO - Running setup.py (path:/tmp/pip-DMjePM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:23 INFO - Running setup.py (path:/tmp/pip-RCgDQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:23 INFO - Running setup.py (path:/tmp/pip-rFZsjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:23 INFO - Running setup.py (path:/tmp/pip-MZZHKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:23 INFO - Running setup.py (path:/tmp/pip-hkiT88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:23 INFO - Running setup.py (path:/tmp/pip-exPIww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:23 INFO - Running setup.py (path:/tmp/pip-FFkjGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:24 INFO - Running setup.py (path:/tmp/pip-BbA9AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:24 INFO - Running setup.py (path:/tmp/pip-ryCiFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:24 INFO - Running setup.py (path:/tmp/pip-EIvn6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:24 INFO - Running setup.py (path:/tmp/pip-wpWeEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:24 INFO - Running setup.py (path:/tmp/pip-L1etA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:24 INFO - Running setup.py (path:/tmp/pip-kA78c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:24 INFO - Running setup.py (path:/tmp/pip-UdpRuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:24 INFO - Running setup.py (path:/tmp/pip-3gHqu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:24 INFO - Running setup.py (path:/tmp/pip-UXxAmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:24 INFO - Running setup.py install for manifestparser 14:32:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:24 INFO - Running setup.py install for mozcrash 14:32:24 INFO - Running setup.py install for mozdebug 14:32:24 INFO - Running setup.py install for mozdevice 14:32:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Running setup.py install for mozfile 14:32:25 INFO - Running setup.py install for mozhttpd 14:32:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Running setup.py install for mozinfo 14:32:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Running setup.py install for mozInstall 14:32:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Running setup.py install for mozleak 14:32:25 INFO - Running setup.py install for mozlog 14:32:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Running setup.py install for moznetwork 14:32:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:25 INFO - Running setup.py install for mozprocess 14:32:25 INFO - Running setup.py install for mozprofile 14:32:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:26 INFO - Running setup.py install for mozrunner 14:32:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:26 INFO - Running setup.py install for mozscreenshot 14:32:26 INFO - Running setup.py install for moztest 14:32:26 INFO - Running setup.py install for mozversion 14:32:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:26 INFO - Cleaning up... 14:32:26 INFO - Return code: 0 14:32:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:26 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:26 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 14:32:26 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 14:32:26 INFO - Using env: {'DISPLAY': ':0', 14:32:26 INFO - 'HOME': '/home/cltbld', 14:32:26 INFO - 'LANG': 'en_US.UTF-8', 14:32:26 INFO - 'LANGUAGE': 'en_US:en', 14:32:26 INFO - 'LOGNAME': 'cltbld', 14:32:26 INFO - 'MAIL': '/var/mail/cltbld', 14:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:26 INFO - 'MOZ_NO_REMOTE': '1', 14:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:26 INFO - 'NO_EM_RESTART': '1', 14:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:26 INFO - 'PWD': '/builds/slave/test', 14:32:26 INFO - 'SHELL': '/bin/bash', 14:32:26 INFO - 'SHLVL': '1', 14:32:26 INFO - 'TERM': 'linux', 14:32:26 INFO - 'TMOUT': '86400', 14:32:26 INFO - 'USER': 'cltbld', 14:32:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:26 INFO - '_': '/tools/buildbot/bin/python'} 14:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:26 INFO - Running setup.py (path:/tmp/pip-QESwBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:26 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)) 14:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:26 INFO - Running setup.py (path:/tmp/pip-NaBEa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:26 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)) 14:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:26 INFO - Running setup.py (path:/tmp/pip-SIBjuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:26 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)) 14:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:26 INFO - Running setup.py (path:/tmp/pip-uxHQ3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:27 INFO - Running setup.py (path:/tmp/pip-C5IJqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:27 INFO - Running setup.py (path:/tmp/pip-wFpJHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:27 INFO - Running setup.py (path:/tmp/pip-OPJIty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:27 INFO - Running setup.py (path:/tmp/pip-B5UKNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:27 INFO - Running setup.py (path:/tmp/pip-GF0paT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:27 INFO - Running setup.py (path:/tmp/pip-1BdNjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:27 INFO - Running setup.py (path:/tmp/pip-B2DfUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:27 INFO - Running setup.py (path:/tmp/pip-CNA1js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:27 INFO - Running setup.py (path:/tmp/pip-iSWsug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:27 INFO - Running setup.py (path:/tmp/pip-EJ0ZhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:27 INFO - Running setup.py (path:/tmp/pip-j9jkne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:27 INFO - Running setup.py (path:/tmp/pip-vPBSuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:27 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)) 14:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:27 INFO - Running setup.py (path:/tmp/pip-znFQWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:29 INFO - Downloading blessings-1.6.tar.gz 14:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:29 INFO - Installing collected packages: blessings 14:32:29 INFO - Running setup.py install for blessings 14:32:30 INFO - Successfully installed blessings 14:32:30 INFO - Cleaning up... 14:32:30 INFO - Return code: 0 14:32:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:30 INFO - Reading from file tmpfile_stdout 14:32:30 INFO - Current package versions: 14:32:30 INFO - argparse == 1.2.1 14:32:30 INFO - blessings == 1.6 14:32:30 INFO - blobuploader == 1.2.4 14:32:30 INFO - docopt == 0.6.1 14:32:30 INFO - functools32 == 3.2.3-2 14:32:30 INFO - jsonschema == 2.5.1 14:32:30 INFO - manifestparser == 1.1 14:32:30 INFO - mozInstall == 1.12 14:32:30 INFO - mozcrash == 0.17 14:32:30 INFO - mozdebug == 0.1 14:32:30 INFO - mozdevice == 0.48 14:32:30 INFO - mozfile == 1.2 14:32:30 INFO - mozhttpd == 0.7 14:32:30 INFO - mozinfo == 0.9 14:32:30 INFO - mozleak == 0.1 14:32:30 INFO - mozlog == 3.4 14:32:30 INFO - moznetwork == 0.27 14:32:30 INFO - mozprocess == 0.23 14:32:30 INFO - mozprofile == 0.28 14:32:30 INFO - mozrunner == 6.12 14:32:30 INFO - mozscreenshot == 0.1 14:32:30 INFO - mozsystemmonitor == 0.3 14:32:30 INFO - moztest == 0.7 14:32:30 INFO - mozversion == 1.4 14:32:30 INFO - psutil == 3.1.1 14:32:30 INFO - requests == 1.2.3 14:32:30 INFO - wsgiref == 0.1.2 14:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:30 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:30 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 14:32:30 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 14:32:30 INFO - Using env: {'DISPLAY': ':0', 14:32:30 INFO - 'HOME': '/home/cltbld', 14:32:30 INFO - 'LANG': 'en_US.UTF-8', 14:32:30 INFO - 'LANGUAGE': 'en_US:en', 14:32:30 INFO - 'LOGNAME': 'cltbld', 14:32:30 INFO - 'MAIL': '/var/mail/cltbld', 14:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:30 INFO - 'MOZ_NO_REMOTE': '1', 14:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:30 INFO - 'NO_EM_RESTART': '1', 14:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:30 INFO - 'PWD': '/builds/slave/test', 14:32:30 INFO - 'SHELL': '/bin/bash', 14:32:30 INFO - 'SHLVL': '1', 14:32:30 INFO - 'TERM': 'linux', 14:32:30 INFO - 'TMOUT': '86400', 14:32:30 INFO - 'USER': 'cltbld', 14:32:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:30 INFO - '_': '/tools/buildbot/bin/python'} 14:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 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)) 14:32:30 INFO - Cleaning up... 14:32:30 INFO - Return code: 0 14:32:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:30 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 0x7fe707e31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', '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 14:32:30 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 14:32:30 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 14:32:30 INFO - Using env: {'DISPLAY': ':0', 14:32:30 INFO - 'HOME': '/home/cltbld', 14:32:30 INFO - 'LANG': 'en_US.UTF-8', 14:32:30 INFO - 'LANGUAGE': 'en_US:en', 14:32:30 INFO - 'LOGNAME': 'cltbld', 14:32:30 INFO - 'MAIL': '/var/mail/cltbld', 14:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:30 INFO - 'MOZ_NO_REMOTE': '1', 14:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:30 INFO - 'NO_EM_RESTART': '1', 14:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:30 INFO - 'PWD': '/builds/slave/test', 14:32:30 INFO - 'SHELL': '/bin/bash', 14:32:30 INFO - 'SHLVL': '1', 14:32:30 INFO - 'TERM': 'linux', 14:32:30 INFO - 'TMOUT': '86400', 14:32:30 INFO - 'USER': 'cltbld', 14:32:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:30 INFO - '_': '/tools/buildbot/bin/python'} 14:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:32:30 INFO - Cleaning up... 14:32:30 INFO - Return code: 0 14:32:30 INFO - Running post-action listener: _resource_record_post_action 14:32:30 INFO - Running post-action listener: _start_resource_monitoring 14:32:30 INFO - Starting resource monitoring. 14:32:30 INFO - [mozharness: 2016-10-03 21:32:30.839046Z] Finished create-virtualenv step (success) 14:32:30 INFO - [mozharness: 2016-10-03 21:32:30.839548Z] Running install step. 14:32:30 INFO - Running pre-action listener: _resource_record_pre_action 14:32:30 INFO - Running main action method: install 14:32:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:31 INFO - Reading from file tmpfile_stdout 14:32:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:31 INFO - Reading from file tmpfile_stdout 14:32:31 INFO - Output received: 14:32:31 INFO - Usage: mozinstall [options] installer 14:32:31 INFO - Options: 14:32:31 INFO - -h, --help show this help message and exit 14:32:31 INFO - -d DEST, --destination=DEST 14:32:31 INFO - Directory to install application into. [default: 14:32:31 INFO - "/builds/slave/test"] 14:32:31 INFO - --app=APP Application being installed. [default: firefox] 14:32:31 INFO - mkdir: /builds/slave/test/build/application 14:32:31 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'] 14:32:31 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 14:32:47 INFO - Reading from file tmpfile_stdout 14:32:47 INFO - Output received: 14:32:47 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:47 INFO - Running post-action listener: _resource_record_post_action 14:32:47 INFO - [mozharness: 2016-10-03 21:32:47.277504Z] Finished install step (success) 14:32:47 INFO - [mozharness: 2016-10-03 21:32:47.277750Z] Running run-tests step. 14:32:47 INFO - Running pre-action listener: _resource_record_pre_action 14:32:47 INFO - Running main action method: run_tests 14:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:47 INFO - Python 2.7.3 14:32:47 INFO - Return code: 0 14:32:47 INFO - grabbing minidump binary from tooltool 14:32:47 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')]} 14:32:47 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 0x111ef60>, '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 0x111fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11201d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:47 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 14:32:47 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 14:32:47 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 14:32:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:47 INFO - Return code: 0 14:32:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:47 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/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 14:32:47 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/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 14:32:47 INFO - Using env: {'DISPLAY': ':0', 14:32:47 INFO - 'HOME': '/home/cltbld', 14:32:47 INFO - 'LANG': 'en_US.UTF-8', 14:32:47 INFO - 'LANGUAGE': 'en_US:en', 14:32:47 INFO - 'LOGNAME': 'cltbld', 14:32:47 INFO - 'MAIL': '/var/mail/cltbld', 14:32:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:47 INFO - 'MOZ_NO_REMOTE': '1', 14:32:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:47 INFO - 'NO_EM_RESTART': '1', 14:32:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:47 INFO - 'PWD': '/builds/slave/test', 14:32:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:47 INFO - 'SHELL': '/bin/bash', 14:32:47 INFO - 'SHLVL': '1', 14:32:47 INFO - 'TERM': 'linux', 14:32:47 INFO - 'TMOUT': '86400', 14:32:47 INFO - 'USER': 'cltbld', 14:32:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076', 14:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:47 INFO - '_': '/tools/buildbot/bin/python'} 14:32:47 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/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 14:32:47 INFO - mozversion application_buildid: 20161003131557 14:32:47 INFO - mozversion application_changeset: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 14:32:47 INFO - mozversion application_display_name: Nightly 14:32:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:47 INFO - mozversion application_name: Firefox 14:32:47 INFO - mozversion application_remotingname: firefox 14:32:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:32:47 INFO - mozversion application_vendor: Mozilla 14:32:47 INFO - mozversion application_version: 52.0a1 14:32:47 INFO - mozversion platform_buildid: 20161003131557 14:32:47 INFO - mozversion platform_changeset: 8db4b1b5dfae11b9681a85373de5dcc0d9cdc7b9 14:32:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:32:47 INFO - mozversion platform_version: 52.0a1 14:32:47 INFO - using testdate: 1475530367 14:32:47 INFO - actual date: 1475530367 14:32:47 INFO - starting webserver on 'localhost:53574' 14:32:47 INFO - SUITE-START | Running 2 tests 14:32:47 INFO - TEST-START | dromaeo_css 14:32:47 INFO - operating with platform_type : linux_ 14:32:47 INFO - Initialising browser for dromaeo_css test... 14:32:47 INFO - TEST-INFO | started process 25627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdhAJik/profile http://localhost:53574/getInfo.html) 14:32:52 INFO - PROCESS | 25627 | __metrics Screen width/height:1600/1200 14:32:52 INFO - PROCESS | 25627 | colorDepth:24 14:32:52 INFO - PROCESS | 25627 | Browser inner width/height: 1024/697 14:32:52 INFO - PROCESS | 25627 | __metrics 14:32:52 INFO - PROCESS | 25627 | 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" 14:32:52 INFO - PROCESS | 25627 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:32:53 INFO - PROCESS | 25627 | console.error: PushService: 14:32:53 INFO - PROCESS | 25627 | stateChangeProcessEnqueue: Error transitioning state 14:32:53 INFO - PROCESS | 25627 | UnknownError 14:32:54 INFO - TEST-INFO | 25627: exit 0 14:32:54 INFO - Browser initialized. 14:32:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:54 INFO - TEST-INFO | started process 25709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdhAJik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:06 INFO - PROCESS | 25709 | RSS: Main: 175648768 14:33:06 INFO - PROCESS | 25709 | 14:33:57 INFO - PROCESS | 25709 | 1475530437707 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] 14:36:12 INFO - PROCESS | 25709 | Cycle 1(1): loaded http://localhost:53574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53574/tests/dromaeo/cssquery-ext.html) 14:36:13 INFO - PROCESS | 25709 | RSS: Main: 300142592 14:36:13 INFO - PROCESS | 25709 | 14:39:16 INFO - PROCESS | 25709 | Cycle 1(1): loaded http://localhost:53574/tests/dromaeo/cssquery-ext.html (next: http://localhost:53574/tests/dromaeo/cssquery-jquery.html) 14:39:17 INFO - PROCESS | 25709 | RSS: Main: 285450240 14:39:17 INFO - PROCESS | 25709 | 14:42:19 INFO - PROCESS | 25709 | Cycle 1(1): loaded http://localhost:53574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53574/tests/dromaeo/cssquery-mootools.html) 14:42:20 INFO - PROCESS | 25709 | RSS: Main: 223199232 14:42:20 INFO - PROCESS | 25709 | 14:45:22 INFO - PROCESS | 25709 | Cycle 1(1): loaded http://localhost:53574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53574/tests/dromaeo/cssquery-prototype.html) 14:45:23 INFO - PROCESS | 25709 | RSS: Main: 221024256 14:45:23 INFO - PROCESS | 25709 | 14:48:26 INFO - PROCESS | 25709 | Cycle 1(1): loaded http://localhost:53574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53574/tests/dromaeo/cssquery-yui.html) 14:48:26 INFO - PROCESS | 25709 | RSS: Main: 220504064 14:48:26 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | Cycle 1(1): loaded http://localhost:53574/tests/dromaeo/cssquery-yui.html (next: http://localhost:53574/tests/dromaeo/cssquery-dojo.html) 14:51:29 INFO - PROCESS | 25709 | RSS: Main: 312938496 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | __start_tp_report 14:51:29 INFO - PROCESS | 25709 | _x_x_mozilla_page_load 14:51:29 INFO - PROCESS | 25709 | _x_x_mozilla_page_load_details 14:51:29 INFO - PROCESS | 25709 | |i|pagename|runs| 14:51:29 INFO - PROCESS | 25709 | |0;dojo.html;2568.833025853319;2602.29737970748;2634.6970098438674;2645.1667724666727;2649.324422272319;4509.098180363924;4568.565986231302;4658.27796691513;4718.551737584929;4731.077439899217;4642.094791515656;4708.764561771906;4748;4756.619470442365;4835.540623640757;4290.506591741942;4317.676174286941;4354.216241076605;4376.19040477511;4385.188740083079;4400;4462.620677242422;4468.97765511172;4471.105778844228;4492.775361231926;4425.889352766175;4454.042380888109;4474.395956545857;4486.798094085774;4511.187986162489;4209.221294060609;4257.957420425787;4259.51015633203;4305.31115021595;4316.654667626613;4293.5706429356815;4306.095719898825;4360.694751367406;4388.71473354231;4418.491873434564;4653.464851542082;4717.528247175289;4753.453352864396;4763.047390521875;4824.734639594821;5095.082885080684;5117;5130.897382052375;5134.127198376285;5193.143131383317;4949.232868905326;4973.950260497385;4985.302057711923;4992.950070499285;5011.072951503984;4674.11191873543;4684.95315046852;4686.859394218179;4690.554397332248;4735.2186889163595;5187.0922588546855;5193.272941788153;5193.870153246199;5199.194124910645;5259.605529585297;4733.881652958704;4807.663463557517;4811.615070794328;4845.297431872359;4862.78117484714;5041.1430056889685;5047.9495205048215;5051.292819005343;5055.039542486916;5059.342285502935;4946.1344264753525;4960.528749768766;5003.4746351633285;5006.549410552995;5007.924881126786;4993.725345106054;5003.949960500421;5064.392272927273;5067.214581739836;5071.036503064406;4232.153569286155;4233.25917964355;4234.237837189336;4235.0682849773;4295.076558539929;3660.871869484555;3725.5715592706642;3769.962300377016;3770.434434834797;3775.339315619756;4248.4477017987465;4275.315949448073;4299.398084268205;4311.461067366579;4312.849050283225;5068.163752980717;5071.594272458195;5071.670341427795;5078.4667609900425;5131.281620573122;4300.569943005675;4327.76197309151;4334.241507736134;4379.167958087953;4385.254506733863;4417.690761646718;4456.309272062836;4486.887827804331;4521.502634710179;4532.864014079583;4837;4874.53691899269;4887.047025829929;4896.11869863428;4898.632602554751;5138.4604616514725;5151.742412879266;5152.149895267239;5156.40701319338;5215.2698622192165;4677.76611169447;4811.7834697438;4826.155422800925;4831.758412079453;4882.804687812448;4947.233178857283;4951.876203094951;4963.305137280856;5024.698518088926;5037;5073.797048118034;5078.390593128701;5079.87300317495;5084.440711521804;5129.102407078821;4952.133376659142;4952.455229924633;4953.405591329064;4955.776990035529;4963.181075122564;4858.562729354375;4872.196087645499;4924.01519696055;4931.0630980113665;4974.204127339608;4901.362822833009;4908.607311415007;4909.582685471775;4912.852614421573;4943.555080042814;4963.280324352876;4995.875103122451;5006.849794506171;5023.2214006829;5075.162598171408;4722.008378240471;4776.761161941959;4777.928331074967;4835.903281934412;4970.776315065758 14:51:29 INFO - PROCESS | 25709 | |1;ext.html;570.6775671745463;576.5992635118592;582.6300299309939;583.3553922915181;590.2887021139526;27656.86171569142;38114.237715245676;39594;39764.801175994115;43056.35415468763;39331.606683933154;39513;39885.40171897424;39939.80030099845;39952.400713989315;5247.242173871758;5249.580033597303;5252.290940723011;5279.683219006863;5362.2224777407255;7575.166731659513;7638.236176382373;7657.310842024217;7661.885071723928;7671.501352412103;7664.540127592362;7710.421718371116;7717.65270562826;7720.961395193016;7724.150343462215;7668.693252269903;7690.961545192295;7711.845763084763;7712;7713.691452341927;7550.509216900939;7612.276833700789;7614.2766437188375;7616.923830761677;7621.23787621239;36419.81790091059;36654.63345366566;36782.816085919665;36800.263994720226;36819.263614727555;2799.7340252675963;2901.202169403431;2953.8375389353578;2960.8371539565314;3006.5941097951936;26999.32501687454;28430.431391372058;28459.715402845915;29225.561616575767;29252.853735731183;3387.1701433149037;3404.131946353664;3435.4503279475416;3590.1024743814046;3618.7285953553587;242227;243829;243967;243981;244220;30607;48779;49153.508464915605;49210.26184607234;49272.260916086285;31619.52570711441;33940.66059339375;33984.49023264653;34005;34027.82986085103;11729.530818767154;11883.58407455735;11903.404829758478;11910.642680719593;11912.106592005634;9273.350865439354;9355.766105847271;9372.67195648149;9377.906220937703;9385.57764900581;7773.844523109507;7795.80510487231;7818.218178182136;7882.921170788219;7930.048394192734;3049.969500305013;3083.969160308413;3109.5491153782573;3155.4162479941283;3187.7449804015623;855.6662901468433;907.6142639378238;946.6497395963399;968.4479846487435;982.577491678585;26300.342491437485;27898.16305510838;27941.720582794318;28167;28167.295817604725;789.4355535791822;886.259972922604;924.9768755781159;963.6675347005272;972.601233494264;11682.766344673058;14122.929385353007;14429.206393648241;14505.637359065897;14585.781213281596;371407;374047;374549;374756;376732;47741.761291193325;48314.5168548317;48353.75823120932;48401.757991209815;48401.757991209815;1072.9302595331278;1108.7449886526144;1127.2222166704948;1191.3507138609305;1194.8805119487981;26939.326516837235;28188.71811281861;28597.42805143927;29080.418391632473;29189.270268243465;40909.659002854605;41337.58662413337;41348;41403.7929810349;41418.37872431856;287470;289179;289204;356809;368002;37637.24725505529;38070.2385952285;38361;38522.22955540817;39001.2199756009;41861.79069104635;41919.7904010478;42203.3669494964;42588;43052;35274;35384.46923296101;35399;35530.822345888104;36266.8186659065;35787.28425431425;36009.459858101625;36590;36651.45022824713;36832.631673683994;34939.30121397608;34986.475202871465;35128;35401.645983539835;35536.46695299624;30515.847420762755;32261.354772903942;32403.161186544465;32522.674773251965;32545.837270813496;24678.506429870944;24734.752652473246;24856.254312370656;25346.493070138124;25357 14:51:29 INFO - PROCESS | 25709 | |2;jquery.html;344.93791117598823;363.220891188401;367.8326361505516;368.7271419149829;395.2569169960474;12182.69543261419;12241.34154355392;13715.245661488614;14060.859391406082;17267.481975540755;15271.770923436157;15547.22263886804;16619.66760664786;16734.912230704995;16802.075885826274;4891.290762839386;4943.4067911850625;4986.202207646777;5006.949930500685;5009.348784657989;3575.3206890690685;3754.8122593870335;4907.950920490803;4979.875503112433;4986.975065124688;5629.099344104944;5864.061750119981;5882.970585147068;5988.940110598882;6010.248718910137;5705.971470142665;5830.446107619811;5875.735591898375;5966.2840459144745;5975.342712301644;5171.818986335498;5172.27588137661;5174.611904107207;5174.7412629368755;5175.378954525481;16313.510594682179;20102.195912163497;20173.899130504255;20209.19163233469;20209.696854547194;1890.1210936914263;1896.6017136401372;1915.2817693364989;1980.3563841751345;2038.0930485933766;12072;12323.383830808514;12686.238825670396;12741.872581274161;13280;1696.2621259752048;1769.761759011802;1788.0523322638892;1842.797292297846;1848.0944337274773;49359.50640493585;58798.41201587972;64715;69585;72371.99999999948;9190.40262382943;9413.152816246571;9545.52272386378;9921.107100361001;9994.150497207673;12480.313582752855;12503.937480312541;12531.934785543332;12537.059720520998;12540;6473.255575608865;6538.313477084837;6665.800025999228;6773.6613169341335;6791.830204244835;6209.6895155242055;6338.239411270677;6475.158229430144;6507.8698426031215;6519;3816.5229346331707;3825.8660946866726;3955.7824319662695;3976.0258736609717;4183.3515805050265;1620.6272557311884;1682.4846853953418;1685.2584862660635;1692.9695844438563;1694.4498529712703;760.7869796457001;785.4972817396871;792.5007245435454;815.8490679224362;881.9603117859712;15861.286242119133;16499.340026399048;16603.750943735853;16804;17232.827671723375;837.0917554453365;844.1052484366469;857.1813917708698;861.7371701630938;870.7953630896734;8613.65545378178;9280.211182049467;9432.38689485195;9496.715098547054;9504.239660827117;346830;361058;364475;369050;369408;73049;75024.12246714125;76783.23216767873;77438.61280693673;77897;842.3135144856922;865.6277800545699;865.7229686500259;865.8354912566718;871.5642178910545;14418;14667.48663796762;14712.852871471148;14771.261436928326;15318.846811531743;35815.28369432649;36632.45051324179;36793;37700.24599507939;37766;49648;49687.25469117894;49903.500964989886;50550.494495054576;52649;6921.653917304014;7023.122109736283;7131.750388736369;7202.279772022755;7297.416206703345;10522.736931576772;10670.57317707283;10758.946205268923;10871.945640271748;11249.775004499701;9230.815383692423;9485.241180705389;9509.191718703987;9511.619535218513;9898.851517227104;9347.953260233655;9359.672411465566;9364.812703746024;9405.153536181777;9478.099580539838;9341.20599749029;9422.858657120012;9448.716538503855;9459.91881786006;9635.951820240854;6596.406323430914;6982.720691172296;7003.789886303419;7088.0785497884945;7145.9285407147345;7432.591207483641;9206.907930920604;9388.530573471437;9642.951785241028;9728.124468797841 14:51:29 INFO - PROCESS | 25709 | |3;mootools.html;1185.8458400407947;1346.959591212264;1383.481194552043;1441.4594527052354;1676.5054308978843;6812.931870681292;7673.769786906388;8017.238362355582;8018.558979256139;8202.548859812709;8052.879206811888;8106.270435660804;8110.716124935629;8113.148119447462;8113.391495637821;2154.946126346842;2180.443986783368;2181.236567201475;2183.475965768212;2183.650615901456;2116.502621883856;2163.372621939636;2205.9558808823813;2210.3258506155616;2216.26863135165;2141.764405915348;2160.2115227941767;2183.5632873425297;2191.627423338028;2198.6372248578964;2125.7555381131137;2132.9573408531896;2137.2092325839385;2139.0801955159277;2141.582391433671;2071.171531387442;2170.0777169702815;2170.9891450542805;2174.3694328644674;2186.6610675345346;7389.778306650809;7477.663505142227;7502.66238019285;7872.291493765589;8107.22981316774;4370.366296886966;4512.435945506812;4514.074614703978;4521.118381915528;4522.728636281834;2801.3556881917275;2862.41320529291;2930.633670791151;2942.7940044196916;2949.8820047198087;825.5954582254652;846.1073567386405;852.3309202276246;1721.8364255395843;1761.1810508113788;10989.835152472719;11032.50353734084;11032.558697652084;11070.059044981186;11099.38953357565;3792.943105853414;3987.5613682494904;4062.086030643082;4067.5525692173837;4126.896827579274;8487.236148746642;8507.957460212783;8510.659573616986;8514.74455766328;8525.914740852637;4349.064951035542;4359.367891655692;4363.869083927487;4366.781660916941;4367.2575662137515;3417.4361230396707;3506.807125608116;3945.467361906106;4101.46680931477;4112.897177570525;3367.2423704666253;3381.644927282649;3503.8948831535095;3522.735794815399;3527.3827080260853;1015.2690063154517;1039.4698703661188;1043.9478026098664;1047.418682631147;1052.6473631333436;687.2474640268897;802.2258520527719;805.1586092533199;805.2068712318362;820.9302209312156;5006.674566153189;5044.646874718735;5059.924101138486;5173.4826517347965;5374.516293533601;355.8096418416135;363.7762775892807;371.5151726996296;372.93287208302763;375.66941091839004;3262.8042317461027;3392.508086327518;3398.5921689396937;3444.8622055118017;3570.7500474967023;9489.952550237344;9904.950475247722;9911.900880991241;9945.552450139761;9966.551505182284;9789.608415663293;9793.461359625146;9812.754681133028;9816.312858099864;9820.165285950774;7368.852622947511;7459.552426854406;7460.29127232912;7460.888086678704;7466.2160473150625;4910.8281210157475;5009.574186194214;5092.592592592658;5093.643444958817;5244.846133850547;9126.726198214064;9175.495347755937;9176.6788162414;9181.678641247525;9221.446713197229;8828.558572071499;9247.630094796134;9257.444553326823;9258.398204116711;9271.443713377219;5624.353199382123;5816.796412125555;6500.707468164039;6560.770373036921;6563.146790917151;7036.120484939383;7205.639718013974;7255.2019277878335;7399.334059934632;7404.666789994355;6532.248791389051;6625.801225963229;6636.502262330248;6796.354346337288;6858.211305699709;6614.10709554204;6741.966290168518;6788.389044985975;6794.558353706993;6808.421284190899;5926.407359264039;6005.159277701038;6006.489448396936;6008.669523176092;6012.098185272244;4339.305711086211;4601.19479091151;4609.654275929386;4640.373549570765;4652.13935421948;4370.562943705604;4442.933355999728;4525.63794896414;4638.628909687284;4741.620670346295 14:51:29 INFO - PROCESS | 25709 | |4;prototype.html;294.43762413789665;300.96237970253713;303.7236115135226;307.91224501017217;308.63889249577994;4813.90372192556;4841.927371089428;4845.854624361266;4855.7814898329525;4866.4160300763915;4723;4751.170799242291;4800.279958006301;4807.855764327067;4815.4221493420755;3552.8934131975952;3616.5895300832694;3661.5423072115987;3697.85208591656;3726.5341832270965;3727.850885964558;3731.2910546995986;3735.514383130203;3738.831752571141;3743.28877513273;3702.241040586673;3703.962960370402;3706.906462593528;3708.3510385682534;3713.6286371362917;3532.894013179609;3602.657747513982;3656.999999999987;3690.870819521304;3718.3864662330684;3303.537504749337;3316.336732653479;3316.436205845012;3316.9834150829333;3321.717653999413;4620.306953956933;4624.583787459145;4628.583427491542;4641.930371044437;4642.187617166982;4192.624936925774;4217.683673724452;4262.573742625744;4292.377605247221;4293.22721910056;4899.583535399495;4913.852584422473;4917.901641967176;4923.433805112422;4967.062845490262;3581.71346292296;3585.8386372613295;3592.7305452091196;3596.6762991330643;3631.5279013728045;4984.82553110643;5137.871553211162;5162.251473536317;5202.4537423570355;5211.348581427322;3664.193877346979;3666.5416822897137;3675.7426980111672;3679.8344074516713;3680.1167719747605;3715.1269451678836;3719.962800372016;3727.7017838572847;3734.925301493955;3739.8691045813266;4229.365595160689;4235.788210589458;4238.237117318912;4241.3637954307105;4266.1254442839145;4767.713937163781;4908.214685650279;4912.189488734319;4949.282354058713;4952.158133117378;1281.589891234796;1300.440810451496;1300.7203451257835;1301.8502872169631;1309.3584143769674;810.4245985350467;834.6103737277487;845.2435070611768;856.3106699107154;856.4005196362571;4207.789610519523;4212.30496968003;4369.628581570602;4408.382826404306;4422;5135.666181698178;5135.974320128375;5142.382914050263;5143.97428012865;5148.922766158511;4328.28583283761;4390.441393305395;4393.924253022897;4403.581659742384;4425.114977004548;2576.458943621823;2682.390565660588;2703.3647092933147;2707.2961030132305;2707.3637695141624;4742.478327383985;4778.522147785194;4783.784729687172;4785.880352991203;4789.832355867528;4989.550940415307;5216.426193118754;5225.6603320784025;5235.842924712265;5252.763625636855;4747.406574178228;4781.904361912742;4786.353842231254;4798.856034318976;4805.9038819224115;5085.542301192911;5122.462141475092;5136.743162841768;5137.6660517066275;5146.819861304836;4747.881302967454;5008.749562521933;5013.222950442687;5020.42265139499;5022.573081288131;4797.544233297831;4806.2310030394965;4832.867897947345;4843.152448321459;4845.442774081026;3550.508786309808;3576.7317451190743;3586.2648157127205;3587.65917237862;3596.2807438511877;4995.775190116527;5126.8974620508125;5140.56305214061;5148.330717006915;5157.252198431282;4993.4808997857;4998.175301075427;5002.799888004584;5028.34631497903;5057.14028615129;4963.751812409293;5003.899922001612;5030.698158110525;5036.571891389273;5058.342415485963;4825.782839772289;4943.950560494349;4963.851084467472;4965.47862474435;4980.825671101494;4792.520747925179;4858.785303674082;4909.828156014522;5007.449180590205;5055.570276526537;4894.290327902506;4915.778789954532;4920.704757714549;4922.286268491121;4943.555080042814 14:51:29 INFO - PROCESS | 25709 | |5;yui.html;578.8812598362649;579.7159391897966;591.645012992205;656.6454114778019;659.7827009168086;11106.888931110687;11928.880711192885;11944.462499187535;12002.579909703161;12199.51201951922;12127.332996685178;12749.872501274984;12787.424565894535;13125.606231813037;13219.471221151143;750.6471958179646;770.3990887108065;772.2702046565997;772.30106753388;772.64072206424;617.3702823120415;632.9968350158266;740.7518481308741;763.4083585221442;763.6105586151075;807.9434439589231;810.4286478032973;810.6392655268407;810.8135128920352;814.1288820961573;806.2542148512603;807.4347956430522;808.4946908182386;808.5674164322089;809.5749731391008;479.5875547029552;486.82230985690325;569.9544036477072;585.5754577931009;596.0314488955447;11527.654170374903;11574.363410012445;11586.594469193622;11587;11603.709907252301;11058.944705276503;11553;11557.711057223552;11705.3562054087;12417.937910310391;10766.40784756838;10950.507227174796;11153.944230278878;11260;11268.43657817114;3924.489816323888;3945.5462621798574;3984.86052988144;4019.095703466726;4031.6169963853386;46380.536194637956;46760.532394676295;47246.05507889857;49167.508324917006;49206.753966230295;9362.765930851783;9452.10205030521;9472.336936414385;9500.334976551576;9580.616775329048;16989.150542472828;16996.660066798595;17036.914815425844;17091.914540427468;17149.314027439013;6110.908336374958;6140.324564297924;6190.3190649028575;6301.873962520724;6367.840803979845;3412;3490.808005559668;3521.7358698097746;3563.2160924596546;3571.339302229096;2755.8897644094013;2846.174609363303;2852.3297025199063;2852.3724780548246;2854.785891058179;532.1937265043463;547.4224692948977;549.3437286580962;553.8919910617471;565.5984251181707;424.7196850078933;446.48654047845235;476.833108412053;479.33133279075497;502.39712345185194;8081.313088387553;8162.632681529345;8207.097219305871;8302.16978302177;8333.791655208546;523.1786095829588;540.8188256933971;544.0859356281485;549.4807407000426;557.289455943667;3723.627637236309;4166.312558427886;4309.396684464177;4468.240399132091;4500.504944456107;54534.45465545294;68709.65645171743;91437;104229;104461.47769261105;83651.58174209212;84060;84732.15267847366;85825;86943.56528217318;71226;74188.62905685545;74742.25257747462;75030.24969750342;75340;7953.363730901398;8353.457025293337;8601.39790214679;8664.653413863374;8896.510691912006;43145.784271078446;44100.55899440964;44646;45739.08521829611;45956;55682.72158639181;62903.911245768875;64896.35103648903;66334.33665663282;67782;11244.493997770283;11459.48432320531;11474.770504589695;11669.474873630877;11950.34273114987;11779.234349767581;11803.527858885893;11887;11990.640280791591;12391.442385092512;11208.607698730506;11399;11589.304641721523;11597.478113484745;11607.76784464323;11300;11492;11523.654290371302;11683.591074312359;11872.465739041936;10784.730381740519;11062.668119956414;11119.555217791198;11151;11224;9329.253659707343;9348.125257724287;9702.75743106428;9863.408195508293;9966.50167491608;9620.95189524048;10231.232657550863;10268.07587317145;10362.168029236222;10374.377537347784 14:51:29 INFO - PROCESS | 25709 | __end_tp_report 14:51:29 INFO - PROCESS | 25709 | __start_cc_report 14:51:29 INFO - PROCESS | 25709 | _x_x_mozilla_cycle_collect,1265 14:51:29 INFO - PROCESS | 25709 | __end_cc_report 14:51:29 INFO - PROCESS | 25709 | __startTimestamp1475531489885__endTimestamp 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | ------- Summary: start ------- 14:51:29 INFO - PROCESS | 25709 | Number of tests: 6 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | [#0] dojo.html Cycles:165 Average:4674.64 Median:4826.16 stddev:498.14 (10.3%) stddev-sans-first:471.48 14:51:29 INFO - PROCESS | 25709 | Values: 2568.8 2602.3 2634.7 2645.2 2649.3 4509.1 4568.6 4658.3 4718.6 4731.1 4642.1 4708.8 4748.0 4756.6 4835.5 4290.5 4317.7 4354.2 4376.2 4385.2 4400.0 4462.6 4469.0 4471.1 4492.8 4425.9 4454.0 4474.4 4486.8 4511.2 4209.2 4258.0 4259.5 4305.3 4316.7 4293.6 4306.1 4360.7 4388.7 4418.5 4653.5 4717.5 4753.5 4763.0 4824.7 5095.1 5117.0 5130.9 5134.1 5193.1 4949.2 4974.0 4985.3 4993.0 5011.1 4674.1 4685.0 4686.9 4690.6 4735.2 5187.1 5193.3 5193.9 5199.2 5259.6 4733.9 4807.7 4811.6 4845.3 4862.8 5041.1 5047.9 5051.3 5055.0 5059.3 4946.1 4960.5 5003.5 5006.5 5007.9 4993.7 5003.9 5064.4 5067.2 5071.0 4232.2 4233.3 4234.2 4235.1 4295.1 3660.9 3725.6 3770.0 3770.4 3775.3 4248.4 4275.3 4299.4 4311.5 4312.8 5068.2 5071.6 5071.7 5078.5 5131.3 4300.6 4327.8 4334.2 4379.2 4385.3 4417.7 4456.3 4486.9 4521.5 4532.9 4837.0 4874.5 4887.0 4896.1 4898.6 5138.5 5151.7 5152.1 5156.4 5215.3 4677.8 4811.8 4826.2 4831.8 4882.8 4947.2 4951.9 4963.3 5024.7 5037.0 5073.8 5078.4 5079.9 5084.4 5129.1 4952.1 4952.5 4953.4 4955.8 4963.2 4858.6 4872.2 4924.0 4931.1 4974.2 4901.4 4908.6 4909.6 4912.9 4943.6 4963.3 4995.9 5006.8 5023.2 5075.2 4722.0 4776.8 4777.9 4835.9 4970.8 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | [#1] ext.html Cycles:180 Average:45553.37 Median:36825.95 stddev:83705.53 (227.3%) stddev-sans-first:83872.21 14:51:29 INFO - PROCESS | 25709 | Values: 570.7 576.6 582.6 583.4 590.3 27656.9 38114.2 39594.0 39764.8 43056.4 39331.6 39513.0 39885.4 39939.8 39952.4 5247.2 5249.6 5252.3 5279.7 5362.2 7575.2 7638.2 7657.3 7661.9 7671.5 7664.5 7710.4 7717.7 7721.0 7724.2 7668.7 7691.0 7711.8 7712.0 7713.7 7550.5 7612.3 7614.3 7616.9 7621.2 36419.8 36654.6 36782.8 36800.3 36819.3 2799.7 2901.2 2953.8 2960.8 3006.6 26999.3 28430.4 28459.7 29225.6 29252.9 3387.2 3404.1 3435.5 3590.1 3618.7 242227.0 243829.0 243967.0 243981.0 244220.0 30607.0 48779.0 49153.5 49210.3 49272.3 31619.5 33940.7 33984.5 34005.0 34027.8 11729.5 11883.6 11903.4 11910.6 11912.1 9273.4 9355.8 9372.7 9377.9 9385.6 7773.8 7795.8 7818.2 7882.9 7930.0 3050.0 3084.0 3109.5 3155.4 3187.7 855.7 907.6 946.6 968.4 982.6 26300.3 27898.2 27941.7 28167.0 28167.3 789.4 886.3 925.0 963.7 972.6 11682.8 14122.9 14429.2 14505.6 14585.8 371407.0 374047.0 374549.0 374756.0 376732.0 47741.8 48314.5 48353.8 48401.8 48401.8 1072.9 1108.7 1127.2 1191.4 1194.9 26939.3 28188.7 28597.4 29080.4 29189.3 40909.7 41337.6 41348.0 41403.8 41418.4 287470.0 289179.0 289204.0 356809.0 368002.0 37637.2 38070.2 38361.0 38522.2 39001.2 41861.8 41919.8 42203.4 42588.0 43052.0 35274.0 35384.5 35399.0 35530.8 36266.8 35787.3 36009.5 36590.0 36651.5 36832.6 34939.3 34986.5 35128.0 35401.6 35536.5 30515.8 32261.4 32403.2 32522.7 32545.8 24678.5 24734.8 24856.3 25346.5 25357.0 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | [#2] jquery.html Cycles:180 Average:22985.41 Median:5172.05 stddev:59933.03 (1158.8%) stddev-sans-first:60077.05 14:51:29 INFO - PROCESS | 25709 | Values: 344.9 363.2 367.8 368.7 395.3 12182.7 12241.3 13715.2 14060.9 17267.5 15271.8 15547.2 16619.7 16734.9 16802.1 4891.3 4943.4 4986.2 5006.9 5009.3 3575.3 3754.8 4908.0 4979.9 4987.0 5629.1 5864.1 5883.0 5988.9 6010.2 5706.0 5830.4 5875.7 5966.3 5975.3 5171.8 5172.3 5174.6 5174.7 5175.4 16313.5 20102.2 20173.9 20209.2 20209.7 1890.1 1896.6 1915.3 1980.4 2038.1 12072.0 12323.4 12686.2 12741.9 13280.0 1696.3 1769.8 1788.1 1842.8 1848.1 49359.5 58798.4 64715.0 69585.0 72372.0 9190.4 9413.2 9545.5 9921.1 9994.2 12480.3 12503.9 12531.9 12537.1 12540.0 6473.3 6538.3 6665.8 6773.7 6791.8 6209.7 6338.2 6475.2 6507.9 6519.0 3816.5 3825.9 3955.8 3976.0 4183.4 1620.6 1682.5 1685.3 1693.0 1694.4 760.8 785.5 792.5 815.8 882.0 15861.3 16499.3 16603.8 16804.0 17232.8 837.1 844.1 857.2 861.7 870.8 8613.7 9280.2 9432.4 9496.7 9504.2 346830.0 361058.0 364475.0 369050.0 369408.0 73049.0 75024.1 76783.2 77438.6 77897.0 842.3 865.6 865.7 865.8 871.6 14418.0 14667.5 14712.9 14771.3 15318.8 35815.3 36632.5 36793.0 37700.2 37766.0 49648.0 49687.3 49903.5 50550.5 52649.0 6921.7 7023.1 7131.8 7202.3 7297.4 10522.7 10670.6 10758.9 10871.9 11249.8 9230.8 9485.2 9509.2 9511.6 9898.9 9348.0 9359.7 9364.8 9405.2 9478.1 9341.2 9422.9 9448.7 9459.9 9636.0 6596.4 6982.7 7003.8 7088.1 7145.9 7432.6 9206.9 9388.5 9643.0 9728.1 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | [#3] mootools.html Cycles:180 Average:5077.77 Median:4696.88 stddev:2942.65 (62.7%) stddev-sans-first:2936.37 14:51:29 INFO - PROCESS | 25709 | Values: 1185.8 1347.0 1383.5 1441.5 1676.5 6812.9 7673.8 8017.2 8018.6 8202.5 8052.9 8106.3 8110.7 8113.1 8113.4 2154.9 2180.4 2181.2 2183.5 2183.7 2116.5 2163.4 2206.0 2210.3 2216.3 2141.8 2160.2 2183.6 2191.6 2198.6 2125.8 2133.0 2137.2 2139.1 2141.6 2071.2 2170.1 2171.0 2174.4 2186.7 7389.8 7477.7 7502.7 7872.3 8107.2 4370.4 4512.4 4514.1 4521.1 4522.7 2801.4 2862.4 2930.6 2942.8 2949.9 825.6 846.1 852.3 1721.8 1761.2 10989.8 11032.5 11032.6 11070.1 11099.4 3792.9 3987.6 4062.1 4067.6 4126.9 8487.2 8508.0 8510.7 8514.7 8525.9 4349.1 4359.4 4363.9 4366.8 4367.3 3417.4 3506.8 3945.5 4101.5 4112.9 3367.2 3381.6 3503.9 3522.7 3527.4 1015.3 1039.5 1043.9 1047.4 1052.6 687.2 802.2 805.2 805.2 820.9 5006.7 5044.6 5059.9 5173.5 5374.5 355.8 363.8 371.5 372.9 375.7 3262.8 3392.5 3398.6 3444.9 3570.8 9490.0 9905.0 9911.9 9945.6 9966.6 9789.6 9793.5 9812.8 9816.3 9820.2 7368.9 7459.6 7460.3 7460.9 7466.2 4910.8 5009.6 5092.6 5093.6 5244.8 9126.7 9175.5 9176.7 9181.7 9221.4 8828.6 9247.6 9257.4 9258.4 9271.4 5624.4 5816.8 6500.7 6560.8 6563.1 7036.1 7205.6 7255.2 7399.3 7404.7 6532.2 6625.8 6636.5 6796.4 6858.2 6614.1 6742.0 6788.4 6794.6 6808.4 5926.4 6005.2 6006.5 6008.7 6012.1 4339.3 4601.2 4609.7 4640.4 4652.1 4370.6 4442.9 4525.6 4638.6 4741.6 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | [#4] prototype.html Cycles:180 Average:4136.01 Median:4773.12 stddev:1196.46 (25.1%) stddev-sans-first:1164.56 14:51:29 INFO - PROCESS | 25709 | Values: 294.4 301.0 303.7 307.9 308.6 4813.9 4841.9 4845.9 4855.8 4866.4 4723.0 4751.2 4800.3 4807.9 4815.4 3552.9 3616.6 3661.5 3697.9 3726.5 3727.9 3731.3 3735.5 3738.8 3743.3 3702.2 3704.0 3706.9 3708.4 3713.6 3532.9 3602.7 3657.0 3690.9 3718.4 3303.5 3316.3 3316.4 3317.0 3321.7 4620.3 4624.6 4628.6 4641.9 4642.2 4192.6 4217.7 4262.6 4292.4 4293.2 4899.6 4913.9 4917.9 4923.4 4967.1 3581.7 3585.8 3592.7 3596.7 3631.5 4984.8 5137.9 5162.3 5202.5 5211.3 3664.2 3666.5 3675.7 3679.8 3680.1 3715.1 3720.0 3727.7 3734.9 3739.9 4229.4 4235.8 4238.2 4241.4 4266.1 4767.7 4908.2 4912.2 4949.3 4952.2 1281.6 1300.4 1300.7 1301.9 1309.4 810.4 834.6 845.2 856.3 856.4 4207.8 4212.3 4369.6 4408.4 4422.0 5135.7 5136.0 5142.4 5144.0 5148.9 4328.3 4390.4 4393.9 4403.6 4425.1 2576.5 2682.4 2703.4 2707.3 2707.4 4742.5 4778.5 4783.8 4785.9 4789.8 4989.6 5216.4 5225.7 5235.8 5252.8 4747.4 4781.9 4786.4 4798.9 4805.9 5085.5 5122.5 5136.7 5137.7 5146.8 4747.9 5008.7 5013.2 5020.4 5022.6 4797.5 4806.2 4832.9 4843.2 4845.4 3550.5 3576.7 3586.3 3587.7 3596.3 4995.8 5126.9 5140.6 5148.3 5157.3 4993.5 4998.2 5002.8 5028.3 5057.1 4963.8 5003.9 5030.7 5036.6 5058.3 4825.8 4944.0 4963.9 4965.5 4980.8 4792.5 4858.8 4909.8 5007.4 5055.6 4894.3 4915.8 4920.7 4922.3 4943.6 14:51:29 INFO - PROCESS | 25709 | 14:51:29 INFO - PROCESS | 25709 | [#5] yui.html Cycles:180 Average:16834.88 Median:23861.44 stddev:23989.33 (100.5%) stddev-sans-first:24025.57 14:51:29 INFO - PROCESS | 25709 | Values: 578.9 579.7 591.6 656.6 659.8 11106.9 11928.9 11944.5 12002.6 12199.5 12127.3 12749.9 12787.4 13125.6 13219.5 750.6 770.4 772.3 772.3 772.6 617.4 633.0 740.8 763.4 763.6 807.9 810.4 810.6 810.8 814.1 806.3 807.4 808.5 808.6 809.6 479.6 486.8 570.0 585.6 596.0 11527.7 11574.4 11586.6 11587.0 11603.7 11058.9 11553.0 11557.7 11705.4 12417.9 10766.4 10950.5 11153.9 11260.0 11268.4 3924.5 3945.5 3984.9 4019.1 4031.6 46380.5 46760.5 47246.1 49167.5 49206.8 9362.8 9452.1 9472.3 9500.3 9580.6 16989.2 16996.7 17036.9 17091.9 17149.3 6110.9 6140.3 6190.3 6301.9 6367.8 3412.0 3490.8 3521.7 3563.2 3571.3 2755.9 2846.2 2852.3 2852.4 2854.8 532.2 547.4 549.3 553.9 565.6 424.7 446.5 476.8 479.3 502.4 8081.3 8162.6 8207.1 8302.2 8333.8 523.2 540.8 544.1 549.5 557.3 3723.6 4166.3 4309.4 4468.2 4500.5 54534.5 68709.7 91437.0 104229.0 104461.5 83651.6 84060.0 84732.2 85825.0 86943.6 71226.0 74188.6 74742.3 75030.2 75340.0 7953.4 8353.5 8601.4 8664.7 8896.5 43145.8 44100.6 44646.0 45739.1 45956.0 55682.7 62903.9 64896.4 66334.3 67782.0 11244.5 11459.5 11474.8 11669.5 11950.3 11779.2 11803.5 11887.0 11990.6 12391.4 11208.6 11399.0 11589.3 11597.5 11607.8 11300.0 11492.0 11523.7 11683.6 11872.5 10784.7 11062.7 11119.6 11151.0 11224.0 9329.3 9348.1 9702.8 9863.4 9966.5 9621.0 10231.2 10268.1 10362.2 10374.4 14:51:29 INFO - PROCESS | 25709 | -------- Summary: end -------- 14:51:29 INFO - PROCESS | 25709 | 14:51:30 INFO - TEST-INFO | 25709: exit 0 14:51:30 INFO - TEST-OK | dromaeo_css | took 1123320ms 14:51:30 INFO - TEST-START | kraken 14:51:30 INFO - operating with platform_type : linux_ 14:51:30 INFO - Initialising browser for kraken test... 14:51:30 INFO - TEST-INFO | started process 26011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPg5qk3/profile http://localhost:53574/getInfo.html) 14:51:35 INFO - PROCESS | 26011 | __metrics Screen width/height:1600/1200 14:51:35 INFO - PROCESS | 26011 | colorDepth:24 14:51:35 INFO - PROCESS | 26011 | Browser inner width/height: 1024/697 14:51:35 INFO - PROCESS | 26011 | __metrics 14:51:35 INFO - PROCESS | 26011 | 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" 14:51:35 INFO - PROCESS | 26011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:51:36 INFO - PROCESS | 26011 | console.error: PushService: 14:51:36 INFO - PROCESS | 26011 | stateChangeProcessEnqueue: Error transitioning state 14:51:36 INFO - PROCESS | 26011 | UnknownError 14:51:37 INFO - TEST-INFO | 26011: exit 0 14:51:37 INFO - Browser initialized. 14:51:37 INFO - Running cycle 1/1 for kraken test... 14:51:37 INFO - TEST-INFO | started process 26094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPg5qk3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:49 INFO - PROCESS | 26094 | RSS: Main: 175308800 14:51:49 INFO - PROCESS | 26094 | 14:51:52 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53574/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:53 INFO - PROCESS | 26094 | RSS: Main: 233488384 14:51:53 INFO - PROCESS | 26094 | 14:51:56 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53574/tests/kraken/driver.html?testName=audio-dft) 14:51:56 INFO - PROCESS | 26094 | RSS: Main: 219131904 14:51:56 INFO - PROCESS | 26094 | 14:51:59 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53574/tests/kraken/driver.html?testName=audio-fft) 14:52:00 INFO - PROCESS | 26094 | RSS: Main: 300277760 14:52:00 INFO - PROCESS | 26094 | 14:52:02 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53574/tests/kraken/driver.html?testName=audio-oscillator) 14:52:03 INFO - PROCESS | 26094 | RSS: Main: 209883136 14:52:03 INFO - PROCESS | 26094 | 14:52:05 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:06 INFO - PROCESS | 26094 | RSS: Main: 213561344 14:52:06 INFO - PROCESS | 26094 | 14:52:09 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53574/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:09 INFO - PROCESS | 26094 | RSS: Main: 249978880 14:52:09 INFO - PROCESS | 26094 | 14:52:13 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53574/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:14 INFO - PROCESS | 26094 | RSS: Main: 244310016 14:52:14 INFO - PROCESS | 26094 | 14:52:16 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53574/tests/kraken/driver.html?testName=json-parse-financial) 14:52:17 INFO - PROCESS | 26094 | RSS: Main: 247455744 14:52:17 INFO - PROCESS | 26094 | 14:52:19 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:19 INFO - PROCESS | 26094 | RSS: Main: 211165184 14:52:19 INFO - PROCESS | 26094 | 14:52:21 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:22 INFO - PROCESS | 26094 | RSS: Main: 218873856 14:52:22 INFO - PROCESS | 26094 | 14:52:24 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:25 INFO - PROCESS | 26094 | RSS: Main: 223244288 14:52:25 INFO - PROCESS | 26094 | 14:52:28 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:28 INFO - PROCESS | 26094 | RSS: Main: 224608256 14:52:28 INFO - PROCESS | 26094 | 14:52:31 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:32 INFO - PROCESS | 26094 | RSS: Main: 222023680 14:52:32 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | Cycle 1(1): loaded http://localhost:53574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53574/tests/kraken/driver.html?testName=ai-astar) 14:52:34 INFO - PROCESS | 26094 | RSS: Main: 273076224 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | __start_tp_report 14:52:34 INFO - PROCESS | 26094 | _x_x_mozilla_page_load 14:52:34 INFO - PROCESS | 26094 | _x_x_mozilla_page_load_details 14:52:34 INFO - PROCESS | 26094 | |i|pagename|runs| 14:52:34 INFO - PROCESS | 26094 | |0;ai-astar;112;115;114;115;112;117;114;113;114;114 14:52:34 INFO - PROCESS | 26094 | |1;audio-beat-detection;156;127;129;174;128;129;126;126;162;127 14:52:34 INFO - PROCESS | 26094 | |2;audio-dft;167;164;162;163;160;161;161;162;161;161 14:52:34 INFO - PROCESS | 26094 | |3;audio-fft;77;77;76;117;78;77;77;76;98;76 14:52:34 INFO - PROCESS | 26094 | |4;audio-oscillator;84;83;109;83;84;84;108;83;82;112 14:52:34 INFO - PROCESS | 26094 | |5;imaging-gaussian-blur;118;117;116;117;117;118;116;116;117;117 14:52:34 INFO - PROCESS | 26094 | |6;imaging-darkroom;148;145;146;145;147;146;146;146;147;145 14:52:34 INFO - PROCESS | 26094 | |7;imaging-desaturate;94;95;95;94;94;95;94;94;95;95 14:52:34 INFO - PROCESS | 26094 | |8;json-parse-financial;64;62;62;62;62;64;64;63;64;64 14:52:34 INFO - PROCESS | 26094 | |9;json-stringify-tinderbox;67;67;66;67;67;67;70;67;67;67 14:52:34 INFO - PROCESS | 26094 | |10;stanford-crypto-aes;84;84;83;86;85;84;92;84;83;82 14:52:34 INFO - PROCESS | 26094 | |11;stanford-crypto-ccm;142;139;141;148;142;144;142;147;175;160 14:52:34 INFO - PROCESS | 26094 | |12;stanford-crypto-pbkdf2;184;183;177;176;177;174;178;180;176;176 14:52:34 INFO - PROCESS | 26094 | |13;stanford-crypto-sha256-iterative;73;71;70;74;74;71;71;72;69;69 14:52:34 INFO - PROCESS | 26094 | __end_tp_report 14:52:34 INFO - PROCESS | 26094 | __start_cc_report 14:52:34 INFO - PROCESS | 26094 | _x_x_mozilla_cycle_collect,1942 14:52:34 INFO - PROCESS | 26094 | __end_cc_report 14:52:34 INFO - PROCESS | 26094 | __startTimestamp1475531554513__endTimestamp 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | ------- Summary: start ------- 14:52:34 INFO - PROCESS | 26094 | Number of tests: 14 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.49 (1.3%) stddev-sans-first:1.39 14:52:34 INFO - PROCESS | 26094 | Values: 112.0 115.0 114.0 115.0 112.0 117.0 114.0 113.0 114.0 114.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:129.00 stddev:18.22 (14.1%) stddev-sans-first:18.17 14:52:34 INFO - PROCESS | 26094 | Values: 156.0 127.0 129.0 174.0 128.0 129.0 126.0 126.0 162.0 127.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.04 (1.3%) stddev-sans-first:1.22 14:52:34 INFO - PROCESS | 26094 | Values: 167.0 164.0 162.0 163.0 160.0 161.0 161.0 162.0 161.0 161.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:13.73 (17.8%) stddev-sans-first:14.40 14:52:34 INFO - PROCESS | 26094 | Values: 77.0 77.0 76.0 117.0 78.0 77.0 77.0 76.0 98.0 76.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:12.80 (15.4%) stddev-sans-first:13.30 14:52:34 INFO - PROCESS | 26094 | Values: 84.0 83.0 109.0 83.0 84.0 84.0 108.0 83.0 82.0 112.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 14:52:34 INFO - PROCESS | 26094 | Values: 118.0 117.0 116.0 117.0 117.0 118.0 116.0 116.0 117.0 117.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:0.78 14:52:34 INFO - PROCESS | 26094 | Values: 148.0 145.0 146.0 145.0 147.0 146.0 146.0 146.0 147.0 145.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:52:34 INFO - PROCESS | 26094 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 14:52:34 INFO - PROCESS | 26094 | Values: 64.0 62.0 62.0 62.0 62.0 64.0 64.0 63.0 64.0 64.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 14:52:34 INFO - PROCESS | 26094 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 70.0 67.0 67.0 67.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.79 (3.3%) stddev-sans-first:2.95 14:52:34 INFO - PROCESS | 26094 | Values: 84.0 84.0 83.0 86.0 85.0 84.0 92.0 84.0 83.0 82.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:145.50 stddev:11.20 (7.7%) stddev-sans-first:11.66 14:52:34 INFO - PROCESS | 26094 | Values: 142.0 139.0 141.0 148.0 142.0 144.0 142.0 147.0 175.0 160.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:177.50 stddev:3.25 (1.8%) stddev-sans-first:2.65 14:52:34 INFO - PROCESS | 26094 | Values: 184.0 183.0 177.0 176.0 177.0 174.0 178.0 180.0 176.0 176.0 14:52:34 INFO - PROCESS | 26094 | 14:52:34 INFO - PROCESS | 26094 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.84 (2.6%) stddev-sans-first:1.86 14:52:34 INFO - PROCESS | 26094 | Values: 73.0 71.0 70.0 74.0 74.0 71.0 71.0 72.0 69.0 69.0 14:52:34 INFO - PROCESS | 26094 | -------- Summary: end -------- 14:52:34 INFO - PROCESS | 26094 | 14:52:35 INFO - TEST-INFO | 26094: exit 0 14:52:35 INFO - TEST-OK | kraken | took 65012ms 14:52:35 INFO - SUITE-END | took 1188s 14:52:36 INFO - Completed test suite (00:19:48) 14:52:36 INFO - javascript benchmark 14:52:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.833025853319, 2602.29737970748, 2634.6970098438674, 2645.1667724666727, 2649.324422272319, 4509.098180363924, 4568.565986231302, 4658.27796691513, 4718.551737584929, 4731.077439899217, 4642.094791515656, 4708.764561771906, 4748.0, 4756.619470442365, 4835.540623640757, 4290.506591741942, 4317.676174286941, 4354.216241076605, 4376.19040477511, 4385.188740083079, 4400.0, 4462.620677242422, 4468.97765511172, 4471.105778844228, 4492.775361231926, 4425.889352766175, 4454.042380888109, 4474.395956545857, 4486.798094085774, 4511.187986162489, 4209.221294060609, 4257.957420425787, 4259.51015633203, 4305.31115021595, 4316.654667626613, 4293.5706429356815, 4306.095719898825, 4360.694751367406, 4388.71473354231, 4418.491873434564, 4653.464851542082, 4717.528247175289, 4753.453352864396, 4763.047390521875, 4824.734639594821, 5095.082885080684, 5117.0, 5130.897382052375, 5134.127198376285, 5193.143131383317, 4949.232868905326, 4973.950260497385, 4985.302057711923, 4992.950070499285, 5011.072951503984, 4674.11191873543, 4684.95315046852, 4686.859394218179, 4690.554397332248, 4735.2186889163595, 5187.0922588546855, 5193.272941788153, 5193.870153246199, 5199.194124910645, 5259.605529585297, 4733.881652958704, 4807.663463557517, 4811.615070794328, 4845.297431872359, 4862.78117484714, 5041.1430056889685, 5047.9495205048215, 5051.292819005343, 5055.039542486916, 5059.342285502935, 4946.1344264753525, 4960.528749768766, 5003.4746351633285, 5006.549410552995, 5007.924881126786, 4993.725345106054, 5003.949960500421, 5064.392272927273, 5067.214581739836, 5071.036503064406, 4232.153569286155, 4233.25917964355, 4234.237837189336, 4235.0682849773, 4295.076558539929, 3660.871869484555, 3725.5715592706642, 3769.962300377016, 3770.434434834797, 3775.339315619756, 4248.4477017987465, 4275.315949448073, 4299.398084268205, 4311.461067366579, 4312.849050283225, 5068.163752980717, 5071.594272458195, 5071.670341427795, 5078.4667609900425, 5131.281620573122, 4300.569943005675, 4327.76197309151, 4334.241507736134, 4379.167958087953, 4385.254506733863, 4417.690761646718, 4456.309272062836, 4486.887827804331, 4521.502634710179, 4532.864014079583, 4837.0, 4874.53691899269, 4887.047025829929, 4896.11869863428, 4898.632602554751, 5138.4604616514725, 5151.742412879266, 5152.149895267239, 5156.40701319338, 5215.2698622192165, 4677.76611169447, 4811.7834697438, 4826.155422800925, 4831.758412079453, 4882.804687812448, 4947.233178857283, 4951.876203094951, 4963.305137280856, 5024.698518088926, 5037.0, 5073.797048118034, 5078.390593128701, 5079.87300317495, 5084.440711521804, 5129.102407078821, 4952.133376659142, 4952.455229924633, 4953.405591329064, 4955.776990035529, 4963.181075122564, 4858.562729354375, 4872.196087645499, 4924.01519696055, 4931.0630980113665, 4974.204127339608, 4901.362822833009, 4908.607311415007, 4909.582685471775, 4912.852614421573, 4943.555080042814, 4963.280324352876, 4995.875103122451, 5006.849794506171, 5023.2214006829, 5075.162598171408, 4722.008378240471, 4776.761161941959, 4777.928331074967, 4835.903281934412, 4970.776315065758], "value": 4642.228259221934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6775671745463, 576.5992635118592, 582.6300299309939, 583.3553922915181, 590.2887021139526, 27656.86171569142, 38114.237715245676, 39594.0, 39764.801175994115, 43056.35415468763, 39331.606683933154, 39513.0, 39885.40171897424, 39939.80030099845, 39952.400713989315, 5247.242173871758, 5249.580033597303, 5252.290940723011, 5279.683219006863, 5362.2224777407255, 7575.166731659513, 7638.236176382373, 7657.310842024217, 7661.885071723928, 7671.501352412103, 7664.540127592362, 7710.421718371116, 7717.65270562826, 7720.961395193016, 7724.150343462215, 7668.693252269903, 7690.961545192295, 7711.845763084763, 7712.0, 7713.691452341927, 7550.509216900939, 7612.276833700789, 7614.2766437188375, 7616.923830761677, 7621.23787621239, 36419.81790091059, 36654.63345366566, 36782.816085919665, 36800.263994720226, 36819.263614727555, 2799.7340252675963, 2901.202169403431, 2953.8375389353578, 2960.8371539565314, 3006.5941097951936, 26999.32501687454, 28430.431391372058, 28459.715402845915, 29225.561616575767, 29252.853735731183, 3387.1701433149037, 3404.131946353664, 3435.4503279475416, 3590.1024743814046, 3618.7285953553587, 242227.0, 243829.0, 243967.0, 243981.0, 244220.0, 30607.0, 48779.0, 49153.508464915605, 49210.26184607234, 49272.260916086285, 31619.52570711441, 33940.66059339375, 33984.49023264653, 34005.0, 34027.82986085103, 11729.530818767154, 11883.58407455735, 11903.404829758478, 11910.642680719593, 11912.106592005634, 9273.350865439354, 9355.766105847271, 9372.67195648149, 9377.906220937703, 9385.57764900581, 7773.844523109507, 7795.80510487231, 7818.218178182136, 7882.921170788219, 7930.048394192734, 3049.969500305013, 3083.969160308413, 3109.5491153782573, 3155.4162479941283, 3187.7449804015623, 855.6662901468433, 907.6142639378238, 946.6497395963399, 968.4479846487435, 982.577491678585, 26300.342491437485, 27898.16305510838, 27941.720582794318, 28167.0, 28167.295817604725, 789.4355535791822, 886.259972922604, 924.9768755781159, 963.6675347005272, 972.601233494264, 11682.766344673058, 14122.929385353007, 14429.206393648241, 14505.637359065897, 14585.781213281596, 371407.0, 374047.0, 374549.0, 374756.0, 376732.0, 47741.761291193325, 48314.5168548317, 48353.75823120932, 48401.757991209815, 48401.757991209815, 1072.9302595331278, 1108.7449886526144, 1127.2222166704948, 1191.3507138609305, 1194.8805119487981, 26939.326516837235, 28188.71811281861, 28597.42805143927, 29080.418391632473, 29189.270268243465, 40909.659002854605, 41337.58662413337, 41348.0, 41403.7929810349, 41418.37872431856, 287470.0, 289179.0, 289204.0, 356809.0, 368002.0, 37637.24725505529, 38070.2385952285, 38361.0, 38522.22955540817, 39001.2199756009, 41861.79069104635, 41919.7904010478, 42203.3669494964, 42588.0, 43052.0, 35274.0, 35384.46923296101, 35399.0, 35530.822345888104, 36266.8186659065, 35787.28425431425, 36009.459858101625, 36590.0, 36651.45022824713, 36832.631673683994, 34939.30121397608, 34986.475202871465, 35128.0, 35401.645983539835, 35536.46695299624, 30515.847420762755, 32261.354772903942, 32403.161186544465, 32522.674773251965, 32545.837270813496, 24678.506429870944, 24734.752652473246, 24856.254312370656, 25346.493070138124, 25357.0], "value": 16052.474027549017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.93791117598823, 363.220891188401, 367.8326361505516, 368.7271419149829, 395.2569169960474, 12182.69543261419, 12241.34154355392, 13715.245661488614, 14060.859391406082, 17267.481975540755, 15271.770923436157, 15547.22263886804, 16619.66760664786, 16734.912230704995, 16802.075885826274, 4891.290762839386, 4943.4067911850625, 4986.202207646777, 5006.949930500685, 5009.348784657989, 3575.3206890690685, 3754.8122593870335, 4907.950920490803, 4979.875503112433, 4986.975065124688, 5629.099344104944, 5864.061750119981, 5882.970585147068, 5988.940110598882, 6010.248718910137, 5705.971470142665, 5830.446107619811, 5875.735591898375, 5966.2840459144745, 5975.342712301644, 5171.818986335498, 5172.27588137661, 5174.611904107207, 5174.7412629368755, 5175.378954525481, 16313.510594682179, 20102.195912163497, 20173.899130504255, 20209.19163233469, 20209.696854547194, 1890.1210936914263, 1896.6017136401372, 1915.2817693364989, 1980.3563841751345, 2038.0930485933766, 12072.0, 12323.383830808514, 12686.238825670396, 12741.872581274161, 13280.0, 1696.2621259752048, 1769.761759011802, 1788.0523322638892, 1842.797292297846, 1848.0944337274773, 49359.50640493585, 58798.41201587972, 64715.0, 69585.0, 72371.99999999948, 9190.40262382943, 9413.152816246571, 9545.52272386378, 9921.107100361001, 9994.150497207673, 12480.313582752855, 12503.937480312541, 12531.934785543332, 12537.059720520998, 12540.0, 6473.255575608865, 6538.313477084837, 6665.800025999228, 6773.6613169341335, 6791.830204244835, 6209.6895155242055, 6338.239411270677, 6475.158229430144, 6507.8698426031215, 6519.0, 3816.5229346331707, 3825.8660946866726, 3955.7824319662695, 3976.0258736609717, 4183.3515805050265, 1620.6272557311884, 1682.4846853953418, 1685.2584862660635, 1692.9695844438563, 1694.4498529712703, 760.7869796457001, 785.4972817396871, 792.5007245435454, 815.8490679224362, 881.9603117859712, 15861.286242119133, 16499.340026399048, 16603.750943735853, 16804.0, 17232.827671723375, 837.0917554453365, 844.1052484366469, 857.1813917708698, 861.7371701630938, 870.7953630896734, 8613.65545378178, 9280.211182049467, 9432.38689485195, 9496.715098547054, 9504.239660827117, 346830.0, 361058.0, 364475.0, 369050.0, 369408.0, 73049.0, 75024.12246714125, 76783.23216767873, 77438.61280693673, 77897.0, 842.3135144856922, 865.6277800545699, 865.7229686500259, 865.8354912566718, 871.5642178910545, 14418.0, 14667.48663796762, 14712.852871471148, 14771.261436928326, 15318.846811531743, 35815.28369432649, 36632.45051324179, 36793.0, 37700.24599507939, 37766.0, 49648.0, 49687.25469117894, 49903.500964989886, 50550.494495054576, 52649.0, 6921.653917304014, 7023.122109736283, 7131.750388736369, 7202.279772022755, 7297.416206703345, 10522.736931576772, 10670.57317707283, 10758.946205268923, 10871.945640271748, 11249.775004499701, 9230.815383692423, 9485.241180705389, 9509.191718703987, 9511.619535218513, 9898.851517227104, 9347.953260233655, 9359.672411465566, 9364.812703746024, 9405.153536181777, 9478.099580539838, 9341.20599749029, 9422.858657120012, 9448.716538503855, 9459.91881786006, 9635.951820240854, 6596.406323430914, 6982.720691172296, 7003.789886303419, 7088.0785497884945, 7145.9285407147345, 7432.591207483641, 9206.907930920604, 9388.530573471437, 9642.951785241028, 9728.124468797841], "value": 7858.551072472444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1185.8458400407947, 1346.959591212264, 1383.481194552043, 1441.4594527052354, 1676.5054308978843, 6812.931870681292, 7673.769786906388, 8017.238362355582, 8018.558979256139, 8202.548859812709, 8052.879206811888, 8106.270435660804, 8110.716124935629, 8113.148119447462, 8113.391495637821, 2154.946126346842, 2180.443986783368, 2181.236567201475, 2183.475965768212, 2183.650615901456, 2116.502621883856, 2163.372621939636, 2205.9558808823813, 2210.3258506155616, 2216.26863135165, 2141.764405915348, 2160.2115227941767, 2183.5632873425297, 2191.627423338028, 2198.6372248578964, 2125.7555381131137, 2132.9573408531896, 2137.2092325839385, 2139.0801955159277, 2141.582391433671, 2071.171531387442, 2170.0777169702815, 2170.9891450542805, 2174.3694328644674, 2186.6610675345346, 7389.778306650809, 7477.663505142227, 7502.66238019285, 7872.291493765589, 8107.22981316774, 4370.366296886966, 4512.435945506812, 4514.074614703978, 4521.118381915528, 4522.728636281834, 2801.3556881917275, 2862.41320529291, 2930.633670791151, 2942.7940044196916, 2949.8820047198087, 825.5954582254652, 846.1073567386405, 852.3309202276246, 1721.8364255395843, 1761.1810508113788, 10989.835152472719, 11032.50353734084, 11032.558697652084, 11070.059044981186, 11099.38953357565, 3792.943105853414, 3987.5613682494904, 4062.086030643082, 4067.5525692173837, 4126.896827579274, 8487.236148746642, 8507.957460212783, 8510.659573616986, 8514.74455766328, 8525.914740852637, 4349.064951035542, 4359.367891655692, 4363.869083927487, 4366.781660916941, 4367.2575662137515, 3417.4361230396707, 3506.807125608116, 3945.467361906106, 4101.46680931477, 4112.897177570525, 3367.2423704666253, 3381.644927282649, 3503.8948831535095, 3522.735794815399, 3527.3827080260853, 1015.2690063154517, 1039.4698703661188, 1043.9478026098664, 1047.418682631147, 1052.6473631333436, 687.2474640268897, 802.2258520527719, 805.1586092533199, 805.2068712318362, 820.9302209312156, 5006.674566153189, 5044.646874718735, 5059.924101138486, 5173.4826517347965, 5374.516293533601, 355.8096418416135, 363.7762775892807, 371.5151726996296, 372.93287208302763, 375.66941091839004, 3262.8042317461027, 3392.508086327518, 3398.5921689396937, 3444.8622055118017, 3570.7500474967023, 9489.952550237344, 9904.950475247722, 9911.900880991241, 9945.552450139761, 9966.551505182284, 9789.608415663293, 9793.461359625146, 9812.754681133028, 9816.312858099864, 9820.165285950774, 7368.852622947511, 7459.552426854406, 7460.29127232912, 7460.888086678704, 7466.2160473150625, 4910.8281210157475, 5009.574186194214, 5092.592592592658, 5093.643444958817, 5244.846133850547, 9126.726198214064, 9175.495347755937, 9176.6788162414, 9181.678641247525, 9221.446713197229, 8828.558572071499, 9247.630094796134, 9257.444553326823, 9258.398204116711, 9271.443713377219, 5624.353199382123, 5816.796412125555, 6500.707468164039, 6560.770373036921, 6563.146790917151, 7036.120484939383, 7205.639718013974, 7255.2019277878335, 7399.334059934632, 7404.666789994355, 6532.248791389051, 6625.801225963229, 6636.502262330248, 6796.354346337288, 6858.211305699709, 6614.10709554204, 6741.966290168518, 6788.389044985975, 6794.558353706993, 6808.421284190899, 5926.407359264039, 6005.159277701038, 6006.489448396936, 6008.669523176092, 6012.098185272244, 4339.305711086211, 4601.19479091151, 4609.654275929386, 4640.373549570765, 4652.13935421948, 4370.562943705604, 4442.933355999728, 4525.63794896414, 4638.628909687284, 4741.620670346295], "value": 3993.987226848403, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.43762413789665, 300.96237970253713, 303.7236115135226, 307.91224501017217, 308.63889249577994, 4813.90372192556, 4841.927371089428, 4845.854624361266, 4855.7814898329525, 4866.4160300763915, 4723.0, 4751.170799242291, 4800.279958006301, 4807.855764327067, 4815.4221493420755, 3552.8934131975952, 3616.5895300832694, 3661.5423072115987, 3697.85208591656, 3726.5341832270965, 3727.850885964558, 3731.2910546995986, 3735.514383130203, 3738.831752571141, 3743.28877513273, 3702.241040586673, 3703.962960370402, 3706.906462593528, 3708.3510385682534, 3713.6286371362917, 3532.894013179609, 3602.657747513982, 3656.999999999987, 3690.870819521304, 3718.3864662330684, 3303.537504749337, 3316.336732653479, 3316.436205845012, 3316.9834150829333, 3321.717653999413, 4620.306953956933, 4624.583787459145, 4628.583427491542, 4641.930371044437, 4642.187617166982, 4192.624936925774, 4217.683673724452, 4262.573742625744, 4292.377605247221, 4293.22721910056, 4899.583535399495, 4913.852584422473, 4917.901641967176, 4923.433805112422, 4967.062845490262, 3581.71346292296, 3585.8386372613295, 3592.7305452091196, 3596.6762991330643, 3631.5279013728045, 4984.82553110643, 5137.871553211162, 5162.251473536317, 5202.4537423570355, 5211.348581427322, 3664.193877346979, 3666.5416822897137, 3675.7426980111672, 3679.8344074516713, 3680.1167719747605, 3715.1269451678836, 3719.962800372016, 3727.7017838572847, 3734.925301493955, 3739.8691045813266, 4229.365595160689, 4235.788210589458, 4238.237117318912, 4241.3637954307105, 4266.1254442839145, 4767.713937163781, 4908.214685650279, 4912.189488734319, 4949.282354058713, 4952.158133117378, 1281.589891234796, 1300.440810451496, 1300.7203451257835, 1301.8502872169631, 1309.3584143769674, 810.4245985350467, 834.6103737277487, 845.2435070611768, 856.3106699107154, 856.4005196362571, 4207.789610519523, 4212.30496968003, 4369.628581570602, 4408.382826404306, 4422.0, 5135.666181698178, 5135.974320128375, 5142.382914050263, 5143.97428012865, 5148.922766158511, 4328.28583283761, 4390.441393305395, 4393.924253022897, 4403.581659742384, 4425.114977004548, 2576.458943621823, 2682.390565660588, 2703.3647092933147, 2707.2961030132305, 2707.3637695141624, 4742.478327383985, 4778.522147785194, 4783.784729687172, 4785.880352991203, 4789.832355867528, 4989.550940415307, 5216.426193118754, 5225.6603320784025, 5235.842924712265, 5252.763625636855, 4747.406574178228, 4781.904361912742, 4786.353842231254, 4798.856034318976, 4805.9038819224115, 5085.542301192911, 5122.462141475092, 5136.743162841768, 5137.6660517066275, 5146.819861304836, 4747.881302967454, 5008.749562521933, 5013.222950442687, 5020.42265139499, 5022.573081288131, 4797.544233297831, 4806.2310030394965, 4832.867897947345, 4843.152448321459, 4845.442774081026, 3550.508786309808, 3576.7317451190743, 3586.2648157127205, 3587.65917237862, 3596.2807438511877, 4995.775190116527, 5126.8974620508125, 5140.56305214061, 5148.330717006915, 5157.252198431282, 4993.4808997857, 4998.175301075427, 5002.799888004584, 5028.34631497903, 5057.14028615129, 4963.751812409293, 5003.899922001612, 5030.698158110525, 5036.571891389273, 5058.342415485963, 4825.782839772289, 4943.950560494349, 4963.851084467472, 4965.47862474435, 4980.825671101494, 4792.520747925179, 4858.785303674082, 4909.828156014522, 5007.449180590205, 5055.570276526537, 4894.290327902506, 4915.778789954532, 4920.704757714549, 4922.286268491121, 4943.555080042814], "value": 3758.201202175405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8812598362649, 579.7159391897966, 591.645012992205, 656.6454114778019, 659.7827009168086, 11106.888931110687, 11928.880711192885, 11944.462499187535, 12002.579909703161, 12199.51201951922, 12127.332996685178, 12749.872501274984, 12787.424565894535, 13125.606231813037, 13219.471221151143, 750.6471958179646, 770.3990887108065, 772.2702046565997, 772.30106753388, 772.64072206424, 617.3702823120415, 632.9968350158266, 740.7518481308741, 763.4083585221442, 763.6105586151075, 807.9434439589231, 810.4286478032973, 810.6392655268407, 810.8135128920352, 814.1288820961573, 806.2542148512603, 807.4347956430522, 808.4946908182386, 808.5674164322089, 809.5749731391008, 479.5875547029552, 486.82230985690325, 569.9544036477072, 585.5754577931009, 596.0314488955447, 11527.654170374903, 11574.363410012445, 11586.594469193622, 11587.0, 11603.709907252301, 11058.944705276503, 11553.0, 11557.711057223552, 11705.3562054087, 12417.937910310391, 10766.40784756838, 10950.507227174796, 11153.944230278878, 11260.0, 11268.43657817114, 3924.489816323888, 3945.5462621798574, 3984.86052988144, 4019.095703466726, 4031.6169963853386, 46380.536194637956, 46760.532394676295, 47246.05507889857, 49167.508324917006, 49206.753966230295, 9362.765930851783, 9452.10205030521, 9472.336936414385, 9500.334976551576, 9580.616775329048, 16989.150542472828, 16996.660066798595, 17036.914815425844, 17091.914540427468, 17149.314027439013, 6110.908336374958, 6140.324564297924, 6190.3190649028575, 6301.873962520724, 6367.840803979845, 3412.0, 3490.808005559668, 3521.7358698097746, 3563.2160924596546, 3571.339302229096, 2755.8897644094013, 2846.174609363303, 2852.3297025199063, 2852.3724780548246, 2854.785891058179, 532.1937265043463, 547.4224692948977, 549.3437286580962, 553.8919910617471, 565.5984251181707, 424.7196850078933, 446.48654047845235, 476.833108412053, 479.33133279075497, 502.39712345185194, 8081.313088387553, 8162.632681529345, 8207.097219305871, 8302.16978302177, 8333.791655208546, 523.1786095829588, 540.8188256933971, 544.0859356281485, 549.4807407000426, 557.289455943667, 3723.627637236309, 4166.312558427886, 4309.396684464177, 4468.240399132091, 4500.504944456107, 54534.45465545294, 68709.65645171743, 91437.0, 104229.0, 104461.47769261105, 83651.58174209212, 84060.0, 84732.15267847366, 85825.0, 86943.56528217318, 71226.0, 74188.62905685545, 74742.25257747462, 75030.24969750342, 75340.0, 7953.363730901398, 8353.457025293337, 8601.39790214679, 8664.653413863374, 8896.510691912006, 43145.784271078446, 44100.55899440964, 44646.0, 45739.08521829611, 45956.0, 55682.72158639181, 62903.911245768875, 64896.35103648903, 66334.33665663282, 67782.0, 11244.493997770283, 11459.48432320531, 11474.770504589695, 11669.474873630877, 11950.34273114987, 11779.234349767581, 11803.527858885893, 11887.0, 11990.640280791591, 12391.442385092512, 11208.607698730506, 11399.0, 11589.304641721523, 11597.478113484745, 11607.76784464323, 11300.0, 11492.0, 11523.654290371302, 11683.591074312359, 11872.465739041936, 10784.730381740519, 11062.668119956414, 11119.555217791198, 11151.0, 11224.0, 9329.253659707343, 9348.125257724287, 9702.75743106428, 9863.408195508293, 9966.50167491608, 9620.95189524048, 10231.232657550863, 10268.07587317145, 10362.168029236222, 10374.377537347784], "value": 6311.830060933044, "unit": "score"}], "name": "dromaeo_css", "value": 6175.896315829367, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 115.0, 112.0, 117.0, 114.0, 113.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 129.0, 174.0, 128.0, 129.0, 126.0, 126.0, 162.0, 127.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 162.0, 163.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 117.0, 78.0, 77.0, 77.0, 76.0, 98.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 109.0, 83.0, 84.0, 84.0, 108.0, 83.0, 82.0, 112.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 62.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 70.0, 67.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 85.0, 84.0, 92.0, 84.0, 83.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 141.0, 148.0, 142.0, 144.0, 142.0, 147.0, 175.0, 160.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 177.0, 176.0, 177.0, 174.0, 178.0, 180.0, 176.0, 176.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 70.0, 74.0, 74.0, 71.0, 71.0, 72.0, 69.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1558.7, "alertThreshold": 2.0}]} 14:52:36 INFO - Return code: 0 14:52:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:52:36 INFO - # TBPL SUCCESS # 14:52:36 INFO - Running post-action listener: _resource_record_post_action 14:52:36 INFO - [mozharness: 2016-10-03 21:52:36.328582Z] Finished run-tests step (success) 14:52:36 INFO - Running post-run listener: _resource_record_post_run 14:52:36 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392556544; Read time: 12; Write time: 309760 14:52:36 INFO - TinderboxPrint: CPU usage
13.0% 14:52:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:52:36 INFO - TinderboxPrint: I/O write bytes / time
392,556,544 / 309,760 14:52:36 INFO - TinderboxPrint: CPU idle
8,363.4 (87.0%) 14:52:36 INFO - TinderboxPrint: CPU user
1,203.2 (12.5%) 14:52:36 INFO - TinderboxPrint: Swap in / out
0 / 0 14:52:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100741120; Read time: 0; Write time: 72384 14:52:36 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291278848; Read time: 0; Write time: 237376 14:52:36 INFO - Running post-run listener: _upload_blobber_files 14:52:36 INFO - Blob upload gear active. 14:52:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:36 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 14:52:36 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'] 14:52:36 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 14:52:37 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:52:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:52:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:38 INFO - (blobuploader) - INFO - Done attempting. 14:52:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:52:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:52:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:38 INFO - (blobuploader) - INFO - Done attempting. 14:52:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:52:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:42 INFO - (blobuploader) - INFO - Done attempting. 14:52:42 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:42 INFO - Return code: 0 14:52:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60efb326a1adaefdc89565e0ebddc25371ef0512bd037d268e2c8d74fb7be7a09e50277c74d042d270d7a7de72c65bee61f76dc1dd59ca17bfa4b952848936db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c2a800c21d5ac74769e0e17513526ce917e27ce0e505fad3ef3730054580a2de73d762ac493b2b0644ec169989c57fac4a66a2772aadc30ebdf37e1c929efb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/302a7c9303a61df3c8db399c8bd1a7fda77da853fa081ee4fe21c2c7c06b4733ee3695e87f671b6478f746d47f1cfadaf77304f32915b7ef10c0a44e790153ce"} 14:52:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:42 INFO - Contents: 14:52:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60efb326a1adaefdc89565e0ebddc25371ef0512bd037d268e2c8d74fb7be7a09e50277c74d042d270d7a7de72c65bee61f76dc1dd59ca17bfa4b952848936db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c2a800c21d5ac74769e0e17513526ce917e27ce0e505fad3ef3730054580a2de73d762ac493b2b0644ec169989c57fac4a66a2772aadc30ebdf37e1c929efb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/302a7c9303a61df3c8db399c8bd1a7fda77da853fa081ee4fe21c2c7c06b4733ee3695e87f671b6478f746d47f1cfadaf77304f32915b7ef10c0a44e790153ce"} 14:52:42 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:42 INFO - Copying logs to upload dir... 14:52:42 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.447223 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 14:52:42.153332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 14:52:42.156876) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076 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/60efb326a1adaefdc89565e0ebddc25371ef0512bd037d268e2c8d74fb7be7a09e50277c74d042d270d7a7de72c65bee61f76dc1dd59ca17bfa4b952848936db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c2a800c21d5ac74769e0e17513526ce917e27ce0e505fad3ef3730054580a2de73d762ac493b2b0644ec169989c57fac4a66a2772aadc30ebdf37e1c929efb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/302a7c9303a61df3c8db399c8bd1a7fda77da853fa081ee4fe21c2c7c06b4733ee3695e87f671b6478f746d47f1cfadaf77304f32915b7ef10c0a44e790153ce"} build_url:https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/H9ImJNMgSVmkKFEvOFpwRg/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/60efb326a1adaefdc89565e0ebddc25371ef0512bd037d268e2c8d74fb7be7a09e50277c74d042d270d7a7de72c65bee61f76dc1dd59ca17bfa4b952848936db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c2a800c21d5ac74769e0e17513526ce917e27ce0e505fad3ef3730054580a2de73d762ac493b2b0644ec169989c57fac4a66a2772aadc30ebdf37e1c929efb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/302a7c9303a61df3c8db399c8bd1a7fda77da853fa081ee4fe21c2c7c06b4733ee3695e87f671b6478f746d47f1cfadaf77304f32915b7ef10c0a44e790153ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 14:52:42.183720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:52:42.184108) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475530310.513024-140825076 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:52:42.270970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 14:52:42.271734) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 14:52:42.272373) ========= ========= Total master_lag: 0.19 =========