builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1476995121.47 results: success (0) buildid: 20161020124549 builduid: 9bb2984081cf41a1b53fda5a2285a5e4 revision: 11ae641575dcfe43941a7cc72d852a2cedd5710f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.475003) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.475449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.475737) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.504728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.505086) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 13:25:21-- 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% 224M=0s 2016-10-20 13:25:21 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.710973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.711293) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.062078 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:21.783745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 13:25:21.784083) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11ae641575dcfe43941a7cc72d852a2cedd5710f --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 11ae641575dcfe43941a7cc72d852a2cedd5710f --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=03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 13:25:21,840 truncating revision to first 12 chars 2016-10-20 13:25:21,840 Setting DEBUG logging. 2016-10-20 13:25:21,840 attempt 1/10 2016-10-20 13:25:21,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11ae641575dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 13:25:22,501 unpacking tar archive at: fx-team-11ae641575dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 13:25:22.795170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:22.795545) ========= script_repo_revision: 11ae641575dcfe43941a7cc72d852a2cedd5710f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:22.796878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:22.797144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 13:25:22.808683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-20 13:25:22.808991) ========= /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=03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:23 INFO - MultiFileLogger online at 20161020 13:25:23 in /builds/slave/test 13:25:23 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 13:25:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:23 INFO - {'append_to_log': False, 13:25:23 INFO - 'base_work_dir': '/builds/slave/test', 13:25:23 INFO - 'blob_upload_branch': 'Fx-Team', 13:25:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:23 INFO - 'branch': 'Fx-Team', 13:25:23 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:23 INFO - 'config_files': ('talos/linux_config.py',), 13:25:23 INFO - 'default_actions': ('clobber', 13:25:23 INFO - 'read-buildbot-config', 13:25:23 INFO - 'download-and-extract', 13:25:23 INFO - 'populate-webroot', 13:25:23 INFO - 'create-virtualenv', 13:25:23 INFO - 'install', 13:25:23 INFO - 'run-tests'), 13:25:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:23 INFO - 'download_minidump_stackwalk': True, 13:25:23 INFO - 'download_symbols': 'ondemand', 13:25:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:23 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:23 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:23 INFO - 'installer_path': 'installer.exe', 13:25:23 INFO - 'log_level': 'info', 13:25:23 INFO - 'log_name': 'talos', 13:25:23 INFO - 'log_to_console': True, 13:25:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:23 INFO - 'opt_config_files': (), 13:25:23 INFO - 'pip_index': False, 13:25:23 INFO - 'sps_profile': False, 13:25:23 INFO - 'sps_profile_interval': 0, 13:25:23 INFO - 'suite': 'dromaeojs', 13:25:23 INFO - 'system_bits': '32', 13:25:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:23 INFO - 'title': 'talos-linux64-ix-047', 13:25:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:23 INFO - 'use_talos_json': True, 13:25:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:23 INFO - 'work_dir': 'build'} 13:25:23 INFO - [mozharness: 2016-10-20 20:25:23.130122Z] Running clobber step. 13:25:23 INFO - Running pre-action listener: _resource_record_pre_action 13:25:23 INFO - Running main action method: clobber 13:25:23 INFO - rmtree: /builds/slave/test/build 13:25:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:24 INFO - Running post-action listener: _resource_record_post_action 13:25:24 INFO - [mozharness: 2016-10-20 20:25:24.234890Z] Finished clobber step (success) 13:25:24 INFO - [mozharness: 2016-10-20 20:25:24.235106Z] Running read-buildbot-config step. 13:25:24 INFO - Running pre-action listener: _resource_record_pre_action 13:25:24 INFO - Running main action method: read_buildbot_config 13:25:24 INFO - Using buildbot properties: 13:25:24 INFO - { 13:25:24 INFO - "project": "", 13:25:24 INFO - "product": "firefox", 13:25:24 INFO - "script_repo_revision": "production", 13:25:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:25:24 INFO - "repository": "", 13:25:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:25:24 INFO - "buildid": "20161020124549", 13:25:24 INFO - "stage_platform": "linux64-pgo", 13:25:24 INFO - "basedir": "/builds/slave/test", 13:25:24 INFO - "buildnumber": 1648, 13:25:24 INFO - "platform": "ubuntu64_hw", 13:25:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:25:24 INFO - "slavebuilddir": "test", 13:25:24 INFO - "branch": "fx-team", 13:25:24 INFO - "revision": "11ae641575dcfe43941a7cc72d852a2cedd5710f", 13:25:24 INFO - "slavename": "talos-linux64-ix-047", 13:25:24 INFO - "builduid": "9bb2984081cf41a1b53fda5a2285a5e4", 13:25:24 INFO - "repo_path": "integration/fx-team" 13:25:24 INFO - } 13:25:24 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:25:24 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:25:24 INFO - Running post-action listener: _resource_record_post_action 13:25:24 INFO - [mozharness: 2016-10-20 20:25:24.240067Z] Finished read-buildbot-config step (success) 13:25:24 INFO - [mozharness: 2016-10-20 20:25:24.240241Z] Running download-and-extract step. 13:25:24 INFO - Running pre-action listener: _resource_record_pre_action 13:25:24 INFO - Running main action method: download_and_extract 13:25:24 INFO - mkdir: /builds/slave/test/build/tests 13:25: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')]} 13:25:24 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:25:24 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/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 13:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/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 13:25:24 INFO - Downloaded 1361 bytes. 13:25:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:25:24 INFO - Using the following test package requirements: 13:25:24 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:25:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:25:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'jsshell-linux-x86_64.zip'], 13:25:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:25:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:25:24 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:25:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:25:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:25:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:25:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:25:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:25:24 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:25:24 INFO - Http code: 200 13:25:24 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 13:25:24 INFO - x-amz-cf-id: pZGGt7sDRIy1uB8aPPRDX8iZqfkB-wl2LuKfrMKkwl22kgh1b3-HNA== 13:25:24 INFO - x-amz-replication-status: COMPLETED 13:25:24 INFO - x-amz-version-id: yL21uDj4xLRcHP6p0GHBsMOYZZXPw5tj 13:25:24 INFO - Expected file size: 22118981 13:25:24 INFO - Obtained file size: 22118981 13:25:28 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 13:25:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:25:28 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:25:28 INFO - Http code: 200 13:25:28 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 13:25:28 INFO - x-amz-cf-id: xMASOj9xo_8gutyQWpmsz0TQPyzgcMo22CqShHk-N2kZNuyp19yNZw== 13:25:28 INFO - x-amz-replication-status: COMPLETED 13:25:28 INFO - x-amz-version-id: yL21uDj4xLRcHP6p0GHBsMOYZZXPw5tj 13:25:29 INFO - Expected file size: 22118981 13:25:29 INFO - Obtained file size: 22118981 13:25:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:25:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:25:33 INFO - Http code: 200 13:25:33 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 13:25:33 INFO - x-amz-cf-id: TAxpvm-0ObF_NriV9vQUiG5V_IEqzxU28ssbXxu_jR_eCMrI0CUUdw== 13:25:33 INFO - x-amz-replication-status: COMPLETED 13:25:33 INFO - x-amz-version-id: BvTUEwQTXKvGW1keJrLjT5kS5PKXTkVc 13:25:33 INFO - Expected file size: 14409028 13:25:33 INFO - Obtained file size: 14409028 13:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:34 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:25:34 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/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 13:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/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 13:25:34 INFO - Downloaded 59486880 bytes. 13:25:34 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:25:34 INFO - mkdir: /builds/slave/test/properties 13:25:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:34 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:34 INFO - Contents: 13:25:34 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:25:35 INFO - Running post-action listener: _resource_record_post_action 13:25:35 INFO - Running post-action listener: set_extra_try_arguments 13:25:35 INFO - [mozharness: 2016-10-20 20:25:35.117955Z] Finished download-and-extract step (success) 13:25:35 INFO - [mozharness: 2016-10-20 20:25:35.118187Z] Running populate-webroot step. 13:25:35 INFO - Running pre-action listener: _resource_record_pre_action 13:25:35 INFO - Running main action method: populate_webroot 13:25:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:35 INFO - '--tppagecycles', 13:25:35 INFO - '7'], 13:25:35 INFO - 'tests': ['tsvgm']}}, 13:25:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['damp', 'tps']}, 13:25:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'tests': ['damp', 'tps']}, 13:25:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['dromaeo_dom']}, 13:25:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['basic_compositor_video']}, 13:25:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:25:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['a11yr', 13:25:35 INFO - 'ts_paint', 13:25:35 INFO - 'tpaint', 13:25:35 INFO - 'sessionrestore', 13:25:35 INFO - 'sessionrestore_no_auto_restore', 13:25:35 INFO - 'tabpaint']}, 13:25:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tsvgx', 13:25:35 INFO - 'tsvgr_opacity', 13:25:35 INFO - 'tart', 13:25:35 INFO - 'tscrollx', 13:25:35 INFO - 'cart']}, 13:25:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:35 INFO - 'tsvgr_opacity', 13:25:35 INFO - 'tart', 13:25:35 INFO - 'tscrollx', 13:25:35 INFO - 'cart']}, 13:25:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s'], 13:25:35 INFO - 'tests': ['tp5o']}, 13:25:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'tests': ['tp5o']}, 13:25:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'talos_options': ['--disable-e10s', 13:25:35 INFO - '--xperf_path', 13:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:35 INFO - 'tests': ['tp5n']}, 13:25:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:35 INFO - 'talos_options': ['--xperf_path', 13:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:35 INFO - 'tests': ['tp5n']}}, 13:25:35 INFO - 'talos.zip': {'path': '', 13:25:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:35 INFO - Running post-action listener: _resource_record_post_action 13:25:35 INFO - [mozharness: 2016-10-20 20:25:35.137190Z] Finished populate-webroot step (success) 13:25:35 INFO - [mozharness: 2016-10-20 20:25:35.137276Z] Running create-virtualenv step. 13:25:35 INFO - Running pre-action listener: _resource_record_pre_action 13:25:35 INFO - Running main action method: create_virtualenv 13:25:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:35 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 13:25:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:35 INFO - Using real prefix '/usr' 13:25:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:35 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:39 INFO - Installing pip.................done. 13:25:39 INFO - Return code: 0 13:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:25:40 INFO - Reading from file tmpfile_stdout 13:25:40 INFO - Output received: 13:25:40 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) 13:25:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25:40 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')]} 13:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:40 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')]} 13:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:40 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:40 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 13:25:40 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 13:25:40 INFO - Using env: {'DISPLAY': ':0', 13:25:40 INFO - 'HOME': '/home/cltbld', 13:25:40 INFO - 'LANG': 'en_US.UTF-8', 13:25:40 INFO - 'LANGUAGE': 'en_US:en', 13:25:40 INFO - 'LOGNAME': 'cltbld', 13:25:40 INFO - 'MAIL': '/var/mail/cltbld', 13:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:40 INFO - 'MOZ_NO_REMOTE': '1', 13:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:40 INFO - 'NO_EM_RESTART': '1', 13:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:40 INFO - 'PWD': '/builds/slave/test', 13:25:40 INFO - 'SHELL': '/bin/bash', 13:25:40 INFO - 'SHLVL': '1', 13:25:40 INFO - 'TERM': 'linux', 13:25:40 INFO - 'TMOUT': '86400', 13:25:40 INFO - 'USER': 'cltbld', 13:25:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:40 INFO - '_': '/tools/buildbot/bin/python'} 13:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:40 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 13:25:40 INFO - Cleaning up... 13:25:40 INFO - Return code: 0 13:25:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:25:40 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')]} 13:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:40 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')]} 13:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:40 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:40 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 13:25:40 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 13:25:40 INFO - Using env: {'DISPLAY': ':0', 13:25:40 INFO - 'HOME': '/home/cltbld', 13:25:40 INFO - 'LANG': 'en_US.UTF-8', 13:25:40 INFO - 'LANGUAGE': 'en_US:en', 13:25:40 INFO - 'LOGNAME': 'cltbld', 13:25:40 INFO - 'MAIL': '/var/mail/cltbld', 13:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:40 INFO - 'MOZ_NO_REMOTE': '1', 13:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:40 INFO - 'NO_EM_RESTART': '1', 13:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:40 INFO - 'PWD': '/builds/slave/test', 13:25:40 INFO - 'SHELL': '/bin/bash', 13:25:40 INFO - 'SHLVL': '1', 13:25:40 INFO - 'TERM': 'linux', 13:25:40 INFO - 'TMOUT': '86400', 13:25:40 INFO - 'USER': 'cltbld', 13:25:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:40 INFO - '_': '/tools/buildbot/bin/python'} 13:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:40 INFO - Downloading/unpacking psutil>=3.1.1 13:25:40 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 13:25:40 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 13:25:40 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 13:25:40 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 13:25:40 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 13:25:40 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 13:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:42 INFO - Installing collected packages: psutil 13:25:42 INFO - Running setup.py install for psutil 13:25:42 INFO - building 'psutil._psutil_linux' extension 13:25:42 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 13:25:44 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 13:25:44 INFO - building 'psutil._psutil_posix' extension 13:25:44 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 13:25:44 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 13:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:44 INFO - Successfully installed psutil 13:25:44 INFO - Cleaning up... 13:25:44 INFO - Return code: 0 13:25:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:25:44 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')]} 13:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:44 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')]} 13:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:44 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:44 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 13:25:44 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 13:25:44 INFO - Using env: {'DISPLAY': ':0', 13:25:44 INFO - 'HOME': '/home/cltbld', 13:25:44 INFO - 'LANG': 'en_US.UTF-8', 13:25:44 INFO - 'LANGUAGE': 'en_US:en', 13:25:44 INFO - 'LOGNAME': 'cltbld', 13:25:44 INFO - 'MAIL': '/var/mail/cltbld', 13:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:44 INFO - 'MOZ_NO_REMOTE': '1', 13:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:44 INFO - 'NO_EM_RESTART': '1', 13:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:44 INFO - 'PWD': '/builds/slave/test', 13:25:44 INFO - 'SHELL': '/bin/bash', 13:25:44 INFO - 'SHLVL': '1', 13:25:44 INFO - 'TERM': 'linux', 13:25:44 INFO - 'TMOUT': '86400', 13:25:44 INFO - 'USER': 'cltbld', 13:25:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:44 INFO - '_': '/tools/buildbot/bin/python'} 13:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:25:44 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 13:25:44 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 13:25:44 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 13:25:44 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 13:25:44 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 13:25:44 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 13:25:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:25:46 INFO - Installing collected packages: mozsystemmonitor 13:25:46 INFO - Running setup.py install for mozsystemmonitor 13:25:46 INFO - Successfully installed mozsystemmonitor 13:25:46 INFO - Cleaning up... 13:25:46 INFO - Return code: 0 13:25:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:46 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:46 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 13:25:46 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 13:25:46 INFO - Using env: {'DISPLAY': ':0', 13:25:46 INFO - 'HOME': '/home/cltbld', 13:25:46 INFO - 'LANG': 'en_US.UTF-8', 13:25:46 INFO - 'LANGUAGE': 'en_US:en', 13:25:46 INFO - 'LOGNAME': 'cltbld', 13:25:46 INFO - 'MAIL': '/var/mail/cltbld', 13:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:46 INFO - 'MOZ_NO_REMOTE': '1', 13:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:46 INFO - 'NO_EM_RESTART': '1', 13:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:46 INFO - 'PWD': '/builds/slave/test', 13:25:46 INFO - 'SHELL': '/bin/bash', 13:25:46 INFO - 'SHLVL': '1', 13:25:46 INFO - 'TERM': 'linux', 13:25:46 INFO - 'TMOUT': '86400', 13:25:46 INFO - 'USER': 'cltbld', 13:25:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:46 INFO - '_': '/tools/buildbot/bin/python'} 13:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:47 INFO - Downloading/unpacking jsonschema==2.5.1 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:47 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 13:25:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:25:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:25:49 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 13:25:49 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 13:25:49 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 13:25:49 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 13:25:49 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 13:25:49 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 13:25:49 INFO - Downloading functools32-3.2.3-2.tar.gz 13:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:25:49 INFO - warning: no files found matching '*.txt' 13:25:49 INFO - no previously-included directories found matching 'build' 13:25:49 INFO - no previously-included directories found matching 'dist' 13:25:49 INFO - no previously-included directories found matching '.git*' 13:25:49 INFO - Installing collected packages: jsonschema, functools32 13:25:49 INFO - Running setup.py install for functools32 13:25:49 INFO - warning: no files found matching '*.txt' 13:25:49 INFO - no previously-included directories found matching 'build' 13:25:49 INFO - no previously-included directories found matching 'dist' 13:25:49 INFO - no previously-included directories found matching '.git*' 13:25:49 INFO - Successfully installed jsonschema functools32 13:25:49 INFO - Cleaning up... 13:25:49 INFO - Return code: 0 13:25:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:25:49 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')]} 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:49 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')]} 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:49 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:49 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 13:25:49 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 13:25:49 INFO - Using env: {'DISPLAY': ':0', 13:25:49 INFO - 'HOME': '/home/cltbld', 13:25:49 INFO - 'LANG': 'en_US.UTF-8', 13:25:49 INFO - 'LANGUAGE': 'en_US:en', 13:25:49 INFO - 'LOGNAME': 'cltbld', 13:25:49 INFO - 'MAIL': '/var/mail/cltbld', 13:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:49 INFO - 'MOZ_NO_REMOTE': '1', 13:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:49 INFO - 'NO_EM_RESTART': '1', 13:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:49 INFO - 'PWD': '/builds/slave/test', 13:25:49 INFO - 'SHELL': '/bin/bash', 13:25:49 INFO - 'SHLVL': '1', 13:25:49 INFO - 'TERM': 'linux', 13:25:49 INFO - 'TMOUT': '86400', 13:25:49 INFO - 'USER': 'cltbld', 13:25:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:49 INFO - '_': '/tools/buildbot/bin/python'} 13:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:25:49 INFO - Cleaning up... 13:25:49 INFO - Return code: 0 13:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:25:49 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')]} 13:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:49 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')]} 13:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:49 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:49 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 13:25:49 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 13:25:49 INFO - Using env: {'DISPLAY': ':0', 13:25:49 INFO - 'HOME': '/home/cltbld', 13:25:49 INFO - 'LANG': 'en_US.UTF-8', 13:25:49 INFO - 'LANGUAGE': 'en_US:en', 13:25:49 INFO - 'LOGNAME': 'cltbld', 13:25:49 INFO - 'MAIL': '/var/mail/cltbld', 13:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:49 INFO - 'MOZ_NO_REMOTE': '1', 13:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:49 INFO - 'NO_EM_RESTART': '1', 13:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:49 INFO - 'PWD': '/builds/slave/test', 13:25:49 INFO - 'SHELL': '/bin/bash', 13:25:49 INFO - 'SHLVL': '1', 13:25:49 INFO - 'TERM': 'linux', 13:25:49 INFO - 'TMOUT': '86400', 13:25:49 INFO - 'USER': 'cltbld', 13:25:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:49 INFO - '_': '/tools/buildbot/bin/python'} 13:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:25:50 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 13:25:50 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 13:25:50 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 13:25:50 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 13:25:50 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 13:25:50 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 13:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 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 13:25:52 INFO - Downloading docopt-0.6.1.tar.gz 13:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:25:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:25:52 INFO - Running setup.py install for blobuploader 13:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:25:53 INFO - Running setup.py install for requests 13:25:53 INFO - Running setup.py install for docopt 13:25:53 INFO - Successfully installed blobuploader requests docopt 13:25:53 INFO - Cleaning up... 13:25:53 INFO - Return code: 0 13:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:53 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:53 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 13:25:53 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 13:25:53 INFO - Using env: {'DISPLAY': ':0', 13:25:53 INFO - 'HOME': '/home/cltbld', 13:25:53 INFO - 'LANG': 'en_US.UTF-8', 13:25:53 INFO - 'LANGUAGE': 'en_US:en', 13:25:53 INFO - 'LOGNAME': 'cltbld', 13:25:53 INFO - 'MAIL': '/var/mail/cltbld', 13:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:53 INFO - 'MOZ_NO_REMOTE': '1', 13:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:53 INFO - 'NO_EM_RESTART': '1', 13:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:53 INFO - 'PWD': '/builds/slave/test', 13:25:53 INFO - 'SHELL': '/bin/bash', 13:25:53 INFO - 'SHLVL': '1', 13:25:53 INFO - 'TERM': 'linux', 13:25:53 INFO - 'TMOUT': '86400', 13:25:53 INFO - 'USER': 'cltbld', 13:25:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:53 INFO - '_': '/tools/buildbot/bin/python'} 13:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:53 INFO - Running setup.py (path:/tmp/pip-l9JgbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:53 INFO - Running setup.py (path:/tmp/pip-9u4VdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:53 INFO - Running setup.py (path:/tmp/pip-FdKst4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:53 INFO - Running setup.py (path:/tmp/pip-lFQUfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:54 INFO - Running setup.py (path:/tmp/pip-n5R2Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:54 INFO - Running setup.py (path:/tmp/pip-CBewt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:54 INFO - Running setup.py (path:/tmp/pip-SlxwMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:54 INFO - Running setup.py (path:/tmp/pip-73gPhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:54 INFO - Running setup.py (path:/tmp/pip-MIgEbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:54 INFO - Running setup.py (path:/tmp/pip-PgGCyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:54 INFO - Running setup.py (path:/tmp/pip-x5Iy6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:54 INFO - Running setup.py (path:/tmp/pip-l5U5Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:54 INFO - Running setup.py (path:/tmp/pip-6OvQGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:54 INFO - Running setup.py (path:/tmp/pip-s1N8_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:54 INFO - Running setup.py (path:/tmp/pip-WBqSDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:54 INFO - Running setup.py (path:/tmp/pip-_sj1z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:54 INFO - Running setup.py (path:/tmp/pip-ArjR5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:25:55 INFO - Running setup.py install for manifestparser 13:25:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Running setup.py install for mozcrash 13:25:55 INFO - Running setup.py install for mozdebug 13:25:55 INFO - Running setup.py install for mozdevice 13:25:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Running setup.py install for mozfile 13:25:55 INFO - Running setup.py install for mozhttpd 13:25:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Running setup.py install for mozinfo 13:25:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Running setup.py install for mozInstall 13:25:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:25:55 INFO - Running setup.py install for mozleak 13:25:55 INFO - Running setup.py install for mozlog 13:25:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Running setup.py install for moznetwork 13:25:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Running setup.py install for mozprocess 13:25:56 INFO - Running setup.py install for mozprofile 13:25:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Running setup.py install for mozrunner 13:25:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Running setup.py install for mozscreenshot 13:25:56 INFO - Running setup.py install for moztest 13:25:56 INFO - Running setup.py install for mozversion 13:25:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:25:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:25:56 INFO - Cleaning up... 13:25:56 INFO - Return code: 0 13:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:25:56 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 13:25:56 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 13:25:56 INFO - Using env: {'DISPLAY': ':0', 13:25:56 INFO - 'HOME': '/home/cltbld', 13:25:56 INFO - 'LANG': 'en_US.UTF-8', 13:25:56 INFO - 'LANGUAGE': 'en_US:en', 13:25:56 INFO - 'LOGNAME': 'cltbld', 13:25:56 INFO - 'MAIL': '/var/mail/cltbld', 13:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:56 INFO - 'MOZ_NO_REMOTE': '1', 13:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:56 INFO - 'NO_EM_RESTART': '1', 13:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:56 INFO - 'PWD': '/builds/slave/test', 13:25:56 INFO - 'SHELL': '/bin/bash', 13:25:56 INFO - 'SHLVL': '1', 13:25:56 INFO - 'TERM': 'linux', 13:25:56 INFO - 'TMOUT': '86400', 13:25:56 INFO - 'USER': 'cltbld', 13:25:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:56 INFO - '_': '/tools/buildbot/bin/python'} 13:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:57 INFO - Running setup.py (path:/tmp/pip-ttky5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:57 INFO - Running setup.py (path:/tmp/pip-79Qaf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:57 INFO - Running setup.py (path:/tmp/pip-bc6ULp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:57 INFO - Running setup.py (path:/tmp/pip-Zd1tjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:57 INFO - Running setup.py (path:/tmp/pip-CE5gi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:57 INFO - Running setup.py (path:/tmp/pip-yWPO4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:57 INFO - Running setup.py (path:/tmp/pip-5xu_gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:57 INFO - Running setup.py (path:/tmp/pip-wQmkp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:57 INFO - Running setup.py (path:/tmp/pip-VJgmOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:57 INFO - Running setup.py (path:/tmp/pip-k8EXMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:57 INFO - Running setup.py (path:/tmp/pip-dI5GcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:57 INFO - Running setup.py (path:/tmp/pip-zG2eT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:57 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)) 13:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:57 INFO - Running setup.py (path:/tmp/pip-ZhuSfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:57 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)) 13:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:58 INFO - Running setup.py (path:/tmp/pip-Af1wQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:58 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)) 13:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:58 INFO - Running setup.py (path:/tmp/pip-j6Ssms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:58 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)) 13:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:58 INFO - Running setup.py (path:/tmp/pip-YZ3RME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:58 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)) 13:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:58 INFO - Running setup.py (path:/tmp/pip-f8ByW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 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)) 13:25:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:00 INFO - Downloading blessings-1.6.tar.gz 13:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:00 INFO - Installing collected packages: blessings 13:26:00 INFO - Running setup.py install for blessings 13:26:00 INFO - Successfully installed blessings 13:26:00 INFO - Cleaning up... 13:26:00 INFO - Return code: 0 13:26:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:00 INFO - Reading from file tmpfile_stdout 13:26:00 INFO - Current package versions: 13:26:00 INFO - argparse == 1.2.1 13:26:00 INFO - blessings == 1.6 13:26:00 INFO - blobuploader == 1.2.4 13:26:00 INFO - docopt == 0.6.1 13:26:00 INFO - functools32 == 3.2.3-2 13:26:00 INFO - jsonschema == 2.5.1 13:26:00 INFO - manifestparser == 1.1 13:26:00 INFO - mozInstall == 1.12 13:26:00 INFO - mozcrash == 0.17 13:26:00 INFO - mozdebug == 0.1 13:26:00 INFO - mozdevice == 0.48 13:26:00 INFO - mozfile == 1.2 13:26:00 INFO - mozhttpd == 0.7 13:26:00 INFO - mozinfo == 0.9 13:26:00 INFO - mozleak == 0.1 13:26:00 INFO - mozlog == 3.4 13:26:00 INFO - moznetwork == 0.27 13:26:00 INFO - mozprocess == 0.23 13:26:00 INFO - mozprofile == 0.28 13:26:00 INFO - mozrunner == 6.12 13:26:00 INFO - mozscreenshot == 0.1 13:26:00 INFO - mozsystemmonitor == 0.3 13:26:00 INFO - moztest == 0.7 13:26:00 INFO - mozversion == 1.4 13:26:00 INFO - psutil == 3.1.1 13:26:00 INFO - requests == 1.2.3 13:26:00 INFO - wsgiref == 0.1.2 13:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:00 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')]} 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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')]} 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:26:00 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 13:26:00 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 13:26:00 INFO - Using env: {'DISPLAY': ':0', 13:26:00 INFO - 'HOME': '/home/cltbld', 13:26:00 INFO - 'LANG': 'en_US.UTF-8', 13:26:00 INFO - 'LANGUAGE': 'en_US:en', 13:26:00 INFO - 'LOGNAME': 'cltbld', 13:26:00 INFO - 'MAIL': '/var/mail/cltbld', 13:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:00 INFO - 'MOZ_NO_REMOTE': '1', 13:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:00 INFO - 'NO_EM_RESTART': '1', 13:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:00 INFO - 'PWD': '/builds/slave/test', 13:26:00 INFO - 'SHELL': '/bin/bash', 13:26:00 INFO - 'SHLVL': '1', 13:26:00 INFO - 'TERM': 'linux', 13:26:00 INFO - 'TMOUT': '86400', 13:26:00 INFO - 'USER': 'cltbld', 13:26:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:00 INFO - '_': '/tools/buildbot/bin/python'} 13:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 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)) 13:26:00 INFO - Cleaning up... 13:26:00 INFO - Return code: 0 13:26:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:00 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')]} 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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')]} 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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 0x7fea0a852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cad7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, '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': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', '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 13:26:00 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 13:26:00 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 13:26:00 INFO - Using env: {'DISPLAY': ':0', 13:26:00 INFO - 'HOME': '/home/cltbld', 13:26:00 INFO - 'LANG': 'en_US.UTF-8', 13:26:00 INFO - 'LANGUAGE': 'en_US:en', 13:26:00 INFO - 'LOGNAME': 'cltbld', 13:26:00 INFO - 'MAIL': '/var/mail/cltbld', 13:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:00 INFO - 'MOZ_NO_REMOTE': '1', 13:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:00 INFO - 'NO_EM_RESTART': '1', 13:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:00 INFO - 'PWD': '/builds/slave/test', 13:26:00 INFO - 'SHELL': '/bin/bash', 13:26:00 INFO - 'SHLVL': '1', 13:26:00 INFO - 'TERM': 'linux', 13:26:00 INFO - 'TMOUT': '86400', 13:26:00 INFO - 'USER': 'cltbld', 13:26:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:00 INFO - '_': '/tools/buildbot/bin/python'} 13:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:26:01 INFO - Cleaning up... 13:26:01 INFO - Return code: 0 13:26:01 INFO - Running post-action listener: _resource_record_post_action 13:26:01 INFO - Running post-action listener: _start_resource_monitoring 13:26:01 INFO - Starting resource monitoring. 13:26:01 INFO - [mozharness: 2016-10-20 20:26:01.211935Z] Finished create-virtualenv step (success) 13:26:01 INFO - [mozharness: 2016-10-20 20:26:01.212373Z] Running install step. 13:26:01 INFO - Running pre-action listener: _resource_record_pre_action 13:26:01 INFO - Running main action method: install 13:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:01 INFO - Reading from file tmpfile_stdout 13:26:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:01 INFO - Reading from file tmpfile_stdout 13:26:01 INFO - Output received: 13:26:01 INFO - Usage: mozinstall [options] installer 13:26:01 INFO - Options: 13:26:01 INFO - -h, --help show this help message and exit 13:26:01 INFO - -d DEST, --destination=DEST 13:26:01 INFO - Directory to install application into. [default: 13:26:01 INFO - "/builds/slave/test"] 13:26:01 INFO - --app=APP Application being installed. [default: firefox] 13:26:01 INFO - mkdir: /builds/slave/test/build/application 13:26:01 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'] 13:26:01 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 13:26:18 INFO - Reading from file tmpfile_stdout 13:26:18 INFO - Output received: 13:26:18 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:18 INFO - Running post-action listener: _resource_record_post_action 13:26:18 INFO - [mozharness: 2016-10-20 20:26:18.454354Z] Finished install step (success) 13:26:18 INFO - [mozharness: 2016-10-20 20:26:18.454626Z] Running run-tests step. 13:26:18 INFO - Running pre-action listener: _resource_record_pre_action 13:26:18 INFO - Running main action method: run_tests 13:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:18 INFO - Python 2.7.3 13:26:18 INFO - Return code: 0 13:26:18 INFO - grabbing minidump binary from tooltool 13:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:18 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 0x2d3c790>, '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 0x2d3d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:18 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 13:26:18 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 13:26:18 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 13:26:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:18 INFO - Return code: 0 13:26:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:18 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://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 13:26:18 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://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 13:26:18 INFO - Using env: {'DISPLAY': ':0', 13:26:18 INFO - 'HOME': '/home/cltbld', 13:26:18 INFO - 'LANG': 'en_US.UTF-8', 13:26:18 INFO - 'LANGUAGE': 'en_US:en', 13:26:18 INFO - 'LOGNAME': 'cltbld', 13:26:18 INFO - 'MAIL': '/var/mail/cltbld', 13:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:18 INFO - 'MOZ_NO_REMOTE': '1', 13:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:18 INFO - 'NO_EM_RESTART': '1', 13:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:18 INFO - 'PWD': '/builds/slave/test', 13:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:18 INFO - 'SHELL': '/bin/bash', 13:26:18 INFO - 'SHLVL': '1', 13:26:18 INFO - 'TERM': 'linux', 13:26:18 INFO - 'TMOUT': '86400', 13:26:18 INFO - 'USER': 'cltbld', 13:26:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485', 13:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:18 INFO - '_': '/tools/buildbot/bin/python'} 13:26:18 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://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 13:26:19 INFO - mozversion application_buildid: 20161020093008 13:26:19 INFO - mozversion application_changeset: 11ae641575dcfe43941a7cc72d852a2cedd5710f 13:26:19 INFO - mozversion application_display_name: Nightly 13:26:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:19 INFO - mozversion application_name: Firefox 13:26:19 INFO - mozversion application_remotingname: firefox 13:26:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:26:19 INFO - mozversion application_vendor: Mozilla 13:26:19 INFO - mozversion application_version: 52.0a1 13:26:19 INFO - mozversion platform_buildid: 20161020093008 13:26:19 INFO - mozversion platform_changeset: 11ae641575dcfe43941a7cc72d852a2cedd5710f 13:26:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:26:19 INFO - mozversion platform_version: 52.0a1 13:26:19 INFO - using testdate: 1476995179 13:26:19 INFO - actual date: 1476995179 13:26:19 INFO - starting webserver on 'localhost:38929' 13:26:19 INFO - SUITE-START | Running 2 tests 13:26:19 INFO - TEST-START | dromaeo_css 13:26:19 INFO - operating with platform_type : linux_ 13:26:19 INFO - Initialising browser for dromaeo_css test... 13:26:19 INFO - TEST-INFO | started process 3303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvIUvn/profile http://localhost:38929/getInfo.html) 13:26:25 INFO - PROCESS | 3303 | __metrics Screen width/height:1600/1200 13:26:25 INFO - PROCESS | 3303 | colorDepth:24 13:26:25 INFO - PROCESS | 3303 | Browser inner width/height: 1024/697 13:26:25 INFO - PROCESS | 3303 | __metrics 13:26:26 INFO - PROCESS | 3303 | 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" 13:26:26 INFO - PROCESS | 3303 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:27 INFO - TEST-INFO | 3303: exit 0 13:26:27 INFO - Browser initialized. 13:26:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:27 INFO - TEST-INFO | started process 3388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvIUvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:39 INFO - PROCESS | 3388 | RSS: Main: 171909120 13:26:39 INFO - PROCESS | 3388 | 13:27:30 INFO - PROCESS | 3388 | 1476995250640 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] 13:29:41 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:38929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38929/tests/dromaeo/cssquery-ext.html) 13:29:43 INFO - PROCESS | 3388 | RSS: Main: 401600512 13:29:43 INFO - PROCESS | 3388 | 13:32:46 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:38929/tests/dromaeo/cssquery-ext.html (next: http://localhost:38929/tests/dromaeo/cssquery-jquery.html) 13:32:47 INFO - PROCESS | 3388 | RSS: Main: 279838720 13:32:47 INFO - PROCESS | 3388 | 13:35:49 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:38929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38929/tests/dromaeo/cssquery-mootools.html) 13:35:49 INFO - PROCESS | 3388 | RSS: Main: 220004352 13:35:49 INFO - PROCESS | 3388 | 13:38:51 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:38929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38929/tests/dromaeo/cssquery-prototype.html) 13:38:52 INFO - PROCESS | 3388 | RSS: Main: 243953664 13:38:52 INFO - PROCESS | 3388 | 13:41:54 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:38929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38929/tests/dromaeo/cssquery-yui.html) 13:41:55 INFO - PROCESS | 3388 | RSS: Main: 221806592 13:41:55 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:38929/tests/dromaeo/cssquery-yui.html (next: http://localhost:38929/tests/dromaeo/cssquery-dojo.html) 13:44:58 INFO - PROCESS | 3388 | RSS: Main: 310419456 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | __start_tp_report 13:44:58 INFO - PROCESS | 3388 | _x_x_mozilla_page_load 13:44:58 INFO - PROCESS | 3388 | _x_x_mozilla_page_load_details 13:44:58 INFO - PROCESS | 3388 | |i|pagename|runs| 13:44:58 INFO - PROCESS | 3388 | |0;dojo.html;3101.8914337998167;3118.64135624403;3148.024112525117;3153.3535625196837;3162.304293055527;5237.266782650432;5348.973255133719;5379;5473.370562385322;5488.286522752047;5380.650257733245;5392.352917649888;5397.2443857859935;5399.487048730364;5401.297831281938;4884.096442158194;4905.533974272456;4918.877028074291;4947.802087916479;4959.578435832958;4986.800527978877;5051.242313652945;5052.393712754475;5059.721715305675;5063.164577844651;4921.138800709879;4952.801887924478;4997.30037794709;5003.549680528752;5053.620978426614;5014.874628134289;5052.520010598987;5055.721935293557;5055.747212639353;5110.412302585213;4834.830780922686;4864.270359446076;4882.853514394574;4902.607791376681;4905.583025442842;5366.865828354284;5375.3012108425655;5392.218128371364;5410.56715462766;5480.26016487773;5734.770609175628;5771.740271687784;5773.191753154561;5777.248957635523;5779;5600.299962504687;5670.886582268332;5672.829815105553;5823;5830.3586605473365;5330.546903513245;5332.9733351333;5334.786608535615;5343.839684809462;5466.726663666801;5993.850153746192;5997.6401415914315;6044.939550604526;6060.151578778975;6083.513318934474;5605.943940560543;5675.091985282335;5722.227499287626;5723.942760572341;5724.255846739898;5518.586106042063;5594.021046316879;5737.139429085587;5748.770049197985;5755.769769209185;5663.575231857627;5697.9430205698245;5704.172894930211;5779.971100144472;5797.884042319214;5706.201131841545;5715.742791574389;5725.227094342294;5727.828165155052;5805.535557155417;4353.717008394444;4355.912881742411;4373.343998400202;4399.450068741407;4440.023194897118;3931.1351502669368;3951.1110000249714;3970.642642162219;3973.8013099344917;4003.679705623543;5469.042917489503;5501.642393244426;5512;5571.052921003439;5579.4978451938705;5872.618279811799;5877.265341832271;5889.146073819272;5889.734961926723;5894.440028197314;5343.118385466354;5389.973050134724;5500.80747173855;5502.58730595207;5508.504234618904;5008.348914641073;5054.772535235923;5058.291839142449;5062.215356619729;5120.820771273062;5960.940390596212;6009;6022.909656355246;6023.096535519707;6025.367336429787;5724.255846739898;5846.269216347957;5848.795292164754;5850.297964244318;5856.267966504187;5930.555208359304;5950.137230101524;5987.371326010706;5989.550783691154;6016.187814645142;5663.263775709132;5779.104238842986;5785.479306862234;5790.160426738184;5795.188673585617;5808.767649293981;5825.679587622722;5829.213056237523;5829.8251052468495;5830.2129212555765;5599.748011339418;5692;5701.372848986525;5706.885862282814;5708.743106560298;5449.836504904859;5489.835304940858;5496.7526461310135;5544.445555444423;5544.833654990357;5535.723213839211;5544.611877168721;5554.028045092012;5554.944450555443;5558.555315574825;5549.278593782782;5581.190727344593;5582.944170558405;5599.384067752462;5599.944000560105;5475.945240547703;5480.890382192254;5484.040292948638;5485.75314110858;5488.643238189505 13:44:58 INFO - PROCESS | 3388 | |1;ext.html;609.5793902207478;615.2340336281328;622.5455417545191;647.62761412188;648.6432462145818;31600.367992640164;33681.66318336819;33710.66289337106;41134.17731645365;42931.14137717251;43293.78353108238;43869.561304387025;43893.341599875945;44055.77972110135;44158;8781.165789250012;8906.153915378061;8920.776980575505;8939.374243802904;8940.910590894073;7910.960445197766;8095.433319667625;8097.9595102024705;8259.256666899977;8715;10330.276880618323;10700.197485188603;10715.46422678863;11035.779284414308;11044.226904116715;10501;10505.68482945513;10509.789804203949;10563.207759418035;10591.470426478645;10399.948000260027;10466.842997355046;10578.84131738017;10579.523921423555;10584.100351470135;41664;41816.1636767266;41985.790071049756;41998.37002444966;42015;2830.6461692288462;3023.591815104977;3055.917421613193;3277.1643230975947;3358.8488518016748;30974;30980.380392392028;30989.845050774828;31019.689803101905;31420.842895785605;4225.880141762435;4232.547307709463;4261.190373828994;4289.1850548395705;4321.719088259253;309774;312329;312655.4367228172;313091;314801;58041;58461;58641.41358586445;58659;58748.41251587515;34781.82609086989;55945.720271398386;55993;56050;56117;14979.625509362353;15410.229488525752;15416.691666166838;15498.845011549965;15595.922020390053;12035.819462708067;12113.636590902288;12123.181522771654;12124;12125.575604853788;14713.55859324222;16732.41436549715;17086.316547337967;17499.56251093733;17997.640047199246;6938.965305173442;7136.892946605805;7144.285571442814;7240;7299.963500182465;903.7514683461969;995.581855620641;1031.0874875735028;1067.386252904583;1113.777244551093;30940.535891961637;30958.380832383227;31036.068917932498;31116.844415777778;31658.841705791325;1061.368485750977;1062.585591619269;1089.487940667885;1100.1858624617726;1112.9777404451866;15764.211789410712;16364.590885227964;16473.917630411772;16503.587410314838;16697.91651041737;495040;497341;498867;499135;499944;34577.82711086429;48473.272900906515;49450.75274623676;54729.45270547323;56576.151357729665;1286.1382873474795;1290.9483620655255;1304.6086174147908;1352.1819299323963;1352.8444228913802;30042.24894377658;31781.20546986344;32096.35807283888;32310.83844580762;34746.13134671653;54567.45432545624;55248.44751552433;55280.72359638176;55333.723331384695;55336.44663553474;454325;474143;475143;639378;645521;41373.586264138175;41407.37888931729;41793.58206417897;42144.78927605465;42642.36036459517;43800;44466.77766611146;46988.7650561745;47125.52874471348;47570.762146189045;38559.6144038556;39847.40228896627;40600.1879962405;40865.59134408618;41989.79005104955;38885.6111438882;39482.194197107165;39952.800235998635;40249.798751006056;41702.582974171084;39274.13351186818;40489.39265911072;40567.79716101401;40762.79618601888;40769.38845917373;33012.21322908213;35860.462093069145;36198.8190059048;36617.81691091527;36753.448698269014;26265.606015910158;26553.60169597496;26582.202533924014;26764.732352676223;27084.458310833277 13:44:58 INFO - PROCESS | 3388 | |2;jquery.html;363.4167161705464;369.9467952861617;377.37915652273483;387.49431991251413;399.6183644619387;14199.71600567988;14632;18895;19067;19103.14035868384;18376.35682751104;18842.81157188428;18997.050147492606;19085.618287634275;19125.426237212872;4115.341545352744;5386.649867758602;5629.6340737852115;5632.549396048306;5635.3237611486675;4200.348945913388;4248.107897341562;5973.940260597382;6149.631022138664;6198.659073750942;6047.546434017467;6242.4693901018245;6274.403931626488;6290.748370065215;6292.5595208335435;6204.348543402945;6260.624362538262;6267.968660156693;6271.090691849657;6273.529485288599;4907.386576677915;5145.279660847447;5178.97410512945;5249.9237656280375;5545.334559852843;12819.294938778363;12996.350182490838;13020.153690010215;19338.613227735368;22652.320430387113;2260.6043942310193;2265.161890100657;2376.572217000939;2438.2685194441774;2611.1774790940794;9525;9572.95213523935;9952.402855828674;11790.35153066581;14022;1805.3049575913237;1832.6334733053443;1833.9174737136861;1864.077281745531;1888.5373083594607;78442.60778696126;86106.13893861044;86999.56500217458;87538;88937.9977900996;10508.264421490423;10815.891841081646;10879.891201088047;10946.233763636468;11649;14262.072965257224;14335.856641433453;14383;15258.694826103638;15291.464798731991;5882.23530940975;6054;6455.805675949964;7264.200937896827;7343.559386436831;6461.935380646133;6746.257911629717;6764.864702705919;6786.830329241809;7301.59841208728;4423.911521769611;4499.52754960731;4500.347449619787;4522.23122069249;4607.723536587815;1822.772153480815;1906.7425897503938;1931.2661188748466;1939.4666466721765;1945.367755479475;795.3557618329056;820.2044017303207;866.5320726807454;977.6040703515088;982.1553464020936;18984.335548255745;19226.230950762092;19227.423177304703;19317;19864.404067877986;927.5918595817818;935.317218430536;942.8161508505913;960.86547883295;999.480270259461;10382.636607718694;10961;10972.835407468894;10987.505562249558;11094.1124710023;411520;415193;425350;426659;428281;88991.55504222437;93622;93775.53112234395;95079;95334.5233273843;921.6635927886407;966.6568368229318;982.6904525074722;997.4464172384252;1004.7990401919645;12310.630681079581;16713.91643041777;16999.7450038252;17730.468085957444;18111.63776724432;41810.58189418067;42514.78742606267;43460;43595.78202108969;43628.56371436245;51779.741101294254;52998.73500632472;55275.723621383244;59750.53118360205;59890.70054649699;11253.930876566714;12295.139340246096;12459.875401245872;12819;12914.612561623166;13684.726305474034;14162.221077840406;14222.359993800097;14273.072250303698;14416.639584010483;11960.10299227544;12055.397230138282;12363.69090772738;12431.129820912449;12694.301813400352;12435.502579896704;12592.685182870502;12720;12931.418086185957;13111.409986550438;12594.181378210753;12870.16343937641;12893.871061289266;12909;12954.28751418681;12607.684807879876;12647.304398258184;12677.683057923257;12987.675308117372;13031.869681303446;12562.93718531438;12622.684432889251;12670.556530521388;12721.618351449471;12723.172993755376 13:44:58 INFO - PROCESS | 3388 | |3;mootools.html;1396.3158052554247;1451.4049239811677;1559.812822461305;1724.5257554172592;1745.5025317784425;7632.580208088553;7858.724944626939;8286.792830179242;8907.331950103751;8940.329475289347;8573;8901.19889209971;8922.197002269795;9167.816643667122;9189.218916392114;2281.999999999996;2316.224064938248;2320.280712978982;2332.5801355755957;2341.496578235679;1926.422073377988;1982.5142840004219;2287.0508738873345;2296.5062511560013;2348.835581509295;2172.73927128744;2239.462528993038;2245.708057952464;2248.763879792623;2261.683364328995;2226.7105276314055;2227.732672079345;2234.0616940884865;2245.7305123385136;2248.8313376496662;2206.360155554887;2207.878566678832;2225.499262665903;2225.977740222593;2226.855254408458;8437.282830959375;8546.40175187737;8595.484270943763;8691.521966291852;8697.47815131088;5096.311997880312;5197.974010129963;5225.033368826779;5226.3989641191365;5228.2680424740565;3135.278885856243;3332.6000879894327;3379;3389.118829104426;3393.79637221765;1069.7272195590074;1099.7305660113243;1113.7104352868312;1123.427052203374;1125.1673761416575;12700.936495317557;12922.41849116792;12922.806157907638;12955.157914735511;12965.286909219989;4321.567843215653;4519.84180553679;4648.744319062416;4658.3711198988385;4678.0410015946645;10753.89246107529;10767.892321076846;10796.838047429295;10798.838017429745;10802.135829133651;5177.119889618773;5217.817376391884;5223.947760522422;5226.895462090737;5245.0296695110765;4657.278121891112;4759.928601070987;4796.424429068534;4796.784144713496;4797.280407938837;3702.7037836972977;3787.981060094682;3808.428735689669;3829.272438236726;3834.8082595870096;1087.027110735887;1134.211722852626;1157.3576664950865;1160.3096157786104;1182.1783860217067;755.7657126290867;759.2293821770907;836.6820608168857;896.3322324867885;922.6632279218037;5713.485786279255;5806.361300256968;5933.762649494059;5936.7328470218945;6117.480014198843;819.4632515702225;839.4879123734516;856.6573370651664;910.0990019880271;933.8926023507248;3921.254961557295;3990.501187351581;4026.375911733686;4033.91932161361;4105.712600118023;10991.670249892515;11324.433778311217;11332.150088743378;11361.829572556418;11442.885571144348;11263.43682815856;11267.661970140909;11271.323720576791;11278.830817537744;11293;7944.880826787603;8304.875426868603;8328.541930193776;8482.642777155625;8496.787580310542;5821.505172060253;5960.910586341121;6049.274087109575;6193.566450348612;6273.372662733873;10334.689959301233;10593.682189534326;10664.733381665521;10693.358398496115;10702.036816686224;10528.210384221367;10551.568262024566;10575.947120264349;10652.467376630982;10677.199210059433;7977.920220797718;8064.798380040546;8093.109757926505;8096;8098.028236611409;8329.167083291622;8334.166583341617;8338.416310858182;8374.623141958748;8376.120507346885;7785.416093793101;7843.098043725045;7875.606219688878;7892.921070789219;8109;7541.476627696282;7748.728794492391;7788.92211077882;7817.804554886174;8022.799430014296;6658.533902626769;6771.62756048422;6776.559523631146;6778.3221677831825;6784.118064651564;5000.749962501787;5049.899002020013;5113.897722045613;5187.818426355059;5351.063563876384;4826.8793280168275;4960.751962401938;4975.527324904128;5163.27714120031;5318.042752304622 13:44:58 INFO - PROCESS | 3388 | |4;prototype.html;318.6781350835657;325.8843110695703;330.7056719519629;332.31377206069465;333.4997503744384;5173.9482605173935;5304.708241046741;5354.491323324288;5385.630322658033;5394.838154855361;5121.436641969381;5218.739063046852;5227;5244.213367994793;5283.577313814895;4111.814968326417;4137.1725654869;4138.13099249158;4145.984233862708;4184.393262976867;4019.859304924328;4127.8968025799295;4135.250058710953;4140.772257525835;4185.372194170884;4067.9796601016956;4069.3895915612597;4085.6527195188446;4099.048684946833;4129.112240868213;4070.715049946505;4081.551029386765;4083.673306135502;4086.7752273624938;4114.938275925863;3601.117726157082;3601.477785721082;3607.3867442534834;3607.7654952428006;3610.9097272568133;4963.478834722338;5108.591312694975;5128.2564028216075;5142.254373115915;5171.948280517222;4636.79134438951;4663.347131401572;4664.367471385022;4680.368150299734;4681.227597446417;5472.1394725793425;5488.81990372068;5508.256385387961;5520.641158324736;5550.973069982067;3725.701943844486;3901.317269477858;3939.6408239157445;3949.5063117110362;3950.881473555798;5676.070136153687;5698.601097923147;5709.600327977043;5717.714114294268;5733.82798516041;3978.6419222270133;3984.880453586397;3999.7800120993625;4021.2962731521866;4030.8589199378466;3922.764634121962;4015.437838702584;4030.2141082488633;4062;4087.5094988600963;4597.724136551751;4621.237495813153;4627.796772839019;4630.083047680007;4639.396878405786;5503.394626591072;5526.778928842882;5532.280803495601;5537.224788529609;5563.860903477364;1285.717142228708;1330.6872884872048;1357.6402253402857;1373.2996171952177;1389.3261768042491;863.4344504349662;879;880.8810810540623;886.9600867960958;888.4363520204487;4675.568704273826;4697.530246975275;4700.294955756595;4709.317149013374;4717.457492388351;4890.486498917634;4910.975445122823;4914.304564925095;4915.3855768029;4936.531029552187;4650.372199753057;4682.976585117052;4688.97655511727;4691.46048204454;4712.43450785901;2783.860806959644;3003.504421770427;3004.459197344499;3019.3659331540184;3020.9546856797165;5743.827685169452;5798.159266906275;5809.808989157213;5815.924054050014;5842.503387212049;5464.617476776667;5680.289963754531;5692.9146062809095;5775.711214439261;5799.39106393831;5806.738696758656;5822.941770582324;5832.50423713989;5844.620099693591;5867.677277749594;5701.40135285789;5701.572382071278;5701.800436984686;5707.828765137053;5715.199872018004;5395.649282796606;5591.700896471101;5632.802851900164;5639.546797143092;5650.389638952879;5859.765609375577;5886.352501224947;5890.204822348928;5898.9115163273445;5942.702864856654;3908.3160446922243;4010.2981978153125;4013.5918448930406;4013.7993100344283;4023.2556976959354;5428.402875683751;5704.942950570441;5708.257926469532;5724.141378793214;5763.6541807491685;5347.385050719217;5438.347398312228;5580.1629755537;5585;5593.244911936837;5446.346438427414;5495;5499;5568.136938774496;5583.469570390806;5328.6571444272795;5465.207544906046;5472.425395333592;5506.017833579988;5510.1459273812625;5473.452654734654;5519.172124181405;5519.923614895057;5520.233525271875;5523.337199536081;5428.502888671255;5463.235147079492;5463.262459567907;5464.316960379952;5518.889622207614 13:44:58 INFO - PROCESS | 3388 | |5;yui.html;711.797137815722;730.605473044556;732.5385007445309;741.4624397311949;784.9215078492151;14446.349914253857;15091.698166036673;15318.617034574114;15344.156071416068;15370.923145384271;15203.467878624251;15358.462453814118;15382.769258461132;15390.461333853318;15403.614909627266;649.6686689788219;664.6942406492994;773.0414286284994;782.034187778095;794.9801254968643;782.2490409207168;791.7070683846985;792.5720111139977;793.0008189681015;793.2028311546887;845.9280961118312;848.995755021224;849.3799526345771;850.0012485329744;850.0734199722301;684.8630273945206;700.8983697363905;823.4236034775621;843.5065486690294;845.9365547583925;610.0270069239556;614.9508039356886;615.0528186592686;615.129591627846;615.6613862375675;15639.765403518957;15675.764863527056;15694;15802.525924222291;15821.208939553091;15219.315130819139;15427;15814.920925395414;15823.683526329523;15827.762583561256;11848.585299514476;11934.343611101385;11976.70058248542;12040;12235.32705701195;3743.7753734776;3776.4146557283666;3843.5964223756664;3853.84584616615;3859.459675645412;65711.01433478549;80718.19281807165;80980;81675.5916220421;83005.58497207536;11595.76808463826;11998.640040798615;12053.216540924812;12055.397230138458;12351.93824030874;22285.888570557043;22374.776252237596;22385.888070559544;22389.664155037688;22484.437889052577;8777.51723655205;8823.382363234641;8838.690645827493;8867.911320886838;9112.726618201465;4352.755153793404;4472.888177795516;4613.746243956614;4696.694714843524;4825.321946319756;3601.5858176309534;3732.42147467143;3749.1564398010773;3752;3763.2097259575794;635.9109724638554;647.1748520636132;651.2803352295645;656.9605823650596;670.963097029668;546.9097598896217;589.5872888977733;604.3020311540179;604.7127614383132;657.6613044282199;9574.138327550554;9577.523786727272;9788.119069283799;9925.900740992642;10007.249456290807;698.8043347862607;698.8637215742983;720.8089856188114;722.458156382713;725.7278520554792;4669.95330046702;4773.618110551148;4777.235642297285;4823.517648235219;4860.125177468019;91715;93688;95822;117650;120979;74180;86239;86375;86720;86799.13200868036;67897;75949.6202518995;78920;79608;79959.60020199978;9183.77040573991;9652.9034709652;9695.806083878142;9725.513724313614;9740.75648108803;36663.87459614707;46090.769546152056;46747;47393.52606473891;49677.26129585447;48696.513034870615;62163.37836621576;63155;72606;75821;12951.546695865976;12996.037671982685;13017.479300827861;13246;13709.451621935012;14461.638459038608;14613.488527901472;14658.780118298448;14702.411903524167;14960.700785984001;13495.662608434868;13943.442262309394;14034.458540667729;14209.786853197416;14274.571762847132;13533.72932541324;13617.31913404306;13674;13889.583312500641;14452.710945781237;13390.924436500767;13397.933010334886;13752.793708094187;14341.92829035848;14551.708965820413;11238.325700458;11298.378589177673;11391.259568128045;11409.828852567052;11416.94291528537;11561.942190289332;11706.648800535997;11730.472128754056;12025.879741202476;12149.088818338836 13:44:58 INFO - PROCESS | 3388 | __end_tp_report 13:44:58 INFO - PROCESS | 3388 | __start_cc_report 13:44:58 INFO - PROCESS | 3388 | _x_x_mozilla_cycle_collect,2449 13:44:58 INFO - PROCESS | 3388 | __end_cc_report 13:44:58 INFO - PROCESS | 3388 | __startTimestamp1476996298604__endTimestamp 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | ------- Summary: start ------- 13:44:58 INFO - PROCESS | 3388 | Number of tests: 6 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | [#0] dojo.html Cycles:165 Average:5375.41 Median:5535.72 stddev:602.46 (10.9%) stddev-sans-first:577.31 13:44:58 INFO - PROCESS | 3388 | Values: 3101.9 3118.6 3148.0 3153.4 3162.3 5237.3 5349.0 5379.0 5473.4 5488.3 5380.7 5392.4 5397.2 5399.5 5401.3 4884.1 4905.5 4918.9 4947.8 4959.6 4986.8 5051.2 5052.4 5059.7 5063.2 4921.1 4952.8 4997.3 5003.5 5053.6 5014.9 5052.5 5055.7 5055.7 5110.4 4834.8 4864.3 4882.9 4902.6 4905.6 5366.9 5375.3 5392.2 5410.6 5480.3 5734.8 5771.7 5773.2 5777.2 5779.0 5600.3 5670.9 5672.8 5823.0 5830.4 5330.5 5333.0 5334.8 5343.8 5466.7 5993.9 5997.6 6044.9 6060.2 6083.5 5605.9 5675.1 5722.2 5723.9 5724.3 5518.6 5594.0 5737.1 5748.8 5755.8 5663.6 5697.9 5704.2 5780.0 5797.9 5706.2 5715.7 5725.2 5727.8 5805.5 4353.7 4355.9 4373.3 4399.5 4440.0 3931.1 3951.1 3970.6 3973.8 4003.7 5469.0 5501.6 5512.0 5571.1 5579.5 5872.6 5877.3 5889.1 5889.7 5894.4 5343.1 5390.0 5500.8 5502.6 5508.5 5008.3 5054.8 5058.3 5062.2 5120.8 5960.9 6009.0 6022.9 6023.1 6025.4 5724.3 5846.3 5848.8 5850.3 5856.3 5930.6 5950.1 5987.4 5989.6 6016.2 5663.3 5779.1 5785.5 5790.2 5795.2 5808.8 5825.7 5829.2 5829.8 5830.2 5599.7 5692.0 5701.4 5706.9 5708.7 5449.8 5489.8 5496.8 5544.4 5544.8 5535.7 5544.6 5554.0 5554.9 5558.6 5549.3 5581.2 5582.9 5599.4 5599.9 5475.9 5480.9 5484.0 5485.8 5488.6 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | [#1] ext.html Cycles:180 Average:60512.34 Median:39378.16 stddev:123079.68 (312.6%) stddev-sans-first:123342.77 13:44:58 INFO - PROCESS | 3388 | Values: 609.6 615.2 622.5 647.6 648.6 31600.4 33681.7 33710.7 41134.2 42931.1 43293.8 43869.6 43893.3 44055.8 44158.0 8781.2 8906.2 8920.8 8939.4 8940.9 7911.0 8095.4 8098.0 8259.3 8715.0 10330.3 10700.2 10715.5 11035.8 11044.2 10501.0 10505.7 10509.8 10563.2 10591.5 10399.9 10466.8 10578.8 10579.5 10584.1 41664.0 41816.2 41985.8 41998.4 42015.0 2830.6 3023.6 3055.9 3277.2 3358.8 30974.0 30980.4 30989.8 31019.7 31420.8 4225.9 4232.5 4261.2 4289.2 4321.7 309774.0 312329.0 312655.4 313091.0 314801.0 58041.0 58461.0 58641.4 58659.0 58748.4 34781.8 55945.7 55993.0 56050.0 56117.0 14979.6 15410.2 15416.7 15498.8 15595.9 12035.8 12113.6 12123.2 12124.0 12125.6 14713.6 16732.4 17086.3 17499.6 17997.6 6939.0 7136.9 7144.3 7240.0 7300.0 903.8 995.6 1031.1 1067.4 1113.8 30940.5 30958.4 31036.1 31116.8 31658.8 1061.4 1062.6 1089.5 1100.2 1113.0 15764.2 16364.6 16473.9 16503.6 16697.9 495040.0 497341.0 498867.0 499135.0 499944.0 34577.8 48473.3 49450.8 54729.5 56576.2 1286.1 1290.9 1304.6 1352.2 1352.8 30042.2 31781.2 32096.4 32310.8 34746.1 54567.5 55248.4 55280.7 55333.7 55336.4 454325.0 474143.0 475143.0 639378.0 645521.0 41373.6 41407.4 41793.6 42144.8 42642.4 43800.0 44466.8 46988.8 47125.5 47570.8 38559.6 39847.4 40600.2 40865.6 41989.8 38885.6 39482.2 39952.8 40249.8 41702.6 39274.1 40489.4 40567.8 40762.8 40769.4 33012.2 35860.5 36198.8 36617.8 36753.4 26265.6 26553.6 26582.2 26764.7 27084.5 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | [#2] jquery.html Cycles:180 Average:27227.63 Median:2407.42 stddev:70034.68 (2909.1%) stddev-sans-first:70202.10 13:44:58 INFO - PROCESS | 3388 | Values: 363.4 369.9 377.4 387.5 399.6 14199.7 14632.0 18895.0 19067.0 19103.1 18376.4 18842.8 18997.1 19085.6 19125.4 4115.3 5386.6 5629.6 5632.5 5635.3 4200.3 4248.1 5973.9 6149.6 6198.7 6047.5 6242.5 6274.4 6290.7 6292.6 6204.3 6260.6 6268.0 6271.1 6273.5 4907.4 5145.3 5179.0 5249.9 5545.3 12819.3 12996.4 13020.2 19338.6 22652.3 2260.6 2265.2 2376.6 2438.3 2611.2 9525.0 9573.0 9952.4 11790.4 14022.0 1805.3 1832.6 1833.9 1864.1 1888.5 78442.6 86106.1 86999.6 87538.0 88938.0 10508.3 10815.9 10879.9 10946.2 11649.0 14262.1 14335.9 14383.0 15258.7 15291.5 5882.2 6054.0 6455.8 7264.2 7343.6 6461.9 6746.3 6764.9 6786.8 7301.6 4423.9 4499.5 4500.3 4522.2 4607.7 1822.8 1906.7 1931.3 1939.5 1945.4 795.4 820.2 866.5 977.6 982.2 18984.3 19226.2 19227.4 19317.0 19864.4 927.6 935.3 942.8 960.9 999.5 10382.6 10961.0 10972.8 10987.5 11094.1 411520.0 415193.0 425350.0 426659.0 428281.0 88991.6 93622.0 93775.5 95079.0 95334.5 921.7 966.7 982.7 997.4 1004.8 12310.6 16713.9 16999.7 17730.5 18111.6 41810.6 42514.8 43460.0 43595.8 43628.6 51779.7 52998.7 55275.7 59750.5 59890.7 11253.9 12295.1 12459.9 12819.0 12914.6 13684.7 14162.2 14222.4 14273.1 14416.6 11960.1 12055.4 12363.7 12431.1 12694.3 12435.5 12592.7 12720.0 12931.4 13111.4 12594.2 12870.2 12893.9 12909.0 12954.3 12607.7 12647.3 12677.7 12987.7 13031.9 12562.9 12622.7 12670.6 12721.6 12723.2 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | [#3] mootools.html Cycles:180 Average:5839.07 Median:4718.98 stddev:3445.53 (73.0%) stddev-sans-first:3439.02 13:44:58 INFO - PROCESS | 3388 | Values: 1396.3 1451.4 1559.8 1724.5 1745.5 7632.6 7858.7 8286.8 8907.3 8940.3 8573.0 8901.2 8922.2 9167.8 9189.2 2282.0 2316.2 2320.3 2332.6 2341.5 1926.4 1982.5 2287.1 2296.5 2348.8 2172.7 2239.5 2245.7 2248.8 2261.7 2226.7 2227.7 2234.1 2245.7 2248.8 2206.4 2207.9 2225.5 2226.0 2226.9 8437.3 8546.4 8595.5 8691.5 8697.5 5096.3 5198.0 5225.0 5226.4 5228.3 3135.3 3332.6 3379.0 3389.1 3393.8 1069.7 1099.7 1113.7 1123.4 1125.2 12700.9 12922.4 12922.8 12955.2 12965.3 4321.6 4519.8 4648.7 4658.4 4678.0 10753.9 10767.9 10796.8 10798.8 10802.1 5177.1 5217.8 5223.9 5226.9 5245.0 4657.3 4759.9 4796.4 4796.8 4797.3 3702.7 3788.0 3808.4 3829.3 3834.8 1087.0 1134.2 1157.4 1160.3 1182.2 755.8 759.2 836.7 896.3 922.7 5713.5 5806.4 5933.8 5936.7 6117.5 819.5 839.5 856.7 910.1 933.9 3921.3 3990.5 4026.4 4033.9 4105.7 10991.7 11324.4 11332.2 11361.8 11442.9 11263.4 11267.7 11271.3 11278.8 11293.0 7944.9 8304.9 8328.5 8482.6 8496.8 5821.5 5960.9 6049.3 6193.6 6273.4 10334.7 10593.7 10664.7 10693.4 10702.0 10528.2 10551.6 10575.9 10652.5 10677.2 7977.9 8064.8 8093.1 8096.0 8098.0 8329.2 8334.2 8338.4 8374.6 8376.1 7785.4 7843.1 7875.6 7892.9 8109.0 7541.5 7748.7 7788.9 7817.8 8022.8 6658.5 6771.6 6776.6 6778.3 6784.1 5000.7 5049.9 5113.9 5187.8 5351.1 4826.9 4960.8 4975.5 5163.3 5318.0 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | [#4] prototype.html Cycles:180 Average:4585.99 Median:5172.95 stddev:1360.49 (26.3%) stddev-sans-first:1326.07 13:44:58 INFO - PROCESS | 3388 | Values: 318.7 325.9 330.7 332.3 333.5 5173.9 5304.7 5354.5 5385.6 5394.8 5121.4 5218.7 5227.0 5244.2 5283.6 4111.8 4137.2 4138.1 4146.0 4184.4 4019.9 4127.9 4135.3 4140.8 4185.4 4068.0 4069.4 4085.7 4099.0 4129.1 4070.7 4081.6 4083.7 4086.8 4114.9 3601.1 3601.5 3607.4 3607.8 3610.9 4963.5 5108.6 5128.3 5142.3 5171.9 4636.8 4663.3 4664.4 4680.4 4681.2 5472.1 5488.8 5508.3 5520.6 5551.0 3725.7 3901.3 3939.6 3949.5 3950.9 5676.1 5698.6 5709.6 5717.7 5733.8 3978.6 3984.9 3999.8 4021.3 4030.9 3922.8 4015.4 4030.2 4062.0 4087.5 4597.7 4621.2 4627.8 4630.1 4639.4 5503.4 5526.8 5532.3 5537.2 5563.9 1285.7 1330.7 1357.6 1373.3 1389.3 863.4 879.0 880.9 887.0 888.4 4675.6 4697.5 4700.3 4709.3 4717.5 4890.5 4911.0 4914.3 4915.4 4936.5 4650.4 4683.0 4689.0 4691.5 4712.4 2783.9 3003.5 3004.5 3019.4 3021.0 5743.8 5798.2 5809.8 5815.9 5842.5 5464.6 5680.3 5692.9 5775.7 5799.4 5806.7 5822.9 5832.5 5844.6 5867.7 5701.4 5701.6 5701.8 5707.8 5715.2 5395.6 5591.7 5632.8 5639.5 5650.4 5859.8 5886.4 5890.2 5898.9 5942.7 3908.3 4010.3 4013.6 4013.8 4023.3 5428.4 5704.9 5708.3 5724.1 5763.7 5347.4 5438.3 5580.2 5585.0 5593.2 5446.3 5495.0 5499.0 5568.1 5583.5 5328.7 5465.2 5472.4 5506.0 5510.1 5473.5 5519.2 5519.9 5520.2 5523.3 5428.5 5463.2 5463.3 5464.3 5518.9 13:44:58 INFO - PROCESS | 3388 | 13:44:58 INFO - PROCESS | 3388 | [#5] yui.html Cycles:180 Average:19592.65 Median:26045.11 stddev:26922.93 (103.4%) stddev-sans-first:26961.13 13:44:58 INFO - PROCESS | 3388 | Values: 711.8 730.6 732.5 741.5 784.9 14446.3 15091.7 15318.6 15344.2 15370.9 15203.5 15358.5 15382.8 15390.5 15403.6 649.7 664.7 773.0 782.0 795.0 782.2 791.7 792.6 793.0 793.2 845.9 849.0 849.4 850.0 850.1 684.9 700.9 823.4 843.5 845.9 610.0 615.0 615.1 615.1 615.7 15639.8 15675.8 15694.0 15802.5 15821.2 15219.3 15427.0 15814.9 15823.7 15827.8 11848.6 11934.3 11976.7 12040.0 12235.3 3743.8 3776.4 3843.6 3853.8 3859.5 65711.0 80718.2 80980.0 81675.6 83005.6 11595.8 11998.6 12053.2 12055.4 12351.9 22285.9 22374.8 22385.9 22389.7 22484.4 8777.5 8823.4 8838.7 8867.9 9112.7 4352.8 4472.9 4613.7 4696.7 4825.3 3601.6 3732.4 3749.2 3752.0 3763.2 635.9 647.2 651.3 657.0 671.0 546.9 589.6 604.3 604.7 657.7 9574.1 9577.5 9788.1 9925.9 10007.2 698.8 698.9 720.8 722.5 725.7 4670.0 4773.6 4777.2 4823.5 4860.1 91715.0 93688.0 95822.0 117650.0 120979.0 74180.0 86239.0 86375.0 86720.0 86799.1 67897.0 75949.6 78920.0 79608.0 79959.6 9183.8 9652.9 9695.8 9725.5 9740.8 36663.9 46090.8 46747.0 47393.5 49677.3 48696.5 62163.4 63155.0 72606.0 75821.0 12951.5 12996.0 13017.5 13246.0 13709.5 14461.6 14613.5 14658.8 14702.4 14960.7 13495.7 13943.4 14034.5 14209.8 14274.6 13533.7 13617.3 13674.0 13889.6 14452.7 13390.9 13397.9 13752.8 14341.9 14551.7 11238.3 11298.4 11391.3 11409.8 11416.9 11561.9 11706.6 11730.5 12025.9 12149.1 13:44:58 INFO - PROCESS | 3388 | -------- Summary: end -------- 13:44:58 INFO - PROCESS | 3388 | 13:44:59 INFO - TEST-INFO | 3388: exit 0 13:44:59 INFO - TEST-OK | dromaeo_css | took 1120515ms 13:44:59 INFO - TEST-START | kraken 13:44:59 INFO - operating with platform_type : linux_ 13:44:59 INFO - Initialising browser for kraken test... 13:44:59 INFO - TEST-INFO | started process 3692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMayQix/profile http://localhost:38929/getInfo.html) 13:45:03 INFO - PROCESS | 3692 | __metrics Screen width/height:1600/1200 13:45:03 INFO - PROCESS | 3692 | colorDepth:24 13:45:03 INFO - PROCESS | 3692 | Browser inner width/height: 1024/697 13:45:03 INFO - PROCESS | 3692 | __metrics 13:45:04 INFO - PROCESS | 3692 | 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" 13:45:04 INFO - PROCESS | 3692 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:45:04 INFO - PROCESS | 3692 | console.error: PushService: 13:45:04 INFO - PROCESS | 3692 | stateChangeProcessEnqueue: Error transitioning state 13:45:04 INFO - PROCESS | 3692 | UnknownError 13:45:05 INFO - TEST-INFO | 3692: exit 0 13:45:05 INFO - Browser initialized. 13:45:05 INFO - Running cycle 1/1 for kraken test... 13:45:05 INFO - TEST-INFO | started process 3776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMayQix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:17 INFO - PROCESS | 3776 | RSS: Main: 171835392 13:45:17 INFO - PROCESS | 3776 | 13:45:19 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38929/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:20 INFO - PROCESS | 3776 | RSS: Main: 228851712 13:45:20 INFO - PROCESS | 3776 | 13:45:23 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38929/tests/kraken/driver.html?testName=audio-dft) 13:45:24 INFO - PROCESS | 3776 | RSS: Main: 216027136 13:45:24 INFO - PROCESS | 3776 | 13:45:27 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38929/tests/kraken/driver.html?testName=audio-fft) 13:45:27 INFO - PROCESS | 3776 | RSS: Main: 297201664 13:45:27 INFO - PROCESS | 3776 | 13:45:29 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38929/tests/kraken/driver.html?testName=audio-oscillator) 13:45:30 INFO - PROCESS | 3776 | RSS: Main: 206516224 13:45:30 INFO - PROCESS | 3776 | 13:45:32 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:33 INFO - PROCESS | 3776 | RSS: Main: 210997248 13:45:33 INFO - PROCESS | 3776 | 13:45:36 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38929/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:36 INFO - PROCESS | 3776 | RSS: Main: 247492608 13:45:36 INFO - PROCESS | 3776 | 13:45:40 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38929/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:40 INFO - PROCESS | 3776 | RSS: Main: 246829056 13:45:40 INFO - PROCESS | 3776 | 13:45:43 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38929/tests/kraken/driver.html?testName=json-parse-financial) 13:45:44 INFO - PROCESS | 3776 | RSS: Main: 246202368 13:45:44 INFO - PROCESS | 3776 | 13:45:45 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:46 INFO - PROCESS | 3776 | RSS: Main: 209047552 13:45:46 INFO - PROCESS | 3776 | 13:45:47 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:45:48 INFO - PROCESS | 3776 | RSS: Main: 216166400 13:45:48 INFO - PROCESS | 3776 | 13:45:51 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:45:52 INFO - PROCESS | 3776 | RSS: Main: 225230848 13:45:52 INFO - PROCESS | 3776 | 13:45:54 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:45:55 INFO - PROCESS | 3776 | RSS: Main: 234946560 13:45:55 INFO - PROCESS | 3776 | 13:45:58 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:45:58 INFO - PROCESS | 3776 | RSS: Main: 230719488 13:45:58 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:38929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38929/tests/kraken/driver.html?testName=ai-astar) 13:46:00 INFO - PROCESS | 3776 | RSS: Main: 282828800 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | __start_tp_report 13:46:00 INFO - PROCESS | 3776 | _x_x_mozilla_page_load 13:46:00 INFO - PROCESS | 3776 | _x_x_mozilla_page_load_details 13:46:00 INFO - PROCESS | 3776 | |i|pagename|runs| 13:46:00 INFO - PROCESS | 3776 | |0;ai-astar;104;113;112;111;113;112;112;111;111;111 13:46:00 INFO - PROCESS | 3776 | |1;audio-beat-detection;146;123;126;165;129;125;122;122;168;124 13:46:00 INFO - PROCESS | 3776 | |2;audio-dft;159;160;160;159;161;161;161;160;160;162 13:46:00 INFO - PROCESS | 3776 | |3;audio-fft;75;75;76;112;78;76;75;78;99;75 13:46:00 INFO - PROCESS | 3776 | |4;audio-oscillator;84;82;109;83;84;83;104;84;83;106 13:46:00 INFO - PROCESS | 3776 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;116;116 13:46:00 INFO - PROCESS | 3776 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;148;146 13:46:00 INFO - PROCESS | 3776 | |7;imaging-desaturate;85;85;85;85;85;84;85;85;85;85 13:46:00 INFO - PROCESS | 3776 | |8;json-parse-financial;57;54;54;53;54;55;55;54;55;54 13:46:00 INFO - PROCESS | 3776 | |9;json-stringify-tinderbox;58;59;58;59;59;58;59;58;59;59 13:46:00 INFO - PROCESS | 3776 | |10;stanford-crypto-aes;80;80;80;80;89;80;81;79;79;80 13:46:00 INFO - PROCESS | 3776 | |11;stanford-crypto-ccm;143;133;135;143;139;129;131;136;173;135 13:46:00 INFO - PROCESS | 3776 | |12;stanford-crypto-pbkdf2;171;169;171;168;172;172;171;169;167;166 13:46:00 INFO - PROCESS | 3776 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;65;66;67;71;65 13:46:00 INFO - PROCESS | 3776 | __end_tp_report 13:46:00 INFO - PROCESS | 3776 | __start_cc_report 13:46:00 INFO - PROCESS | 3776 | _x_x_mozilla_cycle_collect,1708 13:46:00 INFO - PROCESS | 3776 | __end_cc_report 13:46:00 INFO - PROCESS | 3776 | __startTimestamp1476996360778__endTimestamp 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | ------- Summary: start ------- 13:46:00 INFO - PROCESS | 3776 | Number of tests: 14 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 13:46:00 INFO - PROCESS | 3776 | Values: 104.0 113.0 112.0 111.0 113.0 112.0 112.0 111.0 111.0 111.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:127.50 stddev:18.04 (14.2%) stddev-sans-first:18.69 13:46:00 INFO - PROCESS | 3776 | Values: 146.0 123.0 126.0 165.0 129.0 125.0 122.0 122.0 168.0 124.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 13:46:00 INFO - PROCESS | 3776 | Values: 159.0 160.0 160.0 159.0 161.0 161.0 161.0 160.0 160.0 162.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.86 (16.9%) stddev-sans-first:13.40 13:46:00 INFO - PROCESS | 3776 | Values: 75.0 75.0 76.0 112.0 78.0 76.0 75.0 78.0 99.0 75.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.00 stddev:11.21 (13.5%) stddev-sans-first:11.67 13:46:00 INFO - PROCESS | 3776 | Values: 84.0 82.0 109.0 83.0 84.0 83.0 104.0 84.0 83.0 106.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:46:00 INFO - PROCESS | 3776 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:46:00 INFO - PROCESS | 3776 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 148.0 146.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 13:46:00 INFO - PROCESS | 3776 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.08 (2.0%) stddev-sans-first:0.67 13:46:00 INFO - PROCESS | 3776 | Values: 57.0 54.0 54.0 53.0 54.0 55.0 55.0 54.0 55.0 54.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 13:46:00 INFO - PROCESS | 3776 | Values: 58.0 59.0 58.0 59.0 59.0 58.0 59.0 58.0 59.0 59.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.94 (3.7%) stddev-sans-first:3.10 13:46:00 INFO - PROCESS | 3776 | Values: 80.0 80.0 80.0 80.0 89.0 80.0 81.0 79.0 79.0 80.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:137.50 stddev:12.58 (9.1%) stddev-sans-first:13.29 13:46:00 INFO - PROCESS | 3776 | Values: 143.0 133.0 135.0 143.0 139.0 129.0 131.0 136.0 173.0 135.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:171.00 stddev:2.12 (1.2%) stddev-sans-first:2.19 13:46:00 INFO - PROCESS | 3776 | Values: 171.0 169.0 171.0 168.0 172.0 172.0 171.0 169.0 167.0 166.0 13:46:00 INFO - PROCESS | 3776 | 13:46:00 INFO - PROCESS | 3776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.71 (2.6%) stddev-sans-first:1.81 13:46:00 INFO - PROCESS | 3776 | Values: 67.0 66.0 67.0 66.0 66.0 65.0 66.0 67.0 71.0 65.0 13:46:00 INFO - PROCESS | 3776 | -------- Summary: end -------- 13:46:00 INFO - PROCESS | 3776 | 13:46:01 INFO - TEST-INFO | 3776: exit 0 13:46:01 INFO - TEST-OK | kraken | took 62409ms 13:46:01 INFO - SUITE-END | took 1182s 13:46:02 INFO - Completed test suite (00:19:43) 13:46:02 INFO - javascript benchmark 13:46:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.8914337998167, 3118.64135624403, 3148.024112525117, 3153.3535625196837, 3162.304293055527, 5237.266782650432, 5348.973255133719, 5379.0, 5473.370562385322, 5488.286522752047, 5380.650257733245, 5392.352917649888, 5397.2443857859935, 5399.487048730364, 5401.297831281938, 4884.096442158194, 4905.533974272456, 4918.877028074291, 4947.802087916479, 4959.578435832958, 4986.800527978877, 5051.242313652945, 5052.393712754475, 5059.721715305675, 5063.164577844651, 4921.138800709879, 4952.801887924478, 4997.30037794709, 5003.549680528752, 5053.620978426614, 5014.874628134289, 5052.520010598987, 5055.721935293557, 5055.747212639353, 5110.412302585213, 4834.830780922686, 4864.270359446076, 4882.853514394574, 4902.607791376681, 4905.583025442842, 5366.865828354284, 5375.3012108425655, 5392.218128371364, 5410.56715462766, 5480.26016487773, 5734.770609175628, 5771.740271687784, 5773.191753154561, 5777.248957635523, 5779.0, 5600.299962504687, 5670.886582268332, 5672.829815105553, 5823.0, 5830.3586605473365, 5330.546903513245, 5332.9733351333, 5334.786608535615, 5343.839684809462, 5466.726663666801, 5993.850153746192, 5997.6401415914315, 6044.939550604526, 6060.151578778975, 6083.513318934474, 5605.943940560543, 5675.091985282335, 5722.227499287626, 5723.942760572341, 5724.255846739898, 5518.586106042063, 5594.021046316879, 5737.139429085587, 5748.770049197985, 5755.769769209185, 5663.575231857627, 5697.9430205698245, 5704.172894930211, 5779.971100144472, 5797.884042319214, 5706.201131841545, 5715.742791574389, 5725.227094342294, 5727.828165155052, 5805.535557155417, 4353.717008394444, 4355.912881742411, 4373.343998400202, 4399.450068741407, 4440.023194897118, 3931.1351502669368, 3951.1110000249714, 3970.642642162219, 3973.8013099344917, 4003.679705623543, 5469.042917489503, 5501.642393244426, 5512.0, 5571.052921003439, 5579.4978451938705, 5872.618279811799, 5877.265341832271, 5889.146073819272, 5889.734961926723, 5894.440028197314, 5343.118385466354, 5389.973050134724, 5500.80747173855, 5502.58730595207, 5508.504234618904, 5008.348914641073, 5054.772535235923, 5058.291839142449, 5062.215356619729, 5120.820771273062, 5960.940390596212, 6009.0, 6022.909656355246, 6023.096535519707, 6025.367336429787, 5724.255846739898, 5846.269216347957, 5848.795292164754, 5850.297964244318, 5856.267966504187, 5930.555208359304, 5950.137230101524, 5987.371326010706, 5989.550783691154, 6016.187814645142, 5663.263775709132, 5779.104238842986, 5785.479306862234, 5790.160426738184, 5795.188673585617, 5808.767649293981, 5825.679587622722, 5829.213056237523, 5829.8251052468495, 5830.2129212555765, 5599.748011339418, 5692.0, 5701.372848986525, 5706.885862282814, 5708.743106560298, 5449.836504904859, 5489.835304940858, 5496.7526461310135, 5544.445555444423, 5544.833654990357, 5535.723213839211, 5544.611877168721, 5554.028045092012, 5554.944450555443, 5558.555315574825, 5549.278593782782, 5581.190727344593, 5582.944170558405, 5599.384067752462, 5599.944000560105, 5475.945240547703, 5480.890382192254, 5484.040292948638, 5485.75314110858, 5488.643238189505], "value": 5335.130105000825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.5793902207478, 615.2340336281328, 622.5455417545191, 647.62761412188, 648.6432462145818, 31600.367992640164, 33681.66318336819, 33710.66289337106, 41134.17731645365, 42931.14137717251, 43293.78353108238, 43869.561304387025, 43893.341599875945, 44055.77972110135, 44158.0, 8781.165789250012, 8906.153915378061, 8920.776980575505, 8939.374243802904, 8940.910590894073, 7910.960445197766, 8095.433319667625, 8097.9595102024705, 8259.256666899977, 8715.0, 10330.276880618323, 10700.197485188603, 10715.46422678863, 11035.779284414308, 11044.226904116715, 10501.0, 10505.68482945513, 10509.789804203949, 10563.207759418035, 10591.470426478645, 10399.948000260027, 10466.842997355046, 10578.84131738017, 10579.523921423555, 10584.100351470135, 41664.0, 41816.1636767266, 41985.790071049756, 41998.37002444966, 42015.0, 2830.6461692288462, 3023.591815104977, 3055.917421613193, 3277.1643230975947, 3358.8488518016748, 30974.0, 30980.380392392028, 30989.845050774828, 31019.689803101905, 31420.842895785605, 4225.880141762435, 4232.547307709463, 4261.190373828994, 4289.1850548395705, 4321.719088259253, 309774.0, 312329.0, 312655.4367228172, 313091.0, 314801.0, 58041.0, 58461.0, 58641.41358586445, 58659.0, 58748.41251587515, 34781.82609086989, 55945.720271398386, 55993.0, 56050.0, 56117.0, 14979.625509362353, 15410.229488525752, 15416.691666166838, 15498.845011549965, 15595.922020390053, 12035.819462708067, 12113.636590902288, 12123.181522771654, 12124.0, 12125.575604853788, 14713.55859324222, 16732.41436549715, 17086.316547337967, 17499.56251093733, 17997.640047199246, 6938.965305173442, 7136.892946605805, 7144.285571442814, 7240.0, 7299.963500182465, 903.7514683461969, 995.581855620641, 1031.0874875735028, 1067.386252904583, 1113.777244551093, 30940.535891961637, 30958.380832383227, 31036.068917932498, 31116.844415777778, 31658.841705791325, 1061.368485750977, 1062.585591619269, 1089.487940667885, 1100.1858624617726, 1112.9777404451866, 15764.211789410712, 16364.590885227964, 16473.917630411772, 16503.587410314838, 16697.91651041737, 495040.0, 497341.0, 498867.0, 499135.0, 499944.0, 34577.82711086429, 48473.272900906515, 49450.75274623676, 54729.45270547323, 56576.151357729665, 1286.1382873474795, 1290.9483620655255, 1304.6086174147908, 1352.1819299323963, 1352.8444228913802, 30042.24894377658, 31781.20546986344, 32096.35807283888, 32310.83844580762, 34746.13134671653, 54567.45432545624, 55248.44751552433, 55280.72359638176, 55333.723331384695, 55336.44663553474, 454325.0, 474143.0, 475143.0, 639378.0, 645521.0, 41373.586264138175, 41407.37888931729, 41793.58206417897, 42144.78927605465, 42642.36036459517, 43800.0, 44466.77766611146, 46988.7650561745, 47125.52874471348, 47570.762146189045, 38559.6144038556, 39847.40228896627, 40600.1879962405, 40865.59134408618, 41989.79005104955, 38885.6111438882, 39482.194197107165, 39952.800235998635, 40249.798751006056, 41702.582974171084, 39274.13351186818, 40489.39265911072, 40567.79716101401, 40762.79618601888, 40769.38845917373, 33012.21322908213, 35860.462093069145, 36198.8190059048, 36617.81691091527, 36753.448698269014, 26265.606015910158, 26553.60169597496, 26582.202533924014, 26764.732352676223, 27084.458310833277], "value": 19984.42248488829, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4167161705464, 369.9467952861617, 377.37915652273483, 387.49431991251413, 399.6183644619387, 14199.71600567988, 14632.0, 18895.0, 19067.0, 19103.14035868384, 18376.35682751104, 18842.81157188428, 18997.050147492606, 19085.618287634275, 19125.426237212872, 4115.341545352744, 5386.649867758602, 5629.6340737852115, 5632.549396048306, 5635.3237611486675, 4200.348945913388, 4248.107897341562, 5973.940260597382, 6149.631022138664, 6198.659073750942, 6047.546434017467, 6242.4693901018245, 6274.403931626488, 6290.748370065215, 6292.5595208335435, 6204.348543402945, 6260.624362538262, 6267.968660156693, 6271.090691849657, 6273.529485288599, 4907.386576677915, 5145.279660847447, 5178.97410512945, 5249.9237656280375, 5545.334559852843, 12819.294938778363, 12996.350182490838, 13020.153690010215, 19338.613227735368, 22652.320430387113, 2260.6043942310193, 2265.161890100657, 2376.572217000939, 2438.2685194441774, 2611.1774790940794, 9525.0, 9572.95213523935, 9952.402855828674, 11790.35153066581, 14022.0, 1805.3049575913237, 1832.6334733053443, 1833.9174737136861, 1864.077281745531, 1888.5373083594607, 78442.60778696126, 86106.13893861044, 86999.56500217458, 87538.0, 88937.9977900996, 10508.264421490423, 10815.891841081646, 10879.891201088047, 10946.233763636468, 11649.0, 14262.072965257224, 14335.856641433453, 14383.0, 15258.694826103638, 15291.464798731991, 5882.23530940975, 6054.0, 6455.805675949964, 7264.200937896827, 7343.559386436831, 6461.935380646133, 6746.257911629717, 6764.864702705919, 6786.830329241809, 7301.59841208728, 4423.911521769611, 4499.52754960731, 4500.347449619787, 4522.23122069249, 4607.723536587815, 1822.772153480815, 1906.7425897503938, 1931.2661188748466, 1939.4666466721765, 1945.367755479475, 795.3557618329056, 820.2044017303207, 866.5320726807454, 977.6040703515088, 982.1553464020936, 18984.335548255745, 19226.230950762092, 19227.423177304703, 19317.0, 19864.404067877986, 927.5918595817818, 935.317218430536, 942.8161508505913, 960.86547883295, 999.480270259461, 10382.636607718694, 10961.0, 10972.835407468894, 10987.505562249558, 11094.1124710023, 411520.0, 415193.0, 425350.0, 426659.0, 428281.0, 88991.55504222437, 93622.0, 93775.53112234395, 95079.0, 95334.5233273843, 921.6635927886407, 966.6568368229318, 982.6904525074722, 997.4464172384252, 1004.7990401919645, 12310.630681079581, 16713.91643041777, 16999.7450038252, 17730.468085957444, 18111.63776724432, 41810.58189418067, 42514.78742606267, 43460.0, 43595.78202108969, 43628.56371436245, 51779.741101294254, 52998.73500632472, 55275.723621383244, 59750.53118360205, 59890.70054649699, 11253.930876566714, 12295.139340246096, 12459.875401245872, 12819.0, 12914.612561623166, 13684.726305474034, 14162.221077840406, 14222.359993800097, 14273.072250303698, 14416.639584010483, 11960.10299227544, 12055.397230138282, 12363.69090772738, 12431.129820912449, 12694.301813400352, 12435.502579896704, 12592.685182870502, 12720.0, 12931.418086185957, 13111.409986550438, 12594.181378210753, 12870.16343937641, 12893.871061289266, 12909.0, 12954.28751418681, 12607.684807879876, 12647.304398258184, 12677.683057923257, 12987.675308117372, 13031.869681303446, 12562.93718531438, 12622.684432889251, 12670.556530521388, 12721.618351449471, 12723.172993755376], "value": 9177.639327407005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.3158052554247, 1451.4049239811677, 1559.812822461305, 1724.5257554172592, 1745.5025317784425, 7632.580208088553, 7858.724944626939, 8286.792830179242, 8907.331950103751, 8940.329475289347, 8573.0, 8901.19889209971, 8922.197002269795, 9167.816643667122, 9189.218916392114, 2281.999999999996, 2316.224064938248, 2320.280712978982, 2332.5801355755957, 2341.496578235679, 1926.422073377988, 1982.5142840004219, 2287.0508738873345, 2296.5062511560013, 2348.835581509295, 2172.73927128744, 2239.462528993038, 2245.708057952464, 2248.763879792623, 2261.683364328995, 2226.7105276314055, 2227.732672079345, 2234.0616940884865, 2245.7305123385136, 2248.8313376496662, 2206.360155554887, 2207.878566678832, 2225.499262665903, 2225.977740222593, 2226.855254408458, 8437.282830959375, 8546.40175187737, 8595.484270943763, 8691.521966291852, 8697.47815131088, 5096.311997880312, 5197.974010129963, 5225.033368826779, 5226.3989641191365, 5228.2680424740565, 3135.278885856243, 3332.6000879894327, 3379.0, 3389.118829104426, 3393.79637221765, 1069.7272195590074, 1099.7305660113243, 1113.7104352868312, 1123.427052203374, 1125.1673761416575, 12700.936495317557, 12922.41849116792, 12922.806157907638, 12955.157914735511, 12965.286909219989, 4321.567843215653, 4519.84180553679, 4648.744319062416, 4658.3711198988385, 4678.0410015946645, 10753.89246107529, 10767.892321076846, 10796.838047429295, 10798.838017429745, 10802.135829133651, 5177.119889618773, 5217.817376391884, 5223.947760522422, 5226.895462090737, 5245.0296695110765, 4657.278121891112, 4759.928601070987, 4796.424429068534, 4796.784144713496, 4797.280407938837, 3702.7037836972977, 3787.981060094682, 3808.428735689669, 3829.272438236726, 3834.8082595870096, 1087.027110735887, 1134.211722852626, 1157.3576664950865, 1160.3096157786104, 1182.1783860217067, 755.7657126290867, 759.2293821770907, 836.6820608168857, 896.3322324867885, 922.6632279218037, 5713.485786279255, 5806.361300256968, 5933.762649494059, 5936.7328470218945, 6117.480014198843, 819.4632515702225, 839.4879123734516, 856.6573370651664, 910.0990019880271, 933.8926023507248, 3921.254961557295, 3990.501187351581, 4026.375911733686, 4033.91932161361, 4105.712600118023, 10991.670249892515, 11324.433778311217, 11332.150088743378, 11361.829572556418, 11442.885571144348, 11263.43682815856, 11267.661970140909, 11271.323720576791, 11278.830817537744, 11293.0, 7944.880826787603, 8304.875426868603, 8328.541930193776, 8482.642777155625, 8496.787580310542, 5821.505172060253, 5960.910586341121, 6049.274087109575, 6193.566450348612, 6273.372662733873, 10334.689959301233, 10593.682189534326, 10664.733381665521, 10693.358398496115, 10702.036816686224, 10528.210384221367, 10551.568262024566, 10575.947120264349, 10652.467376630982, 10677.199210059433, 7977.920220797718, 8064.798380040546, 8093.109757926505, 8096.0, 8098.028236611409, 8329.167083291622, 8334.166583341617, 8338.416310858182, 8374.623141958748, 8376.120507346885, 7785.416093793101, 7843.098043725045, 7875.606219688878, 7892.921070789219, 8109.0, 7541.476627696282, 7748.728794492391, 7788.92211077882, 7817.804554886174, 8022.799430014296, 6658.533902626769, 6771.62756048422, 6776.559523631146, 6778.3221677831825, 6784.118064651564, 5000.749962501787, 5049.899002020013, 5113.897722045613, 5187.818426355059, 5351.063563876384, 4826.8793280168275, 4960.751962401938, 4975.527324904128, 5163.27714120031, 5318.042752304622], "value": 4589.2593610002405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6781350835657, 325.8843110695703, 330.7056719519629, 332.31377206069465, 333.4997503744384, 5173.9482605173935, 5304.708241046741, 5354.491323324288, 5385.630322658033, 5394.838154855361, 5121.436641969381, 5218.739063046852, 5227.0, 5244.213367994793, 5283.577313814895, 4111.814968326417, 4137.1725654869, 4138.13099249158, 4145.984233862708, 4184.393262976867, 4019.859304924328, 4127.8968025799295, 4135.250058710953, 4140.772257525835, 4185.372194170884, 4067.9796601016956, 4069.3895915612597, 4085.6527195188446, 4099.048684946833, 4129.112240868213, 4070.715049946505, 4081.551029386765, 4083.673306135502, 4086.7752273624938, 4114.938275925863, 3601.117726157082, 3601.477785721082, 3607.3867442534834, 3607.7654952428006, 3610.9097272568133, 4963.478834722338, 5108.591312694975, 5128.2564028216075, 5142.254373115915, 5171.948280517222, 4636.79134438951, 4663.347131401572, 4664.367471385022, 4680.368150299734, 4681.227597446417, 5472.1394725793425, 5488.81990372068, 5508.256385387961, 5520.641158324736, 5550.973069982067, 3725.701943844486, 3901.317269477858, 3939.6408239157445, 3949.5063117110362, 3950.881473555798, 5676.070136153687, 5698.601097923147, 5709.600327977043, 5717.714114294268, 5733.82798516041, 3978.6419222270133, 3984.880453586397, 3999.7800120993625, 4021.2962731521866, 4030.8589199378466, 3922.764634121962, 4015.437838702584, 4030.2141082488633, 4062.0, 4087.5094988600963, 4597.724136551751, 4621.237495813153, 4627.796772839019, 4630.083047680007, 4639.396878405786, 5503.394626591072, 5526.778928842882, 5532.280803495601, 5537.224788529609, 5563.860903477364, 1285.717142228708, 1330.6872884872048, 1357.6402253402857, 1373.2996171952177, 1389.3261768042491, 863.4344504349662, 879.0, 880.8810810540623, 886.9600867960958, 888.4363520204487, 4675.568704273826, 4697.530246975275, 4700.294955756595, 4709.317149013374, 4717.457492388351, 4890.486498917634, 4910.975445122823, 4914.304564925095, 4915.3855768029, 4936.531029552187, 4650.372199753057, 4682.976585117052, 4688.97655511727, 4691.46048204454, 4712.43450785901, 2783.860806959644, 3003.504421770427, 3004.459197344499, 3019.3659331540184, 3020.9546856797165, 5743.827685169452, 5798.159266906275, 5809.808989157213, 5815.924054050014, 5842.503387212049, 5464.617476776667, 5680.289963754531, 5692.9146062809095, 5775.711214439261, 5799.39106393831, 5806.738696758656, 5822.941770582324, 5832.50423713989, 5844.620099693591, 5867.677277749594, 5701.40135285789, 5701.572382071278, 5701.800436984686, 5707.828765137053, 5715.199872018004, 5395.649282796606, 5591.700896471101, 5632.802851900164, 5639.546797143092, 5650.389638952879, 5859.765609375577, 5886.352501224947, 5890.204822348928, 5898.9115163273445, 5942.702864856654, 3908.3160446922243, 4010.2981978153125, 4013.5918448930406, 4013.7993100344283, 4023.2556976959354, 5428.402875683751, 5704.942950570441, 5708.257926469532, 5724.141378793214, 5763.6541807491685, 5347.385050719217, 5438.347398312228, 5580.1629755537, 5585.0, 5593.244911936837, 5446.346438427414, 5495.0, 5499.0, 5568.136938774496, 5583.469570390806, 5328.6571444272795, 5465.207544906046, 5472.425395333592, 5506.017833579988, 5510.1459273812625, 5473.452654734654, 5519.172124181405, 5519.923614895057, 5520.233525271875, 5523.337199536081, 5428.502888671255, 5463.235147079492, 5463.262459567907, 5464.316960379952, 5518.889622207614], "value": 4148.693023503406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.797137815722, 730.605473044556, 732.5385007445309, 741.4624397311949, 784.9215078492151, 14446.349914253857, 15091.698166036673, 15318.617034574114, 15344.156071416068, 15370.923145384271, 15203.467878624251, 15358.462453814118, 15382.769258461132, 15390.461333853318, 15403.614909627266, 649.6686689788219, 664.6942406492994, 773.0414286284994, 782.034187778095, 794.9801254968643, 782.2490409207168, 791.7070683846985, 792.5720111139977, 793.0008189681015, 793.2028311546887, 845.9280961118312, 848.995755021224, 849.3799526345771, 850.0012485329744, 850.0734199722301, 684.8630273945206, 700.8983697363905, 823.4236034775621, 843.5065486690294, 845.9365547583925, 610.0270069239556, 614.9508039356886, 615.0528186592686, 615.129591627846, 615.6613862375675, 15639.765403518957, 15675.764863527056, 15694.0, 15802.525924222291, 15821.208939553091, 15219.315130819139, 15427.0, 15814.920925395414, 15823.683526329523, 15827.762583561256, 11848.585299514476, 11934.343611101385, 11976.70058248542, 12040.0, 12235.32705701195, 3743.7753734776, 3776.4146557283666, 3843.5964223756664, 3853.84584616615, 3859.459675645412, 65711.01433478549, 80718.19281807165, 80980.0, 81675.5916220421, 83005.58497207536, 11595.76808463826, 11998.640040798615, 12053.216540924812, 12055.397230138458, 12351.93824030874, 22285.888570557043, 22374.776252237596, 22385.888070559544, 22389.664155037688, 22484.437889052577, 8777.51723655205, 8823.382363234641, 8838.690645827493, 8867.911320886838, 9112.726618201465, 4352.755153793404, 4472.888177795516, 4613.746243956614, 4696.694714843524, 4825.321946319756, 3601.5858176309534, 3732.42147467143, 3749.1564398010773, 3752.0, 3763.2097259575794, 635.9109724638554, 647.1748520636132, 651.2803352295645, 656.9605823650596, 670.963097029668, 546.9097598896217, 589.5872888977733, 604.3020311540179, 604.7127614383132, 657.6613044282199, 9574.138327550554, 9577.523786727272, 9788.119069283799, 9925.900740992642, 10007.249456290807, 698.8043347862607, 698.8637215742983, 720.8089856188114, 722.458156382713, 725.7278520554792, 4669.95330046702, 4773.618110551148, 4777.235642297285, 4823.517648235219, 4860.125177468019, 91715.0, 93688.0, 95822.0, 117650.0, 120979.0, 74180.0, 86239.0, 86375.0, 86720.0, 86799.13200868036, 67897.0, 75949.6202518995, 78920.0, 79608.0, 79959.60020199978, 9183.77040573991, 9652.9034709652, 9695.806083878142, 9725.513724313614, 9740.75648108803, 36663.87459614707, 46090.769546152056, 46747.0, 47393.52606473891, 49677.26129585447, 48696.513034870615, 62163.37836621576, 63155.0, 72606.0, 75821.0, 12951.546695865976, 12996.037671982685, 13017.479300827861, 13246.0, 13709.451621935012, 14461.638459038608, 14613.488527901472, 14658.780118298448, 14702.411903524167, 14960.700785984001, 13495.662608434868, 13943.442262309394, 14034.458540667729, 14209.786853197416, 14274.571762847132, 13533.72932541324, 13617.31913404306, 13674.0, 13889.583312500641, 14452.710945781237, 13390.924436500767, 13397.933010334886, 13752.793708094187, 14341.92829035848, 14551.708965820413, 11238.325700458, 11298.378589177673, 11391.259568128045, 11409.828852567052, 11416.94291528537, 11561.942190289332, 11706.648800535997, 11730.472128754056, 12025.879741202476, 12149.088818338836], "value": 7451.662040498374, "unit": "score"}], "name": "dromaeo_css", "value": 7195.927237229556, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 111.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 126.0, 165.0, 129.0, 125.0, 122.0, 122.0, 168.0, 124.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 159.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 112.0, 78.0, 76.0, 75.0, 78.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 109.0, 83.0, 84.0, 83.0, 104.0, 84.0, 83.0, 106.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 89.0, 80.0, 81.0, 79.0, 79.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 135.0, 143.0, 139.0, 129.0, 131.0, 136.0, 173.0, 135.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 171.0, 168.0, 172.0, 172.0, 171.0, 169.0, 167.0, 166.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 67.0, 71.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1496.1, "alertThreshold": 2.0}]} 13:46:02 INFO - Return code: 0 13:46:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:46:02 INFO - # TBPL SUCCESS # 13:46:02 INFO - Running post-action listener: _resource_record_post_action 13:46:02 INFO - [mozharness: 2016-10-20 20:46:02.602758Z] Finished run-tests step (success) 13:46:02 INFO - Running post-run listener: _resource_record_post_run 13:46:02 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7864320; Write bytes: 417353728; Read time: 2124; Write time: 455328 13:46:02 INFO - TinderboxPrint: CPU usage
13.1% 13:46:02 INFO - TinderboxPrint: I/O read bytes / time
7,864,320 / 2,124 13:46:02 INFO - TinderboxPrint: I/O write bytes / time
417,353,728 / 455,328 13:46:02 INFO - TinderboxPrint: CPU idle
8,327.5 (86.9%) 13:46:02 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 13:46:02 INFO - TinderboxPrint: Swap in / out
0 / 0 13:46:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 700416; Read time: 0; Write time: 52 13:46:02 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5652480; Write bytes: 374476800; Read time: 1492; Write time: 436960 13:46:03 INFO - Running post-run listener: _upload_blobber_files 13:46:03 INFO - Blob upload gear active. 13:46:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:03 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 13:46:03 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'] 13:46:03 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 13:46:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:07 INFO - (blobuploader) - INFO - Done attempting. 13:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:08 INFO - (blobuploader) - INFO - Done attempting. 13:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:09 INFO - (blobuploader) - INFO - Done attempting. 13:46:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:09 INFO - Return code: 0 13:46:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c063a3d25c58caf0e27e0c51d2205eb24e8d95462cbd759a3078179fca13608aa7954d723b2032244fab2c8de0a5997c4f7a262d2c221fb50fddc7b8b106a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cceb37f38bd99aae8ff2969f5e82ba9424941f33ff1403c8176d44d95e9edcefb5565396b113e1bc0c775e4b410f1c7431b99080b660d818245dafdeef716dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/830d38c87d1403fddd045c63b35a427c3ff5febebbfb9b55107bb11e46bc2b5bea3407886ec6ce397c770aa1ff0e65fb303f3607bdba4d9381f04c1a9661e527"} 13:46:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:09 INFO - Contents: 13:46:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c063a3d25c58caf0e27e0c51d2205eb24e8d95462cbd759a3078179fca13608aa7954d723b2032244fab2c8de0a5997c4f7a262d2c221fb50fddc7b8b106a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cceb37f38bd99aae8ff2969f5e82ba9424941f33ff1403c8176d44d95e9edcefb5565396b113e1bc0c775e4b410f1c7431b99080b660d818245dafdeef716dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/830d38c87d1403fddd045c63b35a427c3ff5febebbfb9b55107bb11e46bc2b5bea3407886ec6ce397c770aa1ff0e65fb303f3607bdba4d9381f04c1a9661e527"} 13:46:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:09 INFO - Copying logs to upload dir... 13:46:09 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.637944 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-20 13:46:09.468208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 13:46:09.472070) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485 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/8c063a3d25c58caf0e27e0c51d2205eb24e8d95462cbd759a3078179fca13608aa7954d723b2032244fab2c8de0a5997c4f7a262d2c221fb50fddc7b8b106a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cceb37f38bd99aae8ff2969f5e82ba9424941f33ff1403c8176d44d95e9edcefb5565396b113e1bc0c775e4b410f1c7431b99080b660d818245dafdeef716dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/830d38c87d1403fddd045c63b35a427c3ff5febebbfb9b55107bb11e46bc2b5bea3407886ec6ce397c770aa1ff0e65fb303f3607bdba4d9381f04c1a9661e527"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476981008/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/8c063a3d25c58caf0e27e0c51d2205eb24e8d95462cbd759a3078179fca13608aa7954d723b2032244fab2c8de0a5997c4f7a262d2c221fb50fddc7b8b106a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cceb37f38bd99aae8ff2969f5e82ba9424941f33ff1403c8176d44d95e9edcefb5565396b113e1bc0c775e4b410f1c7431b99080b660d818245dafdeef716dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/830d38c87d1403fddd045c63b35a427c3ff5febebbfb9b55107bb11e46bc2b5bea3407886ec6ce397c770aa1ff0e65fb303f3607bdba4d9381f04c1a9661e527"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 13:46:09.496416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:46:09.496728) ========= 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=03627c79f6bb3d1578c4a402000001ba-1476995120.314948-870117485 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:46:09.581374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 13:46:09.581692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 13:46:09.581970) ========= ========= Total master_lag: 0.15 =========