builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1475198781.3 results: success (0) buildid: 20160929153009 builduid: 283a4c6cefd14921bdc46ebf27be22b5 revision: 500496dfefccc73d1f87ff912563a8ee1afe8e91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.297091) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.297579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.297915) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.312785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.313140) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 18:26:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-09-29 18:26:22 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.461773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.462131) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.511820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:21.512214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 500496dfefccc73d1f87ff912563a8ee1afe8e91 --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 500496dfefccc73d1f87ff912563a8ee1afe8e91 --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=934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 18:26:22,147 truncating revision to first 12 chars 2016-09-29 18:26:22,147 Setting DEBUG logging. 2016-09-29 18:26:22,147 attempt 1/10 2016-09-29 18:26:22,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/500496dfefcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 18:26:22,781 unpacking tar archive at: fx-team-500496dfefcc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.966696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:22.496176) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:22.496545) ========= script_repo_revision: 500496dfefccc73d1f87ff912563a8ee1afe8e91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:22.496996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:22.497301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 18:26:22.507743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-29 18:26:22.508107) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:26:23 INFO - MultiFileLogger online at 20160929 18:26:23 in /builds/slave/test 18:26:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:26:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:26:23 INFO - {'append_to_log': False, 18:26:23 INFO - 'base_work_dir': '/builds/slave/test', 18:26:23 INFO - 'blob_upload_branch': 'Fx-Team', 18:26:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:26:23 INFO - 'branch': 'Fx-Team', 18:26:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:26:23 INFO - 'config_files': ('talos/linux_config.py',), 18:26:23 INFO - 'default_actions': ('clobber', 18:26:23 INFO - 'read-buildbot-config', 18:26:23 INFO - 'download-and-extract', 18:26:23 INFO - 'populate-webroot', 18:26:23 INFO - 'create-virtualenv', 18:26:23 INFO - 'install', 18:26:23 INFO - 'run-tests'), 18:26:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:26:23 INFO - 'download_minidump_stackwalk': True, 18:26:23 INFO - 'download_symbols': 'ondemand', 18:26:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:26:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:26:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:26:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:26:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:26:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:26:23 INFO - 'installer_path': 'installer.exe', 18:26:23 INFO - 'log_level': 'info', 18:26:23 INFO - 'log_name': 'talos', 18:26:23 INFO - 'log_to_console': True, 18:26:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:26:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:26:23 INFO - 'opt_config_files': (), 18:26:23 INFO - 'pip_index': False, 18:26:23 INFO - 'sps_profile': False, 18:26:23 INFO - 'sps_profile_interval': 0, 18:26:23 INFO - 'suite': 'dromaeojs-e10s', 18:26:23 INFO - 'system_bits': '32', 18:26:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:26:23 INFO - 'title': 'talos-linux64-ix-057', 18:26:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:26:23 INFO - 'use_talos_json': True, 18:26:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:26:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:26:23 INFO - 'work_dir': 'build'} 18:26:23 INFO - [mozharness: 2016-09-30 01:26:23.244093Z] Running clobber step. 18:26:23 INFO - Running pre-action listener: _resource_record_pre_action 18:26:23 INFO - Running main action method: clobber 18:26:23 INFO - rmtree: /builds/slave/test/build 18:26:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:26:23 INFO - Running post-action listener: _resource_record_post_action 18:26:23 INFO - [mozharness: 2016-09-30 01:26:23.704019Z] Finished clobber step (success) 18:26:23 INFO - [mozharness: 2016-09-30 01:26:23.704120Z] Running read-buildbot-config step. 18:26:23 INFO - Running pre-action listener: _resource_record_pre_action 18:26:23 INFO - Running main action method: read_buildbot_config 18:26:23 INFO - Using buildbot properties: 18:26:23 INFO - { 18:26:23 INFO - "project": "", 18:26:23 INFO - "product": "firefox", 18:26:23 INFO - "script_repo_revision": "production", 18:26:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:26:23 INFO - "repository": "", 18:26:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:26:23 INFO - "buildid": "20160929153009", 18:26:23 INFO - "pgo_build": "True", 18:26:23 INFO - "basedir": "/builds/slave/test", 18:26:23 INFO - "buildnumber": 1215, 18:26:23 INFO - "slavename": "talos-linux64-ix-057", 18:26:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:26:23 INFO - "platform": "ubuntu64_hw", 18:26:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:26:23 INFO - "branch": "fx-team", 18:26:23 INFO - "repo_path": "integration/fx-team", 18:26:23 INFO - "revision": "500496dfefccc73d1f87ff912563a8ee1afe8e91", 18:26:23 INFO - "stage_platform": "linux64-pgo", 18:26:23 INFO - "builduid": "283a4c6cefd14921bdc46ebf27be22b5", 18:26:23 INFO - "slavebuilddir": "test" 18:26:23 INFO - } 18:26:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:26:23 INFO - Running post-action listener: _resource_record_post_action 18:26:23 INFO - [mozharness: 2016-09-30 01:26:23.706558Z] Finished read-buildbot-config step (success) 18:26:23 INFO - [mozharness: 2016-09-30 01:26:23.706644Z] Running download-and-extract step. 18:26:23 INFO - Running pre-action listener: _resource_record_pre_action 18:26:23 INFO - Running main action method: download_and_extract 18:26:23 INFO - mkdir: /builds/slave/test/build/tests 18:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:23 INFO - trying https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:26:23 INFO - Downloading https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/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 18:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/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 18:26:24 INFO - Downloaded 1361 bytes. 18:26:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:26:24 INFO - Using the following test package requirements: 18:26:24 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:26:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:26:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'jsshell-linux-x86_64.zip'], 18:26:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:26:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:26:24 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:26:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:26:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:26:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:26:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:26:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:26:24 INFO - Fetch https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:26:24 INFO - Http code: 200 18:26:24 INFO - Content-Encoding: None 18:26:24 INFO - Content-Type: application/zip 18:26:24 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 18:26:24 INFO - x-amz-cf-id: jf56-tv1VI4jDcoaub9V_B5s9rWKq4H3W8dIeXOTHdgHyrd4LIJaOA== 18:26:24 INFO - x-amz-version-id: eJdfmGtTMpE3sa1OE2Y4SW4k8zwSF7WV 18:26:24 INFO - x-cache: Hit from cloudfront 18:26:25 INFO - Expected file size: 21988793 18:26:25 INFO - Obtained file size: 21988793 18:26:29 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 18:26:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:26:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:26:29 INFO - Fetch https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:26:29 INFO - Http code: 200 18:26:29 INFO - Content-Encoding: None 18:26:29 INFO - Content-Type: application/zip 18:26:29 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 18:26:29 INFO - x-amz-cf-id: gBOTMcnX4c7JVCYI42Nj1_nvet98DHDCTY3gCuuPqkZjUg6-mZ6ITw== 18:26:29 INFO - x-amz-version-id: eJdfmGtTMpE3sa1OE2Y4SW4k8zwSF7WV 18:26:29 INFO - x-cache: Hit from cloudfront 18:26:29 INFO - Expected file size: 21988793 18:26:29 INFO - Obtained file size: 21988793 18:26:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:26:34 INFO - Fetch https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:26:34 INFO - Http code: 200 18:26:34 INFO - Content-Encoding: None 18:26:34 INFO - Content-Type: application/zip 18:26:34 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:26:34 INFO - x-amz-cf-id: 5IiLYDAZxu4LTdL6yrKo9YeAy85awBgHawVAFo3Eu_RUziEJtrI0qg== 18:26:34 INFO - x-amz-version-id: z248qwQsmPapCtjbWA6eQXjNl6GeB75X 18:26:34 INFO - x-cache: Hit from cloudfront 18:26:35 INFO - Expected file size: 14414067 18:26:35 INFO - Obtained file size: 14414067 18:26: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')]} 18:26:35 INFO - trying https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:35 INFO - Downloading https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/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 18:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/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 18:26:36 INFO - Downloaded 59716751 bytes. 18:26:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:36 INFO - mkdir: /builds/slave/test/properties 18:26:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:26:36 INFO - Writing to file /builds/slave/test/properties/build_url 18:26:36 INFO - Contents: 18:26:36 INFO - build_url:https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:37 INFO - Running post-action listener: _resource_record_post_action 18:26:37 INFO - Running post-action listener: set_extra_try_arguments 18:26:37 INFO - [mozharness: 2016-09-30 01:26:37.217472Z] Finished download-and-extract step (success) 18:26:37 INFO - [mozharness: 2016-09-30 01:26:37.217697Z] Running populate-webroot step. 18:26:37 INFO - Running pre-action listener: _resource_record_pre_action 18:26:37 INFO - Running main action method: populate_webroot 18:26:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:26:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:26:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:26:37 INFO - '--tppagecycles', 18:26:37 INFO - '7'], 18:26:37 INFO - 'tests': ['tsvgm']}}, 18:26:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:26:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:26:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:26:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:26:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['damp', 'tps']}, 18:26:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'tests': ['damp', 'tps']}, 18:26:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['dromaeo_dom']}, 18:26:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:26:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['basic_compositor_video']}, 18:26:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:26:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['a11yr', 18:26:37 INFO - 'ts_paint', 18:26:37 INFO - 'tpaint', 18:26:37 INFO - 'sessionrestore', 18:26:37 INFO - 'sessionrestore_no_auto_restore', 18:26:37 INFO - 'tabpaint']}, 18:26:37 INFO - 'other-e10s': {'tests': ['a11yr', 18:26:37 INFO - 'ts_paint', 18:26:37 INFO - 'tpaint', 18:26:37 INFO - 'sessionrestore', 18:26:37 INFO - 'sessionrestore_no_auto_restore', 18:26:37 INFO - 'tabpaint']}, 18:26:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:26:37 INFO - 'ts_paint', 18:26:37 INFO - 'tpaint', 18:26:37 INFO - 'sessionrestore', 18:26:37 INFO - 'sessionrestore_no_auto_restore', 18:26:37 INFO - 'tabpaint']}, 18:26:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:26:37 INFO - 'ts_paint', 18:26:37 INFO - 'tpaint', 18:26:37 INFO - 'sessionrestore', 18:26:37 INFO - 'sessionrestore_no_auto_restore', 18:26:37 INFO - 'tabpaint']}, 18:26:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['a11yr', 18:26:37 INFO - 'ts_paint', 18:26:37 INFO - 'tpaint', 18:26:37 INFO - 'sessionrestore', 18:26:37 INFO - 'sessionrestore_no_auto_restore', 18:26:37 INFO - 'tabpaint']}, 18:26:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['a11yr', 18:26:37 INFO - 'ts_paint', 18:26:37 INFO - 'tpaint', 18:26:37 INFO - 'sessionrestore', 18:26:37 INFO - 'sessionrestore_no_auto_restore', 18:26:37 INFO - 'tabpaint']}, 18:26:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['tsvgx', 18:26:37 INFO - 'tsvgr_opacity', 18:26:37 INFO - 'tart', 18:26:37 INFO - 'tscrollx', 18:26:37 INFO - 'cart']}, 18:26:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:26:37 INFO - 'tsvgr_opacity', 18:26:37 INFO - 'tart', 18:26:37 INFO - 'tscrollx', 18:26:37 INFO - 'cart']}, 18:26:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'talos_options': ['--disable-e10s'], 18:26:37 INFO - 'tests': ['tp5o']}, 18:26:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'tests': ['tp5o']}, 18:26:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'talos_options': ['--disable-e10s', 18:26:37 INFO - '--xperf_path', 18:26:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:37 INFO - 'tests': ['tp5n']}, 18:26:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:37 INFO - 'talos_options': ['--xperf_path', 18:26:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:37 INFO - 'tests': ['tp5n']}}, 18:26:37 INFO - 'talos.zip': {'path': '', 18:26:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:26:37 INFO - Running post-action listener: _resource_record_post_action 18:26:37 INFO - [mozharness: 2016-09-30 01:26:37.232954Z] Finished populate-webroot step (success) 18:26:37 INFO - [mozharness: 2016-09-30 01:26:37.233042Z] Running create-virtualenv step. 18:26:37 INFO - Running pre-action listener: _resource_record_pre_action 18:26:37 INFO - Running main action method: create_virtualenv 18:26:37 INFO - Creating virtualenv /builds/slave/test/build/venv 18:26:37 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 18:26:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:26:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:26:37 INFO - Using real prefix '/usr' 18:26:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:26:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:26:39 INFO - Installing pip.................done. 18:26:39 INFO - Return code: 0 18:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:26:40 INFO - Reading from file tmpfile_stdout 18:26:40 INFO - Output received: 18:26:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:26:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:26:40 INFO - Using env: {'DISPLAY': ':0', 18:26:40 INFO - 'HOME': '/home/cltbld', 18:26:40 INFO - 'LANG': 'en_US.UTF-8', 18:26:40 INFO - 'LANGUAGE': 'en_US:en', 18:26:40 INFO - 'LOGNAME': 'cltbld', 18:26:40 INFO - 'MAIL': '/var/mail/cltbld', 18:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:40 INFO - 'MOZ_NO_REMOTE': '1', 18:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:40 INFO - 'NO_EM_RESTART': '1', 18:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:40 INFO - 'PWD': '/builds/slave/test', 18:26:40 INFO - 'SHELL': '/bin/bash', 18:26:40 INFO - 'SHLVL': '1', 18:26:40 INFO - 'TERM': 'linux', 18:26:40 INFO - 'TMOUT': '86400', 18:26:40 INFO - 'USER': 'cltbld', 18:26:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:40 INFO - '_': '/tools/buildbot/bin/python'} 18:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:26:40 INFO - Cleaning up... 18:26:40 INFO - Return code: 0 18:26:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:26:40 INFO - Using env: {'DISPLAY': ':0', 18:26:40 INFO - 'HOME': '/home/cltbld', 18:26:40 INFO - 'LANG': 'en_US.UTF-8', 18:26:40 INFO - 'LANGUAGE': 'en_US:en', 18:26:40 INFO - 'LOGNAME': 'cltbld', 18:26:40 INFO - 'MAIL': '/var/mail/cltbld', 18:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:40 INFO - 'MOZ_NO_REMOTE': '1', 18:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:40 INFO - 'NO_EM_RESTART': '1', 18:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:40 INFO - 'PWD': '/builds/slave/test', 18:26:40 INFO - 'SHELL': '/bin/bash', 18:26:40 INFO - 'SHLVL': '1', 18:26:40 INFO - 'TERM': 'linux', 18:26:40 INFO - 'TMOUT': '86400', 18:26:40 INFO - 'USER': 'cltbld', 18:26:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:40 INFO - '_': '/tools/buildbot/bin/python'} 18:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:40 INFO - Downloading/unpacking psutil>=3.1.1 18:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:42 INFO - Installing collected packages: psutil 18:26:42 INFO - Running setup.py install for psutil 18:26:42 INFO - building 'psutil._psutil_linux' extension 18:26:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:26:42 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 18:26:42 INFO - building 'psutil._psutil_posix' extension 18:26:42 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 18:26:42 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 18:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:42 INFO - Successfully installed psutil 18:26:42 INFO - Cleaning up... 18:26:43 INFO - Return code: 0 18:26:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:26:43 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')]} 18:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:43 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')]} 18:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:43 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:43 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 18:26:43 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 18:26:43 INFO - Using env: {'DISPLAY': ':0', 18:26:43 INFO - 'HOME': '/home/cltbld', 18:26:43 INFO - 'LANG': 'en_US.UTF-8', 18:26:43 INFO - 'LANGUAGE': 'en_US:en', 18:26:43 INFO - 'LOGNAME': 'cltbld', 18:26:43 INFO - 'MAIL': '/var/mail/cltbld', 18:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:43 INFO - 'MOZ_NO_REMOTE': '1', 18:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:43 INFO - 'NO_EM_RESTART': '1', 18:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:43 INFO - 'PWD': '/builds/slave/test', 18:26:43 INFO - 'SHELL': '/bin/bash', 18:26:43 INFO - 'SHLVL': '1', 18:26:43 INFO - 'TERM': 'linux', 18:26:43 INFO - 'TMOUT': '86400', 18:26:43 INFO - 'USER': 'cltbld', 18:26:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:43 INFO - '_': '/tools/buildbot/bin/python'} 18:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:26:43 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 18:26:43 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 18:26:43 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 18:26:43 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 18:26:43 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 18:26:43 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 18:26:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:26:45 INFO - Installing collected packages: mozsystemmonitor 18:26:45 INFO - Running setup.py install for mozsystemmonitor 18:26:45 INFO - Successfully installed mozsystemmonitor 18:26:45 INFO - Cleaning up... 18:26:45 INFO - Return code: 0 18:26:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:26:45 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')]} 18:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:45 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')]} 18:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:45 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:45 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 18:26:45 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 18:26:45 INFO - Using env: {'DISPLAY': ':0', 18:26:45 INFO - 'HOME': '/home/cltbld', 18:26:45 INFO - 'LANG': 'en_US.UTF-8', 18:26:45 INFO - 'LANGUAGE': 'en_US:en', 18:26:45 INFO - 'LOGNAME': 'cltbld', 18:26:45 INFO - 'MAIL': '/var/mail/cltbld', 18:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:45 INFO - 'MOZ_NO_REMOTE': '1', 18:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:45 INFO - 'NO_EM_RESTART': '1', 18:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:45 INFO - 'PWD': '/builds/slave/test', 18:26:45 INFO - 'SHELL': '/bin/bash', 18:26:45 INFO - 'SHLVL': '1', 18:26:45 INFO - 'TERM': 'linux', 18:26:45 INFO - 'TMOUT': '86400', 18:26:45 INFO - 'USER': 'cltbld', 18:26:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:45 INFO - '_': '/tools/buildbot/bin/python'} 18:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:26:45 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 18:26:45 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 18:26:45 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 18:26:45 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 18:26:45 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 18:26:45 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 18:26:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:47 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:47 INFO - warning: no files found matching '*.txt' 18:26:47 INFO - no previously-included directories found matching 'build' 18:26:47 INFO - no previously-included directories found matching 'dist' 18:26:47 INFO - no previously-included directories found matching '.git*' 18:26:47 INFO - Installing collected packages: jsonschema, functools32 18:26:47 INFO - Running setup.py install for functools32 18:26:47 INFO - warning: no files found matching '*.txt' 18:26:47 INFO - no previously-included directories found matching 'build' 18:26:47 INFO - no previously-included directories found matching 'dist' 18:26:47 INFO - no previously-included directories found matching '.git*' 18:26:47 INFO - Successfully installed jsonschema functools32 18:26:47 INFO - Cleaning up... 18:26:47 INFO - Return code: 0 18:26:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:47 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:47 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 18:26:47 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 18:26:47 INFO - Using env: {'DISPLAY': ':0', 18:26:47 INFO - 'HOME': '/home/cltbld', 18:26:47 INFO - 'LANG': 'en_US.UTF-8', 18:26:47 INFO - 'LANGUAGE': 'en_US:en', 18:26:47 INFO - 'LOGNAME': 'cltbld', 18:26:47 INFO - 'MAIL': '/var/mail/cltbld', 18:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:47 INFO - 'MOZ_NO_REMOTE': '1', 18:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:47 INFO - 'NO_EM_RESTART': '1', 18:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:47 INFO - 'PWD': '/builds/slave/test', 18:26:47 INFO - 'SHELL': '/bin/bash', 18:26:47 INFO - 'SHLVL': '1', 18:26:47 INFO - 'TERM': 'linux', 18:26:47 INFO - 'TMOUT': '86400', 18:26:47 INFO - 'USER': 'cltbld', 18:26:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:47 INFO - '_': '/tools/buildbot/bin/python'} 18:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:26:48 INFO - Cleaning up... 18:26:48 INFO - Return code: 0 18:26:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26:48 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')]} 18:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:48 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')]} 18:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:48 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:48 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 18:26:48 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 18:26:48 INFO - Using env: {'DISPLAY': ':0', 18:26:48 INFO - 'HOME': '/home/cltbld', 18:26:48 INFO - 'LANG': 'en_US.UTF-8', 18:26:48 INFO - 'LANGUAGE': 'en_US:en', 18:26:48 INFO - 'LOGNAME': 'cltbld', 18:26:48 INFO - 'MAIL': '/var/mail/cltbld', 18:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:48 INFO - 'MOZ_NO_REMOTE': '1', 18:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:48 INFO - 'NO_EM_RESTART': '1', 18:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:48 INFO - 'PWD': '/builds/slave/test', 18:26:48 INFO - 'SHELL': '/bin/bash', 18:26:48 INFO - 'SHLVL': '1', 18:26:48 INFO - 'TERM': 'linux', 18:26:48 INFO - 'TMOUT': '86400', 18:26:48 INFO - 'USER': 'cltbld', 18:26:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:48 INFO - '_': '/tools/buildbot/bin/python'} 18:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:48 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 18:26:48 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 18:26:48 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 18:26:48 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 18:26:48 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 18:26:48 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 18:26:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:50 INFO - Downloading docopt-0.6.1.tar.gz 18:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:51 INFO - Running setup.py install for blobuploader 18:26:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:51 INFO - Running setup.py install for requests 18:26:51 INFO - Running setup.py install for docopt 18:26:51 INFO - Successfully installed blobuploader requests docopt 18:26:51 INFO - Cleaning up... 18:26:51 INFO - Return code: 0 18:26:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:51 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')]} 18:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:51 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')]} 18:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:51 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:51 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 18:26:51 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 18:26:51 INFO - Using env: {'DISPLAY': ':0', 18:26:51 INFO - 'HOME': '/home/cltbld', 18:26:51 INFO - 'LANG': 'en_US.UTF-8', 18:26:51 INFO - 'LANGUAGE': 'en_US:en', 18:26:51 INFO - 'LOGNAME': 'cltbld', 18:26:51 INFO - 'MAIL': '/var/mail/cltbld', 18:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:51 INFO - 'MOZ_NO_REMOTE': '1', 18:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:51 INFO - 'NO_EM_RESTART': '1', 18:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:51 INFO - 'PWD': '/builds/slave/test', 18:26:51 INFO - 'SHELL': '/bin/bash', 18:26:51 INFO - 'SHLVL': '1', 18:26:51 INFO - 'TERM': 'linux', 18:26:51 INFO - 'TMOUT': '86400', 18:26:51 INFO - 'USER': 'cltbld', 18:26:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:51 INFO - '_': '/tools/buildbot/bin/python'} 18:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:51 INFO - Running setup.py (path:/tmp/pip-B_Nh1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:51 INFO - Running setup.py (path:/tmp/pip-DTSRdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:52 INFO - Running setup.py (path:/tmp/pip-uNYjQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:52 INFO - Running setup.py (path:/tmp/pip-EhB5an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:52 INFO - Running setup.py (path:/tmp/pip-a_tLXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:52 INFO - Running setup.py (path:/tmp/pip-S9j90t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:52 INFO - Running setup.py (path:/tmp/pip-Wk_8s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:52 INFO - Running setup.py (path:/tmp/pip-gnWqQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:52 INFO - Running setup.py (path:/tmp/pip-sGgcvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:52 INFO - Running setup.py (path:/tmp/pip-wtLZeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:52 INFO - Running setup.py (path:/tmp/pip-7Zr0fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:52 INFO - Running setup.py (path:/tmp/pip-EiOAw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:52 INFO - Running setup.py (path:/tmp/pip-duviB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:52 INFO - Running setup.py (path:/tmp/pip-kATQZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:52 INFO - Running setup.py (path:/tmp/pip-kiKITh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:52 INFO - Running setup.py (path:/tmp/pip-jxhacv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:53 INFO - Running setup.py (path:/tmp/pip-I2eApl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:53 INFO - Running setup.py install for manifestparser 18:26:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Running setup.py install for mozcrash 18:26:53 INFO - Running setup.py install for mozdebug 18:26:53 INFO - Running setup.py install for mozdevice 18:26:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Running setup.py install for mozfile 18:26:53 INFO - Running setup.py install for mozhttpd 18:26:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Running setup.py install for mozinfo 18:26:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Running setup.py install for mozInstall 18:26:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:53 INFO - Running setup.py install for mozleak 18:26:54 INFO - Running setup.py install for mozlog 18:26:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Running setup.py install for moznetwork 18:26:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Running setup.py install for mozprocess 18:26:54 INFO - Running setup.py install for mozprofile 18:26:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Running setup.py install for mozrunner 18:26:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Running setup.py install for mozscreenshot 18:26:54 INFO - Running setup.py install for moztest 18:26:54 INFO - Running setup.py install for mozversion 18:26:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:54 INFO - Cleaning up... 18:26:54 INFO - Return code: 0 18:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:54 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')]} 18:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:54 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')]} 18:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:54 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:54 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 18:26:54 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 18:26:54 INFO - Using env: {'DISPLAY': ':0', 18:26:54 INFO - 'HOME': '/home/cltbld', 18:26:54 INFO - 'LANG': 'en_US.UTF-8', 18:26:54 INFO - 'LANGUAGE': 'en_US:en', 18:26:54 INFO - 'LOGNAME': 'cltbld', 18:26:54 INFO - 'MAIL': '/var/mail/cltbld', 18:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:54 INFO - 'MOZ_NO_REMOTE': '1', 18:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:54 INFO - 'NO_EM_RESTART': '1', 18:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:54 INFO - 'PWD': '/builds/slave/test', 18:26:54 INFO - 'SHELL': '/bin/bash', 18:26:54 INFO - 'SHLVL': '1', 18:26:54 INFO - 'TERM': 'linux', 18:26:54 INFO - 'TMOUT': '86400', 18:26:54 INFO - 'USER': 'cltbld', 18:26:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:54 INFO - '_': '/tools/buildbot/bin/python'} 18:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:55 INFO - Running setup.py (path:/tmp/pip-MMwivG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:55 INFO - Running setup.py (path:/tmp/pip-NgfEF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:55 INFO - Running setup.py (path:/tmp/pip-2LQJmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:55 INFO - Running setup.py (path:/tmp/pip-pPGN_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:55 INFO - Running setup.py (path:/tmp/pip-24cKrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:55 INFO - Running setup.py (path:/tmp/pip-ikX5KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:55 INFO - Running setup.py (path:/tmp/pip-Je1wKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:55 INFO - Running setup.py (path:/tmp/pip-d7ZLav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:55 INFO - Running setup.py (path:/tmp/pip-RfSLdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:55 INFO - Running setup.py (path:/tmp/pip-Bsqtid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:55 INFO - Running setup.py (path:/tmp/pip-fJpILC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:55 INFO - Running setup.py (path:/tmp/pip-YCO0sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:55 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)) 18:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:56 INFO - Running setup.py (path:/tmp/pip-gohg3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:56 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)) 18:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:56 INFO - Running setup.py (path:/tmp/pip-SiQpW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:56 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)) 18:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:56 INFO - Running setup.py (path:/tmp/pip-PFzKyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:56 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)) 18:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:56 INFO - Running setup.py (path:/tmp/pip-fW4p4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:56 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)) 18:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:56 INFO - Running setup.py (path:/tmp/pip-5QtC94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:56 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)) 18:26:56 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)) 18:26:56 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)) 18:26:56 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)) 18:26:56 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)) 18:26:56 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)) 18:26:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26:56 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 18:26:56 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 18:26:56 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 18:26:56 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 18:26:56 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 18:26:56 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 18:26:58 INFO - Downloading blessings-1.6.tar.gz 18:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:58 INFO - Installing collected packages: blessings 18:26:58 INFO - Running setup.py install for blessings 18:26:58 INFO - Successfully installed blessings 18:26:58 INFO - Cleaning up... 18:26:58 INFO - Return code: 0 18:26:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:58 INFO - Reading from file tmpfile_stdout 18:26:58 INFO - Current package versions: 18:26:58 INFO - argparse == 1.2.1 18:26:58 INFO - blessings == 1.6 18:26:58 INFO - blobuploader == 1.2.4 18:26:58 INFO - docopt == 0.6.1 18:26:58 INFO - functools32 == 3.2.3-2 18:26:58 INFO - jsonschema == 2.5.1 18:26:58 INFO - manifestparser == 1.1 18:26:58 INFO - mozInstall == 1.12 18:26:58 INFO - mozcrash == 0.17 18:26:58 INFO - mozdebug == 0.1 18:26:58 INFO - mozdevice == 0.48 18:26:58 INFO - mozfile == 1.2 18:26:58 INFO - mozhttpd == 0.7 18:26:58 INFO - mozinfo == 0.9 18:26:58 INFO - mozleak == 0.1 18:26:58 INFO - mozlog == 3.4 18:26:58 INFO - moznetwork == 0.27 18:26:58 INFO - mozprocess == 0.23 18:26:58 INFO - mozprofile == 0.28 18:26:58 INFO - mozrunner == 6.12 18:26:58 INFO - mozscreenshot == 0.1 18:26:58 INFO - mozsystemmonitor == 0.3 18:26:58 INFO - moztest == 0.7 18:26:58 INFO - mozversion == 1.4 18:26:58 INFO - psutil == 3.1.1 18:26:58 INFO - requests == 1.2.3 18:26:58 INFO - wsgiref == 0.1.2 18:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:58 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')]} 18:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:58 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')]} 18:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:58 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:58 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 18:26:58 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 18:26:58 INFO - Using env: {'DISPLAY': ':0', 18:26:58 INFO - 'HOME': '/home/cltbld', 18:26:58 INFO - 'LANG': 'en_US.UTF-8', 18:26:58 INFO - 'LANGUAGE': 'en_US:en', 18:26:58 INFO - 'LOGNAME': 'cltbld', 18:26:58 INFO - 'MAIL': '/var/mail/cltbld', 18:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:58 INFO - 'MOZ_NO_REMOTE': '1', 18:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:58 INFO - 'NO_EM_RESTART': '1', 18:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:58 INFO - 'PWD': '/builds/slave/test', 18:26:58 INFO - 'SHELL': '/bin/bash', 18:26:58 INFO - 'SHLVL': '1', 18:26:58 INFO - 'TERM': 'linux', 18:26:58 INFO - 'TMOUT': '86400', 18:26:58 INFO - 'USER': 'cltbld', 18:26:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:58 INFO - '_': '/tools/buildbot/bin/python'} 18:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 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)) 18:26:58 INFO - Cleaning up... 18:26:58 INFO - Return code: 0 18:26:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26:58 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')]} 18:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:58 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')]} 18:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:58 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 0x7f183956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d547b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, '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': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', '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 18:26:58 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 18:26:58 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 18:26:58 INFO - Using env: {'DISPLAY': ':0', 18:26:58 INFO - 'HOME': '/home/cltbld', 18:26:58 INFO - 'LANG': 'en_US.UTF-8', 18:26:58 INFO - 'LANGUAGE': 'en_US:en', 18:26:58 INFO - 'LOGNAME': 'cltbld', 18:26:58 INFO - 'MAIL': '/var/mail/cltbld', 18:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:58 INFO - 'MOZ_NO_REMOTE': '1', 18:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:58 INFO - 'NO_EM_RESTART': '1', 18:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:58 INFO - 'PWD': '/builds/slave/test', 18:26:58 INFO - 'SHELL': '/bin/bash', 18:26:58 INFO - 'SHLVL': '1', 18:26:58 INFO - 'TERM': 'linux', 18:26:58 INFO - 'TMOUT': '86400', 18:26:58 INFO - 'USER': 'cltbld', 18:26:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:58 INFO - '_': '/tools/buildbot/bin/python'} 18:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:26:59 INFO - Cleaning up... 18:26:59 INFO - Return code: 0 18:26:59 INFO - Running post-action listener: _resource_record_post_action 18:26:59 INFO - Running post-action listener: _start_resource_monitoring 18:26:59 INFO - Starting resource monitoring. 18:26:59 INFO - [mozharness: 2016-09-30 01:26:59.227704Z] Finished create-virtualenv step (success) 18:26:59 INFO - [mozharness: 2016-09-30 01:26:59.228172Z] Running install step. 18:26:59 INFO - Running pre-action listener: _resource_record_pre_action 18:26:59 INFO - Running main action method: install 18:26:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:59 INFO - Reading from file tmpfile_stdout 18:26:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:59 INFO - Reading from file tmpfile_stdout 18:26:59 INFO - Output received: 18:26:59 INFO - Usage: mozinstall [options] installer 18:26:59 INFO - Options: 18:26:59 INFO - -h, --help show this help message and exit 18:26:59 INFO - -d DEST, --destination=DEST 18:26:59 INFO - Directory to install application into. [default: 18:26:59 INFO - "/builds/slave/test"] 18:26:59 INFO - --app=APP Application being installed. [default: firefox] 18:26:59 INFO - mkdir: /builds/slave/test/build/application 18:26:59 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'] 18:26:59 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 18:27:16 INFO - Reading from file tmpfile_stdout 18:27:16 INFO - Output received: 18:27:16 INFO - /builds/slave/test/build/application/firefox/firefox 18:27:16 INFO - Running post-action listener: _resource_record_post_action 18:27:16 INFO - [mozharness: 2016-09-30 01:27:16.539261Z] Finished install step (success) 18:27:16 INFO - [mozharness: 2016-09-30 01:27:16.539508Z] Running run-tests step. 18:27:16 INFO - Running pre-action listener: _resource_record_pre_action 18:27:16 INFO - Running main action method: run_tests 18:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:27:16 INFO - Python 2.7.3 18:27:16 INFO - Return code: 0 18:27:16 INFO - grabbing minidump binary from tooltool 18:27: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')]} 18:27:16 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 0x1de3790>, '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 0x1de4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:27:16 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 18:27:16 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 18:27:16 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 18:27:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:27:16 INFO - Return code: 0 18:27:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:27:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:27:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:27:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:27:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:27:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:27:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:27:16 INFO - Using env: {'DISPLAY': ':0', 18:27:16 INFO - 'HOME': '/home/cltbld', 18:27:16 INFO - 'LANG': 'en_US.UTF-8', 18:27:16 INFO - 'LANGUAGE': 'en_US:en', 18:27:16 INFO - 'LOGNAME': 'cltbld', 18:27:16 INFO - 'MAIL': '/var/mail/cltbld', 18:27:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:27:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:16 INFO - 'MOZ_NO_REMOTE': '1', 18:27:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:27:16 INFO - 'NO_EM_RESTART': '1', 18:27:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:16 INFO - 'PWD': '/builds/slave/test', 18:27:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:27:16 INFO - 'SHELL': '/bin/bash', 18:27:16 INFO - 'SHLVL': '1', 18:27:16 INFO - 'TERM': 'linux', 18:27:16 INFO - 'TMOUT': '86400', 18:27:16 INFO - 'USER': 'cltbld', 18:27:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983', 18:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:16 INFO - '_': '/tools/buildbot/bin/python'} 18:27:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:27:16 INFO - mozversion application_buildid: 20160929153009 18:27:16 INFO - mozversion application_changeset: 500496dfefccc73d1f87ff912563a8ee1afe8e91 18:27:16 INFO - mozversion application_display_name: Nightly 18:27:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:27:16 INFO - mozversion application_name: Firefox 18:27:16 INFO - mozversion application_remotingname: firefox 18:27:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:27:16 INFO - mozversion application_vendor: Mozilla 18:27:16 INFO - mozversion application_version: 52.0a1 18:27:16 INFO - mozversion platform_buildid: 20160929153009 18:27:16 INFO - mozversion platform_changeset: 500496dfefccc73d1f87ff912563a8ee1afe8e91 18:27:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:27:16 INFO - mozversion platform_version: 52.0a1 18:27:16 INFO - using testdate: 1475198836 18:27:16 INFO - actual date: 1475198836 18:27:16 INFO - starting webserver on 'localhost:42920' 18:27:16 INFO - SUITE-START | Running 2 tests 18:27:16 INFO - TEST-START | dromaeo_css 18:27:16 INFO - operating with platform_type : linux_ 18:27:16 INFO - Initialising browser for dromaeo_css test... 18:27:16 INFO - TEST-INFO | started process 23334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmply1AbB/profile http://localhost:42920/getInfo.html) 18:27:21 INFO - PROCESS | 23334 | __metrics Screen width/height:1600/1200 18:27:21 INFO - PROCESS | 23334 | colorDepth:24 18:27:21 INFO - PROCESS | 23334 | Browser inner width/height: 1024/697 18:27:21 INFO - PROCESS | 23334 | __metrics 18:27:22 ERROR - PROCESS | 23334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 18:27:23 INFO - TEST-INFO | 23334: exit 0 18:27:23 INFO - Browser initialized. 18:27:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:27:23 INFO - TEST-INFO | started process 23458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmply1AbB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:35 INFO - PROCESS | 23458 | RSS: Main: 185634816 18:27:35 INFO - PROCESS | 23458 | 18:28:25 INFO - PROCESS | 23458 | 1475198905015 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] 18:30:34 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:42920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42920/tests/dromaeo/cssquery-ext.html) 18:30:35 INFO - PROCESS | 23458 | RSS: Main: 200216576 18:30:35 INFO - PROCESS | 23458 | 18:33:38 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:42920/tests/dromaeo/cssquery-ext.html (next: http://localhost:42920/tests/dromaeo/cssquery-jquery.html) 18:33:38 INFO - PROCESS | 23458 | RSS: Main: 196505600 18:33:38 INFO - PROCESS | 23458 | 18:36:40 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:42920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42920/tests/dromaeo/cssquery-mootools.html) 18:36:41 INFO - PROCESS | 23458 | RSS: Main: 197988352 18:36:41 INFO - PROCESS | 23458 | 18:39:42 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:42920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42920/tests/dromaeo/cssquery-prototype.html) 18:39:43 INFO - PROCESS | 23458 | RSS: Main: 195018752 18:39:43 INFO - PROCESS | 23458 | 18:42:46 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:42920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42920/tests/dromaeo/cssquery-yui.html) 18:42:46 INFO - PROCESS | 23458 | RSS: Main: 198295552 18:42:46 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:42920/tests/dromaeo/cssquery-yui.html (next: http://localhost:42920/tests/dromaeo/cssquery-dojo.html) 18:45:49 INFO - PROCESS | 23458 | RSS: Main: 198807552 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | __start_tp_report 18:45:49 INFO - PROCESS | 23458 | _x_x_mozilla_page_load 18:45:49 INFO - PROCESS | 23458 | _x_x_mozilla_page_load_details 18:45:49 INFO - PROCESS | 23458 | |i|pagename|runs| 18:45:49 INFO - PROCESS | 23458 | |0;dojo.html;2992.8802847886086;3012.5330573761075;3031.7423019043395;3050.1612056684407;3067.6778938211487;5198.844034678957;5345.89308213836;5353.330833645794;5421.972890135548;5499.7250137493065;5255.76349064292;5309.203619457084;5334.813281535147;5390.00284947285;5400.189971504276;4812.663113582051;4845.733484658343;4950.826721064764;4957.529034741694;4970.179920313144;4826.806927722887;4925.975370123145;5005.749712514378;5016.949830501685;5061.038402703493;4752.7861246244;4789.2816077588295;4820.903581928342;4850.054239423313;4868.90449648828;4842.612590992712;4909.042736666352;4945.579625731817;4957.851264462072;4974.925376119325;4879.219324907997;4881.243407271879;4906.9263961040615;4910.21436570147;4968.45347011832;5138.511841375063;5168.8449346519665;5358.410574836765;5359.196120581905;5364.088105022156;5695.1741997410145;5739.282589676291;5739.971300143514;5759.078547432391;5838.095095260242;5813.593048486608;5822.534197264209;5823.301203855522;5824.097264923944;5832.708364581754;5223.921641175385;5372.946270537283;5378.704171270618;5383.650062745909;5398.325209348832;5767.711614419262;5840.707964601838;5884.852878678067;5900.940990590125;5993.940060599338;5618.129189975561;5660.122680984454;5664.405237450091;5664.745086471119;5668.801591944262;5709.600327977002;5731.512821410143;5735.311762588516;5753.453421924911;5759.280089988752;5555.666660000332;5615.691136987505;5615.831525054255;5633.802816901389;5715.571332150105;5629.915551266734;5742.13867919807;5749.108888122348;5760.51035661965;5764.423557644286;4472.217361961643;4477.350784136347;4492;4499.6400287976885;4549.067441174551;3912.374020156761;3926.764394136361;3986.720929534905;3997.5003124609425;4020.557738648746;5413.648112872651;5512.33851937762;5514.310711161105;5552.91670624941;5565.499105080562;5766.88466230673;5812.215350927655;5814.6220495668495;5814.738336774855;5839.795607153729;5323.254744335796;5437.102878025082;5496.862578435571;5501.559875209973;5502.422245664227;4850.975745121252;4939.851804445872;4951.876203094951;4981.800727970913;5062.7468626568525;6012.308584512837;6014.428629280212;6016.217891674054;6016.789412370546;6024.096385542116;5829.854253643693;5833.183354330482;5833.300003999547;5834.474897259267;5845.035569131046;5782.306123265067;5836.978528757535;5897.292324920865;5933.643981361132;5947.1079338099635;5579.46995035471;5625.268715067015;5628.493435590816;5628.746706398304;5695.373508913934;5708.172315014383;5751.597388182787;5762.913556296575;5763.962486752424;5769.048107062287;5442.972785136049;5499.340079190522;5532.446755324436;5565.1930470082425;5594.992901277809;5597.3003374578175;5599.580031497572;5604.607677462538;5644.463775941279;5656.830295091154;5544.556435485071;5575.581831362583;5581.609287349846;5591.608587398843;5598.272224610774;5349.144136938071;5482;5594.104943209067;5617.129344951539;5643.802466913638;5541.833744987657;5542.806001790079;5547.805826796204;5549.5837812163445;5595.916061259003 18:45:49 INFO - PROCESS | 23458 | |1;ext.html;575.309628445865;582.3710392775803;582.5077809251181;585.5842351930129;599.0714392691327;41272.79363603181;43301.35047974279;43614;47569.524304756946;47595.048099038;45466.545334546645;46088.769556152256;46103;46121.308180377324;46378.76810615942;8946.821063578709;9056.683016094437;9061.50161741104;9063.59213835379;9091;8872.512011839379;9007.099290071006;9016.143466370717;9020.41367311126;9043.050479699636;9054.909450905505;9096.0449152839;9114.680986165486;9125.22435592972;9143.771405714877;8945.821083578292;8985.281177505783;9026.277897768163;9061.68284110053;9061.909380906238;8788.692395766118;8839.69061082859;8866;8876.289896808305;8960.820783584291;42650.78674606607;42828.785856070834;42916.57083429157;42948.1410371794;43373.78313108414;3256.397566450214;3390.271091715293;3456.395130852116;3467;3890.824912878899;32076.83961580177;32214.19464513406;32968.6703132968;32968.67031329704;33121.3375732484;4331.662198124219;4345.630621397185;4351.630111440531;4403.977980110111;4432.756198409086;241713;242167;243690;345780;346084;52621.7368913153;52698.47301526936;52779;52787.73606131945;52794;35860.46209306862;37307;37467.437988430196;39603.603963960566;39763.427205871114;15135.924320378328;15363;15398.692026159413;15400.768988465183;15466.536003919675;10451.268411211295;10495.685129446128;10501.264911456277;10522.421266830244;10531.315464494783;19224.231030758892;19259.90370048169;19302.22791088369;19312.4206273812;19335.51661208481;6873.20958089816;6931.653417329113;7243.782686519413;7249.818754531074;7355.161209697576;898.2409863665192;1007.4912169354429;1045.9738506537396;1060.8992145746142;1118.927269727465;32016.359672806415;32141.51787723186;32249.35501290008;32442.188945276557;32443.837780810944;968.8352979993418;1023.488255872064;1124.7188202949262;1158.449736375215;1191.184038933316;16374.508764737076;16492.505224843273;16519;16544;16784.160791960352;765858;774094;775930;777340;787916;57691.711541442026;57984.42015579875;58386;58486.41513584895;58754.706226468596;1308.672831792052;1308.908376413661;1321.9272939988393;1342.8187194728782;1357.253510569183;30065.561819352934;31784.523232151998;31893.8405307972;32576.83711581427;32713.836430817693;52195;52875.47124528705;53035.469645303056;53069.20396193983;53111.20333194928;490129;491409;491845;493291.40566023125;495886;28403.43193136167;28409.57385639176;29121.85439072791;29260.414791704472;29280.41439171162;47463.762681186374;47681;48125;48144.51855481401;49066;39534.40698389469;39778.2044359117;40109.59890401176;40455.59544404518;42304.57695423129;39240;39415.408768867914;40113.39829902496;40993;41118.65457490507;35587.466188006685;37821.62178378181;39894.40158397568;40951;43594.56405435905;34166.82916585401;36480.27039459249;37243.25513489661;37388.813055934545;37549.24901502009;27673.584896226974;28086.71913280841;28151.296217594725;28197.295067623472;28350 18:45:49 INFO - PROCESS | 23458 | |2;jquery.html;374.7189607794156;383.565173868012;392.3389089384387;395.4937679769894;415.6820032675004;16245.350185992576;16972.575685607833;18149.637007259862;19754.90122549387;19812.108455119534;12448.751024979494;12548.372581370917;12558;12861.877790164612;12984;5244.370675518943;5446.537044351235;5446.564274858021;5448.318960129984;5451.618386712912;5151.459096794839;5212.374515058198;5224.746060945384;5780.942190578083;5797.71011449428;5775.249217601706;5781.19063331134;5785.537157027448;5790.276215473066;5807;5365.865853353678;5371.57027437804;5391.973040134774;5534.4742249486235;5762.078067509199;5221.817236396746;5227.921581176285;5238.842834714965;5246.3704355477585;5250.474952504757;14016.22910739909;14225.573232803032;14281.285935703174;14526.782098268535;14531.636709082357;2078.4699901525014;2119.279444988696;2134.4877229464973;2142.6250406178856;2248.482848944752;9956;10265.897341026643;10424.68725938223;10586.470676466146;10611;1699.77902872627;1735.7743493345783;1748.4142812157816;1748.5104170832187;1757.0863151161325;82246;85956;86705;87884;89903.99999999935;10757.83863242052;10759.031687148194;10780.892191078146;10909.39998300101;10950.123990080774;15881.761773573406;15925.840741592667;15935.362585496681;15991.520254392386;16025.59936001586;7345.751222292223;7614.390848732088;7624.580648064299;7743.225677432211;7856.057273127261;6963.9303606964295;7097.787066388017;7225.169105552824;7300.269973002657;7321.121465424183;4777.140114779373;4846.588040016568;4854.927176092361;4940.728259945666;4962.33008543842;1930.362980216525;1967.281942091155;2012.3661046770221;2026.6794520274204;2069.368842503021;849.8002969302332;930.432436213909;961.8557216417454;966.4491239993278;987.4766373821886;18222.180001899946;18797.530061748566;19441.51396215106;19518.609627807364;19788;989.6387818446216;1000.6247657128577;1005.2410430125209;1018.2057994764095;1020.8672872526524;10252.538635761408;10695.304805187638;10776.838347424795;10777.299475534066;10813.134949204044;440921;458687;459167;460673;460691;87746;89063.55468222617;89138.10861891428;89565;89718;972.2319367699438;986.1026465916125;994.380455143279;997.6957028106352;998.2164001258977;16499.67000659956;16744.74882876782;16770.748438773186;17100.401485947932;17228.052457114478;40122.1975560493;40757.79621101876;41013.58986410217;41672.58327416687;42021.78989105035;52713;53825.73087134539;58067;58231;58769;8472.957635211784;8614.698485552975;8695.652173913226;8702.434341767765;9044.457332560067;7303.525270857377;9519.906440230767;11083.8361971995;12214.206076604993;12897.290649014394;9809.313348065567;9913.702588922344;10027.899721002697;10212.336198147097;10920.50857711389;10126.088652021353;10164.593416263562;10416.375017498975;10779;10810.459477026274;5760.251167348218;10087.546060427445;10243.38539687621;10469.738256543342;10555.683329500127;7579.1284002340435;8413.368997325102;8608.09614990417;8667.133286671535;8779.429337093068;9632.47021413829;10215.774107106898;10259.384436933808;10372.118369938338;10620.84068738954 18:45:49 INFO - PROCESS | 23458 | |3;mootools.html;1418.312118622468;1476.6382236352092;1608.5656872644386;1741.0511271357109;1776.6180271241687;7652.349550288218;7924.207579242073;8545.273651739602;9197.540122993849;9256.398334108286;8607.741767746962;8884.466931984085;8895.199432051115;9112.589933452993;9167.679131230409;2336.4275752440676;2355.057976809273;2363.6809030780882;2368.798652114572;2377.4769550698907;2299.37916762474;2306.6194077977116;2336.918207862725;2350.3066595354326;2351.541449417364;2321.8839058047115;2325.9534809303805;2333.6499525071204;2359.976400235993;2363.881805909706;2238.9216377426874;2275.52214035052;2280.1221529711015;2280.2589158523465;2308.249818808894;2224.922127725522;2232.497688020199;2254.0052053932222;2256.3907744908784;2260.5026894083276;9029.909700902972;9033.322500812399;9095.63617455301;9117.77205569866;9121.726348209564;5261.921071183935;5462.726863656841;5478.479544443271;5492.725363731797;5500.58745594082;3358.613759417674;3410.4641718010153;3438.7592868499214;3545.592256890465;3552.0942159749097;1102.327580176092;1109.1902910875106;1110.0118717847297;1124.8425220469142;1139.117184182257;12819.551315703999;12845.100842940998;12882.48470061187;12914.354282285849;12917.67705807353;4722.88192795176;4741.95258047422;4827.927581086286;4839;4920.286558449005;10666.733331666615;10704.1436685065;10710.196735244888;10717.410542420243;10741.89258107409;5301.390340110936;5339.225812257201;5342.519173274346;5352.357717073976;5362.517373436332;4332.935005974913;4451.888702782391;4782.306565547976;4920.778564964514;5000.574951129122;3883.1457079442475;3954.4859168308512;3995.9200815983518;4049.6760259179196;4068.6745060395097;1220.6338098570393;1234.1422711215619;1236.7341021680202;1248.350857554085;1258.6349958511928;781.6677911887425;870.734426000076;882.8099484367701;886.3175354976632;913.2374467319862;5596.048671725735;5637.703328234529;5705.5435565154685;5805.216295800013;6014.669193194416;986.6300137448457;1017.2828156149897;1044.9111825494765;1063.2875973098044;1065.2862582070031;3867.43922131295;3895.2014836958356;3985.601439856049;3997.5003124609425;4063.065494936181;10757.462126893624;10955.890441095487;11067.889321106846;11068.944655276671;11107.666769996913;10571.471426428801;10662.840057399146;10889.727756806144;10903.29128606638;10950.34297942126;8393.664253429795;8397.454165479225;8422.494650321001;8438.409311348147;8509.936257967754;5700.800471983461;5719.113537401709;5776.480116789509;5807.796727114531;5964.5526585505395;10359.378437293786;10383.169346452114;10454.581816727246;10584.576616935545;10594.046535811814;9685.370450920667;10127.291089623655;10140.898591013995;10242.692719218436;10426.113780328757;6988.161420629557;7161.140663120459;7704.92295077042;7764.262395072459;7891.526508409514;8439.493630382196;8499.235068843835;8588.785280368042;8823.02946675878;8859.335549833659;7776.650050747843;7870.1898563329605;8013.559254241072;8069.59652017385;8107.797305067421;7433.331000210007;7551;7625.046869141357;7669.9616501917135;7708.229177082247;6731.990201469819;6796.320367963164;6812.284710105368;6817.863642727217;6861.176658800976;4961.330220420341;4961.742407204641;4971.801127954841;5002.799888004584;5190.702324418895;4936.7284799336385;4999.225120106389;5074.416442109205;5091.338126043591;5098.592112630907 18:45:49 INFO - PROCESS | 23458 | |4;prototype.html;328.6746121339873;329.44159649394277;337.2462546209222;339.8878370137855;341.9111031131907;5376.247325374451;5480.588955828319;5504.697241651707;5581.553475721943;5585.636933599313;5300.284461597693;5380.542653874425;5413.26920865683;5427.267318911946;5454.645448045874;4298.140371925611;4310.590493903074;4311;4312.654987600992;4331.220380331539;4173.24881521326;4289.721168124062;4304.913901721964;4318.611324980751;4319.200947824646;4258.382534532491;4280.721753086055;4284.528701842794;4286.142771445708;4287.892802679942;4251.97874010631;4274;4287.464066991626;4314.158739045887;4314.395984562164;3723.646253605903;3835.2329534093014;3837.194189220267;3837.2325534893134;3838.7312888097845;5320.228566857822;5323.600729945269;5369.355677318707;5408.512084441162;5415.83752487426;4865.321464094882;4922.975385123087;4927.605791536668;4930.531599498042;4931.5315045070665;5552;5689.231953686241;5759.7536960584985;5770.6249093808765;5804.2744656917885;4150.132440401831;4159.168166366709;4196.664266858644;4201.222773786859;4202.642775364097;6014.428629280212;6057.909131363033;6064;6066.454019138255;6082.635041897456;4068.572799856032;4244.936325955113;4319.250703465102;4319.9784001080425;4329.458817647794;4307.956920430818;4326.63223625989;4337.175936572041;4348.978255108767;4388.319810429389;4964.280179373971;4968;4970.925436118461;4971.353724015855;4988.6009119270375;5531.502164805187;5783.797567085216;5844.357120716718;5845.473907348274;5855.414458554111;1453.738327101132;1499.1754535005703;1500.5348342013792;1505.893168521136;1508.1177511155877;946.4699768129869;955.7706150523824;967.7628980899725;974.9268804839666;978.9412635241766;4931;4945.9752701236985;4957.380327459067;4958.652909286217;4988.251762235694;5162.9741851291255;5203.297554830126;5217.556507696889;5244.767479642281;5270.2594650781375;4746.976265118721;4897.7755561109725;4909.656324057353;4917.270914642408;4919.926201106986;2763.06055940981;2789.995601583428;2793.0364024411547;2813.84740673385;2831.5134554358715;5315.574754019669;5336.546393556514;5343.8585096549705;5370.670184485644;5421.945780542223;5253.894922101536;5286.656367336188;5692.573057020657;6115.816525504242;6146.446819786241;6156.230471191101;6171.783987560414;6173.41352571505;6179.876402471926;6208.844778880474;5641.746121424464;5955.880882382415;5959.493443057216;5984.371640977809;5986.2517185351835;5782.508486778671;5799.623024503394;5809;5847.152162936435;5853.912191317048;6176.9073463897175;6177.104319873683;6189.81430557084;6197.783077592443;6235.937640623536;4115.156982680883;4231.767252801125;4243.299855523804;4243.5332113466875;4257.531671516069;5797.797077102281;5930.649183211472;5954.493868021266;5990;6002;5823.213866128188;5823.621464604787;5825.679587622722;5839.766409343579;5851.268591426072;5791.218185544897;5805.996931058778;5806.68063256525;5829.417058294137;5841.853953651193;5595.972020139873;5740.712964351682;5744.167095771173;5770.682612456355;5821.912671310019;5789.421057894346;5792.884142317046;5805.680687562224;5833.8249852502795;5858.443447872445;5400.864978375572;5656.660600363827;5734.61657622005;5739.827805165852;5757.165211044291 18:45:49 INFO - PROCESS | 23458 | |5;yui.html;723.1864152828068;738.575319191465;758.9794401783503;777.1373775109623;821.7575815134533;14206.57380278592;14488.348024338904;14935.477258295961;14998.550043498684;15003.399864005427;13626.454941802342;13645.590632281022;13657.180569165857;13664.795028074586;13781.310934453288;779.9181085985975;788.8106854354957;799.0411506192563;801.1867954026668;801.9318357939553;803.9638216280281;811.7321283976273;811.9553424561647;813.7314686153555;814.7189219719187;854.8803167556547;856.1609622569886;856.2764464027887;857.3655494933736;857.6569372251118;846.724814435308;847.4279861093768;847.5211505499373;847.5846835050843;848.516345682961;619.1610367951452;621.3817251834408;621.3817251834454;623.4762799248607;624.3257282135284;14502.564923052325;14647.194404307758;14661.266936653125;14665.56003319902;14670.339834707356;14105.2242126683;14163.716725665532;14325;14333.928330358385;14439;10408.687739367755;10479.161667066617;10529.684109476728;10549.10332621728;10603;3621.0947263184203;3634.4003239465455;3643.3988391915304;3733.5519737631384;3782.583915769263;82626;83131.5843420779;83833;84513;86199;8387.077421483631;8437.114103019218;8488.533130677748;8594.269487093667;8648.95675521631;19541.51146221356;20158.798412015985;20177.293794717116;20198.596028079355;20231.696524552142;8279.62741676626;8330.333573314121;8374.246317831303;8432.198941100585;8501.10738372462;4422.248217802981;4448.110377924428;4510.954890451119;4539.7049191802425;4559.940919026338;3650.4889315495852;3785.432185172191;3789.2800367930004;3794.4687743715904;3796.2027974125745;616.1712496691943;619.8605313804358;630.8265227062503;642.4154019842015;645.1290757477461;685.2842146959774;685.8353995041155;688.0985908459934;689.9413549848218;723.9203687594361;8907.955460222787;8993.24432363288;9064.365494415328;9113.77215569616;9245.676401325922;740.1872883044409;750.9098908131059;756.587659725451;759.2293821770907;771.1941021632408;4283.2290187765875;4462.754548499864;4499.280115181556;4593.311003349524;4609.372657585144;93515.53242233745;98485.50757246312;107492.46253768838;107950.46024769825;108224;92255.53872230597;94830.52584737031;96929.51535242419;97282.05435891384;98010;78552.60723696345;82198.58900705459;87409;87409.56295218483;88453.99999999872;8494;8638.870416943626;8655.30757539408;8979.086721989672;9378.202852757318;34052.31207374633;36269;40788.59211407848;44607.776961114985;48737.75631121822;69859.65070174617;71105;72937;74635.62682186555;75400.24599754151;12279.263244205376;12372.752544949231;12462.813057804322;12637.368131593199;12639.87360126387;12387.75224495523;13568.728625427239;13685.11046781956;13783.931080344533;14454.638634034232;11335.659930202108;12300.200486968319;12484;12757.067963397065;13389.933050335076;12473.189242699196;12596.496140154657;13083.476660933457;13306.600801975956;13584.25286609246;11219.831702524632;11316.434178290889;11557.47991340375;11577.594784182513;12052.578159764365;10330.896691032993;10342.689719308433;10361.792764144524;10479;10631.840522392326;10001.899981000388;10193.388396696222;10226.386416815016;10246.38521688701;10280.794384112425 18:45:49 INFO - PROCESS | 23458 | __end_tp_report 18:45:49 INFO - PROCESS | 23458 | __start_cc_report 18:45:49 INFO - PROCESS | 23458 | _x_x_mozilla_cycle_collect,309 18:45:49 INFO - PROCESS | 23458 | __end_cc_report 18:45:49 INFO - PROCESS | 23458 | __startTimestamp1475199949761__endTimestamp 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | ------- Summary: start ------- 18:45:49 INFO - PROCESS | 23458 | Number of tests: 6 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | [#0] dojo.html Cycles:165 Average:5340.12 Median:5549.58 stddev:606.77 (10.9%) stddev-sans-first:580.02 18:45:49 INFO - PROCESS | 23458 | Values: 2992.9 3012.5 3031.7 3050.2 3067.7 5198.8 5345.9 5353.3 5422.0 5499.7 5255.8 5309.2 5334.8 5390.0 5400.2 4812.7 4845.7 4950.8 4957.5 4970.2 4826.8 4926.0 5005.7 5016.9 5061.0 4752.8 4789.3 4820.9 4850.1 4868.9 4842.6 4909.0 4945.6 4957.9 4974.9 4879.2 4881.2 4906.9 4910.2 4968.5 5138.5 5168.8 5358.4 5359.2 5364.1 5695.2 5739.3 5740.0 5759.1 5838.1 5813.6 5822.5 5823.3 5824.1 5832.7 5223.9 5372.9 5378.7 5383.7 5398.3 5767.7 5840.7 5884.9 5900.9 5993.9 5618.1 5660.1 5664.4 5664.7 5668.8 5709.6 5731.5 5735.3 5753.5 5759.3 5555.7 5615.7 5615.8 5633.8 5715.6 5629.9 5742.1 5749.1 5760.5 5764.4 4472.2 4477.4 4492.0 4499.6 4549.1 3912.4 3926.8 3986.7 3997.5 4020.6 5413.6 5512.3 5514.3 5552.9 5565.5 5766.9 5812.2 5814.6 5814.7 5839.8 5323.3 5437.1 5496.9 5501.6 5502.4 4851.0 4939.9 4951.9 4981.8 5062.7 6012.3 6014.4 6016.2 6016.8 6024.1 5829.9 5833.2 5833.3 5834.5 5845.0 5782.3 5837.0 5897.3 5933.6 5947.1 5579.5 5625.3 5628.5 5628.7 5695.4 5708.2 5751.6 5762.9 5764.0 5769.0 5443.0 5499.3 5532.4 5565.2 5595.0 5597.3 5599.6 5604.6 5644.5 5656.8 5544.6 5575.6 5581.6 5591.6 5598.3 5349.1 5482.0 5594.1 5617.1 5643.8 5541.8 5542.8 5547.8 5549.6 5595.9 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | [#1] ext.html Cycles:180 Average:65900.84 Median:41195.72 stddev:149771.75 (363.6%) stddev-sans-first:150111.59 18:45:49 INFO - PROCESS | 23458 | Values: 575.3 582.4 582.5 585.6 599.1 41272.8 43301.4 43614.0 47569.5 47595.0 45466.5 46088.8 46103.0 46121.3 46378.8 8946.8 9056.7 9061.5 9063.6 9091.0 8872.5 9007.1 9016.1 9020.4 9043.1 9054.9 9096.0 9114.7 9125.2 9143.8 8945.8 8985.3 9026.3 9061.7 9061.9 8788.7 8839.7 8866.0 8876.3 8960.8 42650.8 42828.8 42916.6 42948.1 43373.8 3256.4 3390.3 3456.4 3467.0 3890.8 32076.8 32214.2 32968.7 32968.7 33121.3 4331.7 4345.6 4351.6 4404.0 4432.8 241713.0 242167.0 243690.0 345780.0 346084.0 52621.7 52698.5 52779.0 52787.7 52794.0 35860.5 37307.0 37467.4 39603.6 39763.4 15135.9 15363.0 15398.7 15400.8 15466.5 10451.3 10495.7 10501.3 10522.4 10531.3 19224.2 19259.9 19302.2 19312.4 19335.5 6873.2 6931.7 7243.8 7249.8 7355.2 898.2 1007.5 1046.0 1060.9 1118.9 32016.4 32141.5 32249.4 32442.2 32443.8 968.8 1023.5 1124.7 1158.4 1191.2 16374.5 16492.5 16519.0 16544.0 16784.2 765858.0 774094.0 775930.0 777340.0 787916.0 57691.7 57984.4 58386.0 58486.4 58754.7 1308.7 1308.9 1321.9 1342.8 1357.3 30065.6 31784.5 31893.8 32576.8 32713.8 52195.0 52875.5 53035.5 53069.2 53111.2 490129.0 491409.0 491845.0 493291.4 495886.0 28403.4 28409.6 29121.9 29260.4 29280.4 47463.8 47681.0 48125.0 48144.5 49066.0 39534.4 39778.2 40109.6 40455.6 42304.6 39240.0 39415.4 40113.4 40993.0 41118.7 35587.5 37821.6 39894.4 40951.0 43594.6 34166.8 36480.3 37243.3 37388.8 37549.2 27673.6 28086.7 28151.3 28197.3 28350.0 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | [#2] jquery.html Cycles:180 Average:27286.92 Median:41847.19 stddev:75565.64 (180.6%) stddev-sans-first:75750.61 18:45:49 INFO - PROCESS | 23458 | Values: 374.7 383.6 392.3 395.5 415.7 16245.4 16972.6 18149.6 19754.9 19812.1 12448.8 12548.4 12558.0 12861.9 12984.0 5244.4 5446.5 5446.6 5448.3 5451.6 5151.5 5212.4 5224.7 5780.9 5797.7 5775.2 5781.2 5785.5 5790.3 5807.0 5365.9 5371.6 5392.0 5534.5 5762.1 5221.8 5227.9 5238.8 5246.4 5250.5 14016.2 14225.6 14281.3 14526.8 14531.6 2078.5 2119.3 2134.5 2142.6 2248.5 9956.0 10265.9 10424.7 10586.5 10611.0 1699.8 1735.8 1748.4 1748.5 1757.1 82246.0 85956.0 86705.0 87884.0 89904.0 10757.8 10759.0 10780.9 10909.4 10950.1 15881.8 15925.8 15935.4 15991.5 16025.6 7345.8 7614.4 7624.6 7743.2 7856.1 6963.9 7097.8 7225.2 7300.3 7321.1 4777.1 4846.6 4854.9 4940.7 4962.3 1930.4 1967.3 2012.4 2026.7 2069.4 849.8 930.4 961.9 966.4 987.5 18222.2 18797.5 19441.5 19518.6 19788.0 989.6 1000.6 1005.2 1018.2 1020.9 10252.5 10695.3 10776.8 10777.3 10813.1 440921.0 458687.0 459167.0 460673.0 460691.0 87746.0 89063.6 89138.1 89565.0 89718.0 972.2 986.1 994.4 997.7 998.2 16499.7 16744.7 16770.7 17100.4 17228.1 40122.2 40757.8 41013.6 41672.6 42021.8 52713.0 53825.7 58067.0 58231.0 58769.0 8473.0 8614.7 8695.7 8702.4 9044.5 7303.5 9519.9 11083.8 12214.2 12897.3 9809.3 9913.7 10027.9 10212.3 10920.5 10126.1 10164.6 10416.4 10779.0 10810.5 5760.3 10087.5 10243.4 10469.7 10555.7 7579.1 8413.4 8608.1 8667.1 8779.4 9632.5 10215.8 10259.4 10372.1 10620.8 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | [#3] mootools.html Cycles:180 Average:5837.89 Median:4732.42 stddev:3369.23 (71.2%) stddev-sans-first:3362.32 18:45:49 INFO - PROCESS | 23458 | Values: 1418.3 1476.6 1608.6 1741.1 1776.6 7652.3 7924.2 8545.3 9197.5 9256.4 8607.7 8884.5 8895.2 9112.6 9167.7 2336.4 2355.1 2363.7 2368.8 2377.5 2299.4 2306.6 2336.9 2350.3 2351.5 2321.9 2326.0 2333.6 2360.0 2363.9 2238.9 2275.5 2280.1 2280.3 2308.2 2224.9 2232.5 2254.0 2256.4 2260.5 9029.9 9033.3 9095.6 9117.8 9121.7 5261.9 5462.7 5478.5 5492.7 5500.6 3358.6 3410.5 3438.8 3545.6 3552.1 1102.3 1109.2 1110.0 1124.8 1139.1 12819.6 12845.1 12882.5 12914.4 12917.7 4722.9 4742.0 4827.9 4839.0 4920.3 10666.7 10704.1 10710.2 10717.4 10741.9 5301.4 5339.2 5342.5 5352.4 5362.5 4332.9 4451.9 4782.3 4920.8 5000.6 3883.1 3954.5 3995.9 4049.7 4068.7 1220.6 1234.1 1236.7 1248.4 1258.6 781.7 870.7 882.8 886.3 913.2 5596.0 5637.7 5705.5 5805.2 6014.7 986.6 1017.3 1044.9 1063.3 1065.3 3867.4 3895.2 3985.6 3997.5 4063.1 10757.5 10955.9 11067.9 11068.9 11107.7 10571.5 10662.8 10889.7 10903.3 10950.3 8393.7 8397.5 8422.5 8438.4 8509.9 5700.8 5719.1 5776.5 5807.8 5964.6 10359.4 10383.2 10454.6 10584.6 10594.0 9685.4 10127.3 10140.9 10242.7 10426.1 6988.2 7161.1 7704.9 7764.3 7891.5 8439.5 8499.2 8588.8 8823.0 8859.3 7776.7 7870.2 8013.6 8069.6 8107.8 7433.3 7551.0 7625.0 7670.0 7708.2 6732.0 6796.3 6812.3 6817.9 6861.2 4961.3 4961.7 4971.8 5002.8 5190.7 4936.7 4999.2 5074.4 5091.3 5098.6 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | [#4] prototype.html Cycles:180 Average:4785.21 Median:5330.07 stddev:1409.36 (26.4%) stddev-sans-first:1373.04 18:45:49 INFO - PROCESS | 23458 | Values: 328.7 329.4 337.2 339.9 341.9 5376.2 5480.6 5504.7 5581.6 5585.6 5300.3 5380.5 5413.3 5427.3 5454.6 4298.1 4310.6 4311.0 4312.7 4331.2 4173.2 4289.7 4304.9 4318.6 4319.2 4258.4 4280.7 4284.5 4286.1 4287.9 4252.0 4274.0 4287.5 4314.2 4314.4 3723.6 3835.2 3837.2 3837.2 3838.7 5320.2 5323.6 5369.4 5408.5 5415.8 4865.3 4923.0 4927.6 4930.5 4931.5 5552.0 5689.2 5759.8 5770.6 5804.3 4150.1 4159.2 4196.7 4201.2 4202.6 6014.4 6057.9 6064.0 6066.5 6082.6 4068.6 4244.9 4319.3 4320.0 4329.5 4308.0 4326.6 4337.2 4349.0 4388.3 4964.3 4968.0 4970.9 4971.4 4988.6 5531.5 5783.8 5844.4 5845.5 5855.4 1453.7 1499.2 1500.5 1505.9 1508.1 946.5 955.8 967.8 974.9 978.9 4931.0 4946.0 4957.4 4958.7 4988.3 5163.0 5203.3 5217.6 5244.8 5270.3 4747.0 4897.8 4909.7 4917.3 4919.9 2763.1 2790.0 2793.0 2813.8 2831.5 5315.6 5336.5 5343.9 5370.7 5421.9 5253.9 5286.7 5692.6 6115.8 6146.4 6156.2 6171.8 6173.4 6179.9 6208.8 5641.7 5955.9 5959.5 5984.4 5986.3 5782.5 5799.6 5809.0 5847.2 5853.9 6176.9 6177.1 6189.8 6197.8 6235.9 4115.2 4231.8 4243.3 4243.5 4257.5 5797.8 5930.6 5954.5 5990.0 6002.0 5823.2 5823.6 5825.7 5839.8 5851.3 5791.2 5806.0 5806.7 5829.4 5841.9 5596.0 5740.7 5744.2 5770.7 5821.9 5789.4 5792.9 5805.7 5833.8 5858.4 5400.9 5656.7 5734.6 5739.8 5757.2 18:45:49 INFO - PROCESS | 23458 | 18:45:49 INFO - PROCESS | 23458 | [#5] yui.html Cycles:180 Average:19752.68 Median:4601.34 stddev:28861.31 (627.2%) stddev-sans-first:28906.90 18:45:49 INFO - PROCESS | 23458 | Values: 723.2 738.6 759.0 777.1 821.8 14206.6 14488.3 14935.5 14998.6 15003.4 13626.5 13645.6 13657.2 13664.8 13781.3 779.9 788.8 799.0 801.2 801.9 804.0 811.7 812.0 813.7 814.7 854.9 856.2 856.3 857.4 857.7 846.7 847.4 847.5 847.6 848.5 619.2 621.4 621.4 623.5 624.3 14502.6 14647.2 14661.3 14665.6 14670.3 14105.2 14163.7 14325.0 14333.9 14439.0 10408.7 10479.2 10529.7 10549.1 10603.0 3621.1 3634.4 3643.4 3733.6 3782.6 82626.0 83131.6 83833.0 84513.0 86199.0 8387.1 8437.1 8488.5 8594.3 8649.0 19541.5 20158.8 20177.3 20198.6 20231.7 8279.6 8330.3 8374.2 8432.2 8501.1 4422.2 4448.1 4511.0 4539.7 4559.9 3650.5 3785.4 3789.3 3794.5 3796.2 616.2 619.9 630.8 642.4 645.1 685.3 685.8 688.1 689.9 723.9 8908.0 8993.2 9064.4 9113.8 9245.7 740.2 750.9 756.6 759.2 771.2 4283.2 4462.8 4499.3 4593.3 4609.4 93515.5 98485.5 107492.5 107950.5 108224.0 92255.5 94830.5 96929.5 97282.1 98010.0 78552.6 82198.6 87409.0 87409.6 88454.0 8494.0 8638.9 8655.3 8979.1 9378.2 34052.3 36269.0 40788.6 44607.8 48737.8 69859.7 71105.0 72937.0 74635.6 75400.2 12279.3 12372.8 12462.8 12637.4 12639.9 12387.8 13568.7 13685.1 13783.9 14454.6 11335.7 12300.2 12484.0 12757.1 13389.9 12473.2 12596.5 13083.5 13306.6 13584.3 11219.8 11316.4 11557.5 11577.6 12052.6 10330.9 10342.7 10361.8 10479.0 10631.8 10001.9 10193.4 10226.4 10246.4 10280.8 18:45:49 INFO - PROCESS | 23458 | -------- Summary: end -------- 18:45:49 INFO - PROCESS | 23458 | 18:45:50 INFO - TEST-INFO | 23458: exit 0 18:45:50 INFO - TEST-OK | dromaeo_css | took 1113981ms 18:45:50 INFO - TEST-START | kraken 18:45:50 INFO - operating with platform_type : linux_ 18:45:50 INFO - Initialising browser for kraken test... 18:45:50 INFO - TEST-INFO | started process 23811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2bJsN_/profile http://localhost:42920/getInfo.html) 18:45:55 INFO - PROCESS | 23811 | __metrics Screen width/height:1600/1200 18:45:55 INFO - PROCESS | 23811 | colorDepth:24 18:45:55 INFO - PROCESS | 23811 | Browser inner width/height: 1024/697 18:45:55 INFO - PROCESS | 23811 | __metrics 18:45:56 ERROR - PROCESS | 23811 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 18:45:56 INFO - TEST-INFO | 23811: exit 0 18:45:56 INFO - Browser initialized. 18:45:56 INFO - Running cycle 1/1 for kraken test... 18:45:56 INFO - TEST-INFO | started process 23935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2bJsN_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:46:09 INFO - PROCESS | 23935 | RSS: Main: 185790464 18:46:09 INFO - PROCESS | 23935 | 18:46:11 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42920/tests/kraken/driver.html?testName=audio-beat-detection) 18:46:12 INFO - PROCESS | 23935 | RSS: Main: 199905280 18:46:12 INFO - PROCESS | 23935 | 18:46:15 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42920/tests/kraken/driver.html?testName=audio-dft) 18:46:16 INFO - PROCESS | 23935 | RSS: Main: 197365760 18:46:16 INFO - PROCESS | 23935 | 18:46:18 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42920/tests/kraken/driver.html?testName=audio-fft) 18:46:19 INFO - PROCESS | 23935 | RSS: Main: 193208320 18:46:19 INFO - PROCESS | 23935 | 18:46:21 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42920/tests/kraken/driver.html?testName=audio-oscillator) 18:46:22 INFO - PROCESS | 23935 | RSS: Main: 194101248 18:46:22 INFO - PROCESS | 23935 | 18:46:24 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:24 INFO - PROCESS | 23935 | RSS: Main: 193855488 18:46:24 INFO - PROCESS | 23935 | 18:46:28 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42920/tests/kraken/driver.html?testName=imaging-darkroom) 18:46:28 INFO - PROCESS | 23935 | RSS: Main: 194334720 18:46:28 INFO - PROCESS | 23935 | 18:46:32 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42920/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:32 INFO - PROCESS | 23935 | RSS: Main: 194297856 18:46:32 INFO - PROCESS | 23935 | 18:46:35 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42920/tests/kraken/driver.html?testName=json-parse-financial) 18:46:36 INFO - PROCESS | 23935 | RSS: Main: 194502656 18:46:36 INFO - PROCESS | 23935 | 18:46:37 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:38 INFO - PROCESS | 23935 | RSS: Main: 194420736 18:46:38 INFO - PROCESS | 23935 | 18:46:40 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:40 INFO - PROCESS | 23935 | RSS: Main: 194301952 18:46:40 INFO - PROCESS | 23935 | 18:46:42 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:46:43 INFO - PROCESS | 23935 | RSS: Main: 194539520 18:46:43 INFO - PROCESS | 23935 | 18:46:46 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:46:46 INFO - PROCESS | 23935 | RSS: Main: 194727936 18:46:46 INFO - PROCESS | 23935 | 18:46:49 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:50 INFO - PROCESS | 23935 | RSS: Main: 194813952 18:46:50 INFO - PROCESS | 23935 | 18:46:51 INFO - PROCESS | 23935 | Cycle 1(1): loaded http://localhost:42920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42920/tests/kraken/driver.html?testName=ai-astar) 18:46:52 INFO - PROCESS | 23935 | RSS: Main: 196325376 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | __start_tp_report 18:46:52 INFO - PROCESS | 23935 | _x_x_mozilla_page_load 18:46:52 INFO - PROCESS | 23935 | _x_x_mozilla_page_load_details 18:46:52 INFO - PROCESS | 23935 | |i|pagename|runs| 18:46:52 INFO - PROCESS | 23935 | |0;ai-astar;110;114;114;114;113;116;112;111;114;113 18:46:52 INFO - PROCESS | 23935 | |1;audio-beat-detection;150;123;121;178;121;121;121;120;145;126 18:46:52 INFO - PROCESS | 23935 | |2;audio-dft;164;164;163;164;172;164;162;164;167;162 18:46:52 INFO - PROCESS | 23935 | |3;audio-fft;75;78;76;104;77;77;78;75;100;75 18:46:52 INFO - PROCESS | 23935 | |4;audio-oscillator;82;85;107;83;83;83;101;82;82;110 18:46:52 INFO - PROCESS | 23935 | |5;imaging-gaussian-blur;118;117;118;118;118;118;118;118;118;117 18:46:52 INFO - PROCESS | 23935 | |6;imaging-darkroom;148;150;147;146;147;146;147;146;146;146 18:46:52 INFO - PROCESS | 23935 | |7;imaging-desaturate;96;97;96;97;96;95;96;96;96;96 18:46:52 INFO - PROCESS | 23935 | |8;json-parse-financial;52;54;53;53;53;54;55;54;54;52 18:46:52 INFO - PROCESS | 23935 | |9;json-stringify-tinderbox;59;59;59;61;63;59;59;59;60;60 18:46:52 INFO - PROCESS | 23935 | |10;stanford-crypto-aes;80;94;79;81;79;82;80;79;80;79 18:46:52 INFO - PROCESS | 23935 | |11;stanford-crypto-ccm;135;131;126;136;126;129;137;143;158;140 18:46:52 INFO - PROCESS | 23935 | |12;stanford-crypto-pbkdf2;172;169;165;169;172;164;172;168;163;170 18:46:52 INFO - PROCESS | 23935 | |13;stanford-crypto-sha256-iterative;66;65;66;66;69;65;66;65;64;68 18:46:52 INFO - PROCESS | 23935 | __end_tp_report 18:46:52 INFO - PROCESS | 23935 | __start_cc_report 18:46:52 INFO - PROCESS | 23935 | _x_x_mozilla_cycle_collect,779 18:46:52 INFO - PROCESS | 23935 | __end_cc_report 18:46:52 INFO - PROCESS | 23935 | __startTimestamp1475200012231__endTimestamp 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | ------- Summary: start ------- 18:46:52 INFO - PROCESS | 23935 | Number of tests: 14 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:1.73 (1.5%) stddev-sans-first:1.42 18:46:52 INFO - PROCESS | 23935 | Values: 110.0 114.0 114.0 114.0 113.0 116.0 112.0 111.0 114.0 113.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:124.50 stddev:19.29 (15.5%) stddev-sans-first:19.41 18:46:52 INFO - PROCESS | 23935 | Values: 150.0 123.0 121.0 178.0 121.0 121.0 121.0 120.0 145.0 126.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.95 (1.8%) stddev-sans-first:3.12 18:46:52 INFO - PROCESS | 23935 | Values: 164.0 164.0 163.0 164.0 172.0 164.0 162.0 164.0 167.0 162.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:10.91 (14.3%) stddev-sans-first:11.31 18:46:52 INFO - PROCESS | 23935 | Values: 75.0 78.0 76.0 104.0 77.0 77.0 78.0 75.0 100.0 75.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.50 stddev:11.42 (13.8%) stddev-sans-first:11.76 18:46:52 INFO - PROCESS | 23935 | Values: 82.0 85.0 107.0 83.0 83.0 83.0 101.0 82.0 82.0 110.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:46:52 INFO - PROCESS | 23935 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:1.30 18:46:52 INFO - PROCESS | 23935 | Values: 148.0 150.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:46:52 INFO - PROCESS | 23935 | Values: 96.0 97.0 96.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 18:46:52 INFO - PROCESS | 23935 | Values: 52.0 54.0 53.0 53.0 53.0 54.0 55.0 54.0 54.0 52.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.50 stddev:1.32 (2.2%) stddev-sans-first:1.36 18:46:52 INFO - PROCESS | 23935 | Values: 59.0 59.0 59.0 61.0 63.0 59.0 59.0 59.0 60.0 60.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:4.57 (5.7%) stddev-sans-first:4.82 18:46:52 INFO - PROCESS | 23935 | Values: 80.0 94.0 79.0 81.0 79.0 82.0 80.0 79.0 80.0 79.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:136.50 stddev:9.57 (7.0%) stddev-sans-first:10.15 18:46:52 INFO - PROCESS | 23935 | Values: 135.0 131.0 126.0 136.0 126.0 129.0 137.0 143.0 158.0 140.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.50 stddev:3.37 (2.0%) stddev-sans-first:3.32 18:46:52 INFO - PROCESS | 23935 | Values: 172.0 169.0 165.0 169.0 172.0 164.0 172.0 168.0 163.0 170.0 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 18:46:52 INFO - PROCESS | 23935 | Values: 66.0 65.0 66.0 66.0 69.0 65.0 66.0 65.0 64.0 68.0 18:46:52 INFO - PROCESS | 23935 | -------- Summary: end -------- 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | 18:46:52 INFO - PROCESS | 23935 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:52 INFO - PROCESS | 23935 | 18:46:53 INFO - TEST-INFO | 23935: exit 0 18:46:53 INFO - TEST-OK | kraken | took 62481ms 18:46:53 INFO - SUITE-END | took 1176s 18:46:53 INFO - Completed test suite (00:19:36) 18:46:53 INFO - javascript benchmark 18:46:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7132.9869233325435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2992.8802847886086, 3012.5330573761075, 3031.7423019043395, 3050.1612056684407, 3067.6778938211487, 5198.844034678957, 5345.89308213836, 5353.330833645794, 5421.972890135548, 5499.7250137493065, 5255.76349064292, 5309.203619457084, 5334.813281535147, 5390.00284947285, 5400.189971504276, 4812.663113582051, 4845.733484658343, 4950.826721064764, 4957.529034741694, 4970.179920313144, 4826.806927722887, 4925.975370123145, 5005.749712514378, 5016.949830501685, 5061.038402703493, 4752.7861246244, 4789.2816077588295, 4820.903581928342, 4850.054239423313, 4868.90449648828, 4842.612590992712, 4909.042736666352, 4945.579625731817, 4957.851264462072, 4974.925376119325, 4879.219324907997, 4881.243407271879, 4906.9263961040615, 4910.21436570147, 4968.45347011832, 5138.511841375063, 5168.8449346519665, 5358.410574836765, 5359.196120581905, 5364.088105022156, 5695.1741997410145, 5739.282589676291, 5739.971300143514, 5759.078547432391, 5838.095095260242, 5813.593048486608, 5822.534197264209, 5823.301203855522, 5824.097264923944, 5832.708364581754, 5223.921641175385, 5372.946270537283, 5378.704171270618, 5383.650062745909, 5398.325209348832, 5767.711614419262, 5840.707964601838, 5884.852878678067, 5900.940990590125, 5993.940060599338, 5618.129189975561, 5660.122680984454, 5664.405237450091, 5664.745086471119, 5668.801591944262, 5709.600327977002, 5731.512821410143, 5735.311762588516, 5753.453421924911, 5759.280089988752, 5555.666660000332, 5615.691136987505, 5615.831525054255, 5633.802816901389, 5715.571332150105, 5629.915551266734, 5742.13867919807, 5749.108888122348, 5760.51035661965, 5764.423557644286, 4472.217361961643, 4477.350784136347, 4492.0, 4499.6400287976885, 4549.067441174551, 3912.374020156761, 3926.764394136361, 3986.720929534905, 3997.5003124609425, 4020.557738648746, 5413.648112872651, 5512.33851937762, 5514.310711161105, 5552.91670624941, 5565.499105080562, 5766.88466230673, 5812.215350927655, 5814.6220495668495, 5814.738336774855, 5839.795607153729, 5323.254744335796, 5437.102878025082, 5496.862578435571, 5501.559875209973, 5502.422245664227, 4850.975745121252, 4939.851804445872, 4951.876203094951, 4981.800727970913, 5062.7468626568525, 6012.308584512837, 6014.428629280212, 6016.217891674054, 6016.789412370546, 6024.096385542116, 5829.854253643693, 5833.183354330482, 5833.300003999547, 5834.474897259267, 5845.035569131046, 5782.306123265067, 5836.978528757535, 5897.292324920865, 5933.643981361132, 5947.1079338099635, 5579.46995035471, 5625.268715067015, 5628.493435590816, 5628.746706398304, 5695.373508913934, 5708.172315014383, 5751.597388182787, 5762.913556296575, 5763.962486752424, 5769.048107062287, 5442.972785136049, 5499.340079190522, 5532.446755324436, 5565.1930470082425, 5594.992901277809, 5597.3003374578175, 5599.580031497572, 5604.607677462538, 5644.463775941279, 5656.830295091154, 5544.556435485071, 5575.581831362583, 5581.609287349846, 5591.608587398843, 5598.272224610774, 5349.144136938071, 5482.0, 5594.104943209067, 5617.129344951539, 5643.802466913638, 5541.833744987657, 5542.806001790079, 5547.805826796204, 5549.5837812163445, 5595.916061259003], "value": 5298.645636861152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.309628445865, 582.3710392775803, 582.5077809251181, 585.5842351930129, 599.0714392691327, 41272.79363603181, 43301.35047974279, 43614.0, 47569.524304756946, 47595.048099038, 45466.545334546645, 46088.769556152256, 46103.0, 46121.308180377324, 46378.76810615942, 8946.821063578709, 9056.683016094437, 9061.50161741104, 9063.59213835379, 9091.0, 8872.512011839379, 9007.099290071006, 9016.143466370717, 9020.41367311126, 9043.050479699636, 9054.909450905505, 9096.0449152839, 9114.680986165486, 9125.22435592972, 9143.771405714877, 8945.821083578292, 8985.281177505783, 9026.277897768163, 9061.68284110053, 9061.909380906238, 8788.692395766118, 8839.69061082859, 8866.0, 8876.289896808305, 8960.820783584291, 42650.78674606607, 42828.785856070834, 42916.57083429157, 42948.1410371794, 43373.78313108414, 3256.397566450214, 3390.271091715293, 3456.395130852116, 3467.0, 3890.824912878899, 32076.83961580177, 32214.19464513406, 32968.6703132968, 32968.67031329704, 33121.3375732484, 4331.662198124219, 4345.630621397185, 4351.630111440531, 4403.977980110111, 4432.756198409086, 241713.0, 242167.0, 243690.0, 345780.0, 346084.0, 52621.7368913153, 52698.47301526936, 52779.0, 52787.73606131945, 52794.0, 35860.46209306862, 37307.0, 37467.437988430196, 39603.603963960566, 39763.427205871114, 15135.924320378328, 15363.0, 15398.692026159413, 15400.768988465183, 15466.536003919675, 10451.268411211295, 10495.685129446128, 10501.264911456277, 10522.421266830244, 10531.315464494783, 19224.231030758892, 19259.90370048169, 19302.22791088369, 19312.4206273812, 19335.51661208481, 6873.20958089816, 6931.653417329113, 7243.782686519413, 7249.818754531074, 7355.161209697576, 898.2409863665192, 1007.4912169354429, 1045.9738506537396, 1060.8992145746142, 1118.927269727465, 32016.359672806415, 32141.51787723186, 32249.35501290008, 32442.188945276557, 32443.837780810944, 968.8352979993418, 1023.488255872064, 1124.7188202949262, 1158.449736375215, 1191.184038933316, 16374.508764737076, 16492.505224843273, 16519.0, 16544.0, 16784.160791960352, 765858.0, 774094.0, 775930.0, 777340.0, 787916.0, 57691.711541442026, 57984.42015579875, 58386.0, 58486.41513584895, 58754.706226468596, 1308.672831792052, 1308.908376413661, 1321.9272939988393, 1342.8187194728782, 1357.253510569183, 30065.561819352934, 31784.523232151998, 31893.8405307972, 32576.83711581427, 32713.836430817693, 52195.0, 52875.47124528705, 53035.469645303056, 53069.20396193983, 53111.20333194928, 490129.0, 491409.0, 491845.0, 493291.40566023125, 495886.0, 28403.43193136167, 28409.57385639176, 29121.85439072791, 29260.414791704472, 29280.41439171162, 47463.762681186374, 47681.0, 48125.0, 48144.51855481401, 49066.0, 39534.40698389469, 39778.2044359117, 40109.59890401176, 40455.59544404518, 42304.57695423129, 39240.0, 39415.408768867914, 40113.39829902496, 40993.0, 41118.65457490507, 35587.466188006685, 37821.62178378181, 39894.40158397568, 40951.0, 43594.56405435905, 34166.82916585401, 36480.27039459249, 37243.25513489661, 37388.813055934545, 37549.24901502009, 27673.584896226974, 28086.71913280841, 28151.296217594725, 28197.295067623472, 28350.0], "value": 19854.369022165545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7189607794156, 383.565173868012, 392.3389089384387, 395.4937679769894, 415.6820032675004, 16245.350185992576, 16972.575685607833, 18149.637007259862, 19754.90122549387, 19812.108455119534, 12448.751024979494, 12548.372581370917, 12558.0, 12861.877790164612, 12984.0, 5244.370675518943, 5446.537044351235, 5446.564274858021, 5448.318960129984, 5451.618386712912, 5151.459096794839, 5212.374515058198, 5224.746060945384, 5780.942190578083, 5797.71011449428, 5775.249217601706, 5781.19063331134, 5785.537157027448, 5790.276215473066, 5807.0, 5365.865853353678, 5371.57027437804, 5391.973040134774, 5534.4742249486235, 5762.078067509199, 5221.817236396746, 5227.921581176285, 5238.842834714965, 5246.3704355477585, 5250.474952504757, 14016.22910739909, 14225.573232803032, 14281.285935703174, 14526.782098268535, 14531.636709082357, 2078.4699901525014, 2119.279444988696, 2134.4877229464973, 2142.6250406178856, 2248.482848944752, 9956.0, 10265.897341026643, 10424.68725938223, 10586.470676466146, 10611.0, 1699.77902872627, 1735.7743493345783, 1748.4142812157816, 1748.5104170832187, 1757.0863151161325, 82246.0, 85956.0, 86705.0, 87884.0, 89903.99999999935, 10757.83863242052, 10759.031687148194, 10780.892191078146, 10909.39998300101, 10950.123990080774, 15881.761773573406, 15925.840741592667, 15935.362585496681, 15991.520254392386, 16025.59936001586, 7345.751222292223, 7614.390848732088, 7624.580648064299, 7743.225677432211, 7856.057273127261, 6963.9303606964295, 7097.787066388017, 7225.169105552824, 7300.269973002657, 7321.121465424183, 4777.140114779373, 4846.588040016568, 4854.927176092361, 4940.728259945666, 4962.33008543842, 1930.362980216525, 1967.281942091155, 2012.3661046770221, 2026.6794520274204, 2069.368842503021, 849.8002969302332, 930.432436213909, 961.8557216417454, 966.4491239993278, 987.4766373821886, 18222.180001899946, 18797.530061748566, 19441.51396215106, 19518.609627807364, 19788.0, 989.6387818446216, 1000.6247657128577, 1005.2410430125209, 1018.2057994764095, 1020.8672872526524, 10252.538635761408, 10695.304805187638, 10776.838347424795, 10777.299475534066, 10813.134949204044, 440921.0, 458687.0, 459167.0, 460673.0, 460691.0, 87746.0, 89063.55468222617, 89138.10861891428, 89565.0, 89718.0, 972.2319367699438, 986.1026465916125, 994.380455143279, 997.6957028106352, 998.2164001258977, 16499.67000659956, 16744.74882876782, 16770.748438773186, 17100.401485947932, 17228.052457114478, 40122.1975560493, 40757.79621101876, 41013.58986410217, 41672.58327416687, 42021.78989105035, 52713.0, 53825.73087134539, 58067.0, 58231.0, 58769.0, 8472.957635211784, 8614.698485552975, 8695.652173913226, 8702.434341767765, 9044.457332560067, 7303.525270857377, 9519.906440230767, 11083.8361971995, 12214.206076604993, 12897.290649014394, 9809.313348065567, 9913.702588922344, 10027.899721002697, 10212.336198147097, 10920.50857711389, 10126.088652021353, 10164.593416263562, 10416.375017498975, 10779.0, 10810.459477026274, 5760.251167348218, 10087.546060427445, 10243.38539687621, 10469.738256543342, 10555.683329500127, 7579.1284002340435, 8413.368997325102, 8608.09614990417, 8667.133286671535, 8779.429337093068, 9632.47021413829, 10215.774107106898, 10259.384436933808, 10372.118369938338, 10620.84068738954], "value": 8619.169934599804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.312118622468, 1476.6382236352092, 1608.5656872644386, 1741.0511271357109, 1776.6180271241687, 7652.349550288218, 7924.207579242073, 8545.273651739602, 9197.540122993849, 9256.398334108286, 8607.741767746962, 8884.466931984085, 8895.199432051115, 9112.589933452993, 9167.679131230409, 2336.4275752440676, 2355.057976809273, 2363.6809030780882, 2368.798652114572, 2377.4769550698907, 2299.37916762474, 2306.6194077977116, 2336.918207862725, 2350.3066595354326, 2351.541449417364, 2321.8839058047115, 2325.9534809303805, 2333.6499525071204, 2359.976400235993, 2363.881805909706, 2238.9216377426874, 2275.52214035052, 2280.1221529711015, 2280.2589158523465, 2308.249818808894, 2224.922127725522, 2232.497688020199, 2254.0052053932222, 2256.3907744908784, 2260.5026894083276, 9029.909700902972, 9033.322500812399, 9095.63617455301, 9117.77205569866, 9121.726348209564, 5261.921071183935, 5462.726863656841, 5478.479544443271, 5492.725363731797, 5500.58745594082, 3358.613759417674, 3410.4641718010153, 3438.7592868499214, 3545.592256890465, 3552.0942159749097, 1102.327580176092, 1109.1902910875106, 1110.0118717847297, 1124.8425220469142, 1139.117184182257, 12819.551315703999, 12845.100842940998, 12882.48470061187, 12914.354282285849, 12917.67705807353, 4722.88192795176, 4741.95258047422, 4827.927581086286, 4839.0, 4920.286558449005, 10666.733331666615, 10704.1436685065, 10710.196735244888, 10717.410542420243, 10741.89258107409, 5301.390340110936, 5339.225812257201, 5342.519173274346, 5352.357717073976, 5362.517373436332, 4332.935005974913, 4451.888702782391, 4782.306565547976, 4920.778564964514, 5000.574951129122, 3883.1457079442475, 3954.4859168308512, 3995.9200815983518, 4049.6760259179196, 4068.6745060395097, 1220.6338098570393, 1234.1422711215619, 1236.7341021680202, 1248.350857554085, 1258.6349958511928, 781.6677911887425, 870.734426000076, 882.8099484367701, 886.3175354976632, 913.2374467319862, 5596.048671725735, 5637.703328234529, 5705.5435565154685, 5805.216295800013, 6014.669193194416, 986.6300137448457, 1017.2828156149897, 1044.9111825494765, 1063.2875973098044, 1065.2862582070031, 3867.43922131295, 3895.2014836958356, 3985.601439856049, 3997.5003124609425, 4063.065494936181, 10757.462126893624, 10955.890441095487, 11067.889321106846, 11068.944655276671, 11107.666769996913, 10571.471426428801, 10662.840057399146, 10889.727756806144, 10903.29128606638, 10950.34297942126, 8393.664253429795, 8397.454165479225, 8422.494650321001, 8438.409311348147, 8509.936257967754, 5700.800471983461, 5719.113537401709, 5776.480116789509, 5807.796727114531, 5964.5526585505395, 10359.378437293786, 10383.169346452114, 10454.581816727246, 10584.576616935545, 10594.046535811814, 9685.370450920667, 10127.291089623655, 10140.898591013995, 10242.692719218436, 10426.113780328757, 6988.161420629557, 7161.140663120459, 7704.92295077042, 7764.262395072459, 7891.526508409514, 8439.493630382196, 8499.235068843835, 8588.785280368042, 8823.02946675878, 8859.335549833659, 7776.650050747843, 7870.1898563329605, 8013.559254241072, 8069.59652017385, 8107.797305067421, 7433.331000210007, 7551.0, 7625.046869141357, 7669.9616501917135, 7708.229177082247, 6731.990201469819, 6796.320367963164, 6812.284710105368, 6817.863642727217, 6861.176658800976, 4961.330220420341, 4961.742407204641, 4971.801127954841, 5002.799888004584, 5190.702324418895, 4936.7284799336385, 4999.225120106389, 5074.416442109205, 5091.338126043591, 5098.592112630907], "value": 4650.882808919198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6746121339873, 329.44159649394277, 337.2462546209222, 339.8878370137855, 341.9111031131907, 5376.247325374451, 5480.588955828319, 5504.697241651707, 5581.553475721943, 5585.636933599313, 5300.284461597693, 5380.542653874425, 5413.26920865683, 5427.267318911946, 5454.645448045874, 4298.140371925611, 4310.590493903074, 4311.0, 4312.654987600992, 4331.220380331539, 4173.24881521326, 4289.721168124062, 4304.913901721964, 4318.611324980751, 4319.200947824646, 4258.382534532491, 4280.721753086055, 4284.528701842794, 4286.142771445708, 4287.892802679942, 4251.97874010631, 4274.0, 4287.464066991626, 4314.158739045887, 4314.395984562164, 3723.646253605903, 3835.2329534093014, 3837.194189220267, 3837.2325534893134, 3838.7312888097845, 5320.228566857822, 5323.600729945269, 5369.355677318707, 5408.512084441162, 5415.83752487426, 4865.321464094882, 4922.975385123087, 4927.605791536668, 4930.531599498042, 4931.5315045070665, 5552.0, 5689.231953686241, 5759.7536960584985, 5770.6249093808765, 5804.2744656917885, 4150.132440401831, 4159.168166366709, 4196.664266858644, 4201.222773786859, 4202.642775364097, 6014.428629280212, 6057.909131363033, 6064.0, 6066.454019138255, 6082.635041897456, 4068.572799856032, 4244.936325955113, 4319.250703465102, 4319.9784001080425, 4329.458817647794, 4307.956920430818, 4326.63223625989, 4337.175936572041, 4348.978255108767, 4388.319810429389, 4964.280179373971, 4968.0, 4970.925436118461, 4971.353724015855, 4988.6009119270375, 5531.502164805187, 5783.797567085216, 5844.357120716718, 5845.473907348274, 5855.414458554111, 1453.738327101132, 1499.1754535005703, 1500.5348342013792, 1505.893168521136, 1508.1177511155877, 946.4699768129869, 955.7706150523824, 967.7628980899725, 974.9268804839666, 978.9412635241766, 4931.0, 4945.9752701236985, 4957.380327459067, 4958.652909286217, 4988.251762235694, 5162.9741851291255, 5203.297554830126, 5217.556507696889, 5244.767479642281, 5270.2594650781375, 4746.976265118721, 4897.7755561109725, 4909.656324057353, 4917.270914642408, 4919.926201106986, 2763.06055940981, 2789.995601583428, 2793.0364024411547, 2813.84740673385, 2831.5134554358715, 5315.574754019669, 5336.546393556514, 5343.8585096549705, 5370.670184485644, 5421.945780542223, 5253.894922101536, 5286.656367336188, 5692.573057020657, 6115.816525504242, 6146.446819786241, 6156.230471191101, 6171.783987560414, 6173.41352571505, 6179.876402471926, 6208.844778880474, 5641.746121424464, 5955.880882382415, 5959.493443057216, 5984.371640977809, 5986.2517185351835, 5782.508486778671, 5799.623024503394, 5809.0, 5847.152162936435, 5853.912191317048, 6176.9073463897175, 6177.104319873683, 6189.81430557084, 6197.783077592443, 6235.937640623536, 4115.156982680883, 4231.767252801125, 4243.299855523804, 4243.5332113466875, 4257.531671516069, 5797.797077102281, 5930.649183211472, 5954.493868021266, 5990.0, 6002.0, 5823.213866128188, 5823.621464604787, 5825.679587622722, 5839.766409343579, 5851.268591426072, 5791.218185544897, 5805.996931058778, 5806.68063256525, 5829.417058294137, 5841.853953651193, 5595.972020139873, 5740.712964351682, 5744.167095771173, 5770.682612456355, 5821.912671310019, 5789.421057894346, 5792.884142317046, 5805.680687562224, 5833.8249852502795, 5858.443447872445, 5400.864978375572, 5656.660600363827, 5734.61657622005, 5739.827805165852, 5757.165211044291], "value": 4335.375355325398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.1864152828068, 738.575319191465, 758.9794401783503, 777.1373775109623, 821.7575815134533, 14206.57380278592, 14488.348024338904, 14935.477258295961, 14998.550043498684, 15003.399864005427, 13626.454941802342, 13645.590632281022, 13657.180569165857, 13664.795028074586, 13781.310934453288, 779.9181085985975, 788.8106854354957, 799.0411506192563, 801.1867954026668, 801.9318357939553, 803.9638216280281, 811.7321283976273, 811.9553424561647, 813.7314686153555, 814.7189219719187, 854.8803167556547, 856.1609622569886, 856.2764464027887, 857.3655494933736, 857.6569372251118, 846.724814435308, 847.4279861093768, 847.5211505499373, 847.5846835050843, 848.516345682961, 619.1610367951452, 621.3817251834408, 621.3817251834454, 623.4762799248607, 624.3257282135284, 14502.564923052325, 14647.194404307758, 14661.266936653125, 14665.56003319902, 14670.339834707356, 14105.2242126683, 14163.716725665532, 14325.0, 14333.928330358385, 14439.0, 10408.687739367755, 10479.161667066617, 10529.684109476728, 10549.10332621728, 10603.0, 3621.0947263184203, 3634.4003239465455, 3643.3988391915304, 3733.5519737631384, 3782.583915769263, 82626.0, 83131.5843420779, 83833.0, 84513.0, 86199.0, 8387.077421483631, 8437.114103019218, 8488.533130677748, 8594.269487093667, 8648.95675521631, 19541.51146221356, 20158.798412015985, 20177.293794717116, 20198.596028079355, 20231.696524552142, 8279.62741676626, 8330.333573314121, 8374.246317831303, 8432.198941100585, 8501.10738372462, 4422.248217802981, 4448.110377924428, 4510.954890451119, 4539.7049191802425, 4559.940919026338, 3650.4889315495852, 3785.432185172191, 3789.2800367930004, 3794.4687743715904, 3796.2027974125745, 616.1712496691943, 619.8605313804358, 630.8265227062503, 642.4154019842015, 645.1290757477461, 685.2842146959774, 685.8353995041155, 688.0985908459934, 689.9413549848218, 723.9203687594361, 8907.955460222787, 8993.24432363288, 9064.365494415328, 9113.77215569616, 9245.676401325922, 740.1872883044409, 750.9098908131059, 756.587659725451, 759.2293821770907, 771.1941021632408, 4283.2290187765875, 4462.754548499864, 4499.280115181556, 4593.311003349524, 4609.372657585144, 93515.53242233745, 98485.50757246312, 107492.46253768838, 107950.46024769825, 108224.0, 92255.53872230597, 94830.52584737031, 96929.51535242419, 97282.05435891384, 98010.0, 78552.60723696345, 82198.58900705459, 87409.0, 87409.56295218483, 88453.99999999872, 8494.0, 8638.870416943626, 8655.30757539408, 8979.086721989672, 9378.202852757318, 34052.31207374633, 36269.0, 40788.59211407848, 44607.776961114985, 48737.75631121822, 69859.65070174617, 71105.0, 72937.0, 74635.62682186555, 75400.24599754151, 12279.263244205376, 12372.752544949231, 12462.813057804322, 12637.368131593199, 12639.87360126387, 12387.75224495523, 13568.728625427239, 13685.11046781956, 13783.931080344533, 14454.638634034232, 11335.659930202108, 12300.200486968319, 12484.0, 12757.067963397065, 13389.933050335076, 12473.189242699196, 12596.496140154657, 13083.476660933457, 13306.600801975956, 13584.25286609246, 11219.831702524632, 11316.434178290889, 11557.47991340375, 11577.594784182513, 12052.578159764365, 10330.896691032993, 10342.689719308433, 10361.792764144524, 10479.0, 10631.840522392326, 10001.899981000388, 10193.388396696222, 10226.386416815016, 10246.38521688701, 10280.794384112425], "value": 7203.396373524226, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 114.0, 113.0, 116.0, 112.0, 111.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 121.0, 178.0, 121.0, 121.0, 121.0, 120.0, 145.0, 126.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 164.0, 172.0, 164.0, 162.0, 164.0, 167.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 104.0, 77.0, 77.0, 78.0, 75.0, 100.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 107.0, 83.0, 83.0, 83.0, 101.0, 82.0, 82.0, 110.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 53.0, 53.0, 54.0, 55.0, 54.0, 54.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 61.0, 63.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 94.0, 79.0, 81.0, 79.0, 82.0, 80.0, 79.0, 80.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 126.0, 136.0, 126.0, 129.0, 137.0, 143.0, 158.0, 140.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 165.0, 169.0, 172.0, 164.0, 172.0, 168.0, 163.0, 170.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 69.0, 65.0, 66.0, 65.0, 64.0, 68.0], "value": 66.0, "unit": "score"}]}]} 18:46:53 INFO - Return code: 0 18:46:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:46:53 ERROR - # TBPL SUCCESS # 18:46:53 INFO - Running post-action listener: _resource_record_post_action 18:46:53 INFO - [mozharness: 2016-09-30 01:46:53.536091Z] Finished run-tests step (success) 18:46:53 INFO - Running post-run listener: _resource_record_post_run 18:46:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403738624; Read time: 16; Write time: 269596 18:46:53 INFO - TinderboxPrint: CPU usage
13.4% 18:46:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:46:53 INFO - TinderboxPrint: I/O write bytes / time
403,738,624 / 269,596 18:46:53 INFO - TinderboxPrint: CPU idle
8,247.3 (86.6%) 18:46:53 INFO - TinderboxPrint: CPU user
1,210.0 (12.7%) 18:46:53 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114753536; Read time: 0; Write time: 72416 18:46:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 287830016; Read time: 0; Write time: 197148 18:46:54 INFO - Running post-run listener: _upload_blobber_files 18:46:54 INFO - Blob upload gear active. 18:46:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:54 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 18:46:54 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'] 18:46:54 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 18:46:54 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:00 INFO - (blobuploader) - INFO - Done attempting. 18:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:00 INFO - (blobuploader) - INFO - Done attempting. 18:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:47:01 INFO - (blobuploader) - INFO - Done attempting. 18:47:01 INFO - (blobuploader) - INFO - Iteration through files over. 18:47:01 INFO - Return code: 0 18:47:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:47:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:47:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/befe27c4b60be15f4a1c7cd64e877683cfe0f7da2034249ab1c28dfe5ea73f6f8937976a31d1913f8febafe032219a95ba03d586f7537b376f639b3d712c14e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32fbdb687bb14d51c30b6fd0e283a5e9a6edfc058bbe12be9b95590de92c33553a37f29f037bec956537b786ca3a889c57f3ea6693a2be88824322eab8f2430e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d28f895c831bc3d9780605e810fc0fe07da5f6b2cddd232e267293233be777b57e2d3cc6ca67397b606cbdafd246294b4e1cdee2c047263c7f49ea2bc2de302f"} 18:47:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:47:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:47:01 INFO - Contents: 18:47:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/befe27c4b60be15f4a1c7cd64e877683cfe0f7da2034249ab1c28dfe5ea73f6f8937976a31d1913f8febafe032219a95ba03d586f7537b376f639b3d712c14e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32fbdb687bb14d51c30b6fd0e283a5e9a6edfc058bbe12be9b95590de92c33553a37f29f037bec956537b786ca3a889c57f3ea6693a2be88824322eab8f2430e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d28f895c831bc3d9780605e810fc0fe07da5f6b2cddd232e267293233be777b57e2d3cc6ca67397b606cbdafd246294b4e1cdee2c047263c7f49ea2bc2de302f"} 18:47:01 INFO - Running post-run listener: copy_logs_to_upload_dir 18:47:01 INFO - Copying logs to upload dir... 18:47:01 INFO - mkdir: /builds/slave/test/build/upload/logs 18:47:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.708147 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-29 18:47:01.419825) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 18:47:01.424051) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/befe27c4b60be15f4a1c7cd64e877683cfe0f7da2034249ab1c28dfe5ea73f6f8937976a31d1913f8febafe032219a95ba03d586f7537b376f639b3d712c14e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32fbdb687bb14d51c30b6fd0e283a5e9a6edfc058bbe12be9b95590de92c33553a37f29f037bec956537b786ca3a889c57f3ea6693a2be88824322eab8f2430e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d28f895c831bc3d9780605e810fc0fe07da5f6b2cddd232e267293233be777b57e2d3cc6ca67397b606cbdafd246294b4e1cdee2c047263c7f49ea2bc2de302f"} build_url:https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/HD2wQ_X-QiuSBZdLyyn1Mg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/befe27c4b60be15f4a1c7cd64e877683cfe0f7da2034249ab1c28dfe5ea73f6f8937976a31d1913f8febafe032219a95ba03d586f7537b376f639b3d712c14e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32fbdb687bb14d51c30b6fd0e283a5e9a6edfc058bbe12be9b95590de92c33553a37f29f037bec956537b786ca3a889c57f3ea6693a2be88824322eab8f2430e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d28f895c831bc3d9780605e810fc0fe07da5f6b2cddd232e267293233be777b57e2d3cc6ca67397b606cbdafd246294b4e1cdee2c047263c7f49ea2bc2de302f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 18:47:01.449248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:47:01.449571) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1475198781.200028-1218048983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 18:47:01.499618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 18:47:01.500036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 18:47:01.500338) ========= ========= Total master_lag: 0.32 =========