builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1476684956.98 results: success (0) buildid: 20161016201455 builduid: 54f65ac94d7d449f96a04cc38229aa1c revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:56.985332) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:56.985899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:56.986169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:57.026981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:57.027234) ========= 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=62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-16 23:15:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-10-16 23:15:57 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.413706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:57.454884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:57.455225) ========= 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=62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016890 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:57.505432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:57.505807) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 687572ea20cb84f1842ad00dcc8ca1712868a361 --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 687572ea20cb84f1842ad00dcc8ca1712868a361 --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=62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-16 23:15:58,074 truncating revision to first 12 chars 2016-10-16 23:15:58,074 Setting DEBUG logging. 2016-10-16 23:15:58,074 attempt 1/10 2016-10-16 23:15:58,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/687572ea20cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 23:15:58,370 unpacking tar archive at: fx-team-687572ea20cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609343 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:58.131994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:58.132721) ========= script_repo_revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:58.133584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:58.134285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:15:58.146059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-16 23:15:58.146367) ========= /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=62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:15:58 INFO - MultiFileLogger online at 20161016 23:15:58 in /builds/slave/test 23:15:58 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 23:15:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:15:58 INFO - {'append_to_log': False, 23:15:58 INFO - 'base_work_dir': '/builds/slave/test', 23:15:58 INFO - 'blob_upload_branch': 'Fx-Team', 23:15:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:15:58 INFO - 'branch': 'Fx-Team', 23:15:58 INFO - 'buildbot_json_path': 'buildprops.json', 23:15:58 INFO - 'config_files': ('talos/linux_config.py',), 23:15:58 INFO - 'default_actions': ('clobber', 23:15:58 INFO - 'read-buildbot-config', 23:15:58 INFO - 'download-and-extract', 23:15:58 INFO - 'populate-webroot', 23:15:58 INFO - 'create-virtualenv', 23:15:58 INFO - 'install', 23:15:58 INFO - 'run-tests'), 23:15:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:15:58 INFO - 'download_minidump_stackwalk': True, 23:15:58 INFO - 'download_symbols': 'ondemand', 23:15:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:15:58 INFO - 'tooltool.py': '/tools/tooltool.py', 23:15:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:15:58 INFO - '/tools/misc-python/virtualenv.py')}, 23:15:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:15:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:15:58 INFO - 'installer_path': 'installer.exe', 23:15:58 INFO - 'log_level': 'info', 23:15:58 INFO - 'log_name': 'talos', 23:15:58 INFO - 'log_to_console': True, 23:15:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:15:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:15:58 INFO - 'opt_config_files': (), 23:15:58 INFO - 'pip_index': False, 23:15:58 INFO - 'sps_profile': False, 23:15:58 INFO - 'sps_profile_interval': 0, 23:15:58 INFO - 'suite': 'dromaeojs', 23:15:58 INFO - 'system_bits': '32', 23:15:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:15:58 INFO - 'title': 'talos-linux64-ix-018', 23:15:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:15:58 INFO - 'use_talos_json': True, 23:15:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:15:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:15:58 INFO - 'work_dir': 'build'} 23:15:58 INFO - [mozharness: 2016-10-17 06:15:58.817186Z] Running clobber step. 23:15:58 INFO - Running pre-action listener: _resource_record_pre_action 23:15:58 INFO - Running main action method: clobber 23:15:58 INFO - rmtree: /builds/slave/test/build 23:15:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:15:59 INFO - Running post-action listener: _resource_record_post_action 23:15:59 INFO - [mozharness: 2016-10-17 06:15:59.800803Z] Finished clobber step (success) 23:15:59 INFO - [mozharness: 2016-10-17 06:15:59.800903Z] Running read-buildbot-config step. 23:15:59 INFO - Running pre-action listener: _resource_record_pre_action 23:15:59 INFO - Running main action method: read_buildbot_config 23:15:59 INFO - Using buildbot properties: 23:15:59 INFO - { 23:15:59 INFO - "project": "", 23:15:59 INFO - "product": "firefox", 23:15:59 INFO - "script_repo_revision": "production", 23:15:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:15:59 INFO - "repository": "", 23:15:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:15:59 INFO - "buildid": "20161016201455", 23:15:59 INFO - "pgo_build": "True", 23:15:59 INFO - "basedir": "/builds/slave/test", 23:15:59 INFO - "buildnumber": 1143, 23:15:59 INFO - "slavename": "talos-linux64-ix-018", 23:15:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:15:59 INFO - "platform": "ubuntu64_hw", 23:15:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:15:59 INFO - "branch": "fx-team", 23:15:59 INFO - "repo_path": "integration/fx-team", 23:15:59 INFO - "revision": "687572ea20cb84f1842ad00dcc8ca1712868a361", 23:15:59 INFO - "stage_platform": "linux64-pgo", 23:15:59 INFO - "builduid": "54f65ac94d7d449f96a04cc38229aa1c", 23:15:59 INFO - "slavebuilddir": "test" 23:15:59 INFO - } 23:15:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:15:59 INFO - Running post-action listener: _resource_record_post_action 23:15:59 INFO - [mozharness: 2016-10-17 06:15:59.803339Z] Finished read-buildbot-config step (success) 23:15:59 INFO - [mozharness: 2016-10-17 06:15:59.803427Z] Running download-and-extract step. 23:15:59 INFO - Running pre-action listener: _resource_record_pre_action 23:15:59 INFO - Running main action method: download_and_extract 23:15:59 INFO - mkdir: /builds/slave/test/build/tests 23:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:59 INFO - trying https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:16:00 INFO - Downloaded 1361 bytes. 23:16:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:16:00 INFO - Using the following test package requirements: 23:16:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'jsshell-linux-x86_64.zip'], 23:16:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:16:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:00 INFO - Fetch https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:16:00 INFO - Http code: 200 23:16:00 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 23:16:00 INFO - x-amz-cf-id: 4Q687oZ2ZY9kJlTRUY_htj0Q1wHKUeotWoMOqav6WrvP84dRyMbl6w== 23:16:00 INFO - x-amz-version-id: nq_xRi390ITI4MZbOFbmyA3Rh0ZVF8m7 23:16:01 INFO - Expected file size: 22100551 23:16:01 INFO - Obtained file size: 22100551 23:16:05 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 23:16:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:16:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:05 INFO - Fetch https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:16:05 INFO - Http code: 200 23:16:05 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 23:16:05 INFO - x-amz-cf-id: BdGwNWhfW7RPt4b7CpsZpqOWlqhF0DhfeOT7g0u5so5tiWJyOHye2g== 23:16:05 INFO - x-amz-version-id: nq_xRi390ITI4MZbOFbmyA3Rh0ZVF8m7 23:16:06 INFO - Expected file size: 22100551 23:16:06 INFO - Obtained file size: 22100551 23:16:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:16:10 INFO - Fetch https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:16:11 INFO - Http code: 200 23:16:11 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 23:16:11 INFO - x-amz-cf-id: NPVzRyu5D2KK5cpcxxEOzpWlIc_DZichIz9v_huxtXwByF56IjekHQ== 23:16:11 INFO - x-amz-version-id: v23c.vIQAQ5WiAPmSokuc7LnsV7UvHx6 23:16:11 INFO - Expected file size: 14409006 23:16:11 INFO - Obtained file size: 14409006 23:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:11 INFO - trying https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:11 INFO - Downloading https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:16:13 INFO - Downloaded 59780329 bytes. 23:16:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:13 INFO - mkdir: /builds/slave/test/properties 23:16:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:13 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:13 INFO - Contents: 23:16:13 INFO - build_url:https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:16:13 INFO - Running post-action listener: _resource_record_post_action 23:16:13 INFO - Running post-action listener: set_extra_try_arguments 23:16:13 INFO - [mozharness: 2016-10-17 06:16:13.580562Z] Finished download-and-extract step (success) 23:16:13 INFO - [mozharness: 2016-10-17 06:16:13.580789Z] Running populate-webroot step. 23:16:13 INFO - Running pre-action listener: _resource_record_pre_action 23:16:13 INFO - Running main action method: populate_webroot 23:16:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:13 INFO - '--tppagecycles', 23:16:13 INFO - '7'], 23:16:13 INFO - 'tests': ['tsvgm']}}, 23:16:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['damp', 'tps']}, 23:16:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'tests': ['damp', 'tps']}, 23:16:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['dromaeo_dom']}, 23:16:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['basic_compositor_video']}, 23:16:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['a11yr', 23:16:13 INFO - 'ts_paint', 23:16:13 INFO - 'tpaint', 23:16:13 INFO - 'sessionrestore', 23:16:13 INFO - 'sessionrestore_no_auto_restore', 23:16:13 INFO - 'tabpaint']}, 23:16:13 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:13 INFO - 'ts_paint', 23:16:13 INFO - 'tpaint', 23:16:13 INFO - 'sessionrestore', 23:16:13 INFO - 'sessionrestore_no_auto_restore', 23:16:13 INFO - 'tabpaint']}, 23:16:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:13 INFO - 'ts_paint', 23:16:13 INFO - 'tpaint', 23:16:13 INFO - 'sessionrestore', 23:16:13 INFO - 'sessionrestore_no_auto_restore', 23:16:13 INFO - 'tabpaint']}, 23:16:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:13 INFO - 'ts_paint', 23:16:13 INFO - 'tpaint', 23:16:13 INFO - 'sessionrestore', 23:16:13 INFO - 'sessionrestore_no_auto_restore', 23:16:13 INFO - 'tabpaint']}, 23:16:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['a11yr', 23:16:13 INFO - 'ts_paint', 23:16:13 INFO - 'tpaint', 23:16:13 INFO - 'sessionrestore', 23:16:13 INFO - 'sessionrestore_no_auto_restore', 23:16:13 INFO - 'tabpaint']}, 23:16:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['a11yr', 23:16:13 INFO - 'ts_paint', 23:16:13 INFO - 'tpaint', 23:16:13 INFO - 'sessionrestore', 23:16:13 INFO - 'sessionrestore_no_auto_restore', 23:16:13 INFO - 'tabpaint']}, 23:16:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['tsvgx', 23:16:13 INFO - 'tsvgr_opacity', 23:16:13 INFO - 'tart', 23:16:13 INFO - 'tscrollx', 23:16:13 INFO - 'cart']}, 23:16:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:13 INFO - 'tsvgr_opacity', 23:16:13 INFO - 'tart', 23:16:13 INFO - 'tscrollx', 23:16:13 INFO - 'cart']}, 23:16:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'talos_options': ['--disable-e10s'], 23:16:13 INFO - 'tests': ['tp5o']}, 23:16:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'tests': ['tp5o']}, 23:16:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'talos_options': ['--disable-e10s', 23:16:13 INFO - '--xperf_path', 23:16:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:13 INFO - 'tests': ['tp5n']}, 23:16:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:13 INFO - 'talos_options': ['--xperf_path', 23:16:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:13 INFO - 'tests': ['tp5n']}}, 23:16:13 INFO - 'talos.zip': {'path': '', 23:16:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:13 INFO - Running post-action listener: _resource_record_post_action 23:16:13 INFO - [mozharness: 2016-10-17 06:16:13.602167Z] Finished populate-webroot step (success) 23:16:13 INFO - [mozharness: 2016-10-17 06:16:13.602256Z] Running create-virtualenv step. 23:16:13 INFO - Running pre-action listener: _resource_record_pre_action 23:16:13 INFO - Running main action method: create_virtualenv 23:16:13 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:13 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 23:16:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:13 INFO - Using real prefix '/usr' 23:16:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:14 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:16 INFO - Installing pip.................done. 23:16:16 INFO - Return code: 0 23:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:16:16 INFO - Reading from file tmpfile_stdout 23:16:16 INFO - Output received: 23:16:16 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) 23:16:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:16:16 INFO - Using env: {'DISPLAY': ':0', 23:16:16 INFO - 'HOME': '/home/cltbld', 23:16:16 INFO - 'LANG': 'en_US.UTF-8', 23:16:16 INFO - 'LANGUAGE': 'en_US:en', 23:16:16 INFO - 'LOGNAME': 'cltbld', 23:16:16 INFO - 'MAIL': '/var/mail/cltbld', 23:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:16 INFO - 'MOZ_NO_REMOTE': '1', 23:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:16 INFO - 'NO_EM_RESTART': '1', 23:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:16 INFO - 'PWD': '/builds/slave/test', 23:16:16 INFO - 'SHELL': '/bin/bash', 23:16:16 INFO - 'SHLVL': '1', 23:16:16 INFO - 'TERM': 'linux', 23:16:16 INFO - 'TMOUT': '86400', 23:16:16 INFO - 'USER': 'cltbld', 23:16:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:16 INFO - '_': '/tools/buildbot/bin/python'} 23:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:16 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 23:16:16 INFO - Cleaning up... 23:16:16 INFO - Return code: 0 23:16:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:16:16 INFO - Using env: {'DISPLAY': ':0', 23:16:16 INFO - 'HOME': '/home/cltbld', 23:16:16 INFO - 'LANG': 'en_US.UTF-8', 23:16:16 INFO - 'LANGUAGE': 'en_US:en', 23:16:16 INFO - 'LOGNAME': 'cltbld', 23:16:16 INFO - 'MAIL': '/var/mail/cltbld', 23:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:16 INFO - 'MOZ_NO_REMOTE': '1', 23:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:16 INFO - 'NO_EM_RESTART': '1', 23:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:16 INFO - 'PWD': '/builds/slave/test', 23:16:16 INFO - 'SHELL': '/bin/bash', 23:16:16 INFO - 'SHLVL': '1', 23:16:16 INFO - 'TERM': 'linux', 23:16:16 INFO - 'TMOUT': '86400', 23:16:16 INFO - 'USER': 'cltbld', 23:16:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:16 INFO - '_': '/tools/buildbot/bin/python'} 23:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:16 INFO - Downloading/unpacking psutil>=3.1.1 23:16:16 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 23:16:16 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 23:16:16 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 23:16:16 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 23:16:16 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 23:16:16 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 23:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:18 INFO - Installing collected packages: psutil 23:16:18 INFO - Running setup.py install for psutil 23:16:18 INFO - building 'psutil._psutil_linux' extension 23:16:18 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 23:16:19 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 23:16:19 INFO - building 'psutil._psutil_posix' extension 23:16:19 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 23:16:19 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 23:16:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:19 INFO - Successfully installed psutil 23:16:19 INFO - Cleaning up... 23:16:19 INFO - Return code: 0 23:16:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:16:19 INFO - Using env: {'DISPLAY': ':0', 23:16:19 INFO - 'HOME': '/home/cltbld', 23:16:19 INFO - 'LANG': 'en_US.UTF-8', 23:16:19 INFO - 'LANGUAGE': 'en_US:en', 23:16:19 INFO - 'LOGNAME': 'cltbld', 23:16:19 INFO - 'MAIL': '/var/mail/cltbld', 23:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:19 INFO - 'MOZ_NO_REMOTE': '1', 23:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:19 INFO - 'NO_EM_RESTART': '1', 23:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:19 INFO - 'PWD': '/builds/slave/test', 23:16:19 INFO - 'SHELL': '/bin/bash', 23:16:19 INFO - 'SHLVL': '1', 23:16:19 INFO - 'TERM': 'linux', 23:16:19 INFO - 'TMOUT': '86400', 23:16:19 INFO - 'USER': 'cltbld', 23:16:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:19 INFO - '_': '/tools/buildbot/bin/python'} 23:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:21 INFO - Installing collected packages: mozsystemmonitor 23:16:21 INFO - Running setup.py install for mozsystemmonitor 23:16:21 INFO - Successfully installed mozsystemmonitor 23:16:21 INFO - Cleaning up... 23:16:21 INFO - Return code: 0 23:16:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:16:21 INFO - Using env: {'DISPLAY': ':0', 23:16:21 INFO - 'HOME': '/home/cltbld', 23:16:21 INFO - 'LANG': 'en_US.UTF-8', 23:16:21 INFO - 'LANGUAGE': 'en_US:en', 23:16:21 INFO - 'LOGNAME': 'cltbld', 23:16:21 INFO - 'MAIL': '/var/mail/cltbld', 23:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:21 INFO - 'MOZ_NO_REMOTE': '1', 23:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:21 INFO - 'NO_EM_RESTART': '1', 23:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:21 INFO - 'PWD': '/builds/slave/test', 23:16:21 INFO - 'SHELL': '/bin/bash', 23:16:21 INFO - 'SHLVL': '1', 23:16:21 INFO - 'TERM': 'linux', 23:16:21 INFO - 'TMOUT': '86400', 23:16:21 INFO - 'USER': 'cltbld', 23:16:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:21 INFO - '_': '/tools/buildbot/bin/python'} 23:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:21 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:24 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:24 INFO - warning: no files found matching '*.txt' 23:16:24 INFO - no previously-included directories found matching 'build' 23:16:24 INFO - no previously-included directories found matching 'dist' 23:16:24 INFO - no previously-included directories found matching '.git*' 23:16:24 INFO - Installing collected packages: jsonschema, functools32 23:16:24 INFO - Running setup.py install for functools32 23:16:24 INFO - warning: no files found matching '*.txt' 23:16:24 INFO - no previously-included directories found matching 'build' 23:16:24 INFO - no previously-included directories found matching 'dist' 23:16:24 INFO - no previously-included directories found matching '.git*' 23:16:24 INFO - Successfully installed jsonschema functools32 23:16:24 INFO - Cleaning up... 23:16:24 INFO - Return code: 0 23:16:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:16:24 INFO - Using env: {'DISPLAY': ':0', 23:16:24 INFO - 'HOME': '/home/cltbld', 23:16:24 INFO - 'LANG': 'en_US.UTF-8', 23:16:24 INFO - 'LANGUAGE': 'en_US:en', 23:16:24 INFO - 'LOGNAME': 'cltbld', 23:16:24 INFO - 'MAIL': '/var/mail/cltbld', 23:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:24 INFO - 'MOZ_NO_REMOTE': '1', 23:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:24 INFO - 'NO_EM_RESTART': '1', 23:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:24 INFO - 'PWD': '/builds/slave/test', 23:16:24 INFO - 'SHELL': '/bin/bash', 23:16:24 INFO - 'SHLVL': '1', 23:16:24 INFO - 'TERM': 'linux', 23:16:24 INFO - 'TMOUT': '86400', 23:16:24 INFO - 'USER': 'cltbld', 23:16:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:24 INFO - '_': '/tools/buildbot/bin/python'} 23:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:24 INFO - Cleaning up... 23:16:24 INFO - Return code: 0 23:16:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:16:24 INFO - Using env: {'DISPLAY': ':0', 23:16:24 INFO - 'HOME': '/home/cltbld', 23:16:24 INFO - 'LANG': 'en_US.UTF-8', 23:16:24 INFO - 'LANGUAGE': 'en_US:en', 23:16:24 INFO - 'LOGNAME': 'cltbld', 23:16:24 INFO - 'MAIL': '/var/mail/cltbld', 23:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:24 INFO - 'MOZ_NO_REMOTE': '1', 23:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:24 INFO - 'NO_EM_RESTART': '1', 23:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:24 INFO - 'PWD': '/builds/slave/test', 23:16:24 INFO - 'SHELL': '/bin/bash', 23:16:24 INFO - 'SHLVL': '1', 23:16:24 INFO - 'TERM': 'linux', 23:16:24 INFO - 'TMOUT': '86400', 23:16:24 INFO - 'USER': 'cltbld', 23:16:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:24 INFO - '_': '/tools/buildbot/bin/python'} 23:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:24 INFO - Downloading/unpacking blobuploader==1.2.4 23:16:24 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 23:16:24 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 23:16:24 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 23:16:24 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 23:16:24 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 23:16:24 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 23:16:26 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:27 INFO - Downloading docopt-0.6.1.tar.gz 23:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:27 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:27 INFO - Running setup.py install for blobuploader 23:16:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:27 INFO - Running setup.py install for requests 23:16:27 INFO - Running setup.py install for docopt 23:16:28 INFO - Successfully installed blobuploader requests docopt 23:16:28 INFO - Cleaning up... 23:16:28 INFO - Return code: 0 23:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:28 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')]} 23:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:28 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')]} 23:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:28 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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:28 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 23:16:28 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 23:16:28 INFO - Using env: {'DISPLAY': ':0', 23:16:28 INFO - 'HOME': '/home/cltbld', 23:16:28 INFO - 'LANG': 'en_US.UTF-8', 23:16:28 INFO - 'LANGUAGE': 'en_US:en', 23:16:28 INFO - 'LOGNAME': 'cltbld', 23:16:28 INFO - 'MAIL': '/var/mail/cltbld', 23:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:28 INFO - 'MOZ_NO_REMOTE': '1', 23:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:28 INFO - 'NO_EM_RESTART': '1', 23:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:28 INFO - 'PWD': '/builds/slave/test', 23:16:28 INFO - 'SHELL': '/bin/bash', 23:16:28 INFO - 'SHLVL': '1', 23:16:28 INFO - 'TERM': 'linux', 23:16:28 INFO - 'TMOUT': '86400', 23:16:28 INFO - 'USER': 'cltbld', 23:16:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:28 INFO - '_': '/tools/buildbot/bin/python'} 23:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:28 INFO - Running setup.py (path:/tmp/pip-nmMjjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:28 INFO - Running setup.py (path:/tmp/pip-rplcDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:28 INFO - Running setup.py (path:/tmp/pip-qBLhjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:28 INFO - Running setup.py (path:/tmp/pip-qaVLfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:28 INFO - Running setup.py (path:/tmp/pip-WFqaOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:28 INFO - Running setup.py (path:/tmp/pip-WKYWYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:28 INFO - Running setup.py (path:/tmp/pip-D4JqAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:28 INFO - Running setup.py (path:/tmp/pip-b9_7FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:28 INFO - Running setup.py (path:/tmp/pip-Vu4Pg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:28 INFO - Running setup.py (path:/tmp/pip-T4t3JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:29 INFO - Running setup.py (path:/tmp/pip-rUrPis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:29 INFO - Running setup.py (path:/tmp/pip-95oM2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:29 INFO - Running setup.py (path:/tmp/pip-eI2m2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:29 INFO - Running setup.py (path:/tmp/pip-cbXYqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:29 INFO - Running setup.py (path:/tmp/pip-8itq7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:29 INFO - Running setup.py (path:/tmp/pip-8WSSK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:29 INFO - Running setup.py (path:/tmp/pip-5xtRiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:29 INFO - Running setup.py install for manifestparser 23:16:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:29 INFO - Running setup.py install for mozcrash 23:16:29 INFO - Running setup.py install for mozdebug 23:16:29 INFO - Running setup.py install for mozdevice 23:16:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:29 INFO - Running setup.py install for mozfile 23:16:30 INFO - Running setup.py install for mozhttpd 23:16:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Running setup.py install for mozinfo 23:16:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Running setup.py install for mozInstall 23:16:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Running setup.py install for mozleak 23:16:30 INFO - Running setup.py install for mozlog 23:16:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Running setup.py install for moznetwork 23:16:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Running setup.py install for mozprocess 23:16:30 INFO - Running setup.py install for mozprofile 23:16:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:30 INFO - Running setup.py install for mozrunner 23:16:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:31 INFO - Running setup.py install for mozscreenshot 23:16:31 INFO - Running setup.py install for moztest 23:16:31 INFO - Running setup.py install for mozversion 23:16:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:31 INFO - Cleaning up... 23:16:31 INFO - Return code: 0 23:16:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:31 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')]} 23:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:31 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')]} 23:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:31 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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:31 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 23:16:31 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 23:16:31 INFO - Using env: {'DISPLAY': ':0', 23:16:31 INFO - 'HOME': '/home/cltbld', 23:16:31 INFO - 'LANG': 'en_US.UTF-8', 23:16:31 INFO - 'LANGUAGE': 'en_US:en', 23:16:31 INFO - 'LOGNAME': 'cltbld', 23:16:31 INFO - 'MAIL': '/var/mail/cltbld', 23:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:31 INFO - 'MOZ_NO_REMOTE': '1', 23:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:31 INFO - 'NO_EM_RESTART': '1', 23:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:31 INFO - 'PWD': '/builds/slave/test', 23:16:31 INFO - 'SHELL': '/bin/bash', 23:16:31 INFO - 'SHLVL': '1', 23:16:31 INFO - 'TERM': 'linux', 23:16:31 INFO - 'TMOUT': '86400', 23:16:31 INFO - 'USER': 'cltbld', 23:16:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:31 INFO - '_': '/tools/buildbot/bin/python'} 23:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:31 INFO - Running setup.py (path:/tmp/pip-NN88AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:31 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)) 23:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:31 INFO - Running setup.py (path:/tmp/pip-MKJlqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:31 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)) 23:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:31 INFO - Running setup.py (path:/tmp/pip-atx_5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:31 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)) 23:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:31 INFO - Running setup.py (path:/tmp/pip-CW7fOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:31 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)) 23:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:31 INFO - Running setup.py (path:/tmp/pip-8p4NxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:31 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)) 23:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:31 INFO - Running setup.py (path:/tmp/pip-59XNo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:32 INFO - Running setup.py (path:/tmp/pip-hEg4kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:32 INFO - Running setup.py (path:/tmp/pip-t78lLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:32 INFO - Running setup.py (path:/tmp/pip-j8qLVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:32 INFO - Running setup.py (path:/tmp/pip-DTKkGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:32 INFO - Running setup.py (path:/tmp/pip-OwrVZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:32 INFO - Running setup.py (path:/tmp/pip-oJU3FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:32 INFO - Running setup.py (path:/tmp/pip-v6I7SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:32 INFO - Running setup.py (path:/tmp/pip-s9Ocxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:32 INFO - Running setup.py (path:/tmp/pip-kiBVXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:32 INFO - Running setup.py (path:/tmp/pip-udB1lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:32 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)) 23:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:32 INFO - Running setup.py (path:/tmp/pip-EP5u7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:32 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)) 23:16:32 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)) 23:16:32 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)) 23:16:32 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)) 23:16:32 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)) 23:16:32 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)) 23:16:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:16:32 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 23:16:32 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 23:16:32 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 23:16:32 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 23:16:32 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 23:16:32 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 23:16:34 INFO - Downloading blessings-1.6.tar.gz 23:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:16:34 INFO - Installing collected packages: blessings 23:16:34 INFO - Running setup.py install for blessings 23:16:34 INFO - Successfully installed blessings 23:16:34 INFO - Cleaning up... 23:16:35 INFO - Return code: 0 23:16:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:35 INFO - Reading from file tmpfile_stdout 23:16:35 INFO - Current package versions: 23:16:35 INFO - argparse == 1.2.1 23:16:35 INFO - blessings == 1.6 23:16:35 INFO - blobuploader == 1.2.4 23:16:35 INFO - docopt == 0.6.1 23:16:35 INFO - functools32 == 3.2.3-2 23:16:35 INFO - jsonschema == 2.5.1 23:16:35 INFO - manifestparser == 1.1 23:16:35 INFO - mozInstall == 1.12 23:16:35 INFO - mozcrash == 0.17 23:16:35 INFO - mozdebug == 0.1 23:16:35 INFO - mozdevice == 0.48 23:16:35 INFO - mozfile == 1.2 23:16:35 INFO - mozhttpd == 0.7 23:16:35 INFO - mozinfo == 0.9 23:16:35 INFO - mozleak == 0.1 23:16:35 INFO - mozlog == 3.4 23:16:35 INFO - moznetwork == 0.27 23:16:35 INFO - mozprocess == 0.23 23:16:35 INFO - mozprofile == 0.28 23:16:35 INFO - mozrunner == 6.12 23:16:35 INFO - mozscreenshot == 0.1 23:16:35 INFO - mozsystemmonitor == 0.3 23:16:35 INFO - moztest == 0.7 23:16:35 INFO - mozversion == 1.4 23:16:35 INFO - psutil == 3.1.1 23:16:35 INFO - requests == 1.2.3 23:16:35 INFO - wsgiref == 0.1.2 23:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:35 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')]} 23:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 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')]} 23:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:35 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 23:16:35 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 23:16:35 INFO - Using env: {'DISPLAY': ':0', 23:16:35 INFO - 'HOME': '/home/cltbld', 23:16:35 INFO - 'LANG': 'en_US.UTF-8', 23:16:35 INFO - 'LANGUAGE': 'en_US:en', 23:16:35 INFO - 'LOGNAME': 'cltbld', 23:16:35 INFO - 'MAIL': '/var/mail/cltbld', 23:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:35 INFO - 'MOZ_NO_REMOTE': '1', 23:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:35 INFO - 'NO_EM_RESTART': '1', 23:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:35 INFO - 'PWD': '/builds/slave/test', 23:16:35 INFO - 'SHELL': '/bin/bash', 23:16:35 INFO - 'SHLVL': '1', 23:16:35 INFO - 'TERM': 'linux', 23:16:35 INFO - 'TMOUT': '86400', 23:16:35 INFO - 'USER': 'cltbld', 23:16:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:35 INFO - '_': '/tools/buildbot/bin/python'} 23:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 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)) 23:16:35 INFO - Cleaning up... 23:16:35 INFO - Return code: 0 23:16:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:16:35 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')]} 23:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 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')]} 23:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:35 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 0x7f5219715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2788790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, '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': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', '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 23:16:35 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 23:16:35 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 23:16:35 INFO - Using env: {'DISPLAY': ':0', 23:16:35 INFO - 'HOME': '/home/cltbld', 23:16:35 INFO - 'LANG': 'en_US.UTF-8', 23:16:35 INFO - 'LANGUAGE': 'en_US:en', 23:16:35 INFO - 'LOGNAME': 'cltbld', 23:16:35 INFO - 'MAIL': '/var/mail/cltbld', 23:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:35 INFO - 'MOZ_NO_REMOTE': '1', 23:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:35 INFO - 'NO_EM_RESTART': '1', 23:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:35 INFO - 'PWD': '/builds/slave/test', 23:16:35 INFO - 'SHELL': '/bin/bash', 23:16:35 INFO - 'SHLVL': '1', 23:16:35 INFO - 'TERM': 'linux', 23:16:35 INFO - 'TMOUT': '86400', 23:16:35 INFO - 'USER': 'cltbld', 23:16:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:35 INFO - '_': '/tools/buildbot/bin/python'} 23:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:16:35 INFO - Cleaning up... 23:16:35 INFO - Return code: 0 23:16:35 INFO - Running post-action listener: _resource_record_post_action 23:16:35 INFO - Running post-action listener: _start_resource_monitoring 23:16:35 INFO - Starting resource monitoring. 23:16:35 INFO - [mozharness: 2016-10-17 06:16:35.735803Z] Finished create-virtualenv step (success) 23:16:35 INFO - [mozharness: 2016-10-17 06:16:35.736325Z] Running install step. 23:16:35 INFO - Running pre-action listener: _resource_record_pre_action 23:16:35 INFO - Running main action method: install 23:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:16:35 INFO - Reading from file tmpfile_stdout 23:16:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:16:36 INFO - Reading from file tmpfile_stdout 23:16:36 INFO - Output received: 23:16:36 INFO - Usage: mozinstall [options] installer 23:16:36 INFO - Options: 23:16:36 INFO - -h, --help show this help message and exit 23:16:36 INFO - -d DEST, --destination=DEST 23:16:36 INFO - Directory to install application into. [default: 23:16:36 INFO - "/builds/slave/test"] 23:16:36 INFO - --app=APP Application being installed. [default: firefox] 23:16:36 INFO - mkdir: /builds/slave/test/build/application 23:16:36 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'] 23:16:36 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 23:16:53 INFO - Reading from file tmpfile_stdout 23:16:53 INFO - Output received: 23:16:53 INFO - /builds/slave/test/build/application/firefox/firefox 23:16:53 INFO - Running post-action listener: _resource_record_post_action 23:16:53 INFO - [mozharness: 2016-10-17 06:16:53.059589Z] Finished install step (success) 23:16:53 INFO - [mozharness: 2016-10-17 06:16:53.059835Z] Running run-tests step. 23:16:53 INFO - Running pre-action listener: _resource_record_pre_action 23:16:53 INFO - Running main action method: run_tests 23:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:16:53 INFO - Python 2.7.3 23:16:53 INFO - Return code: 0 23:16:53 INFO - grabbing minidump binary from tooltool 23:16: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')]} 23:16:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2785930>, '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 0x2786830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2786cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:16:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:16:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:16:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:16:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:16:53 INFO - Return code: 0 23:16:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:16:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:16:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:16:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:16:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 23:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 23:16:53 INFO - Using env: {'DISPLAY': ':0', 23:16:53 INFO - 'HOME': '/home/cltbld', 23:16:53 INFO - 'LANG': 'en_US.UTF-8', 23:16:53 INFO - 'LANGUAGE': 'en_US:en', 23:16:53 INFO - 'LOGNAME': 'cltbld', 23:16:53 INFO - 'MAIL': '/var/mail/cltbld', 23:16:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:16:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:53 INFO - 'MOZ_NO_REMOTE': '1', 23:16:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:53 INFO - 'NO_EM_RESTART': '1', 23:16:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:53 INFO - 'PWD': '/builds/slave/test', 23:16:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:16:53 INFO - 'SHELL': '/bin/bash', 23:16:53 INFO - 'SHLVL': '1', 23:16:53 INFO - 'TERM': 'linux', 23:16:53 INFO - 'TMOUT': '86400', 23:16:53 INFO - 'USER': 'cltbld', 23:16:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411', 23:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:53 INFO - '_': '/tools/buildbot/bin/python'} 23:16:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 23:16:53 INFO - mozversion application_buildid: 20161016201455 23:16:53 INFO - mozversion application_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 23:16:53 INFO - mozversion application_display_name: Nightly 23:16:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:16:53 INFO - mozversion application_name: Firefox 23:16:53 INFO - mozversion application_remotingname: firefox 23:16:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:16:53 INFO - mozversion application_vendor: Mozilla 23:16:53 INFO - mozversion application_version: 52.0a1 23:16:53 INFO - mozversion platform_buildid: 20161016201455 23:16:53 INFO - mozversion platform_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 23:16:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:16:53 INFO - mozversion platform_version: 52.0a1 23:16:53 INFO - using testdate: 1476685013 23:16:53 INFO - actual date: 1476685013 23:16:53 INFO - starting webserver on 'localhost:44084' 23:16:53 INFO - SUITE-START | Running 2 tests 23:16:53 INFO - TEST-START | dromaeo_css 23:16:53 INFO - operating with platform_type : linux_ 23:16:53 INFO - Initialising browser for dromaeo_css test... 23:16:53 INFO - TEST-INFO | started process 28345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0AqR9F/profile http://localhost:44084/getInfo.html) 23:16:57 INFO - PROCESS | 28345 | __metrics Screen width/height:1600/1200 23:16:57 INFO - PROCESS | 28345 | colorDepth:24 23:16:57 INFO - PROCESS | 28345 | Browser inner width/height: 1024/697 23:16:57 INFO - PROCESS | 28345 | __metrics 23:16:57 INFO - PROCESS | 28345 | 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" 23:16:57 INFO - PROCESS | 28345 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:16:58 INFO - PROCESS | 28345 | console.error: PushService: 23:16:58 INFO - PROCESS | 28345 | stateChangeProcessEnqueue: Error transitioning state 23:16:58 INFO - PROCESS | 28345 | UnknownError 23:16:59 INFO - TEST-INFO | 28345: exit 0 23:16:59 INFO - Browser initialized. 23:16:59 INFO - Running cycle 1/1 for dromaeo_css test... 23:16:59 INFO - TEST-INFO | started process 28428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0AqR9F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:11 INFO - PROCESS | 28428 | RSS: Main: 172642304 23:17:11 INFO - PROCESS | 28428 | 23:18:02 INFO - PROCESS | 28428 | 1476685082610 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] 23:20:12 INFO - PROCESS | 28428 | Cycle 1(1): loaded http://localhost:44084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44084/tests/dromaeo/cssquery-ext.html) 23:20:14 INFO - PROCESS | 28428 | RSS: Main: 320098304 23:20:14 INFO - PROCESS | 28428 | 23:23:16 INFO - PROCESS | 28428 | Cycle 1(1): loaded http://localhost:44084/tests/dromaeo/cssquery-ext.html (next: http://localhost:44084/tests/dromaeo/cssquery-jquery.html) 23:23:17 INFO - PROCESS | 28428 | RSS: Main: 271253504 23:23:17 INFO - PROCESS | 28428 | 23:26:19 INFO - PROCESS | 28428 | Cycle 1(1): loaded http://localhost:44084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44084/tests/dromaeo/cssquery-mootools.html) 23:26:20 INFO - PROCESS | 28428 | RSS: Main: 214769664 23:26:20 INFO - PROCESS | 28428 | 23:29:22 INFO - PROCESS | 28428 | Cycle 1(1): loaded http://localhost:44084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44084/tests/dromaeo/cssquery-prototype.html) 23:29:22 INFO - PROCESS | 28428 | RSS: Main: 253001728 23:29:22 INFO - PROCESS | 28428 | 23:32:25 INFO - PROCESS | 28428 | Cycle 1(1): loaded http://localhost:44084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44084/tests/dromaeo/cssquery-yui.html) 23:32:26 INFO - PROCESS | 28428 | RSS: Main: 220213248 23:32:26 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | Cycle 1(1): loaded http://localhost:44084/tests/dromaeo/cssquery-yui.html (next: http://localhost:44084/tests/dromaeo/cssquery-dojo.html) 23:35:29 INFO - PROCESS | 28428 | RSS: Main: 306995200 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | __start_tp_report 23:35:29 INFO - PROCESS | 28428 | _x_x_mozilla_page_load 23:35:29 INFO - PROCESS | 28428 | _x_x_mozilla_page_load_details 23:35:29 INFO - PROCESS | 28428 | |i|pagename|runs| 23:35:29 INFO - PROCESS | 28428 | |0;dojo.html;2968.836713980731;3004.3240270939054;3010.713982171694;3032.787704860658;3052.6184226971627;4936.111499930011;4955.430125535565;5130.743462826862;5200.869978250541;5222.0600291947385;5019.272205530196;5120.769565369558;5169.793208271674;5211.296474975878;5286.841394758163;4658.301254811789;4670.206064968964;4722.220833562458;4752.809887604491;4761.571458568728;4750.524947505239;4790.20961541347;4843.031393721252;4856.441509226449;4916.827911023115;4628.421447319085;4693.225617773063;4702.083093796711;4725.456572494173;4816.603185076341;4637.86086417408;4657.650676199265;4672.462666793328;4686.461056978457;4735.029318989599;4653.488116307203;4660.300954856764;4665.463471700764;4714.976425117887;4721.976390118062;5041.420236672793;5094.414142373637;5099.617528685363;5113.437521872591;5171.3535808024;5345.037893179227;5403.324584426947;5442.455754424565;5476.698781567012;5525.392206857243;5583.748731307101;5598.972005139989;5605.103183490622;5657.943420565783;5673.262475878109;5223.686578805284;5228;5229.372475302988;5231.032259032091;5293.391260005149;5488.204210389471;5518.310211223597;5540.833774986757;5672.773089076473;5685.204071430003;5377.811776587879;5392.757325920343;5408.810691625774;5458.4814442627885;5460.989716902386;5427.9185812212845;5462.535684466865;5475.041867673221;5481.068218402881;5483.287172667528;5152.149895267314;5165.225216217522;5460.781568737206;5462.399136095027;5464.9453505465235;5463.3717122530625;5495.395506494282;5498.477644623755;5554.472325129106;5627.606067575231;4244.427002354704;4300.0539881226705;4301.483821941387;4303.33298338758;4351.891202719958;3831.386978083549;3853.7109716771356;3877.379619260961;3880.3209438348176;3896.376579747227;5001.9499805002215;5043.218301163325;5147.047796157648;5163.535281824654;5172.793088276502;5416.377116631559;5453.127499600045;5456.83629491108;5460.399356070829;5498.202760599691;5159.097157997336;5172.818951336761;5173.818916337986;5178.637495375363;5240.868978275497;4599.793009314589;4622.19111655459;4640.118377508263;4658.254679251304;4674.0885527322525;5591.6365436246515;5594.608377413542;5596.300462442114;5599.552035837123;5647.3787883333625;5393.784248630011;5399.43305952885;5403.351597808131;5405.864853378697;5470.398256191896;5454.318210223722;5511.22842802016;5557.02752018387;5624.606277560531;5633.577481688808;5362.5441837442695;5378.919316210182;5397.676139431646;5410.567154627542;5446.373667028342;5471.890562188813;5477.72611369422;5481.671099734029;5491.0939694951485;5501.752421141138;5136.486351364833;5143.382794064736;5358.383785864676;5359.544438722596;5405.216243644728;5424.538914192338;5428.077226871363;5429.701366424727;5471.9726401369335;5486.149646804752;5335.973320133375;5363.329583802025;5367.114426119647;5373.731313434391;5412.918806217831;5151.613628977917;5187.4553171916405;5203.297554830049;5332.946670533245;5363.329583802025;5091.92362114576;5144.819931302386;5152.562032227303;5156.355455568054;5160.122779127482 23:35:29 INFO - PROCESS | 28428 | |1;ext.html;568.7781765111605;609.4088733928089;612.0543759890968;614.5298846382518;618.5299172628801;31283.374332513336;34360.48459273113;34609;34614.134646633785;34691.47962780554;34509.13727156822;42694.78652606733;43521.782391088076;43614;47281;8594.484330940148;8667.089955554671;8717.7820554486;8722.171393717586;8726.301895848317;8091.676332946675;8270.090290068089;8779.868301975475;8877.422967507091;10482.37105773656;10484.266101372907;10937.671869843878;10939.671809845717;10940.45297735114;10944.23390362675;10677.893221067807;10715.892841071607;10735;10765.30025548337;10771.084457821094;10548.050675439248;10622.734431639194;10626.193547097013;10627.41549214793;10637.095846853026;40697;40844;41070.589294106976;41110;41135.58864411347;3382.4080785862375;3698.5746639136573;3702.833372498244;3850.634189751969;4060.654844338235;31119.688803111905;31354.843225783727;31918.20204494883;32044.83977580097;32866.67133328684;4096.9795151024355;4182.623563879235;4266.594673506043;4384.254676704968;4417.867463976054;318851;320625;322449;322461;322931;34611.82694086564;55880;56110.26676798728;56188.43811561832;56242.71878640581;34063.829680851435;35668.28663426717;35870.103247418505;35948.82025589855;35987;14957.177355245349;15053.247337633074;15057.849421505864;15070.773938390932;15073.849261507465;12627.621171364874;12698.619041428772;12711.555095571795;12713.872861271453;12798.16811907223;7995.680172793023;8174.7956301092945;8390.538520381315;8523.70167044163;8603.956980215058;3287.901362959115;3294.068279231486;3367.343368043208;3375.8987230383127;3397.796132232074;991.2070343724992;1023.8464230365505;1027.2039169643438;1064.3720205079042;1126.79717650822;30438.391232175676;30631.38737225243;30971.380572388425;31296;31495.685043149275;1032.9690109296732;1043.4313299251926;1081.7403823082404;1115.782422427635;1135.182668478694;15569.766453503207;16506.2572184252;16594.66810663804;16603.41888033913;16834.66330673404;490816;495408;495467.3172877936;496880;497432;52663.736681316346;53737;55698.16452753212;56500.717496413075;56642.433575663716;1333.779926312167;1337.458329376604;1370.595674276091;1372.5470594703725;1375.5391943698974;29843.253918652208;31587.526187106752;31745;31796;32288.83855580707;50033.749831250614;50440.49559504358;50475.49524504855;50517;50544.747276263384;440120;440361;441089;442174.9933756288;442380;27491.450170996068;27867;28048;28102.578461323505;28358.71641283643;45885;46153.307700385194;46635;46820.7658961703;47303.526964729914;38318.23363532769;39129;39242.411363830135;39608.2078358437;40067.39898901577;37919.43120853134;38912.2217555653;39294;39428.40857387084;39777.80111099426;39179.608203917596;39194.608053919095;39431.60568394279;39620.2075958485;40399.39400909047;32453.837730811196;34693.30613387768;35362.46956295709;35395.46906796349;35563.28873422569;26658;26724.599131012663;26729.465410692068;26860.865695671397;27016.864915675294 23:35:29 INFO - PROCESS | 28428 | |2;jquery.html;373.29261050309645;377.33965560269496;402.7462698499946;402.97783621900794;423.82623124518955;13278.402471888765;15358.923205383971;16823.579410514743;19320.903395483005;19679.311224107125;18530.444086677388;18715.532111697215;18976.76651017683;19166;19243.807561924375;5708.514776244025;5708.543316534668;5933.080372542263;5937.584369094165;5952.077427998667;5863.706814659271;5907.793227237047;5951.613145145573;5958.344582095966;5963.4334738199805;5552.91670624941;5879.941200587982;5917.792877249297;5918.4673379395845;5920.052791553352;5750.712464376765;5847.970760146214;5859.589828711992;5873.060310350366;5878.088896221093;5631.662100273997;5661.801836935688;5663.008973429633;5880.529557635379;5953.404659534012;13028.283444410554;13053.34733263333;13084.672883177902;13288.800667989892;13294.800577991338;2323.477217626021;2332.265336419023;2447.6206188040883;2686.489566982267;2839.8640543782444;9316.8602470963;9356.157945784844;9620.663276785279;9822.557984890696;10032;1780.6260685256111;1863.636590864782;1878.182990399167;1911.8183772541586;1951.0342380521734;76230.61884690542;78890;80390.5980470094;82616.17383826144;82999.17000829974;9934.701958941243;10126.59493620247;10329.661542152315;10417.874637608687;10495;14237.501687441098;14265.928670356789;14277.500287489887;14285.214313212666;14313.427462901576;7659.234076592407;7974.681012759424;7982.08206056311;8112.1887811219585;8161.55111468863;7899.68401263943;7982.121966583672;8003.759887203393;8062.113167551564;8290.626921788535;4199.349100889367;4228.1966426378885;4233.322668373107;4282.229198744256;4334.26317526015;1733.523281097683;1824.5529845187748;1918.41488346053;1976.3280484635293;2007.1469625409143;795.7294519863274;903.4127816919055;940.3558562384789;942.4141142951137;1073.8335557988523;19441.51396215106;19760.70358944617;19800.207991680458;19926.402207933785;19986.500337491387;955.9187469065068;975.1516180922501;987.807377561383;998.4658207858761;1007.9798404032025;10149;10933.617323393642;11031.831232055923;11154.609588664358;11174.217804753589;437065;457555;491253;497755;502236;52082;58097.41902581005;58654;76412;96887;1009.6062535611118;1038.2576457832686;1082.7509672775307;1082.929609575391;1085.847981282621;16088.517344479684;17046.914765426092;17162.485125446256;17620;18330.175142118904;40222.79888600538;42091.15817683568;42419.7879010603;42614;43330.56669433265;55858;57255.71372143113;58677.413225867196;58789;59395.10907336307;7921.564313962787;8019.879701804594;8182;8408.873866892123;8414.83170336602;10896.782064358827;13214.405351759386;13253.867461325262;13433.529826456419;13611.931940340632;10672.199585031309;11160.497777599865;11543.711407214887;11811.291322520676;12177.269363838199;10995.560177592806;11579.247348922294;11895.881041189477;11908.404579770804;12257.570985015482;11622.244554103956;11708.063354931415;11795.469203885674;11889.34608596501;12041.397930103634;8191.549464779494;8290.58547072656;8308.916910831056;8312.459690120122;8640.56797160152;8923.375363724477;11339.829902551302;11670.649880503599;12227.877721222674;12271.202371845802 23:35:29 INFO - PROCESS | 28428 | |3;mootools.html;1275.738473612909;1351.5539871842293;1375.8005089262058;1723.7672914156585;1748.8426041656257;7574.35617972473;7835.569043702594;8076.878846817295;8662.393632445723;8672.696455624055;7910.525368477881;8170.101288858221;8182;8396.790080247996;8406;2299.298713892262;2324.244620498336;2329.04509151248;2330.0912644068826;2341.051873991028;2000.1799262302459;2051.5999380120884;2223.377454312795;2252.481929156295;2285.80570651494;2053.219776484934;2091.7385326834146;2244.3154837774473;2282.1898226129733;2298.37943755186;2269.909203631853;2271.4094335472732;2272.6477396003647;2276.1009401286483;2290.393045842853;2201.6037113319594;2253.763354847734;2254;2260.864348139117;2261.6494443361307;8613.095624959415;8677.956610216972;8678.826423471559;8681.348898832613;8693.913060869374;4823.493533179001;4994.126027945132;5015.724135172564;5027.648064635477;5029.7736601853;3180.538821870816;3241.675832416763;3370.8146051967133;3373.8070254334634;3389.0510657016075;1115.247208134514;1153.3598852636783;1166.9241499302518;1183.7573297473998;1203.8495188101488;11183;11199.272047316897;11219.38293393863;11245.269057511236;11253.381064041474;4241.406203131564;4269.829206831754;4385.254506733863;4437.090396468716;4511.390962220124;9480.288978326653;9489.952550237205;9494.28792840526;9496.762580935394;9532.666356677482;5124.871878203075;5127.66670166438;5128.512791284822;5133.4609865964285;5139.640225184276;4648.372469716613;4735.052989402134;4739.099571081552;4741.336212930192;4764.809407623726;3882.281777871103;3907.6873850091924;3918.4318273850704;3974.3839704845795;4015.217032678658;1201.3692811273977;1207.7705236005131;1229.0536287058915;1244.508419174439;1248.0701877101617;841.6296829395046;859.2910848549972;895.3106108296575;921.1433366968784;942.6700654770775;5388.838334849961;5403.189521571717;5488.121900495901;5489.725513724298;5568.610197286151;927.2350310993457;947.9526023698787;951.9524023798921;953.3088510829593;983.1299300119446;3504.404251277289;3664.8350824212976;3888.7861167635488;3891.124496988155;3934.3114954883354;10218.131458826083;10545.261831671709;10688.732781680364;10753.892461075446;10775.353478791298;10583.894161058444;10624.893751062546;10669.09312708413;10686.57253709843;10697.732556686145;7808.84382312362;8012.79968000793;8057.798555036054;8072.757817265491;8075.757727268309;5390.353157621111;5421.701806400686;5442.891142177214;5561.165825126263;5735.627184233012;9373.484458354857;9538.14156725898;9756.170725488413;9841.409515429097;9845.310828241954;9799.314048016571;9905.405675659484;9921.164584551881;9927.652532161339;10021.849672255068;7640.80897977555;7791.883121753065;7812.218778122142;7814.062312522534;7817.101033381006;8212.219839115274;8318.292945099734;8387.622556984828;8388.286995605442;8434.03008653988;7527.172011078667;7584.54492730438;7613.5431874087735;7631.427642926692;7812.218778122142;7096.148462184571;7120.430365570845;7126.536775109601;7195.316444937723;7262.273772622695;6704.497162712913;6717.496187786033;6860.5197636164985;6903.447724182154;6937.791866244021;4672.9532704673875;4722.698456999229;4798.136335459651;4802.4957379476045;4832.927506087482;4641.953580464152;4734.7632618369635;4755.38180036593;4793.304970779287;4875.414950205998 23:35:29 INFO - PROCESS | 28428 | |4;prototype.html;285.7911036316383;310.58381768430297;315.6228307172928;318.44272523084595;320.3097325264055;5087.44038155803;5224.84325470236;5285;5313;5360.356757189143;5157.819476318329;5241.371035475739;5286.894262114755;5301.6818990860575;5310.70791106489;4141.4409054777525;4155.047127849905;4180;4185.681510324253;4194.357554740509;3963.1677347757004;4030.9596904031023;4065.3901914712733;4120.629143377096;4187.1416359646355;4085.7130004048777;4094.61101195386;4100.958990410102;4103.651189648884;4113.71204015719;4097.959020409788;4108;4108;4120.17596480705;4122.2579935611575;3609.3290964686207;3639.8180090995343;3664.615215402371;3676.9448458273146;3679.2457546202963;5100.719460429675;5107.620942345583;5134.743262836843;5135.922961155586;5191.532762051395;4698.248280275174;4708.411448568929;4716.198246298138;4735.692180008288;4738.384010078702;5175.689458632456;5457.645253058538;5479.1781232815;5502.2296878437055;5552.139418390156;3933.9213215735813;3948.1116748731592;3968.7420317679257;3990.920181596352;3993.8402463901407;5770.105633626753;5784.07454807233;5788.652680839121;5811.593188476808;5818.5926985111055;3954.703397245218;3968.9603103969166;4074.6774338626697;4079.89800254996;4083.3670781028986;3998.4402183694306;4019.457373254632;4033.4353190553347;4035.7174997750462;4040.515138183378;4475.172093162775;4500.707454015478;4607.14767767964;4634.72191668501;4718.646101542398;5513.283273174462;5514.255575497256;5522.873693627982;5525.557955363642;5533.5849811263515;1367.3026756354332;1391.589481103077;1393.7212557488542;1394.4143459746729;1395.2326220578843;891.790429249126;895.3553441522093;896.551724137931;899.9460032398077;914.337105598449;4661;4712.246040633482;4714.952850471452;4720.371471842209;4723.95276047242;4960.107180707435;4960.437462199396;4960.727160006234;4968.751562421864;4973.179425394842;4423.867283981485;4698.412698412699;4719.976400117977;4742.52574742523;4747.548982846624;2659.5478768609382;2659.8936042558466;2675.304420850593;2686.9059582914897;2687.9059232927143;5079.339685840817;5143.871403214949;5182.693701302959;5184.637075404761;5194.948050519446;4867.758721525988;5052.837847295069;5086.338775959176;5098.1588037973315;5153.3815942087185;5070.771815268322;5097.069185218588;5098.464661210668;5101.566366858784;5149.819756308586;4933.802647894187;4940.097323114699;4962.503749625009;4979.800807967786;5016.824411145592;4716.056788642217;4821.566059054702;4887.315775791321;4927.457979622311;4935.593355893697;5104.132297509358;5114.693118412907;5138.023775482647;5148.43367229612;5152.433232344514;3622.185008373095;3633;3670.4677821716236;3673.7244706646575;3716.9964109690773;4674.789634466525;4943.65394422387;5016.4198277542455;5066.569341606005;5080.8221712241375;4830.203016502238;4837.564619184291;4854.053459575349;4864.148773964613;4867.318575399376;4839.443464001685;4848.369711937426;4854.271859221145;4859.88594961193;4876.95123048765;4445.022095139064;4771.73755443454;4795;4814.085323788469;4844.370231869834;4859.684120532154;4870.707757534559;4894.486078961801;4904.803807847647;4912.582430493448;4776.689515181502;4778.331033655221;4782.593479554138;4789.3055506952;4837.516248375135 23:35:29 INFO - PROCESS | 28428 | |5;yui.html;732.7691777090217;746.9701211951523;757.1406453675077;780.2860382749784;793.9285464308213;15287.541373758791;15795.289211985459;15900.886937914336;15906.363745450197;15983.84016159838;14356.856431435683;14823.703525929503;14866.256687165653;14909.627259318522;14972.850271497282;793.1077537770024;813.7355359508153;816.6202715737181;816.6365967144623;817.199144838059;807.8667019941703;809.4981111710719;810.116972499975;810.1372038778711;810.266708628692;853.0829358439671;854.218390172991;854.8546747052985;855.4909828651943;855.8758979947904;848.9787755306166;848.9872651910226;849.2908421468081;849.4393700157866;849.4903058165082;628.8019273928697;629.4555209743585;629.6473974574208;629.7606909374455;629.7701339011273;13817;14276.428942842274;14430.20633865137;14432.278386080654;14522.273886305748;12999.935000325033;13007.674808129872;13167.934160329232;13392.598222053353;13552;10941.945290273497;10969.451527423596;11045.723856903562;11197.104231661448;11431.199816012882;3716.646918542734;3789.1663833956486;3934.8229329680235;3968;3970.344893092665;49820.750896245285;51223.48776512224;65186;67715.32284677139;72083;11534.884651153548;11890.28658280506;11948.163628545919;12199.268043917216;12648.936755316165;22369;22415.887920560617;22438.663420048713;22491.32526024189;22611;8444.746657600283;8700.912990870136;8793.20861122502;8975.50634715097;9017.81964360709;4461.955380446154;4499.865004049884;4526.79629416677;4635.049814787961;4758.714477131383;3681.4293784463453;3868.980655096763;3928.017995501125;3929.135590170158;3936.0553467167674;635.7202830754453;636.7357546618194;637.6365471681097;653.9149910511603;667.4026746062248;701.6632016632045;709.4359983812881;730.3828265115968;740.8960648633605;743.5464366736287;9867;9940.701778946643;10016.298859079794;10082.59669613222;10212.540435680412;708.9858202835915;715.492000679513;729.2488736601309;732.7142414458366;737.3437640499959;4521.276595744665;4568.497465278817;4878.658493905464;4969.768986125179;4976.129177393942;65528.051237693464;69524;78773.60613196898;127962;132450;102182.48908755557;106464.46767766112;107319.4634026825;107867;111999;56940;74610.62694686491;76135;87476.12523874806;89255;9986.500674966368;10480.266381353233;10495.475226238505;10622.20333474977;10626.946865265934;50063.49936500588;52213;52590;52946;53846.461535385715;43653.12693746171;43974.340384893614;67837.6608116976;73176.63411682908;73954;12654.177478463871;12764.936175319064;13258.204507729568;13645.931770341482;13843.930780346034;14568.543145685771;14680.853191468375;14881.702365952837;14972.7005459888;15839.762403564186;13725.725485490433;14040.929795350958;14059.437622494986;14318.928405357907;14762.261886905826;13486.190828550318;13614.93192534031;14116.858831411555;14177.43290268419;14579;13304.667383315495;14255.857441425867;14274.436594194134;14727.190004549853;14733.852661473247;11093.722656933642;11247.887521124683;11492.712682183012;11923.642290730944;12202.694932626755;11218.83171752408;11349.375784331942;11752.412379381169;12095.637130886087;12179.573714919936 23:35:29 INFO - PROCESS | 28428 | __end_tp_report 23:35:29 INFO - PROCESS | 28428 | __start_cc_report 23:35:29 INFO - PROCESS | 28428 | _x_x_mozilla_cycle_collect,1476 23:35:29 INFO - PROCESS | 28428 | __end_cc_report 23:35:29 INFO - PROCESS | 28428 | __startTimestamp1476686129572__endTimestamp 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | ------- Summary: start ------- 23:35:29 INFO - PROCESS | 28428 | Number of tests: 6 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | [#0] dojo.html Cycles:165 Average:5094.85 Median:5229.37 stddev:548.44 (10.5%) stddev-sans-first:524.15 23:35:29 INFO - PROCESS | 28428 | Values: 2968.8 3004.3 3010.7 3032.8 3052.6 4936.1 4955.4 5130.7 5200.9 5222.1 5019.3 5120.8 5169.8 5211.3 5286.8 4658.3 4670.2 4722.2 4752.8 4761.6 4750.5 4790.2 4843.0 4856.4 4916.8 4628.4 4693.2 4702.1 4725.5 4816.6 4637.9 4657.7 4672.5 4686.5 4735.0 4653.5 4660.3 4665.5 4715.0 4722.0 5041.4 5094.4 5099.6 5113.4 5171.4 5345.0 5403.3 5442.5 5476.7 5525.4 5583.7 5599.0 5605.1 5657.9 5673.3 5223.7 5228.0 5229.4 5231.0 5293.4 5488.2 5518.3 5540.8 5672.8 5685.2 5377.8 5392.8 5408.8 5458.5 5461.0 5427.9 5462.5 5475.0 5481.1 5483.3 5152.1 5165.2 5460.8 5462.4 5464.9 5463.4 5495.4 5498.5 5554.5 5627.6 4244.4 4300.1 4301.5 4303.3 4351.9 3831.4 3853.7 3877.4 3880.3 3896.4 5001.9 5043.2 5147.0 5163.5 5172.8 5416.4 5453.1 5456.8 5460.4 5498.2 5159.1 5172.8 5173.8 5178.6 5240.9 4599.8 4622.2 4640.1 4658.3 4674.1 5591.6 5594.6 5596.3 5599.6 5647.4 5393.8 5399.4 5403.4 5405.9 5470.4 5454.3 5511.2 5557.0 5624.6 5633.6 5362.5 5378.9 5397.7 5410.6 5446.4 5471.9 5477.7 5481.7 5491.1 5501.8 5136.5 5143.4 5358.4 5359.5 5405.2 5424.5 5428.1 5429.7 5472.0 5486.1 5336.0 5363.3 5367.1 5373.7 5412.9 5151.6 5187.5 5203.3 5332.9 5363.3 5091.9 5144.8 5152.6 5156.4 5160.1 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | [#1] ext.html Cycles:180 Average:56494.64 Median:35027.89 stddev:112901.38 (322.3%) stddev-sans-first:113140.01 23:35:29 INFO - PROCESS | 28428 | Values: 568.8 609.4 612.1 614.5 618.5 31283.4 34360.5 34609.0 34614.1 34691.5 34509.1 42694.8 43521.8 43614.0 47281.0 8594.5 8667.1 8717.8 8722.2 8726.3 8091.7 8270.1 8779.9 8877.4 10482.4 10484.3 10937.7 10939.7 10940.5 10944.2 10677.9 10715.9 10735.0 10765.3 10771.1 10548.1 10622.7 10626.2 10627.4 10637.1 40697.0 40844.0 41070.6 41110.0 41135.6 3382.4 3698.6 3702.8 3850.6 4060.7 31119.7 31354.8 31918.2 32044.8 32866.7 4097.0 4182.6 4266.6 4384.3 4417.9 318851.0 320625.0 322449.0 322461.0 322931.0 34611.8 55880.0 56110.3 56188.4 56242.7 34063.8 35668.3 35870.1 35948.8 35987.0 14957.2 15053.2 15057.8 15070.8 15073.8 12627.6 12698.6 12711.6 12713.9 12798.2 7995.7 8174.8 8390.5 8523.7 8604.0 3287.9 3294.1 3367.3 3375.9 3397.8 991.2 1023.8 1027.2 1064.4 1126.8 30438.4 30631.4 30971.4 31296.0 31495.7 1033.0 1043.4 1081.7 1115.8 1135.2 15569.8 16506.3 16594.7 16603.4 16834.7 490816.0 495408.0 495467.3 496880.0 497432.0 52663.7 53737.0 55698.2 56500.7 56642.4 1333.8 1337.5 1370.6 1372.5 1375.5 29843.3 31587.5 31745.0 31796.0 32288.8 50033.7 50440.5 50475.5 50517.0 50544.7 440120.0 440361.0 441089.0 442175.0 442380.0 27491.5 27867.0 28048.0 28102.6 28358.7 45885.0 46153.3 46635.0 46820.8 47303.5 38318.2 39129.0 39242.4 39608.2 40067.4 37919.4 38912.2 39294.0 39428.4 39777.8 39179.6 39194.6 39431.6 39620.2 40399.4 32453.8 34693.3 35362.5 35395.5 35563.3 26658.0 26724.6 26729.5 26860.9 27016.9 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | [#2] jquery.html Cycles:180 Average:27552.59 Median:22211.07 stddev:78526.30 (353.5%) stddev-sans-first:78720.07 23:35:29 INFO - PROCESS | 28428 | Values: 373.3 377.3 402.7 403.0 423.8 13278.4 15358.9 16823.6 19320.9 19679.3 18530.4 18715.5 18976.8 19166.0 19243.8 5708.5 5708.5 5933.1 5937.6 5952.1 5863.7 5907.8 5951.6 5958.3 5963.4 5552.9 5879.9 5917.8 5918.5 5920.1 5750.7 5848.0 5859.6 5873.1 5878.1 5631.7 5661.8 5663.0 5880.5 5953.4 13028.3 13053.3 13084.7 13288.8 13294.8 2323.5 2332.3 2447.6 2686.5 2839.9 9316.9 9356.2 9620.7 9822.6 10032.0 1780.6 1863.6 1878.2 1911.8 1951.0 76230.6 78890.0 80390.6 82616.2 82999.2 9934.7 10126.6 10329.7 10417.9 10495.0 14237.5 14265.9 14277.5 14285.2 14313.4 7659.2 7974.7 7982.1 8112.2 8161.6 7899.7 7982.1 8003.8 8062.1 8290.6 4199.3 4228.2 4233.3 4282.2 4334.3 1733.5 1824.6 1918.4 1976.3 2007.1 795.7 903.4 940.4 942.4 1073.8 19441.5 19760.7 19800.2 19926.4 19986.5 955.9 975.2 987.8 998.5 1008.0 10149.0 10933.6 11031.8 11154.6 11174.2 437065.0 457555.0 491253.0 497755.0 502236.0 52082.0 58097.4 58654.0 76412.0 96887.0 1009.6 1038.3 1082.8 1082.9 1085.8 16088.5 17046.9 17162.5 17620.0 18330.2 40222.8 42091.2 42419.8 42614.0 43330.6 55858.0 57255.7 58677.4 58789.0 59395.1 7921.6 8019.9 8182.0 8408.9 8414.8 10896.8 13214.4 13253.9 13433.5 13611.9 10672.2 11160.5 11543.7 11811.3 12177.3 10995.6 11579.2 11895.9 11908.4 12257.6 11622.2 11708.1 11795.5 11889.3 12041.4 8191.5 8290.6 8308.9 8312.5 8640.6 8923.4 11339.8 11670.6 12227.9 12271.2 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | [#3] mootools.html Cycles:180 Average:5556.04 Median:4854.17 stddev:3141.70 (64.7%) stddev-sans-first:3134.05 23:35:29 INFO - PROCESS | 28428 | Values: 1275.7 1351.6 1375.8 1723.8 1748.8 7574.4 7835.6 8076.9 8662.4 8672.7 7910.5 8170.1 8182.0 8396.8 8406.0 2299.3 2324.2 2329.0 2330.1 2341.1 2000.2 2051.6 2223.4 2252.5 2285.8 2053.2 2091.7 2244.3 2282.2 2298.4 2269.9 2271.4 2272.6 2276.1 2290.4 2201.6 2253.8 2254.0 2260.9 2261.6 8613.1 8678.0 8678.8 8681.3 8693.9 4823.5 4994.1 5015.7 5027.6 5029.8 3180.5 3241.7 3370.8 3373.8 3389.1 1115.2 1153.4 1166.9 1183.8 1203.8 11183.0 11199.3 11219.4 11245.3 11253.4 4241.4 4269.8 4385.3 4437.1 4511.4 9480.3 9490.0 9494.3 9496.8 9532.7 5124.9 5127.7 5128.5 5133.5 5139.6 4648.4 4735.1 4739.1 4741.3 4764.8 3882.3 3907.7 3918.4 3974.4 4015.2 1201.4 1207.8 1229.1 1244.5 1248.1 841.6 859.3 895.3 921.1 942.7 5388.8 5403.2 5488.1 5489.7 5568.6 927.2 948.0 952.0 953.3 983.1 3504.4 3664.8 3888.8 3891.1 3934.3 10218.1 10545.3 10688.7 10753.9 10775.4 10583.9 10624.9 10669.1 10686.6 10697.7 7808.8 8012.8 8057.8 8072.8 8075.8 5390.4 5421.7 5442.9 5561.2 5735.6 9373.5 9538.1 9756.2 9841.4 9845.3 9799.3 9905.4 9921.2 9927.7 10021.8 7640.8 7791.9 7812.2 7814.1 7817.1 8212.2 8318.3 8387.6 8388.3 8434.0 7527.2 7584.5 7613.5 7631.4 7812.2 7096.1 7120.4 7126.5 7195.3 7262.3 6704.5 6717.5 6860.5 6903.4 6937.8 4673.0 4722.7 4798.1 4802.5 4832.9 4642.0 4734.8 4755.4 4793.3 4875.4 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | [#4] prototype.html Cycles:180 Average:4346.07 Median:4825.88 stddev:1223.99 (25.4%) stddev-sans-first:1188.88 23:35:29 INFO - PROCESS | 28428 | Values: 285.8 310.6 315.6 318.4 320.3 5087.4 5224.8 5285.0 5313.0 5360.4 5157.8 5241.4 5286.9 5301.7 5310.7 4141.4 4155.0 4180.0 4185.7 4194.4 3963.2 4031.0 4065.4 4120.6 4187.1 4085.7 4094.6 4101.0 4103.7 4113.7 4098.0 4108.0 4108.0 4120.2 4122.3 3609.3 3639.8 3664.6 3676.9 3679.2 5100.7 5107.6 5134.7 5135.9 5191.5 4698.2 4708.4 4716.2 4735.7 4738.4 5175.7 5457.6 5479.2 5502.2 5552.1 3933.9 3948.1 3968.7 3990.9 3993.8 5770.1 5784.1 5788.7 5811.6 5818.6 3954.7 3969.0 4074.7 4079.9 4083.4 3998.4 4019.5 4033.4 4035.7 4040.5 4475.2 4500.7 4607.1 4634.7 4718.6 5513.3 5514.3 5522.9 5525.6 5533.6 1367.3 1391.6 1393.7 1394.4 1395.2 891.8 895.4 896.6 899.9 914.3 4661.0 4712.2 4715.0 4720.4 4724.0 4960.1 4960.4 4960.7 4968.8 4973.2 4423.9 4698.4 4720.0 4742.5 4747.5 2659.5 2659.9 2675.3 2686.9 2687.9 5079.3 5143.9 5182.7 5184.6 5194.9 4867.8 5052.8 5086.3 5098.2 5153.4 5070.8 5097.1 5098.5 5101.6 5149.8 4933.8 4940.1 4962.5 4979.8 5016.8 4716.1 4821.6 4887.3 4927.5 4935.6 5104.1 5114.7 5138.0 5148.4 5152.4 3622.2 3633.0 3670.5 3673.7 3717.0 4674.8 4943.7 5016.4 5066.6 5080.8 4830.2 4837.6 4854.1 4864.1 4867.3 4839.4 4848.4 4854.3 4859.9 4877.0 4445.0 4771.7 4795.0 4814.1 4844.4 4859.7 4870.7 4894.5 4904.8 4912.6 4776.7 4778.3 4782.6 4789.3 4837.5 23:35:29 INFO - PROCESS | 28428 | 23:35:29 INFO - PROCESS | 28428 | [#5] yui.html Cycles:180 Average:19549.98 Median:3935.44 stddev:27619.75 (701.8%) stddev-sans-first:27661.09 23:35:29 INFO - PROCESS | 28428 | Values: 732.8 747.0 757.1 780.3 793.9 15287.5 15795.3 15900.9 15906.4 15983.8 14356.9 14823.7 14866.3 14909.6 14972.9 793.1 813.7 816.6 816.6 817.2 807.9 809.5 810.1 810.1 810.3 853.1 854.2 854.9 855.5 855.9 849.0 849.0 849.3 849.4 849.5 628.8 629.5 629.6 629.8 629.8 13817.0 14276.4 14430.2 14432.3 14522.3 12999.9 13007.7 13167.9 13392.6 13552.0 10941.9 10969.5 11045.7 11197.1 11431.2 3716.6 3789.2 3934.8 3968.0 3970.3 49820.8 51223.5 65186.0 67715.3 72083.0 11534.9 11890.3 11948.2 12199.3 12648.9 22369.0 22415.9 22438.7 22491.3 22611.0 8444.7 8700.9 8793.2 8975.5 9017.8 4462.0 4499.9 4526.8 4635.0 4758.7 3681.4 3869.0 3928.0 3929.1 3936.1 635.7 636.7 637.6 653.9 667.4 701.7 709.4 730.4 740.9 743.5 9867.0 9940.7 10016.3 10082.6 10212.5 709.0 715.5 729.2 732.7 737.3 4521.3 4568.5 4878.7 4969.8 4976.1 65528.1 69524.0 78773.6 127962.0 132450.0 102182.5 106464.5 107319.5 107867.0 111999.0 56940.0 74610.6 76135.0 87476.1 89255.0 9986.5 10480.3 10495.5 10622.2 10626.9 50063.5 52213.0 52590.0 52946.0 53846.5 43653.1 43974.3 67837.7 73176.6 73954.0 12654.2 12764.9 13258.2 13645.9 13843.9 14568.5 14680.9 14881.7 14972.7 15839.8 13725.7 14040.9 14059.4 14318.9 14762.3 13486.2 13614.9 14116.9 14177.4 14579.0 13304.7 14255.9 14274.4 14727.2 14733.9 11093.7 11247.9 11492.7 11923.6 12202.7 11218.8 11349.4 11752.4 12095.6 12179.6 23:35:29 INFO - PROCESS | 28428 | -------- Summary: end -------- 23:35:29 INFO - PROCESS | 28428 | 23:35:30 INFO - TEST-INFO | 28428: exit 0 23:35:30 INFO - TEST-OK | dromaeo_css | took 1117224ms 23:35:30 INFO - TEST-START | kraken 23:35:30 INFO - operating with platform_type : linux_ 23:35:30 INFO - Initialising browser for kraken test... 23:35:30 INFO - TEST-INFO | started process 28739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIojVU/profile http://localhost:44084/getInfo.html) 23:35:34 INFO - PROCESS | 28739 | __metrics Screen width/height:1600/1200 23:35:34 INFO - PROCESS | 28739 | colorDepth:24 23:35:34 INFO - PROCESS | 28739 | Browser inner width/height: 1024/697 23:35:34 INFO - PROCESS | 28739 | __metrics 23:35:35 INFO - PROCESS | 28739 | 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" 23:35:35 INFO - PROCESS | 28739 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:35:35 INFO - PROCESS | 28739 | console.error: PushService: 23:35:35 INFO - PROCESS | 28739 | stateChangeProcessEnqueue: Error transitioning state 23:35:35 INFO - PROCESS | 28739 | UnknownError 23:35:36 INFO - TEST-INFO | 28739: exit 0 23:35:36 INFO - Browser initialized. 23:35:36 INFO - Running cycle 1/1 for kraken test... 23:35:36 INFO - TEST-INFO | started process 28821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIojVU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:35:48 INFO - PROCESS | 28821 | RSS: Main: 173608960 23:35:48 INFO - PROCESS | 28821 | 23:35:51 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44084/tests/kraken/driver.html?testName=audio-beat-detection) 23:35:51 INFO - PROCESS | 28821 | RSS: Main: 232235008 23:35:51 INFO - PROCESS | 28821 | 23:35:54 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44084/tests/kraken/driver.html?testName=audio-dft) 23:35:55 INFO - PROCESS | 28821 | RSS: Main: 217223168 23:35:55 INFO - PROCESS | 28821 | 23:35:58 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44084/tests/kraken/driver.html?testName=audio-fft) 23:35:58 INFO - PROCESS | 28821 | RSS: Main: 299433984 23:35:58 INFO - PROCESS | 28821 | 23:36:01 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44084/tests/kraken/driver.html?testName=audio-oscillator) 23:36:01 INFO - PROCESS | 28821 | RSS: Main: 206893056 23:36:01 INFO - PROCESS | 28821 | 23:36:03 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:04 INFO - PROCESS | 28821 | RSS: Main: 212549632 23:36:04 INFO - PROCESS | 28821 | 23:36:07 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44084/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:08 INFO - PROCESS | 28821 | RSS: Main: 249196544 23:36:08 INFO - PROCESS | 28821 | 23:36:11 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44084/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:11 INFO - PROCESS | 28821 | RSS: Main: 248287232 23:36:11 INFO - PROCESS | 28821 | 23:36:14 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44084/tests/kraken/driver.html?testName=json-parse-financial) 23:36:15 INFO - PROCESS | 28821 | RSS: Main: 248373248 23:36:15 INFO - PROCESS | 28821 | 23:36:16 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:17 INFO - PROCESS | 28821 | RSS: Main: 210038784 23:36:17 INFO - PROCESS | 28821 | 23:36:19 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:19 INFO - PROCESS | 28821 | RSS: Main: 217194496 23:36:19 INFO - PROCESS | 28821 | 23:36:21 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:22 INFO - PROCESS | 28821 | RSS: Main: 226406400 23:36:22 INFO - PROCESS | 28821 | 23:36:25 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:25 INFO - PROCESS | 28821 | RSS: Main: 234692608 23:36:25 INFO - PROCESS | 28821 | 23:36:28 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:29 INFO - PROCESS | 28821 | RSS: Main: 231522304 23:36:29 INFO - PROCESS | 28821 | 23:36:30 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:44084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44084/tests/kraken/driver.html?testName=ai-astar) 23:36:31 INFO - PROCESS | 28821 | RSS: Main: 281174016 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | __start_tp_report 23:36:31 INFO - PROCESS | 28821 | _x_x_mozilla_page_load 23:36:31 INFO - PROCESS | 28821 | _x_x_mozilla_page_load_details 23:36:31 INFO - PROCESS | 28821 | |i|pagename|runs| 23:36:31 INFO - PROCESS | 28821 | |0;ai-astar;109;111;111;111;112;110;112;112;112;111 23:36:31 INFO - PROCESS | 28821 | |1;audio-beat-detection;153;121;122;164;122;134;127;127;160;121 23:36:31 INFO - PROCESS | 28821 | |2;audio-dft;161;160;159;161;160;160;161;160;160;160 23:36:31 INFO - PROCESS | 28821 | |3;audio-fft;76;76;76;107;75;75;75;74;97;76 23:36:31 INFO - PROCESS | 28821 | |4;audio-oscillator;83;83;125;83;82;83;111;83;83;114 23:36:31 INFO - PROCESS | 28821 | |5;imaging-gaussian-blur;118;117;117;116;116;116;116;117;116;117 23:36:31 INFO - PROCESS | 28821 | |6;imaging-darkroom;146;146;146;146;147;146;145;146;146;147 23:36:31 INFO - PROCESS | 28821 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 23:36:31 INFO - PROCESS | 28821 | |8;json-parse-financial;52;51;51;52;54;53;53;53;53;54 23:36:31 INFO - PROCESS | 28821 | |9;json-stringify-tinderbox;60;61;60;61;61;61;62;61;61;61 23:36:31 INFO - PROCESS | 28821 | |10;stanford-crypto-aes;80;80;78;79;80;88;80;79;79;87 23:36:31 INFO - PROCESS | 28821 | |11;stanford-crypto-ccm;146;132;140;129;141;132;132;128;175;127 23:36:31 INFO - PROCESS | 28821 | |12;stanford-crypto-pbkdf2;165;165;164;165;172;171;168;168;164;165 23:36:31 INFO - PROCESS | 28821 | |13;stanford-crypto-sha256-iterative;66;66;67;65;65;65;64;64;66;64 23:36:31 INFO - PROCESS | 28821 | __end_tp_report 23:36:31 INFO - PROCESS | 28821 | __start_cc_report 23:36:31 INFO - PROCESS | 28821 | _x_x_mozilla_cycle_collect,1735 23:36:31 INFO - PROCESS | 28821 | __end_cc_report 23:36:31 INFO - PROCESS | 28821 | __startTimestamp1476686191141__endTimestamp 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | ------- Summary: start ------- 23:36:31 INFO - PROCESS | 28821 | Number of tests: 14 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:0.99 (0.9%) stddev-sans-first:0.71 23:36:31 INFO - PROCESS | 28821 | Values: 109.0 111.0 111.0 111.0 112.0 110.0 112.0 112.0 112.0 111.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:130.50 stddev:17.16 (13.1%) stddev-sans-first:16.93 23:36:31 INFO - PROCESS | 28821 | Values: 153.0 121.0 122.0 164.0 122.0 134.0 127.0 127.0 160.0 121.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 23:36:31 INFO - PROCESS | 28821 | Values: 161.0 160.0 159.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:11.49 (15.1%) stddev-sans-first:12.06 23:36:31 INFO - PROCESS | 28821 | Values: 76.0 76.0 76.0 107.0 75.0 75.0 75.0 74.0 97.0 76.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:16.70 (20.1%) stddev-sans-first:17.32 23:36:31 INFO - PROCESS | 28821 | Values: 83.0 83.0 125.0 83.0 82.0 83.0 111.0 83.0 83.0 114.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 23:36:31 INFO - PROCESS | 28821 | Values: 118.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 23:36:31 INFO - PROCESS | 28821 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 147.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:36:31 INFO - PROCESS | 28821 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 23:36:31 INFO - PROCESS | 28821 | Values: 52.0 51.0 51.0 52.0 54.0 53.0 53.0 53.0 53.0 54.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 23:36:31 INFO - PROCESS | 28821 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:3.50 (4.4%) stddev-sans-first:3.69 23:36:31 INFO - PROCESS | 28821 | Values: 80.0 80.0 78.0 79.0 80.0 88.0 80.0 79.0 79.0 87.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:136.00 stddev:14.36 (10.6%) stddev-sans-first:14.95 23:36:31 INFO - PROCESS | 28821 | Values: 146.0 132.0 140.0 129.0 141.0 132.0 132.0 128.0 175.0 127.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.50 stddev:2.91 (1.7%) stddev-sans-first:3.02 23:36:31 INFO - PROCESS | 28821 | Values: 165.0 165.0 164.0 165.0 172.0 171.0 168.0 168.0 164.0 165.0 23:36:31 INFO - PROCESS | 28821 | 23:36:31 INFO - PROCESS | 28821 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 23:36:31 INFO - PROCESS | 28821 | Values: 66.0 66.0 67.0 65.0 65.0 65.0 64.0 64.0 66.0 64.0 23:36:31 INFO - PROCESS | 28821 | -------- Summary: end -------- 23:36:31 INFO - PROCESS | 28821 | 23:36:32 INFO - TEST-INFO | 28821: exit 0 23:36:32 INFO - TEST-OK | kraken | took 61770ms 23:36:32 INFO - SUITE-END | took 1178s 23:36:32 INFO - Completed test suite (00:19:39) 23:36:32 INFO - javascript benchmark 23:36:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2968.836713980731, 3004.3240270939054, 3010.713982171694, 3032.787704860658, 3052.6184226971627, 4936.111499930011, 4955.430125535565, 5130.743462826862, 5200.869978250541, 5222.0600291947385, 5019.272205530196, 5120.769565369558, 5169.793208271674, 5211.296474975878, 5286.841394758163, 4658.301254811789, 4670.206064968964, 4722.220833562458, 4752.809887604491, 4761.571458568728, 4750.524947505239, 4790.20961541347, 4843.031393721252, 4856.441509226449, 4916.827911023115, 4628.421447319085, 4693.225617773063, 4702.083093796711, 4725.456572494173, 4816.603185076341, 4637.86086417408, 4657.650676199265, 4672.462666793328, 4686.461056978457, 4735.029318989599, 4653.488116307203, 4660.300954856764, 4665.463471700764, 4714.976425117887, 4721.976390118062, 5041.420236672793, 5094.414142373637, 5099.617528685363, 5113.437521872591, 5171.3535808024, 5345.037893179227, 5403.324584426947, 5442.455754424565, 5476.698781567012, 5525.392206857243, 5583.748731307101, 5598.972005139989, 5605.103183490622, 5657.943420565783, 5673.262475878109, 5223.686578805284, 5228.0, 5229.372475302988, 5231.032259032091, 5293.391260005149, 5488.204210389471, 5518.310211223597, 5540.833774986757, 5672.773089076473, 5685.204071430003, 5377.811776587879, 5392.757325920343, 5408.810691625774, 5458.4814442627885, 5460.989716902386, 5427.9185812212845, 5462.535684466865, 5475.041867673221, 5481.068218402881, 5483.287172667528, 5152.149895267314, 5165.225216217522, 5460.781568737206, 5462.399136095027, 5464.9453505465235, 5463.3717122530625, 5495.395506494282, 5498.477644623755, 5554.472325129106, 5627.606067575231, 4244.427002354704, 4300.0539881226705, 4301.483821941387, 4303.33298338758, 4351.891202719958, 3831.386978083549, 3853.7109716771356, 3877.379619260961, 3880.3209438348176, 3896.376579747227, 5001.9499805002215, 5043.218301163325, 5147.047796157648, 5163.535281824654, 5172.793088276502, 5416.377116631559, 5453.127499600045, 5456.83629491108, 5460.399356070829, 5498.202760599691, 5159.097157997336, 5172.818951336761, 5173.818916337986, 5178.637495375363, 5240.868978275497, 4599.793009314589, 4622.19111655459, 4640.118377508263, 4658.254679251304, 4674.0885527322525, 5591.6365436246515, 5594.608377413542, 5596.300462442114, 5599.552035837123, 5647.3787883333625, 5393.784248630011, 5399.43305952885, 5403.351597808131, 5405.864853378697, 5470.398256191896, 5454.318210223722, 5511.22842802016, 5557.02752018387, 5624.606277560531, 5633.577481688808, 5362.5441837442695, 5378.919316210182, 5397.676139431646, 5410.567154627542, 5446.373667028342, 5471.890562188813, 5477.72611369422, 5481.671099734029, 5491.0939694951485, 5501.752421141138, 5136.486351364833, 5143.382794064736, 5358.383785864676, 5359.544438722596, 5405.216243644728, 5424.538914192338, 5428.077226871363, 5429.701366424727, 5471.9726401369335, 5486.149646804752, 5335.973320133375, 5363.329583802025, 5367.114426119647, 5373.731313434391, 5412.918806217831, 5151.613628977917, 5187.4553171916405, 5203.297554830049, 5332.946670533245, 5363.329583802025, 5091.92362114576, 5144.819931302386, 5152.562032227303, 5156.355455568054, 5160.122779127482], "value": 5059.959093576576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7781765111605, 609.4088733928089, 612.0543759890968, 614.5298846382518, 618.5299172628801, 31283.374332513336, 34360.48459273113, 34609.0, 34614.134646633785, 34691.47962780554, 34509.13727156822, 42694.78652606733, 43521.782391088076, 43614.0, 47281.0, 8594.484330940148, 8667.089955554671, 8717.7820554486, 8722.171393717586, 8726.301895848317, 8091.676332946675, 8270.090290068089, 8779.868301975475, 8877.422967507091, 10482.37105773656, 10484.266101372907, 10937.671869843878, 10939.671809845717, 10940.45297735114, 10944.23390362675, 10677.893221067807, 10715.892841071607, 10735.0, 10765.30025548337, 10771.084457821094, 10548.050675439248, 10622.734431639194, 10626.193547097013, 10627.41549214793, 10637.095846853026, 40697.0, 40844.0, 41070.589294106976, 41110.0, 41135.58864411347, 3382.4080785862375, 3698.5746639136573, 3702.833372498244, 3850.634189751969, 4060.654844338235, 31119.688803111905, 31354.843225783727, 31918.20204494883, 32044.83977580097, 32866.67133328684, 4096.9795151024355, 4182.623563879235, 4266.594673506043, 4384.254676704968, 4417.867463976054, 318851.0, 320625.0, 322449.0, 322461.0, 322931.0, 34611.82694086564, 55880.0, 56110.26676798728, 56188.43811561832, 56242.71878640581, 34063.829680851435, 35668.28663426717, 35870.103247418505, 35948.82025589855, 35987.0, 14957.177355245349, 15053.247337633074, 15057.849421505864, 15070.773938390932, 15073.849261507465, 12627.621171364874, 12698.619041428772, 12711.555095571795, 12713.872861271453, 12798.16811907223, 7995.680172793023, 8174.7956301092945, 8390.538520381315, 8523.70167044163, 8603.956980215058, 3287.901362959115, 3294.068279231486, 3367.343368043208, 3375.8987230383127, 3397.796132232074, 991.2070343724992, 1023.8464230365505, 1027.2039169643438, 1064.3720205079042, 1126.79717650822, 30438.391232175676, 30631.38737225243, 30971.380572388425, 31296.0, 31495.685043149275, 1032.9690109296732, 1043.4313299251926, 1081.7403823082404, 1115.782422427635, 1135.182668478694, 15569.766453503207, 16506.2572184252, 16594.66810663804, 16603.41888033913, 16834.66330673404, 490816.0, 495408.0, 495467.3172877936, 496880.0, 497432.0, 52663.736681316346, 53737.0, 55698.16452753212, 56500.717496413075, 56642.433575663716, 1333.779926312167, 1337.458329376604, 1370.595674276091, 1372.5470594703725, 1375.5391943698974, 29843.253918652208, 31587.526187106752, 31745.0, 31796.0, 32288.83855580707, 50033.749831250614, 50440.49559504358, 50475.49524504855, 50517.0, 50544.747276263384, 440120.0, 440361.0, 441089.0, 442174.9933756288, 442380.0, 27491.450170996068, 27867.0, 28048.0, 28102.578461323505, 28358.71641283643, 45885.0, 46153.307700385194, 46635.0, 46820.7658961703, 47303.526964729914, 38318.23363532769, 39129.0, 39242.411363830135, 39608.2078358437, 40067.39898901577, 37919.43120853134, 38912.2217555653, 39294.0, 39428.40857387084, 39777.80111099426, 39179.608203917596, 39194.608053919095, 39431.60568394279, 39620.2075958485, 40399.39400909047, 32453.837730811196, 34693.30613387768, 35362.46956295709, 35395.46906796349, 35563.28873422569, 26658.0, 26724.599131012663, 26729.465410692068, 26860.865695671397, 27016.864915675294], "value": 18689.937625430495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.29261050309645, 377.33965560269496, 402.7462698499946, 402.97783621900794, 423.82623124518955, 13278.402471888765, 15358.923205383971, 16823.579410514743, 19320.903395483005, 19679.311224107125, 18530.444086677388, 18715.532111697215, 18976.76651017683, 19166.0, 19243.807561924375, 5708.514776244025, 5708.543316534668, 5933.080372542263, 5937.584369094165, 5952.077427998667, 5863.706814659271, 5907.793227237047, 5951.613145145573, 5958.344582095966, 5963.4334738199805, 5552.91670624941, 5879.941200587982, 5917.792877249297, 5918.4673379395845, 5920.052791553352, 5750.712464376765, 5847.970760146214, 5859.589828711992, 5873.060310350366, 5878.088896221093, 5631.662100273997, 5661.801836935688, 5663.008973429633, 5880.529557635379, 5953.404659534012, 13028.283444410554, 13053.34733263333, 13084.672883177902, 13288.800667989892, 13294.800577991338, 2323.477217626021, 2332.265336419023, 2447.6206188040883, 2686.489566982267, 2839.8640543782444, 9316.8602470963, 9356.157945784844, 9620.663276785279, 9822.557984890696, 10032.0, 1780.6260685256111, 1863.636590864782, 1878.182990399167, 1911.8183772541586, 1951.0342380521734, 76230.61884690542, 78890.0, 80390.5980470094, 82616.17383826144, 82999.17000829974, 9934.701958941243, 10126.59493620247, 10329.661542152315, 10417.874637608687, 10495.0, 14237.501687441098, 14265.928670356789, 14277.500287489887, 14285.214313212666, 14313.427462901576, 7659.234076592407, 7974.681012759424, 7982.08206056311, 8112.1887811219585, 8161.55111468863, 7899.68401263943, 7982.121966583672, 8003.759887203393, 8062.113167551564, 8290.626921788535, 4199.349100889367, 4228.1966426378885, 4233.322668373107, 4282.229198744256, 4334.26317526015, 1733.523281097683, 1824.5529845187748, 1918.41488346053, 1976.3280484635293, 2007.1469625409143, 795.7294519863274, 903.4127816919055, 940.3558562384789, 942.4141142951137, 1073.8335557988523, 19441.51396215106, 19760.70358944617, 19800.207991680458, 19926.402207933785, 19986.500337491387, 955.9187469065068, 975.1516180922501, 987.807377561383, 998.4658207858761, 1007.9798404032025, 10149.0, 10933.617323393642, 11031.831232055923, 11154.609588664358, 11174.217804753589, 437065.0, 457555.0, 491253.0, 497755.0, 502236.0, 52082.0, 58097.41902581005, 58654.0, 76412.0, 96887.0, 1009.6062535611118, 1038.2576457832686, 1082.7509672775307, 1082.929609575391, 1085.847981282621, 16088.517344479684, 17046.914765426092, 17162.485125446256, 17620.0, 18330.175142118904, 40222.79888600538, 42091.15817683568, 42419.7879010603, 42614.0, 43330.56669433265, 55858.0, 57255.71372143113, 58677.413225867196, 58789.0, 59395.10907336307, 7921.564313962787, 8019.879701804594, 8182.0, 8408.873866892123, 8414.83170336602, 10896.782064358827, 13214.405351759386, 13253.867461325262, 13433.529826456419, 13611.931940340632, 10672.199585031309, 11160.497777599865, 11543.711407214887, 11811.291322520676, 12177.269363838199, 10995.560177592806, 11579.247348922294, 11895.881041189477, 11908.404579770804, 12257.570985015482, 11622.244554103956, 11708.063354931415, 11795.469203885674, 11889.34608596501, 12041.397930103634, 8191.549464779494, 8290.58547072656, 8308.916910831056, 8312.459690120122, 8640.56797160152, 8923.375363724477, 11339.829902551302, 11670.649880503599, 12227.877721222674, 12271.202371845802], "value": 8888.783179844817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.738473612909, 1351.5539871842293, 1375.8005089262058, 1723.7672914156585, 1748.8426041656257, 7574.35617972473, 7835.569043702594, 8076.878846817295, 8662.393632445723, 8672.696455624055, 7910.525368477881, 8170.101288858221, 8182.0, 8396.790080247996, 8406.0, 2299.298713892262, 2324.244620498336, 2329.04509151248, 2330.0912644068826, 2341.051873991028, 2000.1799262302459, 2051.5999380120884, 2223.377454312795, 2252.481929156295, 2285.80570651494, 2053.219776484934, 2091.7385326834146, 2244.3154837774473, 2282.1898226129733, 2298.37943755186, 2269.909203631853, 2271.4094335472732, 2272.6477396003647, 2276.1009401286483, 2290.393045842853, 2201.6037113319594, 2253.763354847734, 2254.0, 2260.864348139117, 2261.6494443361307, 8613.095624959415, 8677.956610216972, 8678.826423471559, 8681.348898832613, 8693.913060869374, 4823.493533179001, 4994.126027945132, 5015.724135172564, 5027.648064635477, 5029.7736601853, 3180.538821870816, 3241.675832416763, 3370.8146051967133, 3373.8070254334634, 3389.0510657016075, 1115.247208134514, 1153.3598852636783, 1166.9241499302518, 1183.7573297473998, 1203.8495188101488, 11183.0, 11199.272047316897, 11219.38293393863, 11245.269057511236, 11253.381064041474, 4241.406203131564, 4269.829206831754, 4385.254506733863, 4437.090396468716, 4511.390962220124, 9480.288978326653, 9489.952550237205, 9494.28792840526, 9496.762580935394, 9532.666356677482, 5124.871878203075, 5127.66670166438, 5128.512791284822, 5133.4609865964285, 5139.640225184276, 4648.372469716613, 4735.052989402134, 4739.099571081552, 4741.336212930192, 4764.809407623726, 3882.281777871103, 3907.6873850091924, 3918.4318273850704, 3974.3839704845795, 4015.217032678658, 1201.3692811273977, 1207.7705236005131, 1229.0536287058915, 1244.508419174439, 1248.0701877101617, 841.6296829395046, 859.2910848549972, 895.3106108296575, 921.1433366968784, 942.6700654770775, 5388.838334849961, 5403.189521571717, 5488.121900495901, 5489.725513724298, 5568.610197286151, 927.2350310993457, 947.9526023698787, 951.9524023798921, 953.3088510829593, 983.1299300119446, 3504.404251277289, 3664.8350824212976, 3888.7861167635488, 3891.124496988155, 3934.3114954883354, 10218.131458826083, 10545.261831671709, 10688.732781680364, 10753.892461075446, 10775.353478791298, 10583.894161058444, 10624.893751062546, 10669.09312708413, 10686.57253709843, 10697.732556686145, 7808.84382312362, 8012.79968000793, 8057.798555036054, 8072.757817265491, 8075.757727268309, 5390.353157621111, 5421.701806400686, 5442.891142177214, 5561.165825126263, 5735.627184233012, 9373.484458354857, 9538.14156725898, 9756.170725488413, 9841.409515429097, 9845.310828241954, 9799.314048016571, 9905.405675659484, 9921.164584551881, 9927.652532161339, 10021.849672255068, 7640.80897977555, 7791.883121753065, 7812.218778122142, 7814.062312522534, 7817.101033381006, 8212.219839115274, 8318.292945099734, 8387.622556984828, 8388.286995605442, 8434.03008653988, 7527.172011078667, 7584.54492730438, 7613.5431874087735, 7631.427642926692, 7812.218778122142, 7096.148462184571, 7120.430365570845, 7126.536775109601, 7195.316444937723, 7262.273772622695, 6704.497162712913, 6717.496187786033, 6860.5197636164985, 6903.447724182154, 6937.791866244021, 4672.9532704673875, 4722.698456999229, 4798.136335459651, 4802.4957379476045, 4832.927506087482, 4641.953580464152, 4734.7632618369635, 4755.38180036593, 4793.304970779287, 4875.414950205998], "value": 4459.563497151135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7911036316383, 310.58381768430297, 315.6228307172928, 318.44272523084595, 320.3097325264055, 5087.44038155803, 5224.84325470236, 5285.0, 5313.0, 5360.356757189143, 5157.819476318329, 5241.371035475739, 5286.894262114755, 5301.6818990860575, 5310.70791106489, 4141.4409054777525, 4155.047127849905, 4180.0, 4185.681510324253, 4194.357554740509, 3963.1677347757004, 4030.9596904031023, 4065.3901914712733, 4120.629143377096, 4187.1416359646355, 4085.7130004048777, 4094.61101195386, 4100.958990410102, 4103.651189648884, 4113.71204015719, 4097.959020409788, 4108.0, 4108.0, 4120.17596480705, 4122.2579935611575, 3609.3290964686207, 3639.8180090995343, 3664.615215402371, 3676.9448458273146, 3679.2457546202963, 5100.719460429675, 5107.620942345583, 5134.743262836843, 5135.922961155586, 5191.532762051395, 4698.248280275174, 4708.411448568929, 4716.198246298138, 4735.692180008288, 4738.384010078702, 5175.689458632456, 5457.645253058538, 5479.1781232815, 5502.2296878437055, 5552.139418390156, 3933.9213215735813, 3948.1116748731592, 3968.7420317679257, 3990.920181596352, 3993.8402463901407, 5770.105633626753, 5784.07454807233, 5788.652680839121, 5811.593188476808, 5818.5926985111055, 3954.703397245218, 3968.9603103969166, 4074.6774338626697, 4079.89800254996, 4083.3670781028986, 3998.4402183694306, 4019.457373254632, 4033.4353190553347, 4035.7174997750462, 4040.515138183378, 4475.172093162775, 4500.707454015478, 4607.14767767964, 4634.72191668501, 4718.646101542398, 5513.283273174462, 5514.255575497256, 5522.873693627982, 5525.557955363642, 5533.5849811263515, 1367.3026756354332, 1391.589481103077, 1393.7212557488542, 1394.4143459746729, 1395.2326220578843, 891.790429249126, 895.3553441522093, 896.551724137931, 899.9460032398077, 914.337105598449, 4661.0, 4712.246040633482, 4714.952850471452, 4720.371471842209, 4723.95276047242, 4960.107180707435, 4960.437462199396, 4960.727160006234, 4968.751562421864, 4973.179425394842, 4423.867283981485, 4698.412698412699, 4719.976400117977, 4742.52574742523, 4747.548982846624, 2659.5478768609382, 2659.8936042558466, 2675.304420850593, 2686.9059582914897, 2687.9059232927143, 5079.339685840817, 5143.871403214949, 5182.693701302959, 5184.637075404761, 5194.948050519446, 4867.758721525988, 5052.837847295069, 5086.338775959176, 5098.1588037973315, 5153.3815942087185, 5070.771815268322, 5097.069185218588, 5098.464661210668, 5101.566366858784, 5149.819756308586, 4933.802647894187, 4940.097323114699, 4962.503749625009, 4979.800807967786, 5016.824411145592, 4716.056788642217, 4821.566059054702, 4887.315775791321, 4927.457979622311, 4935.593355893697, 5104.132297509358, 5114.693118412907, 5138.023775482647, 5148.43367229612, 5152.433232344514, 3622.185008373095, 3633.0, 3670.4677821716236, 3673.7244706646575, 3716.9964109690773, 4674.789634466525, 4943.65394422387, 5016.4198277542455, 5066.569341606005, 5080.8221712241375, 4830.203016502238, 4837.564619184291, 4854.053459575349, 4864.148773964613, 4867.318575399376, 4839.443464001685, 4848.369711937426, 4854.271859221145, 4859.88594961193, 4876.95123048765, 4445.022095139064, 4771.73755443454, 4795.0, 4814.085323788469, 4844.370231869834, 4859.684120532154, 4870.707757534559, 4894.486078961801, 4904.803807847647, 4912.582430493448, 4776.689515181502, 4778.331033655221, 4782.593479554138, 4789.3055506952, 4837.516248375135], "value": 3956.4329655645115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.7691777090217, 746.9701211951523, 757.1406453675077, 780.2860382749784, 793.9285464308213, 15287.541373758791, 15795.289211985459, 15900.886937914336, 15906.363745450197, 15983.84016159838, 14356.856431435683, 14823.703525929503, 14866.256687165653, 14909.627259318522, 14972.850271497282, 793.1077537770024, 813.7355359508153, 816.6202715737181, 816.6365967144623, 817.199144838059, 807.8667019941703, 809.4981111710719, 810.116972499975, 810.1372038778711, 810.266708628692, 853.0829358439671, 854.218390172991, 854.8546747052985, 855.4909828651943, 855.8758979947904, 848.9787755306166, 848.9872651910226, 849.2908421468081, 849.4393700157866, 849.4903058165082, 628.8019273928697, 629.4555209743585, 629.6473974574208, 629.7606909374455, 629.7701339011273, 13817.0, 14276.428942842274, 14430.20633865137, 14432.278386080654, 14522.273886305748, 12999.935000325033, 13007.674808129872, 13167.934160329232, 13392.598222053353, 13552.0, 10941.945290273497, 10969.451527423596, 11045.723856903562, 11197.104231661448, 11431.199816012882, 3716.646918542734, 3789.1663833956486, 3934.8229329680235, 3968.0, 3970.344893092665, 49820.750896245285, 51223.48776512224, 65186.0, 67715.32284677139, 72083.0, 11534.884651153548, 11890.28658280506, 11948.163628545919, 12199.268043917216, 12648.936755316165, 22369.0, 22415.887920560617, 22438.663420048713, 22491.32526024189, 22611.0, 8444.746657600283, 8700.912990870136, 8793.20861122502, 8975.50634715097, 9017.81964360709, 4461.955380446154, 4499.865004049884, 4526.79629416677, 4635.049814787961, 4758.714477131383, 3681.4293784463453, 3868.980655096763, 3928.017995501125, 3929.135590170158, 3936.0553467167674, 635.7202830754453, 636.7357546618194, 637.6365471681097, 653.9149910511603, 667.4026746062248, 701.6632016632045, 709.4359983812881, 730.3828265115968, 740.8960648633605, 743.5464366736287, 9867.0, 9940.701778946643, 10016.298859079794, 10082.59669613222, 10212.540435680412, 708.9858202835915, 715.492000679513, 729.2488736601309, 732.7142414458366, 737.3437640499959, 4521.276595744665, 4568.497465278817, 4878.658493905464, 4969.768986125179, 4976.129177393942, 65528.051237693464, 69524.0, 78773.60613196898, 127962.0, 132450.0, 102182.48908755557, 106464.46767766112, 107319.4634026825, 107867.0, 111999.0, 56940.0, 74610.62694686491, 76135.0, 87476.12523874806, 89255.0, 9986.500674966368, 10480.266381353233, 10495.475226238505, 10622.20333474977, 10626.946865265934, 50063.49936500588, 52213.0, 52590.0, 52946.0, 53846.461535385715, 43653.12693746171, 43974.340384893614, 67837.6608116976, 73176.63411682908, 73954.0, 12654.177478463871, 12764.936175319064, 13258.204507729568, 13645.931770341482, 13843.930780346034, 14568.543145685771, 14680.853191468375, 14881.702365952837, 14972.7005459888, 15839.762403564186, 13725.725485490433, 14040.929795350958, 14059.437622494986, 14318.928405357907, 14762.261886905826, 13486.190828550318, 13614.93192534031, 14116.858831411555, 14177.43290268419, 14579.0, 13304.667383315495, 14255.857441425867, 14274.436594194134, 14727.190004549853, 14733.852661473247, 11093.722656933642, 11247.887521124683, 11492.712682183012, 11923.642290730944, 12202.694932626755, 11218.83171752408, 11349.375784331942, 11752.412379381169, 12095.637130886087, 12179.573714919936], "value": 7527.6623188031535, "unit": "score"}], "name": "dromaeo_css", "value": 6939.317935312432, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 111.0, 112.0, 110.0, 112.0, 112.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 122.0, 164.0, 122.0, 134.0, 127.0, 127.0, 160.0, 121.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 107.0, 75.0, 75.0, 75.0, 74.0, 97.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 83.0, 82.0, 83.0, 111.0, 83.0, 83.0, 114.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 79.0, 80.0, 88.0, 80.0, 79.0, 79.0, 87.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 132.0, 140.0, 129.0, 141.0, 132.0, 132.0, 128.0, 175.0, 127.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 165.0, 172.0, 171.0, 168.0, 168.0, 164.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1502.4, "alertThreshold": 2.0}]} 23:36:32 INFO - Return code: 0 23:36:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:32 INFO - # TBPL SUCCESS # 23:36:32 INFO - Running post-action listener: _resource_record_post_action 23:36:32 INFO - [mozharness: 2016-10-17 06:36:32.951775Z] Finished run-tests step (success) 23:36:32 INFO - Running post-run listener: _resource_record_post_run 23:36:33 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410796032; Read time: 8; Write time: 261920 23:36:33 INFO - TinderboxPrint: CPU usage
13.2% 23:36:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:36:33 INFO - TinderboxPrint: I/O write bytes / time
410,796,032 / 261,920 23:36:33 INFO - TinderboxPrint: CPU idle
8,291.9 (86.8%) 23:36:33 INFO - TinderboxPrint: CPU user
1,208.0 (12.6%) 23:36:33 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120889344; Read time: 0; Write time: 71716 23:36:33 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289906688; Read time: 0; Write time: 190204 23:36:33 INFO - Running post-run listener: _upload_blobber_files 23:36:33 INFO - Blob upload gear active. 23:36:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:33 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 23:36:33 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'] 23:36:33 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 23:36:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:34 INFO - (blobuploader) - INFO - Done attempting. 23:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:36:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:35 INFO - (blobuploader) - INFO - Done attempting. 23:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:38 INFO - (blobuploader) - INFO - Done attempting. 23:36:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:36:38 INFO - Return code: 0 23:36:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:36:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:36:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fdc47609770f774b5d5cd10281e66f58658a9796be0132894cad0d1570c1f00d2c0a23b572671a57f56f20331d8d9e9d0e858cd5a0071b8849df493d277996c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b74fd1286d094da0b553c4083ae5bda3904bedd50ff126b2ca7feb7e2463f456bde497cf91674e047d34daf53a9a7e8b7c79b46079930a9fac9fbf52010ce379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a748c91d88a50f424be029f5768d2c2090bd8028ca9e442d898222c0dbcc76c69609dc08913b86a7a2bd99ca8d21c645e7fe9ddd1fbbe05bd946ef4a714871b2"} 23:36:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:36:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:36:38 INFO - Contents: 23:36:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fdc47609770f774b5d5cd10281e66f58658a9796be0132894cad0d1570c1f00d2c0a23b572671a57f56f20331d8d9e9d0e858cd5a0071b8849df493d277996c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b74fd1286d094da0b553c4083ae5bda3904bedd50ff126b2ca7feb7e2463f456bde497cf91674e047d34daf53a9a7e8b7c79b46079930a9fac9fbf52010ce379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a748c91d88a50f424be029f5768d2c2090bd8028ca9e442d898222c0dbcc76c69609dc08913b86a7a2bd99ca8d21c645e7fe9ddd1fbbe05bd946ef4a714871b2"} 23:36:38 INFO - Running post-run listener: copy_logs_to_upload_dir 23:36:38 INFO - Copying logs to upload dir... 23:36:38 INFO - mkdir: /builds/slave/test/build/upload/logs 23:36:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.113583 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-16 23:36:38.277488) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:38.281084) ========= 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=62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411 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/7fdc47609770f774b5d5cd10281e66f58658a9796be0132894cad0d1570c1f00d2c0a23b572671a57f56f20331d8d9e9d0e858cd5a0071b8849df493d277996c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b74fd1286d094da0b553c4083ae5bda3904bedd50ff126b2ca7feb7e2463f456bde497cf91674e047d34daf53a9a7e8b7c79b46079930a9fac9fbf52010ce379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a748c91d88a50f424be029f5768d2c2090bd8028ca9e442d898222c0dbcc76c69609dc08913b86a7a2bd99ca8d21c645e7fe9ddd1fbbe05bd946ef4a714871b2"} build_url:https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/GTUS7stpTgOxm1zl1ECKjQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fdc47609770f774b5d5cd10281e66f58658a9796be0132894cad0d1570c1f00d2c0a23b572671a57f56f20331d8d9e9d0e858cd5a0071b8849df493d277996c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b74fd1286d094da0b553c4083ae5bda3904bedd50ff126b2ca7feb7e2463f456bde497cf91674e047d34daf53a9a7e8b7c79b46079930a9fac9fbf52010ce379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a748c91d88a50f424be029f5768d2c2090bd8028ca9e442d898222c0dbcc76c69609dc08913b86a7a2bd99ca8d21c645e7fe9ddd1fbbe05bd946ef4a714871b2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:38.306264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:38.306564) ========= 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=62c568580acbfdaac3eec7be000001dc-1476677622.895703-1370043411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:36:38.389417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:36:38.389732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:36:38.390029) ========= ========= Total master_lag: 0.17 =========