builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1477898925.14 results: success (0) buildid: 20161030213030 builduid: bbe4db3529974881bfdfca3ff0475f7b revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.136470) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.136956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.137271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.152258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.152594) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 00:28:45-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2016-10-31 00:28:45 (32.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.239385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.239744) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016479 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.289035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.289401) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e017b947cea08b7bdd21007e95bd13e14ad59103 --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 e017b947cea08b7bdd21007e95bd13e14ad59103 --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=516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 00:28:45,751 truncating revision to first 12 chars 2016-10-31 00:28:45,751 Setting DEBUG logging. 2016-10-31 00:28:45,751 attempt 1/10 2016-10-31 00:28:45,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e017b947cea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 00:28:46,059 unpacking tar archive at: fx-team-e017b947cea0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.918989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.919306) ========= script_repo_revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.919732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.920030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 00:28:45.930601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-31 00:28:45.930995) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:28:46 INFO - MultiFileLogger online at 20161031 00:28:46 in /builds/slave/test 00:28:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:28:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:28:46 INFO - {'append_to_log': False, 00:28:46 INFO - 'base_work_dir': '/builds/slave/test', 00:28:46 INFO - 'blob_upload_branch': 'Fx-Team', 00:28:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:28:46 INFO - 'branch': 'Fx-Team', 00:28:46 INFO - 'buildbot_json_path': 'buildprops.json', 00:28:46 INFO - 'config_files': ('talos/linux_config.py',), 00:28:46 INFO - 'default_actions': ('clobber', 00:28:46 INFO - 'read-buildbot-config', 00:28:46 INFO - 'download-and-extract', 00:28:46 INFO - 'populate-webroot', 00:28:46 INFO - 'create-virtualenv', 00:28:46 INFO - 'install', 00:28:46 INFO - 'run-tests'), 00:28:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:28:46 INFO - 'download_minidump_stackwalk': True, 00:28:46 INFO - 'download_symbols': 'ondemand', 00:28:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:28:46 INFO - 'tooltool.py': '/tools/tooltool.py', 00:28:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:28:46 INFO - '/tools/misc-python/virtualenv.py')}, 00:28:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:28:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:28:46 INFO - 'installer_path': 'installer.exe', 00:28:46 INFO - 'log_level': 'info', 00:28:46 INFO - 'log_name': 'talos', 00:28:46 INFO - 'log_to_console': True, 00:28:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:28:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:28:46 INFO - 'opt_config_files': (), 00:28:46 INFO - 'pip_index': False, 00:28:46 INFO - 'sps_profile': False, 00:28:46 INFO - 'sps_profile_interval': 0, 00:28:46 INFO - 'suite': 'dromaeojs', 00:28:46 INFO - 'system_bits': '32', 00:28:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:28:46 INFO - 'title': 'talos-linux64-ix-061', 00:28:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:28:46 INFO - 'use_talos_json': True, 00:28:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:28:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:28:46 INFO - 'work_dir': 'build'} 00:28:46 INFO - [mozharness: 2016-10-31 07:28:46.497822Z] Running clobber step. 00:28:46 INFO - Running pre-action listener: _resource_record_pre_action 00:28:46 INFO - Running main action method: clobber 00:28:46 INFO - rmtree: /builds/slave/test/build 00:28:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:28:47 INFO - Running post-action listener: _resource_record_post_action 00:28:47 INFO - [mozharness: 2016-10-31 07:28:47.468435Z] Finished clobber step (success) 00:28:47 INFO - [mozharness: 2016-10-31 07:28:47.468534Z] Running read-buildbot-config step. 00:28:47 INFO - Running pre-action listener: _resource_record_pre_action 00:28:47 INFO - Running main action method: read_buildbot_config 00:28:47 INFO - Using buildbot properties: 00:28:47 INFO - { 00:28:47 INFO - "project": "", 00:28:47 INFO - "product": "firefox", 00:28:47 INFO - "script_repo_revision": "production", 00:28:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:28:47 INFO - "repository": "", 00:28:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:28:47 INFO - "buildid": "20161030213030", 00:28:47 INFO - "pgo_build": "True", 00:28:47 INFO - "basedir": "/builds/slave/test", 00:28:47 INFO - "buildnumber": 1669, 00:28:47 INFO - "slavename": "talos-linux64-ix-061", 00:28:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:28:47 INFO - "platform": "ubuntu64_hw", 00:28:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:28:47 INFO - "branch": "fx-team", 00:28:47 INFO - "repo_path": "integration/fx-team", 00:28:47 INFO - "revision": "e017b947cea08b7bdd21007e95bd13e14ad59103", 00:28:47 INFO - "stage_platform": "linux64-pgo", 00:28:47 INFO - "builduid": "bbe4db3529974881bfdfca3ff0475f7b", 00:28:47 INFO - "slavebuilddir": "test" 00:28:47 INFO - } 00:28:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:28:47 INFO - Running post-action listener: _resource_record_post_action 00:28:47 INFO - [mozharness: 2016-10-31 07:28:47.471005Z] Finished read-buildbot-config step (success) 00:28:47 INFO - [mozharness: 2016-10-31 07:28:47.471094Z] Running download-and-extract step. 00:28:47 INFO - Running pre-action listener: _resource_record_pre_action 00:28:47 INFO - Running main action method: download_and_extract 00:28:47 INFO - mkdir: /builds/slave/test/build/tests 00:28: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')]} 00:28:47 INFO - trying https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:28:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/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 00:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/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 00:28:48 INFO - Downloaded 1361 bytes. 00:28:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:28:48 INFO - Using the following test package requirements: 00:28:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:28:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:28:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:28:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'jsshell-linux-x86_64.zip'], 00:28:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:28:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:28:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:28:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:28:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:28:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:28:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:28:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:28:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:28:48 INFO - Http code: 200 00:28:48 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 00:28:48 INFO - x-amz-cf-id: _PLKc-qsqz89YAP4UKJWa2v6qgPpXQhK4VkW09DRhNeAhb5PqMV_bg== 00:28:48 INFO - x-amz-version-id: hbfgZDe1XqYmyCNDioOYa6RTzvxPdGi8 00:28:48 INFO - Expected file size: 22006771 00:28:48 INFO - Obtained file size: 22006771 00:28:52 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 00:28:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:28:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:28:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:28:53 INFO - Http code: 200 00:28:53 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 00:28:53 INFO - x-amz-cf-id: PG05qCR9YqQX2o_wT2wGFJqOE-Cqp83n6nD8LprctdDM6lWWbCaJoQ== 00:28:53 INFO - x-amz-version-id: hbfgZDe1XqYmyCNDioOYa6RTzvxPdGi8 00:28:53 INFO - Expected file size: 22006771 00:28:53 INFO - Obtained file size: 22006771 00:28:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:28:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:28:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:28:58 INFO - Http code: 200 00:28:58 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 00:28:58 INFO - x-amz-cf-id: vJRBLNwQab1DoT05lMlj4485qfbJm5moVcsdG4pbgfFIZchEirtgtg== 00:28:58 INFO - x-amz-version-id: Iec6I0AHYZvF4V1ePyS84b8U6C_rwpvU 00:28:59 INFO - Expected file size: 14409038 00:28:59 INFO - Obtained file size: 14409038 00:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:28:59 INFO - trying https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:28:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/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 00:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/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 00:29:01 INFO - Downloaded 59606250 bytes. 00:29:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:29:01 INFO - mkdir: /builds/slave/test/properties 00:29:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:29:01 INFO - Writing to file /builds/slave/test/properties/build_url 00:29:01 INFO - Contents: 00:29:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:29:02 INFO - Running post-action listener: _resource_record_post_action 00:29:02 INFO - Running post-action listener: set_extra_try_arguments 00:29:02 INFO - [mozharness: 2016-10-31 07:29:02.023729Z] Finished download-and-extract step (success) 00:29:02 INFO - [mozharness: 2016-10-31 07:29:02.023956Z] Running populate-webroot step. 00:29:02 INFO - Running pre-action listener: _resource_record_pre_action 00:29:02 INFO - Running main action method: populate_webroot 00:29:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:29:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:29:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:29:02 INFO - '--tppagecycles', 00:29:02 INFO - '7'], 00:29:02 INFO - 'tests': ['tsvgm']}}, 00:29:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:29:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:29:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:29:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:29:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:29:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:29:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['damp', 'tps']}, 00:29:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'tests': ['damp', 'tps']}, 00:29:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['dromaeo_dom']}, 00:29:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:29:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['basic_compositor_video']}, 00:29:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:29:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['a11yr', 00:29:02 INFO - 'ts_paint', 00:29:02 INFO - 'tpaint', 00:29:02 INFO - 'sessionrestore', 00:29:02 INFO - 'sessionrestore_no_auto_restore', 00:29:02 INFO - 'tabpaint']}, 00:29:02 INFO - 'other-e10s': {'tests': ['a11yr', 00:29:02 INFO - 'ts_paint', 00:29:02 INFO - 'tpaint', 00:29:02 INFO - 'sessionrestore', 00:29:02 INFO - 'sessionrestore_no_auto_restore', 00:29:02 INFO - 'tabpaint']}, 00:29:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:29:02 INFO - 'ts_paint', 00:29:02 INFO - 'tpaint', 00:29:02 INFO - 'sessionrestore', 00:29:02 INFO - 'sessionrestore_no_auto_restore', 00:29:02 INFO - 'tabpaint']}, 00:29:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:29:02 INFO - 'ts_paint', 00:29:02 INFO - 'tpaint', 00:29:02 INFO - 'sessionrestore', 00:29:02 INFO - 'sessionrestore_no_auto_restore', 00:29:02 INFO - 'tabpaint']}, 00:29:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['a11yr', 00:29:02 INFO - 'ts_paint', 00:29:02 INFO - 'tpaint', 00:29:02 INFO - 'sessionrestore', 00:29:02 INFO - 'sessionrestore_no_auto_restore', 00:29:02 INFO - 'tabpaint']}, 00:29:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['a11yr', 00:29:02 INFO - 'ts_paint', 00:29:02 INFO - 'tpaint', 00:29:02 INFO - 'sessionrestore', 00:29:02 INFO - 'sessionrestore_no_auto_restore', 00:29:02 INFO - 'tabpaint']}, 00:29:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['tsvgx', 00:29:02 INFO - 'tsvgr_opacity', 00:29:02 INFO - 'tart', 00:29:02 INFO - 'tscrollx', 00:29:02 INFO - 'cart']}, 00:29:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:29:02 INFO - 'tsvgr_opacity', 00:29:02 INFO - 'tart', 00:29:02 INFO - 'tscrollx', 00:29:02 INFO - 'cart']}, 00:29:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'talos_options': ['--disable-e10s'], 00:29:02 INFO - 'tests': ['tp5o']}, 00:29:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'tests': ['tp5o']}, 00:29:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'talos_options': ['--disable-e10s', 00:29:02 INFO - '--xperf_path', 00:29:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:29:02 INFO - 'tests': ['tp5n']}, 00:29:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:29:02 INFO - 'talos_options': ['--xperf_path', 00:29:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:29:02 INFO - 'tests': ['tp5n']}}, 00:29:02 INFO - 'talos.zip': {'path': '', 00:29:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:29:02 INFO - Running post-action listener: _resource_record_post_action 00:29:02 INFO - [mozharness: 2016-10-31 07:29:02.043589Z] Finished populate-webroot step (success) 00:29:02 INFO - [mozharness: 2016-10-31 07:29:02.043677Z] Running create-virtualenv step. 00:29:02 INFO - Running pre-action listener: _resource_record_pre_action 00:29:02 INFO - Running main action method: create_virtualenv 00:29:02 INFO - Creating virtualenv /builds/slave/test/build/venv 00:29:02 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 00:29:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:29:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:29:02 INFO - Using real prefix '/usr' 00:29:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:29:02 INFO - Installing distribute.............................................................................................................................................................................................done. 00:29:04 INFO - Installing pip.................done. 00:29:04 INFO - Return code: 0 00:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:29:04 INFO - Reading from file tmpfile_stdout 00:29:04 INFO - Output received: 00:29:04 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) 00:29:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:29:04 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')]} 00:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:04 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')]} 00:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:04 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:04 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 00:29:04 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 00:29:04 INFO - Using env: {'DISPLAY': ':0', 00:29:04 INFO - 'HOME': '/home/cltbld', 00:29:04 INFO - 'LANG': 'en_US.UTF-8', 00:29:04 INFO - 'LANGUAGE': 'en_US:en', 00:29:04 INFO - 'LOGNAME': 'cltbld', 00:29:04 INFO - 'MAIL': '/var/mail/cltbld', 00:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:04 INFO - 'MOZ_NO_REMOTE': '1', 00:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:04 INFO - 'NO_EM_RESTART': '1', 00:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:04 INFO - 'PWD': '/builds/slave/test', 00:29:04 INFO - 'SHELL': '/bin/bash', 00:29:04 INFO - 'SHLVL': '1', 00:29:04 INFO - 'TERM': 'linux', 00:29:04 INFO - 'TMOUT': '86400', 00:29:04 INFO - 'USER': 'cltbld', 00:29:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:04 INFO - '_': '/tools/buildbot/bin/python'} 00:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:05 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 00:29:05 INFO - Cleaning up... 00:29:05 INFO - Return code: 0 00:29:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:29: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')]} 00:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29: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')]} 00:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:05 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:05 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 00:29:05 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 00:29:05 INFO - Using env: {'DISPLAY': ':0', 00:29:05 INFO - 'HOME': '/home/cltbld', 00:29:05 INFO - 'LANG': 'en_US.UTF-8', 00:29:05 INFO - 'LANGUAGE': 'en_US:en', 00:29:05 INFO - 'LOGNAME': 'cltbld', 00:29:05 INFO - 'MAIL': '/var/mail/cltbld', 00:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:05 INFO - 'MOZ_NO_REMOTE': '1', 00:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:05 INFO - 'NO_EM_RESTART': '1', 00:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:05 INFO - 'PWD': '/builds/slave/test', 00:29:05 INFO - 'SHELL': '/bin/bash', 00:29:05 INFO - 'SHLVL': '1', 00:29:05 INFO - 'TERM': 'linux', 00:29:05 INFO - 'TMOUT': '86400', 00:29:05 INFO - 'USER': 'cltbld', 00:29:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:05 INFO - '_': '/tools/buildbot/bin/python'} 00:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:05 INFO - Downloading/unpacking psutil>=3.1.1 00:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:29:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:29:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:29:07 INFO - Installing collected packages: psutil 00:29:07 INFO - Running setup.py install for psutil 00:29:07 INFO - building 'psutil._psutil_linux' extension 00:29:07 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 00:29:07 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 00:29:07 INFO - building 'psutil._psutil_posix' extension 00:29:07 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 00:29:07 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 00:29:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:29:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:29:07 INFO - Successfully installed psutil 00:29:07 INFO - Cleaning up... 00:29:07 INFO - Return code: 0 00:29:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:29:07 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')]} 00:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:07 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')]} 00:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:07 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:07 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 00:29:07 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 00:29:07 INFO - Using env: {'DISPLAY': ':0', 00:29:07 INFO - 'HOME': '/home/cltbld', 00:29:07 INFO - 'LANG': 'en_US.UTF-8', 00:29:07 INFO - 'LANGUAGE': 'en_US:en', 00:29:07 INFO - 'LOGNAME': 'cltbld', 00:29:07 INFO - 'MAIL': '/var/mail/cltbld', 00:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:07 INFO - 'MOZ_NO_REMOTE': '1', 00:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:07 INFO - 'NO_EM_RESTART': '1', 00:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:07 INFO - 'PWD': '/builds/slave/test', 00:29:07 INFO - 'SHELL': '/bin/bash', 00:29:07 INFO - 'SHLVL': '1', 00:29:07 INFO - 'TERM': 'linux', 00:29:07 INFO - 'TMOUT': '86400', 00:29:07 INFO - 'USER': 'cltbld', 00:29:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:07 INFO - '_': '/tools/buildbot/bin/python'} 00:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:29:08 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 00:29:08 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 00:29:08 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 00:29:08 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 00:29:08 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 00:29:08 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 00:29:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:29:10 INFO - Installing collected packages: mozsystemmonitor 00:29:10 INFO - Running setup.py install for mozsystemmonitor 00:29:10 INFO - Successfully installed mozsystemmonitor 00:29:10 INFO - Cleaning up... 00:29:10 INFO - Return code: 0 00:29:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:29:10 INFO - Using env: {'DISPLAY': ':0', 00:29:10 INFO - 'HOME': '/home/cltbld', 00:29:10 INFO - 'LANG': 'en_US.UTF-8', 00:29:10 INFO - 'LANGUAGE': 'en_US:en', 00:29:10 INFO - 'LOGNAME': 'cltbld', 00:29:10 INFO - 'MAIL': '/var/mail/cltbld', 00:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:10 INFO - 'MOZ_NO_REMOTE': '1', 00:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:10 INFO - 'NO_EM_RESTART': '1', 00:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:10 INFO - 'PWD': '/builds/slave/test', 00:29:10 INFO - 'SHELL': '/bin/bash', 00:29:10 INFO - 'SHLVL': '1', 00:29:10 INFO - 'TERM': 'linux', 00:29:10 INFO - 'TMOUT': '86400', 00:29:10 INFO - 'USER': 'cltbld', 00:29:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:10 INFO - '_': '/tools/buildbot/bin/python'} 00:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:10 INFO - Downloading/unpacking jsonschema==2.5.1 00:29:10 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 00:29:10 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 00:29:10 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 00:29:10 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 00:29:10 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 00:29:10 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 00:29:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:29:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:29: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 00:29: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 00:29: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 00:29: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 00:29: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 00:29: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 00:29:12 INFO - Downloading functools32-3.2.3-2.tar.gz 00:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:29:12 INFO - warning: no files found matching '*.txt' 00:29:12 INFO - no previously-included directories found matching 'build' 00:29:12 INFO - no previously-included directories found matching 'dist' 00:29:12 INFO - no previously-included directories found matching '.git*' 00:29:12 INFO - Installing collected packages: jsonschema, functools32 00:29:12 INFO - Running setup.py install for functools32 00:29:12 INFO - warning: no files found matching '*.txt' 00:29:12 INFO - no previously-included directories found matching 'build' 00:29:12 INFO - no previously-included directories found matching 'dist' 00:29:12 INFO - no previously-included directories found matching '.git*' 00:29:12 INFO - Successfully installed jsonschema functools32 00:29:12 INFO - Cleaning up... 00:29:12 INFO - Return code: 0 00:29:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:29:12 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')]} 00:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:12 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')]} 00:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:12 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:12 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 00:29:12 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 00:29:12 INFO - Using env: {'DISPLAY': ':0', 00:29:12 INFO - 'HOME': '/home/cltbld', 00:29:12 INFO - 'LANG': 'en_US.UTF-8', 00:29:12 INFO - 'LANGUAGE': 'en_US:en', 00:29:12 INFO - 'LOGNAME': 'cltbld', 00:29:12 INFO - 'MAIL': '/var/mail/cltbld', 00:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:12 INFO - 'MOZ_NO_REMOTE': '1', 00:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:12 INFO - 'NO_EM_RESTART': '1', 00:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:12 INFO - 'PWD': '/builds/slave/test', 00:29:12 INFO - 'SHELL': '/bin/bash', 00:29:12 INFO - 'SHLVL': '1', 00:29:12 INFO - 'TERM': 'linux', 00:29:12 INFO - 'TMOUT': '86400', 00:29:12 INFO - 'USER': 'cltbld', 00:29:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:12 INFO - '_': '/tools/buildbot/bin/python'} 00:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:29:13 INFO - Cleaning up... 00:29:13 INFO - Return code: 0 00:29:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:13 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:13 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 00:29:13 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 00:29:13 INFO - Using env: {'DISPLAY': ':0', 00:29:13 INFO - 'HOME': '/home/cltbld', 00:29:13 INFO - 'LANG': 'en_US.UTF-8', 00:29:13 INFO - 'LANGUAGE': 'en_US:en', 00:29:13 INFO - 'LOGNAME': 'cltbld', 00:29:13 INFO - 'MAIL': '/var/mail/cltbld', 00:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:13 INFO - 'MOZ_NO_REMOTE': '1', 00:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:13 INFO - 'NO_EM_RESTART': '1', 00:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:13 INFO - 'PWD': '/builds/slave/test', 00:29:13 INFO - 'SHELL': '/bin/bash', 00:29:13 INFO - 'SHLVL': '1', 00:29:13 INFO - 'TERM': 'linux', 00:29:13 INFO - 'TMOUT': '86400', 00:29:13 INFO - 'USER': 'cltbld', 00:29:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:13 INFO - '_': '/tools/buildbot/bin/python'} 00:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:13 INFO - Downloading/unpacking blobuploader==1.2.4 00:29:13 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 00:29:13 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 00:29:13 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 00:29:13 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 00:29:13 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 00:29:13 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 00:29:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:29:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:29:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 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 00:29:15 INFO - Downloading docopt-0.6.1.tar.gz 00:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 00:29:16 INFO - Running setup.py install for blobuploader 00:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:29:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:29:16 INFO - Running setup.py install for requests 00:29:16 INFO - Running setup.py install for docopt 00:29:16 INFO - Successfully installed blobuploader requests docopt 00:29:16 INFO - Cleaning up... 00:29:16 INFO - Return code: 0 00:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29: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')]} 00:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29: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')]} 00:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:16 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:16 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 00:29:16 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 00:29:16 INFO - Using env: {'DISPLAY': ':0', 00:29:16 INFO - 'HOME': '/home/cltbld', 00:29:16 INFO - 'LANG': 'en_US.UTF-8', 00:29:16 INFO - 'LANGUAGE': 'en_US:en', 00:29:16 INFO - 'LOGNAME': 'cltbld', 00:29:16 INFO - 'MAIL': '/var/mail/cltbld', 00:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:16 INFO - 'MOZ_NO_REMOTE': '1', 00:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:16 INFO - 'NO_EM_RESTART': '1', 00:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:16 INFO - 'PWD': '/builds/slave/test', 00:29:16 INFO - 'SHELL': '/bin/bash', 00:29:16 INFO - 'SHLVL': '1', 00:29:16 INFO - 'TERM': 'linux', 00:29:16 INFO - 'TMOUT': '86400', 00:29:16 INFO - 'USER': 'cltbld', 00:29:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:16 INFO - '_': '/tools/buildbot/bin/python'} 00:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:29:16 INFO - Running setup.py (path:/tmp/pip-42pPLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:29:16 INFO - Running setup.py (path:/tmp/pip-tRjNty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:29:17 INFO - Running setup.py (path:/tmp/pip-a00ItD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:29:17 INFO - Running setup.py (path:/tmp/pip-UR5gBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:29:17 INFO - Running setup.py (path:/tmp/pip-st25MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:29:17 INFO - Running setup.py (path:/tmp/pip-Q9JMlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:29:17 INFO - Running setup.py (path:/tmp/pip-ryn5mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:29:17 INFO - Running setup.py (path:/tmp/pip-eC7QVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:29:17 INFO - Running setup.py (path:/tmp/pip-jKKDXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:29:17 INFO - Running setup.py (path:/tmp/pip-Bz020g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:29:17 INFO - Running setup.py (path:/tmp/pip-BgV2Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:29:17 INFO - Running setup.py (path:/tmp/pip-eejgGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:29:17 INFO - Running setup.py (path:/tmp/pip-umEOkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:29:17 INFO - Running setup.py (path:/tmp/pip-5HKRAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:17 INFO - Running setup.py (path:/tmp/pip-U0eKfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:29:18 INFO - Running setup.py (path:/tmp/pip-i27yQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:29:18 INFO - Running setup.py (path:/tmp/pip-lY5xl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:29:18 INFO - Running setup.py install for manifestparser 00:29:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Running setup.py install for mozcrash 00:29:18 INFO - Running setup.py install for mozdebug 00:29:18 INFO - Running setup.py install for mozdevice 00:29:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Running setup.py install for mozfile 00:29:18 INFO - Running setup.py install for mozhttpd 00:29:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Running setup.py install for mozinfo 00:29:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Running setup.py install for mozInstall 00:29:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:29:18 INFO - Running setup.py install for mozleak 00:29:19 INFO - Running setup.py install for mozlog 00:29:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Running setup.py install for moznetwork 00:29:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Running setup.py install for mozprocess 00:29:19 INFO - Running setup.py install for mozprofile 00:29:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Running setup.py install for mozrunner 00:29:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Running setup.py install for mozscreenshot 00:29:19 INFO - Running setup.py install for moztest 00:29:19 INFO - Running setup.py install for mozversion 00:29:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:29:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:29:19 INFO - Cleaning up... 00:29:19 INFO - Return code: 0 00:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29: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')]} 00:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29: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')]} 00:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:19 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:19 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 00:29:19 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 00:29:19 INFO - Using env: {'DISPLAY': ':0', 00:29:19 INFO - 'HOME': '/home/cltbld', 00:29:19 INFO - 'LANG': 'en_US.UTF-8', 00:29:19 INFO - 'LANGUAGE': 'en_US:en', 00:29:19 INFO - 'LOGNAME': 'cltbld', 00:29:19 INFO - 'MAIL': '/var/mail/cltbld', 00:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:19 INFO - 'MOZ_NO_REMOTE': '1', 00:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:19 INFO - 'NO_EM_RESTART': '1', 00:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:19 INFO - 'PWD': '/builds/slave/test', 00:29:19 INFO - 'SHELL': '/bin/bash', 00:29:19 INFO - 'SHLVL': '1', 00:29:19 INFO - 'TERM': 'linux', 00:29:19 INFO - 'TMOUT': '86400', 00:29:19 INFO - 'USER': 'cltbld', 00:29:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:19 INFO - '_': '/tools/buildbot/bin/python'} 00:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:29:20 INFO - Running setup.py (path:/tmp/pip-Y4JIu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:29:20 INFO - Running setup.py (path:/tmp/pip-pHNCRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:29:20 INFO - Running setup.py (path:/tmp/pip-PDvCAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:29:20 INFO - Running setup.py (path:/tmp/pip-pKlSM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:29:20 INFO - Running setup.py (path:/tmp/pip-rqlxzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:29:20 INFO - Running setup.py (path:/tmp/pip-aiTxIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:29:20 INFO - Running setup.py (path:/tmp/pip-iRSJPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:29:20 INFO - Running setup.py (path:/tmp/pip-9Dse56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:29:20 INFO - Running setup.py (path:/tmp/pip-9zDna8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:29:20 INFO - Running setup.py (path:/tmp/pip-tRAKS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:29:20 INFO - Running setup.py (path:/tmp/pip-7aU7Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:29:20 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)) 00:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:29:20 INFO - Running setup.py (path:/tmp/pip-_GgFnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:29:21 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)) 00:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:29:21 INFO - Running setup.py (path:/tmp/pip-UNEy3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:29:21 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)) 00:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:29:21 INFO - Running setup.py (path:/tmp/pip-_UEcBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:29:21 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)) 00:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:21 INFO - Running setup.py (path:/tmp/pip-eSrgl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:21 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)) 00:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:29:21 INFO - Running setup.py (path:/tmp/pip-ILYyOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:29:21 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)) 00:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:29:21 INFO - Running setup.py (path:/tmp/pip-4WffcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:29:21 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)) 00:29:21 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)) 00:29:21 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)) 00:29:21 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)) 00:29:21 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)) 00:29:21 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)) 00:29:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:29: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 00:29: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 00:29: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 00:29: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 00:29: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 00:29: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 00:29:23 INFO - Downloading blessings-1.6.tar.gz 00:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:29:23 INFO - Installing collected packages: blessings 00:29:23 INFO - Running setup.py install for blessings 00:29:23 INFO - Successfully installed blessings 00:29:23 INFO - Cleaning up... 00:29:23 INFO - Return code: 0 00:29:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:29:23 INFO - Reading from file tmpfile_stdout 00:29:23 INFO - Current package versions: 00:29:23 INFO - argparse == 1.2.1 00:29:23 INFO - blessings == 1.6 00:29:23 INFO - blobuploader == 1.2.4 00:29:23 INFO - docopt == 0.6.1 00:29:23 INFO - functools32 == 3.2.3-2 00:29:23 INFO - jsonschema == 2.5.1 00:29:23 INFO - manifestparser == 1.1 00:29:23 INFO - mozInstall == 1.12 00:29:23 INFO - mozcrash == 0.17 00:29:23 INFO - mozdebug == 0.1 00:29:23 INFO - mozdevice == 0.48 00:29:23 INFO - mozfile == 1.2 00:29:23 INFO - mozhttpd == 0.7 00:29:23 INFO - mozinfo == 0.9 00:29:23 INFO - mozleak == 0.1 00:29:23 INFO - mozlog == 3.4 00:29:23 INFO - moznetwork == 0.27 00:29:23 INFO - mozprocess == 0.23 00:29:23 INFO - mozprofile == 0.28 00:29:23 INFO - mozrunner == 6.12 00:29:23 INFO - mozscreenshot == 0.1 00:29:23 INFO - mozsystemmonitor == 0.3 00:29:23 INFO - moztest == 0.7 00:29:23 INFO - mozversion == 1.4 00:29:23 INFO - psutil == 3.1.1 00:29:23 INFO - requests == 1.2.3 00:29:23 INFO - wsgiref == 0.1.2 00:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29: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')]} 00:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29: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')]} 00:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:23 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 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:23 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 00:29:23 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 00:29:23 INFO - Using env: {'DISPLAY': ':0', 00:29:23 INFO - 'HOME': '/home/cltbld', 00:29:23 INFO - 'LANG': 'en_US.UTF-8', 00:29:23 INFO - 'LANGUAGE': 'en_US:en', 00:29:23 INFO - 'LOGNAME': 'cltbld', 00:29:23 INFO - 'MAIL': '/var/mail/cltbld', 00:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:23 INFO - 'MOZ_NO_REMOTE': '1', 00:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:23 INFO - 'NO_EM_RESTART': '1', 00:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:23 INFO - 'PWD': '/builds/slave/test', 00:29:23 INFO - 'SHELL': '/bin/bash', 00:29:23 INFO - 'SHLVL': '1', 00:29:23 INFO - 'TERM': 'linux', 00:29:23 INFO - 'TMOUT': '86400', 00:29:23 INFO - 'USER': 'cltbld', 00:29:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:23 INFO - '_': '/tools/buildbot/bin/python'} 00:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 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)) 00:29:24 INFO - Cleaning up... 00:29:24 INFO - Return code: 0 00:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa160eeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', '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 00:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:29:24 INFO - Using env: {'DISPLAY': ':0', 00:29:24 INFO - 'HOME': '/home/cltbld', 00:29:24 INFO - 'LANG': 'en_US.UTF-8', 00:29:24 INFO - 'LANGUAGE': 'en_US:en', 00:29:24 INFO - 'LOGNAME': 'cltbld', 00:29:24 INFO - 'MAIL': '/var/mail/cltbld', 00:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:24 INFO - 'MOZ_NO_REMOTE': '1', 00:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:24 INFO - 'NO_EM_RESTART': '1', 00:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:24 INFO - 'PWD': '/builds/slave/test', 00:29:24 INFO - 'SHELL': '/bin/bash', 00:29:24 INFO - 'SHLVL': '1', 00:29:24 INFO - 'TERM': 'linux', 00:29:24 INFO - 'TMOUT': '86400', 00:29:24 INFO - 'USER': 'cltbld', 00:29:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:24 INFO - '_': '/tools/buildbot/bin/python'} 00:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:29:24 INFO - Cleaning up... 00:29:24 INFO - Return code: 0 00:29:24 INFO - Running post-action listener: _resource_record_post_action 00:29:24 INFO - Running post-action listener: _start_resource_monitoring 00:29:24 INFO - Starting resource monitoring. 00:29:24 INFO - [mozharness: 2016-10-31 07:29:24.285541Z] Finished create-virtualenv step (success) 00:29:24 INFO - [mozharness: 2016-10-31 07:29:24.286047Z] Running install step. 00:29:24 INFO - Running pre-action listener: _resource_record_pre_action 00:29:24 INFO - Running main action method: install 00:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:29:24 INFO - Reading from file tmpfile_stdout 00:29:24 INFO - Detecting whether we're running mozinstall >=1.0... 00:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:29:24 INFO - Reading from file tmpfile_stdout 00:29:24 INFO - Output received: 00:29:24 INFO - Usage: mozinstall [options] installer 00:29:24 INFO - Options: 00:29:24 INFO - -h, --help show this help message and exit 00:29:24 INFO - -d DEST, --destination=DEST 00:29:24 INFO - Directory to install application into. [default: 00:29:24 INFO - "/builds/slave/test"] 00:29:24 INFO - --app=APP Application being installed. [default: firefox] 00:29:24 INFO - mkdir: /builds/slave/test/build/application 00:29:24 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'] 00:29:24 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 00:29:41 INFO - Reading from file tmpfile_stdout 00:29:41 INFO - Output received: 00:29:41 INFO - /builds/slave/test/build/application/firefox/firefox 00:29:41 INFO - Running post-action listener: _resource_record_post_action 00:29:41 INFO - [mozharness: 2016-10-31 07:29:41.560203Z] Finished install step (success) 00:29:41 INFO - [mozharness: 2016-10-31 07:29:41.560447Z] Running run-tests step. 00:29:41 INFO - Running pre-action listener: _resource_record_pre_action 00:29:41 INFO - Running main action method: run_tests 00:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:29:41 INFO - Python 2.7.3 00:29:41 INFO - Return code: 0 00:29:41 INFO - grabbing minidump binary from tooltool 00:29:41 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')]} 00:29:41 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 0x263c790>, '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 0x263d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:29:41 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 00:29:41 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 00:29:41 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 00:29:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:29:41 INFO - Return code: 0 00:29:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:29:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:29:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:29:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:29:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 00:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 00:29:41 INFO - Using env: {'DISPLAY': ':0', 00:29:41 INFO - 'HOME': '/home/cltbld', 00:29:41 INFO - 'LANG': 'en_US.UTF-8', 00:29:41 INFO - 'LANGUAGE': 'en_US:en', 00:29:41 INFO - 'LOGNAME': 'cltbld', 00:29:41 INFO - 'MAIL': '/var/mail/cltbld', 00:29:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:29:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:41 INFO - 'MOZ_NO_REMOTE': '1', 00:29:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:29:41 INFO - 'NO_EM_RESTART': '1', 00:29:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:41 INFO - 'PWD': '/builds/slave/test', 00:29:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:29:41 INFO - 'SHELL': '/bin/bash', 00:29:41 INFO - 'SHLVL': '1', 00:29:41 INFO - 'TERM': 'linux', 00:29:41 INFO - 'TMOUT': '86400', 00:29:41 INFO - 'USER': 'cltbld', 00:29:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865', 00:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:41 INFO - '_': '/tools/buildbot/bin/python'} 00:29:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 00:29:41 INFO - mozversion application_buildid: 20161030213030 00:29:41 INFO - mozversion application_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 00:29:41 INFO - mozversion application_display_name: Nightly 00:29:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:29:41 INFO - mozversion application_name: Firefox 00:29:41 INFO - mozversion application_remotingname: firefox 00:29:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:29:41 INFO - mozversion application_vendor: Mozilla 00:29:41 INFO - mozversion application_version: 52.0a1 00:29:41 INFO - mozversion platform_buildid: 20161030213030 00:29:41 INFO - mozversion platform_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 00:29:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:29:41 INFO - mozversion platform_version: 52.0a1 00:29:41 INFO - using testdate: 1477898981 00:29:41 INFO - actual date: 1477898981 00:29:41 INFO - starting webserver on 'localhost:41282' 00:29:41 INFO - SUITE-START | Running 2 tests 00:29:41 INFO - TEST-START | dromaeo_css 00:29:41 INFO - operating with platform_type : linux_ 00:29:41 INFO - Initialising browser for dromaeo_css test... 00:29:41 INFO - TEST-INFO | started process 6994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mwAuP/profile http://localhost:41282/getInfo.html) 00:29:46 INFO - PROCESS | 6994 | __metrics Screen width/height:1600/1200 00:29:46 INFO - PROCESS | 6994 | colorDepth:24 00:29:46 INFO - PROCESS | 6994 | Browser inner width/height: 1024/697 00:29:46 INFO - PROCESS | 6994 | __metrics 00:29:46 INFO - PROCESS | 6994 | 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" 00:29:46 INFO - PROCESS | 6994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:29:47 INFO - PROCESS | 6994 | console.error: PushService: 00:29:47 INFO - PROCESS | 6994 | stateChangeProcessEnqueue: Error transitioning state 00:29:47 INFO - PROCESS | 6994 | UnknownError 00:29:48 INFO - TEST-INFO | 6994: exit 0 00:29:48 INFO - Browser initialized. 00:29:48 INFO - Running cycle 1/1 for dromaeo_css test... 00:29:48 INFO - TEST-INFO | started process 7081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mwAuP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:30:00 INFO - PROCESS | 7081 | RSS: Main: 174813184 00:30:00 INFO - PROCESS | 7081 | 00:30:51 INFO - PROCESS | 7081 | 1477899051684 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] 00:33:02 INFO - PROCESS | 7081 | Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41282/tests/dromaeo/cssquery-ext.html) 00:33:03 INFO - PROCESS | 7081 | RSS: Main: 283385856 00:33:03 INFO - PROCESS | 7081 | 00:36:06 INFO - PROCESS | 7081 | Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-ext.html (next: http://localhost:41282/tests/dromaeo/cssquery-jquery.html) 00:36:06 INFO - PROCESS | 7081 | RSS: Main: 282370048 00:36:06 INFO - PROCESS | 7081 | 00:39:09 INFO - PROCESS | 7081 | Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41282/tests/dromaeo/cssquery-mootools.html) 00:39:09 INFO - PROCESS | 7081 | RSS: Main: 291303424 00:39:09 INFO - PROCESS | 7081 | 00:42:11 INFO - PROCESS | 7081 | Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41282/tests/dromaeo/cssquery-prototype.html) 00:42:12 INFO - PROCESS | 7081 | RSS: Main: 221954048 00:42:12 INFO - PROCESS | 7081 | 00:45:15 INFO - PROCESS | 7081 | Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41282/tests/dromaeo/cssquery-yui.html) 00:45:15 INFO - PROCESS | 7081 | RSS: Main: 221265920 00:45:15 INFO - PROCESS | 7081 | 00:48:18 INFO - PROCESS | 7081 | Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-yui.html (next: http://localhost:41282/tests/dromaeo/cssquery-dojo.html) 00:48:19 INFO - PROCESS | 7081 | RSS: Main: 314023936 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | __start_tp_report 00:48:19 INFO - PROCESS | 7081 | _x_x_mozilla_page_load 00:48:19 INFO - PROCESS | 7081 | _x_x_mozilla_page_load_details 00:48:19 INFO - PROCESS | 7081 | |i|pagename|runs| 00:48:19 INFO - PROCESS | 7081 | |0;dojo.html;3030.2727345437092;3057.938841223177;3074.538819177124;3105.7204851563356;3107.3474570340213;5140.100482415572;5190.71451070191;5305.41640419554;5363.46365363464;5377.139657654771;5228.764705588248;5244.160934250521;5273.947260527393;5281.128613778722;5374.032674118657;4815.133276010317;4870.318155458239;4871.269309603553;4882.048000639877;4885.120678277917;4427.850564569047;4867.464578896319;4878.536539028804;4910.067087253428;4966.602671786249;5016.623753218505;5035.068512325213;5055.216441451581;5071.087204303224;5090.567301779334;4718.150732868083;4751.904961900743;4754.643401744848;4961.8511444656715;5043.747812609355;4823.927641085386;4882.584980276681;4905.681130726492;4920.3357546731095;4981.800727970877;5340.813071542478;5363.490468405495;5370.624056316059;5393.919091213635;5443.074677304868;5528.419515950807;5750.683712395817;5756.136579513065;5758;5758.827235182951;5650.463205995465;5696.8006119785605;5721.7711291548285;5751.309842818889;5836.737346819404;5382.4886635769535;5383.327084114486;5384.542313903362;5385.703786291752;5391.81128660499;5850.385709500526;5853.414658534198;5857.26784151981;5866.794662186803;5869.618474799125;5452.963936852065;5507.9449205507435;5582.469665381782;5654.349749778746;5661.065924122474;5695.202671625976;5746.511546518593;5748.770049198069;5751.396103409165;5795.768169273182;5673.432656734376;5711.828645140652;5737.3115226172295;5737.85655358611;5739.311282646109;5540;5605.775768969195;5606.018946684314;5679.318481782213;5759.596828221985;4346.695731298779;4367;4373.234683930299;4376.212281789309;4402.537733537996;3936.5079365079364;3979.602039796055;3980.3233450313514;3995.300822356076;4003.039270575041;5442.319710036246;5447.782088716486;5447.891042179134;5452.1276595745285;5460.126379779216;5482.862928426821;5543.833684989457;5743.684097374601;5793.275840519935;5794.971025144847;5180.585553155738;5213.817516386908;5228.895422091537;5251.711155886463;5319.734013299397;4829.855104346875;4831.0820944020525;4832.178529649968;4836.516348365135;4888.242322439956;5658.5473162147755;5734.655920644775;5742.196092546963;5757.0788673811985;5759.308882934075;5579.944200558105;5668.631538949955;5669.4047125051275;5721.199032135588;5738.196652468574;5897.70511474416;5936.406359364029;5955.315138758925;5959.7020148991505;6016.939830601813;5615.747291371979;5624.803131890364;5643.125315576092;5643.604947653789;5655.72746132117;5496.4503549646315;5566.666000040011;5567.66594004361;5573.7770489179975;5734.827955161185;5522.5581953442825;5530.336359636869;5532.861678458071;5580.441955804387;5597.692126933058;5445.564354851523;5484.753186106715;5489.835304940858;5491.560675145899;5507.917381239365;5317.415084340642;5387.380451248;5415.512603865671;5500.092484740133;5531;5625.353084395183;5630.802921897878;5632.436756324335;5669.20631111653;5697.971510142423;5311.760970756248;5451.073317535949;5512.2558454608115;5518.089515229942;5520.447955204608 00:48:19 INFO - PROCESS | 7081 | |1;ext.html;576.1616847486906;588.9587728858979;598.3149294058303;601.0983524712931;605.6214865708932;32013.19967000826;41082.7945860271;42606.36090458646;42692.78653606732;45959.540404595944;44654;44937.325940110924;45040.774796125974;45111.32333014999;45152.3227151593;8014.358851291882;8865.556722163898;9011.594478248462;9020.14308640678;9028.8645670315;8284.502929824199;10498.527566259498;10713.08938740204;10721.463926803668;11034.668959931216;10885;10968.122550196005;10971.23201375904;10977.725556861062;10988.340699558052;10732.141428685687;10777.784444311148;10778.514966826511;10792.838107428395;10797.190210734187;10658.294672852306;10668.733281667943;10687.732806679818;10707.1434285257;10720.303180293256;41948.37077443841;42150;42257.57742422598;42301.36547951783;42313.78843105765;3510.403231450634;3579.391503444395;3602.873899413534;3846.6345697158727;4051.8581849635416;30489.847550762104;31478.842605787053;31573.684263157305;31722.682773172204;31726.365472690646;4225.535191128974;4301.333293339538;4356.237658409766;4372.3004319309075;4558.726476411426;326774;326862;327127;327245;327576.36211819027;56508.15237771437;56669.43330566724;57001.71499142478;57061.42938570561;57172.42827571754;58779.65254343207;58793;59426.70286648626;59442.94734947578;59446.70276648589;14918.776218356734;15265.23673816327;15280.617984550252;15290.311935962909;15311.387544498319;10715.410652414192;10807.83788243177;11634;11664.950154486138;11798.056155507711;15876.459766437314;16455.87338405699;16498.42255521051;16514;16538.421155259508;5882.647041177543;5920.141579470953;5966.584727301853;6051.122587224828;6225.564210505221;910.3263584947091;982.4989255479613;1022.25375475903;1051.4952822645173;1073.1468482556386;30459.2385190372;30639.2340191497;30879;31048;31410.528842067386;1063.9574417023232;1072.9302595331278;1088.1947358954476;1133.1218305812897;1191.5293459083614;15086.54740357791;16065.437709680105;16215;16389.672206555802;16591.502254932373;441149;446484;446866;447237;447361;56751.43248567544;57030;57072.42927570671;57149.14276285859;57273.42726572681;1229.7294595189044;1231.9322437265857;1246.214884622682;1292.689754458942;1295.520657356784;28024.719752803026;32152.839235803673;32243.51634725434;32377;32763.34473310473;48391.27413088736;48961.41098129796;49070.509294906595;49078;49127.75436122796;356495;357183;358363;358498;359526;25967.480650387264;26340.473190536464;26723;39646.60353396545;39995.2000959985;45526.54473455356;45549.54450455453;46074.35150506269;46448.76775616236;46558.53441465677;38818.22363552656;39065.2186956265;39537;40604.3909341366;41036.384454233805;39536.60463395444;40557.39163912485;40855;41216.79391603023;41673;39525.43084699485;39644.207115858095;39773.602263978144;39777.42003219724;39853.60146398499;33460.33079338351;36407.54461440395;36828;36858.815705922374;37044.629553704115;26543.601845972713;27109.86445067762;27315.726842732114;27391.315217119733;27536.724632753416 00:48:19 INFO - PROCESS | 7081 | |2;jquery.html;367.4543303194754;383.1647009519247;395.6043956043956;398.7737706552351;419.4128220491312;13737.519186828464;19054.61890762184;19435.902820485877;20226.49433764153;20369.694454583194;18788.71816922747;19399.903000484977;19788.802111978875;20051.390749665054;20086.397408077744;5177.119889618764;5434.483724046209;5442.9727851360685;5450.073487507114;5450.618456708032;5332.520073193412;5430.56555475563;5803.187553742479;5828.358880523139;5834.533237341024;5783.334916484595;5792.7972520961775;5793.884122317551;5806.187133801272;5813.128030795372;5293.391260005091;5313.043652142613;5327.360716713981;5339.492748188916;5458.972705136489;5175.534201921845;5178.456262092502;5179.171332586806;5180.248863914711;5181.171012637998;20778.48053798667;22483;22957.426064348358;23091.653625195635;23252.767472325228;2205.8677274987567;2312.063614236237;2413.662087307778;2428.453597940467;2542.1992072497287;9556.808863822755;9702.805943881154;9735;9873.753156171082;10284.897151028468;1783.9286428542844;1840.300685739424;1861.944141675752;1867.1411150870615;1888.6600411925847;83800.58099709524;84399.5780021096;84678;84866.57566712188;86057.70913436303;10600.469976501145;10701.518431670593;10853.371994200776;10947.616833410792;11078.944605276922;15255.923720381326;15278.236088195546;15321.616959575877;15340.769888451681;15384.846151538566;7671.731489397845;7807.024121984752;7952.125266220711;8000.719974800971;8063.354931605458;7193.460490463236;7220.891686624705;7318.780436586911;7411.518251313647;7466.962665186639;4554.7039442436135;4577.862664120082;4593.517680643551;4603.424571928509;4672.462666793363;1832.4960635825255;1943.3781190019058;1949.3859434278156;1958.4026871804238;1962.313190383383;830.9626066826886;923.9445633262026;941.4257303045274;959.5777857742571;1018;18269.81730182708;19143;19410.126544305258;19434;19763.802361976483;906.40177482861;929.7907970706536;941.8257622339889;948.4830767231875;985.1773768902902;10060.597576096874;10426;10500.894991050145;10733.51699173539;11181.931342701626;468788;480406;482625;482947.4378909194;508458;92479;93810;94468;94690.5265473682;95479.52260238794;982.4989255479757;1003.1824063388315;1004.2016596805703;1009.3540134314045;1011.206203130539;16028.038317700975;16403;16621.841850048935;16996.065216413215;17570.56073598119;43894.56105438905;44383.33974932585;44466.333005005596;45770.31344529901;45898.311525327816;55555;55867.72066139643;56394;56858.14712779394;57261;8273.46222495536;8557.786055348666;8661.220490155916;8692.217700406994;8790.077041910507;12316.876831231573;13325.267110309027;13379.86620133825;13445.193288402726;13539;11453.427328633368;11771.23486973344;12013.579524716593;12052.879471205526;12260.938695306466;11530.3081815088;11557.190996630155;11582.768344633228;11859.229150105215;12214.511419543118;11593.188476806543;11663.59177428786;11673.649790506299;11722.882771172179;12135.817962730389;8464.322854171774;8571.4000019998;8619.695915730996;8714.128587141235;8880.422772519765;10987.560497580007;11101;11447.599334023269;11570.537178513101;11638.275751759695 00:48:19 INFO - PROCESS | 7081 | |3;mootools.html;1345.8358519880308;1449.3984996226563;1480;1611.8468745469183;1776.9111544422776;6985.231624521299;7919.6832126714935;8058.194180581939;8152.877706834387;8425.1153628869;8182.959085204566;8246.38152138589;8253.298469630088;8261.091279959215;8271.462354946923;2228.0530774420845;2250.2799104286637;2266.5920134375806;2269.6255117905525;2273.7726227377298;2265.082641530175;2304.7349554801244;2333.8599684018927;2335.9532809343805;2338.818896457287;2181.182056728727;2189.9233526826565;2205.8235341172667;2231.631780756173;2239.652853807654;2113.3448630924463;2122.384508492535;2151.0535364439675;2154.633712268918;2159.114762947192;2163.0482587661377;2191.3645042937687;2198.0658220256487;2198.9450263743374;2199.6480563109985;8303.792405189859;8346.081930987586;8354.874676879852;8358.540280284582;8363.790905227357;4966.081274964144;5114.082219167812;5126.231065340192;5185.896282074337;5187.766550505198;3157.621085469735;3199.1842080269616;3202.903912882617;3203.5354873543206;3212.6947939945667;1030.4641586375044;1036.575004248262;1048.5543643951366;1052.1272135598647;1084.430673896203;11032.503537340759;11175.050120739746;11177.83233251502;11263.04264137541;11264.324140551511;4004.8598299059395;4145.129522800185;4297.355396690521;4388.078503514298;4410.029793445437;9085.318601104811;9089.181973622273;9106.908930910606;9108.453492790453;9114.908850911539;4838.419389673261;4838.516148385203;4842.757862106881;4849.4908034655855;4852.126617208865;4184.644305234028;4308.267594508941;4443.933340999887;4644;4721.079389519011;3552.3960926642535;3587.3542762302513;3679.0986208379118;3690.815459227028;3709.5887673012758;1100.878903320634;1109.7447587055024;1131.1290306463977;1137.670075678044;1142.7485953090306;937.3344925103253;959.4387283439127;962.4706411473661;968.7287559483356;982.189693502863;5641.548676105902;5685.943140568541;5746.856328591735;5835.679037652885;5873.58884878063;950.8098380323963;1022.703416009349;1023.1098943918689;1037.818381783185;1066.925315227942;3786.2238241160494;3814.446905198786;3838.9424158637644;3866.2654095721723;3895.5130608673917;9532.094451027142;9952.15406690425;9976.45129517869;9976.650817221507;9984.650537231308;9881.357711748713;9901.900980990242;9907.058829411339;9915.454649994319;9929.2056635469;7377.9262207378315;7388.704451821867;7562.697492100365;7775.261350171724;7780.49426787257;5387.865303367447;5581.720913954205;5665.263515743092;5695.800646977336;5882.264716910387;9114;9157.221636161;9181.678641247525;9184.357095003286;9221.17009469151;9295.628174872929;9323.673671421468;9362.719118426457;9405.200557952377;9414.293927955294;6590.505712071518;6765.052892594942;7233.746818861315;7303.780886573411;7468.626568671436;7756.961215193888;8109.10799812032;8114.513129212266;8115.918840811516;8134.308583770446;7096.822579435349;7101.11236095488;7267.963660181666;7310.634468276671;7390.815229619087;6728.495362847904;7032.26161253061;7066.258042905626;7170.784876453506;7249.05762250904;6235.96882015587;6306.779262725782;6320.146780184617;6320.241571011508;6324.620522768649;4507.887302817456;4530.569595888385;4550.840720574764;4629.259318509023;4712.387389639325;4727.692699974491;4786.976065119652;4841.540053694894;4900.240462728283;4928.8767780805765 00:48:19 INFO - PROCESS | 7081 | |4;prototype.html;319.94081094997415;330.2898767649553;330.8362360631487;342.07468796904374;342.71554609673973;5219.321488206532;5264.921026184601;5298;5321;5339.585009972356;5189.195674670432;5196.974015129928;5197.324347834786;5201.375834899808;5201.505856943584;3870.9419358709642;3960.128771670228;4013.5183777946686;4042.594656179583;4070.1859628074358;4095;4096.85661001865;4142.482189726285;4143.502779666444;4149.668026557883;4052.2098190852794;4063.7764922929227;4082.5100987881497;4086.284900142478;4111.979440102796;3858.59484754101;3867.7292589518743;3980.761154330735;4069.9593004069875;4087.6321131098343;3617.5478065241846;3627.9818600907092;3638.017735211478;3639.6542328479018;3644.599094099647;4973.676711013809;4999.725015124203;5005.799768009275;5011.972545628174;5017.849464516034;4533.297338912441;4573.931391029138;4646.976765116153;4662.626989840838;4673.532646735299;5329.173978033411;5332.76002579881;5368.7115092377935;5375.5162035417;5382.67703937765;3926.1362500249897;3926.823292951824;3937.3897045957924;3960.2475529649273;3982.825066605358;5347.6256662033675;5580.441955804427;5602.859928501779;5675.2054712340305;5681.659100453945;3948.4866967294643;3954.3277642800217;3970.3845903884944;3979.621935916083;3991.201759648082;3947.0988823214916;3966.7421617594764;4022.5172979242093;4027.194561087794;4042.959570404317;4459.175052615276;4557.931631025537;4562.794674239667;4571.314302854598;4594.540545945379;5361.865953351197;5382.192671099288;5382.91925621116;5385.569154467633;5395.595330350239;1340.5040135149861;1355.3697530648099;1356.7286542691502;1361.952331668387;1362.0942073520998;827.2843989948772;864.3215076165305;876.4303202918027;880.2297989259398;880.3749337970113;5039.97480012605;5056.140456122468;5099.450274862569;5116.411612664591;5147.2279158126585;5332.493413125747;5399.433059528771;5402.837914862561;5515.917261241085;5522.171674248895;5032.3206367139965;5149.9742501287255;5180.870478238075;5212.061828870764;5245.527902488718;2892.4070565534016;2953.464198616707;2966.1249931269895;2970.4207679502288;2973.4647763402795;5750.367459579443;5752.626079304916;5756.280464941882;5774.307083150049;5799.3620701722775;5514.779408823682;5588.944110558924;5623.8594035149445;5628.240187574625;5659;5677.971610141923;5713.485926229552;5718.857028574235;5720.313562372458;5730.713464326684;5268.315119034501;5516.282883225155;5518.33779946409;5518.972405137949;5575.721213939368;5407.918881216706;5431.4840090191365;5447.093517268924;5449.754761035683;5485.945140548703;5646.802361917313;5692.260006199168;5723.7996670116345;5733.627314224562;5738.512226460631;3960.4653371795594;3990.9401358980217;4051.5948405159247;4054.39184122384;4060.127072679388;5460.262864513399;5462.235287059894;5472.398036216093;5479.53423958968;5479.753411096431;5342.9465705342445;5359.410464848941;5398.40617532079;5402.135658294654;5451.727413629382;5139.357580302462;5252.947470525399;5332.120200166929;5363.678179309254;5442.510174084351;5272.05103081449;5287.814926477555;5316.229146773619;5324.494173053554;5329.361965826941;5188.22176673502;5312.309399778004;5333.679849265582;5402.891942161056;5407.324084489439;5262.89474210506;5263.710495922608;5267.762950667306;5309.65487243328;5317.760700768397 00:48:19 INFO - PROCESS | 7081 | |5;yui.html;684.7979845945446;684.979380722723;739.2681245566889;755.2258934592043;814.1695470619969;12839.743205135892;13726.450941962323;13732.382042808073;13740.656483587914;13744.17534947904;12400.255984640928;12503.18729282596;12511.186772859757;12519.061070419732;12522.18605790623;649.0750680280605;787.3189690917372;788.4126325887222;791.473670009443;793.1117148793345;664.2991643815773;779.9766007019798;786.8819677048431;802.8956235689382;816.2286639126029;842.8272204198124;842.93256539477;849.0066622052183;855.4396870050127;856.0497847389393;678.6131904814258;839.8782176584361;843.6077224090827;844.5566077809137;844.8141408890065;512.8564002079423;606.8786242751468;610.1823556434355;614.9914140809077;615.7075389190144;11624.360660163687;11759.412029398582;11772.058235341152;11778.705532361759;11822.645320640395;12916.935415322863;13139.240759440529;13329.095568224711;13493.595192144252;13614.115082519704;12014.279143251433;12025.518979240907;12028.51885924562;12054;12105.455254513568;4241.384999175102;4268.957310426918;4324.156789426063;4354.412154359185;4362.214801335758;61120;61293;62262.68868655628;63173.68413157997;63879.36120638827;10111.7472063199;10223.9488802557;10309.226807989431;10356.896431035593;10708.196885233483;18237.54406139857;18265;18284.908575457303;18292.359767408343;18297.085145742658;7514.887276690854;7677.846443071219;7806.648700808477;7869.960650196713;8053.919460805434;4259.97870010648;4277.1873344064525;4404.603585677304;4428.2914733642465;4466.531014243457;3103.3638104188585;3171.4608516552244;3203.0711093783007;3220.7745457818196;3225.5645487859306;562.7819492900735;570.9029464990962;573.7418161827194;573.8020382967869;579.901416759152;661.2527843536773;673.182083768224;685.6229074009275;701.1726163127456;706.9717211311593;8002.319802816709;8816.77958051041;8824.205821476098;8988.415752976036;9021.368504204642;656.6979189572754;672.8116127484312;683.3132701634925;684.1550684904139;726.4079774983371;3924.1955399143108;4044.4539987101366;4205;4224.45082139326;4275.5296917339065;82781.58609207036;84224.15775842285;87563;88542.55728721315;88605;53614;54165;76433.6178319116;76549.6172519145;76879.61560192163;68717.31282687209;69491.30508694849;71306.28693712996;71959.6402017997;73322;8031.83936321282;8250.504969701837;8264.256216940505;8361.247487726134;8700.260477859452;42698;43191.78404107959;46344.30483542817;47016.29475557938;47620.2856957139;60239.698801505714;60815.39184608097;64895;66454;68001.31998680148;10527.210459215436;11183;11273.098152147644;11274.210805243554;11583.073354131819;11618.477168527606;11688.824667630162;11701.648950531498;11939.223950443193;12184.57353992606;10899.564017439214;10969.396683182502;11127.554897803997;11368.772624547297;11734.530618775154;10770.353778773298;10852.891471085504;11178.664640060812;11420.200585958903;11510.59712910044;10938.45307734626;11395.772084558428;11608.24546404481;11761.376331272537;11824.290542567473;8550.700725474579;8592.140785921358;8646.524441155796;8804.163604457566;8808.11918808114;7886.6510724337895;8225.259726624632;8893.333000024895;9225.953870230605;9351 00:48:19 INFO - PROCESS | 7081 | __end_tp_report 00:48:19 INFO - PROCESS | 7081 | __start_cc_report 00:48:19 INFO - PROCESS | 7081 | _x_x_mozilla_cycle_collect,1081 00:48:19 INFO - PROCESS | 7081 | __end_cc_report 00:48:19 INFO - PROCESS | 7081 | __startTimestamp1477900099078__endTimestamp 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | ------- Summary: start ------- 00:48:19 INFO - PROCESS | 7081 | Number of tests: 6 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | [#0] dojo.html Cycles:165 Average:5290.18 Median:5482.86 stddev:589.15 (10.7%) stddev-sans-first:563.66 00:48:19 INFO - PROCESS | 7081 | Values: 3030.3 3057.9 3074.5 3105.7 3107.3 5140.1 5190.7 5305.4 5363.5 5377.1 5228.8 5244.2 5273.9 5281.1 5374.0 4815.1 4870.3 4871.3 4882.0 4885.1 4427.9 4867.5 4878.5 4910.1 4966.6 5016.6 5035.1 5055.2 5071.1 5090.6 4718.2 4751.9 4754.6 4961.9 5043.7 4823.9 4882.6 4905.7 4920.3 4981.8 5340.8 5363.5 5370.6 5393.9 5443.1 5528.4 5750.7 5756.1 5758.0 5758.8 5650.5 5696.8 5721.8 5751.3 5836.7 5382.5 5383.3 5384.5 5385.7 5391.8 5850.4 5853.4 5857.3 5866.8 5869.6 5453.0 5507.9 5582.5 5654.3 5661.1 5695.2 5746.5 5748.8 5751.4 5795.8 5673.4 5711.8 5737.3 5737.9 5739.3 5540.0 5605.8 5606.0 5679.3 5759.6 4346.7 4367.0 4373.2 4376.2 4402.5 3936.5 3979.6 3980.3 3995.3 4003.0 5442.3 5447.8 5447.9 5452.1 5460.1 5482.9 5543.8 5743.7 5793.3 5795.0 5180.6 5213.8 5228.9 5251.7 5319.7 4829.9 4831.1 4832.2 4836.5 4888.2 5658.5 5734.7 5742.2 5757.1 5759.3 5579.9 5668.6 5669.4 5721.2 5738.2 5897.7 5936.4 5955.3 5959.7 6016.9 5615.7 5624.8 5643.1 5643.6 5655.7 5496.5 5566.7 5567.7 5573.8 5734.8 5522.6 5530.3 5532.9 5580.4 5597.7 5445.6 5484.8 5489.8 5491.6 5507.9 5317.4 5387.4 5415.5 5500.1 5531.0 5625.4 5630.8 5632.4 5669.2 5698.0 5311.8 5451.1 5512.3 5518.1 5520.4 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | [#1] ext.html Cycles:180 Average:54574.97 Median:36617.77 stddev:100149.46 (273.5%) stddev-sans-first:100348.34 00:48:19 INFO - PROCESS | 7081 | Values: 576.2 589.0 598.3 601.1 605.6 32013.2 41082.8 42606.4 42692.8 45959.5 44654.0 44937.3 45040.8 45111.3 45152.3 8014.4 8865.6 9011.6 9020.1 9028.9 8284.5 10498.5 10713.1 10721.5 11034.7 10885.0 10968.1 10971.2 10977.7 10988.3 10732.1 10777.8 10778.5 10792.8 10797.2 10658.3 10668.7 10687.7 10707.1 10720.3 41948.4 42150.0 42257.6 42301.4 42313.8 3510.4 3579.4 3602.9 3846.6 4051.9 30489.8 31478.8 31573.7 31722.7 31726.4 4225.5 4301.3 4356.2 4372.3 4558.7 326774.0 326862.0 327127.0 327245.0 327576.4 56508.2 56669.4 57001.7 57061.4 57172.4 58779.7 58793.0 59426.7 59442.9 59446.7 14918.8 15265.2 15280.6 15290.3 15311.4 10715.4 10807.8 11634.0 11665.0 11798.1 15876.5 16455.9 16498.4 16514.0 16538.4 5882.6 5920.1 5966.6 6051.1 6225.6 910.3 982.5 1022.3 1051.5 1073.1 30459.2 30639.2 30879.0 31048.0 31410.5 1064.0 1072.9 1088.2 1133.1 1191.5 15086.5 16065.4 16215.0 16389.7 16591.5 441149.0 446484.0 446866.0 447237.0 447361.0 56751.4 57030.0 57072.4 57149.1 57273.4 1229.7 1231.9 1246.2 1292.7 1295.5 28024.7 32152.8 32243.5 32377.0 32763.3 48391.3 48961.4 49070.5 49078.0 49127.8 356495.0 357183.0 358363.0 358498.0 359526.0 25967.5 26340.5 26723.0 39646.6 39995.2 45526.5 45549.5 46074.4 46448.8 46558.5 38818.2 39065.2 39537.0 40604.4 41036.4 39536.6 40557.4 40855.0 41216.8 41673.0 39525.4 39644.2 39773.6 39777.4 39853.6 33460.3 36407.5 36828.0 36858.8 37044.6 26543.6 27109.9 27315.7 27391.3 27536.7 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | [#2] jquery.html Cycles:180 Average:28941.03 Median:22156.99 stddev:80114.27 (361.6%) stddev-sans-first:80310.29 00:48:19 INFO - PROCESS | 7081 | Values: 367.5 383.2 395.6 398.8 419.4 13737.5 19054.6 19435.9 20226.5 20369.7 18788.7 19399.9 19788.8 20051.4 20086.4 5177.1 5434.5 5443.0 5450.1 5450.6 5332.5 5430.6 5803.2 5828.4 5834.5 5783.3 5792.8 5793.9 5806.2 5813.1 5293.4 5313.0 5327.4 5339.5 5459.0 5175.5 5178.5 5179.2 5180.2 5181.2 20778.5 22483.0 22957.4 23091.7 23252.8 2205.9 2312.1 2413.7 2428.5 2542.2 9556.8 9702.8 9735.0 9873.8 10284.9 1783.9 1840.3 1861.9 1867.1 1888.7 83800.6 84399.6 84678.0 84866.6 86057.7 10600.5 10701.5 10853.4 10947.6 11078.9 15255.9 15278.2 15321.6 15340.8 15384.8 7671.7 7807.0 7952.1 8000.7 8063.4 7193.5 7220.9 7318.8 7411.5 7467.0 4554.7 4577.9 4593.5 4603.4 4672.5 1832.5 1943.4 1949.4 1958.4 1962.3 831.0 923.9 941.4 959.6 1018.0 18269.8 19143.0 19410.1 19434.0 19763.8 906.4 929.8 941.8 948.5 985.2 10060.6 10426.0 10500.9 10733.5 11181.9 468788.0 480406.0 482625.0 482947.4 508458.0 92479.0 93810.0 94468.0 94690.5 95479.5 982.5 1003.2 1004.2 1009.4 1011.2 16028.0 16403.0 16621.8 16996.1 17570.6 43894.6 44383.3 44466.3 45770.3 45898.3 55555.0 55867.7 56394.0 56858.1 57261.0 8273.5 8557.8 8661.2 8692.2 8790.1 12316.9 13325.3 13379.9 13445.2 13539.0 11453.4 11771.2 12013.6 12052.9 12260.9 11530.3 11557.2 11582.8 11859.2 12214.5 11593.2 11663.6 11673.6 11722.9 12135.8 8464.3 8571.4 8619.7 8714.1 8880.4 10987.6 11101.0 11447.6 11570.5 11638.3 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | [#3] mootools.html Cycles:180 Average:5371.07 Median:5120.16 stddev:2981.46 (58.2%) stddev-sans-first:2974.47 00:48:19 INFO - PROCESS | 7081 | Values: 1345.8 1449.4 1480.0 1611.8 1776.9 6985.2 7919.7 8058.2 8152.9 8425.1 8183.0 8246.4 8253.3 8261.1 8271.5 2228.1 2250.3 2266.6 2269.6 2273.8 2265.1 2304.7 2333.9 2336.0 2338.8 2181.2 2189.9 2205.8 2231.6 2239.7 2113.3 2122.4 2151.1 2154.6 2159.1 2163.0 2191.4 2198.1 2198.9 2199.6 8303.8 8346.1 8354.9 8358.5 8363.8 4966.1 5114.1 5126.2 5185.9 5187.8 3157.6 3199.2 3202.9 3203.5 3212.7 1030.5 1036.6 1048.6 1052.1 1084.4 11032.5 11175.1 11177.8 11263.0 11264.3 4004.9 4145.1 4297.4 4388.1 4410.0 9085.3 9089.2 9106.9 9108.5 9114.9 4838.4 4838.5 4842.8 4849.5 4852.1 4184.6 4308.3 4443.9 4644.0 4721.1 3552.4 3587.4 3679.1 3690.8 3709.6 1100.9 1109.7 1131.1 1137.7 1142.7 937.3 959.4 962.5 968.7 982.2 5641.5 5685.9 5746.9 5835.7 5873.6 950.8 1022.7 1023.1 1037.8 1066.9 3786.2 3814.4 3838.9 3866.3 3895.5 9532.1 9952.2 9976.5 9976.7 9984.7 9881.4 9901.9 9907.1 9915.5 9929.2 7377.9 7388.7 7562.7 7775.3 7780.5 5387.9 5581.7 5665.3 5695.8 5882.3 9114.0 9157.2 9181.7 9184.4 9221.2 9295.6 9323.7 9362.7 9405.2 9414.3 6590.5 6765.1 7233.7 7303.8 7468.6 7757.0 8109.1 8114.5 8115.9 8134.3 7096.8 7101.1 7268.0 7310.6 7390.8 6728.5 7032.3 7066.3 7170.8 7249.1 6236.0 6306.8 6320.1 6320.2 6324.6 4507.9 4530.6 4550.8 4629.3 4712.4 4727.7 4787.0 4841.5 4900.2 4928.9 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | [#4] prototype.html Cycles:180 Average:4547.52 Median:5215.69 stddev:1328.55 (25.5%) stddev-sans-first:1293.83 00:48:19 INFO - PROCESS | 7081 | Values: 319.9 330.3 330.8 342.1 342.7 5219.3 5264.9 5298.0 5321.0 5339.6 5189.2 5197.0 5197.3 5201.4 5201.5 3870.9 3960.1 4013.5 4042.6 4070.2 4095.0 4096.9 4142.5 4143.5 4149.7 4052.2 4063.8 4082.5 4086.3 4112.0 3858.6 3867.7 3980.8 4070.0 4087.6 3617.5 3628.0 3638.0 3639.7 3644.6 4973.7 4999.7 5005.8 5012.0 5017.8 4533.3 4573.9 4647.0 4662.6 4673.5 5329.2 5332.8 5368.7 5375.5 5382.7 3926.1 3926.8 3937.4 3960.2 3982.8 5347.6 5580.4 5602.9 5675.2 5681.7 3948.5 3954.3 3970.4 3979.6 3991.2 3947.1 3966.7 4022.5 4027.2 4043.0 4459.2 4557.9 4562.8 4571.3 4594.5 5361.9 5382.2 5382.9 5385.6 5395.6 1340.5 1355.4 1356.7 1362.0 1362.1 827.3 864.3 876.4 880.2 880.4 5040.0 5056.1 5099.5 5116.4 5147.2 5332.5 5399.4 5402.8 5515.9 5522.2 5032.3 5150.0 5180.9 5212.1 5245.5 2892.4 2953.5 2966.1 2970.4 2973.5 5750.4 5752.6 5756.3 5774.3 5799.4 5514.8 5588.9 5623.9 5628.2 5659.0 5678.0 5713.5 5718.9 5720.3 5730.7 5268.3 5516.3 5518.3 5519.0 5575.7 5407.9 5431.5 5447.1 5449.8 5485.9 5646.8 5692.3 5723.8 5733.6 5738.5 3960.5 3990.9 4051.6 4054.4 4060.1 5460.3 5462.2 5472.4 5479.5 5479.8 5342.9 5359.4 5398.4 5402.1 5451.7 5139.4 5252.9 5332.1 5363.7 5442.5 5272.1 5287.8 5316.2 5324.5 5329.4 5188.2 5312.3 5333.7 5402.9 5407.3 5262.9 5263.7 5267.8 5309.7 5317.8 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - PROCESS | 7081 | [#5] yui.html Cycles:180 Average:16943.12 Median:573.77 stddev:23177.47 (4039.5%) stddev-sans-first:23210.34 00:48:19 INFO - PROCESS | 7081 | Values: 684.8 685.0 739.3 755.2 814.2 12839.7 13726.5 13732.4 13740.7 13744.2 12400.3 12503.2 12511.2 12519.1 12522.2 649.1 787.3 788.4 791.5 793.1 664.3 780.0 786.9 802.9 816.2 842.8 842.9 849.0 855.4 856.0 678.6 839.9 843.6 844.6 844.8 512.9 606.9 610.2 615.0 615.7 11624.4 11759.4 11772.1 11778.7 11822.6 12916.9 13139.2 13329.1 13493.6 13614.1 12014.3 12025.5 12028.5 12054.0 12105.5 4241.4 4269.0 4324.2 4354.4 4362.2 61120.0 61293.0 62262.7 63173.7 63879.4 10111.7 10223.9 10309.2 10356.9 10708.2 18237.5 18265.0 18284.9 18292.4 18297.1 7514.9 7677.8 7806.6 7870.0 8053.9 4260.0 4277.2 4404.6 4428.3 4466.5 3103.4 3171.5 3203.1 3220.8 3225.6 562.8 570.9 573.7 573.8 579.9 661.3 673.2 685.6 701.2 707.0 8002.3 8816.8 8824.2 8988.4 9021.4 656.7 672.8 683.3 684.2 726.4 3924.2 4044.5 4205.0 4224.5 4275.5 82781.6 84224.2 87563.0 88542.6 88605.0 53614.0 54165.0 76433.6 76549.6 76879.6 68717.3 69491.3 71306.3 71959.6 73322.0 8031.8 8250.5 8264.3 8361.2 8700.3 42698.0 43191.8 46344.3 47016.3 47620.3 60239.7 60815.4 64895.0 66454.0 68001.3 10527.2 11183.0 11273.1 11274.2 11583.1 11618.5 11688.8 11701.6 11939.2 12184.6 10899.6 10969.4 11127.6 11368.8 11734.5 10770.4 10852.9 11178.7 11420.2 11510.6 10938.5 11395.8 11608.2 11761.4 11824.3 8550.7 8592.1 8646.5 8804.2 8808.1 7886.7 8225.3 8893.3 9226.0 9351.0 00:48:19 INFO - PROCESS | 7081 | -------- Summary: end -------- 00:48:19 INFO - PROCESS | 7081 | 00:48:19 INFO - TEST-INFO | 7081: exit 0 00:48:20 INFO - TEST-OK | dromaeo_css | took 1118184ms 00:48:20 INFO - TEST-START | kraken 00:48:20 INFO - operating with platform_type : linux_ 00:48:20 INFO - Initialising browser for kraken test... 00:48:20 INFO - TEST-INFO | started process 7390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGdFsU/profile http://localhost:41282/getInfo.html) 00:48:24 INFO - PROCESS | 7390 | __metrics Screen width/height:1600/1200 00:48:24 INFO - PROCESS | 7390 | colorDepth:24 00:48:24 INFO - PROCESS | 7390 | Browser inner width/height: 1024/697 00:48:24 INFO - PROCESS | 7390 | __metrics 00:48:24 INFO - PROCESS | 7390 | 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" 00:48:24 INFO - PROCESS | 7390 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:48:25 INFO - PROCESS | 7390 | console.error: PushService: 00:48:25 INFO - PROCESS | 7390 | stateChangeProcessEnqueue: Error transitioning state 00:48:25 INFO - PROCESS | 7390 | UnknownError 00:48:26 INFO - TEST-INFO | 7390: exit 0 00:48:26 INFO - Browser initialized. 00:48:26 INFO - Running cycle 1/1 for kraken test... 00:48:26 INFO - TEST-INFO | started process 7475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGdFsU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:48:38 INFO - PROCESS | 7475 | RSS: Main: 174260224 00:48:38 INFO - PROCESS | 7475 | 00:48:40 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-beat-detection) 00:48:41 INFO - PROCESS | 7475 | RSS: Main: 231497728 00:48:41 INFO - PROCESS | 7475 | 00:48:44 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-dft) 00:48:45 INFO - PROCESS | 7475 | RSS: Main: 217915392 00:48:45 INFO - PROCESS | 7475 | 00:48:48 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-fft) 00:48:48 INFO - PROCESS | 7475 | RSS: Main: 299638784 00:48:48 INFO - PROCESS | 7475 | 00:48:50 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-oscillator) 00:48:51 INFO - PROCESS | 7475 | RSS: Main: 209080320 00:48:51 INFO - PROCESS | 7475 | 00:48:53 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:48:54 INFO - PROCESS | 7475 | RSS: Main: 214237184 00:48:54 INFO - PROCESS | 7475 | 00:48:57 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41282/tests/kraken/driver.html?testName=imaging-darkroom) 00:48:57 INFO - PROCESS | 7475 | RSS: Main: 250281984 00:48:57 INFO - PROCESS | 7475 | 00:49:01 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41282/tests/kraken/driver.html?testName=imaging-desaturate) 00:49:01 INFO - PROCESS | 7475 | RSS: Main: 249925632 00:49:01 INFO - PROCESS | 7475 | 00:49:04 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41282/tests/kraken/driver.html?testName=json-parse-financial) 00:49:04 INFO - PROCESS | 7475 | RSS: Main: 248619008 00:49:04 INFO - PROCESS | 7475 | 00:49:06 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:49:07 INFO - PROCESS | 7475 | RSS: Main: 210763776 00:49:07 INFO - PROCESS | 7475 | 00:49:08 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:49:09 INFO - PROCESS | 7475 | RSS: Main: 217923584 00:49:09 INFO - PROCESS | 7475 | 00:49:11 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:49:12 INFO - PROCESS | 7475 | RSS: Main: 227115008 00:49:12 INFO - PROCESS | 7475 | 00:49:14 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:49:15 INFO - PROCESS | 7475 | RSS: Main: 237187072 00:49:15 INFO - PROCESS | 7475 | 00:49:18 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:49:18 INFO - PROCESS | 7475 | RSS: Main: 233635840 00:49:18 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41282/tests/kraken/driver.html?testName=ai-astar) 00:49:20 INFO - PROCESS | 7475 | RSS: Main: 283213824 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | __start_tp_report 00:49:20 INFO - PROCESS | 7475 | _x_x_mozilla_page_load 00:49:20 INFO - PROCESS | 7475 | _x_x_mozilla_page_load_details 00:49:20 INFO - PROCESS | 7475 | |i|pagename|runs| 00:49:20 INFO - PROCESS | 7475 | |0;ai-astar;105;112;112;112;112;113;113;112;113;113 00:49:20 INFO - PROCESS | 7475 | |1;audio-beat-detection;158;124;127;167;125;126;123;121;165;124 00:49:20 INFO - PROCESS | 7475 | |2;audio-dft;159;161;161;161;161;164;163;164;162;163 00:49:20 INFO - PROCESS | 7475 | |3;audio-fft;74;76;75;119;76;76;75;76;105;75 00:49:20 INFO - PROCESS | 7475 | |4;audio-oscillator;84;82;123;82;83;83;106;82;82;114 00:49:20 INFO - PROCESS | 7475 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;116;117 00:49:20 INFO - PROCESS | 7475 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;145;145 00:49:20 INFO - PROCESS | 7475 | |7;imaging-desaturate;84;85;85;85;86;85;84;85;84;85 00:49:20 INFO - PROCESS | 7475 | |8;json-parse-financial;54;53;54;61;54;54;54;53;54;54 00:49:20 INFO - PROCESS | 7475 | |9;json-stringify-tinderbox;61;62;61;61;61;62;61;61;61;61 00:49:20 INFO - PROCESS | 7475 | |10;stanford-crypto-aes;81;80;80;85;80;79;79;79;79;81 00:49:20 INFO - PROCESS | 7475 | |11;stanford-crypto-ccm;129;128;132;129;129;133;133;131;180;135 00:49:20 INFO - PROCESS | 7475 | |12;stanford-crypto-pbkdf2;168;173;172;167;164;164;165;164;166;164 00:49:20 INFO - PROCESS | 7475 | |13;stanford-crypto-sha256-iterative;65;65;63;69;67;69;63;63;63;62 00:49:20 INFO - PROCESS | 7475 | __end_tp_report 00:49:20 INFO - PROCESS | 7475 | __start_cc_report 00:49:20 INFO - PROCESS | 7475 | _x_x_mozilla_cycle_collect,1725 00:49:20 INFO - PROCESS | 7475 | __end_cc_report 00:49:20 INFO - PROCESS | 7475 | __startTimestamp1477900160747__endTimestamp 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | ------- Summary: start ------- 00:49:20 INFO - PROCESS | 7475 | Number of tests: 14 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.41 (2.1%) stddev-sans-first:0.53 00:49:20 INFO - PROCESS | 7475 | Values: 105.0 112.0 112.0 112.0 112.0 113.0 113.0 112.0 113.0 113.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:126.50 stddev:19.06 (15.1%) stddev-sans-first:18.48 00:49:20 INFO - PROCESS | 7475 | Values: 158.0 124.0 127.0 167.0 125.0 126.0 123.0 121.0 165.0 124.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.60 (1.0%) stddev-sans-first:1.30 00:49:20 INFO - PROCESS | 7475 | Values: 159.0 161.0 161.0 161.0 161.0 164.0 163.0 164.0 162.0 163.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:15.80 (20.9%) stddev-sans-first:16.45 00:49:20 INFO - PROCESS | 7475 | Values: 74.0 76.0 75.0 119.0 76.0 76.0 75.0 76.0 105.0 75.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:82.00 stddev:15.87 (19.4%) stddev-sans-first:16.56 00:49:20 INFO - PROCESS | 7475 | Values: 84.0 82.0 123.0 82.0 83.0 83.0 106.0 82.0 82.0 114.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:49:20 INFO - PROCESS | 7475 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 00:49:20 INFO - PROCESS | 7475 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 00:49:20 INFO - PROCESS | 7475 | Values: 84.0 85.0 85.0 85.0 86.0 85.0 84.0 85.0 84.0 85.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.32 (4.3%) stddev-sans-first:2.46 00:49:20 INFO - PROCESS | 7475 | Values: 54.0 53.0 54.0 61.0 54.0 54.0 54.0 53.0 54.0 54.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 00:49:20 INFO - PROCESS | 7475 | Values: 61.0 62.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.83 (2.3%) stddev-sans-first:1.92 00:49:20 INFO - PROCESS | 7475 | Values: 81.0 80.0 80.0 85.0 80.0 79.0 79.0 79.0 79.0 81.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:132.50 stddev:15.66 (11.8%) stddev-sans-first:16.41 00:49:20 INFO - PROCESS | 7475 | Values: 129.0 128.0 132.0 129.0 129.0 133.0 133.0 131.0 180.0 135.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.50 stddev:3.37 (2.0%) stddev-sans-first:3.54 00:49:20 INFO - PROCESS | 7475 | Values: 168.0 173.0 172.0 167.0 164.0 164.0 165.0 164.0 166.0 164.0 00:49:20 INFO - PROCESS | 7475 | 00:49:20 INFO - PROCESS | 7475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.60 (4.0%) stddev-sans-first:2.76 00:49:20 INFO - PROCESS | 7475 | Values: 65.0 65.0 63.0 69.0 67.0 69.0 63.0 63.0 63.0 62.0 00:49:20 INFO - PROCESS | 7475 | -------- Summary: end -------- 00:49:20 INFO - PROCESS | 7475 | 00:49:22 INFO - TEST-INFO | 7475: exit 0 00:49:22 INFO - TEST-OK | kraken | took 62038ms 00:49:22 INFO - SUITE-END | took 1180s 00:49:22 INFO - Completed test suite (00:19:40) 00:49:22 INFO - javascript benchmark 00:49:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.2727345437092, 3057.938841223177, 3074.538819177124, 3105.7204851563356, 3107.3474570340213, 5140.100482415572, 5190.71451070191, 5305.41640419554, 5363.46365363464, 5377.139657654771, 5228.764705588248, 5244.160934250521, 5273.947260527393, 5281.128613778722, 5374.032674118657, 4815.133276010317, 4870.318155458239, 4871.269309603553, 4882.048000639877, 4885.120678277917, 4427.850564569047, 4867.464578896319, 4878.536539028804, 4910.067087253428, 4966.602671786249, 5016.623753218505, 5035.068512325213, 5055.216441451581, 5071.087204303224, 5090.567301779334, 4718.150732868083, 4751.904961900743, 4754.643401744848, 4961.8511444656715, 5043.747812609355, 4823.927641085386, 4882.584980276681, 4905.681130726492, 4920.3357546731095, 4981.800727970877, 5340.813071542478, 5363.490468405495, 5370.624056316059, 5393.919091213635, 5443.074677304868, 5528.419515950807, 5750.683712395817, 5756.136579513065, 5758.0, 5758.827235182951, 5650.463205995465, 5696.8006119785605, 5721.7711291548285, 5751.309842818889, 5836.737346819404, 5382.4886635769535, 5383.327084114486, 5384.542313903362, 5385.703786291752, 5391.81128660499, 5850.385709500526, 5853.414658534198, 5857.26784151981, 5866.794662186803, 5869.618474799125, 5452.963936852065, 5507.9449205507435, 5582.469665381782, 5654.349749778746, 5661.065924122474, 5695.202671625976, 5746.511546518593, 5748.770049198069, 5751.396103409165, 5795.768169273182, 5673.432656734376, 5711.828645140652, 5737.3115226172295, 5737.85655358611, 5739.311282646109, 5540.0, 5605.775768969195, 5606.018946684314, 5679.318481782213, 5759.596828221985, 4346.695731298779, 4367.0, 4373.234683930299, 4376.212281789309, 4402.537733537996, 3936.5079365079364, 3979.602039796055, 3980.3233450313514, 3995.300822356076, 4003.039270575041, 5442.319710036246, 5447.782088716486, 5447.891042179134, 5452.1276595745285, 5460.126379779216, 5482.862928426821, 5543.833684989457, 5743.684097374601, 5793.275840519935, 5794.971025144847, 5180.585553155738, 5213.817516386908, 5228.895422091537, 5251.711155886463, 5319.734013299397, 4829.855104346875, 4831.0820944020525, 4832.178529649968, 4836.516348365135, 4888.242322439956, 5658.5473162147755, 5734.655920644775, 5742.196092546963, 5757.0788673811985, 5759.308882934075, 5579.944200558105, 5668.631538949955, 5669.4047125051275, 5721.199032135588, 5738.196652468574, 5897.70511474416, 5936.406359364029, 5955.315138758925, 5959.7020148991505, 6016.939830601813, 5615.747291371979, 5624.803131890364, 5643.125315576092, 5643.604947653789, 5655.72746132117, 5496.4503549646315, 5566.666000040011, 5567.66594004361, 5573.7770489179975, 5734.827955161185, 5522.5581953442825, 5530.336359636869, 5532.861678458071, 5580.441955804387, 5597.692126933058, 5445.564354851523, 5484.753186106715, 5489.835304940858, 5491.560675145899, 5507.917381239365, 5317.415084340642, 5387.380451248, 5415.512603865671, 5500.092484740133, 5531.0, 5625.353084395183, 5630.802921897878, 5632.436756324335, 5669.20631111653, 5697.971510142423, 5311.760970756248, 5451.073317535949, 5512.2558454608115, 5518.089515229942, 5520.447955204608], "value": 5251.2747557212615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1616847486906, 588.9587728858979, 598.3149294058303, 601.0983524712931, 605.6214865708932, 32013.19967000826, 41082.7945860271, 42606.36090458646, 42692.78653606732, 45959.540404595944, 44654.0, 44937.325940110924, 45040.774796125974, 45111.32333014999, 45152.3227151593, 8014.358851291882, 8865.556722163898, 9011.594478248462, 9020.14308640678, 9028.8645670315, 8284.502929824199, 10498.527566259498, 10713.08938740204, 10721.463926803668, 11034.668959931216, 10885.0, 10968.122550196005, 10971.23201375904, 10977.725556861062, 10988.340699558052, 10732.141428685687, 10777.784444311148, 10778.514966826511, 10792.838107428395, 10797.190210734187, 10658.294672852306, 10668.733281667943, 10687.732806679818, 10707.1434285257, 10720.303180293256, 41948.37077443841, 42150.0, 42257.57742422598, 42301.36547951783, 42313.78843105765, 3510.403231450634, 3579.391503444395, 3602.873899413534, 3846.6345697158727, 4051.8581849635416, 30489.847550762104, 31478.842605787053, 31573.684263157305, 31722.682773172204, 31726.365472690646, 4225.535191128974, 4301.333293339538, 4356.237658409766, 4372.3004319309075, 4558.726476411426, 326774.0, 326862.0, 327127.0, 327245.0, 327576.36211819027, 56508.15237771437, 56669.43330566724, 57001.71499142478, 57061.42938570561, 57172.42827571754, 58779.65254343207, 58793.0, 59426.70286648626, 59442.94734947578, 59446.70276648589, 14918.776218356734, 15265.23673816327, 15280.617984550252, 15290.311935962909, 15311.387544498319, 10715.410652414192, 10807.83788243177, 11634.0, 11664.950154486138, 11798.056155507711, 15876.459766437314, 16455.87338405699, 16498.42255521051, 16514.0, 16538.421155259508, 5882.647041177543, 5920.141579470953, 5966.584727301853, 6051.122587224828, 6225.564210505221, 910.3263584947091, 982.4989255479613, 1022.25375475903, 1051.4952822645173, 1073.1468482556386, 30459.2385190372, 30639.2340191497, 30879.0, 31048.0, 31410.528842067386, 1063.9574417023232, 1072.9302595331278, 1088.1947358954476, 1133.1218305812897, 1191.5293459083614, 15086.54740357791, 16065.437709680105, 16215.0, 16389.672206555802, 16591.502254932373, 441149.0, 446484.0, 446866.0, 447237.0, 447361.0, 56751.43248567544, 57030.0, 57072.42927570671, 57149.14276285859, 57273.42726572681, 1229.7294595189044, 1231.9322437265857, 1246.214884622682, 1292.689754458942, 1295.520657356784, 28024.719752803026, 32152.839235803673, 32243.51634725434, 32377.0, 32763.34473310473, 48391.27413088736, 48961.41098129796, 49070.509294906595, 49078.0, 49127.75436122796, 356495.0, 357183.0, 358363.0, 358498.0, 359526.0, 25967.480650387264, 26340.473190536464, 26723.0, 39646.60353396545, 39995.2000959985, 45526.54473455356, 45549.54450455453, 46074.35150506269, 46448.76775616236, 46558.53441465677, 38818.22363552656, 39065.2186956265, 39537.0, 40604.3909341366, 41036.384454233805, 39536.60463395444, 40557.39163912485, 40855.0, 41216.79391603023, 41673.0, 39525.43084699485, 39644.207115858095, 39773.602263978144, 39777.42003219724, 39853.60146398499, 33460.33079338351, 36407.54461440395, 36828.0, 36858.815705922374, 37044.629553704115, 26543.601845972713, 27109.86445067762, 27315.726842732114, 27391.315217119733, 27536.724632753416], "value": 19771.10431211398, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4543303194754, 383.1647009519247, 395.6043956043956, 398.7737706552351, 419.4128220491312, 13737.519186828464, 19054.61890762184, 19435.902820485877, 20226.49433764153, 20369.694454583194, 18788.71816922747, 19399.903000484977, 19788.802111978875, 20051.390749665054, 20086.397408077744, 5177.119889618764, 5434.483724046209, 5442.9727851360685, 5450.073487507114, 5450.618456708032, 5332.520073193412, 5430.56555475563, 5803.187553742479, 5828.358880523139, 5834.533237341024, 5783.334916484595, 5792.7972520961775, 5793.884122317551, 5806.187133801272, 5813.128030795372, 5293.391260005091, 5313.043652142613, 5327.360716713981, 5339.492748188916, 5458.972705136489, 5175.534201921845, 5178.456262092502, 5179.171332586806, 5180.248863914711, 5181.171012637998, 20778.48053798667, 22483.0, 22957.426064348358, 23091.653625195635, 23252.767472325228, 2205.8677274987567, 2312.063614236237, 2413.662087307778, 2428.453597940467, 2542.1992072497287, 9556.808863822755, 9702.805943881154, 9735.0, 9873.753156171082, 10284.897151028468, 1783.9286428542844, 1840.300685739424, 1861.944141675752, 1867.1411150870615, 1888.6600411925847, 83800.58099709524, 84399.5780021096, 84678.0, 84866.57566712188, 86057.70913436303, 10600.469976501145, 10701.518431670593, 10853.371994200776, 10947.616833410792, 11078.944605276922, 15255.923720381326, 15278.236088195546, 15321.616959575877, 15340.769888451681, 15384.846151538566, 7671.731489397845, 7807.024121984752, 7952.125266220711, 8000.719974800971, 8063.354931605458, 7193.460490463236, 7220.891686624705, 7318.780436586911, 7411.518251313647, 7466.962665186639, 4554.7039442436135, 4577.862664120082, 4593.517680643551, 4603.424571928509, 4672.462666793363, 1832.4960635825255, 1943.3781190019058, 1949.3859434278156, 1958.4026871804238, 1962.313190383383, 830.9626066826886, 923.9445633262026, 941.4257303045274, 959.5777857742571, 1018.0, 18269.81730182708, 19143.0, 19410.126544305258, 19434.0, 19763.802361976483, 906.40177482861, 929.7907970706536, 941.8257622339889, 948.4830767231875, 985.1773768902902, 10060.597576096874, 10426.0, 10500.894991050145, 10733.51699173539, 11181.931342701626, 468788.0, 480406.0, 482625.0, 482947.4378909194, 508458.0, 92479.0, 93810.0, 94468.0, 94690.5265473682, 95479.52260238794, 982.4989255479757, 1003.1824063388315, 1004.2016596805703, 1009.3540134314045, 1011.206203130539, 16028.038317700975, 16403.0, 16621.841850048935, 16996.065216413215, 17570.56073598119, 43894.56105438905, 44383.33974932585, 44466.333005005596, 45770.31344529901, 45898.311525327816, 55555.0, 55867.72066139643, 56394.0, 56858.14712779394, 57261.0, 8273.46222495536, 8557.786055348666, 8661.220490155916, 8692.217700406994, 8790.077041910507, 12316.876831231573, 13325.267110309027, 13379.86620133825, 13445.193288402726, 13539.0, 11453.427328633368, 11771.23486973344, 12013.579524716593, 12052.879471205526, 12260.938695306466, 11530.3081815088, 11557.190996630155, 11582.768344633228, 11859.229150105215, 12214.511419543118, 11593.188476806543, 11663.59177428786, 11673.649790506299, 11722.882771172179, 12135.817962730389, 8464.322854171774, 8571.4000019998, 8619.695915730996, 8714.128587141235, 8880.422772519765, 10987.560497580007, 11101.0, 11447.599334023269, 11570.537178513101, 11638.275751759695], "value": 9083.523142521215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.8358519880308, 1449.3984996226563, 1480.0, 1611.8468745469183, 1776.9111544422776, 6985.231624521299, 7919.6832126714935, 8058.194180581939, 8152.877706834387, 8425.1153628869, 8182.959085204566, 8246.38152138589, 8253.298469630088, 8261.091279959215, 8271.462354946923, 2228.0530774420845, 2250.2799104286637, 2266.5920134375806, 2269.6255117905525, 2273.7726227377298, 2265.082641530175, 2304.7349554801244, 2333.8599684018927, 2335.9532809343805, 2338.818896457287, 2181.182056728727, 2189.9233526826565, 2205.8235341172667, 2231.631780756173, 2239.652853807654, 2113.3448630924463, 2122.384508492535, 2151.0535364439675, 2154.633712268918, 2159.114762947192, 2163.0482587661377, 2191.3645042937687, 2198.0658220256487, 2198.9450263743374, 2199.6480563109985, 8303.792405189859, 8346.081930987586, 8354.874676879852, 8358.540280284582, 8363.790905227357, 4966.081274964144, 5114.082219167812, 5126.231065340192, 5185.896282074337, 5187.766550505198, 3157.621085469735, 3199.1842080269616, 3202.903912882617, 3203.5354873543206, 3212.6947939945667, 1030.4641586375044, 1036.575004248262, 1048.5543643951366, 1052.1272135598647, 1084.430673896203, 11032.503537340759, 11175.050120739746, 11177.83233251502, 11263.04264137541, 11264.324140551511, 4004.8598299059395, 4145.129522800185, 4297.355396690521, 4388.078503514298, 4410.029793445437, 9085.318601104811, 9089.181973622273, 9106.908930910606, 9108.453492790453, 9114.908850911539, 4838.419389673261, 4838.516148385203, 4842.757862106881, 4849.4908034655855, 4852.126617208865, 4184.644305234028, 4308.267594508941, 4443.933340999887, 4644.0, 4721.079389519011, 3552.3960926642535, 3587.3542762302513, 3679.0986208379118, 3690.815459227028, 3709.5887673012758, 1100.878903320634, 1109.7447587055024, 1131.1290306463977, 1137.670075678044, 1142.7485953090306, 937.3344925103253, 959.4387283439127, 962.4706411473661, 968.7287559483356, 982.189693502863, 5641.548676105902, 5685.943140568541, 5746.856328591735, 5835.679037652885, 5873.58884878063, 950.8098380323963, 1022.703416009349, 1023.1098943918689, 1037.818381783185, 1066.925315227942, 3786.2238241160494, 3814.446905198786, 3838.9424158637644, 3866.2654095721723, 3895.5130608673917, 9532.094451027142, 9952.15406690425, 9976.45129517869, 9976.650817221507, 9984.650537231308, 9881.357711748713, 9901.900980990242, 9907.058829411339, 9915.454649994319, 9929.2056635469, 7377.9262207378315, 7388.704451821867, 7562.697492100365, 7775.261350171724, 7780.49426787257, 5387.865303367447, 5581.720913954205, 5665.263515743092, 5695.800646977336, 5882.264716910387, 9114.0, 9157.221636161, 9181.678641247525, 9184.357095003286, 9221.17009469151, 9295.628174872929, 9323.673671421468, 9362.719118426457, 9405.200557952377, 9414.293927955294, 6590.505712071518, 6765.052892594942, 7233.746818861315, 7303.780886573411, 7468.626568671436, 7756.961215193888, 8109.10799812032, 8114.513129212266, 8115.918840811516, 8134.308583770446, 7096.822579435349, 7101.11236095488, 7267.963660181666, 7310.634468276671, 7390.815229619087, 6728.495362847904, 7032.26161253061, 7066.258042905626, 7170.784876453506, 7249.05762250904, 6235.96882015587, 6306.779262725782, 6320.146780184617, 6320.241571011508, 6324.620522768649, 4507.887302817456, 4530.569595888385, 4550.840720574764, 4629.259318509023, 4712.387389639325, 4727.692699974491, 4786.976065119652, 4841.540053694894, 4900.240462728283, 4928.8767780805765], "value": 4346.739243869791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.94081094997415, 330.2898767649553, 330.8362360631487, 342.07468796904374, 342.71554609673973, 5219.321488206532, 5264.921026184601, 5298.0, 5321.0, 5339.585009972356, 5189.195674670432, 5196.974015129928, 5197.324347834786, 5201.375834899808, 5201.505856943584, 3870.9419358709642, 3960.128771670228, 4013.5183777946686, 4042.594656179583, 4070.1859628074358, 4095.0, 4096.85661001865, 4142.482189726285, 4143.502779666444, 4149.668026557883, 4052.2098190852794, 4063.7764922929227, 4082.5100987881497, 4086.284900142478, 4111.979440102796, 3858.59484754101, 3867.7292589518743, 3980.761154330735, 4069.9593004069875, 4087.6321131098343, 3617.5478065241846, 3627.9818600907092, 3638.017735211478, 3639.6542328479018, 3644.599094099647, 4973.676711013809, 4999.725015124203, 5005.799768009275, 5011.972545628174, 5017.849464516034, 4533.297338912441, 4573.931391029138, 4646.976765116153, 4662.626989840838, 4673.532646735299, 5329.173978033411, 5332.76002579881, 5368.7115092377935, 5375.5162035417, 5382.67703937765, 3926.1362500249897, 3926.823292951824, 3937.3897045957924, 3960.2475529649273, 3982.825066605358, 5347.6256662033675, 5580.441955804427, 5602.859928501779, 5675.2054712340305, 5681.659100453945, 3948.4866967294643, 3954.3277642800217, 3970.3845903884944, 3979.621935916083, 3991.201759648082, 3947.0988823214916, 3966.7421617594764, 4022.5172979242093, 4027.194561087794, 4042.959570404317, 4459.175052615276, 4557.931631025537, 4562.794674239667, 4571.314302854598, 4594.540545945379, 5361.865953351197, 5382.192671099288, 5382.91925621116, 5385.569154467633, 5395.595330350239, 1340.5040135149861, 1355.3697530648099, 1356.7286542691502, 1361.952331668387, 1362.0942073520998, 827.2843989948772, 864.3215076165305, 876.4303202918027, 880.2297989259398, 880.3749337970113, 5039.97480012605, 5056.140456122468, 5099.450274862569, 5116.411612664591, 5147.2279158126585, 5332.493413125747, 5399.433059528771, 5402.837914862561, 5515.917261241085, 5522.171674248895, 5032.3206367139965, 5149.9742501287255, 5180.870478238075, 5212.061828870764, 5245.527902488718, 2892.4070565534016, 2953.464198616707, 2966.1249931269895, 2970.4207679502288, 2973.4647763402795, 5750.367459579443, 5752.626079304916, 5756.280464941882, 5774.307083150049, 5799.3620701722775, 5514.779408823682, 5588.944110558924, 5623.8594035149445, 5628.240187574625, 5659.0, 5677.971610141923, 5713.485926229552, 5718.857028574235, 5720.313562372458, 5730.713464326684, 5268.315119034501, 5516.282883225155, 5518.33779946409, 5518.972405137949, 5575.721213939368, 5407.918881216706, 5431.4840090191365, 5447.093517268924, 5449.754761035683, 5485.945140548703, 5646.802361917313, 5692.260006199168, 5723.7996670116345, 5733.627314224562, 5738.512226460631, 3960.4653371795594, 3990.9401358980217, 4051.5948405159247, 4054.39184122384, 4060.127072679388, 5460.262864513399, 5462.235287059894, 5472.398036216093, 5479.53423958968, 5479.753411096431, 5342.9465705342445, 5359.410464848941, 5398.40617532079, 5402.135658294654, 5451.727413629382, 5139.357580302462, 5252.947470525399, 5332.120200166929, 5363.678179309254, 5442.510174084351, 5272.05103081449, 5287.814926477555, 5316.229146773619, 5324.494173053554, 5329.361965826941, 5188.22176673502, 5312.309399778004, 5333.679849265582, 5402.891942161056, 5407.324084489439, 5262.89474210506, 5263.710495922608, 5267.762950667306, 5309.65487243328, 5317.760700768397], "value": 4120.95614162988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7979845945446, 684.979380722723, 739.2681245566889, 755.2258934592043, 814.1695470619969, 12839.743205135892, 13726.450941962323, 13732.382042808073, 13740.656483587914, 13744.17534947904, 12400.255984640928, 12503.18729282596, 12511.186772859757, 12519.061070419732, 12522.18605790623, 649.0750680280605, 787.3189690917372, 788.4126325887222, 791.473670009443, 793.1117148793345, 664.2991643815773, 779.9766007019798, 786.8819677048431, 802.8956235689382, 816.2286639126029, 842.8272204198124, 842.93256539477, 849.0066622052183, 855.4396870050127, 856.0497847389393, 678.6131904814258, 839.8782176584361, 843.6077224090827, 844.5566077809137, 844.8141408890065, 512.8564002079423, 606.8786242751468, 610.1823556434355, 614.9914140809077, 615.7075389190144, 11624.360660163687, 11759.412029398582, 11772.058235341152, 11778.705532361759, 11822.645320640395, 12916.935415322863, 13139.240759440529, 13329.095568224711, 13493.595192144252, 13614.115082519704, 12014.279143251433, 12025.518979240907, 12028.51885924562, 12054.0, 12105.455254513568, 4241.384999175102, 4268.957310426918, 4324.156789426063, 4354.412154359185, 4362.214801335758, 61120.0, 61293.0, 62262.68868655628, 63173.68413157997, 63879.36120638827, 10111.7472063199, 10223.9488802557, 10309.226807989431, 10356.896431035593, 10708.196885233483, 18237.54406139857, 18265.0, 18284.908575457303, 18292.359767408343, 18297.085145742658, 7514.887276690854, 7677.846443071219, 7806.648700808477, 7869.960650196713, 8053.919460805434, 4259.97870010648, 4277.1873344064525, 4404.603585677304, 4428.2914733642465, 4466.531014243457, 3103.3638104188585, 3171.4608516552244, 3203.0711093783007, 3220.7745457818196, 3225.5645487859306, 562.7819492900735, 570.9029464990962, 573.7418161827194, 573.8020382967869, 579.901416759152, 661.2527843536773, 673.182083768224, 685.6229074009275, 701.1726163127456, 706.9717211311593, 8002.319802816709, 8816.77958051041, 8824.205821476098, 8988.415752976036, 9021.368504204642, 656.6979189572754, 672.8116127484312, 683.3132701634925, 684.1550684904139, 726.4079774983371, 3924.1955399143108, 4044.4539987101366, 4205.0, 4224.45082139326, 4275.5296917339065, 82781.58609207036, 84224.15775842285, 87563.0, 88542.55728721315, 88605.0, 53614.0, 54165.0, 76433.6178319116, 76549.6172519145, 76879.61560192163, 68717.31282687209, 69491.30508694849, 71306.28693712996, 71959.6402017997, 73322.0, 8031.83936321282, 8250.504969701837, 8264.256216940505, 8361.247487726134, 8700.260477859452, 42698.0, 43191.78404107959, 46344.30483542817, 47016.29475557938, 47620.2856957139, 60239.698801505714, 60815.39184608097, 64895.0, 66454.0, 68001.31998680148, 10527.210459215436, 11183.0, 11273.098152147644, 11274.210805243554, 11583.073354131819, 11618.477168527606, 11688.824667630162, 11701.648950531498, 11939.223950443193, 12184.57353992606, 10899.564017439214, 10969.396683182502, 11127.554897803997, 11368.772624547297, 11734.530618775154, 10770.353778773298, 10852.891471085504, 11178.664640060812, 11420.200585958903, 11510.59712910044, 10938.45307734626, 11395.772084558428, 11608.24546404481, 11761.376331272537, 11824.290542567473, 8550.700725474579, 8592.140785921358, 8646.524441155796, 8804.163604457566, 8808.11918808114, 7886.6510724337895, 8225.259726624632, 8893.333000024895, 9225.953870230605, 9351.0], "value": 6657.077263369157, "unit": "score"}], "name": "dromaeo_css", "value": 6947.691411897026, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 112.0, 112.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 127.0, 167.0, 125.0, 126.0, 123.0, 121.0, 165.0, 124.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 161.0, 161.0, 161.0, 164.0, 163.0, 164.0, 162.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 119.0, 76.0, 76.0, 75.0, 76.0, 105.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 123.0, 82.0, 83.0, 83.0, 106.0, 82.0, 82.0, 114.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 61.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 85.0, 80.0, 79.0, 79.0, 79.0, 79.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 132.0, 129.0, 129.0, 133.0, 133.0, 131.0, 180.0, 135.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 172.0, 167.0, 164.0, 164.0, 165.0, 164.0, 166.0, 164.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 69.0, 67.0, 69.0, 63.0, 63.0, 63.0, 62.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1494.9, "alertThreshold": 2.0}]} 00:49:22 INFO - Return code: 0 00:49:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:49:22 INFO - # TBPL SUCCESS # 00:49:22 INFO - Running post-action listener: _resource_record_post_action 00:49:22 INFO - [mozharness: 2016-10-31 07:49:22.569032Z] Finished run-tests step (success) 00:49:22 INFO - Running post-run listener: _resource_record_post_run 00:49:22 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409890816; Read time: 12; Write time: 322248 00:49:22 INFO - TinderboxPrint: CPU usage
13.1% 00:49:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:49:22 INFO - TinderboxPrint: I/O write bytes / time
409,890,816 / 322,248 00:49:22 INFO - TinderboxPrint: CPU idle
8,307.5 (86.9%) 00:49:22 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 00:49:22 INFO - TinderboxPrint: Swap in / out
0 / 0 00:49:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120463360; Read time: 0; Write time: 81172 00:49:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289067008; Read time: 0; Write time: 241076 00:49:23 INFO - Running post-run listener: _upload_blobber_files 00:49:23 INFO - Blob upload gear active. 00:49:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:49:23 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 00:49:23 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:49:23 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:49:23 INFO - (blobuploader) - INFO - Open directory for files ... 00:49:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:49:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:24 INFO - (blobuploader) - INFO - Done attempting. 00:49:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:49:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:49:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:27 INFO - (blobuploader) - INFO - Done attempting. 00:49:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:49:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:49:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:28 INFO - (blobuploader) - INFO - Done attempting. 00:49:28 INFO - (blobuploader) - INFO - Iteration through files over. 00:49:28 INFO - Return code: 0 00:49:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:49:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:49:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d100b12577bf03e04fc1456f6034ae69365ce695bf8ec6a88c4c8919e2bb29c969880ab765da3c67e03c5154597100b571125116778d25d91f015a2530de969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0961a3dfe068bd7d81a67274ac6d104d240c1860e7de319151253c526adf49e8b3b961060e93472a5e6e81941f52f25f00652fb8c9abfd78c47753704bc0c57d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f153da9e5c541f376993d597b06c4f52eb3a41e87e4291b26625f4b22585666d88d10f7a5dbc65305855997db5171fe71f3b9dfa602c071c44124699685f66bd"} 00:49:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:49:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:49:28 INFO - Contents: 00:49:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d100b12577bf03e04fc1456f6034ae69365ce695bf8ec6a88c4c8919e2bb29c969880ab765da3c67e03c5154597100b571125116778d25d91f015a2530de969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0961a3dfe068bd7d81a67274ac6d104d240c1860e7de319151253c526adf49e8b3b961060e93472a5e6e81941f52f25f00652fb8c9abfd78c47753704bc0c57d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f153da9e5c541f376993d597b06c4f52eb3a41e87e4291b26625f4b22585666d88d10f7a5dbc65305855997db5171fe71f3b9dfa602c071c44124699685f66bd"} 00:49:28 INFO - Running post-run listener: copy_logs_to_upload_dir 00:49:28 INFO - Copying logs to upload dir... 00:49:28 INFO - mkdir: /builds/slave/test/build/upload/logs 00:49:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.346798 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-31 00:49:28.296845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 00:49:28.304699) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865 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/sha512/7d100b12577bf03e04fc1456f6034ae69365ce695bf8ec6a88c4c8919e2bb29c969880ab765da3c67e03c5154597100b571125116778d25d91f015a2530de969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0961a3dfe068bd7d81a67274ac6d104d240c1860e7de319151253c526adf49e8b3b961060e93472a5e6e81941f52f25f00652fb8c9abfd78c47753704bc0c57d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f153da9e5c541f376993d597b06c4f52eb3a41e87e4291b26625f4b22585666d88d10f7a5dbc65305855997db5171fe71f3b9dfa602c071c44124699685f66bd"} build_url:https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/ZJgu83GsRDyuekFAaCKWFg/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/sha512/7d100b12577bf03e04fc1456f6034ae69365ce695bf8ec6a88c4c8919e2bb29c969880ab765da3c67e03c5154597100b571125116778d25d91f015a2530de969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0961a3dfe068bd7d81a67274ac6d104d240c1860e7de319151253c526adf49e8b3b961060e93472a5e6e81941f52f25f00652fb8c9abfd78c47753704bc0c57d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f153da9e5c541f376993d597b06c4f52eb3a41e87e4291b26625f4b22585666d88d10f7a5dbc65305855997db5171fe71f3b9dfa602c071c44124699685f66bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 00:49:28.332939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:49:28.333328) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477892843.910776-100657865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 00:49:28.415088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 00:49:28.418447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 00:49:28.418768) ========= ========= Total master_lag: 0.17 =========